builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1468629372.34 results: success (0) buildid: 20160715165251 builduid: 09c15deeb0f742768beedac5c8641428 revision: 98979093d45f152ee94a39ed97ccb02d8a8ddcb4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 17:36:12.336309) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 17:36:12.336758) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 17:36:12.337035) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 17:36:12.353137) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 17:36:12.353418) ========= 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=4300f881736b422476174874000001bc-1468629081.631444-1854461590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-15 17:36:12-- 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% 224M=0s 2016-07-15 17:36:12 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105536 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 17:36:12.481800) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 17:36:12.482093) ========= 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=4300f881736b422476174874000001bc-1468629081.631444-1854461590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021487 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 17:36:12.535470) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 17:36:12.535798) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 98979093d45f152ee94a39ed97ccb02d8a8ddcb4 --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 98979093d45f152ee94a39ed97ccb02d8a8ddcb4 --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=4300f881736b422476174874000001bc-1468629081.631444-1854461590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 17:36:12,977 truncating revision to first 12 chars 2016-07-15 17:36:12,977 Setting DEBUG logging. 2016-07-15 17:36:12,977 attempt 1/10 2016-07-15 17:36:12,977 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/98979093d45f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 17:36:13,298 unpacking tar archive at: fx-team-98979093d45f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.668517 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 17:36:13.220529) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 17:36:13.220840) ========= script_repo_revision: 98979093d45f152ee94a39ed97ccb02d8a8ddcb4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 17:36:13.221929) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 17:36:13.222193) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 17:36:13.231695) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-15 17:36:13.232050) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1468629081.631444-1854461590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:36:13 INFO - MultiFileLogger online at 20160715 17:36:13 in /builds/slave/test 17:36:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 17:36:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:36:13 INFO - {'append_to_log': False, 17:36:13 INFO - 'base_work_dir': '/builds/slave/test', 17:36:13 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:36:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:36:13 INFO - 'branch': 'Fx-Team-Non-PGO', 17:36:13 INFO - 'buildbot_json_path': 'buildprops.json', 17:36:13 INFO - 'config_files': ('talos/linux_config.py',), 17:36:13 INFO - 'default_actions': ('clobber', 17:36:13 INFO - 'read-buildbot-config', 17:36:13 INFO - 'download-and-extract', 17:36:13 INFO - 'populate-webroot', 17:36:13 INFO - 'create-virtualenv', 17:36:13 INFO - 'install', 17:36:13 INFO - 'run-tests'), 17:36:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:36:13 INFO - 'download_minidump_stackwalk': True, 17:36:13 INFO - 'download_symbols': 'ondemand', 17:36:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:36:13 INFO - 'tooltool.py': '/tools/tooltool.py', 17:36:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:36:13 INFO - '/tools/misc-python/virtualenv.py')}, 17:36:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:36:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:36:13 INFO - 'installer_path': 'installer.exe', 17:36:13 INFO - 'log_level': 'info', 17:36:13 INFO - 'log_name': 'talos', 17:36:13 INFO - 'log_to_console': True, 17:36:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:36:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:36:13 INFO - 'opt_config_files': (), 17:36:13 INFO - 'pip_index': False, 17:36:13 INFO - 'sps_profile': False, 17:36:13 INFO - 'sps_profile_interval': 0, 17:36:13 INFO - 'suite': 'dromaeojs', 17:36:13 INFO - 'system_bits': '32', 17:36:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:36:13 INFO - 'title': 'talos-linux64-ix-045', 17:36:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:36:13 INFO - 'use_talos_json': True, 17:36:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:36:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:36:13 INFO - 'work_dir': 'build'} 17:36:13 INFO - ##### 17:36:13 INFO - ##### Running clobber step. 17:36:13 INFO - ##### 17:36:13 INFO - Running pre-action listener: _resource_record_pre_action 17:36:13 INFO - Running main action method: clobber 17:36:13 INFO - rmtree: /builds/slave/test/build 17:36:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:36:14 INFO - Running post-action listener: _resource_record_post_action 17:36:14 INFO - ##### 17:36:14 INFO - ##### Finished clobber step (success) 17:36:14 INFO - ##### 17:36:14 INFO - ##### 17:36:14 INFO - ##### Running read-buildbot-config step. 17:36:14 INFO - ##### 17:36:14 INFO - Running pre-action listener: _resource_record_pre_action 17:36:14 INFO - Running main action method: read_buildbot_config 17:36:14 INFO - Using buildbot properties: 17:36:14 INFO - { 17:36:14 INFO - "project": "", 17:36:14 INFO - "product": "firefox", 17:36:14 INFO - "script_repo_revision": "production", 17:36:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:36:14 INFO - "repository": "", 17:36:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:36:14 INFO - "buildid": "20160715165251", 17:36:14 INFO - "pgo_build": "False", 17:36:14 INFO - "basedir": "/builds/slave/test", 17:36:14 INFO - "buildnumber": 1809, 17:36:14 INFO - "slavename": "talos-linux64-ix-045", 17:36:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:36:14 INFO - "platform": "ubuntu64_hw", 17:36:14 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:36:14 INFO - "branch": "fx-team", 17:36:14 INFO - "repo_path": "integration/fx-team", 17:36:14 INFO - "revision": "98979093d45f152ee94a39ed97ccb02d8a8ddcb4", 17:36:14 INFO - "stage_platform": "linux64", 17:36:14 INFO - "builduid": "09c15deeb0f742768beedac5c8641428", 17:36:14 INFO - "slavebuilddir": "test" 17:36:14 INFO - } 17:36:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/f47mknD3SJS7O4IfsvuMSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:36:14 INFO - Running post-action listener: _resource_record_post_action 17:36:14 INFO - ##### 17:36:14 INFO - ##### Finished read-buildbot-config step (success) 17:36:14 INFO - ##### 17:36:14 INFO - ##### 17:36:14 INFO - ##### Running download-and-extract step. 17:36:14 INFO - ##### 17:36:14 INFO - Running pre-action listener: _resource_record_pre_action 17:36:14 INFO - Running main action method: download_and_extract 17:36:14 INFO - mkdir: /builds/slave/test/build/tests 17:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:14 INFO - https://queue.taskcluster.net/v1/task/f47mknD3SJS7O4IfsvuMSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:36:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f47mknD3SJS7O4IfsvuMSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:36:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f47mknD3SJS7O4IfsvuMSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:36:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f47mknD3SJS7O4IfsvuMSw/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 17:36:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f47mknD3SJS7O4IfsvuMSw/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 17:36:14 INFO - Downloaded 1361 bytes. 17:36:14 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:36:14 INFO - Using the following test package requirements: 17:36:14 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:36:14 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:36:14 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:36:14 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:14 INFO - u'jsshell-linux-x86_64.zip'], 17:36:14 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:36:14 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:36:14 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:36:14 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:36:14 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:36:14 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:36:14 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:14 INFO - https://queue.taskcluster.net/v1/task/f47mknD3SJS7O4IfsvuMSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:36:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f47mknD3SJS7O4IfsvuMSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:36:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f47mknD3SJS7O4IfsvuMSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:36:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f47mknD3SJS7O4IfsvuMSw/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 17:36:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f47mknD3SJS7O4IfsvuMSw/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 17:36:15 INFO - Downloaded 22757261 bytes. 17:36:15 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'] 17:36:15 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 17:36:17 INFO - Return code: 0 17:36:17 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:17 INFO - https://queue.taskcluster.net/v1/task/f47mknD3SJS7O4IfsvuMSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:36:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f47mknD3SJS7O4IfsvuMSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:36:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f47mknD3SJS7O4IfsvuMSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:36:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f47mknD3SJS7O4IfsvuMSw/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 17:36:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f47mknD3SJS7O4IfsvuMSw/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 17:36:18 INFO - Downloaded 22757261 bytes. 17:36:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:36:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:36:19 INFO - Return code: 0 17:36:19 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')]} 17:36:19 INFO - https://queue.taskcluster.net/v1/task/f47mknD3SJS7O4IfsvuMSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:36:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f47mknD3SJS7O4IfsvuMSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:36:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f47mknD3SJS7O4IfsvuMSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:36:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f47mknD3SJS7O4IfsvuMSw/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 17:36:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f47mknD3SJS7O4IfsvuMSw/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 17:36:20 INFO - Downloaded 14403317 bytes. 17:36:20 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'] 17:36:20 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 17:36:20 INFO - Return code: 0 17:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:20 INFO - https://queue.taskcluster.net/v1/task/f47mknD3SJS7O4IfsvuMSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:36:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f47mknD3SJS7O4IfsvuMSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:36:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f47mknD3SJS7O4IfsvuMSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:36:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f47mknD3SJS7O4IfsvuMSw/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 17:36:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f47mknD3SJS7O4IfsvuMSw/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 17:36:22 INFO - Downloaded 57075758 bytes. 17:36:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f47mknD3SJS7O4IfsvuMSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:36:22 INFO - mkdir: /builds/slave/test/properties 17:36:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:36:22 INFO - Writing to file /builds/slave/test/properties/build_url 17:36:22 INFO - Contents: 17:36:22 INFO - build_url:https://queue.taskcluster.net/v1/task/f47mknD3SJS7O4IfsvuMSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:36:23 INFO - Running post-action listener: _resource_record_post_action 17:36:23 INFO - Running post-action listener: set_extra_try_arguments 17:36:23 INFO - ##### 17:36:23 INFO - ##### Finished download-and-extract step (success) 17:36:23 INFO - ##### 17:36:23 INFO - ##### 17:36:23 INFO - ##### Running populate-webroot step. 17:36:23 INFO - ##### 17:36:23 INFO - Running pre-action listener: _resource_record_pre_action 17:36:23 INFO - Running main action method: populate_webroot 17:36:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:36:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:36:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:36:23 INFO - '--tppagecycles', 17:36:23 INFO - '7'], 17:36:23 INFO - 'tests': ['tsvgm']}}, 17:36:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:36:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:36:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:36:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:36:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:36:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:36:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:23 INFO - 'talos_options': ['--disable-e10s'], 17:36:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:36:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:36:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:23 INFO - 'talos_options': ['--disable-e10s'], 17:36:23 INFO - 'tests': ['damp', 'tps']}, 17:36:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:23 INFO - 'tests': ['damp', 'tps']}, 17:36:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:36:23 INFO - 'tests': ['dromaeo_dom']}, 17:36:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:36:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:36:23 INFO - 'tests': ['basic_compositor_video']}, 17:36:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:36:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:36:23 INFO - 'tests': ['a11yr', 17:36:23 INFO - 'ts_paint', 17:36:23 INFO - 'tpaint', 17:36:23 INFO - 'sessionrestore', 17:36:23 INFO - 'sessionrestore_no_auto_restore', 17:36:23 INFO - 'tabpaint']}, 17:36:23 INFO - 'other-e10s': {'tests': ['a11yr', 17:36:23 INFO - 'ts_paint', 17:36:23 INFO - 'tpaint', 17:36:23 INFO - 'sessionrestore', 17:36:23 INFO - 'sessionrestore_no_auto_restore', 17:36:23 INFO - 'tabpaint']}, 17:36:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:36:23 INFO - 'ts_paint', 17:36:23 INFO - 'tpaint', 17:36:23 INFO - 'sessionrestore', 17:36:23 INFO - 'sessionrestore_no_auto_restore', 17:36:23 INFO - 'tabpaint']}, 17:36:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:36:23 INFO - 'ts_paint', 17:36:23 INFO - 'tpaint', 17:36:23 INFO - 'sessionrestore', 17:36:23 INFO - 'sessionrestore_no_auto_restore', 17:36:23 INFO - 'tabpaint']}, 17:36:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:36:23 INFO - 'tests': ['a11yr', 17:36:23 INFO - 'ts_paint', 17:36:23 INFO - 'tpaint', 17:36:23 INFO - 'sessionrestore', 17:36:23 INFO - 'sessionrestore_no_auto_restore', 17:36:23 INFO - 'tabpaint']}, 17:36:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:36:23 INFO - 'tests': ['a11yr', 17:36:23 INFO - 'ts_paint', 17:36:23 INFO - 'tpaint', 17:36:23 INFO - 'sessionrestore', 17:36:23 INFO - 'sessionrestore_no_auto_restore', 17:36:23 INFO - 'tabpaint']}, 17:36:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:36:23 INFO - 'tests': ['tsvgx', 17:36:23 INFO - 'tsvgr_opacity', 17:36:23 INFO - 'tart', 17:36:23 INFO - 'tscrollx', 17:36:23 INFO - 'cart']}, 17:36:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:36:23 INFO - 'tsvgr_opacity', 17:36:23 INFO - 'tart', 17:36:23 INFO - 'tscrollx', 17:36:23 INFO - 'cart']}, 17:36:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:23 INFO - 'talos_options': ['--disable-e10s'], 17:36:23 INFO - 'tests': ['tp5o']}, 17:36:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:23 INFO - 'tests': ['tp5o']}, 17:36:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:23 INFO - 'talos_options': ['--disable-e10s', 17:36:23 INFO - '--xperf_path', 17:36:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:36:23 INFO - 'tests': ['tp5n']}, 17:36:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:23 INFO - 'talos_options': ['--xperf_path', 17:36:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:36:23 INFO - 'tests': ['tp5n']}}, 17:36:23 INFO - 'talos.zip': {'path': '', 17:36:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:36:23 INFO - Running post-action listener: _resource_record_post_action 17:36:23 INFO - ##### 17:36:23 INFO - ##### Finished populate-webroot step (success) 17:36:23 INFO - ##### 17:36:23 INFO - ##### 17:36:23 INFO - ##### Running create-virtualenv step. 17:36:23 INFO - ##### 17:36:23 INFO - Running pre-action listener: _resource_record_pre_action 17:36:23 INFO - Running main action method: create_virtualenv 17:36:23 INFO - Creating virtualenv /builds/slave/test/build/venv 17:36:23 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:36:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:36:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:36:23 INFO - Using real prefix '/usr' 17:36:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:36:23 INFO - Installing distribute.............................................................................................................................................................................................done. 17:36:25 INFO - Installing pip.................done. 17:36:25 INFO - Return code: 0 17:36:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:36:25 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')]} 17:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:25 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')]} 17:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:25 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 0x23eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26aa3b0>, '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 0x26ab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ab740>, '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': '4300f881736b422476174874000001bc-1468629081.631444-1854461590', '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 17:36:25 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 17:36:25 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 17:36:25 INFO - Using env: {'DISPLAY': ':0', 17:36:25 INFO - 'HOME': '/home/cltbld', 17:36:25 INFO - 'LANG': 'en_US.UTF-8', 17:36:25 INFO - 'LANGUAGE': 'en_US:en', 17:36:25 INFO - 'LOGNAME': 'cltbld', 17:36:25 INFO - 'MAIL': '/var/mail/cltbld', 17:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:25 INFO - 'MOZ_NO_REMOTE': '1', 17:36:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:25 INFO - 'NO_EM_RESTART': '1', 17:36:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:25 INFO - 'PWD': '/builds/slave/test', 17:36:25 INFO - 'SHELL': '/bin/bash', 17:36:25 INFO - 'SHLVL': '1', 17:36:25 INFO - 'TERM': 'linux', 17:36:25 INFO - 'TMOUT': '86400', 17:36:25 INFO - 'USER': 'cltbld', 17:36:25 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1468629081.631444-1854461590', 17:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:25 INFO - '_': '/tools/buildbot/bin/python'} 17:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:25 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 17:36:25 INFO - Cleaning up... 17:36:25 INFO - Return code: 0 17:36:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:36:25 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')]} 17:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:25 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')]} 17:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:25 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 0x23eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26aa3b0>, '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 0x26ab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ab740>, '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': '4300f881736b422476174874000001bc-1468629081.631444-1854461590', '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 17:36:25 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 17:36:25 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 17:36:25 INFO - Using env: {'DISPLAY': ':0', 17:36:25 INFO - 'HOME': '/home/cltbld', 17:36:25 INFO - 'LANG': 'en_US.UTF-8', 17:36:25 INFO - 'LANGUAGE': 'en_US:en', 17:36:25 INFO - 'LOGNAME': 'cltbld', 17:36:25 INFO - 'MAIL': '/var/mail/cltbld', 17:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:25 INFO - 'MOZ_NO_REMOTE': '1', 17:36:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:25 INFO - 'NO_EM_RESTART': '1', 17:36:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:25 INFO - 'PWD': '/builds/slave/test', 17:36:25 INFO - 'SHELL': '/bin/bash', 17:36:25 INFO - 'SHLVL': '1', 17:36:25 INFO - 'TERM': 'linux', 17:36:25 INFO - 'TMOUT': '86400', 17:36:25 INFO - 'USER': 'cltbld', 17:36:25 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1468629081.631444-1854461590', 17:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:25 INFO - '_': '/tools/buildbot/bin/python'} 17:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:26 INFO - Downloading/unpacking psutil>=3.1.1 17:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:36:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:36:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:36:28 INFO - Installing collected packages: psutil 17:36:28 INFO - Running setup.py install for psutil 17:36:28 INFO - building 'psutil._psutil_linux' extension 17:36:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:36:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:36:28 INFO - building 'psutil._psutil_posix' extension 17:36:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:36:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:36:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:36:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:36:28 INFO - Successfully installed psutil 17:36:28 INFO - Cleaning up... 17:36:28 INFO - Return code: 0 17:36:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:28 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 0x23eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26aa3b0>, '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 0x26ab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ab740>, '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': '4300f881736b422476174874000001bc-1468629081.631444-1854461590', '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 17:36:28 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 17:36:28 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 17:36:28 INFO - Using env: {'DISPLAY': ':0', 17:36:28 INFO - 'HOME': '/home/cltbld', 17:36:28 INFO - 'LANG': 'en_US.UTF-8', 17:36:28 INFO - 'LANGUAGE': 'en_US:en', 17:36:28 INFO - 'LOGNAME': 'cltbld', 17:36:28 INFO - 'MAIL': '/var/mail/cltbld', 17:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:28 INFO - 'MOZ_NO_REMOTE': '1', 17:36:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:28 INFO - 'NO_EM_RESTART': '1', 17:36:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:28 INFO - 'PWD': '/builds/slave/test', 17:36:28 INFO - 'SHELL': '/bin/bash', 17:36:28 INFO - 'SHLVL': '1', 17:36:28 INFO - 'TERM': 'linux', 17:36:28 INFO - 'TMOUT': '86400', 17:36:28 INFO - 'USER': 'cltbld', 17:36:28 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1468629081.631444-1854461590', 17:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:28 INFO - '_': '/tools/buildbot/bin/python'} 17:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:36:28 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 17:36:28 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 17:36:28 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 17:36:28 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 17:36:28 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 17:36:28 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 17:36:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:36:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:36:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:36:30 INFO - Installing collected packages: mozsystemmonitor 17:36:30 INFO - Running setup.py install for mozsystemmonitor 17:36:30 INFO - Successfully installed mozsystemmonitor 17:36:30 INFO - Cleaning up... 17:36:31 INFO - Return code: 0 17:36:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26aa3b0>, '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 0x26ab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ab740>, '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': '4300f881736b422476174874000001bc-1468629081.631444-1854461590', '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 17:36:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:36:31 INFO - Using env: {'DISPLAY': ':0', 17:36:31 INFO - 'HOME': '/home/cltbld', 17:36:31 INFO - 'LANG': 'en_US.UTF-8', 17:36:31 INFO - 'LANGUAGE': 'en_US:en', 17:36:31 INFO - 'LOGNAME': 'cltbld', 17:36:31 INFO - 'MAIL': '/var/mail/cltbld', 17:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:31 INFO - 'MOZ_NO_REMOTE': '1', 17:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:31 INFO - 'NO_EM_RESTART': '1', 17:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:31 INFO - 'PWD': '/builds/slave/test', 17:36:31 INFO - 'SHELL': '/bin/bash', 17:36:31 INFO - 'SHLVL': '1', 17:36:31 INFO - 'TERM': 'linux', 17:36:31 INFO - 'TMOUT': '86400', 17:36:31 INFO - 'USER': 'cltbld', 17:36:31 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1468629081.631444-1854461590', 17:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:31 INFO - '_': '/tools/buildbot/bin/python'} 17:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:31 INFO - Downloading/unpacking jsonschema==2.5.1 17:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:36:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:33 INFO - Downloading functools32-3.2.3-2.tar.gz 17:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:36:33 INFO - warning: no files found matching '*.txt' 17:36:33 INFO - no previously-included directories found matching 'build' 17:36:33 INFO - no previously-included directories found matching 'dist' 17:36:33 INFO - no previously-included directories found matching '.git*' 17:36:33 INFO - Installing collected packages: jsonschema, functools32 17:36:33 INFO - Running setup.py install for functools32 17:36:33 INFO - warning: no files found matching '*.txt' 17:36:33 INFO - no previously-included directories found matching 'build' 17:36:33 INFO - no previously-included directories found matching 'dist' 17:36:33 INFO - no previously-included directories found matching '.git*' 17:36:33 INFO - Successfully installed jsonschema functools32 17:36:33 INFO - Cleaning up... 17:36:33 INFO - Return code: 0 17:36:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:36: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')]} 17:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36: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')]} 17:36:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26aa3b0>, '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 0x26ab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ab740>, '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': '4300f881736b422476174874000001bc-1468629081.631444-1854461590', '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 17:36:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:36:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:36:33 INFO - Using env: {'DISPLAY': ':0', 17:36:33 INFO - 'HOME': '/home/cltbld', 17:36:33 INFO - 'LANG': 'en_US.UTF-8', 17:36:33 INFO - 'LANGUAGE': 'en_US:en', 17:36:33 INFO - 'LOGNAME': 'cltbld', 17:36:33 INFO - 'MAIL': '/var/mail/cltbld', 17:36:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:33 INFO - 'MOZ_NO_REMOTE': '1', 17:36:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:33 INFO - 'NO_EM_RESTART': '1', 17:36:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:33 INFO - 'PWD': '/builds/slave/test', 17:36:33 INFO - 'SHELL': '/bin/bash', 17:36:33 INFO - 'SHLVL': '1', 17:36:33 INFO - 'TERM': 'linux', 17:36:33 INFO - 'TMOUT': '86400', 17:36:33 INFO - 'USER': 'cltbld', 17:36:33 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1468629081.631444-1854461590', 17:36:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:33 INFO - '_': '/tools/buildbot/bin/python'} 17:36:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:33 INFO - Downloading/unpacking blobuploader==1.2.4 17:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:35 INFO - Downloading blobuploader-1.2.4.tar.gz 17:36:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:36:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:36:35 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 17:36:35 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 17:36:35 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 17:36:35 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 17:36:35 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 17:36:35 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 17:36:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:36:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:36 INFO - Downloading docopt-0.6.1.tar.gz 17:36:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:36:36 INFO - Installing collected packages: blobuploader, requests, docopt 17:36:36 INFO - Running setup.py install for blobuploader 17:36:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:36:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:36:36 INFO - Running setup.py install for requests 17:36:36 INFO - Running setup.py install for docopt 17:36:37 INFO - Successfully installed blobuploader requests docopt 17:36:37 INFO - Cleaning up... 17:36:37 INFO - Return code: 0 17:36:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26aa3b0>, '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 0x26ab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ab740>, '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': '4300f881736b422476174874000001bc-1468629081.631444-1854461590', '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 17:36:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:36:37 INFO - Using env: {'DISPLAY': ':0', 17:36:37 INFO - 'HOME': '/home/cltbld', 17:36:37 INFO - 'LANG': 'en_US.UTF-8', 17:36:37 INFO - 'LANGUAGE': 'en_US:en', 17:36:37 INFO - 'LOGNAME': 'cltbld', 17:36:37 INFO - 'MAIL': '/var/mail/cltbld', 17:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:37 INFO - 'MOZ_NO_REMOTE': '1', 17:36:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:37 INFO - 'NO_EM_RESTART': '1', 17:36:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:37 INFO - 'PWD': '/builds/slave/test', 17:36:37 INFO - 'SHELL': '/bin/bash', 17:36:37 INFO - 'SHLVL': '1', 17:36:37 INFO - 'TERM': 'linux', 17:36:37 INFO - 'TMOUT': '86400', 17:36:37 INFO - 'USER': 'cltbld', 17:36:37 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1468629081.631444-1854461590', 17:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:37 INFO - '_': '/tools/buildbot/bin/python'} 17:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:36:37 INFO - Running setup.py (path:/tmp/pip-VNoRdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:36:37 INFO - Running setup.py (path:/tmp/pip-vF9jgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:36:37 INFO - Running setup.py (path:/tmp/pip-0QuJqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:36:37 INFO - Running setup.py (path:/tmp/pip-HpIUjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:36:37 INFO - Running setup.py (path:/tmp/pip-EBmjsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:36:37 INFO - Running setup.py (path:/tmp/pip-pKMmcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:36:37 INFO - Running setup.py (path:/tmp/pip-q2jCoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:36:37 INFO - Running setup.py (path:/tmp/pip-d_RlaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:36:37 INFO - Running setup.py (path:/tmp/pip-K2VDiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:36:37 INFO - Running setup.py (path:/tmp/pip-IBy64q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:36:38 INFO - Running setup.py (path:/tmp/pip-MYfRmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:36:38 INFO - Running setup.py (path:/tmp/pip-yoFGfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:36:38 INFO - Running setup.py (path:/tmp/pip-J7YPqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:36:38 INFO - Running setup.py (path:/tmp/pip-VHHT5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:38 INFO - Running setup.py (path:/tmp/pip-GWwh63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:36:38 INFO - Running setup.py (path:/tmp/pip-OI76TO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:36:38 INFO - Running setup.py (path:/tmp/pip-6xQ6ia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:36:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:36:38 INFO - Running setup.py install for manifestparser 17:36:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:36:38 INFO - Running setup.py install for mozcrash 17:36:38 INFO - Running setup.py install for mozdebug 17:36:38 INFO - Running setup.py install for mozdevice 17:36:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:36:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:36:38 INFO - Running setup.py install for mozfile 17:36:39 INFO - Running setup.py install for mozhttpd 17:36:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:36:39 INFO - Running setup.py install for mozinfo 17:36:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:36:39 INFO - Running setup.py install for mozInstall 17:36:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:36:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:36:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:36:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:36:39 INFO - Running setup.py install for mozleak 17:36:39 INFO - Running setup.py install for mozlog 17:36:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:36:39 INFO - Running setup.py install for moznetwork 17:36:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:36:39 INFO - Running setup.py install for mozprocess 17:36:39 INFO - Running setup.py install for mozprofile 17:36:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:36:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:36:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:36:39 INFO - Running setup.py install for mozrunner 17:36:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:36:39 INFO - Running setup.py install for mozscreenshot 17:36:40 INFO - Running setup.py install for moztest 17:36:40 INFO - Running setup.py install for mozversion 17:36:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:36:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:36:40 INFO - Cleaning up... 17:36:40 INFO - Return code: 0 17:36:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:36: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')]} 17:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36: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')]} 17:36:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26aa3b0>, '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 0x26ab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ab740>, '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': '4300f881736b422476174874000001bc-1468629081.631444-1854461590', '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 17:36:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:36:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:36:40 INFO - Using env: {'DISPLAY': ':0', 17:36:40 INFO - 'HOME': '/home/cltbld', 17:36:40 INFO - 'LANG': 'en_US.UTF-8', 17:36:40 INFO - 'LANGUAGE': 'en_US:en', 17:36:40 INFO - 'LOGNAME': 'cltbld', 17:36:40 INFO - 'MAIL': '/var/mail/cltbld', 17:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:40 INFO - 'MOZ_NO_REMOTE': '1', 17:36:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:40 INFO - 'NO_EM_RESTART': '1', 17:36:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:40 INFO - 'PWD': '/builds/slave/test', 17:36:40 INFO - 'SHELL': '/bin/bash', 17:36:40 INFO - 'SHLVL': '1', 17:36:40 INFO - 'TERM': 'linux', 17:36:40 INFO - 'TMOUT': '86400', 17:36:40 INFO - 'USER': 'cltbld', 17:36:40 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1468629081.631444-1854461590', 17:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:40 INFO - '_': '/tools/buildbot/bin/python'} 17:36:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:36:40 INFO - Running setup.py (path:/tmp/pip-2un60v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:36:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:36:40 INFO - Running setup.py (path:/tmp/pip-4tcWLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:36:40 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)) 17:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:36:40 INFO - Running setup.py (path:/tmp/pip-NrbSCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:36:40 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)) 17:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:36:40 INFO - Running setup.py (path:/tmp/pip-C7ZiVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:36:40 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)) 17:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:36:40 INFO - Running setup.py (path:/tmp/pip-Vv5ALx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:36:40 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)) 17:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:36:40 INFO - Running setup.py (path:/tmp/pip-pXcAbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:36:40 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)) 17:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:36:40 INFO - Running setup.py (path:/tmp/pip-622I6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:36:41 INFO - Running setup.py (path:/tmp/pip-javMsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:36:41 INFO - Running setup.py (path:/tmp/pip-NLBN6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:36:41 INFO - Running setup.py (path:/tmp/pip-4Ogf3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:36:41 INFO - Running setup.py (path:/tmp/pip-5xEULj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:36:41 INFO - Running setup.py (path:/tmp/pip-uM61LD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:36:41 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)) 17:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:36:41 INFO - Running setup.py (path:/tmp/pip-HnnViO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:36:41 INFO - Running setup.py (path:/tmp/pip-3h8Nte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:36:41 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)) 17:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:41 INFO - Running setup.py (path:/tmp/pip-67BBhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:36:41 INFO - Running setup.py (path:/tmp/pip-kuFBb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:36:41 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)) 17:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:36:41 INFO - Running setup.py (path:/tmp/pip-qQC6_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:36:41 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)) 17:36:41 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)) 17:36:41 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)) 17:36:41 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)) 17:36:41 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)) 17:36:41 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)) 17:36:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:43 INFO - Downloading blessings-1.6.tar.gz 17:36:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:36:43 INFO - Installing collected packages: blessings 17:36:43 INFO - Running setup.py install for blessings 17:36:43 INFO - Successfully installed blessings 17:36:43 INFO - Cleaning up... 17:36:43 INFO - Return code: 0 17:36:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:36:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:36:44 INFO - Reading from file tmpfile_stdout 17:36:44 INFO - Current package versions: 17:36:44 INFO - argparse == 1.2.1 17:36:44 INFO - blessings == 1.6 17:36:44 INFO - blobuploader == 1.2.4 17:36:44 INFO - docopt == 0.6.1 17:36:44 INFO - functools32 == 3.2.3-2 17:36:44 INFO - jsonschema == 2.5.1 17:36:44 INFO - manifestparser == 1.1 17:36:44 INFO - mozInstall == 1.12 17:36:44 INFO - mozcrash == 0.17 17:36:44 INFO - mozdebug == 0.1 17:36:44 INFO - mozdevice == 0.48 17:36:44 INFO - mozfile == 1.2 17:36:44 INFO - mozhttpd == 0.7 17:36:44 INFO - mozinfo == 0.9 17:36:44 INFO - mozleak == 0.1 17:36:44 INFO - mozlog == 3.2 17:36:44 INFO - moznetwork == 0.27 17:36:44 INFO - mozprocess == 0.23 17:36:44 INFO - mozprofile == 0.28 17:36:44 INFO - mozrunner == 6.12 17:36:44 INFO - mozscreenshot == 0.1 17:36:44 INFO - mozsystemmonitor == 0.3 17:36:44 INFO - moztest == 0.7 17:36:44 INFO - mozversion == 1.4 17:36:44 INFO - psutil == 3.1.1 17:36:44 INFO - requests == 1.2.3 17:36:44 INFO - wsgiref == 0.1.2 17:36:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26aa3b0>, '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 0x26ab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ab740>, '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': '4300f881736b422476174874000001bc-1468629081.631444-1854461590', '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 17:36:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:36:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:36:44 INFO - Using env: {'DISPLAY': ':0', 17:36:44 INFO - 'HOME': '/home/cltbld', 17:36:44 INFO - 'LANG': 'en_US.UTF-8', 17:36:44 INFO - 'LANGUAGE': 'en_US:en', 17:36:44 INFO - 'LOGNAME': 'cltbld', 17:36:44 INFO - 'MAIL': '/var/mail/cltbld', 17:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:44 INFO - 'MOZ_NO_REMOTE': '1', 17:36:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:44 INFO - 'NO_EM_RESTART': '1', 17:36:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:44 INFO - 'PWD': '/builds/slave/test', 17:36:44 INFO - 'SHELL': '/bin/bash', 17:36:44 INFO - 'SHLVL': '1', 17:36:44 INFO - 'TERM': 'linux', 17:36:44 INFO - 'TMOUT': '86400', 17:36:44 INFO - 'USER': 'cltbld', 17:36:44 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1468629081.631444-1854461590', 17:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:44 INFO - '_': '/tools/buildbot/bin/python'} 17:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:36:44 INFO - Cleaning up... 17:36:44 INFO - Return code: 0 17:36:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26aa3b0>, '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 0x26ab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ab740>, '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': '4300f881736b422476174874000001bc-1468629081.631444-1854461590', '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 17:36:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:36:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:36:44 INFO - Using env: {'DISPLAY': ':0', 17:36:44 INFO - 'HOME': '/home/cltbld', 17:36:44 INFO - 'LANG': 'en_US.UTF-8', 17:36:44 INFO - 'LANGUAGE': 'en_US:en', 17:36:44 INFO - 'LOGNAME': 'cltbld', 17:36:44 INFO - 'MAIL': '/var/mail/cltbld', 17:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:44 INFO - 'MOZ_NO_REMOTE': '1', 17:36:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:44 INFO - 'NO_EM_RESTART': '1', 17:36:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:44 INFO - 'PWD': '/builds/slave/test', 17:36:44 INFO - 'SHELL': '/bin/bash', 17:36:44 INFO - 'SHLVL': '1', 17:36:44 INFO - 'TERM': 'linux', 17:36:44 INFO - 'TMOUT': '86400', 17:36:44 INFO - 'USER': 'cltbld', 17:36:44 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1468629081.631444-1854461590', 17:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:44 INFO - '_': '/tools/buildbot/bin/python'} 17:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:36:44 INFO - Cleaning up... 17:36:44 INFO - Return code: 0 17:36:44 INFO - Running post-action listener: _resource_record_post_action 17:36:44 INFO - Running post-action listener: _start_resource_monitoring 17:36:44 INFO - Starting resource monitoring. 17:36:44 INFO - ##### 17:36:44 INFO - ##### Finished create-virtualenv step (success) 17:36:44 INFO - ##### 17:36:44 INFO - ##### 17:36:44 INFO - ##### Running install step. 17:36:44 INFO - ##### 17:36:44 INFO - Running pre-action listener: _resource_record_pre_action 17:36:44 INFO - Running main action method: install 17:36:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:36:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:36:44 INFO - Reading from file tmpfile_stdout 17:36:44 INFO - Detecting whether we're running mozinstall >=1.0... 17:36:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:36:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:36:44 INFO - Reading from file tmpfile_stdout 17:36:44 INFO - Output received: 17:36:44 INFO - Usage: mozinstall [options] installer 17:36:44 INFO - Options: 17:36:44 INFO - -h, --help show this help message and exit 17:36:44 INFO - -d DEST, --destination=DEST 17:36:44 INFO - Directory to install application into. [default: 17:36:44 INFO - "/builds/slave/test"] 17:36:44 INFO - --app=APP Application being installed. [default: firefox] 17:36:44 INFO - mkdir: /builds/slave/test/build/application 17:36:44 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'] 17:36:44 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 17:37:01 INFO - Reading from file tmpfile_stdout 17:37:01 INFO - Output received: 17:37:01 INFO - /builds/slave/test/build/application/firefox/firefox 17:37:01 INFO - Running post-action listener: _resource_record_post_action 17:37:01 INFO - ##### 17:37:01 INFO - ##### Finished install step (success) 17:37:01 INFO - ##### 17:37:01 INFO - ##### 17:37:01 INFO - ##### Running run-tests step. 17:37:01 INFO - ##### 17:37:01 INFO - Running pre-action listener: _resource_record_pre_action 17:37:01 INFO - Running main action method: run_tests 17:37:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:37:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:37:01 INFO - Python 2.7.3 17:37:01 INFO - Return code: 0 17:37:01 INFO - grabbing minidump binary from tooltool 17:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:37:01 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26aa3b0>, '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 0x26ab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ab740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:37:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:37:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:37:01 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:37:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:37:01 INFO - Return code: 0 17:37:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:37:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:37:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:37:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:37:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:37:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f47mknD3SJS7O4IfsvuMSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 17:37:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f47mknD3SJS7O4IfsvuMSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 17:37:01 INFO - Using env: {'DISPLAY': ':0', 17:37:01 INFO - 'HOME': '/home/cltbld', 17:37:01 INFO - 'LANG': 'en_US.UTF-8', 17:37:01 INFO - 'LANGUAGE': 'en_US:en', 17:37:01 INFO - 'LOGNAME': 'cltbld', 17:37:01 INFO - 'MAIL': '/var/mail/cltbld', 17:37:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:37:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:01 INFO - 'MOZ_NO_REMOTE': '1', 17:37:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:37:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:01 INFO - 'NO_EM_RESTART': '1', 17:37:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:01 INFO - 'PWD': '/builds/slave/test', 17:37:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:37:01 INFO - 'SHELL': '/bin/bash', 17:37:01 INFO - 'SHLVL': '1', 17:37:01 INFO - 'TERM': 'linux', 17:37:01 INFO - 'TMOUT': '86400', 17:37:01 INFO - 'USER': 'cltbld', 17:37:01 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1468629081.631444-1854461590', 17:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:01 INFO - '_': '/tools/buildbot/bin/python'} 17:37:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f47mknD3SJS7O4IfsvuMSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 17:37:01 INFO - mozversion application_buildid: 20160715165251 17:37:01 INFO - mozversion application_changeset: 98979093d45f152ee94a39ed97ccb02d8a8ddcb4 17:37:01 INFO - mozversion application_display_name: Nightly 17:37:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:37:01 INFO - mozversion application_name: Firefox 17:37:01 INFO - mozversion application_remotingname: firefox 17:37:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:37:01 INFO - mozversion application_vendor: Mozilla 17:37:01 INFO - mozversion application_version: 50.0a1 17:37:01 INFO - mozversion platform_buildid: 20160715165251 17:37:01 INFO - mozversion platform_changeset: 98979093d45f152ee94a39ed97ccb02d8a8ddcb4 17:37:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:37:01 INFO - mozversion platform_version: 50.0a1 17:37:01 INFO - using testdate: 1468629421 17:37:01 INFO - actual date: 1468629421 17:37:01 INFO - starting webserver on 'localhost:32939' 17:37:01 INFO - SUITE-START | Running 2 tests 17:37:01 INFO - TEST-START | dromaeo_css 17:37:01 INFO - operating with platform_type : linux_ 17:37:01 INFO - Initialising browser for dromaeo_css test... 17:37:01 INFO - TEST-INFO | started process 26829 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpec_Pk4/profile http://localhost:32939/getInfo.html) 17:37:06 INFO - PROCESS | 26829 | __metrics Screen width/height:1600/1200 17:37:06 INFO - PROCESS | 26829 | colorDepth:24 17:37:06 INFO - PROCESS | 26829 | Browser inner width/height: 1024/697 17:37:06 INFO - PROCESS | 26829 | __metrics 17:37:06 INFO - PROCESS | 26829 | 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" 17:37:06 INFO - PROCESS | 26829 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:37:07 INFO - PROCESS | 26829 | console.error: PushService: 17:37:07 INFO - PROCESS | 26829 | stateChangeProcessEnqueue: Error transitioning state 17:37:07 INFO - PROCESS | 26829 | UnknownError 17:37:07 INFO - TEST-INFO | 26829: exit 0 17:37:07 INFO - Browser initialized. 17:37:07 INFO - Running cycle 1/1 for dromaeo_css test... 17:37:07 INFO - TEST-INFO | started process 26914 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpec_Pk4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:37:19 INFO - PROCESS | 26914 | RSS: Main: 158826496 17:37:19 INFO - PROCESS | 26914 | 17:38:10 INFO - PROCESS | 26914 | 1468629490605 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] 17:40:23 INFO - PROCESS | 26914 | Cycle 1(1): loaded http://localhost:32939/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32939/tests/dromaeo/cssquery-ext.html) 17:40:24 INFO - PROCESS | 26914 | RSS: Main: 263147520 17:40:24 INFO - PROCESS | 26914 | 17:43:27 INFO - PROCESS | 26914 | Cycle 1(1): loaded http://localhost:32939/tests/dromaeo/cssquery-ext.html (next: http://localhost:32939/tests/dromaeo/cssquery-jquery.html) 17:43:28 INFO - PROCESS | 26914 | RSS: Main: 243744768 17:43:28 INFO - PROCESS | 26914 | 17:46:30 INFO - PROCESS | 26914 | Cycle 1(1): loaded http://localhost:32939/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32939/tests/dromaeo/cssquery-mootools.html) 17:46:30 INFO - PROCESS | 26914 | RSS: Main: 242548736 17:46:30 INFO - PROCESS | 26914 | 17:49:33 INFO - PROCESS | 26914 | Cycle 1(1): loaded http://localhost:32939/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32939/tests/dromaeo/cssquery-prototype.html) 17:49:33 INFO - PROCESS | 26914 | RSS: Main: 243249152 17:49:33 INFO - PROCESS | 26914 | 17:52:36 INFO - PROCESS | 26914 | Cycle 1(1): loaded http://localhost:32939/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32939/tests/dromaeo/cssquery-yui.html) 17:52:37 INFO - PROCESS | 26914 | RSS: Main: 225132544 17:52:37 INFO - PROCESS | 26914 | 17:55:40 INFO - PROCESS | 26914 | Cycle 1(1): loaded http://localhost:32939/tests/dromaeo/cssquery-yui.html (next: http://localhost:32939/tests/dromaeo/cssquery-dojo.html) 17:55:40 INFO - PROCESS | 26914 | RSS: Main: 265924608 17:55:40 INFO - PROCESS | 26914 | 17:55:40 INFO - PROCESS | 26914 | __start_tp_report 17:55:40 INFO - PROCESS | 26914 | _x_x_mozilla_page_load 17:55:40 INFO - PROCESS | 26914 | _x_x_mozilla_page_load_details 17:55:40 INFO - PROCESS | 26914 | |i|pagename|runs| 17:55:40 INFO - PROCESS | 26914 | |0;dojo.html;2608.8173827832047;2619.6070589411597;2647.0470630572995;2665.0405853892607;2665.080547211213;4627.699199552027;4691.788869500872;4713.78787954542;4728.716277023376;4761.952380476194;4683.718976861391;4705.811767529295;4713.481517033124;4720.315554244641;4769.165396055685;4352.12957408518;4399.120175964804;4404.4494438195225;4420.823167073313;4433.800478978437;4367.650587952972;4407.338899165119;4450.888727781815;4482.8655140345845;4532.0256144928835;4443.60007599316;4459.108178364324;4479.641628669699;4494.303382975644;4500.099980003996;4246.256905041636;4281.6574674026315;4290.99161697001;4406.361077643755;4437.179121862434;4309.612134907873;4315.5900189481945;4318.157959197958;4332.176886391576;4334.263175260214;4825.034993001414;4840.975795121037;4841.370621819176;4848.2727590861305;4851.248056551241;4966.230234313687;5076.06092872816;5102.38771347437;5105.489451054865;5125.333706618153;5139.820106296299;5198.246254293106;5212.244224587452;5218.973905130488;5222.63441559091;4798.856034318941;4825.662203645711;4836.927446088312;4854.635902307341;4859.052484765508;5046.873828154326;5167.199084141964;5232.712200828915;5246.449122842123;5338.839834804962;5010.198368261061;5042.042012017705;5060.291559181717;5063.265826455144;5069.062223488666;5087.567556757717;5096.031753966735;5107.259447380184;5116.948830511722;5135.152699804565;4859.975700121477;4912.38595175603;4997.775100120503;5061.139606266944;5065.746712664426;4997.825076122318;5018.5985121190215;5031.949680503149;5032.874178145503;5074.695518268915;3965.92068158641;3967.107400834847;3978.244133614604;3980.144268982183;4013.4381186633896;3449.586049674055;3464.5149679044953;3478.80866552337;3484.982575087108;3503.702185314226;4305.311150216013;4308.74147551148;4319.200947824663;4328.935065974013;4346.978265108654;5043.9747801260755;5044.445111037783;5046.924296135561;5053.292539044537;5089.720065396365;4224.9155016899485;4348.391225228471;4391.3412988051405;4399.12017596482;4404.867853964386;4595.931061034087;4612.976935115303;4618.030213655103;4621.792019359137;4673.99509105544;4644.883877902945;4844.418669759581;4852.078105160008;4852.150873597036;4870.707757534559;5048.949510504848;5082.440931497458;5089.312942752829;5100.107481190851;5107.514786095315;4745.193317136026;4758.072175925661;4768.165571024987;4772.308015337826;4825.9758701207675;4885.316055752127;4894.1679914415345;5003.474635163401;5003.899922001612;5041.092603331435;5025.120603894377;5068.315777370008;5079.898402031865;5082.669626474268;5084.898302033865;4922.384701912261;4927.802887884588;4928.630352723489;4929.112759703288;4968.329275547755;4875.366202393666;4890.217565189552;4920;4927.852164435073;4971.105201063843;4795.256735206049;4803.1114243864995;4817;4861.878453038702;4909.4354149273295;4936.358273424432;4944.604431645388;4945.208766597327;4947.6536642434685;5000.77496512665;4767.809287628595;4832.565069143794;4840.806367745251;4849.539293767087;4889.193283108248 17:55:40 INFO - PROCESS | 26914 | |1;ext.html;552.9944700552994;564.8785511115109;567.7133047810855;568.641755693913;574.2706762411734;26935;42157;44050.999999999956;44165.337519937224;44207.115857682824;41119.177616447654;41393.37909931346;41418.79290603543;41473.58526414735;41573.7921310393;7620.999999999986;7775.572343521104;7784.455088143832;7793.337566306871;7793.376529877596;7753.573553454557;7847.372210223169;7848.7645370638975;7854.528728276322;7864.724734634289;7825.373970082408;7889.9743033405575;7891.881621775649;7892.842143157133;7899.802504937394;7839.333656639193;7868.842623147562;7876.881846772303;7884.526928384315;7884.921150788476;7763.495372800807;7839.529628222268;7846.058472983222;7851.175626559186;7854;37507.624923750685;37711.62288377136;37829.81085094557;37872;37903.052423689354;3023.304639932806;3053.603031605899;3138.2781960149064;3269.6239932407602;3272.983635081833;29149.56275655846;29728.702712973027;29853.552196717068;30092.548611770842;30332.696673033428;3552.928941421183;3593.0478423217605;3599.8740044098595;3607.2244467439627;3640.453931910208;290880;295412;296409;389716.99999999715;394390;55243;55736;55830.44169558334;55887.720561396934;56011;33047.834760826045;33950.151246219044;34016.82991585076;35917;59032;13601.04792664504;13696.93151534256;13699.178049317074;13713.108647937852;13728.45086196561;9936.354136981074;9957.651482198089;9967.651132210338;9982.650607228712;9984.101430871257;18017.729734054;18411.447656570323;18523.81476185221;18561.81438185601;18575.81424185768;6738;6776.796696099125;6926.861462770717;7004.509684322048;7018.263082376379;783.6512751825497;879.090141703334;930.3812964378612;937.3344925103116;954.6420092465326;27284.31789205286;28617;28698.42603147967;28752;29240.268993274913;790.8457850719054;932.3706498113746;936.1901954809177;980.8915925004842;1048.9265751397481;14803;14919;14937.427531885935;15019.474318398803;15503.379864805507;403370;405180;409728;412763;412812;49481;50193.74903125461;50287;50416;50457;1098.7143342730947;1129.3224065560598;1154.7228665120479;1213.7390461050916;1235.184778046485;26999.46001079928;29138.27154321074;29321.56017659694;29904.25239369033;30057;41839.7908010458;42291.788541057096;42536;42572.57427425686;42574.361384579875;255861;259023;259083;259208;259334;22015.449613759785;23978.16076437386;24837.87581062083;25135.371615709755;25169.119080832814;40073.1985360297;40288.79855600703;40636.79681601573;41259.1748165041;41369;35485;35625;35769;36159.45760813643;36427.45358819567;35760;35775.105622359646;35821.641783582876;35945.64054359423;36060;33765.155871103416;34518.13704657404;34614.82692586521;34845;34912;30260.69739302579;31723.04830855078;31819.04542863718;31863.84068079645;34491.31017379588;25933.22200333993;26148.215553533424;26159;26333.210003699918;26392.340191495365 17:55:40 INFO - PROCESS | 26914 | |2;jquery.html;375.3843696338006;378.109552005028;383.88099689096373;389.6512621204024;392.2527584950668;16354.83645163548;16618.75071873923;17377.913110434463;17654.735178972292;17684.204210810512;10912.127029837613;11419.714507137325;11434.771304573904;11440.771184576304;11443.828342574847;4390.363397307388;4693.976530117353;5349.545288650469;5354;5370.113931201347;5212.817551385702;5285.973570132144;5295.655782374133;5299.470052994689;5317.601179911503;4755.667103302771;4813.253945638414;4822.373091498101;4824.734639594821;5281.524662780349;4828.179209534387;4831.323614693945;4840.177169881111;4849.393825771761;4863.440704319013;4556;4733.857984260478;4734.4081989751285;4735.502772208903;4742.739149346785;12473.126881118325;12791.976641868629;12972.416241269166;12978;12993.350332483338;1942.494951312669;1975.5950030243766;1996.4509759816021;2004.83961283097;2014.5870096630156;9064;9416.90583094167;9456.723342348763;9496.762580935463;9928.056834600702;1702.9233684484227;1712.6403455274408;1714.7170716831708;1768.2219823277844;1847.2149336532054;72626.63686681585;73515.63242183809;73597.26402736011;73779;73991.63004184945;10029.297949143636;10060.24548158891;10346;10427.705904701106;10460.52927618259;14278.2146981917;14363.21002344881;14387.136771793726;14403.423863045571;14403.927980360031;7223.097112860893;7528.435367347471;7555.471117021756;7575;7596.544207347577;7119.572825630479;7165.856682866313;7280.890786638205;7306.59813710251;7316.122065352191;4421.336799480039;4491.169133710274;4530.614897733663;4577.427821522309;4614.884627884329;1543.668111356064;1662.3516828436918;1730.5500569851677;1823.7629108215847;1884.5853912139307;738.1584993107862;842.3808500751942;897.5781382750097;898.8831451911341;916.6470908700065;17559.73660395095;17588.736168957475;18179;18282.54293642643;18500.35248766287;844.8014716541608;863.766782968595;864.4510735682886;871.2724874729545;934.8036912248368;9748.658796942073;9974.750631234278;10047.447390393452;10093;10101.69694909154;368957;373824;374403;375014;378464;47556.28665570019;57619;68775.65612172007;69169;75845;732.4799392431327;867.8866958954839;882.6513527156737;911.0798093925183;917.3395155488038;13031.283279419724;15008.174550399834;15578.454754083552;16266.186690665656;16712.080835554163;38130.61869381271;38246.23507529889;38539.036524087125;38611.227775443775;38958.2208355837;45818.770906145255;48782;49687.75156124196;49942.75028624834;50293.74853125711;7466.514676546007;7574;7742.729004484816;7754.340881025176;7754.379649627904;10895.2918060329;11460;11641;11754.29474231549;11960.282383056696;9873.753156171153;10058.145057669888;10613.628523001658;10686.946565267124;10776.568937242422;10119.139873110867;10337.276390652582;10353.119984801377;10539.525721342405;10633.680989570325;10330.535125919201;10464.843027354444;10656.360618362924;10754.300970436896;10791.244612877023;7244.855102897807;7520.548767073993;7526.473146879666;7532.472726909283;8045.758627241192;9498.19265362452;10226.590936362461;10347.586096556053;10603.840942386025;10774.084202842532 17:55:40 INFO - PROCESS | 26914 | |3;mootools.html;1382.9446822127113;1401.481451862811;1499.8500149984995;1699.813020567738;1720.6472673102016;7678.808029799251;8120.025596928362;8181.3863960202925;8190.508569485827;8191.5085094894275;6611.768588099418;6800.217974932884;6819.283975182609;7005.124359455068;8070;1825.8223445877402;2130.659094544873;2194.692743015979;2201.7137772089604;2227.8329125315586;2164;2193.9451513712124;2216.501287210373;2218.1238410827714;2218.800307972282;1807.051298068518;2187.507810742586;2191.704119943803;2194.2539536557565;2195.506011147495;1991.1935666055272;2073.6163809695104;2075.968860467094;2091.1948899673584;2097.265956915083;2112.376848829599;2117.6188286108495;2134.6691262854283;2136;2146.4741138421186;8105.594720264022;8169.060558035842;8181.918180818235;8195.71315003972;8207.302379297767;4387.298032314814;4404.933925991113;4528.0943811237885;4642.117997580449;4652.558006989364;2841.3891013432003;2845.758110560605;2878.928026799326;2898.043645596948;2978.4192082543914;898.1596532594943;902.4134312696734;905.3571963905634;907.3648446087765;915.748169253454;10415.062644361968;10651.467426628715;10766.78466430667;11063.778724425547;11085.057770089552;3840.116773142193;3848.730588858753;3906.667933225651;3943.211357728466;4151.605597468236;8693.608787604573;8700.91299087001;8703.303735701129;8718.738437846874;8727.563621818883;4587.816487340469;4618.49196588375;4628.444586649556;4632.397788287569;4635.513271106553;3430.6740859618294;4226.2181496422645;4255.829766809293;4276.828926842892;4289.506706728704;3373.527706121145;3483.7561370704316;3516;3518.7536872419196;3533.434650455915;973.2651847854966;991.7223177510309;996.4170959988343;1008.2589296866797;1015.3400289811682;626.0827887145354;673.4444083631024;772.25863171355;793.6706266899288;809.7935026568188;4984.476629953875;5037.168867136955;5117.513836185556;5148.99594579061;5218.843434696965;814.7067055859885;853.470848074198;854.9273311768569;867.4578388507183;875.1030194051149;3430.828458577061;3437.8281085945605;3468.843902024415;3475.5481787367985;3648.8175591220333;9403.858942115874;9579.089986451416;9591.328606997582;9636.084571965652;9675.612975481043;9626.47054412;9628.037196280316;9638.855417168748;9639.566219520138;9648.855267170999;7035.401990830836;7082.610456424843;7246.96376518114;7259.818504537428;7269.491135620561;5049.924251136309;5074.695518268915;5122.359705036871;5305.522502974596;5382.650127741685;8808.779780505538;9118.863217051883;9221.677241296522;9229.307801914749;9240.722778316662;8929.419587726778;9152.95423522878;9418.529073546433;9421.623135074795;9431.528423578657;6333.841653958688;7292.671829767779;7560.9621951889885;7680.615969201629;7691.807704807425;7598.582077985764;7739.922600774145;7750.496217745828;7754.418418618739;7769.92230077692;6913.896291555731;7149.749758758627;7155.606441645551;7170.247124052108;7181.676824542804;7039.120109986252;7067.505274630932;7100.396466300215;7116.857662846817;7210.567365958059;6468.838279043061;6476.935230647821;6482.189726284215;6483.124778154889;6484.157059582413;4490.618297444754;4614.423197100363;4633.073385322881;4665.113628410591;4691.413573303337;4460.776961151864;4513.300438432048;4529.094181163847;4550.704204226715;4590.98998220391 17:55:40 INFO - PROCESS | 26914 | |4;prototype.html;286.62309063581387;287.0727550013458;293.84866793601293;295.1411392846816;300.04286326618086;4727.243641017438;4831.492693267204;4834.10569044727;4881.24340727187;4893.119238537062;4729.527047295269;4817.975910120454;4857.854264372066;4866.829660961867;4887.291342755308;3819.2552452271816;3823.636754508317;3829.5021647185895;3829.617038296162;3845.8461661533506;3598.802065886375;3675.705943524525;3809.257194847006;3830.6743926766258;3881.941770873439;3788.583255841855;3799.35410980134;3802.676772474343;3820.2932457495453;3830.2148059647707;3793;3795;3796.9430458543143;3809;3812.1422679897078;3336.816475093869;3354.3291341731506;3356.3790698720813;3361.3949489091956;3367.6800703933086;4653.976730116327;4681.882952926204;4710.3405523226775;4710.599599034086;4746.145693775119;4313;4330;4340.631046361063;4343.109662519176;4357.3899654048455;5027.648064635477;5038.445770965191;5043.773030213649;5047.3438453001245;5066.316047333599;3529.6470352964498;3637.0725465006517;3642.963570364289;3652.411201127518;3656.3601369760186;5259.921101183485;5262.657927234755;5267.973660131752;5274.2879711238875;5297.867553311159;3727.9440808387894;3733.439984002367;3735.906602334909;3738.5887552369218;3779.962200378016;3514.525539052246;3803.980980095137;3813.637704418076;3814.3515602347666;3815.771053736785;4232.032105071095;4260.893477663083;4261.190373828963;4282.379055037002;4298.247806633889;4788.25782003783;5046.142155833517;5059.139946209079;5060.949390506122;5074.2895994560795;1240.466599362283;1264.1277518512197;1269.2321145706899;1278.4758249118004;1279.0790630745848;802.6027116577332;807.4832107451236;827.2017503109528;827.4662842466696;829.4318391901567;4063.4108054332546;4071.531773845986;4095.1809638072505;4100.91798164035;4116;4612.331211974245;4631;4655.37152484417;4660.576500219867;4688.5545873142;4020.3465712629522;4035.414864844581;4069.308217603015;4074.9796251018556;4098.319688927525;2349.577076126314;2461.2616215135386;2496.588062969626;2498.6376975338476;2499.3251822007956;4385.956140438555;4399.38408622793;4403.735775853459;4420.226460369487;4424.823007079745;4682.688847122811;4713.929291060636;4759.690620109682;4788.294613543337;4818.204996175662;4379;4383.991681913178;4457.576530229623;4952.801887924515;4972.627052970969;5262.605304602247;5279.524842764016;5288.550473209821;5292.364916210079;5298.3906850712665;5183.300254465749;5193.974030129825;5209.218617207449;5238.68567885928;5258.89482210346;4784.593309568726;4992.126377883928;4995.875103122451;5007.7746501408255;5042.294078828893;3720.8883733488037;3723.7765734056043;3742.401215805458;3757.49273848027;3762.9623703762613;5105.081085404663;5323.787048518016;5336.146216605324;5339.359276886798;5378.515933565998;4988.8752781180765;5129.87175320605;5130.230465430215;5131.538161565477;5151.613628977917;5112.616553758408;5122.948770512247;5129.769160387867;5146.536811686966;5147.639665223398;4922.778474968563;5058.822941197188;5082.593392528515;5085.753990272259;5115.462876398074;5134.15286477727;5156.7421628917655;5158.329417175743;5161.683770638463;5164.147915593885;5024.748762561931;5032;5043.2687260347775;5046.435604962473;5065.037642847848 17:55:40 INFO - PROCESS | 26914 | |5;yui.html;605.2555356910999;654.0157063619249;669.3406994110803;682.7303215229985;704.3414407528961;12144.878551214486;13161.276129812857;13235.073544851864;13246.867531324684;13288.069835111546;13329.200247985103;13379.26414047227;13392.93303533481;13403.731925361488;13438.260895650736;619.0312161467311;629.2511910826125;747.2079595628624;752.8795392737163;765.0360545712415;772.8492943875947;773.4701729315409;778.6379333609871;779.8752199648058;781.5154604145438;827.8385714785619;828.4325237212529;829.2122483640535;829.4774292195908;829.875518672201;646.0986923242098;659.7427003468651;667.5193860420538;672.9596224226514;820.958952052395;582.659144400522;601.2454369765959;606.8118883146238;609.6585911889312;609.9878002439971;13153.539626113135;13175.802362964563;13180.802287965687;13187.53843615469;13190.208587484782;12506.437210325557;12834.35828208586;12897.290649014394;12956.09307348486;13100.737985240241;11566.826497602458;11731.354775487345;11756.647300580997;11791.174617776758;12041.337726425043;4113.095119073829;4135.648469880064;4138.530821558364;4155.085881106182;4168.187203495319;58948;59754.70122649359;59960.400395995915;60108.398916010716;60330.69834650843;9802.264830137769;9891.932298035183;9921.55353009102;10173.44046077458;10580.153587712965;19197.808021919882;19237.230510779693;19237.711434328496;19252.133653985606;19262.518437039187;6743.291954344723;6890.689918953659;6952.826179345557;6980.720771169198;7133.7146514139895;3595.173110184672;3707.3882809336696;3712.201876596545;3735.1782607826776;3755.9061023474087;2823.1953893140358;2886.985565072161;2909.1999700082224;2916.0814343481734;2922.108756829145;479.1758175937382;492.7536231884058;495.02727141167776;496.4662987288679;496.4985364781597;454.62720569132995;498.5737194698481;520.9739513024333;521.6009752539311;537.938137114229;6855.451563874978;7097.89353159703;7331.523450975669;7349.04462419882;7485.139208990927;485.42234740658506;511.88994366211443;514.2414937966545;527.2592008228445;534.2760559441978;3349.581302337208;3398.915027124292;3521.6126226115107;3557.875474358385;3619.60184379718;90824;95471;97491;98814;100185;82096.17903820885;83546.58226708828;86149.56925215333;86996;87683.56158219169;44039.33940990888;60988.39011609916;74653.62673186707;75677.9999999989;76045;6320.304766475592;6347.619142851444;6382.297947225894;6422.839429014312;6509.804705858832;43384;43731.78134109309;44294.33558496561;46349.30476042795;46488.302675460574;55488.445115548326;66419.33580664132;66646.66676666586;67046.66476667585;67576.32423675897;9116.316276279438;9505.811773528309;9566.9043309566;9753.756156096155;9917.45454000008;10117.797644047225;10120.949395252977;10252.794944100928;10381.688549343531;10532.89467105319;9408.623655053721;9643.614255429984;9647.276454265817;9656.71029869105;9845.606175753177;9772.657956971472;9882.505874706092;9932;9960.352577082467;10240.436775977392;8586.31896005074;8667.479951202948;9103.635854565744;9170.862437063315;9373.578188981648;8157.34741220689;8397.916020839957;8609.913900861162;8844.955775221082;8883.689070882747;6853.417459515997;7124.501284910007;7308.085467102316;7465.514741541782;7676.232376762279 17:55:40 INFO - PROCESS | 26914 | __end_tp_report 17:55:40 INFO - PROCESS | 26914 | __start_cc_report 17:55:40 INFO - PROCESS | 26914 | _x_x_mozilla_cycle_collect,1056 17:55:40 INFO - PROCESS | 26914 | __end_cc_report 17:55:40 INFO - PROCESS | 26914 | __startTimestamp1468630540412__endTimestamp 17:55:40 INFO - PROCESS | 26914 | 17:55:40 INFO - PROCESS | 26914 | ------- Summary: start ------- 17:55:40 INFO - PROCESS | 26914 | Number of tests: 6 17:55:40 INFO - PROCESS | 26914 | 17:55:40 INFO - PROCESS | 26914 | [#0] dojo.html Cycles:165 Average:4677.84 Median:4841.37 stddev:521.24 (10.8%) stddev-sans-first:496.92 17:55:40 INFO - PROCESS | 26914 | Values: 2608.8 2619.6 2647.0 2665.0 2665.1 4627.7 4691.8 4713.8 4728.7 4762.0 4683.7 4705.8 4713.5 4720.3 4769.2 4352.1 4399.1 4404.4 4420.8 4433.8 4367.7 4407.3 4450.9 4482.9 4532.0 4443.6 4459.1 4479.6 4494.3 4500.1 4246.3 4281.7 4291.0 4406.4 4437.2 4309.6 4315.6 4318.2 4332.2 4334.3 4825.0 4841.0 4841.4 4848.3 4851.2 4966.2 5076.1 5102.4 5105.5 5125.3 5139.8 5198.2 5212.2 5219.0 5222.6 4798.9 4825.7 4836.9 4854.6 4859.1 5046.9 5167.2 5232.7 5246.4 5338.8 5010.2 5042.0 5060.3 5063.3 5069.1 5087.6 5096.0 5107.3 5116.9 5135.2 4860.0 4912.4 4997.8 5061.1 5065.7 4997.8 5018.6 5031.9 5032.9 5074.7 3965.9 3967.1 3978.2 3980.1 4013.4 3449.6 3464.5 3478.8 3485.0 3503.7 4305.3 4308.7 4319.2 4328.9 4347.0 5044.0 5044.4 5046.9 5053.3 5089.7 4224.9 4348.4 4391.3 4399.1 4404.9 4595.9 4613.0 4618.0 4621.8 4674.0 4644.9 4844.4 4852.1 4852.2 4870.7 5048.9 5082.4 5089.3 5100.1 5107.5 4745.2 4758.1 4768.2 4772.3 4826.0 4885.3 4894.2 5003.5 5003.9 5041.1 5025.1 5068.3 5079.9 5082.7 5084.9 4922.4 4927.8 4928.6 4929.1 4968.3 4875.4 4890.2 4920.0 4927.9 4971.1 4795.3 4803.1 4817.0 4861.9 4909.4 4936.4 4944.6 4945.2 4947.7 5000.8 4767.8 4832.6 4840.8 4849.5 4889.2 17:55:40 INFO - PROCESS | 26914 | 17:55:40 INFO - PROCESS | 26914 | [#1] ext.html Cycles:180 Average:48276.58 Median:37770.72 stddev:89822.77 (237.8%) stddev-sans-first:90003.28 17:55:40 INFO - PROCESS | 26914 | Values: 553.0 564.9 567.7 568.6 574.3 26935.0 42157.0 44051.0 44165.3 44207.1 41119.2 41393.4 41418.8 41473.6 41573.8 7621.0 7775.6 7784.5 7793.3 7793.4 7753.6 7847.4 7848.8 7854.5 7864.7 7825.4 7890.0 7891.9 7892.8 7899.8 7839.3 7868.8 7876.9 7884.5 7884.9 7763.5 7839.5 7846.1 7851.2 7854.0 37507.6 37711.6 37829.8 37872.0 37903.1 3023.3 3053.6 3138.3 3269.6 3273.0 29149.6 29728.7 29853.6 30092.5 30332.7 3552.9 3593.0 3599.9 3607.2 3640.5 290880.0 295412.0 296409.0 389717.0 394390.0 55243.0 55736.0 55830.4 55887.7 56011.0 33047.8 33950.2 34016.8 35917.0 59032.0 13601.0 13696.9 13699.2 13713.1 13728.5 9936.4 9957.7 9967.7 9982.7 9984.1 18017.7 18411.4 18523.8 18561.8 18575.8 6738.0 6776.8 6926.9 7004.5 7018.3 783.7 879.1 930.4 937.3 954.6 27284.3 28617.0 28698.4 28752.0 29240.3 790.8 932.4 936.2 980.9 1048.9 14803.0 14919.0 14937.4 15019.5 15503.4 403370.0 405180.0 409728.0 412763.0 412812.0 49481.0 50193.7 50287.0 50416.0 50457.0 1098.7 1129.3 1154.7 1213.7 1235.2 26999.5 29138.3 29321.6 29904.3 30057.0 41839.8 42291.8 42536.0 42572.6 42574.4 255861.0 259023.0 259083.0 259208.0 259334.0 22015.4 23978.2 24837.9 25135.4 25169.1 40073.2 40288.8 40636.8 41259.2 41369.0 35485.0 35625.0 35769.0 36159.5 36427.5 35760.0 35775.1 35821.6 35945.6 36060.0 33765.2 34518.1 34614.8 34845.0 34912.0 30260.7 31723.0 31819.0 31863.8 34491.3 25933.2 26148.2 26159.0 26333.2 26392.3 17:55:40 INFO - PROCESS | 26914 | 17:55:40 INFO - PROCESS | 26914 | [#2] jquery.html Cycles:180 Average:23291.77 Median:2391.31 stddev:61748.73 (2582.2%) stddev-sans-first:61897.98 17:55:40 INFO - PROCESS | 26914 | Values: 375.4 378.1 383.9 389.7 392.3 16354.8 16618.8 17377.9 17654.7 17684.2 10912.1 11419.7 11434.8 11440.8 11443.8 4390.4 4694.0 5349.5 5354.0 5370.1 5212.8 5286.0 5295.7 5299.5 5317.6 4755.7 4813.3 4822.4 4824.7 5281.5 4828.2 4831.3 4840.2 4849.4 4863.4 4556.0 4733.9 4734.4 4735.5 4742.7 12473.1 12792.0 12972.4 12978.0 12993.4 1942.5 1975.6 1996.5 2004.8 2014.6 9064.0 9416.9 9456.7 9496.8 9928.1 1702.9 1712.6 1714.7 1768.2 1847.2 72626.6 73515.6 73597.3 73779.0 73991.6 10029.3 10060.2 10346.0 10427.7 10460.5 14278.2 14363.2 14387.1 14403.4 14403.9 7223.1 7528.4 7555.5 7575.0 7596.5 7119.6 7165.9 7280.9 7306.6 7316.1 4421.3 4491.2 4530.6 4577.4 4614.9 1543.7 1662.4 1730.6 1823.8 1884.6 738.2 842.4 897.6 898.9 916.6 17559.7 17588.7 18179.0 18282.5 18500.4 844.8 863.8 864.5 871.3 934.8 9748.7 9974.8 10047.4 10093.0 10101.7 368957.0 373824.0 374403.0 375014.0 378464.0 47556.3 57619.0 68775.7 69169.0 75845.0 732.5 867.9 882.7 911.1 917.3 13031.3 15008.2 15578.5 16266.2 16712.1 38130.6 38246.2 38539.0 38611.2 38958.2 45818.8 48782.0 49687.8 49942.8 50293.7 7466.5 7574.0 7742.7 7754.3 7754.4 10895.3 11460.0 11641.0 11754.3 11960.3 9873.8 10058.1 10613.6 10686.9 10776.6 10119.1 10337.3 10353.1 10539.5 10633.7 10330.5 10464.8 10656.4 10754.3 10791.2 7244.9 7520.5 7526.5 7532.5 8045.8 9498.2 10226.6 10347.6 10603.8 10774.1 17:55:40 INFO - PROCESS | 26914 | 17:55:40 INFO - PROCESS | 26914 | [#3] mootools.html Cycles:180 Average:5152.04 Median:5344.09 stddev:2946.30 (55.1%) stddev-sans-first:2940.95 17:55:40 INFO - PROCESS | 26914 | Values: 1382.9 1401.5 1499.9 1699.8 1720.6 7678.8 8120.0 8181.4 8190.5 8191.5 6611.8 6800.2 6819.3 7005.1 8070.0 1825.8 2130.7 2194.7 2201.7 2227.8 2164.0 2193.9 2216.5 2218.1 2218.8 1807.1 2187.5 2191.7 2194.3 2195.5 1991.2 2073.6 2076.0 2091.2 2097.3 2112.4 2117.6 2134.7 2136.0 2146.5 8105.6 8169.1 8181.9 8195.7 8207.3 4387.3 4404.9 4528.1 4642.1 4652.6 2841.4 2845.8 2878.9 2898.0 2978.4 898.2 902.4 905.4 907.4 915.7 10415.1 10651.5 10766.8 11063.8 11085.1 3840.1 3848.7 3906.7 3943.2 4151.6 8693.6 8700.9 8703.3 8718.7 8727.6 4587.8 4618.5 4628.4 4632.4 4635.5 3430.7 4226.2 4255.8 4276.8 4289.5 3373.5 3483.8 3516.0 3518.8 3533.4 973.3 991.7 996.4 1008.3 1015.3 626.1 673.4 772.3 793.7 809.8 4984.5 5037.2 5117.5 5149.0 5218.8 814.7 853.5 854.9 867.5 875.1 3430.8 3437.8 3468.8 3475.5 3648.8 9403.9 9579.1 9591.3 9636.1 9675.6 9626.5 9628.0 9638.9 9639.6 9648.9 7035.4 7082.6 7247.0 7259.8 7269.5 5049.9 5074.7 5122.4 5305.5 5382.7 8808.8 9118.9 9221.7 9229.3 9240.7 8929.4 9153.0 9418.5 9421.6 9431.5 6333.8 7292.7 7561.0 7680.6 7691.8 7598.6 7739.9 7750.5 7754.4 7769.9 6913.9 7149.7 7155.6 7170.2 7181.7 7039.1 7067.5 7100.4 7116.9 7210.6 6468.8 6476.9 6482.2 6483.1 6484.2 4490.6 4614.4 4633.1 4665.1 4691.4 4460.8 4513.3 4529.1 4550.7 4591.0 17:55:40 INFO - PROCESS | 26914 | 17:55:40 INFO - PROCESS | 26914 | [#4] prototype.html Cycles:180 Average:4149.56 Median:4654.67 stddev:1217.86 (26.2%) stddev-sans-first:1186.26 17:55:40 INFO - PROCESS | 26914 | Values: 286.6 287.1 293.8 295.1 300.0 4727.2 4831.5 4834.1 4881.2 4893.1 4729.5 4818.0 4857.9 4866.8 4887.3 3819.3 3823.6 3829.5 3829.6 3845.8 3598.8 3675.7 3809.3 3830.7 3881.9 3788.6 3799.4 3802.7 3820.3 3830.2 3793.0 3795.0 3796.9 3809.0 3812.1 3336.8 3354.3 3356.4 3361.4 3367.7 4654.0 4681.9 4710.3 4710.6 4746.1 4313.0 4330.0 4340.6 4343.1 4357.4 5027.6 5038.4 5043.8 5047.3 5066.3 3529.6 3637.1 3643.0 3652.4 3656.4 5259.9 5262.7 5268.0 5274.3 5297.9 3727.9 3733.4 3735.9 3738.6 3780.0 3514.5 3804.0 3813.6 3814.4 3815.8 4232.0 4260.9 4261.2 4282.4 4298.2 4788.3 5046.1 5059.1 5060.9 5074.3 1240.5 1264.1 1269.2 1278.5 1279.1 802.6 807.5 827.2 827.5 829.4 4063.4 4071.5 4095.2 4100.9 4116.0 4612.3 4631.0 4655.4 4660.6 4688.6 4020.3 4035.4 4069.3 4075.0 4098.3 2349.6 2461.3 2496.6 2498.6 2499.3 4386.0 4399.4 4403.7 4420.2 4424.8 4682.7 4713.9 4759.7 4788.3 4818.2 4379.0 4384.0 4457.6 4952.8 4972.6 5262.6 5279.5 5288.6 5292.4 5298.4 5183.3 5194.0 5209.2 5238.7 5258.9 4784.6 4992.1 4995.9 5007.8 5042.3 3720.9 3723.8 3742.4 3757.5 3763.0 5105.1 5323.8 5336.1 5339.4 5378.5 4988.9 5129.9 5130.2 5131.5 5151.6 5112.6 5122.9 5129.8 5146.5 5147.6 4922.8 5058.8 5082.6 5085.8 5115.5 5134.2 5156.7 5158.3 5161.7 5164.1 5024.7 5032.0 5043.3 5046.4 5065.0 17:55:40 INFO - PROCESS | 26914 | 17:55:40 INFO - PROCESS | 26914 | [#5] yui.html Cycles:180 Average:17106.36 Median:609.82 stddev:25075.37 (4111.9%) stddev-sans-first:25115.10 17:55:40 INFO - PROCESS | 26914 | Values: 605.3 654.0 669.3 682.7 704.3 12144.9 13161.3 13235.1 13246.9 13288.1 13329.2 13379.3 13392.9 13403.7 13438.3 619.0 629.3 747.2 752.9 765.0 772.8 773.5 778.6 779.9 781.5 827.8 828.4 829.2 829.5 829.9 646.1 659.7 667.5 673.0 821.0 582.7 601.2 606.8 609.7 610.0 13153.5 13175.8 13180.8 13187.5 13190.2 12506.4 12834.4 12897.3 12956.1 13100.7 11566.8 11731.4 11756.6 11791.2 12041.3 4113.1 4135.6 4138.5 4155.1 4168.2 58948.0 59754.7 59960.4 60108.4 60330.7 9802.3 9891.9 9921.6 10173.4 10580.2 19197.8 19237.2 19237.7 19252.1 19262.5 6743.3 6890.7 6952.8 6980.7 7133.7 3595.2 3707.4 3712.2 3735.2 3755.9 2823.2 2887.0 2909.2 2916.1 2922.1 479.2 492.8 495.0 496.5 496.5 454.6 498.6 521.0 521.6 537.9 6855.5 7097.9 7331.5 7349.0 7485.1 485.4 511.9 514.2 527.3 534.3 3349.6 3398.9 3521.6 3557.9 3619.6 90824.0 95471.0 97491.0 98814.0 100185.0 82096.2 83546.6 86149.6 86996.0 87683.6 44039.3 60988.4 74653.6 75678.0 76045.0 6320.3 6347.6 6382.3 6422.8 6509.8 43384.0 43731.8 44294.3 46349.3 46488.3 55488.4 66419.3 66646.7 67046.7 67576.3 9116.3 9505.8 9566.9 9753.8 9917.5 10117.8 10120.9 10252.8 10381.7 10532.9 9408.6 9643.6 9647.3 9656.7 9845.6 9772.7 9882.5 9932.0 9960.4 10240.4 8586.3 8667.5 9103.6 9170.9 9373.6 8157.3 8397.9 8609.9 8845.0 8883.7 6853.4 7124.5 7308.1 7465.5 7676.2 17:55:40 INFO - PROCESS | 26914 | -------- Summary: end -------- 17:55:40 INFO - PROCESS | 26914 | 17:55:41 INFO - TEST-INFO | 26914: exit 0 17:55:41 INFO - TEST-OK | dromaeo_css | took 1119611ms 17:55:41 INFO - TEST-START | kraken 17:55:41 INFO - operating with platform_type : linux_ 17:55:41 INFO - Initialising browser for kraken test... 17:55:41 INFO - TEST-INFO | started process 27100 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp32XtCT/profile http://localhost:32939/getInfo.html) 17:55:45 INFO - PROCESS | 27100 | __metrics Screen width/height:1600/1200 17:55:45 INFO - PROCESS | 27100 | colorDepth:24 17:55:45 INFO - PROCESS | 27100 | Browser inner width/height: 1024/697 17:55:45 INFO - PROCESS | 27100 | __metrics 17:55:46 INFO - PROCESS | 27100 | 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" 17:55:46 INFO - PROCESS | 27100 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:55:47 INFO - TEST-INFO | 27100: exit 0 17:55:47 INFO - Browser initialized. 17:55:47 INFO - Running cycle 1/1 for kraken test... 17:55:47 INFO - TEST-INFO | started process 27181 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp32XtCT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:55:59 INFO - PROCESS | 27181 | RSS: Main: 159379456 17:55:59 INFO - PROCESS | 27181 | 17:56:02 INFO - PROCESS | 27181 | Cycle 1(1): loaded http://localhost:32939/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32939/tests/kraken/driver.html?testName=audio-beat-detection) 17:56:03 INFO - PROCESS | 27181 | RSS: Main: 218501120 17:56:03 INFO - PROCESS | 27181 | 17:56:05 INFO - PROCESS | 27181 | Cycle 1(1): loaded http://localhost:32939/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32939/tests/kraken/driver.html?testName=audio-dft) 17:56:06 INFO - PROCESS | 27181 | RSS: Main: 205217792 17:56:06 INFO - PROCESS | 27181 | 17:56:09 INFO - PROCESS | 27181 | Cycle 1(1): loaded http://localhost:32939/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32939/tests/kraken/driver.html?testName=audio-fft) 17:56:10 INFO - PROCESS | 27181 | RSS: Main: 272994304 17:56:10 INFO - PROCESS | 27181 | 17:56:12 INFO - PROCESS | 27181 | Cycle 1(1): loaded http://localhost:32939/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32939/tests/kraken/driver.html?testName=audio-oscillator) 17:56:13 INFO - PROCESS | 27181 | RSS: Main: 181796864 17:56:13 INFO - PROCESS | 27181 | 17:56:15 INFO - PROCESS | 27181 | Cycle 1(1): loaded http://localhost:32939/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32939/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:56:15 INFO - PROCESS | 27181 | RSS: Main: 186155008 17:56:15 INFO - PROCESS | 27181 | 17:56:19 INFO - PROCESS | 27181 | Cycle 1(1): loaded http://localhost:32939/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32939/tests/kraken/driver.html?testName=imaging-darkroom) 17:56:19 INFO - PROCESS | 27181 | RSS: Main: 221884416 17:56:19 INFO - PROCESS | 27181 | 17:56:23 INFO - PROCESS | 27181 | Cycle 1(1): loaded http://localhost:32939/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32939/tests/kraken/driver.html?testName=imaging-desaturate) 17:56:23 INFO - PROCESS | 27181 | RSS: Main: 222932992 17:56:23 INFO - PROCESS | 27181 | 17:56:26 INFO - PROCESS | 27181 | Cycle 1(1): loaded http://localhost:32939/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32939/tests/kraken/driver.html?testName=json-parse-financial) 17:56:27 INFO - PROCESS | 27181 | RSS: Main: 223043584 17:56:27 INFO - PROCESS | 27181 | 17:56:29 INFO - PROCESS | 27181 | Cycle 1(1): loaded http://localhost:32939/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32939/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:56:29 INFO - PROCESS | 27181 | RSS: Main: 212168704 17:56:29 INFO - PROCESS | 27181 | 17:56:31 INFO - PROCESS | 27181 | Cycle 1(1): loaded http://localhost:32939/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32939/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:56:32 INFO - PROCESS | 27181 | RSS: Main: 216416256 17:56:32 INFO - PROCESS | 27181 | 17:56:34 INFO - PROCESS | 27181 | Cycle 1(1): loaded http://localhost:32939/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32939/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:56:34 INFO - PROCESS | 27181 | RSS: Main: 213057536 17:56:34 INFO - PROCESS | 27181 | 17:56:37 INFO - PROCESS | 27181 | Cycle 1(1): loaded http://localhost:32939/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:56:38 INFO - PROCESS | 27181 | RSS: Main: 225927168 17:56:38 INFO - PROCESS | 27181 | 17:56:41 INFO - PROCESS | 27181 | Cycle 1(1): loaded http://localhost:32939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:56:41 INFO - PROCESS | 27181 | RSS: Main: 227471360 17:56:41 INFO - PROCESS | 27181 | 17:56:43 INFO - PROCESS | 27181 | Cycle 1(1): loaded http://localhost:32939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32939/tests/kraken/driver.html?testName=ai-astar) 17:56:43 INFO - PROCESS | 27181 | RSS: Main: 269979648 17:56:43 INFO - PROCESS | 27181 | 17:56:43 INFO - PROCESS | 27181 | __start_tp_report 17:56:43 INFO - PROCESS | 27181 | _x_x_mozilla_page_load 17:56:43 INFO - PROCESS | 27181 | _x_x_mozilla_page_load_details 17:56:43 INFO - PROCESS | 27181 | |i|pagename|runs| 17:56:43 INFO - PROCESS | 27181 | |0;ai-astar;104;114;115;117;114;114;114;114;114;113 17:56:43 INFO - PROCESS | 27181 | |1;audio-beat-detection;156;126;123;190;121;124;144;126;172;123 17:56:43 INFO - PROCESS | 27181 | |2;audio-dft;160;161;162;162;161;160;161;161;161;160 17:56:43 INFO - PROCESS | 27181 | |3;audio-fft;75;75;76;112;76;78;75;75;108;75 17:56:43 INFO - PROCESS | 27181 | |4;audio-oscillator;85;85;111;84;85;86;125;84;85;131 17:56:43 INFO - PROCESS | 27181 | |5;imaging-gaussian-blur;117;117;117;117;117;118;117;117;117;117 17:56:43 INFO - PROCESS | 27181 | |6;imaging-darkroom;146;147;146;146;147;146;146;147;149;146 17:56:43 INFO - PROCESS | 27181 | |7;imaging-desaturate;95;94;95;95;94;95;95;95;95;95 17:56:43 INFO - PROCESS | 27181 | |8;json-parse-financial;67;65;65;65;65;65;64;66;66;64 17:56:43 INFO - PROCESS | 27181 | |9;json-stringify-tinderbox;65;65;66;66;68;66;65;66;66;67 17:56:43 INFO - PROCESS | 27181 | |10;stanford-crypto-aes;80;79;84;82;85;79;78;80;78;84 17:56:43 INFO - PROCESS | 27181 | |11;stanford-crypto-ccm;140;138;136;126;126;126;128;127;214;132 17:56:43 INFO - PROCESS | 27181 | |12;stanford-crypto-pbkdf2;167;166;165;164;165;164;166;163;163;165 17:56:43 INFO - PROCESS | 27181 | |13;stanford-crypto-sha256-iterative;69;66;67;65;69;67;66;68;64;64 17:56:43 INFO - PROCESS | 27181 | __end_tp_report 17:56:43 INFO - PROCESS | 27181 | __start_cc_report 17:56:43 INFO - PROCESS | 27181 | _x_x_mozilla_cycle_collect,1908 17:56:43 INFO - PROCESS | 27181 | __end_cc_report 17:56:43 INFO - PROCESS | 27181 | __startTimestamp1468630603751__endTimestamp 17:56:43 INFO - PROCESS | 27181 | 17:56:43 INFO - PROCESS | 27181 | ------- Summary: start ------- 17:56:43 INFO - PROCESS | 27181 | Number of tests: 14 17:56:43 INFO - PROCESS | 27181 | 17:56:43 INFO - PROCESS | 27181 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:3.43 (3.0%) stddev-sans-first:1.12 17:56:43 INFO - PROCESS | 27181 | Values: 104.0 114.0 115.0 117.0 114.0 114.0 114.0 114.0 114.0 113.0 17:56:43 INFO - PROCESS | 27181 | 17:56:43 INFO - PROCESS | 27181 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:135.00 stddev:24.45 (18.1%) stddev-sans-first:25.28 17:56:43 INFO - PROCESS | 27181 | Values: 156.0 126.0 123.0 190.0 121.0 124.0 144.0 126.0 172.0 123.0 17:56:43 INFO - PROCESS | 27181 | 17:56:43 INFO - PROCESS | 27181 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 17:56:43 INFO - PROCESS | 27181 | Values: 160.0 161.0 162.0 162.0 161.0 160.0 161.0 161.0 161.0 160.0 17:56:43 INFO - PROCESS | 27181 | 17:56:43 INFO - PROCESS | 27181 | [#3] audio-fft Cycles:10 Average:82.50 Median:75.00 stddev:14.55 (19.4%) stddev-sans-first:15.18 17:56:43 INFO - PROCESS | 27181 | Values: 75.0 75.0 76.0 112.0 76.0 78.0 75.0 75.0 108.0 75.0 17:56:43 INFO - PROCESS | 27181 | 17:56:43 INFO - PROCESS | 27181 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:85.00 stddev:18.75 (22.1%) stddev-sans-first:19.45 17:56:43 INFO - PROCESS | 27181 | Values: 85.0 85.0 111.0 84.0 85.0 86.0 125.0 84.0 85.0 131.0 17:56:43 INFO - PROCESS | 27181 | 17:56:43 INFO - PROCESS | 27181 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:56:43 INFO - PROCESS | 27181 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 17:56:43 INFO - PROCESS | 27181 | 17:56:43 INFO - PROCESS | 27181 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:0.97 (0.7%) stddev-sans-first:1.00 17:56:43 INFO - PROCESS | 27181 | Values: 146.0 147.0 146.0 146.0 147.0 146.0 146.0 147.0 149.0 146.0 17:56:43 INFO - PROCESS | 27181 | 17:56:43 INFO - PROCESS | 27181 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:56:43 INFO - PROCESS | 27181 | Values: 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 17:56:43 INFO - PROCESS | 27181 | 17:56:43 INFO - PROCESS | 27181 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:65.00 stddev:0.92 (1.4%) stddev-sans-first:0.71 17:56:43 INFO - PROCESS | 27181 | Values: 67.0 65.0 65.0 65.0 65.0 65.0 64.0 66.0 66.0 64.0 17:56:43 INFO - PROCESS | 27181 | 17:56:43 INFO - PROCESS | 27181 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.94 (1.4%) stddev-sans-first:0.93 17:56:43 INFO - PROCESS | 27181 | Values: 65.0 65.0 66.0 66.0 68.0 66.0 65.0 66.0 66.0 67.0 17:56:43 INFO - PROCESS | 27181 | 17:56:43 INFO - PROCESS | 27181 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:81.00 stddev:2.64 (3.3%) stddev-sans-first:2.78 17:56:43 INFO - PROCESS | 27181 | Values: 80.0 79.0 84.0 82.0 85.0 79.0 78.0 80.0 78.0 84.0 17:56:43 INFO - PROCESS | 27181 | 17:56:43 INFO - PROCESS | 27181 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:134.00 stddev:26.78 (20.0%) stddev-sans-first:28.41 17:56:43 INFO - PROCESS | 27181 | Values: 140.0 138.0 136.0 126.0 126.0 126.0 128.0 127.0 214.0 132.0 17:56:43 INFO - PROCESS | 27181 | 17:56:43 INFO - PROCESS | 27181 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.80 Median:165.00 stddev:1.32 (0.8%) stddev-sans-first:1.13 17:56:43 INFO - PROCESS | 27181 | Values: 167.0 166.0 165.0 164.0 165.0 164.0 166.0 163.0 163.0 165.0 17:56:43 INFO - PROCESS | 27181 | 17:56:43 INFO - PROCESS | 27181 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.84 (2.7%) stddev-sans-first:1.72 17:56:43 INFO - PROCESS | 27181 | Values: 69.0 66.0 67.0 65.0 69.0 67.0 66.0 68.0 64.0 64.0 17:56:43 INFO - PROCESS | 27181 | -------- Summary: end -------- 17:56:43 INFO - PROCESS | 27181 | 17:56:44 INFO - TEST-INFO | 27181: exit 0 17:56:44 INFO - TEST-OK | kraken | took 63681ms 17:56:44 INFO - SUITE-END | took 1183s 17:56:44 INFO - Completed test suite (00:19:43) 17:56:44 INFO - javascript benchmark 17:56:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2608.8173827832047, 2619.6070589411597, 2647.0470630572995, 2665.0405853892607, 2665.080547211213, 4627.699199552027, 4691.788869500872, 4713.78787954542, 4728.716277023376, 4761.952380476194, 4683.718976861391, 4705.811767529295, 4713.481517033124, 4720.315554244641, 4769.165396055685, 4352.12957408518, 4399.120175964804, 4404.4494438195225, 4420.823167073313, 4433.800478978437, 4367.650587952972, 4407.338899165119, 4450.888727781815, 4482.8655140345845, 4532.0256144928835, 4443.60007599316, 4459.108178364324, 4479.641628669699, 4494.303382975644, 4500.099980003996, 4246.256905041636, 4281.6574674026315, 4290.99161697001, 4406.361077643755, 4437.179121862434, 4309.612134907873, 4315.5900189481945, 4318.157959197958, 4332.176886391576, 4334.263175260214, 4825.034993001414, 4840.975795121037, 4841.370621819176, 4848.2727590861305, 4851.248056551241, 4966.230234313687, 5076.06092872816, 5102.38771347437, 5105.489451054865, 5125.333706618153, 5139.820106296299, 5198.246254293106, 5212.244224587452, 5218.973905130488, 5222.63441559091, 4798.856034318941, 4825.662203645711, 4836.927446088312, 4854.635902307341, 4859.052484765508, 5046.873828154326, 5167.199084141964, 5232.712200828915, 5246.449122842123, 5338.839834804962, 5010.198368261061, 5042.042012017705, 5060.291559181717, 5063.265826455144, 5069.062223488666, 5087.567556757717, 5096.031753966735, 5107.259447380184, 5116.948830511722, 5135.152699804565, 4859.975700121477, 4912.38595175603, 4997.775100120503, 5061.139606266944, 5065.746712664426, 4997.825076122318, 5018.5985121190215, 5031.949680503149, 5032.874178145503, 5074.695518268915, 3965.92068158641, 3967.107400834847, 3978.244133614604, 3980.144268982183, 4013.4381186633896, 3449.586049674055, 3464.5149679044953, 3478.80866552337, 3484.982575087108, 3503.702185314226, 4305.311150216013, 4308.74147551148, 4319.200947824663, 4328.935065974013, 4346.978265108654, 5043.9747801260755, 5044.445111037783, 5046.924296135561, 5053.292539044537, 5089.720065396365, 4224.9155016899485, 4348.391225228471, 4391.3412988051405, 4399.12017596482, 4404.867853964386, 4595.931061034087, 4612.976935115303, 4618.030213655103, 4621.792019359137, 4673.99509105544, 4644.883877902945, 4844.418669759581, 4852.078105160008, 4852.150873597036, 4870.707757534559, 5048.949510504848, 5082.440931497458, 5089.312942752829, 5100.107481190851, 5107.514786095315, 4745.193317136026, 4758.072175925661, 4768.165571024987, 4772.308015337826, 4825.9758701207675, 4885.316055752127, 4894.1679914415345, 5003.474635163401, 5003.899922001612, 5041.092603331435, 5025.120603894377, 5068.315777370008, 5079.898402031865, 5082.669626474268, 5084.898302033865, 4922.384701912261, 4927.802887884588, 4928.630352723489, 4929.112759703288, 4968.329275547755, 4875.366202393666, 4890.217565189552, 4920.0, 4927.852164435073, 4971.105201063843, 4795.256735206049, 4803.1114243864995, 4817.0, 4861.878453038702, 4909.4354149273295, 4936.358273424432, 4944.604431645388, 4945.208766597327, 4947.6536642434685, 5000.77496512665, 4767.809287628595, 4832.565069143794, 4840.806367745251, 4849.539293767087, 4889.193283108248], "value": 4642.521704115337, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.9944700552994, 564.8785511115109, 567.7133047810855, 568.641755693913, 574.2706762411734, 26935.0, 42157.0, 44050.999999999956, 44165.337519937224, 44207.115857682824, 41119.177616447654, 41393.37909931346, 41418.79290603543, 41473.58526414735, 41573.7921310393, 7620.999999999986, 7775.572343521104, 7784.455088143832, 7793.337566306871, 7793.376529877596, 7753.573553454557, 7847.372210223169, 7848.7645370638975, 7854.528728276322, 7864.724734634289, 7825.373970082408, 7889.9743033405575, 7891.881621775649, 7892.842143157133, 7899.802504937394, 7839.333656639193, 7868.842623147562, 7876.881846772303, 7884.526928384315, 7884.921150788476, 7763.495372800807, 7839.529628222268, 7846.058472983222, 7851.175626559186, 7854.0, 37507.624923750685, 37711.62288377136, 37829.81085094557, 37872.0, 37903.052423689354, 3023.304639932806, 3053.603031605899, 3138.2781960149064, 3269.6239932407602, 3272.983635081833, 29149.56275655846, 29728.702712973027, 29853.552196717068, 30092.548611770842, 30332.696673033428, 3552.928941421183, 3593.0478423217605, 3599.8740044098595, 3607.2244467439627, 3640.453931910208, 290880.0, 295412.0, 296409.0, 389716.99999999715, 394390.0, 55243.0, 55736.0, 55830.44169558334, 55887.720561396934, 56011.0, 33047.834760826045, 33950.151246219044, 34016.82991585076, 35917.0, 59032.0, 13601.04792664504, 13696.93151534256, 13699.178049317074, 13713.108647937852, 13728.45086196561, 9936.354136981074, 9957.651482198089, 9967.651132210338, 9982.650607228712, 9984.101430871257, 18017.729734054, 18411.447656570323, 18523.81476185221, 18561.81438185601, 18575.81424185768, 6738.0, 6776.796696099125, 6926.861462770717, 7004.509684322048, 7018.263082376379, 783.6512751825497, 879.090141703334, 930.3812964378612, 937.3344925103116, 954.6420092465326, 27284.31789205286, 28617.0, 28698.42603147967, 28752.0, 29240.268993274913, 790.8457850719054, 932.3706498113746, 936.1901954809177, 980.8915925004842, 1048.9265751397481, 14803.0, 14919.0, 14937.427531885935, 15019.474318398803, 15503.379864805507, 403370.0, 405180.0, 409728.0, 412763.0, 412812.0, 49481.0, 50193.74903125461, 50287.0, 50416.0, 50457.0, 1098.7143342730947, 1129.3224065560598, 1154.7228665120479, 1213.7390461050916, 1235.184778046485, 26999.46001079928, 29138.27154321074, 29321.56017659694, 29904.25239369033, 30057.0, 41839.7908010458, 42291.788541057096, 42536.0, 42572.57427425686, 42574.361384579875, 255861.0, 259023.0, 259083.0, 259208.0, 259334.0, 22015.449613759785, 23978.16076437386, 24837.87581062083, 25135.371615709755, 25169.119080832814, 40073.1985360297, 40288.79855600703, 40636.79681601573, 41259.1748165041, 41369.0, 35485.0, 35625.0, 35769.0, 36159.45760813643, 36427.45358819567, 35760.0, 35775.105622359646, 35821.641783582876, 35945.64054359423, 36060.0, 33765.155871103416, 34518.13704657404, 34614.82692586521, 34845.0, 34912.0, 30260.69739302579, 31723.04830855078, 31819.04542863718, 31863.84068079645, 34491.31017379588, 25933.22200333993, 26148.215553533424, 26159.0, 26333.210003699918, 26392.340191495365], "value": 17399.148037566476, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.3843696338006, 378.109552005028, 383.88099689096373, 389.6512621204024, 392.2527584950668, 16354.83645163548, 16618.75071873923, 17377.913110434463, 17654.735178972292, 17684.204210810512, 10912.127029837613, 11419.714507137325, 11434.771304573904, 11440.771184576304, 11443.828342574847, 4390.363397307388, 4693.976530117353, 5349.545288650469, 5354.0, 5370.113931201347, 5212.817551385702, 5285.973570132144, 5295.655782374133, 5299.470052994689, 5317.601179911503, 4755.667103302771, 4813.253945638414, 4822.373091498101, 4824.734639594821, 5281.524662780349, 4828.179209534387, 4831.323614693945, 4840.177169881111, 4849.393825771761, 4863.440704319013, 4556.0, 4733.857984260478, 4734.4081989751285, 4735.502772208903, 4742.739149346785, 12473.126881118325, 12791.976641868629, 12972.416241269166, 12978.0, 12993.350332483338, 1942.494951312669, 1975.5950030243766, 1996.4509759816021, 2004.83961283097, 2014.5870096630156, 9064.0, 9416.90583094167, 9456.723342348763, 9496.762580935463, 9928.056834600702, 1702.9233684484227, 1712.6403455274408, 1714.7170716831708, 1768.2219823277844, 1847.2149336532054, 72626.63686681585, 73515.63242183809, 73597.26402736011, 73779.0, 73991.63004184945, 10029.297949143636, 10060.24548158891, 10346.0, 10427.705904701106, 10460.52927618259, 14278.2146981917, 14363.21002344881, 14387.136771793726, 14403.423863045571, 14403.927980360031, 7223.097112860893, 7528.435367347471, 7555.471117021756, 7575.0, 7596.544207347577, 7119.572825630479, 7165.856682866313, 7280.890786638205, 7306.59813710251, 7316.122065352191, 4421.336799480039, 4491.169133710274, 4530.614897733663, 4577.427821522309, 4614.884627884329, 1543.668111356064, 1662.3516828436918, 1730.5500569851677, 1823.7629108215847, 1884.5853912139307, 738.1584993107862, 842.3808500751942, 897.5781382750097, 898.8831451911341, 916.6470908700065, 17559.73660395095, 17588.736168957475, 18179.0, 18282.54293642643, 18500.35248766287, 844.8014716541608, 863.766782968595, 864.4510735682886, 871.2724874729545, 934.8036912248368, 9748.658796942073, 9974.750631234278, 10047.447390393452, 10093.0, 10101.69694909154, 368957.0, 373824.0, 374403.0, 375014.0, 378464.0, 47556.28665570019, 57619.0, 68775.65612172007, 69169.0, 75845.0, 732.4799392431327, 867.8866958954839, 882.6513527156737, 911.0798093925183, 917.3395155488038, 13031.283279419724, 15008.174550399834, 15578.454754083552, 16266.186690665656, 16712.080835554163, 38130.61869381271, 38246.23507529889, 38539.036524087125, 38611.227775443775, 38958.2208355837, 45818.770906145255, 48782.0, 49687.75156124196, 49942.75028624834, 50293.74853125711, 7466.514676546007, 7574.0, 7742.729004484816, 7754.340881025176, 7754.379649627904, 10895.2918060329, 11460.0, 11641.0, 11754.29474231549, 11960.282383056696, 9873.753156171153, 10058.145057669888, 10613.628523001658, 10686.946565267124, 10776.568937242422, 10119.139873110867, 10337.276390652582, 10353.119984801377, 10539.525721342405, 10633.680989570325, 10330.535125919201, 10464.843027354444, 10656.360618362924, 10754.300970436896, 10791.244612877023, 7244.855102897807, 7520.548767073993, 7526.473146879666, 7532.472726909283, 8045.758627241192, 9498.19265362452, 10226.590936362461, 10347.586096556053, 10603.840942386025, 10774.084202842532], "value": 7963.011573258019, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1382.9446822127113, 1401.481451862811, 1499.8500149984995, 1699.813020567738, 1720.6472673102016, 7678.808029799251, 8120.025596928362, 8181.3863960202925, 8190.508569485827, 8191.5085094894275, 6611.768588099418, 6800.217974932884, 6819.283975182609, 7005.124359455068, 8070.0, 1825.8223445877402, 2130.659094544873, 2194.692743015979, 2201.7137772089604, 2227.8329125315586, 2164.0, 2193.9451513712124, 2216.501287210373, 2218.1238410827714, 2218.800307972282, 1807.051298068518, 2187.507810742586, 2191.704119943803, 2194.2539536557565, 2195.506011147495, 1991.1935666055272, 2073.6163809695104, 2075.968860467094, 2091.1948899673584, 2097.265956915083, 2112.376848829599, 2117.6188286108495, 2134.6691262854283, 2136.0, 2146.4741138421186, 8105.594720264022, 8169.060558035842, 8181.918180818235, 8195.71315003972, 8207.302379297767, 4387.298032314814, 4404.933925991113, 4528.0943811237885, 4642.117997580449, 4652.558006989364, 2841.3891013432003, 2845.758110560605, 2878.928026799326, 2898.043645596948, 2978.4192082543914, 898.1596532594943, 902.4134312696734, 905.3571963905634, 907.3648446087765, 915.748169253454, 10415.062644361968, 10651.467426628715, 10766.78466430667, 11063.778724425547, 11085.057770089552, 3840.116773142193, 3848.730588858753, 3906.667933225651, 3943.211357728466, 4151.605597468236, 8693.608787604573, 8700.91299087001, 8703.303735701129, 8718.738437846874, 8727.563621818883, 4587.816487340469, 4618.49196588375, 4628.444586649556, 4632.397788287569, 4635.513271106553, 3430.6740859618294, 4226.2181496422645, 4255.829766809293, 4276.828926842892, 4289.506706728704, 3373.527706121145, 3483.7561370704316, 3516.0, 3518.7536872419196, 3533.434650455915, 973.2651847854966, 991.7223177510309, 996.4170959988343, 1008.2589296866797, 1015.3400289811682, 626.0827887145354, 673.4444083631024, 772.25863171355, 793.6706266899288, 809.7935026568188, 4984.476629953875, 5037.168867136955, 5117.513836185556, 5148.99594579061, 5218.843434696965, 814.7067055859885, 853.470848074198, 854.9273311768569, 867.4578388507183, 875.1030194051149, 3430.828458577061, 3437.8281085945605, 3468.843902024415, 3475.5481787367985, 3648.8175591220333, 9403.858942115874, 9579.089986451416, 9591.328606997582, 9636.084571965652, 9675.612975481043, 9626.47054412, 9628.037196280316, 9638.855417168748, 9639.566219520138, 9648.855267170999, 7035.401990830836, 7082.610456424843, 7246.96376518114, 7259.818504537428, 7269.491135620561, 5049.924251136309, 5074.695518268915, 5122.359705036871, 5305.522502974596, 5382.650127741685, 8808.779780505538, 9118.863217051883, 9221.677241296522, 9229.307801914749, 9240.722778316662, 8929.419587726778, 9152.95423522878, 9418.529073546433, 9421.623135074795, 9431.528423578657, 6333.841653958688, 7292.671829767779, 7560.9621951889885, 7680.615969201629, 7691.807704807425, 7598.582077985764, 7739.922600774145, 7750.496217745828, 7754.418418618739, 7769.92230077692, 6913.896291555731, 7149.749758758627, 7155.606441645551, 7170.247124052108, 7181.676824542804, 7039.120109986252, 7067.505274630932, 7100.396466300215, 7116.857662846817, 7210.567365958059, 6468.838279043061, 6476.935230647821, 6482.189726284215, 6483.124778154889, 6484.157059582413, 4490.618297444754, 4614.423197100363, 4633.073385322881, 4665.113628410591, 4691.413573303337, 4460.776961151864, 4513.300438432048, 4529.094181163847, 4550.704204226715, 4590.98998220391], "value": 4098.221658473292, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.62309063581387, 287.0727550013458, 293.84866793601293, 295.1411392846816, 300.04286326618086, 4727.243641017438, 4831.492693267204, 4834.10569044727, 4881.24340727187, 4893.119238537062, 4729.527047295269, 4817.975910120454, 4857.854264372066, 4866.829660961867, 4887.291342755308, 3819.2552452271816, 3823.636754508317, 3829.5021647185895, 3829.617038296162, 3845.8461661533506, 3598.802065886375, 3675.705943524525, 3809.257194847006, 3830.6743926766258, 3881.941770873439, 3788.583255841855, 3799.35410980134, 3802.676772474343, 3820.2932457495453, 3830.2148059647707, 3793.0, 3795.0, 3796.9430458543143, 3809.0, 3812.1422679897078, 3336.816475093869, 3354.3291341731506, 3356.3790698720813, 3361.3949489091956, 3367.6800703933086, 4653.976730116327, 4681.882952926204, 4710.3405523226775, 4710.599599034086, 4746.145693775119, 4313.0, 4330.0, 4340.631046361063, 4343.109662519176, 4357.3899654048455, 5027.648064635477, 5038.445770965191, 5043.773030213649, 5047.3438453001245, 5066.316047333599, 3529.6470352964498, 3637.0725465006517, 3642.963570364289, 3652.411201127518, 3656.3601369760186, 5259.921101183485, 5262.657927234755, 5267.973660131752, 5274.2879711238875, 5297.867553311159, 3727.9440808387894, 3733.439984002367, 3735.906602334909, 3738.5887552369218, 3779.962200378016, 3514.525539052246, 3803.980980095137, 3813.637704418076, 3814.3515602347666, 3815.771053736785, 4232.032105071095, 4260.893477663083, 4261.190373828963, 4282.379055037002, 4298.247806633889, 4788.25782003783, 5046.142155833517, 5059.139946209079, 5060.949390506122, 5074.2895994560795, 1240.466599362283, 1264.1277518512197, 1269.2321145706899, 1278.4758249118004, 1279.0790630745848, 802.6027116577332, 807.4832107451236, 827.2017503109528, 827.4662842466696, 829.4318391901567, 4063.4108054332546, 4071.531773845986, 4095.1809638072505, 4100.91798164035, 4116.0, 4612.331211974245, 4631.0, 4655.37152484417, 4660.576500219867, 4688.5545873142, 4020.3465712629522, 4035.414864844581, 4069.308217603015, 4074.9796251018556, 4098.319688927525, 2349.577076126314, 2461.2616215135386, 2496.588062969626, 2498.6376975338476, 2499.3251822007956, 4385.956140438555, 4399.38408622793, 4403.735775853459, 4420.226460369487, 4424.823007079745, 4682.688847122811, 4713.929291060636, 4759.690620109682, 4788.294613543337, 4818.204996175662, 4379.0, 4383.991681913178, 4457.576530229623, 4952.801887924515, 4972.627052970969, 5262.605304602247, 5279.524842764016, 5288.550473209821, 5292.364916210079, 5298.3906850712665, 5183.300254465749, 5193.974030129825, 5209.218617207449, 5238.68567885928, 5258.89482210346, 4784.593309568726, 4992.126377883928, 4995.875103122451, 5007.7746501408255, 5042.294078828893, 3720.8883733488037, 3723.7765734056043, 3742.401215805458, 3757.49273848027, 3762.9623703762613, 5105.081085404663, 5323.787048518016, 5336.146216605324, 5339.359276886798, 5378.515933565998, 4988.8752781180765, 5129.87175320605, 5130.230465430215, 5131.538161565477, 5151.613628977917, 5112.616553758408, 5122.948770512247, 5129.769160387867, 5146.536811686966, 5147.639665223398, 4922.778474968563, 5058.822941197188, 5082.593392528515, 5085.753990272259, 5115.462876398074, 5134.15286477727, 5156.7421628917655, 5158.329417175743, 5161.683770638463, 5164.147915593885, 5024.748762561931, 5032.0, 5043.2687260347775, 5046.435604962473, 5065.037642847848], "value": 3758.921674238576, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.2555356910999, 654.0157063619249, 669.3406994110803, 682.7303215229985, 704.3414407528961, 12144.878551214486, 13161.276129812857, 13235.073544851864, 13246.867531324684, 13288.069835111546, 13329.200247985103, 13379.26414047227, 13392.93303533481, 13403.731925361488, 13438.260895650736, 619.0312161467311, 629.2511910826125, 747.2079595628624, 752.8795392737163, 765.0360545712415, 772.8492943875947, 773.4701729315409, 778.6379333609871, 779.8752199648058, 781.5154604145438, 827.8385714785619, 828.4325237212529, 829.2122483640535, 829.4774292195908, 829.875518672201, 646.0986923242098, 659.7427003468651, 667.5193860420538, 672.9596224226514, 820.958952052395, 582.659144400522, 601.2454369765959, 606.8118883146238, 609.6585911889312, 609.9878002439971, 13153.539626113135, 13175.802362964563, 13180.802287965687, 13187.53843615469, 13190.208587484782, 12506.437210325557, 12834.35828208586, 12897.290649014394, 12956.09307348486, 13100.737985240241, 11566.826497602458, 11731.354775487345, 11756.647300580997, 11791.174617776758, 12041.337726425043, 4113.095119073829, 4135.648469880064, 4138.530821558364, 4155.085881106182, 4168.187203495319, 58948.0, 59754.70122649359, 59960.400395995915, 60108.398916010716, 60330.69834650843, 9802.264830137769, 9891.932298035183, 9921.55353009102, 10173.44046077458, 10580.153587712965, 19197.808021919882, 19237.230510779693, 19237.711434328496, 19252.133653985606, 19262.518437039187, 6743.291954344723, 6890.689918953659, 6952.826179345557, 6980.720771169198, 7133.7146514139895, 3595.173110184672, 3707.3882809336696, 3712.201876596545, 3735.1782607826776, 3755.9061023474087, 2823.1953893140358, 2886.985565072161, 2909.1999700082224, 2916.0814343481734, 2922.108756829145, 479.1758175937382, 492.7536231884058, 495.02727141167776, 496.4662987288679, 496.4985364781597, 454.62720569132995, 498.5737194698481, 520.9739513024333, 521.6009752539311, 537.938137114229, 6855.451563874978, 7097.89353159703, 7331.523450975669, 7349.04462419882, 7485.139208990927, 485.42234740658506, 511.88994366211443, 514.2414937966545, 527.2592008228445, 534.2760559441978, 3349.581302337208, 3398.915027124292, 3521.6126226115107, 3557.875474358385, 3619.60184379718, 90824.0, 95471.0, 97491.0, 98814.0, 100185.0, 82096.17903820885, 83546.58226708828, 86149.56925215333, 86996.0, 87683.56158219169, 44039.33940990888, 60988.39011609916, 74653.62673186707, 75677.9999999989, 76045.0, 6320.304766475592, 6347.619142851444, 6382.297947225894, 6422.839429014312, 6509.804705858832, 43384.0, 43731.78134109309, 44294.33558496561, 46349.30476042795, 46488.302675460574, 55488.445115548326, 66419.33580664132, 66646.66676666586, 67046.66476667585, 67576.32423675897, 9116.316276279438, 9505.811773528309, 9566.9043309566, 9753.756156096155, 9917.45454000008, 10117.797644047225, 10120.949395252977, 10252.794944100928, 10381.688549343531, 10532.89467105319, 9408.623655053721, 9643.614255429984, 9647.276454265817, 9656.71029869105, 9845.606175753177, 9772.657956971472, 9882.505874706092, 9932.0, 9960.352577082467, 10240.436775977392, 8586.31896005074, 8667.479951202948, 9103.635854565744, 9170.862437063315, 9373.578188981648, 8157.34741220689, 8397.916020839957, 8609.913900861162, 8844.955775221082, 8883.689070882747, 6853.417459515997, 7124.501284910007, 7308.085467102316, 7465.514741541782, 7676.232376762279], "value": 6164.460644725423, "unit": "score"}], "name": "dromaeo_css", "value": 6275.6754447079375, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 115.0, 117.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 126.0, 123.0, 190.0, 121.0, 124.0, 144.0, 126.0, 172.0, 123.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 162.0, 161.0, 160.0, 161.0, 161.0, 161.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 112.0, 76.0, 78.0, 75.0, 75.0, 108.0, 75.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 111.0, 84.0, 85.0, 86.0, 125.0, 84.0, 85.0, 131.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 149.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 66.0, 66.0, 64.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 68.0, 66.0, 65.0, 66.0, 66.0, 67.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 84.0, 82.0, 85.0, 79.0, 78.0, 80.0, 78.0, 84.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 136.0, 126.0, 126.0, 126.0, 128.0, 127.0, 214.0, 132.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 165.0, 164.0, 165.0, 164.0, 166.0, 163.0, 163.0, 165.0], "value": 164.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 67.0, 65.0, 69.0, 67.0, 66.0, 68.0, 64.0, 64.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1534.5, "alertThreshold": 2.0}]} 17:56:45 INFO - Return code: 0 17:56:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:56:45 INFO - # TBPL SUCCESS # 17:56:45 INFO - Running post-action listener: _resource_record_post_action 17:56:45 INFO - ##### 17:56:45 INFO - ##### Finished run-tests step (success) 17:56:45 INFO - ##### 17:56:45 INFO - Running post-run listener: _resource_record_post_run 17:56:45 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 12288; Write bytes: 548986880; Read time: 204; Write time: 477844 17:56:45 INFO - TinderboxPrint: CPU usage
13.0% 17:56:45 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 204 17:56:45 INFO - TinderboxPrint: I/O write bytes / time
548,986,880 / 477,844 17:56:45 INFO - TinderboxPrint: CPU idle
8,331.1 (87.0%) 17:56:45 INFO - TinderboxPrint: CPU user
1,203.6 (12.6%) 17:56:45 INFO - TinderboxPrint: Swap in / out
0 / 0 17:56:45 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 260886528; Read time: 0; Write time: 283484 17:56:45 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288100352; Read time: 192; Write time: 194360 17:56:45 INFO - Running post-run listener: _upload_blobber_files 17:56:45 INFO - Blob upload gear active. 17:56:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:56:45 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 17:56:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:56:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:56:46 INFO - (blobuploader) - INFO - Open directory for files ... 17:56:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:56:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:56:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:56:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:56:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:56:47 INFO - (blobuploader) - INFO - Done attempting. 17:56:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:56:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:56:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:56:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:56:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:56:50 INFO - (blobuploader) - INFO - Done attempting. 17:56:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:56:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:56:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:56:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:56:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:56:51 INFO - (blobuploader) - INFO - Done attempting. 17:56:51 INFO - (blobuploader) - INFO - Iteration through files over. 17:56:51 INFO - Return code: 0 17:56:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:56:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:56:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1374400f8334a4b421f7214bc8d88f30b6d771a2d0b5ce2d025b33bb5a69322ba0be2f2fc09520421b24888e0f4119900b7451c65bddd325d6edb6acb61814d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a35e230c907e012e08cc57459a478ad01a3969a088b3adcceb545dca8094df1f42311d135bfe105809e7ff4c309cfd29577a9e2bb33aac37d1ce15b5dfdd1d4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/87f53c320d54679eeb73290709df1e158f289205567f982deb50910744a298e6e69f69d7d7a526e8f45ac701452db2764c1d214d1a79f22c7a5074ce3336d319"} 17:56:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:56:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:56:51 INFO - Contents: 17:56:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1374400f8334a4b421f7214bc8d88f30b6d771a2d0b5ce2d025b33bb5a69322ba0be2f2fc09520421b24888e0f4119900b7451c65bddd325d6edb6acb61814d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a35e230c907e012e08cc57459a478ad01a3969a088b3adcceb545dca8094df1f42311d135bfe105809e7ff4c309cfd29577a9e2bb33aac37d1ce15b5dfdd1d4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/87f53c320d54679eeb73290709df1e158f289205567f982deb50910744a298e6e69f69d7d7a526e8f45ac701452db2764c1d214d1a79f22c7a5074ce3336d319"} 17:56:51 INFO - Running post-run listener: copy_logs_to_upload_dir 17:56:51 INFO - Copying logs to upload dir... 17:56:51 INFO - mkdir: /builds/slave/test/build/upload/logs 17:56:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.704458 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-15 17:56:50.949466) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 17:56:50.955158) ========= 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=4300f881736b422476174874000001bc-1468629081.631444-1854461590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1374400f8334a4b421f7214bc8d88f30b6d771a2d0b5ce2d025b33bb5a69322ba0be2f2fc09520421b24888e0f4119900b7451c65bddd325d6edb6acb61814d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a35e230c907e012e08cc57459a478ad01a3969a088b3adcceb545dca8094df1f42311d135bfe105809e7ff4c309cfd29577a9e2bb33aac37d1ce15b5dfdd1d4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/87f53c320d54679eeb73290709df1e158f289205567f982deb50910744a298e6e69f69d7d7a526e8f45ac701452db2764c1d214d1a79f22c7a5074ce3336d319"} build_url:https://queue.taskcluster.net/v1/task/f47mknD3SJS7O4IfsvuMSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://queue.taskcluster.net/v1/task/f47mknD3SJS7O4IfsvuMSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1374400f8334a4b421f7214bc8d88f30b6d771a2d0b5ce2d025b33bb5a69322ba0be2f2fc09520421b24888e0f4119900b7451c65bddd325d6edb6acb61814d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a35e230c907e012e08cc57459a478ad01a3969a088b3adcceb545dca8094df1f42311d135bfe105809e7ff4c309cfd29577a9e2bb33aac37d1ce15b5dfdd1d4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/87f53c320d54679eeb73290709df1e158f289205567f982deb50910744a298e6e69f69d7d7a526e8f45ac701452db2764c1d214d1a79f22c7a5074ce3336d319"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 17:56:50.980738) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 17:56:50.981074) ========= 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=4300f881736b422476174874000001bc-1468629081.631444-1854461590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 17:56:51.065697) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 17:56:51.066015) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 17:56:51.066317) ========= ========= Total master_lag: 0.18 =========