builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-024 starttime: 1468403657.97 results: success (0) buildid: 20160713022410 builduid: 9c8a6af159ab421085793dd6bcd1de76 revision: a76528042c032f558b3c2c55700de04e1c673745 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 02:54:17.966059) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 02:54:17.966730) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 02:54:17.967085) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 02:54:17.985377) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 02:54:17.985745) ========= 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=41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 02:54:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.5M=0s 2016-07-13 02:54:18 (88.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159008 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 02:54:18.170671) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 02:54:18.171005) ========= 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=41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018748 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 02:54:18.237759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 02:54:18.238390) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a76528042c032f558b3c2c55700de04e1c673745 --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 a76528042c032f558b3c2c55700de04e1c673745 --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=41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 02:54:18,336 truncating revision to first 12 chars 2016-07-13 02:54:18,336 Setting DEBUG logging. 2016-07-13 02:54:18,336 attempt 1/10 2016-07-13 02:54:18,336 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a76528042c03?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 02:54:18,639 unpacking tar archive at: fx-team-a76528042c03/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648319 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 02:54:18.906140) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 02:54:18.909512) ========= script_repo_revision: a76528042c032f558b3c2c55700de04e1c673745 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 02:54:18.909978) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 02:54:18.910329) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 02:54:18.921340) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-13 02:54:18.921676) ========= /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=41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:54:19 INFO - MultiFileLogger online at 20160713 02:54:19 in /builds/slave/test 02:54:19 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 02:54:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:54:19 INFO - {'append_to_log': False, 02:54:19 INFO - 'base_work_dir': '/builds/slave/test', 02:54:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:54:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:54:19 INFO - 'branch': 'Fx-Team-Non-PGO', 02:54:19 INFO - 'buildbot_json_path': 'buildprops.json', 02:54:19 INFO - 'config_files': ('talos/linux_config.py',), 02:54:19 INFO - 'default_actions': ('clobber', 02:54:19 INFO - 'read-buildbot-config', 02:54:19 INFO - 'download-and-extract', 02:54:19 INFO - 'populate-webroot', 02:54:19 INFO - 'create-virtualenv', 02:54:19 INFO - 'install', 02:54:19 INFO - 'run-tests'), 02:54:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:54:19 INFO - 'download_minidump_stackwalk': True, 02:54:19 INFO - 'download_symbols': 'ondemand', 02:54:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:54:19 INFO - 'tooltool.py': '/tools/tooltool.py', 02:54:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:54:19 INFO - '/tools/misc-python/virtualenv.py')}, 02:54:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:54:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:54:19 INFO - 'installer_path': 'installer.exe', 02:54:19 INFO - 'log_level': 'info', 02:54:19 INFO - 'log_name': 'talos', 02:54:19 INFO - 'log_to_console': True, 02:54:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:54:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:54:19 INFO - 'opt_config_files': (), 02:54:19 INFO - 'pip_index': False, 02:54:19 INFO - 'sps_profile': False, 02:54:19 INFO - 'sps_profile_interval': 0, 02:54:19 INFO - 'suite': 'dromaeojs', 02:54:19 INFO - 'system_bits': '32', 02:54:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:54:19 INFO - 'title': 'talos-linux64-ix-024', 02:54:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:54:19 INFO - 'use_talos_json': True, 02:54:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:54:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:54:19 INFO - 'work_dir': 'build'} 02:54:19 INFO - ##### 02:54:19 INFO - ##### Running clobber step. 02:54:19 INFO - ##### 02:54:19 INFO - Running pre-action listener: _resource_record_pre_action 02:54:19 INFO - Running main action method: clobber 02:54:19 INFO - rmtree: /builds/slave/test/build 02:54:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:54:19 INFO - Running post-action listener: _resource_record_post_action 02:54:19 INFO - ##### 02:54:19 INFO - ##### Finished clobber step (success) 02:54:19 INFO - ##### 02:54:19 INFO - ##### 02:54:19 INFO - ##### Running read-buildbot-config step. 02:54:19 INFO - ##### 02:54:19 INFO - Running pre-action listener: _resource_record_pre_action 02:54:19 INFO - Running main action method: read_buildbot_config 02:54:19 INFO - Using buildbot properties: 02:54:19 INFO - { 02:54:19 INFO - "project": "", 02:54:19 INFO - "product": "firefox", 02:54:19 INFO - "script_repo_revision": "production", 02:54:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:54:19 INFO - "repository": "", 02:54:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:54:19 INFO - "buildid": "20160713022410", 02:54:19 INFO - "pgo_build": "False", 02:54:19 INFO - "basedir": "/builds/slave/test", 02:54:19 INFO - "buildnumber": 1802, 02:54:19 INFO - "slavename": "talos-linux64-ix-024", 02:54:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:54:19 INFO - "platform": "ubuntu64_hw", 02:54:19 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:54:19 INFO - "branch": "fx-team", 02:54:19 INFO - "repo_path": "integration/fx-team", 02:54:19 INFO - "revision": "a76528042c032f558b3c2c55700de04e1c673745", 02:54:19 INFO - "stage_platform": "linux64", 02:54:19 INFO - "builduid": "9c8a6af159ab421085793dd6bcd1de76", 02:54:19 INFO - "slavebuilddir": "test" 02:54:19 INFO - } 02:54:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Duyqd9QKQ1eIOuunhgjfew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:54:19 INFO - Running post-action listener: _resource_record_post_action 02:54:19 INFO - ##### 02:54:19 INFO - ##### Finished read-buildbot-config step (success) 02:54:19 INFO - ##### 02:54:19 INFO - ##### 02:54:19 INFO - ##### Running download-and-extract step. 02:54:19 INFO - ##### 02:54:19 INFO - Running pre-action listener: _resource_record_pre_action 02:54:19 INFO - Running main action method: download_and_extract 02:54:19 INFO - mkdir: /builds/slave/test/build/tests 02:54: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')]} 02:54:19 INFO - https://queue.taskcluster.net/v1/task/Duyqd9QKQ1eIOuunhgjfew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:54:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Duyqd9QKQ1eIOuunhgjfew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:54:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Duyqd9QKQ1eIOuunhgjfew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:54:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Duyqd9QKQ1eIOuunhgjfew/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 02:54:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Duyqd9QKQ1eIOuunhgjfew/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 02:54:20 INFO - Downloaded 1361 bytes. 02:54:20 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:54:20 INFO - Using the following test package requirements: 02:54:20 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:54:20 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:54:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:54:20 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:54:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:54:20 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:54:20 INFO - u'jsshell-linux-x86_64.zip'], 02:54:20 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:54:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:54:20 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:54:20 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:54:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:54:20 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:54:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:54:20 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:54:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:54:20 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:54:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:54:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:54: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')]} 02:54:20 INFO - https://queue.taskcluster.net/v1/task/Duyqd9QKQ1eIOuunhgjfew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:54:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Duyqd9QKQ1eIOuunhgjfew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:54:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Duyqd9QKQ1eIOuunhgjfew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:54:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Duyqd9QKQ1eIOuunhgjfew/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 02:54:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Duyqd9QKQ1eIOuunhgjfew/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 02:54:21 INFO - Downloaded 22750981 bytes. 02:54:21 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'] 02:54:21 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 02:54:22 INFO - Return code: 0 02:54:22 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 02:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:22 INFO - https://queue.taskcluster.net/v1/task/Duyqd9QKQ1eIOuunhgjfew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:54:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Duyqd9QKQ1eIOuunhgjfew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:54:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Duyqd9QKQ1eIOuunhgjfew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:54:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Duyqd9QKQ1eIOuunhgjfew/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 02:54:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Duyqd9QKQ1eIOuunhgjfew/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 02:54:28 INFO - Downloaded 22750981 bytes. 02:54:28 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'] 02:54:28 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 02:54:30 INFO - Return code: 0 02:54:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:30 INFO - https://queue.taskcluster.net/v1/task/Duyqd9QKQ1eIOuunhgjfew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:54:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Duyqd9QKQ1eIOuunhgjfew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:54:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Duyqd9QKQ1eIOuunhgjfew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:54:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Duyqd9QKQ1eIOuunhgjfew/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 02:54:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Duyqd9QKQ1eIOuunhgjfew/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 02:54:31 INFO - Downloaded 14403317 bytes. 02:54:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:54:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:54:31 INFO - Return code: 0 02:54: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')]} 02:54:31 INFO - https://queue.taskcluster.net/v1/task/Duyqd9QKQ1eIOuunhgjfew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:54:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Duyqd9QKQ1eIOuunhgjfew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:54:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Duyqd9QKQ1eIOuunhgjfew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:54:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Duyqd9QKQ1eIOuunhgjfew/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 02:54:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Duyqd9QKQ1eIOuunhgjfew/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 02:54:33 INFO - Downloaded 56988420 bytes. 02:54:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Duyqd9QKQ1eIOuunhgjfew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:54:33 INFO - mkdir: /builds/slave/test/properties 02:54:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:54:33 INFO - Writing to file /builds/slave/test/properties/build_url 02:54:33 INFO - Contents: 02:54:33 INFO - build_url:https://queue.taskcluster.net/v1/task/Duyqd9QKQ1eIOuunhgjfew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:54:33 INFO - Running post-action listener: _resource_record_post_action 02:54:33 INFO - Running post-action listener: set_extra_try_arguments 02:54:33 INFO - ##### 02:54:33 INFO - ##### Finished download-and-extract step (success) 02:54:33 INFO - ##### 02:54:33 INFO - ##### 02:54:33 INFO - ##### Running populate-webroot step. 02:54:33 INFO - ##### 02:54:33 INFO - Running pre-action listener: _resource_record_pre_action 02:54:33 INFO - Running main action method: populate_webroot 02:54:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:54:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:54:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:54:34 INFO - '--tppagecycles', 02:54:34 INFO - '7'], 02:54:34 INFO - 'tests': ['tsvgm']}}, 02:54:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:54:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:54:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:54:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:54:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:54:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:54:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:34 INFO - 'talos_options': ['--disable-e10s'], 02:54:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:54:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:54:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:34 INFO - 'talos_options': ['--disable-e10s'], 02:54:34 INFO - 'tests': ['damp', 'tps']}, 02:54:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:34 INFO - 'tests': ['damp', 'tps']}, 02:54:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:54:34 INFO - 'tests': ['dromaeo_dom']}, 02:54:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:54:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:54:34 INFO - 'tests': ['basic_compositor_video']}, 02:54:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:54:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:54:34 INFO - 'tests': ['a11yr', 02:54:34 INFO - 'ts_paint', 02:54:34 INFO - 'tpaint', 02:54:34 INFO - 'sessionrestore', 02:54:34 INFO - 'sessionrestore_no_auto_restore', 02:54:34 INFO - 'tabpaint']}, 02:54:34 INFO - 'other-e10s': {'tests': ['a11yr', 02:54:34 INFO - 'ts_paint', 02:54:34 INFO - 'tpaint', 02:54:34 INFO - 'sessionrestore', 02:54:34 INFO - 'sessionrestore_no_auto_restore', 02:54:34 INFO - 'tabpaint']}, 02:54:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:54:34 INFO - 'ts_paint', 02:54:34 INFO - 'tpaint', 02:54:34 INFO - 'sessionrestore', 02:54:34 INFO - 'sessionrestore_no_auto_restore', 02:54:34 INFO - 'tabpaint']}, 02:54:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:54:34 INFO - 'ts_paint', 02:54:34 INFO - 'tpaint', 02:54:34 INFO - 'sessionrestore', 02:54:34 INFO - 'sessionrestore_no_auto_restore', 02:54:34 INFO - 'tabpaint']}, 02:54:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:54:34 INFO - 'tests': ['a11yr', 02:54:34 INFO - 'ts_paint', 02:54:34 INFO - 'tpaint', 02:54:34 INFO - 'sessionrestore', 02:54:34 INFO - 'sessionrestore_no_auto_restore', 02:54:34 INFO - 'tabpaint']}, 02:54:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:54:34 INFO - 'tests': ['a11yr', 02:54:34 INFO - 'ts_paint', 02:54:34 INFO - 'tpaint', 02:54:34 INFO - 'sessionrestore', 02:54:34 INFO - 'sessionrestore_no_auto_restore', 02:54:34 INFO - 'tabpaint']}, 02:54:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:54:34 INFO - 'tests': ['tsvgx', 02:54:34 INFO - 'tsvgr_opacity', 02:54:34 INFO - 'tart', 02:54:34 INFO - 'tscrollx', 02:54:34 INFO - 'cart']}, 02:54:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:54:34 INFO - 'tsvgr_opacity', 02:54:34 INFO - 'tart', 02:54:34 INFO - 'tscrollx', 02:54:34 INFO - 'cart']}, 02:54:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:34 INFO - 'talos_options': ['--disable-e10s'], 02:54:34 INFO - 'tests': ['tp5o']}, 02:54:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:34 INFO - 'tests': ['tp5o']}, 02:54:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:34 INFO - 'talos_options': ['--disable-e10s', 02:54:34 INFO - '--xperf_path', 02:54:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:54:34 INFO - 'tests': ['tp5n']}, 02:54:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:34 INFO - 'talos_options': ['--xperf_path', 02:54:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:54:34 INFO - 'tests': ['tp5n']}}, 02:54:34 INFO - 'talos.zip': {'path': '', 02:54:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:54:34 INFO - Running post-action listener: _resource_record_post_action 02:54:34 INFO - ##### 02:54:34 INFO - ##### Finished populate-webroot step (success) 02:54:34 INFO - ##### 02:54:34 INFO - ##### 02:54:34 INFO - ##### Running create-virtualenv step. 02:54:34 INFO - ##### 02:54:34 INFO - Running pre-action listener: _resource_record_pre_action 02:54:34 INFO - Running main action method: create_virtualenv 02:54:34 INFO - Creating virtualenv /builds/slave/test/build/venv 02:54:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:54:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:54:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:54:34 INFO - Using real prefix '/usr' 02:54:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:54:34 INFO - Installing distribute.............................................................................................................................................................................................done. 02:54:36 INFO - Installing pip.................done. 02:54:36 INFO - Return code: 0 02:54:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb3b0>, '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 0x24bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bc740>, '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': '41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068', '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 02:54:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:54:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:54:36 INFO - Using env: {'DISPLAY': ':0', 02:54:36 INFO - 'HOME': '/home/cltbld', 02:54:36 INFO - 'LANG': 'en_US.UTF-8', 02:54:36 INFO - 'LANGUAGE': 'en_US:en', 02:54:36 INFO - 'LOGNAME': 'cltbld', 02:54:36 INFO - 'MAIL': '/var/mail/cltbld', 02:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:36 INFO - 'MOZ_NO_REMOTE': '1', 02:54:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:36 INFO - 'NO_EM_RESTART': '1', 02:54:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:36 INFO - 'PWD': '/builds/slave/test', 02:54:36 INFO - 'SHELL': '/bin/bash', 02:54:36 INFO - 'SHLVL': '1', 02:54:36 INFO - 'TERM': 'linux', 02:54:36 INFO - 'TMOUT': '86400', 02:54:36 INFO - 'USER': 'cltbld', 02:54:36 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068', 02:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:36 INFO - '_': '/tools/buildbot/bin/python'} 02:54:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:36 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 02:54:36 INFO - Cleaning up... 02:54:36 INFO - Return code: 0 02:54:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb3b0>, '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 0x24bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bc740>, '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': '41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068', '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 02:54:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:54:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:54:36 INFO - Using env: {'DISPLAY': ':0', 02:54:36 INFO - 'HOME': '/home/cltbld', 02:54:36 INFO - 'LANG': 'en_US.UTF-8', 02:54:36 INFO - 'LANGUAGE': 'en_US:en', 02:54:36 INFO - 'LOGNAME': 'cltbld', 02:54:36 INFO - 'MAIL': '/var/mail/cltbld', 02:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:36 INFO - 'MOZ_NO_REMOTE': '1', 02:54:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:36 INFO - 'NO_EM_RESTART': '1', 02:54:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:36 INFO - 'PWD': '/builds/slave/test', 02:54:36 INFO - 'SHELL': '/bin/bash', 02:54:36 INFO - 'SHLVL': '1', 02:54:36 INFO - 'TERM': 'linux', 02:54:36 INFO - 'TMOUT': '86400', 02:54:36 INFO - 'USER': 'cltbld', 02:54:36 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068', 02:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:36 INFO - '_': '/tools/buildbot/bin/python'} 02:54:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:37 INFO - Downloading/unpacking psutil>=3.1.1 02:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:54:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:54:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:54:39 INFO - Installing collected packages: psutil 02:54:39 INFO - Running setup.py install for psutil 02:54:39 INFO - building 'psutil._psutil_linux' extension 02:54:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:54:39 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 02:54:39 INFO - building 'psutil._psutil_posix' extension 02:54:39 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 02:54:39 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 02:54:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:54:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:54:39 INFO - Successfully installed psutil 02:54:39 INFO - Cleaning up... 02:54:39 INFO - Return code: 0 02:54:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb3b0>, '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 0x24bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bc740>, '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': '41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068', '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 02:54:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:54:39 INFO - Using env: {'DISPLAY': ':0', 02:54:39 INFO - 'HOME': '/home/cltbld', 02:54:39 INFO - 'LANG': 'en_US.UTF-8', 02:54:39 INFO - 'LANGUAGE': 'en_US:en', 02:54:39 INFO - 'LOGNAME': 'cltbld', 02:54:39 INFO - 'MAIL': '/var/mail/cltbld', 02:54:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:39 INFO - 'MOZ_NO_REMOTE': '1', 02:54:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:39 INFO - 'NO_EM_RESTART': '1', 02:54:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:39 INFO - 'PWD': '/builds/slave/test', 02:54:39 INFO - 'SHELL': '/bin/bash', 02:54:39 INFO - 'SHLVL': '1', 02:54:39 INFO - 'TERM': 'linux', 02:54:39 INFO - 'TMOUT': '86400', 02:54:39 INFO - 'USER': 'cltbld', 02:54:39 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068', 02:54:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:39 INFO - '_': '/tools/buildbot/bin/python'} 02:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:54:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:54:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:54:41 INFO - Installing collected packages: mozsystemmonitor 02:54:41 INFO - Running setup.py install for mozsystemmonitor 02:54:41 INFO - Successfully installed mozsystemmonitor 02:54:41 INFO - Cleaning up... 02:54:41 INFO - Return code: 0 02:54:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:54:41 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')]} 02:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:41 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')]} 02:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:41 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 0x21fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb3b0>, '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 0x24bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bc740>, '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': '41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068', '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 02:54:41 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 02:54:41 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 02:54:41 INFO - Using env: {'DISPLAY': ':0', 02:54:41 INFO - 'HOME': '/home/cltbld', 02:54:41 INFO - 'LANG': 'en_US.UTF-8', 02:54:41 INFO - 'LANGUAGE': 'en_US:en', 02:54:41 INFO - 'LOGNAME': 'cltbld', 02:54:41 INFO - 'MAIL': '/var/mail/cltbld', 02:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:41 INFO - 'MOZ_NO_REMOTE': '1', 02:54:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:41 INFO - 'NO_EM_RESTART': '1', 02:54:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:41 INFO - 'PWD': '/builds/slave/test', 02:54:41 INFO - 'SHELL': '/bin/bash', 02:54:41 INFO - 'SHLVL': '1', 02:54:41 INFO - 'TERM': 'linux', 02:54:41 INFO - 'TMOUT': '86400', 02:54:41 INFO - 'USER': 'cltbld', 02:54:41 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068', 02:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:41 INFO - '_': '/tools/buildbot/bin/python'} 02:54:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:42 INFO - Downloading/unpacking jsonschema==2.5.1 02:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:54:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:44 INFO - Downloading functools32-3.2.3-2.tar.gz 02:54:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:54:44 INFO - warning: no files found matching '*.txt' 02:54:44 INFO - no previously-included directories found matching 'build' 02:54:44 INFO - no previously-included directories found matching 'dist' 02:54:44 INFO - no previously-included directories found matching '.git*' 02:54:44 INFO - Installing collected packages: jsonschema, functools32 02:54:44 INFO - Running setup.py install for functools32 02:54:44 INFO - warning: no files found matching '*.txt' 02:54:44 INFO - no previously-included directories found matching 'build' 02:54:44 INFO - no previously-included directories found matching 'dist' 02:54:44 INFO - no previously-included directories found matching '.git*' 02:54:44 INFO - Successfully installed jsonschema functools32 02:54:44 INFO - Cleaning up... 02:54:44 INFO - Return code: 0 02:54:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:54: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')]} 02:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54: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')]} 02:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54: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', '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 0x21fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb3b0>, '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 0x24bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bc740>, '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': '41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068', '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 02:54: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:54: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 blobuploader==1.2.4 02:54:44 INFO - Using env: {'DISPLAY': ':0', 02:54:44 INFO - 'HOME': '/home/cltbld', 02:54:44 INFO - 'LANG': 'en_US.UTF-8', 02:54:44 INFO - 'LANGUAGE': 'en_US:en', 02:54:44 INFO - 'LOGNAME': 'cltbld', 02:54:44 INFO - 'MAIL': '/var/mail/cltbld', 02:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:44 INFO - 'MOZ_NO_REMOTE': '1', 02:54:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:44 INFO - 'NO_EM_RESTART': '1', 02:54:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:44 INFO - 'PWD': '/builds/slave/test', 02:54:44 INFO - 'SHELL': '/bin/bash', 02:54:44 INFO - 'SHLVL': '1', 02:54:44 INFO - 'TERM': 'linux', 02:54:44 INFO - 'TMOUT': '86400', 02:54:44 INFO - 'USER': 'cltbld', 02:54:44 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068', 02:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:44 INFO - '_': '/tools/buildbot/bin/python'} 02:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:44 INFO - Downloading/unpacking blobuploader==1.2.4 02:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:46 INFO - Downloading blobuploader-1.2.4.tar.gz 02:54:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:54:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:54:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:54:47 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 02:54:47 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 02:54:47 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 02:54:47 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 02:54:47 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 02:54:47 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 02:54:47 INFO - Downloading docopt-0.6.1.tar.gz 02:54:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:54:47 INFO - Installing collected packages: blobuploader, requests, docopt 02:54:47 INFO - Running setup.py install for blobuploader 02:54:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:54:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:54:47 INFO - Running setup.py install for requests 02:54:47 INFO - Running setup.py install for docopt 02:54:47 INFO - Successfully installed blobuploader requests docopt 02:54:47 INFO - Cleaning up... 02:54:47 INFO - Return code: 0 02:54:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:54:47 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')]} 02:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:47 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')]} 02:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:47 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 0x21fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb3b0>, '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 0x24bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bc740>, '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': '41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068', '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 02:54:47 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 02:54:47 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 02:54:47 INFO - Using env: {'DISPLAY': ':0', 02:54:47 INFO - 'HOME': '/home/cltbld', 02:54:47 INFO - 'LANG': 'en_US.UTF-8', 02:54:47 INFO - 'LANGUAGE': 'en_US:en', 02:54:47 INFO - 'LOGNAME': 'cltbld', 02:54:47 INFO - 'MAIL': '/var/mail/cltbld', 02:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:47 INFO - 'MOZ_NO_REMOTE': '1', 02:54:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:47 INFO - 'NO_EM_RESTART': '1', 02:54:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:47 INFO - 'PWD': '/builds/slave/test', 02:54:47 INFO - 'SHELL': '/bin/bash', 02:54:47 INFO - 'SHLVL': '1', 02:54:47 INFO - 'TERM': 'linux', 02:54:47 INFO - 'TMOUT': '86400', 02:54:47 INFO - 'USER': 'cltbld', 02:54:47 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068', 02:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:47 INFO - '_': '/tools/buildbot/bin/python'} 02:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:54:48 INFO - Running setup.py (path:/tmp/pip-v6_kW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:54:48 INFO - Running setup.py (path:/tmp/pip-IXfPRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:54:48 INFO - Running setup.py (path:/tmp/pip-X0js5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:54:48 INFO - Running setup.py (path:/tmp/pip-Q8PQQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:54:48 INFO - Running setup.py (path:/tmp/pip-rfjpvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:54:48 INFO - Running setup.py (path:/tmp/pip-apF9Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:54:48 INFO - Running setup.py (path:/tmp/pip-zeMs8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:54:48 INFO - Running setup.py (path:/tmp/pip-DHgeSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:54:48 INFO - Running setup.py (path:/tmp/pip-C5ouFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:54:48 INFO - Running setup.py (path:/tmp/pip-hwcrZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:54:48 INFO - Running setup.py (path:/tmp/pip-XvrgXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:54:48 INFO - Running setup.py (path:/tmp/pip-SWpdx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:54:49 INFO - Running setup.py (path:/tmp/pip-LMhIsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:54:49 INFO - Running setup.py (path:/tmp/pip-UQkvnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:54:49 INFO - Running setup.py (path:/tmp/pip-zNtxLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:54:49 INFO - Running setup.py (path:/tmp/pip-mjpqA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:54:49 INFO - Running setup.py (path:/tmp/pip-wIE999-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:54:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:54:49 INFO - Running setup.py install for manifestparser 02:54:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:54:49 INFO - Running setup.py install for mozcrash 02:54:49 INFO - Running setup.py install for mozdebug 02:54:49 INFO - Running setup.py install for mozdevice 02:54:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:54:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:54:49 INFO - Running setup.py install for mozfile 02:54:49 INFO - Running setup.py install for mozhttpd 02:54:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:54:50 INFO - Running setup.py install for mozinfo 02:54:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:54:50 INFO - Running setup.py install for mozInstall 02:54:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:54:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:54:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:54:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:54:50 INFO - Running setup.py install for mozleak 02:54:50 INFO - Running setup.py install for mozlog 02:54:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:54:50 INFO - Running setup.py install for moznetwork 02:54:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:54:50 INFO - Running setup.py install for mozprocess 02:54:50 INFO - Running setup.py install for mozprofile 02:54:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:54:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:54:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:54:50 INFO - Running setup.py install for mozrunner 02:54:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:54:50 INFO - Running setup.py install for mozscreenshot 02:54:50 INFO - Running setup.py install for moztest 02:54:51 INFO - Running setup.py install for mozversion 02:54:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:54:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:54:51 INFO - Cleaning up... 02:54:51 INFO - Return code: 0 02:54:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:51 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 0x21fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb3b0>, '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 0x24bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bc740>, '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': '41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068', '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 02:54:51 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 02:54:51 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 02:54:51 INFO - Using env: {'DISPLAY': ':0', 02:54:51 INFO - 'HOME': '/home/cltbld', 02:54:51 INFO - 'LANG': 'en_US.UTF-8', 02:54:51 INFO - 'LANGUAGE': 'en_US:en', 02:54:51 INFO - 'LOGNAME': 'cltbld', 02:54:51 INFO - 'MAIL': '/var/mail/cltbld', 02:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:51 INFO - 'MOZ_NO_REMOTE': '1', 02:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:51 INFO - 'NO_EM_RESTART': '1', 02:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:51 INFO - 'PWD': '/builds/slave/test', 02:54:51 INFO - 'SHELL': '/bin/bash', 02:54:51 INFO - 'SHLVL': '1', 02:54:51 INFO - 'TERM': 'linux', 02:54:51 INFO - 'TMOUT': '86400', 02:54:51 INFO - 'USER': 'cltbld', 02:54:51 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068', 02:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:51 INFO - '_': '/tools/buildbot/bin/python'} 02:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:54:51 INFO - Running setup.py (path:/tmp/pip-h4qnYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:54:51 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)) 02:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:54:51 INFO - Running setup.py (path:/tmp/pip-kGMfDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:54:51 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)) 02:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:54:51 INFO - Running setup.py (path:/tmp/pip-VoESOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:54:51 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)) 02:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:54:51 INFO - Running setup.py (path:/tmp/pip-xc_Ub8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:54:51 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)) 02:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:54:51 INFO - Running setup.py (path:/tmp/pip-wJreno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:54:51 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)) 02:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:54:51 INFO - Running setup.py (path:/tmp/pip-aINvtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:54:51 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)) 02:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:54:51 INFO - Running setup.py (path:/tmp/pip-mDxAFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:54:51 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)) 02:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:54:51 INFO - Running setup.py (path:/tmp/pip-ZdPmmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:54:51 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)) 02:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:54:51 INFO - Running setup.py (path:/tmp/pip-JSCDbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:54:52 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)) 02:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:54:52 INFO - Running setup.py (path:/tmp/pip-oA4fJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:54:52 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)) 02:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:54:52 INFO - Running setup.py (path:/tmp/pip-btBYST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:54:52 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)) 02:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:54:52 INFO - Running setup.py (path:/tmp/pip-922ouw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:54:52 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)) 02:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:54:52 INFO - Running setup.py (path:/tmp/pip-Ti_OGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:54:52 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)) 02:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:54:52 INFO - Running setup.py (path:/tmp/pip-Y0TOgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:54:52 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)) 02:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:54:52 INFO - Running setup.py (path:/tmp/pip-iqwgyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:54:52 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)) 02:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:54:52 INFO - Running setup.py (path:/tmp/pip-hvJ9oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:54:52 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)) 02:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:54:52 INFO - Running setup.py (path:/tmp/pip-0BZu1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:54:52 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)) 02:54:52 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)) 02:54:52 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)) 02:54:52 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)) 02:54:52 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)) 02:54:52 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)) 02:54:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:54:52 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 02:54:52 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 02:54:52 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 02:54:52 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 02:54:52 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 02:54:52 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 02:54:54 INFO - Downloading blessings-1.6.tar.gz 02:54:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:54:54 INFO - Installing collected packages: blessings 02:54:54 INFO - Running setup.py install for blessings 02:54:54 INFO - Successfully installed blessings 02:54:54 INFO - Cleaning up... 02:54:54 INFO - Return code: 0 02:54:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:54:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:54:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:54:55 INFO - Reading from file tmpfile_stdout 02:54:55 INFO - Current package versions: 02:54:55 INFO - argparse == 1.2.1 02:54:55 INFO - blessings == 1.6 02:54:55 INFO - blobuploader == 1.2.4 02:54:55 INFO - docopt == 0.6.1 02:54:55 INFO - functools32 == 3.2.3-2 02:54:55 INFO - jsonschema == 2.5.1 02:54:55 INFO - manifestparser == 1.1 02:54:55 INFO - mozInstall == 1.12 02:54:55 INFO - mozcrash == 0.17 02:54:55 INFO - mozdebug == 0.1 02:54:55 INFO - mozdevice == 0.48 02:54:55 INFO - mozfile == 1.2 02:54:55 INFO - mozhttpd == 0.7 02:54:55 INFO - mozinfo == 0.9 02:54:55 INFO - mozleak == 0.1 02:54:55 INFO - mozlog == 3.2 02:54:55 INFO - moznetwork == 0.27 02:54:55 INFO - mozprocess == 0.23 02:54:55 INFO - mozprofile == 0.28 02:54:55 INFO - mozrunner == 6.12 02:54:55 INFO - mozscreenshot == 0.1 02:54:55 INFO - mozsystemmonitor == 0.3 02:54:55 INFO - moztest == 0.7 02:54:55 INFO - mozversion == 1.4 02:54:55 INFO - psutil == 3.1.1 02:54:55 INFO - requests == 1.2.3 02:54:55 INFO - wsgiref == 0.1.2 02:54:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:54:55 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')]} 02:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:55 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')]} 02:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:55 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 0x21fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb3b0>, '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 0x24bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bc740>, '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': '41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068', '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 02:54:55 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 02:54:55 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 02:54:55 INFO - Using env: {'DISPLAY': ':0', 02:54:55 INFO - 'HOME': '/home/cltbld', 02:54:55 INFO - 'LANG': 'en_US.UTF-8', 02:54:55 INFO - 'LANGUAGE': 'en_US:en', 02:54:55 INFO - 'LOGNAME': 'cltbld', 02:54:55 INFO - 'MAIL': '/var/mail/cltbld', 02:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:55 INFO - 'MOZ_NO_REMOTE': '1', 02:54:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:55 INFO - 'NO_EM_RESTART': '1', 02:54:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:55 INFO - 'PWD': '/builds/slave/test', 02:54:55 INFO - 'SHELL': '/bin/bash', 02:54:55 INFO - 'SHLVL': '1', 02:54:55 INFO - 'TERM': 'linux', 02:54:55 INFO - 'TMOUT': '86400', 02:54:55 INFO - 'USER': 'cltbld', 02:54:55 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068', 02:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:55 INFO - '_': '/tools/buildbot/bin/python'} 02:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:55 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)) 02:54:55 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)) 02:54:55 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)) 02:54:55 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)) 02:54:55 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)) 02:54:55 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)) 02:54:55 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)) 02:54:55 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)) 02:54:55 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)) 02:54:55 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)) 02:54:55 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)) 02:54:55 INFO - Cleaning up... 02:54:55 INFO - Return code: 0 02:54:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:54:55 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')]} 02:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:55 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')]} 02:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:55 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 0x21fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb3b0>, '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 0x24bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bc740>, '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': '41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068', '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 02:54:55 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 02:54:55 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 02:54:55 INFO - Using env: {'DISPLAY': ':0', 02:54:55 INFO - 'HOME': '/home/cltbld', 02:54:55 INFO - 'LANG': 'en_US.UTF-8', 02:54:55 INFO - 'LANGUAGE': 'en_US:en', 02:54:55 INFO - 'LOGNAME': 'cltbld', 02:54:55 INFO - 'MAIL': '/var/mail/cltbld', 02:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:55 INFO - 'MOZ_NO_REMOTE': '1', 02:54:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:55 INFO - 'NO_EM_RESTART': '1', 02:54:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:55 INFO - 'PWD': '/builds/slave/test', 02:54:55 INFO - 'SHELL': '/bin/bash', 02:54:55 INFO - 'SHLVL': '1', 02:54:55 INFO - 'TERM': 'linux', 02:54:55 INFO - 'TMOUT': '86400', 02:54:55 INFO - 'USER': 'cltbld', 02:54:55 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068', 02:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:55 INFO - '_': '/tools/buildbot/bin/python'} 02:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:54:55 INFO - Cleaning up... 02:54:55 INFO - Return code: 0 02:54:55 INFO - Running post-action listener: _resource_record_post_action 02:54:55 INFO - Running post-action listener: _start_resource_monitoring 02:54:55 INFO - Starting resource monitoring. 02:54:55 INFO - ##### 02:54:55 INFO - ##### Finished create-virtualenv step (success) 02:54:55 INFO - ##### 02:54:55 INFO - ##### 02:54:55 INFO - ##### Running install step. 02:54:55 INFO - ##### 02:54:55 INFO - Running pre-action listener: _resource_record_pre_action 02:54:55 INFO - Running main action method: install 02:54:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:54:55 INFO - Reading from file tmpfile_stdout 02:54:55 INFO - Detecting whether we're running mozinstall >=1.0... 02:54:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:54:55 INFO - Reading from file tmpfile_stdout 02:54:55 INFO - Output received: 02:54:55 INFO - Usage: mozinstall [options] installer 02:54:55 INFO - Options: 02:54:55 INFO - -h, --help show this help message and exit 02:54:55 INFO - -d DEST, --destination=DEST 02:54:55 INFO - Directory to install application into. [default: 02:54:55 INFO - "/builds/slave/test"] 02:54:55 INFO - --app=APP Application being installed. [default: firefox] 02:54:55 INFO - mkdir: /builds/slave/test/build/application 02:54:55 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'] 02:54:55 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 02:55:12 INFO - Reading from file tmpfile_stdout 02:55:12 INFO - Output received: 02:55:12 INFO - /builds/slave/test/build/application/firefox/firefox 02:55:12 INFO - Running post-action listener: _resource_record_post_action 02:55:12 INFO - ##### 02:55:12 INFO - ##### Finished install step (success) 02:55:12 INFO - ##### 02:55:12 INFO - ##### 02:55:12 INFO - ##### Running run-tests step. 02:55:12 INFO - ##### 02:55:12 INFO - Running pre-action listener: _resource_record_pre_action 02:55:12 INFO - Running main action method: run_tests 02:55:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:55:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:55:12 INFO - Python 2.7.3 02:55:12 INFO - Return code: 0 02:55:12 INFO - grabbing minidump binary from tooltool 02:55:12 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')]} 02:55:12 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 0x24bb3b0>, '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 0x24bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bc740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:55:12 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 02:55:12 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 02:55:12 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 02:55:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:55:12 INFO - Return code: 0 02:55:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:55:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:55:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:55:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:55:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:55:12 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/Duyqd9QKQ1eIOuunhgjfew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 02:55:12 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/Duyqd9QKQ1eIOuunhgjfew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 02:55:12 INFO - Using env: {'DISPLAY': ':0', 02:55:12 INFO - 'HOME': '/home/cltbld', 02:55:12 INFO - 'LANG': 'en_US.UTF-8', 02:55:12 INFO - 'LANGUAGE': 'en_US:en', 02:55:12 INFO - 'LOGNAME': 'cltbld', 02:55:12 INFO - 'MAIL': '/var/mail/cltbld', 02:55:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:55:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:12 INFO - 'MOZ_NO_REMOTE': '1', 02:55:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:55:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:55:12 INFO - 'NO_EM_RESTART': '1', 02:55:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:12 INFO - 'PWD': '/builds/slave/test', 02:55:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:55:12 INFO - 'SHELL': '/bin/bash', 02:55:12 INFO - 'SHLVL': '1', 02:55:12 INFO - 'TERM': 'linux', 02:55:12 INFO - 'TMOUT': '86400', 02:55:12 INFO - 'USER': 'cltbld', 02:55:12 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068', 02:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:12 INFO - '_': '/tools/buildbot/bin/python'} 02:55:12 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/Duyqd9QKQ1eIOuunhgjfew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 02:55:12 INFO - mozversion application_buildid: 20160713022410 02:55:12 INFO - mozversion application_changeset: a76528042c032f558b3c2c55700de04e1c673745 02:55:12 INFO - mozversion application_display_name: Nightly 02:55:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:55:12 INFO - mozversion application_name: Firefox 02:55:12 INFO - mozversion application_remotingname: firefox 02:55:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:55:12 INFO - mozversion application_vendor: Mozilla 02:55:12 INFO - mozversion application_version: 50.0a1 02:55:12 INFO - mozversion platform_buildid: 20160713022410 02:55:12 INFO - mozversion platform_changeset: a76528042c032f558b3c2c55700de04e1c673745 02:55:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:55:12 INFO - mozversion platform_version: 50.0a1 02:55:12 INFO - using testdate: 1468403712 02:55:12 INFO - actual date: 1468403712 02:55:12 INFO - starting webserver on 'localhost:43858' 02:55:12 INFO - SUITE-START | Running 2 tests 02:55:12 INFO - TEST-START | dromaeo_css 02:55:12 INFO - operating with platform_type : linux_ 02:55:12 INFO - Initialising browser for dromaeo_css test... 02:55:12 INFO - TEST-INFO | started process 11011 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp48e84e/profile http://localhost:43858/getInfo.html) 02:55:16 INFO - PROCESS | 11011 | __metrics Screen width/height:1600/1200 02:55:16 INFO - PROCESS | 11011 | colorDepth:24 02:55:16 INFO - PROCESS | 11011 | Browser inner width/height: 1024/697 02:55:16 INFO - PROCESS | 11011 | __metrics 02:55:17 INFO - PROCESS | 11011 | 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" 02:55:17 INFO - PROCESS | 11011 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:55:18 INFO - TEST-INFO | 11011: exit 0 02:55:18 INFO - Browser initialized. 02:55:18 INFO - Running cycle 1/1 for dromaeo_css test... 02:55:18 INFO - TEST-INFO | started process 11092 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp48e84e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:55:30 INFO - PROCESS | 11092 | RSS: Main: 159117312 02:55:30 INFO - PROCESS | 11092 | 02:56:22 INFO - PROCESS | 11092 | 1468403782718 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] 02:58:34 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:43858/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43858/tests/dromaeo/cssquery-ext.html) 02:58:35 INFO - PROCESS | 11092 | RSS: Main: 258318336 02:58:35 INFO - PROCESS | 11092 | 03:01:38 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:43858/tests/dromaeo/cssquery-ext.html (next: http://localhost:43858/tests/dromaeo/cssquery-jquery.html) 03:01:39 INFO - PROCESS | 11092 | RSS: Main: 239517696 03:01:39 INFO - PROCESS | 11092 | 03:04:41 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:43858/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43858/tests/dromaeo/cssquery-mootools.html) 03:04:42 INFO - PROCESS | 11092 | RSS: Main: 245600256 03:04:42 INFO - PROCESS | 11092 | 03:07:44 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:43858/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43858/tests/dromaeo/cssquery-prototype.html) 03:07:44 INFO - PROCESS | 11092 | RSS: Main: 246067200 03:07:44 INFO - PROCESS | 11092 | 03:10:47 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:43858/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43858/tests/dromaeo/cssquery-yui.html) 03:10:48 INFO - PROCESS | 11092 | RSS: Main: 223666176 03:10:48 INFO - PROCESS | 11092 | 03:13:51 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:43858/tests/dromaeo/cssquery-yui.html (next: http://localhost:43858/tests/dromaeo/cssquery-dojo.html) 03:13:51 INFO - PROCESS | 11092 | RSS: Main: 303747072 03:13:51 INFO - PROCESS | 11092 | 03:13:51 INFO - PROCESS | 11092 | __start_tp_report 03:13:51 INFO - PROCESS | 11092 | _x_x_mozilla_page_load 03:13:51 INFO - PROCESS | 11092 | _x_x_mozilla_page_load_details 03:13:51 INFO - PROCESS | 11092 | |i|pagename|runs| 03:13:51 INFO - PROCESS | 11092 | |0;dojo.html;2642.656454660896;2653.5488966875632;2679.129282983031;2688.005437987945;2700.1899430170943;4560.97719511402;4684.554967278112;4711.363965864612;4758.214894542396;4818.51814818518;4627.953720462794;4645.279981602857;4662.230731929228;4678.602318802898;4702.200625893598;4255.085156691311;4315.805788739514;4348.956510434903;4376.387305777193;4476.7090139140855;4421.469423669164;4446.199684056868;4456.153330867125;4482.5069242383315;4501.887452813673;4208.179405016023;4249.936250956238;4259.10558782656;4273.572642735701;4385.057212699285;4243.87268381946;4253.1706317268145;4258.382534532507;4303.419038429804;4338.544452832471;4281.593248641374;4281.678874084425;4295.484541854966;4331.870043898656;4336.783160841946;4598.517155698671;4658.161530924433;4717.150912835688;4747.548982846624;4748.3589715388325;5029.170186919154;5110.361204849394;5124.231365295198;5124.5131712487255;5131.640785145041;5117.872053198663;5132.281480592683;5132.84601461953;5140.820071297487;5141.948580514184;4577;4678.251479763221;4751.287306903992;4779.952200477951;4784.952150478451;5135;5155.304033955443;5159.329287192641;5205.7397130143345;5208.609354298443;4946.777395017233;4947.554720075139;4971.353724015855;4992.276119962585;4996.775145118479;4861.295112208781;4962.429320628174;4995.850124496271;5023.874403139951;5024.045431368028;4970.403551573834;4985.725785081855;4995;5008.5993120550265;5050.318207042076;4959.82640607577;4974.278729584263;4976.780688731284;4983.576396006308;5030.496950304941;4218.029853133797;4259.297215959394;4259.467566554181;4261.74429534229;4262.616364527207;3718.9442158367647;3759.49246851677;3772.2644084403278;3822.7324087313623;3862.1696335288048;4350.129974005212;4357.934630980474;4367.30123180296;4393.077453734688;4403.207422663887;4850.1269771440775;5066.290719299301;5069.771860266297;5072.289879416885;5112.284280200774;4228.513720922133;4272.530021697611;4301.118270754488;4308.719933204395;4340.370646256339;4559.726416414959;4563.904662880885;4567.885802854955;4575.199340115467;4614.953850461519;4696.037312350892;4789.209780386267;4805.879853003563;4809.134355815847;4811.639127065484;4971.154903666457;4988.775505102207;5009.774560144875;5013.273075404119;5082.390113186293;4782.95217047839;4786.425628924551;4796.184648609815;4797.832075877328;4845.1278769820365;4825.420949486084;4977.626677999092;4977.701337919736;4979.203327467588;5022;4939.876503087452;4965.776540055634;5042.193249080129;5061.670991385548;5095.388553373619;4942.233953737176;4945.901081978413;4947.134251506044;4947.431045429822;4998.375203099613;4706.9529304707885;4940.209566469348;4940.407151141886;4952.232403977389;4997.400311962588;4709.105269998689;4738.50245724194;4744.027474367677;4786.760661966818;4823.758812059313;4868.561829435368;4884.340614017062;4885.755712214446;4894.412670479565;4939.53074457926;4661.230896901973;4776.044791041875;4783.425988881357;4795.376601041842;4797.376341075638 03:13:51 INFO - PROCESS | 11092 | |1;ext.html;561.446974729891;563.1608902734927;565.0507147991378;575.3785911215887;579.1341943794027;39976.80011599942;41406.792966035166;41486.962825929404;45133.323000155026;45332.77333613335;42738.35892461608;43137.568624313746;43209.13581728363;43289.56710432895;43290.783546082304;7491.513051651653;7864.567448790329;8011.879821802678;8019.639116239783;10054.798904021914;9957.601695932153;10327.535260913277;10355.792884142313;10364.378137311747;10365.481725913713;10405.635802746905;10464.790704185913;10474.057334839863;10482.737931551696;10487.056164945154;7601.239876012382;10017.549210285555;10295.588176472933;10305.896941030569;10331.27681062326;10191.235657325657;10281.228907831868;10287;10300.381977081399;10300.948495257551;39998.200035999114;40241.19517609631;40366.19267614661;40380.798096009625;40404.59595404038;2424.5029768897334;2879.5968564401;3127.5934128563367;3367.4275373186615;3481.268933523963;30008.399832003237;30328.848355758302;30413.23966900823;30602;31415;3563.8396272167815;3573.5711714594154;3574.5889222739197;3627.528421305213;3680.0799800049986;278971;280135;280221;281072.99999999796;282435;48770.512294877306;48996.120465544365;49156.508434915195;49177.75411122993;49194.75402623036;49850.501494985314;55249;56953.430465695645;56955.715221424456;63030.68484657639;14820.258987050604;15119.848801512064;15123.848761512465;15132.243387830564;15138.924305378623;10425.582976681;11464.598739044093;11830.940845295718;11838.526458941546;12063.396830158457;16924.407645732586;16941.71286876256;16990.660186796194;16996.660066798595;17024.404145854834;5775.509081728016;5890.204822349014;5940;6003.969980150071;6063;708.3553965891015;772.729544659376;799.928006479408;811.3063330852154;829.9543525106177;24132.39669008289;25442.618360724606;25529.744702552736;25530.23409297724;25540.74459255421;851.3784936996028;866.8179682266668;872.520113937332;899.5277479323277;909.6770646420425;13210.867891320964;13380;13442.865571344162;13569.86430135686;13593.116447431083;386761;388616;388866;389541;390098;51265.7436712814;51338;51416;51422.22866657003;51462.22806657828;910.4309806371018;1128.8758236593967;1146.3064845768356;1151.2631915574038;1178.3754610056683;28845.711542884303;30118.3976320468;30178.396432071673;30241.517629151323;30411.239719006317;42794.57205427906;42999.78500107479;43217.135657287305;43339.349909750745;43427.565724342356;302106;303505;303928;304654;305104;31354.21614459657;36298.8185059073;37376.62623373731;37380;40550.1889962205;42513.14973700447;42676.78661606672;42688.35967460428;43319.35020974751;43594.422585628054;35870.282594348486;36681;37479.81260093682;37625.4356184652;37757;36371.27257454889;37019.62980370162;37035;37887.81056094702;38095.809520952214;36953.44569831401;37606;37703.24593508169;37784.43323350097;37827.24345513019;31669.366612667156;33633.49549756707;33980.941715245746;34088.48867267043;34384.82807586046;26023.349416264744;26368.472630547665;26541.734582653928;26745.071116218336;26753.866230668722 03:13:51 INFO - PROCESS | 11092 | |2;jquery.html;363.15566308333126;369.7485709717392;372.0605471185257;383.6872948546932;385.3276033321854;16588.585285367873;16835.074070926094;17576.121193940286;17616.735748963776;17633;15751.60620984476;16025.198740062979;17252.48242552722;17257.91371043143;17327.913360433213;4904.411470623521;5091.159958606825;5123.103456895047;5128.05131050755;5131.589472842183;3747.887563373103;3838.366669499529;3907.2185562887394;5051.090803655341;5838.854028649275;6091.14723938649;6179.073139029137;6186.288576813657;6190.226221722285;6191.659458729768;5892.322382925976;6036.849078773043;6038.879222415571;6040.728167232485;6046.486048685823;3438.7249020078334;3611.494390785292;3619.8552057917914;5329.173978033411;5329.653572517813;18977.620447591107;20424.795752042588;20619.58760824775;21887.78112218889;22014.449638759;1880.407671583447;1981.0482381251975;1986.9006549672458;2159.4601349662585;2541.0979102418746;13351.465941362334;13465.66335841602;13720.108192967426;13799.586012419644;14039.929800351036;1694.0767281831309;1706.8463838254493;1756.8945863248246;1760.102347802617;1807.7559529463485;71102.64448677724;71224.28775712228;72541.63729181373;73225.26774732291;74452;9785.26610504215;9883.11052005323;9966.700998969898;10182.490875456346;10324.328918620266;13632.591022269347;13692.383842727102;13728.725425491633;13741.24423156736;13751.312434378242;7192.3886469649615;7211.314925082109;7353.8161545961775;7396.112466504054;7477.476576639583;6886.311368863174;6978.965105174441;6989.091418115612;7123.361626825756;7127.536710113826;6212.844678883064;6387.265464471552;6398.29618741938;6437.066625339299;6440.516961227927;1622;1739.956501087483;1744.7819022622173;1752.6757549853319;1783.2064731194494;837.1293854391365;874.2044739287218;899.0649724286799;910.9726708198765;971.4025874087527;17064.56714913668;18029.7295540567;18139.343408542085;18147.818521814614;18281.725774113398;855.6278019061729;856.6530555125184;868.1925808997693;886.2289807867197;923.9974627529072;9880.35777674449;10277.17782577392;10330.328528645614;10341.37951722899;10473.214508911862;372448;377874;384261;386071;386570;71157.6442117786;71548.64225678942;71720.64139679268;71852.2814771856;72022.27977720261;851.965921363151;926.092429419173;935.7005758157325;952.5856252530172;952.9332946693803;13413.932930335286;15415.306311215798;15663.843361566695;16754.916225418794;17013.404530841362;24094.277171684877;32204;36859;37584;37764.81117594394;43579.78210109056;44201.33697994468;44826.55173448224;45485;45549.31676024928;6528.824811533779;6581.111549940888;6614.239362473377;6758.459323254029;7545.245475452411;6114.816555503342;8900.709397137509;10487.423191724529;10608.575656973635;11010.284331518425;6233.594816337105;7431.8142046449275;9377.81244375095;10021.899781002388;10369.118624916664;9853.605855765689;9871.506424678593;9907.405555666683;10042.146417554297;10251;9612.66355677548;10069.798604028025;10258.17934565248;10377.429241391796;10457.9477102614;7356.337929586149;7486.6256687166515;7601.353884919844;7669.233076692286;7706.884396734165;10127.79744405093;10194.592216311265;10343.586256549654;10344.224183186141;10404.219683523615 03:13:51 INFO - PROCESS | 11092 | |3;mootools.html;1228.533157400188;1299.7140629061603;1333.3733145421652;1666.2751703009199;1691.627841874787;7162.785116446508;7573.9621301893485;7669.731559395423;7670.6548205330755;7672.6930922763095;6405.29541750407;6890.965545172279;7162.570245785257;7163.391111755507;7513.323800857922;2141.8607790493647;2162.50262439639;2163.123934806398;2163.56728654269;2163.891805409731;2120.3638908327516;2154.3859999900033;2155.9461013474634;2159.2334721173993;2160.82713382929;1809.3305476973537;1878.2017642501883;1878.3238034307637;1886.368066697658;2055.5580550181708;2149.419656692692;2187.0814258011674;2189.255653077945;2190.266260802617;2194;2193.122750899653;2199.8900054997184;2209.359285807114;2213.944651383712;2220.2562141682556;7501.24987501251;7619.4285428593075;7623.771286861403;7626.122995855492;7642.350400215988;4312.3531470279395;4444.799984000728;4451.532589078132;4456.532064133252;4464.598186163261;2824.646919135108;2881.5821705852536;2916.6937471565393;2960.06757871272;2962.155785601093;830.6843399508148;857.0829212742368;863.0549548244662;867.119873328572;870.2689740617911;9954;9984.301098923079;9989.051040151247;9995.400275983464;10000.699979000568;3845.288621605012;4170.103427763045;4179;4179.686523510749;4186.225548273579;8602.61288242018;8664.61009254585;8668.263197628272;8678.088800675965;8719.084496127814;4560.452745670541;4575;4586.0827834432575;4587.3807036050375;4606.585407313358;4134.91730165395;4200.936985945214;4205.137946720976;4208.368744688321;4219.599138081878;3479.7738147020364;3482.0946553895665;3546.7871927684423;3569.5716514017963;3582.8566857325413;1150.6663067710438;1167.1654766841748;1172.9648110556698;1181.787278289916;1186.8397766301612;736.488140742179;750.9074296898;815.5514467043103;822.9177082291723;841.6591280531395;4887.926681099786;5133.897322053538;5153.330067091254;5160.148575485078;5303.7878484860175;845.0999685335098;860.4149178558515;865.1002956924727;865.4331412924545;867.9175478329548;3424.6917777400154;3481.4255647817827;3574.7855128692363;3576.946345804815;3616.5479315085613;8944.150305720947;9254.213391861633;9324.393914395543;9350.345475816763;9352.392094513834;9189.264858811413;9200.493972831558;9212.907870921339;9224.723258302127;9241.768955776159;6587.769428070091;6828.556143850634;6890.621015844076;6978.860422791516;7039.436845052383;5226.895462090661;5259.289995850511;5299.046171688979;5343.732813359395;5359.3032905722;8188.2630563249595;8251.752447426346;8507.234348908629;8540.231379175904;8582.828343432971;8514.829703405774;8550.315974722133;8616.870746938926;8672.913270867211;8743.868841967249;6294.087357333253;6357.618542887441;6374.93625063762;6395.744170233324;6423.871522569429;6703.530752847254;6894.827629309308;6907.516473846783;6908.1019467468905;6912.55068420551;4612.654050946126;6320.367963203643;6351.142595749515;6547.443467305142;6604.966975165094;6234.532410069353;6245.18812554365;6294.3076261612105;6316.652584107918;6514.200997975172;5521.00621888064;5543.25166102571;5568.749406276646;5883.882322353615;5905.616134951214;4489.73061616304;4568;4601.217792975269;4605.125026245003;4730.787114579921;4272.081502476983;4351.086271882813;4371.409859668904;4449.243628583084;4453.220686379936 03:13:51 INFO - PROCESS | 11092 | |4;prototype.html;286.25002493467105;289.67701013370095;296.8678937872647;300.361731320943;302.2760488629732;4805.135075686375;4831.661783675144;4837.3227748115205;4842.273658951159;4868.805247790088;4501.7524036178;4587.243104887698;4706.411698537683;4769.809207631699;4772.260299653551;3779.9055023624355;3804.4293355996683;3807.58116607173;3811.8856434306877;3817.6945844332527;3807.2385522895393;3816.9045773855596;3817.7709337439705;3831.1188426661884;3862.86479973201;3602.2615363850346;3628.8931875777876;3752.287065457568;3756.136088699601;3760.8683696070643;3735.831887565066;3752.230792687506;3762.7930463824478;3762.8682996095004;3801.7834293026244;3354;3383.4924761285756;3383.796972181677;3386.0688310714504;3387.983060084684;4359.910022494377;4690.601298889598;4727.149113159629;4739.170645137087;4740.928886066712;4209.431726716915;4233.872983810491;4263.253930562139;4267.701260911737;4279.486461624594;4987.576056035241;4998.375203099613;5007.324011258506;5016.874578135539;5038.722870242135;3541.9291614167573;3542.742326474116;3547.1909326243544;3567.3935430976535;3574.1422058705984;4964.453910069889;5215.496561650429;5234.8691282717855;5238.60710446718;5238.926020165857;3669.321175582526;3688.483612294281;3694.8706795262037;3698;3698.613020117456;3732.9626703733156;3740.345439548068;3741.5323084614424;3761.247750449921;3766.3408903442337;4148.149629325981;4202.327627579572;4220.261454245495;4283.550227226158;4295.355696645465;4965.205567109245;4966.577840883565;4966.6771659842;4976.527229913152;4994.375703037121;1232.648695121886;1252.7932891072871;1278.4055414232428;1278.4822147030468;1296.7925131978839;863.48622569571;877.9692710755221;890.4879694175875;895.6641259527677;900.2707806676613;4358.585934336233;4369.519352871182;4377.8248870044845;4384.47386313638;4388.912221755547;5067.214581739836;5085.059264036091;5085.74571271435;5089.949100509021;5093.821716239988;4368.4102646143;4378.963781841396;4380.474343078788;4386.539413361615;4386.736795792199;2291.46150654596;2419.6733440985595;2427.7936375407935;2432.7497065214607;2439.097533912464;4328.5455027222315;4338.848140315074;4351.282038463618;4352.2818734909015;4403.955960440355;4573.405457290531;4588.7935042923145;4608.654350923694;4619.3994780678295;4621.689155422288;4101.89745256365;4295.162443323647;4359.629431498295;4371.32244502109;4404.383386325917;4528.886777830448;4531.886702832324;4535.659825513034;4543.500214976284;4555.5649970259265;4507.414036175276;4514.638828893615;4516.638668906414;4521.932171017372;4536.183486972244;4132.483439570054;4285.742855428684;4330.545292744217;4362.498312693954;4370.956290437055;3354.2117602363915;3356.395848747249;3358.261182539837;3382.5771778527683;3407.318536292702;4509.571590698878;4554.521775213555;4587.931181032354;4608.239640459286;4955.2319390493085;4808.519148085164;4997.200447928314;5003.724795136302;5009.795689896434;5029.823956161516;4935.457099718957;4941.65408421407;4950.579200767831;4971.950280497149;5011.3963531669515;4817.686850354716;4923.852284431473;4930.556249937523;4949.158643030765;4968.527989840959;4997.475265097112;5016.448190699093;5017.84946451607;5045.217991211368;5053.949460505495;4911.410630724193;4915.149213456259;4917.926231106465;4922.458529561817;4926.605871530197 03:13:51 INFO - PROCESS | 11092 | |5;yui.html;616.8211218746562;639.1882309466977;680.8672308899767;722.4798145335357;770.2374649097395;11495.942520287397;12139.393030348492;12505.624831255065;12522.56171034014;12658.367081645927;11812.468438920248;11850.3482308473;11864.703382415444;11922.165448418615;11933.64199074027;618.8143556932924;765.7396485195032;767.0411985018727;788.2550989315099;788.787027502574;797.3023604346197;797.5453991225004;798.4091772088642;800.2677550041734;800.3757069485781;831.5135645647304;832.4672209785742;833.042001698049;833.1293797981094;834.6828205281985;649.405793698765;662.6653539962289;665;665.4576520136073;824.6618886256636;576.3544829790619;598.4015984015984;599.2180204832691;599.5143933413949;600.6996501749126;10938.726531836688;10939.56241750329;10961.671149865517;10963.890361096446;10973.615923442641;12566.560170393992;12951.870481295255;13021.869781302255;13101.754770455314;13150.276734779583;11623.825642615368;11926.821097683542;12088.395580221042;12117.515299388015;12308.81536776949;4200.432941552882;4263.424437700933;4267.317229243306;4279.721818081845;4429.092036132585;58085.419145808846;58221.70889145527;59189.704051479464;59211;59758.99999999956;10601.522931468102;10602.734931626772;10654.840177397346;10676.199285053497;10749;19157.233710651697;19200;19223.711644325347;19312.61374772497;19329.51676208106;6384.52116091295;6420.5184611154355;6422.389872962061;6429.3570642936265;6684.097646817715;3772.4718539404507;3794.71539634523;3803.7147213959065;3851.3837785954674;3857.2092720992127;2671.839689618629;2754.118682021774;2769.8061135720304;2772.916812495628;2781.304673831542;466.1446246138374;489.59363728105586;491.8106528986294;492.3132230538379;500.45450458999136;462.95139010404097;522.9921551176735;523.377181154425;535.5715427657858;536.9624126311121;7706.730264440717;7888.684452621946;7931.960340198378;7934.920650793533;8040.437169398086;513.8997895410433;516.5764073459727;535.1223992652053;538.1685296217354;540.8864138530953;3584.5877724061547;3663.7069034477177;3804.847806087781;3917.118648304109;3940.0937784309767;86838.56580717055;91799.95100269416;93708.0629193713;93796;93889.5305523468;65823.34176658173;74419.25580744231;78874;80145.59927200327;80870.7434016787;67896;69657;69823.30176698168;69833.65083174653;72044;8855.512946787989;9149.954250228706;9280.535973201448;9413.670521531714;9511.857322140311;42008.369874451295;44426;44454.55545444504;44765.77617111894;45650.54349456463;54032.44605137315;63082.36917630765;64083.35916640774;64272.67863660652;64771.67614161899;11018.205068473422;11252.493637786156;11368.715782105513;11557.364344961108;11876;13251.403686833923;13382.13016153947;13608.863911361155;13999.44002239899;14442.783358249424;11990.792410714412;12406.751864962469;12535.498580057061;12571.377498833119;12662;12681.492740290285;12693.682657933625;12816.615501534969;12825.871741282841;12825.935870320589;10941;12901.741965160832;12904.354782260662;12905.096643234883;13345.266010369523;10192.388456692623;10429.634962776267;10544.26190166681;10564.471776411303;10861.619843305447;9612.615495380387;9849.507524623883;9920.751981200528;10530.947345263225;10566.735831604272 03:13:51 INFO - PROCESS | 11092 | __end_tp_report 03:13:51 INFO - PROCESS | 11092 | __start_cc_report 03:13:51 INFO - PROCESS | 11092 | _x_x_mozilla_cycle_collect,950 03:13:51 INFO - PROCESS | 11092 | __end_cc_report 03:13:51 INFO - PROCESS | 11092 | __startTimestamp1468404831344__endTimestamp 03:13:51 INFO - PROCESS | 11092 | 03:13:51 INFO - PROCESS | 11092 | ------- Summary: start ------- 03:13:51 INFO - PROCESS | 11092 | Number of tests: 6 03:13:51 INFO - PROCESS | 11092 | 03:13:51 INFO - PROCESS | 11092 | [#0] dojo.html Cycles:165 Average:4655.72 Median:4784.95 stddev:480.81 (10.0%) stddev-sans-first:455.61 03:13:51 INFO - PROCESS | 11092 | Values: 2642.7 2653.5 2679.1 2688.0 2700.2 4561.0 4684.6 4711.4 4758.2 4818.5 4628.0 4645.3 4662.2 4678.6 4702.2 4255.1 4315.8 4349.0 4376.4 4476.7 4421.5 4446.2 4456.2 4482.5 4501.9 4208.2 4249.9 4259.1 4273.6 4385.1 4243.9 4253.2 4258.4 4303.4 4338.5 4281.6 4281.7 4295.5 4331.9 4336.8 4598.5 4658.2 4717.2 4747.5 4748.4 5029.2 5110.4 5124.2 5124.5 5131.6 5117.9 5132.3 5132.8 5140.8 5141.9 4577.0 4678.3 4751.3 4780.0 4785.0 5135.0 5155.3 5159.3 5205.7 5208.6 4946.8 4947.6 4971.4 4992.3 4996.8 4861.3 4962.4 4995.9 5023.9 5024.0 4970.4 4985.7 4995.0 5008.6 5050.3 4959.8 4974.3 4976.8 4983.6 5030.5 4218.0 4259.3 4259.5 4261.7 4262.6 3718.9 3759.5 3772.3 3822.7 3862.2 4350.1 4357.9 4367.3 4393.1 4403.2 4850.1 5066.3 5069.8 5072.3 5112.3 4228.5 4272.5 4301.1 4308.7 4340.4 4559.7 4563.9 4567.9 4575.2 4615.0 4696.0 4789.2 4805.9 4809.1 4811.6 4971.2 4988.8 5009.8 5013.3 5082.4 4783.0 4786.4 4796.2 4797.8 4845.1 4825.4 4977.6 4977.7 4979.2 5022.0 4939.9 4965.8 5042.2 5061.7 5095.4 4942.2 4945.9 4947.1 4947.4 4998.4 4707.0 4940.2 4940.4 4952.2 4997.4 4709.1 4738.5 4744.0 4786.8 4823.8 4868.6 4884.3 4885.8 4894.4 4939.5 4661.2 4776.0 4783.4 4795.4 4797.4 03:13:51 INFO - PROCESS | 11092 | 03:13:51 INFO - PROCESS | 11092 | [#1] ext.html Cycles:180 Average:48847.38 Median:36526.14 stddev:85997.47 (235.4%) stddev-sans-first:86162.29 03:13:51 INFO - PROCESS | 11092 | Values: 561.4 563.2 565.1 575.4 579.1 39976.8 41406.8 41487.0 45133.3 45332.8 42738.4 43137.6 43209.1 43289.6 43290.8 7491.5 7864.6 8011.9 8019.6 10054.8 9957.6 10327.5 10355.8 10364.4 10365.5 10405.6 10464.8 10474.1 10482.7 10487.1 7601.2 10017.5 10295.6 10305.9 10331.3 10191.2 10281.2 10287.0 10300.4 10300.9 39998.2 40241.2 40366.2 40380.8 40404.6 2424.5 2879.6 3127.6 3367.4 3481.3 30008.4 30328.8 30413.2 30602.0 31415.0 3563.8 3573.6 3574.6 3627.5 3680.1 278971.0 280135.0 280221.0 281073.0 282435.0 48770.5 48996.1 49156.5 49177.8 49194.8 49850.5 55249.0 56953.4 56955.7 63030.7 14820.3 15119.8 15123.8 15132.2 15138.9 10425.6 11464.6 11830.9 11838.5 12063.4 16924.4 16941.7 16990.7 16996.7 17024.4 5775.5 5890.2 5940.0 6004.0 6063.0 708.4 772.7 799.9 811.3 830.0 24132.4 25442.6 25529.7 25530.2 25540.7 851.4 866.8 872.5 899.5 909.7 13210.9 13380.0 13442.9 13569.9 13593.1 386761.0 388616.0 388866.0 389541.0 390098.0 51265.7 51338.0 51416.0 51422.2 51462.2 910.4 1128.9 1146.3 1151.3 1178.4 28845.7 30118.4 30178.4 30241.5 30411.2 42794.6 42999.8 43217.1 43339.3 43427.6 302106.0 303505.0 303928.0 304654.0 305104.0 31354.2 36298.8 37376.6 37380.0 40550.2 42513.1 42676.8 42688.4 43319.4 43594.4 35870.3 36681.0 37479.8 37625.4 37757.0 36371.3 37019.6 37035.0 37887.8 38095.8 36953.4 37606.0 37703.2 37784.4 37827.2 31669.4 33633.5 33980.9 34088.5 34384.8 26023.3 26368.5 26541.7 26745.1 26753.9 03:13:51 INFO - PROCESS | 11092 | 03:13:51 INFO - PROCESS | 11092 | [#2] jquery.html Cycles:180 Average:23842.84 Median:386320.50 stddev:62905.14 (16.3%) stddev-sans-first:63056.90 03:13:51 INFO - PROCESS | 11092 | Values: 363.2 369.7 372.1 383.7 385.3 16588.6 16835.1 17576.1 17616.7 17633.0 15751.6 16025.2 17252.5 17257.9 17327.9 4904.4 5091.2 5123.1 5128.1 5131.6 3747.9 3838.4 3907.2 5051.1 5838.9 6091.1 6179.1 6186.3 6190.2 6191.7 5892.3 6036.8 6038.9 6040.7 6046.5 3438.7 3611.5 3619.9 5329.2 5329.7 18977.6 20424.8 20619.6 21887.8 22014.4 1880.4 1981.0 1986.9 2159.5 2541.1 13351.5 13465.7 13720.1 13799.6 14039.9 1694.1 1706.8 1756.9 1760.1 1807.8 71102.6 71224.3 72541.6 73225.3 74452.0 9785.3 9883.1 9966.7 10182.5 10324.3 13632.6 13692.4 13728.7 13741.2 13751.3 7192.4 7211.3 7353.8 7396.1 7477.5 6886.3 6979.0 6989.1 7123.4 7127.5 6212.8 6387.3 6398.3 6437.1 6440.5 1622.0 1740.0 1744.8 1752.7 1783.2 837.1 874.2 899.1 911.0 971.4 17064.6 18029.7 18139.3 18147.8 18281.7 855.6 856.7 868.2 886.2 924.0 9880.4 10277.2 10330.3 10341.4 10473.2 372448.0 377874.0 384261.0 386071.0 386570.0 71157.6 71548.6 71720.6 71852.3 72022.3 852.0 926.1 935.7 952.6 952.9 13413.9 15415.3 15663.8 16754.9 17013.4 24094.3 32204.0 36859.0 37584.0 37764.8 43579.8 44201.3 44826.6 45485.0 45549.3 6528.8 6581.1 6614.2 6758.5 7545.2 6114.8 8900.7 10487.4 10608.6 11010.3 6233.6 7431.8 9377.8 10021.9 10369.1 9853.6 9871.5 9907.4 10042.1 10251.0 9612.7 10069.8 10258.2 10377.4 10457.9 7356.3 7486.6 7601.4 7669.2 7706.9 10127.8 10194.6 10343.6 10344.2 10404.2 03:13:51 INFO - PROCESS | 11092 | 03:13:51 INFO - PROCESS | 11092 | [#3] mootools.html Cycles:180 Average:4914.96 Median:5351.52 stddev:2701.34 (50.5%) stddev-sans-first:2694.71 03:13:51 INFO - PROCESS | 11092 | Values: 1228.5 1299.7 1333.4 1666.3 1691.6 7162.8 7574.0 7669.7 7670.7 7672.7 6405.3 6891.0 7162.6 7163.4 7513.3 2141.9 2162.5 2163.1 2163.6 2163.9 2120.4 2154.4 2155.9 2159.2 2160.8 1809.3 1878.2 1878.3 1886.4 2055.6 2149.4 2187.1 2189.3 2190.3 2194.0 2193.1 2199.9 2209.4 2213.9 2220.3 7501.2 7619.4 7623.8 7626.1 7642.4 4312.4 4444.8 4451.5 4456.5 4464.6 2824.6 2881.6 2916.7 2960.1 2962.2 830.7 857.1 863.1 867.1 870.3 9954.0 9984.3 9989.1 9995.4 10000.7 3845.3 4170.1 4179.0 4179.7 4186.2 8602.6 8664.6 8668.3 8678.1 8719.1 4560.5 4575.0 4586.1 4587.4 4606.6 4134.9 4200.9 4205.1 4208.4 4219.6 3479.8 3482.1 3546.8 3569.6 3582.9 1150.7 1167.2 1173.0 1181.8 1186.8 736.5 750.9 815.6 822.9 841.7 4887.9 5133.9 5153.3 5160.1 5303.8 845.1 860.4 865.1 865.4 867.9 3424.7 3481.4 3574.8 3576.9 3616.5 8944.2 9254.2 9324.4 9350.3 9352.4 9189.3 9200.5 9212.9 9224.7 9241.8 6587.8 6828.6 6890.6 6978.9 7039.4 5226.9 5259.3 5299.0 5343.7 5359.3 8188.3 8251.8 8507.2 8540.2 8582.8 8514.8 8550.3 8616.9 8672.9 8743.9 6294.1 6357.6 6374.9 6395.7 6423.9 6703.5 6894.8 6907.5 6908.1 6912.6 4612.7 6320.4 6351.1 6547.4 6605.0 6234.5 6245.2 6294.3 6316.7 6514.2 5521.0 5543.3 5568.7 5883.9 5905.6 4489.7 4568.0 4601.2 4605.1 4730.8 4272.1 4351.1 4371.4 4449.2 4453.2 03:13:51 INFO - PROCESS | 11092 | 03:13:51 INFO - PROCESS | 11092 | [#4] prototype.html Cycles:180 Average:4038.48 Median:4385.51 stddev:1153.27 (26.3%) stddev-sans-first:1121.59 03:13:51 INFO - PROCESS | 11092 | Values: 286.3 289.7 296.9 300.4 302.3 4805.1 4831.7 4837.3 4842.3 4868.8 4501.8 4587.2 4706.4 4769.8 4772.3 3779.9 3804.4 3807.6 3811.9 3817.7 3807.2 3816.9 3817.8 3831.1 3862.9 3602.3 3628.9 3752.3 3756.1 3760.9 3735.8 3752.2 3762.8 3762.9 3801.8 3354.0 3383.5 3383.8 3386.1 3388.0 4359.9 4690.6 4727.1 4739.2 4740.9 4209.4 4233.9 4263.3 4267.7 4279.5 4987.6 4998.4 5007.3 5016.9 5038.7 3541.9 3542.7 3547.2 3567.4 3574.1 4964.5 5215.5 5234.9 5238.6 5238.9 3669.3 3688.5 3694.9 3698.0 3698.6 3733.0 3740.3 3741.5 3761.2 3766.3 4148.1 4202.3 4220.3 4283.6 4295.4 4965.2 4966.6 4966.7 4976.5 4994.4 1232.6 1252.8 1278.4 1278.5 1296.8 863.5 878.0 890.5 895.7 900.3 4358.6 4369.5 4377.8 4384.5 4388.9 5067.2 5085.1 5085.7 5089.9 5093.8 4368.4 4379.0 4380.5 4386.5 4386.7 2291.5 2419.7 2427.8 2432.7 2439.1 4328.5 4338.8 4351.3 4352.3 4404.0 4573.4 4588.8 4608.7 4619.4 4621.7 4101.9 4295.2 4359.6 4371.3 4404.4 4528.9 4531.9 4535.7 4543.5 4555.6 4507.4 4514.6 4516.6 4521.9 4536.2 4132.5 4285.7 4330.5 4362.5 4371.0 3354.2 3356.4 3358.3 3382.6 3407.3 4509.6 4554.5 4587.9 4608.2 4955.2 4808.5 4997.2 5003.7 5009.8 5029.8 4935.5 4941.7 4950.6 4972.0 5011.4 4817.7 4923.9 4930.6 4949.2 4968.5 4997.5 5016.4 5017.8 5045.2 5053.9 4911.4 4915.1 4917.9 4922.5 4926.6 03:13:51 INFO - PROCESS | 11092 | 03:13:51 INFO - PROCESS | 11092 | [#5] yui.html Cycles:180 Average:17243.22 Median:45208.16 stddev:23766.80 (52.6%) stddev-sans-first:23800.68 03:13:51 INFO - PROCESS | 11092 | Values: 616.8 639.2 680.9 722.5 770.2 11495.9 12139.4 12505.6 12522.6 12658.4 11812.5 11850.3 11864.7 11922.2 11933.6 618.8 765.7 767.0 788.3 788.8 797.3 797.5 798.4 800.3 800.4 831.5 832.5 833.0 833.1 834.7 649.4 662.7 665.0 665.5 824.7 576.4 598.4 599.2 599.5 600.7 10938.7 10939.6 10961.7 10963.9 10973.6 12566.6 12951.9 13021.9 13101.8 13150.3 11623.8 11926.8 12088.4 12117.5 12308.8 4200.4 4263.4 4267.3 4279.7 4429.1 58085.4 58221.7 59189.7 59211.0 59759.0 10601.5 10602.7 10654.8 10676.2 10749.0 19157.2 19200.0 19223.7 19312.6 19329.5 6384.5 6420.5 6422.4 6429.4 6684.1 3772.5 3794.7 3803.7 3851.4 3857.2 2671.8 2754.1 2769.8 2772.9 2781.3 466.1 489.6 491.8 492.3 500.5 463.0 523.0 523.4 535.6 537.0 7706.7 7888.7 7932.0 7934.9 8040.4 513.9 516.6 535.1 538.2 540.9 3584.6 3663.7 3804.8 3917.1 3940.1 86838.6 91800.0 93708.1 93796.0 93889.5 65823.3 74419.3 78874.0 80145.6 80870.7 67896.0 69657.0 69823.3 69833.7 72044.0 8855.5 9150.0 9280.5 9413.7 9511.9 42008.4 44426.0 44454.6 44765.8 45650.5 54032.4 63082.4 64083.4 64272.7 64771.7 11018.2 11252.5 11368.7 11557.4 11876.0 13251.4 13382.1 13608.9 13999.4 14442.8 11990.8 12406.8 12535.5 12571.4 12662.0 12681.5 12693.7 12816.6 12825.9 12825.9 10941.0 12901.7 12904.4 12905.1 13345.3 10192.4 10429.6 10544.3 10564.5 10861.6 9612.6 9849.5 9920.8 10530.9 10566.7 03:13:51 INFO - PROCESS | 11092 | -------- Summary: end -------- 03:13:51 INFO - PROCESS | 11092 | 03:13:52 INFO - TEST-INFO | 11092: exit 0 03:13:52 INFO - TEST-OK | dromaeo_css | took 1119726ms 03:13:52 INFO - TEST-START | kraken 03:13:52 INFO - operating with platform_type : linux_ 03:13:52 INFO - Initialising browser for kraken test... 03:13:52 INFO - TEST-INFO | started process 11280 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUxXrYl/profile http://localhost:43858/getInfo.html) 03:13:56 INFO - PROCESS | 11280 | __metrics Screen width/height:1600/1200 03:13:56 INFO - PROCESS | 11280 | colorDepth:24 03:13:56 INFO - PROCESS | 11280 | Browser inner width/height: 1024/697 03:13:56 INFO - PROCESS | 11280 | __metrics 03:13:57 INFO - PROCESS | 11280 | 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" 03:13:57 INFO - PROCESS | 11280 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:13:57 INFO - PROCESS | 11280 | console.error: PushService: 03:13:57 INFO - PROCESS | 11280 | stateChangeProcessEnqueue: Error transitioning state 03:13:57 INFO - PROCESS | 11280 | UnknownError 03:13:58 INFO - TEST-INFO | 11280: exit 0 03:13:58 INFO - Browser initialized. 03:13:58 INFO - Running cycle 1/1 for kraken test... 03:13:58 INFO - TEST-INFO | started process 11364 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUxXrYl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:14:10 INFO - PROCESS | 11364 | RSS: Main: 158547968 03:14:10 INFO - PROCESS | 11364 | 03:14:12 INFO - PROCESS | 11364 | Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43858/tests/kraken/driver.html?testName=audio-beat-detection) 03:14:13 INFO - PROCESS | 11364 | RSS: Main: 216850432 03:14:13 INFO - PROCESS | 11364 | 03:14:16 INFO - PROCESS | 11364 | Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43858/tests/kraken/driver.html?testName=audio-dft) 03:14:17 INFO - PROCESS | 11364 | RSS: Main: 204140544 03:14:17 INFO - PROCESS | 11364 | 03:14:20 INFO - PROCESS | 11364 | Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43858/tests/kraken/driver.html?testName=audio-fft) 03:14:21 INFO - PROCESS | 11364 | RSS: Main: 270774272 03:14:21 INFO - PROCESS | 11364 | 03:14:23 INFO - PROCESS | 11364 | Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43858/tests/kraken/driver.html?testName=audio-oscillator) 03:14:23 INFO - PROCESS | 11364 | RSS: Main: 181547008 03:14:23 INFO - PROCESS | 11364 | 03:14:26 INFO - PROCESS | 11364 | Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43858/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:14:26 INFO - PROCESS | 11364 | RSS: Main: 185552896 03:14:26 INFO - PROCESS | 11364 | 03:14:29 INFO - PROCESS | 11364 | Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43858/tests/kraken/driver.html?testName=imaging-darkroom) 03:14:30 INFO - PROCESS | 11364 | RSS: Main: 221806592 03:14:30 INFO - PROCESS | 11364 | 03:14:33 INFO - PROCESS | 11364 | Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43858/tests/kraken/driver.html?testName=imaging-desaturate) 03:14:34 INFO - PROCESS | 11364 | RSS: Main: 217276416 03:14:34 INFO - PROCESS | 11364 | 03:14:37 INFO - PROCESS | 11364 | Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43858/tests/kraken/driver.html?testName=json-parse-financial) 03:14:38 INFO - PROCESS | 11364 | RSS: Main: 220385280 03:14:38 INFO - PROCESS | 11364 | 03:14:39 INFO - PROCESS | 11364 | Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43858/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:14:40 INFO - PROCESS | 11364 | RSS: Main: 206364672 03:14:40 INFO - PROCESS | 11364 | 03:14:42 INFO - PROCESS | 11364 | Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43858/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:14:42 INFO - PROCESS | 11364 | RSS: Main: 210771968 03:14:42 INFO - PROCESS | 11364 | 03:14:45 INFO - PROCESS | 11364 | Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43858/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:14:45 INFO - PROCESS | 11364 | RSS: Main: 210849792 03:14:45 INFO - PROCESS | 11364 | 03:14:48 INFO - PROCESS | 11364 | Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43858/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:14:49 INFO - PROCESS | 11364 | RSS: Main: 224952320 03:14:49 INFO - PROCESS | 11364 | 03:14:52 INFO - PROCESS | 11364 | Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43858/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:14:52 INFO - PROCESS | 11364 | RSS: Main: 225427456 03:14:52 INFO - PROCESS | 11364 | 03:14:54 INFO - PROCESS | 11364 | Cycle 1(1): loaded http://localhost:43858/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43858/tests/kraken/driver.html?testName=ai-astar) 03:14:54 INFO - PROCESS | 11364 | RSS: Main: 267698176 03:14:54 INFO - PROCESS | 11364 | 03:14:54 INFO - PROCESS | 11364 | __start_tp_report 03:14:54 INFO - PROCESS | 11364 | _x_x_mozilla_page_load 03:14:54 INFO - PROCESS | 11364 | _x_x_mozilla_page_load_details 03:14:54 INFO - PROCESS | 11364 | |i|pagename|runs| 03:14:54 INFO - PROCESS | 11364 | |0;ai-astar;105;114;114;115;114;113;113;113;112;114 03:14:54 INFO - PROCESS | 11364 | |1;audio-beat-detection;164;121;123;191;127;128;157;122;163;120 03:14:54 INFO - PROCESS | 11364 | |2;audio-dft;162;160;160;161;161;162;162;160;163;160 03:14:54 INFO - PROCESS | 11364 | |3;audio-fft;76;75;77;108;76;86;75;75;99;74 03:14:54 INFO - PROCESS | 11364 | |4;audio-oscillator;85;87;126;86;86;85;109;85;85;122 03:14:54 INFO - PROCESS | 11364 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;117;117;117 03:14:54 INFO - PROCESS | 11364 | |6;imaging-darkroom;146;148;147;147;147;147;147;146;147;147 03:14:54 INFO - PROCESS | 11364 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 03:14:54 INFO - PROCESS | 11364 | |8;json-parse-financial;73;65;64;66;64;74;69;65;64;64 03:14:54 INFO - PROCESS | 11364 | |9;json-stringify-tinderbox;65;64;65;65;65;64;66;64;66;64 03:14:54 INFO - PROCESS | 11364 | |10;stanford-crypto-aes;79;78;78;78;79;87;79;78;81;83 03:14:54 INFO - PROCESS | 11364 | |11;stanford-crypto-ccm;139;132;131;128;138;130;130;138;177;131 03:14:54 INFO - PROCESS | 11364 | |12;stanford-crypto-pbkdf2;176;169;168;172;173;172;168;175;173;172 03:14:54 INFO - PROCESS | 11364 | |13;stanford-crypto-sha256-iterative;67;67;67;67;67;66;67;66;67;66 03:14:54 INFO - PROCESS | 11364 | __end_tp_report 03:14:54 INFO - PROCESS | 11364 | __start_cc_report 03:14:54 INFO - PROCESS | 11364 | _x_x_mozilla_cycle_collect,1916 03:14:54 INFO - PROCESS | 11364 | __end_cc_report 03:14:54 INFO - PROCESS | 11364 | __startTimestamp1468404894691__endTimestamp 03:14:54 INFO - PROCESS | 11364 | 03:14:54 INFO - PROCESS | 11364 | ------- Summary: start ------- 03:14:54 INFO - PROCESS | 11364 | Number of tests: 14 03:14:54 INFO - PROCESS | 11364 | 03:14:54 INFO - PROCESS | 11364 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:2.83 (2.5%) stddev-sans-first:0.88 03:14:54 INFO - PROCESS | 11364 | Values: 105.0 114.0 114.0 115.0 114.0 113.0 113.0 113.0 112.0 114.0 03:14:54 INFO - PROCESS | 11364 | 03:14:54 INFO - PROCESS | 11364 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:142.50 stddev:25.07 (17.6%) stddev-sans-first:25.25 03:14:54 INFO - PROCESS | 11364 | Values: 164.0 121.0 123.0 191.0 127.0 128.0 157.0 122.0 163.0 120.0 03:14:54 INFO - PROCESS | 11364 | 03:14:54 INFO - PROCESS | 11364 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.10 (0.7%) stddev-sans-first:1.12 03:14:54 INFO - PROCESS | 11364 | Values: 162.0 160.0 160.0 161.0 161.0 162.0 162.0 160.0 163.0 160.0 03:14:54 INFO - PROCESS | 11364 | 03:14:54 INFO - PROCESS | 11364 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:11.97 (15.7%) stddev-sans-first:12.49 03:14:54 INFO - PROCESS | 11364 | Values: 76.0 75.0 77.0 108.0 76.0 86.0 75.0 75.0 99.0 74.0 03:14:54 INFO - PROCESS | 11364 | 03:14:54 INFO - PROCESS | 11364 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:85.00 stddev:16.69 (19.6%) stddev-sans-first:17.26 03:14:54 INFO - PROCESS | 11364 | Values: 85.0 87.0 126.0 86.0 86.0 85.0 109.0 85.0 85.0 122.0 03:14:54 INFO - PROCESS | 11364 | 03:14:54 INFO - PROCESS | 11364 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:14:54 INFO - PROCESS | 11364 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 03:14:54 INFO - PROCESS | 11364 | 03:14:54 INFO - PROCESS | 11364 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 03:14:54 INFO - PROCESS | 11364 | Values: 146.0 148.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 03:14:54 INFO - PROCESS | 11364 | 03:14:54 INFO - PROCESS | 11364 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 03:14:54 INFO - PROCESS | 11364 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 03:14:54 INFO - PROCESS | 11364 | 03:14:54 INFO - PROCESS | 11364 | [#8] json-parse-financial Cycles:10 Average:66.80 Median:65.50 stddev:3.85 (5.9%) stddev-sans-first:3.37 03:14:54 INFO - PROCESS | 11364 | Values: 73.0 65.0 64.0 66.0 64.0 74.0 69.0 65.0 64.0 64.0 03:14:54 INFO - PROCESS | 11364 | 03:14:54 INFO - PROCESS | 11364 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 03:14:54 INFO - PROCESS | 11364 | Values: 65.0 64.0 65.0 65.0 65.0 64.0 66.0 64.0 66.0 64.0 03:14:54 INFO - PROCESS | 11364 | 03:14:54 INFO - PROCESS | 11364 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:79.00 stddev:2.94 (3.7%) stddev-sans-first:3.10 03:14:54 INFO - PROCESS | 11364 | Values: 79.0 78.0 78.0 78.0 79.0 87.0 79.0 78.0 81.0 83.0 03:14:54 INFO - PROCESS | 11364 | 03:14:54 INFO - PROCESS | 11364 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:135.00 stddev:14.45 (10.7%) stddev-sans-first:15.32 03:14:54 INFO - PROCESS | 11364 | Values: 139.0 132.0 131.0 128.0 138.0 130.0 130.0 138.0 177.0 131.0 03:14:54 INFO - PROCESS | 11364 | 03:14:54 INFO - PROCESS | 11364 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:172.50 stddev:2.74 (1.6%) stddev-sans-first:2.45 03:14:54 INFO - PROCESS | 11364 | Values: 176.0 169.0 168.0 172.0 173.0 172.0 168.0 175.0 173.0 172.0 03:14:54 INFO - PROCESS | 11364 | 03:14:54 INFO - PROCESS | 11364 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 03:14:54 INFO - PROCESS | 11364 | Values: 67.0 67.0 67.0 67.0 67.0 66.0 67.0 66.0 67.0 66.0 03:14:54 INFO - PROCESS | 11364 | -------- Summary: end -------- 03:14:54 INFO - PROCESS | 11364 | 03:14:55 INFO - TEST-INFO | 11364: exit 0 03:14:55 INFO - TEST-OK | kraken | took 63609ms 03:14:55 INFO - SUITE-END | took 1183s 03:14:55 INFO - Completed test suite (00:19:43) 03:14:55 INFO - javascript benchmark 03:14:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2642.656454660896, 2653.5488966875632, 2679.129282983031, 2688.005437987945, 2700.1899430170943, 4560.97719511402, 4684.554967278112, 4711.363965864612, 4758.214894542396, 4818.51814818518, 4627.953720462794, 4645.279981602857, 4662.230731929228, 4678.602318802898, 4702.200625893598, 4255.085156691311, 4315.805788739514, 4348.956510434903, 4376.387305777193, 4476.7090139140855, 4421.469423669164, 4446.199684056868, 4456.153330867125, 4482.5069242383315, 4501.887452813673, 4208.179405016023, 4249.936250956238, 4259.10558782656, 4273.572642735701, 4385.057212699285, 4243.87268381946, 4253.1706317268145, 4258.382534532507, 4303.419038429804, 4338.544452832471, 4281.593248641374, 4281.678874084425, 4295.484541854966, 4331.870043898656, 4336.783160841946, 4598.517155698671, 4658.161530924433, 4717.150912835688, 4747.548982846624, 4748.3589715388325, 5029.170186919154, 5110.361204849394, 5124.231365295198, 5124.5131712487255, 5131.640785145041, 5117.872053198663, 5132.281480592683, 5132.84601461953, 5140.820071297487, 5141.948580514184, 4577.0, 4678.251479763221, 4751.287306903992, 4779.952200477951, 4784.952150478451, 5135.0, 5155.304033955443, 5159.329287192641, 5205.7397130143345, 5208.609354298443, 4946.777395017233, 4947.554720075139, 4971.353724015855, 4992.276119962585, 4996.775145118479, 4861.295112208781, 4962.429320628174, 4995.850124496271, 5023.874403139951, 5024.045431368028, 4970.403551573834, 4985.725785081855, 4995.0, 5008.5993120550265, 5050.318207042076, 4959.82640607577, 4974.278729584263, 4976.780688731284, 4983.576396006308, 5030.496950304941, 4218.029853133797, 4259.297215959394, 4259.467566554181, 4261.74429534229, 4262.616364527207, 3718.9442158367647, 3759.49246851677, 3772.2644084403278, 3822.7324087313623, 3862.1696335288048, 4350.129974005212, 4357.934630980474, 4367.30123180296, 4393.077453734688, 4403.207422663887, 4850.1269771440775, 5066.290719299301, 5069.771860266297, 5072.289879416885, 5112.284280200774, 4228.513720922133, 4272.530021697611, 4301.118270754488, 4308.719933204395, 4340.370646256339, 4559.726416414959, 4563.904662880885, 4567.885802854955, 4575.199340115467, 4614.953850461519, 4696.037312350892, 4789.209780386267, 4805.879853003563, 4809.134355815847, 4811.639127065484, 4971.154903666457, 4988.775505102207, 5009.774560144875, 5013.273075404119, 5082.390113186293, 4782.95217047839, 4786.425628924551, 4796.184648609815, 4797.832075877328, 4845.1278769820365, 4825.420949486084, 4977.626677999092, 4977.701337919736, 4979.203327467588, 5022.0, 4939.876503087452, 4965.776540055634, 5042.193249080129, 5061.670991385548, 5095.388553373619, 4942.233953737176, 4945.901081978413, 4947.134251506044, 4947.431045429822, 4998.375203099613, 4706.9529304707885, 4940.209566469348, 4940.407151141886, 4952.232403977389, 4997.400311962588, 4709.105269998689, 4738.50245724194, 4744.027474367677, 4786.760661966818, 4823.758812059313, 4868.561829435368, 4884.340614017062, 4885.755712214446, 4894.412670479565, 4939.53074457926, 4661.230896901973, 4776.044791041875, 4783.425988881357, 4795.376601041842, 4797.376341075638], "value": 4625.795416765978, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.446974729891, 563.1608902734927, 565.0507147991378, 575.3785911215887, 579.1341943794027, 39976.80011599942, 41406.792966035166, 41486.962825929404, 45133.323000155026, 45332.77333613335, 42738.35892461608, 43137.568624313746, 43209.13581728363, 43289.56710432895, 43290.783546082304, 7491.513051651653, 7864.567448790329, 8011.879821802678, 8019.639116239783, 10054.798904021914, 9957.601695932153, 10327.535260913277, 10355.792884142313, 10364.378137311747, 10365.481725913713, 10405.635802746905, 10464.790704185913, 10474.057334839863, 10482.737931551696, 10487.056164945154, 7601.239876012382, 10017.549210285555, 10295.588176472933, 10305.896941030569, 10331.27681062326, 10191.235657325657, 10281.228907831868, 10287.0, 10300.381977081399, 10300.948495257551, 39998.200035999114, 40241.19517609631, 40366.19267614661, 40380.798096009625, 40404.59595404038, 2424.5029768897334, 2879.5968564401, 3127.5934128563367, 3367.4275373186615, 3481.268933523963, 30008.399832003237, 30328.848355758302, 30413.23966900823, 30602.0, 31415.0, 3563.8396272167815, 3573.5711714594154, 3574.5889222739197, 3627.528421305213, 3680.0799800049986, 278971.0, 280135.0, 280221.0, 281072.99999999796, 282435.0, 48770.512294877306, 48996.120465544365, 49156.508434915195, 49177.75411122993, 49194.75402623036, 49850.501494985314, 55249.0, 56953.430465695645, 56955.715221424456, 63030.68484657639, 14820.258987050604, 15119.848801512064, 15123.848761512465, 15132.243387830564, 15138.924305378623, 10425.582976681, 11464.598739044093, 11830.940845295718, 11838.526458941546, 12063.396830158457, 16924.407645732586, 16941.71286876256, 16990.660186796194, 16996.660066798595, 17024.404145854834, 5775.509081728016, 5890.204822349014, 5940.0, 6003.969980150071, 6063.0, 708.3553965891015, 772.729544659376, 799.928006479408, 811.3063330852154, 829.9543525106177, 24132.39669008289, 25442.618360724606, 25529.744702552736, 25530.23409297724, 25540.74459255421, 851.3784936996028, 866.8179682266668, 872.520113937332, 899.5277479323277, 909.6770646420425, 13210.867891320964, 13380.0, 13442.865571344162, 13569.86430135686, 13593.116447431083, 386761.0, 388616.0, 388866.0, 389541.0, 390098.0, 51265.7436712814, 51338.0, 51416.0, 51422.22866657003, 51462.22806657828, 910.4309806371018, 1128.8758236593967, 1146.3064845768356, 1151.2631915574038, 1178.3754610056683, 28845.711542884303, 30118.3976320468, 30178.396432071673, 30241.517629151323, 30411.239719006317, 42794.57205427906, 42999.78500107479, 43217.135657287305, 43339.349909750745, 43427.565724342356, 302106.0, 303505.0, 303928.0, 304654.0, 305104.0, 31354.21614459657, 36298.8185059073, 37376.62623373731, 37380.0, 40550.1889962205, 42513.14973700447, 42676.78661606672, 42688.35967460428, 43319.35020974751, 43594.422585628054, 35870.282594348486, 36681.0, 37479.81260093682, 37625.4356184652, 37757.0, 36371.27257454889, 37019.62980370162, 37035.0, 37887.81056094702, 38095.809520952214, 36953.44569831401, 37606.0, 37703.24593508169, 37784.43323350097, 37827.24345513019, 31669.366612667156, 33633.49549756707, 33980.941715245746, 34088.48867267043, 34384.82807586046, 26023.349416264744, 26368.472630547665, 26541.734582653928, 26745.071116218336, 26753.866230668722], "value": 18247.61483850363, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.15566308333126, 369.7485709717392, 372.0605471185257, 383.6872948546932, 385.3276033321854, 16588.585285367873, 16835.074070926094, 17576.121193940286, 17616.735748963776, 17633.0, 15751.60620984476, 16025.198740062979, 17252.48242552722, 17257.91371043143, 17327.913360433213, 4904.411470623521, 5091.159958606825, 5123.103456895047, 5128.05131050755, 5131.589472842183, 3747.887563373103, 3838.366669499529, 3907.2185562887394, 5051.090803655341, 5838.854028649275, 6091.14723938649, 6179.073139029137, 6186.288576813657, 6190.226221722285, 6191.659458729768, 5892.322382925976, 6036.849078773043, 6038.879222415571, 6040.728167232485, 6046.486048685823, 3438.7249020078334, 3611.494390785292, 3619.8552057917914, 5329.173978033411, 5329.653572517813, 18977.620447591107, 20424.795752042588, 20619.58760824775, 21887.78112218889, 22014.449638759, 1880.407671583447, 1981.0482381251975, 1986.9006549672458, 2159.4601349662585, 2541.0979102418746, 13351.465941362334, 13465.66335841602, 13720.108192967426, 13799.586012419644, 14039.929800351036, 1694.0767281831309, 1706.8463838254493, 1756.8945863248246, 1760.102347802617, 1807.7559529463485, 71102.64448677724, 71224.28775712228, 72541.63729181373, 73225.26774732291, 74452.0, 9785.26610504215, 9883.11052005323, 9966.700998969898, 10182.490875456346, 10324.328918620266, 13632.591022269347, 13692.383842727102, 13728.725425491633, 13741.24423156736, 13751.312434378242, 7192.3886469649615, 7211.314925082109, 7353.8161545961775, 7396.112466504054, 7477.476576639583, 6886.311368863174, 6978.965105174441, 6989.091418115612, 7123.361626825756, 7127.536710113826, 6212.844678883064, 6387.265464471552, 6398.29618741938, 6437.066625339299, 6440.516961227927, 1622.0, 1739.956501087483, 1744.7819022622173, 1752.6757549853319, 1783.2064731194494, 837.1293854391365, 874.2044739287218, 899.0649724286799, 910.9726708198765, 971.4025874087527, 17064.56714913668, 18029.7295540567, 18139.343408542085, 18147.818521814614, 18281.725774113398, 855.6278019061729, 856.6530555125184, 868.1925808997693, 886.2289807867197, 923.9974627529072, 9880.35777674449, 10277.17782577392, 10330.328528645614, 10341.37951722899, 10473.214508911862, 372448.0, 377874.0, 384261.0, 386071.0, 386570.0, 71157.6442117786, 71548.64225678942, 71720.64139679268, 71852.2814771856, 72022.27977720261, 851.965921363151, 926.092429419173, 935.7005758157325, 952.5856252530172, 952.9332946693803, 13413.932930335286, 15415.306311215798, 15663.843361566695, 16754.916225418794, 17013.404530841362, 24094.277171684877, 32204.0, 36859.0, 37584.0, 37764.81117594394, 43579.78210109056, 44201.33697994468, 44826.55173448224, 45485.0, 45549.31676024928, 6528.824811533779, 6581.111549940888, 6614.239362473377, 6758.459323254029, 7545.245475452411, 6114.816555503342, 8900.709397137509, 10487.423191724529, 10608.575656973635, 11010.284331518425, 6233.594816337105, 7431.8142046449275, 9377.81244375095, 10021.899781002388, 10369.118624916664, 9853.605855765689, 9871.506424678593, 9907.405555666683, 10042.146417554297, 10251.0, 9612.66355677548, 10069.798604028025, 10258.17934565248, 10377.429241391796, 10457.9477102614, 7356.337929586149, 7486.6256687166515, 7601.353884919844, 7669.233076692286, 7706.884396734165, 10127.79744405093, 10194.592216311265, 10343.586256549654, 10344.224183186141, 10404.219683523615], "value": 8224.46313056462, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1228.533157400188, 1299.7140629061603, 1333.3733145421652, 1666.2751703009199, 1691.627841874787, 7162.785116446508, 7573.9621301893485, 7669.731559395423, 7670.6548205330755, 7672.6930922763095, 6405.29541750407, 6890.965545172279, 7162.570245785257, 7163.391111755507, 7513.323800857922, 2141.8607790493647, 2162.50262439639, 2163.123934806398, 2163.56728654269, 2163.891805409731, 2120.3638908327516, 2154.3859999900033, 2155.9461013474634, 2159.2334721173993, 2160.82713382929, 1809.3305476973537, 1878.2017642501883, 1878.3238034307637, 1886.368066697658, 2055.5580550181708, 2149.419656692692, 2187.0814258011674, 2189.255653077945, 2190.266260802617, 2194.0, 2193.122750899653, 2199.8900054997184, 2209.359285807114, 2213.944651383712, 2220.2562141682556, 7501.24987501251, 7619.4285428593075, 7623.771286861403, 7626.122995855492, 7642.350400215988, 4312.3531470279395, 4444.799984000728, 4451.532589078132, 4456.532064133252, 4464.598186163261, 2824.646919135108, 2881.5821705852536, 2916.6937471565393, 2960.06757871272, 2962.155785601093, 830.6843399508148, 857.0829212742368, 863.0549548244662, 867.119873328572, 870.2689740617911, 9954.0, 9984.301098923079, 9989.051040151247, 9995.400275983464, 10000.699979000568, 3845.288621605012, 4170.103427763045, 4179.0, 4179.686523510749, 4186.225548273579, 8602.61288242018, 8664.61009254585, 8668.263197628272, 8678.088800675965, 8719.084496127814, 4560.452745670541, 4575.0, 4586.0827834432575, 4587.3807036050375, 4606.585407313358, 4134.91730165395, 4200.936985945214, 4205.137946720976, 4208.368744688321, 4219.599138081878, 3479.7738147020364, 3482.0946553895665, 3546.7871927684423, 3569.5716514017963, 3582.8566857325413, 1150.6663067710438, 1167.1654766841748, 1172.9648110556698, 1181.787278289916, 1186.8397766301612, 736.488140742179, 750.9074296898, 815.5514467043103, 822.9177082291723, 841.6591280531395, 4887.926681099786, 5133.897322053538, 5153.330067091254, 5160.148575485078, 5303.7878484860175, 845.0999685335098, 860.4149178558515, 865.1002956924727, 865.4331412924545, 867.9175478329548, 3424.6917777400154, 3481.4255647817827, 3574.7855128692363, 3576.946345804815, 3616.5479315085613, 8944.150305720947, 9254.213391861633, 9324.393914395543, 9350.345475816763, 9352.392094513834, 9189.264858811413, 9200.493972831558, 9212.907870921339, 9224.723258302127, 9241.768955776159, 6587.769428070091, 6828.556143850634, 6890.621015844076, 6978.860422791516, 7039.436845052383, 5226.895462090661, 5259.289995850511, 5299.046171688979, 5343.732813359395, 5359.3032905722, 8188.2630563249595, 8251.752447426346, 8507.234348908629, 8540.231379175904, 8582.828343432971, 8514.829703405774, 8550.315974722133, 8616.870746938926, 8672.913270867211, 8743.868841967249, 6294.087357333253, 6357.618542887441, 6374.93625063762, 6395.744170233324, 6423.871522569429, 6703.530752847254, 6894.827629309308, 6907.516473846783, 6908.1019467468905, 6912.55068420551, 4612.654050946126, 6320.367963203643, 6351.142595749515, 6547.443467305142, 6604.966975165094, 6234.532410069353, 6245.18812554365, 6294.3076261612105, 6316.652584107918, 6514.200997975172, 5521.00621888064, 5543.25166102571, 5568.749406276646, 5883.882322353615, 5905.616134951214, 4489.73061616304, 4568.0, 4601.217792975269, 4605.125026245003, 4730.787114579921, 4272.081502476983, 4351.086271882813, 4371.409859668904, 4449.243628583084, 4453.220686379936], "value": 3985.963760706231, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.25002493467105, 289.67701013370095, 296.8678937872647, 300.361731320943, 302.2760488629732, 4805.135075686375, 4831.661783675144, 4837.3227748115205, 4842.273658951159, 4868.805247790088, 4501.7524036178, 4587.243104887698, 4706.411698537683, 4769.809207631699, 4772.260299653551, 3779.9055023624355, 3804.4293355996683, 3807.58116607173, 3811.8856434306877, 3817.6945844332527, 3807.2385522895393, 3816.9045773855596, 3817.7709337439705, 3831.1188426661884, 3862.86479973201, 3602.2615363850346, 3628.8931875777876, 3752.287065457568, 3756.136088699601, 3760.8683696070643, 3735.831887565066, 3752.230792687506, 3762.7930463824478, 3762.8682996095004, 3801.7834293026244, 3354.0, 3383.4924761285756, 3383.796972181677, 3386.0688310714504, 3387.983060084684, 4359.910022494377, 4690.601298889598, 4727.149113159629, 4739.170645137087, 4740.928886066712, 4209.431726716915, 4233.872983810491, 4263.253930562139, 4267.701260911737, 4279.486461624594, 4987.576056035241, 4998.375203099613, 5007.324011258506, 5016.874578135539, 5038.722870242135, 3541.9291614167573, 3542.742326474116, 3547.1909326243544, 3567.3935430976535, 3574.1422058705984, 4964.453910069889, 5215.496561650429, 5234.8691282717855, 5238.60710446718, 5238.926020165857, 3669.321175582526, 3688.483612294281, 3694.8706795262037, 3698.0, 3698.613020117456, 3732.9626703733156, 3740.345439548068, 3741.5323084614424, 3761.247750449921, 3766.3408903442337, 4148.149629325981, 4202.327627579572, 4220.261454245495, 4283.550227226158, 4295.355696645465, 4965.205567109245, 4966.577840883565, 4966.6771659842, 4976.527229913152, 4994.375703037121, 1232.648695121886, 1252.7932891072871, 1278.4055414232428, 1278.4822147030468, 1296.7925131978839, 863.48622569571, 877.9692710755221, 890.4879694175875, 895.6641259527677, 900.2707806676613, 4358.585934336233, 4369.519352871182, 4377.8248870044845, 4384.47386313638, 4388.912221755547, 5067.214581739836, 5085.059264036091, 5085.74571271435, 5089.949100509021, 5093.821716239988, 4368.4102646143, 4378.963781841396, 4380.474343078788, 4386.539413361615, 4386.736795792199, 2291.46150654596, 2419.6733440985595, 2427.7936375407935, 2432.7497065214607, 2439.097533912464, 4328.5455027222315, 4338.848140315074, 4351.282038463618, 4352.2818734909015, 4403.955960440355, 4573.405457290531, 4588.7935042923145, 4608.654350923694, 4619.3994780678295, 4621.689155422288, 4101.89745256365, 4295.162443323647, 4359.629431498295, 4371.32244502109, 4404.383386325917, 4528.886777830448, 4531.886702832324, 4535.659825513034, 4543.500214976284, 4555.5649970259265, 4507.414036175276, 4514.638828893615, 4516.638668906414, 4521.932171017372, 4536.183486972244, 4132.483439570054, 4285.742855428684, 4330.545292744217, 4362.498312693954, 4370.956290437055, 3354.2117602363915, 3356.395848747249, 3358.261182539837, 3382.5771778527683, 3407.318536292702, 4509.571590698878, 4554.521775213555, 4587.931181032354, 4608.239640459286, 4955.2319390493085, 4808.519148085164, 4997.200447928314, 5003.724795136302, 5009.795689896434, 5029.823956161516, 4935.457099718957, 4941.65408421407, 4950.579200767831, 4971.950280497149, 5011.3963531669515, 4817.686850354716, 4923.852284431473, 4930.556249937523, 4949.158643030765, 4968.527989840959, 4997.475265097112, 5016.448190699093, 5017.84946451607, 5045.217991211368, 5053.949460505495, 4911.410630724193, 4915.149213456259, 4917.926231106465, 4922.458529561817, 4926.605871530197], "value": 3677.060548751334, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [616.8211218746562, 639.1882309466977, 680.8672308899767, 722.4798145335357, 770.2374649097395, 11495.942520287397, 12139.393030348492, 12505.624831255065, 12522.56171034014, 12658.367081645927, 11812.468438920248, 11850.3482308473, 11864.703382415444, 11922.165448418615, 11933.64199074027, 618.8143556932924, 765.7396485195032, 767.0411985018727, 788.2550989315099, 788.787027502574, 797.3023604346197, 797.5453991225004, 798.4091772088642, 800.2677550041734, 800.3757069485781, 831.5135645647304, 832.4672209785742, 833.042001698049, 833.1293797981094, 834.6828205281985, 649.405793698765, 662.6653539962289, 665.0, 665.4576520136073, 824.6618886256636, 576.3544829790619, 598.4015984015984, 599.2180204832691, 599.5143933413949, 600.6996501749126, 10938.726531836688, 10939.56241750329, 10961.671149865517, 10963.890361096446, 10973.615923442641, 12566.560170393992, 12951.870481295255, 13021.869781302255, 13101.754770455314, 13150.276734779583, 11623.825642615368, 11926.821097683542, 12088.395580221042, 12117.515299388015, 12308.81536776949, 4200.432941552882, 4263.424437700933, 4267.317229243306, 4279.721818081845, 4429.092036132585, 58085.419145808846, 58221.70889145527, 59189.704051479464, 59211.0, 59758.99999999956, 10601.522931468102, 10602.734931626772, 10654.840177397346, 10676.199285053497, 10749.0, 19157.233710651697, 19200.0, 19223.711644325347, 19312.61374772497, 19329.51676208106, 6384.52116091295, 6420.5184611154355, 6422.389872962061, 6429.3570642936265, 6684.097646817715, 3772.4718539404507, 3794.71539634523, 3803.7147213959065, 3851.3837785954674, 3857.2092720992127, 2671.839689618629, 2754.118682021774, 2769.8061135720304, 2772.916812495628, 2781.304673831542, 466.1446246138374, 489.59363728105586, 491.8106528986294, 492.3132230538379, 500.45450458999136, 462.95139010404097, 522.9921551176735, 523.377181154425, 535.5715427657858, 536.9624126311121, 7706.730264440717, 7888.684452621946, 7931.960340198378, 7934.920650793533, 8040.437169398086, 513.8997895410433, 516.5764073459727, 535.1223992652053, 538.1685296217354, 540.8864138530953, 3584.5877724061547, 3663.7069034477177, 3804.847806087781, 3917.118648304109, 3940.0937784309767, 86838.56580717055, 91799.95100269416, 93708.0629193713, 93796.0, 93889.5305523468, 65823.34176658173, 74419.25580744231, 78874.0, 80145.59927200327, 80870.7434016787, 67896.0, 69657.0, 69823.30176698168, 69833.65083174653, 72044.0, 8855.512946787989, 9149.954250228706, 9280.535973201448, 9413.670521531714, 9511.857322140311, 42008.369874451295, 44426.0, 44454.55545444504, 44765.77617111894, 45650.54349456463, 54032.44605137315, 63082.36917630765, 64083.35916640774, 64272.67863660652, 64771.67614161899, 11018.205068473422, 11252.493637786156, 11368.715782105513, 11557.364344961108, 11876.0, 13251.403686833923, 13382.13016153947, 13608.863911361155, 13999.44002239899, 14442.783358249424, 11990.792410714412, 12406.751864962469, 12535.498580057061, 12571.377498833119, 12662.0, 12681.492740290285, 12693.682657933625, 12816.615501534969, 12825.871741282841, 12825.935870320589, 10941.0, 12901.741965160832, 12904.354782260662, 12905.096643234883, 13345.266010369523, 10192.388456692623, 10429.634962776267, 10544.26190166681, 10564.471776411303, 10861.619843305447, 9612.615495380387, 9849.507524623883, 9920.751981200528, 10530.947345263225, 10566.735831604272], "value": 6518.661348245916, "unit": "score"}], "name": "dromaeo_css", "value": 6362.452309315709, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 114.0, 115.0, 114.0, 113.0, 113.0, 113.0, 112.0, 114.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 121.0, 123.0, 191.0, 127.0, 128.0, 157.0, 122.0, 163.0, 120.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 161.0, 161.0, 162.0, 162.0, 160.0, 163.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 108.0, 76.0, 86.0, 75.0, 75.0, 99.0, 74.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 126.0, 86.0, 86.0, 85.0, 109.0, 85.0, 85.0, 122.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 65.0, 64.0, 66.0, 64.0, 74.0, 69.0, 65.0, 64.0, 64.0], "value": 66.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 66.0, 64.0, 66.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 78.0, 79.0, 87.0, 79.0, 78.0, 81.0, 83.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 132.0, 131.0, 128.0, 138.0, 130.0, 130.0, 138.0, 177.0, 131.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 169.0, 168.0, 172.0, 173.0, 172.0, 168.0, 175.0, 173.0, 172.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 66.0, 67.0, 66.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1539.3, "alertThreshold": 2.0}]} 03:14:55 INFO - Return code: 0 03:14:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:14:55 INFO - # TBPL SUCCESS # 03:14:55 INFO - Running post-action listener: _resource_record_post_action 03:14:55 INFO - ##### 03:14:55 INFO - ##### Finished run-tests step (success) 03:14:55 INFO - ##### 03:14:55 INFO - Running post-run listener: _resource_record_post_run 03:14:56 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 547205120; Read time: 0; Write time: 420980 03:14:56 INFO - TinderboxPrint: CPU usage
13.0% 03:14:56 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:14:56 INFO - TinderboxPrint: I/O write bytes / time
547,205,120 / 420,980 03:14:56 INFO - TinderboxPrint: CPU idle
8,329.2 (87.0%) 03:14:56 INFO - TinderboxPrint: CPU user
1,205.2 (12.6%) 03:14:56 INFO - TinderboxPrint: Swap in / out
0 / 0 03:14:56 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 258674688; Read time: 0; Write time: 245968 03:14:56 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 288530432; Read time: 0; Write time: 175012 03:14:56 INFO - Running post-run listener: _upload_blobber_files 03:14:56 INFO - Blob upload gear active. 03:14:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:14:56 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 03:14:56 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'] 03:14:56 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 03:14:56 INFO - (blobuploader) - INFO - Open directory for files ... 03:14:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:14:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:14:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:15:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:15:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:15:00 INFO - (blobuploader) - INFO - Done attempting. 03:15:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:15:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:15:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:15:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:15:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:15:01 INFO - (blobuploader) - INFO - Done attempting. 03:15:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:15:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:15:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:15:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:15:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:15:02 INFO - (blobuploader) - INFO - Done attempting. 03:15:02 INFO - (blobuploader) - INFO - Iteration through files over. 03:15:02 INFO - Return code: 0 03:15:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:15:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:15:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d37c1c33d56cec7969a37102bb3785a893b0976aa616d7d61e75b152b8a8aa3c6963f8700c7c8b6a011aa0595093916c808a9e82126144c19fbfbc9377dd0a72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e322534f670322311c8d1eede79d4ab9154a0855f8f2b678f6fc8742959c50f44a6de54fd629c315c6a959b260351183735718d31531354147cb25ceec6530d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/19d6267fbd20030ba67381e3b6940485ae48eb32d593078b46f6f17ae6f4b01b35c2b093d4c139c9b2cfecff36cf4181c2279b9a424b7a17f04e02861b32ed11"} 03:15:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:15:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:15:02 INFO - Contents: 03:15:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d37c1c33d56cec7969a37102bb3785a893b0976aa616d7d61e75b152b8a8aa3c6963f8700c7c8b6a011aa0595093916c808a9e82126144c19fbfbc9377dd0a72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e322534f670322311c8d1eede79d4ab9154a0855f8f2b678f6fc8742959c50f44a6de54fd629c315c6a959b260351183735718d31531354147cb25ceec6530d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/19d6267fbd20030ba67381e3b6940485ae48eb32d593078b46f6f17ae6f4b01b35c2b093d4c139c9b2cfecff36cf4181c2279b9a424b7a17f04e02861b32ed11"} 03:15:02 INFO - Running post-run listener: copy_logs_to_upload_dir 03:15:02 INFO - Copying logs to upload dir... 03:15:02 INFO - mkdir: /builds/slave/test/build/upload/logs 03:15:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.682465 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-13 03:15:02.623722) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 03:15:02.627687) ========= 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=41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068 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/d37c1c33d56cec7969a37102bb3785a893b0976aa616d7d61e75b152b8a8aa3c6963f8700c7c8b6a011aa0595093916c808a9e82126144c19fbfbc9377dd0a72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e322534f670322311c8d1eede79d4ab9154a0855f8f2b678f6fc8742959c50f44a6de54fd629c315c6a959b260351183735718d31531354147cb25ceec6530d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/19d6267fbd20030ba67381e3b6940485ae48eb32d593078b46f6f17ae6f4b01b35c2b093d4c139c9b2cfecff36cf4181c2279b9a424b7a17f04e02861b32ed11"} build_url:https://queue.taskcluster.net/v1/task/Duyqd9QKQ1eIOuunhgjfew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/Duyqd9QKQ1eIOuunhgjfew/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/d37c1c33d56cec7969a37102bb3785a893b0976aa616d7d61e75b152b8a8aa3c6963f8700c7c8b6a011aa0595093916c808a9e82126144c19fbfbc9377dd0a72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e322534f670322311c8d1eede79d4ab9154a0855f8f2b678f6fc8742959c50f44a6de54fd629c315c6a959b260351183735718d31531354147cb25ceec6530d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/19d6267fbd20030ba67381e3b6940485ae48eb32d593078b46f6f17ae6f4b01b35c2b093d4c139c9b2cfecff36cf4181c2279b9a424b7a17f04e02861b32ed11"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 03:15:02.653212) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 03:15:02.653549) ========= 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=41a7e32711b8e08598a63237000001d6-1468403284.260302-693250068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 03:15:02.738567) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 03:15:02.739015) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 03:15:02.740516) ========= ========= Total master_lag: 0.21 =========