builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1468866810.91 results: success (0) buildid: 20160718083017 builduid: f4132788998e43cc9f2e21ac1971a65c revision: ec19b4cb42d5355d336967e00059ddee3053f924 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 11:33:30.912695) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 11:33:30.913160) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 11:33:30.913472) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 11:33:30.929096) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:33:30.929498) ========= 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=1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 11:33:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 95.4M=0s 2016-07-18 11:33:31 (95.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126888 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:33:31.071044) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:33:31.071394) ========= 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=1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018276 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:33:31.121602) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:33:31.121953) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ec19b4cb42d5355d336967e00059ddee3053f924 --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 ec19b4cb42d5355d336967e00059ddee3053f924 --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=1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 11:33:31,326 truncating revision to first 12 chars 2016-07-18 11:33:31,326 Setting DEBUG logging. 2016-07-18 11:33:31,326 attempt 1/10 2016-07-18 11:33:31,326 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ec19b4cb42d5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 11:33:31,892 unpacking tar archive at: fx-team-ec19b4cb42d5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.912535 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:33:32.048032) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 11:33:32.048377) ========= script_repo_revision: ec19b4cb42d5355d336967e00059ddee3053f924 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 11:33:32.048783) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 11:33:32.049055) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 11:33:32.058695) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-18 11:33:32.059040) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:33:32 INFO - MultiFileLogger online at 20160718 11:33:32 in /builds/slave/test 11:33:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:33:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:33:32 INFO - {'append_to_log': False, 11:33:32 INFO - 'base_work_dir': '/builds/slave/test', 11:33:32 INFO - 'blob_upload_branch': 'Fx-Team', 11:33:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:33:32 INFO - 'branch': 'Fx-Team', 11:33:32 INFO - 'buildbot_json_path': 'buildprops.json', 11:33:32 INFO - 'config_files': ('talos/linux_config.py',), 11:33:32 INFO - 'default_actions': ('clobber', 11:33:32 INFO - 'read-buildbot-config', 11:33:32 INFO - 'download-and-extract', 11:33:32 INFO - 'populate-webroot', 11:33:32 INFO - 'create-virtualenv', 11:33:32 INFO - 'install', 11:33:32 INFO - 'run-tests'), 11:33:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:33:32 INFO - 'download_minidump_stackwalk': True, 11:33:32 INFO - 'download_symbols': 'ondemand', 11:33:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:33:32 INFO - 'tooltool.py': '/tools/tooltool.py', 11:33:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:33:32 INFO - '/tools/misc-python/virtualenv.py')}, 11:33:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:33:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:33:32 INFO - 'installer_path': 'installer.exe', 11:33:32 INFO - 'log_level': 'info', 11:33:32 INFO - 'log_name': 'talos', 11:33:32 INFO - 'log_to_console': True, 11:33:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:33:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:33:32 INFO - 'opt_config_files': (), 11:33:32 INFO - 'pip_index': False, 11:33:32 INFO - 'sps_profile': False, 11:33:32 INFO - 'sps_profile_interval': 0, 11:33:32 INFO - 'suite': 'dromaeojs', 11:33:32 INFO - 'system_bits': '32', 11:33:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:33:32 INFO - 'title': 'talos-linux64-ix-027', 11:33:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:33:32 INFO - 'use_talos_json': True, 11:33:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:33:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:33:32 INFO - 'work_dir': 'build'} 11:33:32 INFO - ##### 11:33:32 INFO - ##### Running clobber step. 11:33:32 INFO - ##### 11:33:32 INFO - Running pre-action listener: _resource_record_pre_action 11:33:32 INFO - Running main action method: clobber 11:33:32 INFO - rmtree: /builds/slave/test/build 11:33:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:33:32 INFO - Running post-action listener: _resource_record_post_action 11:33:32 INFO - ##### 11:33:32 INFO - ##### Finished clobber step (success) 11:33:32 INFO - ##### 11:33:32 INFO - ##### 11:33:32 INFO - ##### Running read-buildbot-config step. 11:33:32 INFO - ##### 11:33:32 INFO - Running pre-action listener: _resource_record_pre_action 11:33:32 INFO - Running main action method: read_buildbot_config 11:33:32 INFO - Using buildbot properties: 11:33:32 INFO - { 11:33:32 INFO - "project": "", 11:33:32 INFO - "product": "firefox", 11:33:32 INFO - "script_repo_revision": "production", 11:33:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:33:32 INFO - "repository": "", 11:33:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:33:32 INFO - "buildid": "20160718083017", 11:33:32 INFO - "pgo_build": "True", 11:33:32 INFO - "basedir": "/builds/slave/test", 11:33:32 INFO - "buildnumber": 1331, 11:33:32 INFO - "slavename": "talos-linux64-ix-027", 11:33:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:33:32 INFO - "platform": "ubuntu64_hw", 11:33:32 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:33:32 INFO - "branch": "fx-team", 11:33:32 INFO - "repo_path": "integration/fx-team", 11:33:32 INFO - "revision": "ec19b4cb42d5355d336967e00059ddee3053f924", 11:33:32 INFO - "stage_platform": "linux64-pgo", 11:33:32 INFO - "builduid": "f4132788998e43cc9f2e21ac1971a65c", 11:33:32 INFO - "slavebuilddir": "test" 11:33:32 INFO - } 11:33:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:33:32 INFO - Running post-action listener: _resource_record_post_action 11:33:32 INFO - ##### 11:33:32 INFO - ##### Finished read-buildbot-config step (success) 11:33:32 INFO - ##### 11:33:32 INFO - ##### 11:33:32 INFO - ##### Running download-and-extract step. 11:33:32 INFO - ##### 11:33:32 INFO - Running pre-action listener: _resource_record_pre_action 11:33:32 INFO - Running main action method: download_and_extract 11:33:32 INFO - mkdir: /builds/slave/test/build/tests 11:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:32 INFO - https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:33:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:33:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:33:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:33:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:33:33 INFO - Downloaded 1361 bytes. 11:33:33 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:33:33 INFO - Using the following test package requirements: 11:33:33 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:33:33 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:33:33 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:33:33 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:33 INFO - u'jsshell-linux-x86_64.zip'], 11:33:33 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:33:33 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:33:33 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:33:33 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:33:33 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:33:33 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:33:33 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:33:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:33 INFO - https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:33:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:33:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:33:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:33:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:33:34 INFO - Downloaded 24333771 bytes. 11:33:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:33:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:33:35 INFO - Return code: 0 11:33:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:35 INFO - https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:33:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:33:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:33:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:33:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:33:38 INFO - Downloaded 24333771 bytes. 11:33:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:33:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:33:39 INFO - Return code: 0 11:33: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')]} 11:33:39 INFO - https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:33:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:33:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:33:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:33:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:33:40 INFO - Downloaded 14403317 bytes. 11:33:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:33:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:33:40 INFO - Return code: 0 11:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:40 INFO - https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:33:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:33:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:33:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:33:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:33:42 INFO - Downloaded 60849652 bytes. 11:33:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:33:42 INFO - mkdir: /builds/slave/test/properties 11:33:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:33:42 INFO - Writing to file /builds/slave/test/properties/build_url 11:33:42 INFO - Contents: 11:33:42 INFO - build_url:https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:33:43 INFO - Running post-action listener: _resource_record_post_action 11:33:43 INFO - Running post-action listener: set_extra_try_arguments 11:33:43 INFO - ##### 11:33:43 INFO - ##### Finished download-and-extract step (success) 11:33:43 INFO - ##### 11:33:43 INFO - ##### 11:33:43 INFO - ##### Running populate-webroot step. 11:33:43 INFO - ##### 11:33:43 INFO - Running pre-action listener: _resource_record_pre_action 11:33:43 INFO - Running main action method: populate_webroot 11:33:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:33:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:33:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:33:43 INFO - '--tppagecycles', 11:33:43 INFO - '7'], 11:33:43 INFO - 'tests': ['tsvgm']}}, 11:33:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:33:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:33:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:33:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:33:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:33:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:33:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:33:43 INFO - 'talos_options': ['--disable-e10s'], 11:33:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:33:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:33:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:33:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:33:43 INFO - 'talos_options': ['--disable-e10s'], 11:33:43 INFO - 'tests': ['damp', 'tps']}, 11:33:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:33:43 INFO - 'tests': ['damp', 'tps']}, 11:33:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:33:43 INFO - 'tests': ['dromaeo_dom']}, 11:33:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:33:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:33:43 INFO - 'tests': ['basic_compositor_video']}, 11:33:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:33:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:33:43 INFO - 'tests': ['a11yr', 11:33:43 INFO - 'ts_paint', 11:33:43 INFO - 'tpaint', 11:33:43 INFO - 'sessionrestore', 11:33:43 INFO - 'sessionrestore_no_auto_restore', 11:33:43 INFO - 'tabpaint']}, 11:33:43 INFO - 'other-e10s': {'tests': ['a11yr', 11:33:43 INFO - 'ts_paint', 11:33:43 INFO - 'tpaint', 11:33:43 INFO - 'sessionrestore', 11:33:43 INFO - 'sessionrestore_no_auto_restore', 11:33:43 INFO - 'tabpaint']}, 11:33:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:33:43 INFO - 'ts_paint', 11:33:43 INFO - 'tpaint', 11:33:43 INFO - 'sessionrestore', 11:33:43 INFO - 'sessionrestore_no_auto_restore', 11:33:43 INFO - 'tabpaint']}, 11:33:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:33:43 INFO - 'ts_paint', 11:33:43 INFO - 'tpaint', 11:33:43 INFO - 'sessionrestore', 11:33:43 INFO - 'sessionrestore_no_auto_restore', 11:33:43 INFO - 'tabpaint']}, 11:33:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:33:43 INFO - 'tests': ['a11yr', 11:33:43 INFO - 'ts_paint', 11:33:43 INFO - 'tpaint', 11:33:43 INFO - 'sessionrestore', 11:33:43 INFO - 'sessionrestore_no_auto_restore', 11:33:43 INFO - 'tabpaint']}, 11:33:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:33:43 INFO - 'tests': ['a11yr', 11:33:43 INFO - 'ts_paint', 11:33:43 INFO - 'tpaint', 11:33:43 INFO - 'sessionrestore', 11:33:43 INFO - 'sessionrestore_no_auto_restore', 11:33:43 INFO - 'tabpaint']}, 11:33:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:33:43 INFO - 'tests': ['tsvgx', 11:33:43 INFO - 'tsvgr_opacity', 11:33:43 INFO - 'tart', 11:33:43 INFO - 'tscrollx', 11:33:43 INFO - 'cart']}, 11:33:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:33:43 INFO - 'tsvgr_opacity', 11:33:43 INFO - 'tart', 11:33:43 INFO - 'tscrollx', 11:33:43 INFO - 'cart']}, 11:33:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:33:43 INFO - 'talos_options': ['--disable-e10s'], 11:33:43 INFO - 'tests': ['tp5o']}, 11:33:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:33:43 INFO - 'tests': ['tp5o']}, 11:33:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:33:43 INFO - 'talos_options': ['--disable-e10s', 11:33:43 INFO - '--xperf_path', 11:33:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:33:43 INFO - 'tests': ['tp5n']}, 11:33:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:33:43 INFO - 'talos_options': ['--xperf_path', 11:33:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:33:43 INFO - 'tests': ['tp5n']}}, 11:33:43 INFO - 'talos.zip': {'path': '', 11:33:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:33:43 INFO - Running post-action listener: _resource_record_post_action 11:33:43 INFO - ##### 11:33:43 INFO - ##### Finished populate-webroot step (success) 11:33:43 INFO - ##### 11:33:43 INFO - ##### 11:33:43 INFO - ##### Running create-virtualenv step. 11:33:43 INFO - ##### 11:33:43 INFO - Running pre-action listener: _resource_record_pre_action 11:33:43 INFO - Running main action method: create_virtualenv 11:33:43 INFO - Creating virtualenv /builds/slave/test/build/venv 11:33:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:33:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:33:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:33:43 INFO - Using real prefix '/usr' 11:33:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:33:43 INFO - Installing distribute.............................................................................................................................................................................................done. 11:33:45 INFO - Installing pip.................done. 11:33:45 INFO - Return code: 0 11:33:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:33: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')]} 11:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33: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')]} 11:33:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf543b0>, '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 0xf552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55740>, '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': '1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:33:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:33:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:33:45 INFO - Using env: {'DISPLAY': ':0', 11:33:45 INFO - 'HOME': '/home/cltbld', 11:33:45 INFO - 'LANG': 'en_US.UTF-8', 11:33:45 INFO - 'LANGUAGE': 'en_US:en', 11:33:45 INFO - 'LOGNAME': 'cltbld', 11:33:45 INFO - 'MAIL': '/var/mail/cltbld', 11:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:45 INFO - 'MOZ_NO_REMOTE': '1', 11:33:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:45 INFO - 'NO_EM_RESTART': '1', 11:33:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:45 INFO - 'PWD': '/builds/slave/test', 11:33:45 INFO - 'SHELL': '/bin/bash', 11:33:45 INFO - 'SHLVL': '1', 11:33:45 INFO - 'TERM': 'linux', 11:33:45 INFO - 'TMOUT': '86400', 11:33:45 INFO - 'USER': 'cltbld', 11:33:45 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531', 11:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:45 INFO - '_': '/tools/buildbot/bin/python'} 11:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:33:46 INFO - Cleaning up... 11:33:46 INFO - Return code: 0 11:33:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf543b0>, '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 0xf552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55740>, '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': '1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:33:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:33:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:33:46 INFO - Using env: {'DISPLAY': ':0', 11:33:46 INFO - 'HOME': '/home/cltbld', 11:33:46 INFO - 'LANG': 'en_US.UTF-8', 11:33:46 INFO - 'LANGUAGE': 'en_US:en', 11:33:46 INFO - 'LOGNAME': 'cltbld', 11:33:46 INFO - 'MAIL': '/var/mail/cltbld', 11:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:46 INFO - 'MOZ_NO_REMOTE': '1', 11:33:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:46 INFO - 'NO_EM_RESTART': '1', 11:33:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:46 INFO - 'PWD': '/builds/slave/test', 11:33:46 INFO - 'SHELL': '/bin/bash', 11:33:46 INFO - 'SHLVL': '1', 11:33:46 INFO - 'TERM': 'linux', 11:33:46 INFO - 'TMOUT': '86400', 11:33:46 INFO - 'USER': 'cltbld', 11:33:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531', 11:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:46 INFO - '_': '/tools/buildbot/bin/python'} 11:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:46 INFO - Downloading/unpacking psutil>=3.1.1 11:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:33:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:33:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:33:48 INFO - Installing collected packages: psutil 11:33:48 INFO - Running setup.py install for psutil 11:33:48 INFO - building 'psutil._psutil_linux' extension 11:33:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:33:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:33:48 INFO - building 'psutil._psutil_posix' extension 11:33:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:33:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:33:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:33:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:33:48 INFO - Successfully installed psutil 11:33:48 INFO - Cleaning up... 11:33:48 INFO - Return code: 0 11:33:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:33: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')]} 11:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33: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')]} 11:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf543b0>, '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 0xf552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55740>, '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': '1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:33:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:33:48 INFO - Using env: {'DISPLAY': ':0', 11:33:48 INFO - 'HOME': '/home/cltbld', 11:33:48 INFO - 'LANG': 'en_US.UTF-8', 11:33:48 INFO - 'LANGUAGE': 'en_US:en', 11:33:48 INFO - 'LOGNAME': 'cltbld', 11:33:48 INFO - 'MAIL': '/var/mail/cltbld', 11:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:48 INFO - 'MOZ_NO_REMOTE': '1', 11:33:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:48 INFO - 'NO_EM_RESTART': '1', 11:33:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:48 INFO - 'PWD': '/builds/slave/test', 11:33:48 INFO - 'SHELL': '/bin/bash', 11:33:48 INFO - 'SHLVL': '1', 11:33:48 INFO - 'TERM': 'linux', 11:33:48 INFO - 'TMOUT': '86400', 11:33:48 INFO - 'USER': 'cltbld', 11:33:48 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531', 11:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:48 INFO - '_': '/tools/buildbot/bin/python'} 11:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:33:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:33:51 INFO - Installing collected packages: mozsystemmonitor 11:33:51 INFO - Running setup.py install for mozsystemmonitor 11:33:51 INFO - Successfully installed mozsystemmonitor 11:33:51 INFO - Cleaning up... 11:33:51 INFO - Return code: 0 11:33:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:51 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 0xc95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf543b0>, '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 0xf552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55740>, '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': '1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:33:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:33:51 INFO - Using env: {'DISPLAY': ':0', 11:33:51 INFO - 'HOME': '/home/cltbld', 11:33:51 INFO - 'LANG': 'en_US.UTF-8', 11:33:51 INFO - 'LANGUAGE': 'en_US:en', 11:33:51 INFO - 'LOGNAME': 'cltbld', 11:33:51 INFO - 'MAIL': '/var/mail/cltbld', 11:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:51 INFO - 'MOZ_NO_REMOTE': '1', 11:33:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:51 INFO - 'NO_EM_RESTART': '1', 11:33:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:51 INFO - 'PWD': '/builds/slave/test', 11:33:51 INFO - 'SHELL': '/bin/bash', 11:33:51 INFO - 'SHLVL': '1', 11:33:51 INFO - 'TERM': 'linux', 11:33:51 INFO - 'TMOUT': '86400', 11:33:51 INFO - 'USER': 'cltbld', 11:33:51 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531', 11:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:51 INFO - '_': '/tools/buildbot/bin/python'} 11:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:51 INFO - Downloading/unpacking jsonschema==2.5.1 11:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:33:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:53 INFO - Downloading functools32-3.2.3-2.tar.gz 11:33:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:33:53 INFO - warning: no files found matching '*.txt' 11:33:53 INFO - no previously-included directories found matching 'build' 11:33:53 INFO - no previously-included directories found matching 'dist' 11:33:53 INFO - no previously-included directories found matching '.git*' 11:33:53 INFO - Installing collected packages: jsonschema, functools32 11:33:53 INFO - Running setup.py install for functools32 11:33:53 INFO - warning: no files found matching '*.txt' 11:33:53 INFO - no previously-included directories found matching 'build' 11:33:53 INFO - no previously-included directories found matching 'dist' 11:33:53 INFO - no previously-included directories found matching '.git*' 11:33:53 INFO - Successfully installed jsonschema functools32 11:33:53 INFO - Cleaning up... 11:33:53 INFO - Return code: 0 11:33:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:53 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 0xc95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf543b0>, '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 0xf552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55740>, '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': '1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:33:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:33:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:33:53 INFO - Using env: {'DISPLAY': ':0', 11:33:53 INFO - 'HOME': '/home/cltbld', 11:33:53 INFO - 'LANG': 'en_US.UTF-8', 11:33:53 INFO - 'LANGUAGE': 'en_US:en', 11:33:53 INFO - 'LOGNAME': 'cltbld', 11:33:53 INFO - 'MAIL': '/var/mail/cltbld', 11:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:53 INFO - 'MOZ_NO_REMOTE': '1', 11:33:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:53 INFO - 'NO_EM_RESTART': '1', 11:33:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:53 INFO - 'PWD': '/builds/slave/test', 11:33:53 INFO - 'SHELL': '/bin/bash', 11:33:53 INFO - 'SHLVL': '1', 11:33:53 INFO - 'TERM': 'linux', 11:33:53 INFO - 'TMOUT': '86400', 11:33:53 INFO - 'USER': 'cltbld', 11:33:53 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531', 11:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:53 INFO - '_': '/tools/buildbot/bin/python'} 11:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:54 INFO - Downloading/unpacking blobuploader==1.2.4 11:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:55 INFO - Downloading blobuploader-1.2.4.tar.gz 11:33:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:33:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:33:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:56 INFO - Downloading docopt-0.6.1.tar.gz 11:33:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:33:56 INFO - Installing collected packages: blobuploader, requests, docopt 11:33:56 INFO - Running setup.py install for blobuploader 11:33:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:33:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:33:56 INFO - Running setup.py install for requests 11:33:57 INFO - Running setup.py install for docopt 11:33:57 INFO - Successfully installed blobuploader requests docopt 11:33:57 INFO - Cleaning up... 11:33:57 INFO - Return code: 0 11:33:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:57 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 0xc95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf543b0>, '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 0xf552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55740>, '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': '1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:33:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:33:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:33:57 INFO - Using env: {'DISPLAY': ':0', 11:33:57 INFO - 'HOME': '/home/cltbld', 11:33:57 INFO - 'LANG': 'en_US.UTF-8', 11:33:57 INFO - 'LANGUAGE': 'en_US:en', 11:33:57 INFO - 'LOGNAME': 'cltbld', 11:33:57 INFO - 'MAIL': '/var/mail/cltbld', 11:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:57 INFO - 'MOZ_NO_REMOTE': '1', 11:33:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:57 INFO - 'NO_EM_RESTART': '1', 11:33:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:57 INFO - 'PWD': '/builds/slave/test', 11:33:57 INFO - 'SHELL': '/bin/bash', 11:33:57 INFO - 'SHLVL': '1', 11:33:57 INFO - 'TERM': 'linux', 11:33:57 INFO - 'TMOUT': '86400', 11:33:57 INFO - 'USER': 'cltbld', 11:33:57 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531', 11:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:57 INFO - '_': '/tools/buildbot/bin/python'} 11:33:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:33:57 INFO - Running setup.py (path:/tmp/pip-UiotH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:33:57 INFO - Running setup.py (path:/tmp/pip-dxWXpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:33:57 INFO - Running setup.py (path:/tmp/pip-ZRciLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:33:57 INFO - Running setup.py (path:/tmp/pip-otGbjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:33:57 INFO - Running setup.py (path:/tmp/pip-561KMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:33:57 INFO - Running setup.py (path:/tmp/pip-ZHhD2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:33:57 INFO - Running setup.py (path:/tmp/pip-xl2m8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:33:58 INFO - Running setup.py (path:/tmp/pip-w8Nhvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:33:58 INFO - Running setup.py (path:/tmp/pip-Jr_fXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:33:58 INFO - Running setup.py (path:/tmp/pip-Vj0zYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:33:58 INFO - Running setup.py (path:/tmp/pip-RFcGcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:33:58 INFO - Running setup.py (path:/tmp/pip-vqb7Ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:33:58 INFO - Running setup.py (path:/tmp/pip-G7Uqhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:33:58 INFO - Running setup.py (path:/tmp/pip-a7W3q3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:33:58 INFO - Running setup.py (path:/tmp/pip-RQ3Q1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:33:58 INFO - Running setup.py (path:/tmp/pip-PCBJwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:33:58 INFO - Running setup.py (path:/tmp/pip-YtGUEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:33:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:33:58 INFO - Running setup.py install for manifestparser 11:33:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:33:58 INFO - Running setup.py install for mozcrash 11:33:58 INFO - Running setup.py install for mozdebug 11:33:59 INFO - Running setup.py install for mozdevice 11:33:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:33:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:33:59 INFO - Running setup.py install for mozfile 11:33:59 INFO - Running setup.py install for mozhttpd 11:33:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:33:59 INFO - Running setup.py install for mozinfo 11:33:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:33:59 INFO - Running setup.py install for mozInstall 11:33:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:33:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:33:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:33:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:33:59 INFO - Running setup.py install for mozleak 11:33:59 INFO - Running setup.py install for mozlog 11:33:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:33:59 INFO - Running setup.py install for moznetwork 11:33:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:33:59 INFO - Running setup.py install for mozprocess 11:34:00 INFO - Running setup.py install for mozprofile 11:34:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:34:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:34:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:34:00 INFO - Running setup.py install for mozrunner 11:34:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:34:00 INFO - Running setup.py install for mozscreenshot 11:34:00 INFO - Running setup.py install for moztest 11:34:00 INFO - Running setup.py install for mozversion 11:34:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:34:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:34:00 INFO - Cleaning up... 11:34:00 INFO - Return code: 0 11:34:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:00 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 0xc95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf543b0>, '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 0xf552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55740>, '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': '1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:34:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:34:00 INFO - Using env: {'DISPLAY': ':0', 11:34:00 INFO - 'HOME': '/home/cltbld', 11:34:00 INFO - 'LANG': 'en_US.UTF-8', 11:34:00 INFO - 'LANGUAGE': 'en_US:en', 11:34:00 INFO - 'LOGNAME': 'cltbld', 11:34:00 INFO - 'MAIL': '/var/mail/cltbld', 11:34:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:00 INFO - 'MOZ_NO_REMOTE': '1', 11:34:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:00 INFO - 'NO_EM_RESTART': '1', 11:34:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:00 INFO - 'PWD': '/builds/slave/test', 11:34:00 INFO - 'SHELL': '/bin/bash', 11:34:00 INFO - 'SHLVL': '1', 11:34:00 INFO - 'TERM': 'linux', 11:34:00 INFO - 'TMOUT': '86400', 11:34:00 INFO - 'USER': 'cltbld', 11:34:00 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531', 11:34:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:00 INFO - '_': '/tools/buildbot/bin/python'} 11:34:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:34:00 INFO - Running setup.py (path:/tmp/pip-hHb5kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:34:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:34:00 INFO - Running setup.py (path:/tmp/pip-9Ivxet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:34:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:34:00 INFO - Running setup.py (path:/tmp/pip-fs5vr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:34:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:34:01 INFO - Running setup.py (path:/tmp/pip-BzPjFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:34:01 INFO - Running setup.py (path:/tmp/pip-ao0TWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:34:01 INFO - Running setup.py (path:/tmp/pip-rI5bOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:34:01 INFO - Running setup.py (path:/tmp/pip-YdEpIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:34:01 INFO - Running setup.py (path:/tmp/pip-_xM54_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:34:01 INFO - Running setup.py (path:/tmp/pip-v2SMgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:34:01 INFO - Running setup.py (path:/tmp/pip-doFKrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:34:01 INFO - Running setup.py (path:/tmp/pip-NyrDi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:34:01 INFO - Running setup.py (path:/tmp/pip-2srDGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:34:01 INFO - Running setup.py (path:/tmp/pip-Wgy92H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:34:01 INFO - Running setup.py (path:/tmp/pip-yVfjjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:34:01 INFO - Running setup.py (path:/tmp/pip-1UgzNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:34:01 INFO - Running setup.py (path:/tmp/pip-fZfabM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:34:01 INFO - Running setup.py (path:/tmp/pip-kTs3ul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:34:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:03 INFO - Downloading blessings-1.6.tar.gz 11:34:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:34:04 INFO - Installing collected packages: blessings 11:34:04 INFO - Running setup.py install for blessings 11:34:04 INFO - Successfully installed blessings 11:34:04 INFO - Cleaning up... 11:34:04 INFO - Return code: 0 11:34:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:34:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:34:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:34:04 INFO - Reading from file tmpfile_stdout 11:34:04 INFO - Current package versions: 11:34:04 INFO - argparse == 1.2.1 11:34:04 INFO - blessings == 1.6 11:34:04 INFO - blobuploader == 1.2.4 11:34:04 INFO - docopt == 0.6.1 11:34:04 INFO - functools32 == 3.2.3-2 11:34:04 INFO - jsonschema == 2.5.1 11:34:04 INFO - manifestparser == 1.1 11:34:04 INFO - mozInstall == 1.12 11:34:04 INFO - mozcrash == 0.17 11:34:04 INFO - mozdebug == 0.1 11:34:04 INFO - mozdevice == 0.48 11:34:04 INFO - mozfile == 1.2 11:34:04 INFO - mozhttpd == 0.7 11:34:04 INFO - mozinfo == 0.9 11:34:04 INFO - mozleak == 0.1 11:34:04 INFO - mozlog == 3.2 11:34:04 INFO - moznetwork == 0.27 11:34:04 INFO - mozprocess == 0.23 11:34:04 INFO - mozprofile == 0.28 11:34:04 INFO - mozrunner == 6.12 11:34:04 INFO - mozscreenshot == 0.1 11:34:04 INFO - mozsystemmonitor == 0.3 11:34:04 INFO - moztest == 0.7 11:34:04 INFO - mozversion == 1.4 11:34:04 INFO - psutil == 3.1.1 11:34:04 INFO - requests == 1.2.3 11:34:04 INFO - wsgiref == 0.1.2 11:34:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:34:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:04 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 0xc95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf543b0>, '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 0xf552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55740>, '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': '1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:34:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:34:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:34:04 INFO - Using env: {'DISPLAY': ':0', 11:34:04 INFO - 'HOME': '/home/cltbld', 11:34:04 INFO - 'LANG': 'en_US.UTF-8', 11:34:04 INFO - 'LANGUAGE': 'en_US:en', 11:34:04 INFO - 'LOGNAME': 'cltbld', 11:34:04 INFO - 'MAIL': '/var/mail/cltbld', 11:34:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:04 INFO - 'MOZ_NO_REMOTE': '1', 11:34:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:04 INFO - 'NO_EM_RESTART': '1', 11:34:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:04 INFO - 'PWD': '/builds/slave/test', 11:34:04 INFO - 'SHELL': '/bin/bash', 11:34:04 INFO - 'SHLVL': '1', 11:34:04 INFO - 'TERM': 'linux', 11:34:04 INFO - 'TMOUT': '86400', 11:34:04 INFO - 'USER': 'cltbld', 11:34:04 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531', 11:34:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:04 INFO - '_': '/tools/buildbot/bin/python'} 11:34:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:34:04 INFO - Cleaning up... 11:34:04 INFO - Return code: 0 11:34:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:34:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:04 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 0xc95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf543b0>, '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 0xf552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55740>, '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': '1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:34:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:34:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:34:04 INFO - Using env: {'DISPLAY': ':0', 11:34:04 INFO - 'HOME': '/home/cltbld', 11:34:04 INFO - 'LANG': 'en_US.UTF-8', 11:34:04 INFO - 'LANGUAGE': 'en_US:en', 11:34:04 INFO - 'LOGNAME': 'cltbld', 11:34:04 INFO - 'MAIL': '/var/mail/cltbld', 11:34:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:04 INFO - 'MOZ_NO_REMOTE': '1', 11:34:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:04 INFO - 'NO_EM_RESTART': '1', 11:34:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:04 INFO - 'PWD': '/builds/slave/test', 11:34:04 INFO - 'SHELL': '/bin/bash', 11:34:04 INFO - 'SHLVL': '1', 11:34:04 INFO - 'TERM': 'linux', 11:34:04 INFO - 'TMOUT': '86400', 11:34:04 INFO - 'USER': 'cltbld', 11:34:04 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531', 11:34:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:04 INFO - '_': '/tools/buildbot/bin/python'} 11:34:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:34:04 INFO - Cleaning up... 11:34:04 INFO - Return code: 0 11:34:04 INFO - Running post-action listener: _resource_record_post_action 11:34:04 INFO - Running post-action listener: _start_resource_monitoring 11:34:04 INFO - Starting resource monitoring. 11:34:04 INFO - ##### 11:34:04 INFO - ##### Finished create-virtualenv step (success) 11:34:04 INFO - ##### 11:34:04 INFO - ##### 11:34:04 INFO - ##### Running install step. 11:34:04 INFO - ##### 11:34:04 INFO - Running pre-action listener: _resource_record_pre_action 11:34:04 INFO - Running main action method: install 11:34:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:34:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:34:05 INFO - Reading from file tmpfile_stdout 11:34:05 INFO - Detecting whether we're running mozinstall >=1.0... 11:34:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:34:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:34:05 INFO - Reading from file tmpfile_stdout 11:34:05 INFO - Output received: 11:34:05 INFO - Usage: mozinstall [options] installer 11:34:05 INFO - Options: 11:34:05 INFO - -h, --help show this help message and exit 11:34:05 INFO - -d DEST, --destination=DEST 11:34:05 INFO - Directory to install application into. [default: 11:34:05 INFO - "/builds/slave/test"] 11:34:05 INFO - --app=APP Application being installed. [default: firefox] 11:34:05 INFO - mkdir: /builds/slave/test/build/application 11:34:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:34:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:34:22 INFO - Reading from file tmpfile_stdout 11:34:22 INFO - Output received: 11:34:22 INFO - /builds/slave/test/build/application/firefox/firefox 11:34:22 INFO - Running post-action listener: _resource_record_post_action 11:34:22 INFO - ##### 11:34:22 INFO - ##### Finished install step (success) 11:34:22 INFO - ##### 11:34:22 INFO - ##### 11:34:22 INFO - ##### Running run-tests step. 11:34:22 INFO - ##### 11:34:22 INFO - Running pre-action listener: _resource_record_pre_action 11:34:22 INFO - Running main action method: run_tests 11:34:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:34:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:34:22 INFO - Python 2.7.3 11:34:22 INFO - Return code: 0 11:34:22 INFO - grabbing minidump binary from tooltool 11:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:22 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 0xf543b0>, '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 0xf552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:34:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:34:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:34:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:34:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:34:22 INFO - Return code: 0 11:34:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:34:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:34:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:34:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:34:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:34:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:34:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:34:22 INFO - Using env: {'DISPLAY': ':0', 11:34:22 INFO - 'HOME': '/home/cltbld', 11:34:22 INFO - 'LANG': 'en_US.UTF-8', 11:34:22 INFO - 'LANGUAGE': 'en_US:en', 11:34:22 INFO - 'LOGNAME': 'cltbld', 11:34:22 INFO - 'MAIL': '/var/mail/cltbld', 11:34:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:34:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:22 INFO - 'MOZ_NO_REMOTE': '1', 11:34:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:34:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:22 INFO - 'NO_EM_RESTART': '1', 11:34:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:22 INFO - 'PWD': '/builds/slave/test', 11:34:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:34:22 INFO - 'SHELL': '/bin/bash', 11:34:22 INFO - 'SHLVL': '1', 11:34:22 INFO - 'TERM': 'linux', 11:34:22 INFO - 'TMOUT': '86400', 11:34:22 INFO - 'USER': 'cltbld', 11:34:22 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531', 11:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:22 INFO - '_': '/tools/buildbot/bin/python'} 11:34:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:34:23 INFO - mozversion application_buildid: 20160718083017 11:34:23 INFO - mozversion application_changeset: ec19b4cb42d5355d336967e00059ddee3053f924 11:34:23 INFO - mozversion application_display_name: Nightly 11:34:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:34:23 INFO - mozversion application_name: Firefox 11:34:23 INFO - mozversion application_remotingname: firefox 11:34:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:34:23 INFO - mozversion application_vendor: Mozilla 11:34:23 INFO - mozversion application_version: 50.0a1 11:34:23 INFO - mozversion platform_buildid: 20160718083017 11:34:23 INFO - mozversion platform_changeset: ec19b4cb42d5355d336967e00059ddee3053f924 11:34:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:34:23 INFO - mozversion platform_version: 50.0a1 11:34:23 INFO - using testdate: 1468866863 11:34:23 INFO - actual date: 1468866863 11:34:23 INFO - starting webserver on 'localhost:52737' 11:34:23 INFO - SUITE-START | Running 2 tests 11:34:23 INFO - TEST-START | dromaeo_css 11:34:23 INFO - operating with platform_type : linux_ 11:34:23 INFO - Initialising browser for dromaeo_css test... 11:34:23 INFO - TEST-INFO | started process 18644 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwt8ofN/profile http://localhost:52737/getInfo.html) 11:34:26 INFO - PROCESS | 18644 | __metrics Screen width/height:1600/1200 11:34:26 INFO - PROCESS | 18644 | colorDepth:24 11:34:26 INFO - PROCESS | 18644 | Browser inner width/height: 1024/697 11:34:26 INFO - PROCESS | 18644 | __metrics 11:34:27 INFO - PROCESS | 18644 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:34:27 INFO - PROCESS | 18644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:34:28 INFO - TEST-INFO | 18644: exit 0 11:34:28 INFO - Browser initialized. 11:34:28 INFO - Running cycle 1/1 for dromaeo_css test... 11:34:28 INFO - TEST-INFO | started process 18725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwt8ofN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:34:40 INFO - PROCESS | 18725 | RSS: Main: 158052352 11:34:40 INFO - PROCESS | 18725 | 11:35:31 INFO - PROCESS | 18725 | 1468866931297 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:37:39 INFO - PROCESS | 18725 | Cycle 1(1): loaded http://localhost:52737/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52737/tests/dromaeo/cssquery-ext.html) 11:37:40 INFO - PROCESS | 18725 | RSS: Main: 256290816 11:37:40 INFO - PROCESS | 18725 | 11:40:43 INFO - PROCESS | 18725 | Cycle 1(1): loaded http://localhost:52737/tests/dromaeo/cssquery-ext.html (next: http://localhost:52737/tests/dromaeo/cssquery-jquery.html) 11:40:43 INFO - PROCESS | 18725 | RSS: Main: 242888704 11:40:43 INFO - PROCESS | 18725 | 11:43:45 INFO - PROCESS | 18725 | Cycle 1(1): loaded http://localhost:52737/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52737/tests/dromaeo/cssquery-mootools.html) 11:43:46 INFO - PROCESS | 18725 | RSS: Main: 236892160 11:43:46 INFO - PROCESS | 18725 | 11:46:48 INFO - PROCESS | 18725 | Cycle 1(1): loaded http://localhost:52737/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52737/tests/dromaeo/cssquery-prototype.html) 11:46:48 INFO - PROCESS | 18725 | RSS: Main: 242221056 11:46:48 INFO - PROCESS | 18725 | 11:49:51 INFO - PROCESS | 18725 | Cycle 1(1): loaded http://localhost:52737/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52737/tests/dromaeo/cssquery-yui.html) 11:49:52 INFO - PROCESS | 18725 | RSS: Main: 209870848 11:49:52 INFO - PROCESS | 18725 | 11:52:54 INFO - PROCESS | 18725 | Cycle 1(1): loaded http://localhost:52737/tests/dromaeo/cssquery-yui.html (next: http://localhost:52737/tests/dromaeo/cssquery-dojo.html) 11:52:55 INFO - PROCESS | 18725 | RSS: Main: 278577152 11:52:55 INFO - PROCESS | 18725 | 11:52:55 INFO - PROCESS | 18725 | __start_tp_report 11:52:55 INFO - PROCESS | 18725 | _x_x_mozilla_page_load 11:52:55 INFO - PROCESS | 18725 | _x_x_mozilla_page_load_details 11:52:55 INFO - PROCESS | 18725 | |i|pagename|runs| 11:52:55 INFO - PROCESS | 18725 | |0;dojo.html;3107.238726512004;3122.797018193816;3144.701253380928;3145.3394787094717;3161.130689060508;5386.407495175527;5458.4541545845395;5476.233327334171;5525.198846167308;5586.413426590206;5477.904419116173;5489.505944464997;5537.889242215153;5568.081266591008;5590.524805391547;4898.559129678329;4905.117078925792;4969.105560999019;4980.6762560433635;5003.649744517885;4935.111679897617;5055.292259083732;5057.9494205057845;5097.311862898517;5103.770330335125;4831.22700367943;4838.298446725205;4859.902801943941;4972.279019542164;4977.701337919718;4887.951120488785;4891.26631005352;4894.902101957941;4897.363342765453;4897.4123105227245;4880.560749532559;4886.242632391985;4886.413630364379;4888.902221955576;4891.584215341701;5435.619506634537;5518.889622207534;5527.060399732055;5538.975289571442;5551.750171242304;5831.504322132624;5852.853678658025;5886.6468011919;5892.528597712173;5909.556783241274;5727.570432217601;5743.195952566644;5926.407359264039;5954.612950158269;5987.461128498412;5398.055340315468;5444.8366549003595;5487.067198576252;5490.368607610136;5494.983428065821;5928.288605367297;5967.224260846062;5982.222311099529;5982.312034116132;5983.850403739942;5578.079616863253;5638.407967163471;5672.347680016768;5749.741261643236;5760.683162426023;5796.797112101056;5805.419458054245;5852.678102704393;5855.619384739978;5862.179294898718;5715.942840571541;5717.514011309002;5717.742701578439;5721.942780572141;5728.627639203439;5500.87232117415;5711.914321285184;5736.741846616829;5776.5089967352405;5796.42035796417;4412.955870441318;4414.955850441519;4456.68803183774;4458.821647134143;4463.375127482155;3956.5054368203973;3982.761034337891;3984.7011474139554;3987.6211759882763;4000.739951903117;5440.972795135999;5447.319085114361;5466.1527463243265;5492.5605951523785;5572.888542229132;5914.319853216849;5915.319738230072;5917.733701983335;5924.259467566554;5930.851728706731;5490.149026900836;5492.340919089735;5499.340079190522;5502.394736578973;5548.500634942875;4919.163742163841;5046.21783623539;5060.974695126501;5070.29015937769;5099.898002039939;6042.546808989343;6090.299615544269;6092.7562897484495;6102.816915492543;6110.175126357974;5934.19888315072;5950.4644581986095;5950.642961422329;5951.404859514014;5955.851103722442;5932.970335148297;5980.581359304807;6026.578139530191;6036.607620504653;6039.063945088518;5754.597178197486;5765.827025189251;5798.652080875161;5802;5808.041673123887;5694.17434471991;5878.94121058801;5882.23530940975;5890.057590785454;5890.116482527484;5688.459596338341;5705.201271821865;5712.285964254468;5736.598438109292;5749.425057494217;5716.657000579979;5717.142428635738;5718.914216286676;5721.599488035798;5731.570132240182;5471.8084867029465;5690.2887139107615;5716.5426765859465;5724.942750572441;5731.684757338219;5809.186713860147;5850.882982340244;5863.589548731718;5916.49709774674;5925.229720136354;5684.147377893349;5694.14587811815;5719.8570035749435;5732.283464566929;5732.656040637575 11:52:55 INFO - PROCESS | 18725 | |1;ext.html;596.373807502123;615.8337248942782;630.6688988281152;633.104157616972;647.880142173698;34454.82772586137;37214.62785372149;44553.554464455345;45708;45725.08549829001;47424.28863567049;47976.76011619946;48074;48075.51924480754;48104.27843582349;9138.497382643953;9291.210247129002;9292.907070929306;9294.581743821544;9297.442153470813;8983.326250531203;9058.909410905873;9087.818243635124;9096.226820720247;9099.090090990914;9175.220106290973;9195.080491950785;9208.539573021322;9210.447373157598;9223.769405764842;9108.681196158135;9135.040820713795;9145.268378529734;9152.22206112478;9161.450312981242;9075.682351117744;9148.039455857172;9154.359194856363;9166.175044245983;9170.587323570455;44198;44397;44542;44563.33155002678;44575.331370029475;3427.503012063262;3494.8951531454095;3555.1289933966086;3791.9241615167816;4354.7604881731495;33898;34087;34737.13157171091;35070.47394289088;35182.296354073034;4512.616427603658;4549.377511036146;4613.584777370019;4697.4832768395445;4727.479977202505;257008;257530;257744;258389;258743;61494.38505614976;61501.69249153815;61787.6910615453;61859.690701546206;61883.69058154771;36667;37676;37695.86912392633;39276.803615981735;64727.67636161883;15907.681846363008;16308.83691163097;16336.509904702878;16337.346506139858;16338.591535211715;11956.940215298868;12126.211796233216;12129.090318226168;12132.393380331125;12135.029197664166;20419;20486;20537.17851285932;20545.897270513553;20565.280215192397;7063;7156.284371562906;7193.712251509881;7305;7374.33630973215;988.619381538113;1052.5263631365915;1064.4784055812595;1108.9390083545482;1139.6524060161564;33989.490157647655;34563.82718086393;34622.30755384878;34624;35060.298794024486;904.2133343990639;1102.4102105373747;1189.411241435495;1228.072805032195;1228.4778968938344;17491.825081749274;17732.556686082695;17901.641967160584;17930.462086137435;17934.282628694706;573726;574412;579074;579395;580234;61773;62039.37960620426;62250.37749622446;62366.68816655887;62397;1198.9940050299692;1309.214471317202;1335.933203339829;1341.7987301904793;1358.9388477518535;34645.826770865984;35636.46545301771;35835.28329433344;35889.51381077366;35924;53244.4675553255;53696;53707.194392083366;53770.46229537811;53903;418087;418355;418602;420316;701086;28131.57802632921;29102;29301.41397172087;30450.390992180477;30451.54322685206;49892.25161622506;50402;50647.49352506575;51106.488935110174;51806.22290665718;41310.38034429426;41775.16449670929;43451.534064713735;46181.76909115433;46344.53655463537;42242.36636450394;43097.78451107725;43183.568164317956;43317.783411082746;43858.56141438545;44039.77980110079;44424.77787611041;45541;45688.31467527923;45974.77012614915;37856.621433786415;39076.82769516919;39398.40902386409;39732.39675523541;40250;29178.854105729337;29572.408551828412;29729.554056688736;29814.85092574523;30075.699243008166 11:52:55 INFO - PROCESS | 18725 | |2;jquery.html;388.50271652285085;389.01332075916537;395.4147861165475;398.77269956125;411.13456174752145;19105.23579056838;20375.08312125954;20692.89653551732;20743.688844667304;21826.70819563947;15445.536633900972;15575.376984920618;17616.559586010357;19874.105665245064;20725;5569.944300557004;5610.326760788711;5747.137929310595;5751.626144300628;5837.299524057119;5685.118806584986;5735.426457354252;5744.368119506851;5746.770129194827;5771.163181338703;5494.340679118512;5639.15412688096;5639.577031722617;5662.915056274159;5712.971435142818;5586.13414920688;5631.155326700987;5634.295713035871;5638.4361563843495;5650.124230744241;4905.092557876804;5149.382074151088;5152.690838549699;5153.072446959546;5154.793808247666;24492;24764.504709905883;25188.11841585554;25405.61891571628;25428.872855635604;2157.7734337894453;2309.7921187093243;2339.368370539945;2558.7952963762855;2971.9405611887855;10606;10684.679459616224;11044.723881902937;11625.418729063598;15968.840311596967;1899.7910229874703;1973.4868934077244;2021.4238941901635;2041.2549419461939;2086.353230498535;62017.6899115506;67102.3289767101;79952.20047799505;88314;93540.53229733875;11329.71675708114;11398.20212585111;11504.194706370474;11597.942010289895;11752.941235293769;14168.149911005372;14754.926225368805;15692.450764223197;15758.212089395485;16110.275037623334;7674.654640541189;7786.688532458638;8247.134050924567;8296.792580185424;8321.583920803936;7686.500377475446;7731.536107833548;7751.689932402641;7802.531848089019;7937.880931786028;4893.7063776173545;4902.730349830722;4925.556699897026;4969.055879382906;5090.49095090488;1879.8026207248315;1881.5766452548066;1912.6270377276298;1944.1251436853472;1956.7162761399518;930.3673502018557;950.3632566180537;999.5402115027024;1003.7641154328727;1048.4548035021746;20495.180192792122;20812;20864.687029694567;21179.364619061453;21194;909.5679552212646;995.1690338567232;999.2106236073566;1004.2267454060333;1026.7176526455135;11279.154063445274;11536.538538458535;11782.291567722632;11792.23350482216;11801.17391782567;505466;510090;517629;521008;522829;100251;101072;101728;102376;103237.48381258195;957;980.0787259975742;981.79873126009;993.64228877604;1055.904968552834;18819.529511762317;18917.527061823566;19230.23079076821;19301.131449084543;19473.318433854747;30919.690803091682;42261;43382.56617433785;45647.543524565655;47367;61091.69454152701;61764.38235617586;62141.378586213556;62468;64674.353256466835;8532.530710810965;8633.39566230358;8701.695440659547;8937.508437036025;9062.546872656472;12717.236965782082;12903.354832258161;13052.738945221232;13130;13155.671108221988;6012.849678758066;11160.49777760019;11197.72005699864;11909.106816988933;11963.820542691692;11521.308721476404;11579.42102894835;11725.648230553097;11751.647450576496;11795.705107372385;10732.785344292914;11296.661100167008;11693.941530292293;11722.58970936013;11807.527698891949;8554.743357699279;8588.03712719111;8653.35099867525;8871.201591856763;8910.643574257216;8975.057618950177;10818.296810707594;10889.292196007234;11339.433028348714;11484.712882178012 11:52:55 INFO - PROCESS | 18725 | |3;mootools.html;1512.107856364745;1521.018942781906;1668.557832174474;1808.0507733439952;1849.9907500462505;8873.68942087027;9441.81116377672;9481.573329200186;9527.571259293323;9533.47565883876;8135.837283254331;8870.37907346486;9014.729558113251;9060;9329.253659707225;2351.623740201564;2384.4396566806786;2391.8804059797026;2394.5570069537102;2395.4849707312924;2370.0756704885107;2372.988135059331;2408.4701365699607;2409.3856066702965;2411.6382542618658;2067.834573234145;2142.335875878475;2142.357292812158;2151.924682636108;2286.4398222435525;2357.068957761683;2392.497575509145;2394.7605239476175;2394.964075538868;2395.8802059896934;2381.3213234228333;2420.4674971506242;2425.854448733082;2426.2721183645012;2426.4297889995837;9340.859887101631;9461.668841590512;9481.857772133424;9488;9491.145796878245;5344.385395679507;5448.264484294609;5476.342838859323;5480.287562616874;5480.369757477862;3388.728901687859;3448.5516882805327;3564.8752293669595;3569.625189355106;3602.8018458984743;1242.385019415386;1255.7614053329837;1287.3949243855373;1303.113882559859;1305.0994813578695;13470;13478.595642130655;13482.258475783829;13494.595162145151;13503.729925401536;4742.146413645508;4749;4797.856064318076;4826.782794774173;4989.675671081441;11046.171537134747;11053.060489858452;11073.114150867912;11093.335999599964;11104.389258590694;5472.7263636818;5479.0959491684225;5480.534154596824;5480.6437581557075;5481.835544933659;5035.546800787946;5085.313482679865;5086.4659210783075;5186.222066689951;5205.713685747321;4135.201187483454;4148.937225379607;4167.458230430025;4196.9370459443135;4257.74453532789;1278.6957303550328;1286.1382873474795;1286.5304163980268;1326.8759366037075;1336.0981337597084;803.8753993131074;891.9777005574913;995.9402435853872;1009.3086235928266;1026.563710423082;6306;6438.806835794933;6468.838279043061;6495.4803615710625;6582.210134783857;996.9252306076928;1031.3811712972306;1032.6901929421144;1060.4697651174413;1064.4943651765504;4472.08322293929;4487.820487180542;4514.390557274792;4523.298888672195;4554.157480866051;11192.776144477228;11525.135614828921;11722.648320550397;12030.81953770694;12060.095492837896;11755.05959523236;11865.644030679094;11883.346415947206;11906.761864762657;11908.940455297668;7663.961680191564;8300.377471689648;8614.138586141336;8626.094260102724;8640.827183456297;6535.085088087767;6695.899561506484;6740.12378390806;6771.830704232433;6841.863162736817;10702.304350217211;10817.891821081688;10863.78272434531;10872.67381978542;11014.229003969645;11032.724181895517;11199.944000279946;11387.145964052563;11424.200305978835;11454.14093942941;7798.532088074734;8127.431079824592;8288.378371622031;8394.24451799341;8442.66229350819;8867.64529418816;8876.733697989072;8924.330675199257;8929.151730585583;8937.01692813803;8036.316913062221;8105.75682729519;8155.388345873965;8207.466514676527;8587.270082043096;7823.374130069467;7908.52548847071;7970.721024764105;7991.480553763987;8363.03825060126;7621.580813055113;7697.422693297913;7720.112187098555;7794.181610930771;7807.687692492236;5543.641807757125;5568.9443105568425;5578.665280083208;5625.634333768292;5647.491725744702;5703.173039909107;5718.199452076796;5718.971405142947;5906.4093590642315;6012.068129439944 11:52:55 INFO - PROCESS | 18725 | |4;prototype.html;321.65904141609894;325.7931213679316;326.9885554005609;329.82848918562365;334.83593039410687;5291.7883284668615;5308.150695888658;5322.467753224676;5332.280142180809;5353.197020446935;5293.364796224449;5294;5299.125644268691;5307.150855863063;5314.4951229633125;4102.092526974956;4194.161167766443;4198.748075115487;4215.725977811448;4221.092465119998;4115.670746340301;4141.233871733723;4164.10471748574;4168.895777605569;4172.290710579209;4128.195001974616;4129.6283334499885;4132.318167502359;4141.192467468844;4170.249355116078;3967.5716741972865;3970.2456533258587;4100.425940368321;4112.383142528614;4145.813438395265;3630.183208778004;3630.6913912317486;3638.3450978823803;3649.59854416014;3651.47053677218;5160.741962901878;5163.63854530183;5166.741662916839;5171.689698618057;5183.144781111112;4475.5748203920575;4605.332226827125;4705.12955103307;4723.267893476483;4739.668223224376;5452.291202143696;5464.808731694411;5466.371367292772;5488.4237155098535;5521.475459831309;4045.2111838191563;4085.816138273785;4088.3867419886956;4094.1402305515876;4105.958940410587;5467.917981230285;5626.634268772516;5700.344460387067;5733.598648094635;5753.0219862623035;4052.6352628263007;4076.655922844317;4084.9387259191135;4088.4889388826396;4129.545749967501;4125.876223713293;4168.416421700964;4174;4181.519125300569;4186.413902053715;4650.67445278834;4675.064987002545;4704.176769065469;4710.105080034782;4751.3348131261655;5559.416261292587;5594.461523081104;5640.32316122068;5673.290838645169;5681.295611316588;1442.9826971984726;1445.886667266199;1450.9564713058626;1457.3223451095291;1459.3797636004656;934.1639232886664;964.8359778837614;980.9117179453883;982.729749318943;982.8230918434607;5280.524752772269;5281.471852814765;5288.206768984606;5311.7344132793205;5328.6802791832615;5584.329880414376;5604.103343465026;5622.8313150605545;5675.631083979528;5677.290338707661;5106.795728170831;5110.182370820651;5222.4149046222365;5275.736213189325;5336.4129945705945;2996.310848504856;3004.3540638762333;3009.563613276063;3016.909492715222;3029.0307101727235;5757.366689664133;5796.710164491758;5829.271341082364;5839.620424672383;5841.1238314253205;5617.21359009739;5751.728067413348;5752.453516915886;5778.27771528559;5804.2877351181505;5729.825385795902;5801.9129713054335;5804.82585522435;5849.853753656107;5859.091840764689;5372.985130576034;5614.63504872182;5650.180723795109;5653.632513886584;5665.235193249024;5536.754230298151;5568;5576.832695019156;5603.775848966159;5621.156826476062;5760.6255593386295;5803.970980145073;5811.186433899342;5817.603775094031;5822;4051.2707712612014;4173.664427383208;4181.770002649883;4182.707210495236;4183.66530677539;5655.264815573949;5694.715264236855;5695.658260504383;5707.315122185364;5708.686022268649;5563.304586926634;5573.554115670818;5580.693061881636;5590.8043218487155;5594.692291923983;5352.785888564414;5558.388577256418;5574.275344205227;5587.525060369914;5592.608517403743;5447.793643574359;5494.945050549603;5497.202905578749;5497.3952865184;5530.364008139116;5313.734313284398;5548.667079975215;5548.889022219614;5559.694216818114;5562.694051827189;5427.538659214011;5429.837104886702;5440.727963601883;5444.8094316698725;5457.808976685956 11:52:55 INFO - PROCESS | 18725 | |5;yui.html;736.5102207032323;758.7420277105787;800.5276886636883;801.0187520287644;825.3892119831324;15138.470153544627;16619.66760664786;16643;16669.666606667874;16688.83311166888;14035.228062456561;14063.718725625482;14065.226412547307;14122.364493597786;14147.36336864841;798.8042929482285;818.0428898189103;818.6807145213371;819.0089991110763;819.0294501016315;641.9903701444458;766.1687069529567;821.6713314674118;823.2467292427422;825.9917400826005;869.6956065377099;875.2997601918472;875.3609864798701;877.079066979672;877.9517126558037;676.5669971218424;860.9840388341754;871.7907702151501;871.8212766382908;872.7163671806657;592.236015539953;631.5736877607642;632.6425569553188;632.6868200240864;633.2274624957545;15196.468123615621;15243.847561524353;15250.618734531614;15253.237338133049;15275;13896.16623002623;14181.220032898187;14527.491537796232;14568.198749068797;14769.409223631043;13033.218006919615;13153.934230328883;13249.403776830066;13407;13417.127886687334;4423.800928958204;4441.578050085237;4443.266860967937;4485.775711214426;4561.954380456219;77170;77530.61234693846;77552.22447775507;77578.22421775822;77638.61180694118;11074.612388566362;11186.888131118747;11474.082073434272;11520.596779112859;11638.76722465546;21043.368698939055;21271.89364053201;21288.680669789966;21314.36056918295;21318.360449186548;8188.385871059575;8339.749807505785;8446;8652.134786521297;8716.782080447912;4500.234960056799;4507.549245075466;4621.745803980746;4636.11913736389;4789.137955168034;3515.7187425005936;3614.204874927512;3615.2588719313003;3616.764910280823;3618.2582570572968;587.3627114580643;595.2737660054727;611.0742225528328;616.8612062286039;621.3941407128104;689.5035574386434;738.9150247721581;765.285917947092;775.7982924439686;800.795797071743;10498.737531561772;10599.682009539727;10618.734531636617;10868.836967445495;11154.776904462027;611.260374946311;637.3467196123918;655.7180412422608;758.4804408979867;801.8115742800437;4806.735629540339;5249.475052494797;5279.815206467755;5345.866353341197;5349.277847490617;104732;109133;110271.44864275627;110860;115815;63395.6830215846;63667.68166159139;91430.54284728666;96820;100044;85064.14935850687;85079.5746021266;85149;85442.57278713566;85526.14473855306;9597.7290105905;9642.71071867845;9690.903090969001;9703.417794932328;9777.706668799947;46488.30267545922;49870.25194622011;50327.245091322926;51089.74455127701;52348.47651523588;72649;78194;78835.60582197053;79924.200757994;80255.59872200602;12091.758164836478;12380;12433.564825231435;12494.687632809253;13373.866261337651;14042.368093435616;14185.219812910389;14293.785593216318;14474.638134046732;15018.399264029753;13592.32038398096;13664.795028074388;13704.862951370758;13839.654008649864;13981.720365592835;12699.238045717286;12936.935315323739;12993.66114099471;13060.738785224052;13113.475460981836;12927.676808079497;13307;13431.395587198404;13440;13482.258475783534;10302.690919272434;10838.620648277272;10898.18263630215;11346.602868899548;11498.25261358009;10874.184436167478;11186.32882027081;11286.573386721895;11289.32264064126;11539 11:52:55 INFO - PROCESS | 18725 | __end_tp_report 11:52:55 INFO - PROCESS | 18725 | __start_cc_report 11:52:55 INFO - PROCESS | 18725 | _x_x_mozilla_cycle_collect,839 11:52:55 INFO - PROCESS | 18725 | __end_cc_report 11:52:55 INFO - PROCESS | 18725 | __startTimestamp1468867975049__endTimestamp 11:52:55 INFO - PROCESS | 18725 | 11:52:55 INFO - PROCESS | 18725 | ------- Summary: start ------- 11:52:55 INFO - PROCESS | 18725 | Number of tests: 6 11:52:55 INFO - PROCESS | 18725 | 11:52:55 INFO - PROCESS | 18725 | [#0] dojo.html Cycles:165 Average:5430.31 Median:5690.29 stddev:628.93 (11.1%) stddev-sans-first:603.88 11:52:55 INFO - PROCESS | 18725 | Values: 3107.2 3122.8 3144.7 3145.3 3161.1 5386.4 5458.5 5476.2 5525.2 5586.4 5477.9 5489.5 5537.9 5568.1 5590.5 4898.6 4905.1 4969.1 4980.7 5003.6 4935.1 5055.3 5057.9 5097.3 5103.8 4831.2 4838.3 4859.9 4972.3 4977.7 4888.0 4891.3 4894.9 4897.4 4897.4 4880.6 4886.2 4886.4 4888.9 4891.6 5435.6 5518.9 5527.1 5539.0 5551.8 5831.5 5852.9 5886.6 5892.5 5909.6 5727.6 5743.2 5926.4 5954.6 5987.5 5398.1 5444.8 5487.1 5490.4 5495.0 5928.3 5967.2 5982.2 5982.3 5983.9 5578.1 5638.4 5672.3 5749.7 5760.7 5796.8 5805.4 5852.7 5855.6 5862.2 5715.9 5717.5 5717.7 5721.9 5728.6 5500.9 5711.9 5736.7 5776.5 5796.4 4413.0 4415.0 4456.7 4458.8 4463.4 3956.5 3982.8 3984.7 3987.6 4000.7 5441.0 5447.3 5466.2 5492.6 5572.9 5914.3 5915.3 5917.7 5924.3 5930.9 5490.1 5492.3 5499.3 5502.4 5548.5 4919.2 5046.2 5061.0 5070.3 5099.9 6042.5 6090.3 6092.8 6102.8 6110.2 5934.2 5950.5 5950.6 5951.4 5955.9 5933.0 5980.6 6026.6 6036.6 6039.1 5754.6 5765.8 5798.7 5802.0 5808.0 5694.2 5878.9 5882.2 5890.1 5890.1 5688.5 5705.2 5712.3 5736.6 5749.4 5716.7 5717.1 5718.9 5721.6 5731.6 5471.8 5690.3 5716.5 5724.9 5731.7 5809.2 5850.9 5863.6 5916.5 5925.2 5684.1 5694.1 5719.9 5732.3 5732.7 11:52:55 INFO - PROCESS | 18725 | 11:52:55 INFO - PROCESS | 18725 | [#1] ext.html Cycles:180 Average:60649.98 Median:43949.17 stddev:123004.55 (279.9%) stddev-sans-first:123266.97 11:52:55 INFO - PROCESS | 18725 | Values: 596.4 615.8 630.7 633.1 647.9 34454.8 37214.6 44553.6 45708.0 45725.1 47424.3 47976.8 48074.0 48075.5 48104.3 9138.5 9291.2 9292.9 9294.6 9297.4 8983.3 9058.9 9087.8 9096.2 9099.1 9175.2 9195.1 9208.5 9210.4 9223.8 9108.7 9135.0 9145.3 9152.2 9161.5 9075.7 9148.0 9154.4 9166.2 9170.6 44198.0 44397.0 44542.0 44563.3 44575.3 3427.5 3494.9 3555.1 3791.9 4354.8 33898.0 34087.0 34737.1 35070.5 35182.3 4512.6 4549.4 4613.6 4697.5 4727.5 257008.0 257530.0 257744.0 258389.0 258743.0 61494.4 61501.7 61787.7 61859.7 61883.7 36667.0 37676.0 37695.9 39276.8 64727.7 15907.7 16308.8 16336.5 16337.3 16338.6 11956.9 12126.2 12129.1 12132.4 12135.0 20419.0 20486.0 20537.2 20545.9 20565.3 7063.0 7156.3 7193.7 7305.0 7374.3 988.6 1052.5 1064.5 1108.9 1139.7 33989.5 34563.8 34622.3 34624.0 35060.3 904.2 1102.4 1189.4 1228.1 1228.5 17491.8 17732.6 17901.6 17930.5 17934.3 573726.0 574412.0 579074.0 579395.0 580234.0 61773.0 62039.4 62250.4 62366.7 62397.0 1199.0 1309.2 1335.9 1341.8 1358.9 34645.8 35636.5 35835.3 35889.5 35924.0 53244.5 53696.0 53707.2 53770.5 53903.0 418087.0 418355.0 418602.0 420316.0 701086.0 28131.6 29102.0 29301.4 30450.4 30451.5 49892.3 50402.0 50647.5 51106.5 51806.2 41310.4 41775.2 43451.5 46181.8 46344.5 42242.4 43097.8 43183.6 43317.8 43858.6 44039.8 44424.8 45541.0 45688.3 45974.8 37856.6 39076.8 39398.4 39732.4 40250.0 29178.9 29572.4 29729.6 29814.9 30075.7 11:52:55 INFO - PROCESS | 18725 | 11:52:55 INFO - PROCESS | 18725 | [#2] jquery.html Cycles:180 Average:30186.80 Median:13993.83 stddev:85080.96 (608.0%) stddev-sans-first:85290.22 11:52:55 INFO - PROCESS | 18725 | Values: 388.5 389.0 395.4 398.8 411.1 19105.2 20375.1 20692.9 20743.7 21826.7 15445.5 15575.4 17616.6 19874.1 20725.0 5569.9 5610.3 5747.1 5751.6 5837.3 5685.1 5735.4 5744.4 5746.8 5771.2 5494.3 5639.2 5639.6 5662.9 5713.0 5586.1 5631.2 5634.3 5638.4 5650.1 4905.1 5149.4 5152.7 5153.1 5154.8 24492.0 24764.5 25188.1 25405.6 25428.9 2157.8 2309.8 2339.4 2558.8 2971.9 10606.0 10684.7 11044.7 11625.4 15968.8 1899.8 1973.5 2021.4 2041.3 2086.4 62017.7 67102.3 79952.2 88314.0 93540.5 11329.7 11398.2 11504.2 11597.9 11752.9 14168.1 14754.9 15692.5 15758.2 16110.3 7674.7 7786.7 8247.1 8296.8 8321.6 7686.5 7731.5 7751.7 7802.5 7937.9 4893.7 4902.7 4925.6 4969.1 5090.5 1879.8 1881.6 1912.6 1944.1 1956.7 930.4 950.4 999.5 1003.8 1048.5 20495.2 20812.0 20864.7 21179.4 21194.0 909.6 995.2 999.2 1004.2 1026.7 11279.2 11536.5 11782.3 11792.2 11801.2 505466.0 510090.0 517629.0 521008.0 522829.0 100251.0 101072.0 101728.0 102376.0 103237.5 957.0 980.1 981.8 993.6 1055.9 18819.5 18917.5 19230.2 19301.1 19473.3 30919.7 42261.0 43382.6 45647.5 47367.0 61091.7 61764.4 62141.4 62468.0 64674.4 8532.5 8633.4 8701.7 8937.5 9062.5 12717.2 12903.4 13052.7 13130.0 13155.7 6012.8 11160.5 11197.7 11909.1 11963.8 11521.3 11579.4 11725.6 11751.6 11795.7 10732.8 11296.7 11693.9 11722.6 11807.5 8554.7 8588.0 8653.4 8871.2 8910.6 8975.1 10818.3 10889.3 11339.4 11484.7 11:52:55 INFO - PROCESS | 18725 | 11:52:55 INFO - PROCESS | 18725 | [#3] mootools.html Cycles:180 Average:6196.18 Median:4648.15 stddev:3575.21 (76.9%) stddev-sans-first:3567.91 11:52:55 INFO - PROCESS | 18725 | Values: 1512.1 1521.0 1668.6 1808.1 1850.0 8873.7 9441.8 9481.6 9527.6 9533.5 8135.8 8870.4 9014.7 9060.0 9329.3 2351.6 2384.4 2391.9 2394.6 2395.5 2370.1 2373.0 2408.5 2409.4 2411.6 2067.8 2142.3 2142.4 2151.9 2286.4 2357.1 2392.5 2394.8 2395.0 2395.9 2381.3 2420.5 2425.9 2426.3 2426.4 9340.9 9461.7 9481.9 9488.0 9491.1 5344.4 5448.3 5476.3 5480.3 5480.4 3388.7 3448.6 3564.9 3569.6 3602.8 1242.4 1255.8 1287.4 1303.1 1305.1 13470.0 13478.6 13482.3 13494.6 13503.7 4742.1 4749.0 4797.9 4826.8 4989.7 11046.2 11053.1 11073.1 11093.3 11104.4 5472.7 5479.1 5480.5 5480.6 5481.8 5035.5 5085.3 5086.5 5186.2 5205.7 4135.2 4148.9 4167.5 4196.9 4257.7 1278.7 1286.1 1286.5 1326.9 1336.1 803.9 892.0 995.9 1009.3 1026.6 6306.0 6438.8 6468.8 6495.5 6582.2 996.9 1031.4 1032.7 1060.5 1064.5 4472.1 4487.8 4514.4 4523.3 4554.2 11192.8 11525.1 11722.6 12030.8 12060.1 11755.1 11865.6 11883.3 11906.8 11908.9 7664.0 8300.4 8614.1 8626.1 8640.8 6535.1 6695.9 6740.1 6771.8 6841.9 10702.3 10817.9 10863.8 10872.7 11014.2 11032.7 11199.9 11387.1 11424.2 11454.1 7798.5 8127.4 8288.4 8394.2 8442.7 8867.6 8876.7 8924.3 8929.2 8937.0 8036.3 8105.8 8155.4 8207.5 8587.3 7823.4 7908.5 7970.7 7991.5 8363.0 7621.6 7697.4 7720.1 7794.2 7807.7 5543.6 5568.9 5578.7 5625.6 5647.5 5703.2 5718.2 5719.0 5906.4 6012.1 11:52:55 INFO - PROCESS | 18725 | 11:52:55 INFO - PROCESS | 18725 | [#4] prototype.html Cycles:180 Average:4668.38 Median:5318.48 stddev:1354.78 (25.5%) stddev-sans-first:1318.71 11:52:55 INFO - PROCESS | 18725 | Values: 321.7 325.8 327.0 329.8 334.8 5291.8 5308.2 5322.5 5332.3 5353.2 5293.4 5294.0 5299.1 5307.2 5314.5 4102.1 4194.2 4198.7 4215.7 4221.1 4115.7 4141.2 4164.1 4168.9 4172.3 4128.2 4129.6 4132.3 4141.2 4170.2 3967.6 3970.2 4100.4 4112.4 4145.8 3630.2 3630.7 3638.3 3649.6 3651.5 5160.7 5163.6 5166.7 5171.7 5183.1 4475.6 4605.3 4705.1 4723.3 4739.7 5452.3 5464.8 5466.4 5488.4 5521.5 4045.2 4085.8 4088.4 4094.1 4106.0 5467.9 5626.6 5700.3 5733.6 5753.0 4052.6 4076.7 4084.9 4088.5 4129.5 4125.9 4168.4 4174.0 4181.5 4186.4 4650.7 4675.1 4704.2 4710.1 4751.3 5559.4 5594.5 5640.3 5673.3 5681.3 1443.0 1445.9 1451.0 1457.3 1459.4 934.2 964.8 980.9 982.7 982.8 5280.5 5281.5 5288.2 5311.7 5328.7 5584.3 5604.1 5622.8 5675.6 5677.3 5106.8 5110.2 5222.4 5275.7 5336.4 2996.3 3004.4 3009.6 3016.9 3029.0 5757.4 5796.7 5829.3 5839.6 5841.1 5617.2 5751.7 5752.5 5778.3 5804.3 5729.8 5801.9 5804.8 5849.9 5859.1 5373.0 5614.6 5650.2 5653.6 5665.2 5536.8 5568.0 5576.8 5603.8 5621.2 5760.6 5804.0 5811.2 5817.6 5822.0 4051.3 4173.7 4181.8 4182.7 4183.7 5655.3 5694.7 5695.7 5707.3 5708.7 5563.3 5573.6 5580.7 5590.8 5594.7 5352.8 5558.4 5574.3 5587.5 5592.6 5447.8 5494.9 5497.2 5497.4 5530.4 5313.7 5548.7 5548.9 5559.7 5562.7 5427.5 5429.8 5440.7 5444.8 5457.8 11:52:55 INFO - PROCESS | 18725 | 11:52:55 INFO - PROCESS | 18725 | [#5] yui.html Cycles:180 Average:20352.04 Median:4503.89 stddev:28678.38 (636.7%) stddev-sans-first:28721.01 11:52:55 INFO - PROCESS | 18725 | Values: 736.5 758.7 800.5 801.0 825.4 15138.5 16619.7 16643.0 16669.7 16688.8 14035.2 14063.7 14065.2 14122.4 14147.4 798.8 818.0 818.7 819.0 819.0 642.0 766.2 821.7 823.2 826.0 869.7 875.3 875.4 877.1 878.0 676.6 861.0 871.8 871.8 872.7 592.2 631.6 632.6 632.7 633.2 15196.5 15243.8 15250.6 15253.2 15275.0 13896.2 14181.2 14527.5 14568.2 14769.4 13033.2 13153.9 13249.4 13407.0 13417.1 4423.8 4441.6 4443.3 4485.8 4562.0 77170.0 77530.6 77552.2 77578.2 77638.6 11074.6 11186.9 11474.1 11520.6 11638.8 21043.4 21271.9 21288.7 21314.4 21318.4 8188.4 8339.7 8446.0 8652.1 8716.8 4500.2 4507.5 4621.7 4636.1 4789.1 3515.7 3614.2 3615.3 3616.8 3618.3 587.4 595.3 611.1 616.9 621.4 689.5 738.9 765.3 775.8 800.8 10498.7 10599.7 10618.7 10868.8 11154.8 611.3 637.3 655.7 758.5 801.8 4806.7 5249.5 5279.8 5345.9 5349.3 104732.0 109133.0 110271.4 110860.0 115815.0 63395.7 63667.7 91430.5 96820.0 100044.0 85064.1 85079.6 85149.0 85442.6 85526.1 9597.7 9642.7 9690.9 9703.4 9777.7 46488.3 49870.3 50327.2 51089.7 52348.5 72649.0 78194.0 78835.6 79924.2 80255.6 12091.8 12380.0 12433.6 12494.7 13373.9 14042.4 14185.2 14293.8 14474.6 15018.4 13592.3 13664.8 13704.9 13839.7 13981.7 12699.2 12936.9 12993.7 13060.7 13113.5 12927.7 13307.0 13431.4 13440.0 13482.3 10302.7 10838.6 10898.2 11346.6 11498.3 10874.2 11186.3 11286.6 11289.3 11539.0 11:52:55 INFO - PROCESS | 18725 | -------- Summary: end -------- 11:52:55 INFO - PROCESS | 18725 | 11:52:55 INFO - TEST-INFO | 18725: exit 0 11:52:55 INFO - TEST-OK | dromaeo_css | took 1112743ms 11:52:55 INFO - TEST-START | kraken 11:52:55 INFO - operating with platform_type : linux_ 11:52:55 INFO - Initialising browser for kraken test... 11:52:55 INFO - TEST-INFO | started process 18915 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvzY9aJ/profile http://localhost:52737/getInfo.html) 11:52:59 INFO - PROCESS | 18915 | __metrics Screen width/height:1600/1200 11:52:59 INFO - PROCESS | 18915 | colorDepth:24 11:52:59 INFO - PROCESS | 18915 | Browser inner width/height: 1024/697 11:52:59 INFO - PROCESS | 18915 | __metrics 11:53:00 INFO - PROCESS | 18915 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:53:00 INFO - PROCESS | 18915 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:53:01 INFO - TEST-INFO | 18915: exit 0 11:53:01 INFO - Browser initialized. 11:53:01 INFO - Running cycle 1/1 for kraken test... 11:53:01 INFO - TEST-INFO | started process 18999 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvzY9aJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:53:13 INFO - PROCESS | 18999 | RSS: Main: 157548544 11:53:13 INFO - PROCESS | 18999 | 11:53:15 INFO - PROCESS | 18999 | Cycle 1(1): loaded http://localhost:52737/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52737/tests/kraken/driver.html?testName=audio-beat-detection) 11:53:16 INFO - PROCESS | 18999 | RSS: Main: 216834048 11:53:16 INFO - PROCESS | 18999 | 11:53:19 INFO - PROCESS | 18999 | Cycle 1(1): loaded http://localhost:52737/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52737/tests/kraken/driver.html?testName=audio-dft) 11:53:19 INFO - PROCESS | 18999 | RSS: Main: 205979648 11:53:19 INFO - PROCESS | 18999 | 11:53:22 INFO - PROCESS | 18999 | Cycle 1(1): loaded http://localhost:52737/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52737/tests/kraken/driver.html?testName=audio-fft) 11:53:23 INFO - PROCESS | 18999 | RSS: Main: 269635584 11:53:23 INFO - PROCESS | 18999 | 11:53:25 INFO - PROCESS | 18999 | Cycle 1(1): loaded http://localhost:52737/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52737/tests/kraken/driver.html?testName=audio-oscillator) 11:53:26 INFO - PROCESS | 18999 | RSS: Main: 180137984 11:53:26 INFO - PROCESS | 18999 | 11:53:28 INFO - PROCESS | 18999 | Cycle 1(1): loaded http://localhost:52737/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52737/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:53:28 INFO - PROCESS | 18999 | RSS: Main: 184922112 11:53:28 INFO - PROCESS | 18999 | 11:53:31 INFO - PROCESS | 18999 | Cycle 1(1): loaded http://localhost:52737/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52737/tests/kraken/driver.html?testName=imaging-darkroom) 11:53:32 INFO - PROCESS | 18999 | RSS: Main: 218992640 11:53:32 INFO - PROCESS | 18999 | 11:53:35 INFO - PROCESS | 18999 | Cycle 1(1): loaded http://localhost:52737/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52737/tests/kraken/driver.html?testName=imaging-desaturate) 11:53:36 INFO - PROCESS | 18999 | RSS: Main: 221495296 11:53:36 INFO - PROCESS | 18999 | 11:53:39 INFO - PROCESS | 18999 | Cycle 1(1): loaded http://localhost:52737/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52737/tests/kraken/driver.html?testName=json-parse-financial) 11:53:39 INFO - PROCESS | 18999 | RSS: Main: 221671424 11:53:39 INFO - PROCESS | 18999 | 11:53:41 INFO - PROCESS | 18999 | Cycle 1(1): loaded http://localhost:52737/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52737/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:53:41 INFO - PROCESS | 18999 | RSS: Main: 210186240 11:53:41 INFO - PROCESS | 18999 | 11:53:43 INFO - PROCESS | 18999 | Cycle 1(1): loaded http://localhost:52737/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52737/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:53:44 INFO - PROCESS | 18999 | RSS: Main: 213139456 11:53:44 INFO - PROCESS | 18999 | 11:53:46 INFO - PROCESS | 18999 | Cycle 1(1): loaded http://localhost:52737/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52737/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:53:46 INFO - PROCESS | 18999 | RSS: Main: 210124800 11:53:46 INFO - PROCESS | 18999 | 11:53:49 INFO - PROCESS | 18999 | Cycle 1(1): loaded http://localhost:52737/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52737/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:53:50 INFO - PROCESS | 18999 | RSS: Main: 225509376 11:53:50 INFO - PROCESS | 18999 | 11:53:52 INFO - PROCESS | 18999 | Cycle 1(1): loaded http://localhost:52737/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52737/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:53:53 INFO - PROCESS | 18999 | RSS: Main: 224227328 11:53:53 INFO - PROCESS | 18999 | 11:53:54 INFO - PROCESS | 18999 | Cycle 1(1): loaded http://localhost:52737/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52737/tests/kraken/driver.html?testName=ai-astar) 11:53:55 INFO - PROCESS | 18999 | RSS: Main: 267010048 11:53:55 INFO - PROCESS | 18999 | 11:53:55 INFO - PROCESS | 18999 | __start_tp_report 11:53:55 INFO - PROCESS | 18999 | _x_x_mozilla_page_load 11:53:55 INFO - PROCESS | 18999 | _x_x_mozilla_page_load_details 11:53:55 INFO - PROCESS | 18999 | |i|pagename|runs| 11:53:55 INFO - PROCESS | 18999 | |0;ai-astar;100;111;111;112;112;114;111;111;112;112 11:53:55 INFO - PROCESS | 18999 | |1;audio-beat-detection;141;119;120;167;118;120;141;116;152;122 11:53:55 INFO - PROCESS | 18999 | |2;audio-dft;165;160;160;158;158;160;159;160;161;160 11:53:55 INFO - PROCESS | 18999 | |3;audio-fft;73;76;75;112;75;76;74;74;102;75 11:53:55 INFO - PROCESS | 18999 | |4;audio-oscillator;84;84;118;84;83;84;123;84;84;125 11:53:55 INFO - PROCESS | 18999 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;117 11:53:55 INFO - PROCESS | 18999 | |6;imaging-darkroom;145;146;146;146;146;151;146;146;147;145 11:53:55 INFO - PROCESS | 18999 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 11:53:55 INFO - PROCESS | 18999 | |8;json-parse-financial;52;50;50;51;52;50;51;50;50;50 11:53:55 INFO - PROCESS | 18999 | |9;json-stringify-tinderbox;61;61;61;62;62;61;62;61;62;62 11:53:55 INFO - PROCESS | 18999 | |10;stanford-crypto-aes;75;75;77;81;75;75;74;75;80;77 11:53:55 INFO - PROCESS | 18999 | |11;stanford-crypto-ccm;125;132;116;116;117;118;122;119;177;126 11:53:55 INFO - PROCESS | 18999 | |12;stanford-crypto-pbkdf2;152;152;152;155;154;154;152;153;152;153 11:53:55 INFO - PROCESS | 18999 | |13;stanford-crypto-sha256-iterative;65;62;65;63;64;64;64;68;66;62 11:53:55 INFO - PROCESS | 18999 | __end_tp_report 11:53:55 INFO - PROCESS | 18999 | __start_cc_report 11:53:55 INFO - PROCESS | 18999 | _x_x_mozilla_cycle_collect,1669 11:53:55 INFO - PROCESS | 18999 | __end_cc_report 11:53:55 INFO - PROCESS | 18999 | __startTimestamp1468868035189__endTimestamp 11:53:55 INFO - PROCESS | 18999 | 11:53:55 INFO - PROCESS | 18999 | ------- Summary: start ------- 11:53:55 INFO - PROCESS | 18999 | Number of tests: 14 11:53:55 INFO - PROCESS | 18999 | 11:53:55 INFO - PROCESS | 18999 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:3.84 (3.4%) stddev-sans-first:0.97 11:53:55 INFO - PROCESS | 18999 | Values: 100.0 111.0 111.0 112.0 112.0 114.0 111.0 111.0 112.0 112.0 11:53:55 INFO - PROCESS | 18999 | 11:53:55 INFO - PROCESS | 18999 | [#1] audio-beat-detection Cycles:10 Average:131.60 Median:131.50 stddev:17.62 (13.4%) stddev-sans-first:18.36 11:53:55 INFO - PROCESS | 18999 | Values: 141.0 119.0 120.0 167.0 118.0 120.0 141.0 116.0 152.0 122.0 11:53:55 INFO - PROCESS | 18999 | 11:53:55 INFO - PROCESS | 18999 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:1.97 (1.2%) stddev-sans-first:1.01 11:53:55 INFO - PROCESS | 18999 | Values: 165.0 160.0 160.0 158.0 158.0 160.0 159.0 160.0 161.0 160.0 11:53:55 INFO - PROCESS | 18999 | 11:53:55 INFO - PROCESS | 18999 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.00 stddev:13.83 (18.4%) stddev-sans-first:14.35 11:53:55 INFO - PROCESS | 18999 | Values: 73.0 76.0 75.0 112.0 75.0 76.0 74.0 74.0 102.0 75.0 11:53:55 INFO - PROCESS | 18999 | 11:53:55 INFO - PROCESS | 18999 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:84.00 stddev:18.51 (22.0%) stddev-sans-first:19.17 11:53:55 INFO - PROCESS | 18999 | Values: 84.0 84.0 118.0 84.0 83.0 84.0 123.0 84.0 84.0 125.0 11:53:55 INFO - PROCESS | 18999 | 11:53:55 INFO - PROCESS | 18999 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:53:55 INFO - PROCESS | 18999 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 11:53:55 INFO - PROCESS | 18999 | 11:53:55 INFO - PROCESS | 18999 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:1.71 (1.2%) stddev-sans-first:1.74 11:53:55 INFO - PROCESS | 18999 | Values: 145.0 146.0 146.0 146.0 146.0 151.0 146.0 146.0 147.0 145.0 11:53:55 INFO - PROCESS | 18999 | 11:53:55 INFO - PROCESS | 18999 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:53:55 INFO - PROCESS | 18999 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 11:53:55 INFO - PROCESS | 18999 | 11:53:55 INFO - PROCESS | 18999 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:50.50 stddev:0.84 (1.7%) stddev-sans-first:0.73 11:53:55 INFO - PROCESS | 18999 | Values: 52.0 50.0 50.0 51.0 52.0 50.0 51.0 50.0 50.0 50.0 11:53:55 INFO - PROCESS | 18999 | 11:53:55 INFO - PROCESS | 18999 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 11:53:55 INFO - PROCESS | 18999 | Values: 61.0 61.0 61.0 62.0 62.0 61.0 62.0 61.0 62.0 62.0 11:53:55 INFO - PROCESS | 18999 | 11:53:55 INFO - PROCESS | 18999 | [#10] stanford-crypto-aes Cycles:10 Average:76.40 Median:76.00 stddev:2.37 (3.1%) stddev-sans-first:2.46 11:53:55 INFO - PROCESS | 18999 | Values: 75.0 75.0 77.0 81.0 75.0 75.0 74.0 75.0 80.0 77.0 11:53:55 INFO - PROCESS | 18999 | 11:53:55 INFO - PROCESS | 18999 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:123.50 stddev:18.38 (14.9%) stddev-sans-first:19.49 11:53:55 INFO - PROCESS | 18999 | Values: 125.0 132.0 116.0 116.0 117.0 118.0 122.0 119.0 177.0 126.0 11:53:55 INFO - PROCESS | 18999 | 11:53:55 INFO - PROCESS | 18999 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.90 Median:153.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 11:53:55 INFO - PROCESS | 18999 | Values: 152.0 152.0 152.0 155.0 154.0 154.0 152.0 153.0 152.0 153.0 11:53:55 INFO - PROCESS | 18999 | 11:53:55 INFO - PROCESS | 18999 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.50 stddev:1.83 (2.8%) stddev-sans-first:1.92 11:53:55 INFO - PROCESS | 18999 | Values: 65.0 62.0 65.0 63.0 64.0 64.0 64.0 68.0 66.0 62.0 11:53:55 INFO - PROCESS | 18999 | -------- Summary: end -------- 11:53:55 INFO - PROCESS | 18999 | 11:53:56 INFO - TEST-INFO | 18999: exit 0 11:53:56 INFO - TEST-OK | kraken | took 60441ms 11:53:56 INFO - SUITE-END | took 1173s 11:53:56 INFO - Completed test suite (00:19:33) 11:53:56 INFO - javascript benchmark 11:53:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3107.238726512004, 3122.797018193816, 3144.701253380928, 3145.3394787094717, 3161.130689060508, 5386.407495175527, 5458.4541545845395, 5476.233327334171, 5525.198846167308, 5586.413426590206, 5477.904419116173, 5489.505944464997, 5537.889242215153, 5568.081266591008, 5590.524805391547, 4898.559129678329, 4905.117078925792, 4969.105560999019, 4980.6762560433635, 5003.649744517885, 4935.111679897617, 5055.292259083732, 5057.9494205057845, 5097.311862898517, 5103.770330335125, 4831.22700367943, 4838.298446725205, 4859.902801943941, 4972.279019542164, 4977.701337919718, 4887.951120488785, 4891.26631005352, 4894.902101957941, 4897.363342765453, 4897.4123105227245, 4880.560749532559, 4886.242632391985, 4886.413630364379, 4888.902221955576, 4891.584215341701, 5435.619506634537, 5518.889622207534, 5527.060399732055, 5538.975289571442, 5551.750171242304, 5831.504322132624, 5852.853678658025, 5886.6468011919, 5892.528597712173, 5909.556783241274, 5727.570432217601, 5743.195952566644, 5926.407359264039, 5954.612950158269, 5987.461128498412, 5398.055340315468, 5444.8366549003595, 5487.067198576252, 5490.368607610136, 5494.983428065821, 5928.288605367297, 5967.224260846062, 5982.222311099529, 5982.312034116132, 5983.850403739942, 5578.079616863253, 5638.407967163471, 5672.347680016768, 5749.741261643236, 5760.683162426023, 5796.797112101056, 5805.419458054245, 5852.678102704393, 5855.619384739978, 5862.179294898718, 5715.942840571541, 5717.514011309002, 5717.742701578439, 5721.942780572141, 5728.627639203439, 5500.87232117415, 5711.914321285184, 5736.741846616829, 5776.5089967352405, 5796.42035796417, 4412.955870441318, 4414.955850441519, 4456.68803183774, 4458.821647134143, 4463.375127482155, 3956.5054368203973, 3982.761034337891, 3984.7011474139554, 3987.6211759882763, 4000.739951903117, 5440.972795135999, 5447.319085114361, 5466.1527463243265, 5492.5605951523785, 5572.888542229132, 5914.319853216849, 5915.319738230072, 5917.733701983335, 5924.259467566554, 5930.851728706731, 5490.149026900836, 5492.340919089735, 5499.340079190522, 5502.394736578973, 5548.500634942875, 4919.163742163841, 5046.21783623539, 5060.974695126501, 5070.29015937769, 5099.898002039939, 6042.546808989343, 6090.299615544269, 6092.7562897484495, 6102.816915492543, 6110.175126357974, 5934.19888315072, 5950.4644581986095, 5950.642961422329, 5951.404859514014, 5955.851103722442, 5932.970335148297, 5980.581359304807, 6026.578139530191, 6036.607620504653, 6039.063945088518, 5754.597178197486, 5765.827025189251, 5798.652080875161, 5802.0, 5808.041673123887, 5694.17434471991, 5878.94121058801, 5882.23530940975, 5890.057590785454, 5890.116482527484, 5688.459596338341, 5705.201271821865, 5712.285964254468, 5736.598438109292, 5749.425057494217, 5716.657000579979, 5717.142428635738, 5718.914216286676, 5721.599488035798, 5731.570132240182, 5471.8084867029465, 5690.2887139107615, 5716.5426765859465, 5724.942750572441, 5731.684757338219, 5809.186713860147, 5850.882982340244, 5863.589548731718, 5916.49709774674, 5925.229720136354, 5684.147377893349, 5694.14587811815, 5719.8570035749435, 5732.283464566929, 5732.656040637575], "value": 5386.902035101613, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.373807502123, 615.8337248942782, 630.6688988281152, 633.104157616972, 647.880142173698, 34454.82772586137, 37214.62785372149, 44553.554464455345, 45708.0, 45725.08549829001, 47424.28863567049, 47976.76011619946, 48074.0, 48075.51924480754, 48104.27843582349, 9138.497382643953, 9291.210247129002, 9292.907070929306, 9294.581743821544, 9297.442153470813, 8983.326250531203, 9058.909410905873, 9087.818243635124, 9096.226820720247, 9099.090090990914, 9175.220106290973, 9195.080491950785, 9208.539573021322, 9210.447373157598, 9223.769405764842, 9108.681196158135, 9135.040820713795, 9145.268378529734, 9152.22206112478, 9161.450312981242, 9075.682351117744, 9148.039455857172, 9154.359194856363, 9166.175044245983, 9170.587323570455, 44198.0, 44397.0, 44542.0, 44563.33155002678, 44575.331370029475, 3427.503012063262, 3494.8951531454095, 3555.1289933966086, 3791.9241615167816, 4354.7604881731495, 33898.0, 34087.0, 34737.13157171091, 35070.47394289088, 35182.296354073034, 4512.616427603658, 4549.377511036146, 4613.584777370019, 4697.4832768395445, 4727.479977202505, 257008.0, 257530.0, 257744.0, 258389.0, 258743.0, 61494.38505614976, 61501.69249153815, 61787.6910615453, 61859.690701546206, 61883.69058154771, 36667.0, 37676.0, 37695.86912392633, 39276.803615981735, 64727.67636161883, 15907.681846363008, 16308.83691163097, 16336.509904702878, 16337.346506139858, 16338.591535211715, 11956.940215298868, 12126.211796233216, 12129.090318226168, 12132.393380331125, 12135.029197664166, 20419.0, 20486.0, 20537.17851285932, 20545.897270513553, 20565.280215192397, 7063.0, 7156.284371562906, 7193.712251509881, 7305.0, 7374.33630973215, 988.619381538113, 1052.5263631365915, 1064.4784055812595, 1108.9390083545482, 1139.6524060161564, 33989.490157647655, 34563.82718086393, 34622.30755384878, 34624.0, 35060.298794024486, 904.2133343990639, 1102.4102105373747, 1189.411241435495, 1228.072805032195, 1228.4778968938344, 17491.825081749274, 17732.556686082695, 17901.641967160584, 17930.462086137435, 17934.282628694706, 573726.0, 574412.0, 579074.0, 579395.0, 580234.0, 61773.0, 62039.37960620426, 62250.37749622446, 62366.68816655887, 62397.0, 1198.9940050299692, 1309.214471317202, 1335.933203339829, 1341.7987301904793, 1358.9388477518535, 34645.826770865984, 35636.46545301771, 35835.28329433344, 35889.51381077366, 35924.0, 53244.4675553255, 53696.0, 53707.194392083366, 53770.46229537811, 53903.0, 418087.0, 418355.0, 418602.0, 420316.0, 701086.0, 28131.57802632921, 29102.0, 29301.41397172087, 30450.390992180477, 30451.54322685206, 49892.25161622506, 50402.0, 50647.49352506575, 51106.488935110174, 51806.22290665718, 41310.38034429426, 41775.16449670929, 43451.534064713735, 46181.76909115433, 46344.53655463537, 42242.36636450394, 43097.78451107725, 43183.568164317956, 43317.783411082746, 43858.56141438545, 44039.77980110079, 44424.77787611041, 45541.0, 45688.31467527923, 45974.77012614915, 37856.621433786415, 39076.82769516919, 39398.40902386409, 39732.39675523541, 40250.0, 29178.854105729337, 29572.408551828412, 29729.554056688736, 29814.85092574523, 30075.699243008166], "value": 20607.651408789665, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.50271652285085, 389.01332075916537, 395.4147861165475, 398.77269956125, 411.13456174752145, 19105.23579056838, 20375.08312125954, 20692.89653551732, 20743.688844667304, 21826.70819563947, 15445.536633900972, 15575.376984920618, 17616.559586010357, 19874.105665245064, 20725.0, 5569.944300557004, 5610.326760788711, 5747.137929310595, 5751.626144300628, 5837.299524057119, 5685.118806584986, 5735.426457354252, 5744.368119506851, 5746.770129194827, 5771.163181338703, 5494.340679118512, 5639.15412688096, 5639.577031722617, 5662.915056274159, 5712.971435142818, 5586.13414920688, 5631.155326700987, 5634.295713035871, 5638.4361563843495, 5650.124230744241, 4905.092557876804, 5149.382074151088, 5152.690838549699, 5153.072446959546, 5154.793808247666, 24492.0, 24764.504709905883, 25188.11841585554, 25405.61891571628, 25428.872855635604, 2157.7734337894453, 2309.7921187093243, 2339.368370539945, 2558.7952963762855, 2971.9405611887855, 10606.0, 10684.679459616224, 11044.723881902937, 11625.418729063598, 15968.840311596967, 1899.7910229874703, 1973.4868934077244, 2021.4238941901635, 2041.2549419461939, 2086.353230498535, 62017.6899115506, 67102.3289767101, 79952.20047799505, 88314.0, 93540.53229733875, 11329.71675708114, 11398.20212585111, 11504.194706370474, 11597.942010289895, 11752.941235293769, 14168.149911005372, 14754.926225368805, 15692.450764223197, 15758.212089395485, 16110.275037623334, 7674.654640541189, 7786.688532458638, 8247.134050924567, 8296.792580185424, 8321.583920803936, 7686.500377475446, 7731.536107833548, 7751.689932402641, 7802.531848089019, 7937.880931786028, 4893.7063776173545, 4902.730349830722, 4925.556699897026, 4969.055879382906, 5090.49095090488, 1879.8026207248315, 1881.5766452548066, 1912.6270377276298, 1944.1251436853472, 1956.7162761399518, 930.3673502018557, 950.3632566180537, 999.5402115027024, 1003.7641154328727, 1048.4548035021746, 20495.180192792122, 20812.0, 20864.687029694567, 21179.364619061453, 21194.0, 909.5679552212646, 995.1690338567232, 999.2106236073566, 1004.2267454060333, 1026.7176526455135, 11279.154063445274, 11536.538538458535, 11782.291567722632, 11792.23350482216, 11801.17391782567, 505466.0, 510090.0, 517629.0, 521008.0, 522829.0, 100251.0, 101072.0, 101728.0, 102376.0, 103237.48381258195, 957.0, 980.0787259975742, 981.79873126009, 993.64228877604, 1055.904968552834, 18819.529511762317, 18917.527061823566, 19230.23079076821, 19301.131449084543, 19473.318433854747, 30919.690803091682, 42261.0, 43382.56617433785, 45647.543524565655, 47367.0, 61091.69454152701, 61764.38235617586, 62141.378586213556, 62468.0, 64674.353256466835, 8532.530710810965, 8633.39566230358, 8701.695440659547, 8937.508437036025, 9062.546872656472, 12717.236965782082, 12903.354832258161, 13052.738945221232, 13130.0, 13155.671108221988, 6012.849678758066, 11160.49777760019, 11197.72005699864, 11909.106816988933, 11963.820542691692, 11521.308721476404, 11579.42102894835, 11725.648230553097, 11751.647450576496, 11795.705107372385, 10732.785344292914, 11296.661100167008, 11693.941530292293, 11722.58970936013, 11807.527698891949, 8554.743357699279, 8588.03712719111, 8653.35099867525, 8871.201591856763, 8910.643574257216, 8975.057618950177, 10818.296810707594, 10889.292196007234, 11339.433028348714, 11484.712882178012], "value": 9343.090603367173, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1512.107856364745, 1521.018942781906, 1668.557832174474, 1808.0507733439952, 1849.9907500462505, 8873.68942087027, 9441.81116377672, 9481.573329200186, 9527.571259293323, 9533.47565883876, 8135.837283254331, 8870.37907346486, 9014.729558113251, 9060.0, 9329.253659707225, 2351.623740201564, 2384.4396566806786, 2391.8804059797026, 2394.5570069537102, 2395.4849707312924, 2370.0756704885107, 2372.988135059331, 2408.4701365699607, 2409.3856066702965, 2411.6382542618658, 2067.834573234145, 2142.335875878475, 2142.357292812158, 2151.924682636108, 2286.4398222435525, 2357.068957761683, 2392.497575509145, 2394.7605239476175, 2394.964075538868, 2395.8802059896934, 2381.3213234228333, 2420.4674971506242, 2425.854448733082, 2426.2721183645012, 2426.4297889995837, 9340.859887101631, 9461.668841590512, 9481.857772133424, 9488.0, 9491.145796878245, 5344.385395679507, 5448.264484294609, 5476.342838859323, 5480.287562616874, 5480.369757477862, 3388.728901687859, 3448.5516882805327, 3564.8752293669595, 3569.625189355106, 3602.8018458984743, 1242.385019415386, 1255.7614053329837, 1287.3949243855373, 1303.113882559859, 1305.0994813578695, 13470.0, 13478.595642130655, 13482.258475783829, 13494.595162145151, 13503.729925401536, 4742.146413645508, 4749.0, 4797.856064318076, 4826.782794774173, 4989.675671081441, 11046.171537134747, 11053.060489858452, 11073.114150867912, 11093.335999599964, 11104.389258590694, 5472.7263636818, 5479.0959491684225, 5480.534154596824, 5480.6437581557075, 5481.835544933659, 5035.546800787946, 5085.313482679865, 5086.4659210783075, 5186.222066689951, 5205.713685747321, 4135.201187483454, 4148.937225379607, 4167.458230430025, 4196.9370459443135, 4257.74453532789, 1278.6957303550328, 1286.1382873474795, 1286.5304163980268, 1326.8759366037075, 1336.0981337597084, 803.8753993131074, 891.9777005574913, 995.9402435853872, 1009.3086235928266, 1026.563710423082, 6306.0, 6438.806835794933, 6468.838279043061, 6495.4803615710625, 6582.210134783857, 996.9252306076928, 1031.3811712972306, 1032.6901929421144, 1060.4697651174413, 1064.4943651765504, 4472.08322293929, 4487.820487180542, 4514.390557274792, 4523.298888672195, 4554.157480866051, 11192.776144477228, 11525.135614828921, 11722.648320550397, 12030.81953770694, 12060.095492837896, 11755.05959523236, 11865.644030679094, 11883.346415947206, 11906.761864762657, 11908.940455297668, 7663.961680191564, 8300.377471689648, 8614.138586141336, 8626.094260102724, 8640.827183456297, 6535.085088087767, 6695.899561506484, 6740.12378390806, 6771.830704232433, 6841.863162736817, 10702.304350217211, 10817.891821081688, 10863.78272434531, 10872.67381978542, 11014.229003969645, 11032.724181895517, 11199.944000279946, 11387.145964052563, 11424.200305978835, 11454.14093942941, 7798.532088074734, 8127.431079824592, 8288.378371622031, 8394.24451799341, 8442.66229350819, 8867.64529418816, 8876.733697989072, 8924.330675199257, 8929.151730585583, 8937.01692813803, 8036.316913062221, 8105.75682729519, 8155.388345873965, 8207.466514676527, 8587.270082043096, 7823.374130069467, 7908.52548847071, 7970.721024764105, 7991.480553763987, 8363.03825060126, 7621.580813055113, 7697.422693297913, 7720.112187098555, 7794.181610930771, 7807.687692492236, 5543.641807757125, 5568.9443105568425, 5578.665280083208, 5625.634333768292, 5647.491725744702, 5703.173039909107, 5718.199452076796, 5718.971405142947, 5906.4093590642315, 6012.068129439944], "value": 4923.445812664385, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.65904141609894, 325.7931213679316, 326.9885554005609, 329.82848918562365, 334.83593039410687, 5291.7883284668615, 5308.150695888658, 5322.467753224676, 5332.280142180809, 5353.197020446935, 5293.364796224449, 5294.0, 5299.125644268691, 5307.150855863063, 5314.4951229633125, 4102.092526974956, 4194.161167766443, 4198.748075115487, 4215.725977811448, 4221.092465119998, 4115.670746340301, 4141.233871733723, 4164.10471748574, 4168.895777605569, 4172.290710579209, 4128.195001974616, 4129.6283334499885, 4132.318167502359, 4141.192467468844, 4170.249355116078, 3967.5716741972865, 3970.2456533258587, 4100.425940368321, 4112.383142528614, 4145.813438395265, 3630.183208778004, 3630.6913912317486, 3638.3450978823803, 3649.59854416014, 3651.47053677218, 5160.741962901878, 5163.63854530183, 5166.741662916839, 5171.689698618057, 5183.144781111112, 4475.5748203920575, 4605.332226827125, 4705.12955103307, 4723.267893476483, 4739.668223224376, 5452.291202143696, 5464.808731694411, 5466.371367292772, 5488.4237155098535, 5521.475459831309, 4045.2111838191563, 4085.816138273785, 4088.3867419886956, 4094.1402305515876, 4105.958940410587, 5467.917981230285, 5626.634268772516, 5700.344460387067, 5733.598648094635, 5753.0219862623035, 4052.6352628263007, 4076.655922844317, 4084.9387259191135, 4088.4889388826396, 4129.545749967501, 4125.876223713293, 4168.416421700964, 4174.0, 4181.519125300569, 4186.413902053715, 4650.67445278834, 4675.064987002545, 4704.176769065469, 4710.105080034782, 4751.3348131261655, 5559.416261292587, 5594.461523081104, 5640.32316122068, 5673.290838645169, 5681.295611316588, 1442.9826971984726, 1445.886667266199, 1450.9564713058626, 1457.3223451095291, 1459.3797636004656, 934.1639232886664, 964.8359778837614, 980.9117179453883, 982.729749318943, 982.8230918434607, 5280.524752772269, 5281.471852814765, 5288.206768984606, 5311.7344132793205, 5328.6802791832615, 5584.329880414376, 5604.103343465026, 5622.8313150605545, 5675.631083979528, 5677.290338707661, 5106.795728170831, 5110.182370820651, 5222.4149046222365, 5275.736213189325, 5336.4129945705945, 2996.310848504856, 3004.3540638762333, 3009.563613276063, 3016.909492715222, 3029.0307101727235, 5757.366689664133, 5796.710164491758, 5829.271341082364, 5839.620424672383, 5841.1238314253205, 5617.21359009739, 5751.728067413348, 5752.453516915886, 5778.27771528559, 5804.2877351181505, 5729.825385795902, 5801.9129713054335, 5804.82585522435, 5849.853753656107, 5859.091840764689, 5372.985130576034, 5614.63504872182, 5650.180723795109, 5653.632513886584, 5665.235193249024, 5536.754230298151, 5568.0, 5576.832695019156, 5603.775848966159, 5621.156826476062, 5760.6255593386295, 5803.970980145073, 5811.186433899342, 5817.603775094031, 5822.0, 4051.2707712612014, 4173.664427383208, 4181.770002649883, 4182.707210495236, 4183.66530677539, 5655.264815573949, 5694.715264236855, 5695.658260504383, 5707.315122185364, 5708.686022268649, 5563.304586926634, 5573.554115670818, 5580.693061881636, 5590.8043218487155, 5594.692291923983, 5352.785888564414, 5558.388577256418, 5574.275344205227, 5587.525060369914, 5592.608517403743, 5447.793643574359, 5494.945050549603, 5497.202905578749, 5497.3952865184, 5530.364008139116, 5313.734313284398, 5548.667079975215, 5548.889022219614, 5559.694216818114, 5562.694051827189, 5427.538659214011, 5429.837104886702, 5440.727963601883, 5444.8094316698725, 5457.808976685956], "value": 4237.1584081761175, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.5102207032323, 758.7420277105787, 800.5276886636883, 801.0187520287644, 825.3892119831324, 15138.470153544627, 16619.66760664786, 16643.0, 16669.666606667874, 16688.83311166888, 14035.228062456561, 14063.718725625482, 14065.226412547307, 14122.364493597786, 14147.36336864841, 798.8042929482285, 818.0428898189103, 818.6807145213371, 819.0089991110763, 819.0294501016315, 641.9903701444458, 766.1687069529567, 821.6713314674118, 823.2467292427422, 825.9917400826005, 869.6956065377099, 875.2997601918472, 875.3609864798701, 877.079066979672, 877.9517126558037, 676.5669971218424, 860.9840388341754, 871.7907702151501, 871.8212766382908, 872.7163671806657, 592.236015539953, 631.5736877607642, 632.6425569553188, 632.6868200240864, 633.2274624957545, 15196.468123615621, 15243.847561524353, 15250.618734531614, 15253.237338133049, 15275.0, 13896.16623002623, 14181.220032898187, 14527.491537796232, 14568.198749068797, 14769.409223631043, 13033.218006919615, 13153.934230328883, 13249.403776830066, 13407.0, 13417.127886687334, 4423.800928958204, 4441.578050085237, 4443.266860967937, 4485.775711214426, 4561.954380456219, 77170.0, 77530.61234693846, 77552.22447775507, 77578.22421775822, 77638.61180694118, 11074.612388566362, 11186.888131118747, 11474.082073434272, 11520.596779112859, 11638.76722465546, 21043.368698939055, 21271.89364053201, 21288.680669789966, 21314.36056918295, 21318.360449186548, 8188.385871059575, 8339.749807505785, 8446.0, 8652.134786521297, 8716.782080447912, 4500.234960056799, 4507.549245075466, 4621.745803980746, 4636.11913736389, 4789.137955168034, 3515.7187425005936, 3614.204874927512, 3615.2588719313003, 3616.764910280823, 3618.2582570572968, 587.3627114580643, 595.2737660054727, 611.0742225528328, 616.8612062286039, 621.3941407128104, 689.5035574386434, 738.9150247721581, 765.285917947092, 775.7982924439686, 800.795797071743, 10498.737531561772, 10599.682009539727, 10618.734531636617, 10868.836967445495, 11154.776904462027, 611.260374946311, 637.3467196123918, 655.7180412422608, 758.4804408979867, 801.8115742800437, 4806.735629540339, 5249.475052494797, 5279.815206467755, 5345.866353341197, 5349.277847490617, 104732.0, 109133.0, 110271.44864275627, 110860.0, 115815.0, 63395.6830215846, 63667.68166159139, 91430.54284728666, 96820.0, 100044.0, 85064.14935850687, 85079.5746021266, 85149.0, 85442.57278713566, 85526.14473855306, 9597.7290105905, 9642.71071867845, 9690.903090969001, 9703.417794932328, 9777.706668799947, 46488.30267545922, 49870.25194622011, 50327.245091322926, 51089.74455127701, 52348.47651523588, 72649.0, 78194.0, 78835.60582197053, 79924.200757994, 80255.59872200602, 12091.758164836478, 12380.0, 12433.564825231435, 12494.687632809253, 13373.866261337651, 14042.368093435616, 14185.219812910389, 14293.785593216318, 14474.638134046732, 15018.399264029753, 13592.32038398096, 13664.795028074388, 13704.862951370758, 13839.654008649864, 13981.720365592835, 12699.238045717286, 12936.935315323739, 12993.66114099471, 13060.738785224052, 13113.475460981836, 12927.676808079497, 13307.0, 13431.395587198404, 13440.0, 13482.258475783534, 10302.690919272434, 10838.620648277272, 10898.18263630215, 11346.602868899548, 11498.25261358009, 10874.184436167478, 11186.32882027081, 11286.573386721895, 11289.32264064126, 11539.0], "value": 7592.959201626145, "unit": "score"}], "name": "dromaeo_css", "value": 7400.757494010499, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 111.0, 112.0, 112.0, 114.0, 111.0, 111.0, 112.0, 112.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 119.0, 120.0, 167.0, 118.0, 120.0, 141.0, 116.0, 152.0, 122.0], "value": 131.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 160.0, 160.0, 158.0, 158.0, 160.0, 159.0, 160.0, 161.0, 160.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 75.0, 112.0, 75.0, 76.0, 74.0, 74.0, 102.0, 75.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 118.0, 84.0, 83.0, 84.0, 123.0, 84.0, 84.0, 125.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 151.0, 146.0, 146.0, 147.0, 145.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 50.0, 51.0, 52.0, 50.0, 51.0, 50.0, 50.0, 50.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 62.0, 61.0, 62.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 81.0, 75.0, 75.0, 74.0, 75.0, 80.0, 77.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 132.0, 116.0, 116.0, 117.0, 118.0, 122.0, 119.0, 177.0, 126.0], "value": 126.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 152.0, 155.0, 154.0, 154.0, 152.0, 153.0, 152.0, 153.0], "value": 152.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 65.0, 63.0, 64.0, 64.0, 64.0, 68.0, 66.0, 62.0], "value": 64.3, "unit": "score"}], "name": "kraken", "value": 1469.6, "alertThreshold": 2.0}]} 11:53:56 INFO - Return code: 0 11:53:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:53:56 INFO - # TBPL SUCCESS # 11:53:56 INFO - Running post-action listener: _resource_record_post_action 11:53:56 INFO - ##### 11:53:56 INFO - ##### Finished run-tests step (success) 11:53:56 INFO - ##### 11:53:56 INFO - Running post-run listener: _resource_record_post_run 11:53:56 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 568639488; Read time: 8; Write time: 618108 11:53:56 INFO - TinderboxPrint: CPU usage
13.0% 11:53:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 11:53:56 INFO - TinderboxPrint: I/O write bytes / time
568,639,488 / 618,108 11:53:56 INFO - TinderboxPrint: CPU idle
8,267.6 (87.0%) 11:53:56 INFO - TinderboxPrint: CPU user
1,194.0 (12.6%) 11:53:56 INFO - TinderboxPrint: Swap in / out
0 / 0 11:53:56 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 270643200; Read time: 0; Write time: 310536 11:53:56 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297996288; Read time: 8; Write time: 307572 11:53:57 INFO - Running post-run listener: _upload_blobber_files 11:53:57 INFO - Blob upload gear active. 11:53:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:53:57 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 11:53:57 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:53:57 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:53:57 INFO - (blobuploader) - INFO - Open directory for files ... 11:53:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:53:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:53:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:54:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:54:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:54:01 INFO - (blobuploader) - INFO - Done attempting. 11:54:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:54:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:54:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:54:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:54:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:54:02 INFO - (blobuploader) - INFO - Done attempting. 11:54:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:54:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:54:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:54:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:54:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:54:03 INFO - (blobuploader) - INFO - Done attempting. 11:54:03 INFO - (blobuploader) - INFO - Iteration through files over. 11:54:03 INFO - Return code: 0 11:54:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:54:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:54:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/722c2426de1fce69a7c0e54c10fd02fa271c48a075471aa41aa40a4dba11bf75a9b7e3ebdd787d794b090a9ec072f287fd0765b8407f285d75a118e632bbe033", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95d9ea0687b171d348c0a58fd4215320b1e1bf6642299c88f6193ebde97dd7d94e4720c00956d281f77d0667ae1fb92b510c6de16a9fdf3105f6fce6147ad051", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc95827a88846b5208ec10511051655649bc2e9f3f4c692c70fc070787f312c97690e9fece6330cf3648421878ed06472119620374072b50829717a84b3b1583"} 11:54:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:54:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:54:03 INFO - Contents: 11:54:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/722c2426de1fce69a7c0e54c10fd02fa271c48a075471aa41aa40a4dba11bf75a9b7e3ebdd787d794b090a9ec072f287fd0765b8407f285d75a118e632bbe033", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95d9ea0687b171d348c0a58fd4215320b1e1bf6642299c88f6193ebde97dd7d94e4720c00956d281f77d0667ae1fb92b510c6de16a9fdf3105f6fce6147ad051", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc95827a88846b5208ec10511051655649bc2e9f3f4c692c70fc070787f312c97690e9fece6330cf3648421878ed06472119620374072b50829717a84b3b1583"} 11:54:03 INFO - Running post-run listener: copy_logs_to_upload_dir 11:54:03 INFO - Copying logs to upload dir... 11:54:03 INFO - mkdir: /builds/slave/test/build/upload/logs 11:54:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.522925 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-18 11:54:03.705427) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 11:54:03.709747) ========= 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=1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531 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/sha512/722c2426de1fce69a7c0e54c10fd02fa271c48a075471aa41aa40a4dba11bf75a9b7e3ebdd787d794b090a9ec072f287fd0765b8407f285d75a118e632bbe033", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95d9ea0687b171d348c0a58fd4215320b1e1bf6642299c88f6193ebde97dd7d94e4720c00956d281f77d0667ae1fb92b510c6de16a9fdf3105f6fce6147ad051", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc95827a88846b5208ec10511051655649bc2e9f3f4c692c70fc070787f312c97690e9fece6330cf3648421878ed06472119620374072b50829717a84b3b1583"} build_url:https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/E10Y8aEpSPeMpBZU8PD5Eg/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/sha512/722c2426de1fce69a7c0e54c10fd02fa271c48a075471aa41aa40a4dba11bf75a9b7e3ebdd787d794b090a9ec072f287fd0765b8407f285d75a118e632bbe033", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95d9ea0687b171d348c0a58fd4215320b1e1bf6642299c88f6193ebde97dd7d94e4720c00956d281f77d0667ae1fb92b510c6de16a9fdf3105f6fce6147ad051", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc95827a88846b5208ec10511051655649bc2e9f3f4c692c70fc070787f312c97690e9fece6330cf3648421878ed06472119620374072b50829717a84b3b1583"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 11:54:03.737754) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:54:03.738090) ========= 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=1f5564757af27664ca02d71f000001b0-1468866810.250116-2028464531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:54:03.787978) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 11:54:03.788292) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 11:54:03.791715) ========= ========= Total master_lag: 0.25 =========