builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-068 starttime: 1467819600.95 results: success (0) buildid: 20160706075222 builduid: 30396a0c715a4d07baca85ffd69bf772 revision: 3705eb1dc2cce4582cc3f95af52aeec700801fae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 08:40:00.946813) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 08:40:00.947237) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 08:40:00.947863) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 08:40:01.009654) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 08:40:01.009937) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 08:40:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-07-06 08:40:01 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109166 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 08:40:01.134638) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 08:40:01.134954) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017797 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 08:40:01.189206) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 08:40:01.189569) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3705eb1dc2cce4582cc3f95af52aeec700801fae --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 3705eb1dc2cce4582cc3f95af52aeec700801fae --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=97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 08:40:01,589 truncating revision to first 12 chars 2016-07-06 08:40:01,589 Setting DEBUG logging. 2016-07-06 08:40:01,590 attempt 1/10 2016-07-06 08:40:01,590 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3705eb1dc2cc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 08:40:02,269 unpacking tar archive at: fx-team-3705eb1dc2cc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.021517 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 08:40:02.225383) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 08:40:02.225796) ========= script_repo_revision: 3705eb1dc2cce4582cc3f95af52aeec700801fae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 08:40:02.226285) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 08:40:02.226623) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 08:40:02.237237) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-06 08:40:02.237706) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:40:02 INFO - MultiFileLogger online at 20160706 08:40:02 in /builds/slave/test 08:40:02 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 08:40:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:40:02 INFO - {'append_to_log': False, 08:40:02 INFO - 'base_work_dir': '/builds/slave/test', 08:40:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:40:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:40:02 INFO - 'branch': 'Fx-Team-Non-PGO', 08:40:02 INFO - 'buildbot_json_path': 'buildprops.json', 08:40:02 INFO - 'config_files': ('talos/linux_config.py',), 08:40:02 INFO - 'default_actions': ('clobber', 08:40:02 INFO - 'read-buildbot-config', 08:40:02 INFO - 'download-and-extract', 08:40:02 INFO - 'populate-webroot', 08:40:02 INFO - 'create-virtualenv', 08:40:02 INFO - 'install', 08:40:02 INFO - 'run-tests'), 08:40:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:40:02 INFO - 'download_minidump_stackwalk': True, 08:40:02 INFO - 'download_symbols': 'ondemand', 08:40:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:40:02 INFO - 'tooltool.py': '/tools/tooltool.py', 08:40:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:40:02 INFO - '/tools/misc-python/virtualenv.py')}, 08:40:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:40:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:40:02 INFO - 'installer_path': 'installer.exe', 08:40:02 INFO - 'log_level': 'info', 08:40:02 INFO - 'log_name': 'talos', 08:40:02 INFO - 'log_to_console': True, 08:40:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:40:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:40:02 INFO - 'opt_config_files': (), 08:40:02 INFO - 'pip_index': False, 08:40:02 INFO - 'sps_profile': False, 08:40:02 INFO - 'sps_profile_interval': 0, 08:40:02 INFO - 'suite': 'dromaeojs', 08:40:02 INFO - 'system_bits': '32', 08:40:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:40:02 INFO - 'title': 'talos-linux64-ix-068', 08:40:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:40:02 INFO - 'use_talos_json': True, 08:40:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:40:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:40:02 INFO - 'work_dir': 'build'} 08:40:02 INFO - ##### 08:40:02 INFO - ##### Running clobber step. 08:40:02 INFO - ##### 08:40:02 INFO - Running pre-action listener: _resource_record_pre_action 08:40:02 INFO - Running main action method: clobber 08:40:02 INFO - rmtree: /builds/slave/test/build 08:40:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:40:03 INFO - Running post-action listener: _resource_record_post_action 08:40:03 INFO - ##### 08:40:03 INFO - ##### Finished clobber step (success) 08:40:03 INFO - ##### 08:40:03 INFO - ##### 08:40:03 INFO - ##### Running read-buildbot-config step. 08:40:03 INFO - ##### 08:40:03 INFO - Running pre-action listener: _resource_record_pre_action 08:40:03 INFO - Running main action method: read_buildbot_config 08:40:03 INFO - Using buildbot properties: 08:40:03 INFO - { 08:40:03 INFO - "project": "", 08:40:03 INFO - "product": "firefox", 08:40:03 INFO - "script_repo_revision": "production", 08:40:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:40:03 INFO - "repository": "", 08:40:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:40:03 INFO - "buildid": "20160706075222", 08:40:03 INFO - "pgo_build": "False", 08:40:03 INFO - "basedir": "/builds/slave/test", 08:40:03 INFO - "buildnumber": 1937, 08:40:03 INFO - "slavename": "talos-linux64-ix-068", 08:40:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:40:03 INFO - "platform": "ubuntu64_hw", 08:40:03 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:40:03 INFO - "branch": "fx-team", 08:40:03 INFO - "repo_path": "integration/fx-team", 08:40:03 INFO - "revision": "3705eb1dc2cce4582cc3f95af52aeec700801fae", 08:40:03 INFO - "stage_platform": "linux64", 08:40:03 INFO - "builduid": "30396a0c715a4d07baca85ffd69bf772", 08:40:03 INFO - "slavebuilddir": "test" 08:40:03 INFO - } 08:40:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/KiZeecaPTG2HC5zCggZj6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:40:03 INFO - Running post-action listener: _resource_record_post_action 08:40:03 INFO - ##### 08:40:03 INFO - ##### Finished read-buildbot-config step (success) 08:40:03 INFO - ##### 08:40:03 INFO - ##### 08:40:03 INFO - ##### Running download-and-extract step. 08:40:03 INFO - ##### 08:40:03 INFO - Running pre-action listener: _resource_record_pre_action 08:40:03 INFO - Running main action method: download_and_extract 08:40:03 INFO - mkdir: /builds/slave/test/build/tests 08:40:03 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')]} 08:40:03 INFO - https://queue.taskcluster.net/v1/task/KiZeecaPTG2HC5zCggZj6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:40:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiZeecaPTG2HC5zCggZj6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:40:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiZeecaPTG2HC5zCggZj6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:40:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiZeecaPTG2HC5zCggZj6Q/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 08:40:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiZeecaPTG2HC5zCggZj6Q/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 08:40:12 INFO - Downloaded 1361 bytes. 08:40:12 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:40:12 INFO - Using the following test package requirements: 08:40:12 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:40:12 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:40:12 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:40:12 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:12 INFO - u'jsshell-linux-x86_64.zip'], 08:40:12 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:40:12 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:40:12 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:40:12 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:40:12 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:40:12 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:40:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:40: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')]} 08:40:12 INFO - https://queue.taskcluster.net/v1/task/KiZeecaPTG2HC5zCggZj6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:40:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiZeecaPTG2HC5zCggZj6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:40:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiZeecaPTG2HC5zCggZj6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:40:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiZeecaPTG2HC5zCggZj6Q/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 08:40:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiZeecaPTG2HC5zCggZj6Q/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 08:40:23 INFO - Downloaded 22730934 bytes. 08:40:23 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'] 08:40:23 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 08:40:24 INFO - Return code: 0 08:40:24 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 08:40:24 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')]} 08:40:24 INFO - https://queue.taskcluster.net/v1/task/KiZeecaPTG2HC5zCggZj6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:40:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiZeecaPTG2HC5zCggZj6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:40:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiZeecaPTG2HC5zCggZj6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:40:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiZeecaPTG2HC5zCggZj6Q/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 08:40:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiZeecaPTG2HC5zCggZj6Q/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 08:40:26 INFO - Downloaded 22730934 bytes. 08:40:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:40:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:40:27 INFO - Return code: 0 08:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:27 INFO - https://queue.taskcluster.net/v1/task/KiZeecaPTG2HC5zCggZj6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:40:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiZeecaPTG2HC5zCggZj6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:40:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiZeecaPTG2HC5zCggZj6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:40:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiZeecaPTG2HC5zCggZj6Q/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 08:40:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiZeecaPTG2HC5zCggZj6Q/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 08:40:28 INFO - Downloaded 14403333 bytes. 08:40:28 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'] 08:40:28 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 08:40:28 INFO - Return code: 0 08:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:28 INFO - https://queue.taskcluster.net/v1/task/KiZeecaPTG2HC5zCggZj6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:40:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiZeecaPTG2HC5zCggZj6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:40:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiZeecaPTG2HC5zCggZj6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:40:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiZeecaPTG2HC5zCggZj6Q/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 08:40:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiZeecaPTG2HC5zCggZj6Q/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 08:40:30 INFO - Downloaded 56470162 bytes. 08:40:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KiZeecaPTG2HC5zCggZj6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:40:30 INFO - mkdir: /builds/slave/test/properties 08:40:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:40:30 INFO - Writing to file /builds/slave/test/properties/build_url 08:40:30 INFO - Contents: 08:40:30 INFO - build_url:https://queue.taskcluster.net/v1/task/KiZeecaPTG2HC5zCggZj6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:40:30 INFO - Running post-action listener: _resource_record_post_action 08:40:30 INFO - Running post-action listener: set_extra_try_arguments 08:40:30 INFO - ##### 08:40:30 INFO - ##### Finished download-and-extract step (success) 08:40:30 INFO - ##### 08:40:30 INFO - ##### 08:40:30 INFO - ##### Running populate-webroot step. 08:40:30 INFO - ##### 08:40:30 INFO - Running pre-action listener: _resource_record_pre_action 08:40:30 INFO - Running main action method: populate_webroot 08:40:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:40:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:40:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:40:30 INFO - '--tppagecycles', 08:40:30 INFO - '7'], 08:40:30 INFO - 'tests': ['tsvgm']}}, 08:40:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:40:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:40:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:40:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:40:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:40:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:40:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:30 INFO - 'talos_options': ['--disable-e10s'], 08:40:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:30 INFO - 'talos_options': ['--disable-e10s'], 08:40:30 INFO - 'tests': ['damp', 'tps']}, 08:40:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:30 INFO - 'tests': ['damp', 'tps']}, 08:40:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:40:30 INFO - 'tests': ['dromaeo_dom']}, 08:40:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:40:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:40:30 INFO - 'tests': ['basic_compositor_video']}, 08:40:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:40:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:40:30 INFO - 'tests': ['a11yr', 08:40:30 INFO - 'ts_paint', 08:40:30 INFO - 'tpaint', 08:40:30 INFO - 'sessionrestore', 08:40:30 INFO - 'sessionrestore_no_auto_restore', 08:40:30 INFO - 'tabpaint']}, 08:40:30 INFO - 'other-e10s': {'tests': ['a11yr', 08:40:30 INFO - 'ts_paint', 08:40:30 INFO - 'tpaint', 08:40:30 INFO - 'sessionrestore', 08:40:30 INFO - 'sessionrestore_no_auto_restore', 08:40:30 INFO - 'tabpaint']}, 08:40:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:40:30 INFO - 'ts_paint', 08:40:30 INFO - 'tpaint', 08:40:30 INFO - 'sessionrestore', 08:40:30 INFO - 'sessionrestore_no_auto_restore', 08:40:30 INFO - 'tabpaint']}, 08:40:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:40:30 INFO - 'ts_paint', 08:40:30 INFO - 'tpaint', 08:40:30 INFO - 'sessionrestore', 08:40:30 INFO - 'sessionrestore_no_auto_restore', 08:40:30 INFO - 'tabpaint']}, 08:40:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:40:30 INFO - 'tests': ['a11yr', 08:40:30 INFO - 'ts_paint', 08:40:30 INFO - 'tpaint', 08:40:30 INFO - 'sessionrestore', 08:40:30 INFO - 'sessionrestore_no_auto_restore', 08:40:30 INFO - 'tabpaint']}, 08:40:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:40:30 INFO - 'tests': ['a11yr', 08:40:30 INFO - 'ts_paint', 08:40:30 INFO - 'tpaint', 08:40:30 INFO - 'sessionrestore', 08:40:30 INFO - 'sessionrestore_no_auto_restore', 08:40:30 INFO - 'tabpaint']}, 08:40:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:40:30 INFO - 'tests': ['tsvgx', 08:40:30 INFO - 'tsvgr_opacity', 08:40:30 INFO - 'tart', 08:40:30 INFO - 'tscrollx', 08:40:30 INFO - 'cart']}, 08:40:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:40:30 INFO - 'tsvgr_opacity', 08:40:30 INFO - 'tart', 08:40:30 INFO - 'tscrollx', 08:40:30 INFO - 'cart']}, 08:40:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:30 INFO - 'talos_options': ['--disable-e10s'], 08:40:30 INFO - 'tests': ['tp5o']}, 08:40:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:30 INFO - 'tests': ['tp5o']}, 08:40:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:30 INFO - 'talos_options': ['--disable-e10s', 08:40:30 INFO - '--xperf_path', 08:40:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:30 INFO - 'tests': ['tp5n']}, 08:40:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:30 INFO - 'talos_options': ['--xperf_path', 08:40:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:30 INFO - 'tests': ['tp5n']}}, 08:40:30 INFO - 'talos.zip': {'path': '', 08:40:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:40:30 INFO - Running post-action listener: _resource_record_post_action 08:40:30 INFO - ##### 08:40:30 INFO - ##### Finished populate-webroot step (success) 08:40:30 INFO - ##### 08:40:30 INFO - ##### 08:40:30 INFO - ##### Running create-virtualenv step. 08:40:30 INFO - ##### 08:40:30 INFO - Running pre-action listener: _resource_record_pre_action 08:40:30 INFO - Running main action method: create_virtualenv 08:40:30 INFO - Creating virtualenv /builds/slave/test/build/venv 08:40:30 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 08:40:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:40:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:40:31 INFO - Using real prefix '/usr' 08:40:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:40:31 INFO - Installing distribute.............................................................................................................................................................................................done. 08:40:33 INFO - Installing pip.................done. 08:40:33 INFO - Return code: 0 08:40:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b73b0>, '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 0x28b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b8740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144', '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 08:40:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:40:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:40:33 INFO - Using env: {'DISPLAY': ':0', 08:40:33 INFO - 'HOME': '/home/cltbld', 08:40:33 INFO - 'LANG': 'en_US.UTF-8', 08:40:33 INFO - 'LANGUAGE': 'en_US:en', 08:40:33 INFO - 'LOGNAME': 'cltbld', 08:40:33 INFO - 'MAIL': '/var/mail/cltbld', 08:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:33 INFO - 'MOZ_NO_REMOTE': '1', 08:40:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:33 INFO - 'NO_EM_RESTART': '1', 08:40:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:33 INFO - 'PWD': '/builds/slave/test', 08:40:33 INFO - 'SHELL': '/bin/bash', 08:40:33 INFO - 'SHLVL': '1', 08:40:33 INFO - 'TERM': 'linux', 08:40:33 INFO - 'TMOUT': '86400', 08:40:33 INFO - 'USER': 'cltbld', 08:40:33 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144', 08:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:33 INFO - '_': '/tools/buildbot/bin/python'} 08:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:33 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 08:40:33 INFO - Cleaning up... 08:40:33 INFO - Return code: 0 08:40:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b73b0>, '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 0x28b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b8740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144', '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 08:40:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:40:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:40:33 INFO - Using env: {'DISPLAY': ':0', 08:40:33 INFO - 'HOME': '/home/cltbld', 08:40:33 INFO - 'LANG': 'en_US.UTF-8', 08:40:33 INFO - 'LANGUAGE': 'en_US:en', 08:40:33 INFO - 'LOGNAME': 'cltbld', 08:40:33 INFO - 'MAIL': '/var/mail/cltbld', 08:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:33 INFO - 'MOZ_NO_REMOTE': '1', 08:40:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:33 INFO - 'NO_EM_RESTART': '1', 08:40:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:33 INFO - 'PWD': '/builds/slave/test', 08:40:33 INFO - 'SHELL': '/bin/bash', 08:40:33 INFO - 'SHLVL': '1', 08:40:33 INFO - 'TERM': 'linux', 08:40:33 INFO - 'TMOUT': '86400', 08:40:33 INFO - 'USER': 'cltbld', 08:40:33 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144', 08:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:33 INFO - '_': '/tools/buildbot/bin/python'} 08:40:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:34 INFO - Downloading/unpacking psutil>=3.1.1 08:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:40:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:36 INFO - Installing collected packages: psutil 08:40:36 INFO - Running setup.py install for psutil 08:40:36 INFO - building 'psutil._psutil_linux' extension 08:40:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:40:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:40:36 INFO - building 'psutil._psutil_posix' extension 08:40:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:40:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:40:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:36 INFO - Successfully installed psutil 08:40:36 INFO - Cleaning up... 08:40:36 INFO - Return code: 0 08:40:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b73b0>, '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 0x28b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b8740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144', '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 08:40: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:40: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 mozsystemmonitor==0.3 08:40:36 INFO - Using env: {'DISPLAY': ':0', 08:40:36 INFO - 'HOME': '/home/cltbld', 08:40:36 INFO - 'LANG': 'en_US.UTF-8', 08:40:36 INFO - 'LANGUAGE': 'en_US:en', 08:40:36 INFO - 'LOGNAME': 'cltbld', 08:40:36 INFO - 'MAIL': '/var/mail/cltbld', 08:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:36 INFO - 'MOZ_NO_REMOTE': '1', 08:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:36 INFO - 'NO_EM_RESTART': '1', 08:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:36 INFO - 'PWD': '/builds/slave/test', 08:40:36 INFO - 'SHELL': '/bin/bash', 08:40:36 INFO - 'SHLVL': '1', 08:40:36 INFO - 'TERM': 'linux', 08:40:36 INFO - 'TMOUT': '86400', 08:40:36 INFO - 'USER': 'cltbld', 08:40:36 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144', 08:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:36 INFO - '_': '/tools/buildbot/bin/python'} 08:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:40:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:40:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:40:38 INFO - Installing collected packages: mozsystemmonitor 08:40:38 INFO - Running setup.py install for mozsystemmonitor 08:40:38 INFO - Successfully installed mozsystemmonitor 08:40:38 INFO - Cleaning up... 08:40:38 INFO - Return code: 0 08:40:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:40:38 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')]} 08:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:38 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')]} 08:40:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:38 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 0x25f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b73b0>, '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 0x28b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b8740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144', '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 08:40:38 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 08:40:38 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 08:40:38 INFO - Using env: {'DISPLAY': ':0', 08:40:38 INFO - 'HOME': '/home/cltbld', 08:40:38 INFO - 'LANG': 'en_US.UTF-8', 08:40:38 INFO - 'LANGUAGE': 'en_US:en', 08:40:38 INFO - 'LOGNAME': 'cltbld', 08:40:38 INFO - 'MAIL': '/var/mail/cltbld', 08:40:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:38 INFO - 'MOZ_NO_REMOTE': '1', 08:40:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:38 INFO - 'NO_EM_RESTART': '1', 08:40:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:38 INFO - 'PWD': '/builds/slave/test', 08:40:38 INFO - 'SHELL': '/bin/bash', 08:40:38 INFO - 'SHLVL': '1', 08:40:38 INFO - 'TERM': 'linux', 08:40:38 INFO - 'TMOUT': '86400', 08:40:38 INFO - 'USER': 'cltbld', 08:40:38 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144', 08:40:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:38 INFO - '_': '/tools/buildbot/bin/python'} 08:40:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:39 INFO - Downloading/unpacking jsonschema==2.5.1 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:40:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:41 INFO - Downloading functools32-3.2.3-2.tar.gz 08:40:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:40:41 INFO - warning: no files found matching '*.txt' 08:40:41 INFO - no previously-included directories found matching 'build' 08:40:41 INFO - no previously-included directories found matching 'dist' 08:40:41 INFO - no previously-included directories found matching '.git*' 08:40:41 INFO - Installing collected packages: jsonschema, functools32 08:40:41 INFO - Running setup.py install for functools32 08:40:41 INFO - warning: no files found matching '*.txt' 08:40:41 INFO - no previously-included directories found matching 'build' 08:40:41 INFO - no previously-included directories found matching 'dist' 08:40:41 INFO - no previously-included directories found matching '.git*' 08:40:41 INFO - Successfully installed jsonschema functools32 08:40:41 INFO - Cleaning up... 08:40:41 INFO - Return code: 0 08:40:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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', '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 0x25f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b73b0>, '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 0x28b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b8740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144', '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 08:40: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:40: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 blobuploader==1.2.4 08:40:41 INFO - Using env: {'DISPLAY': ':0', 08:40:41 INFO - 'HOME': '/home/cltbld', 08:40:41 INFO - 'LANG': 'en_US.UTF-8', 08:40:41 INFO - 'LANGUAGE': 'en_US:en', 08:40:41 INFO - 'LOGNAME': 'cltbld', 08:40:41 INFO - 'MAIL': '/var/mail/cltbld', 08:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:41 INFO - 'MOZ_NO_REMOTE': '1', 08:40:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:41 INFO - 'NO_EM_RESTART': '1', 08:40:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:41 INFO - 'PWD': '/builds/slave/test', 08:40:41 INFO - 'SHELL': '/bin/bash', 08:40:41 INFO - 'SHLVL': '1', 08:40:41 INFO - 'TERM': 'linux', 08:40:41 INFO - 'TMOUT': '86400', 08:40:41 INFO - 'USER': 'cltbld', 08:40:41 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144', 08:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:41 INFO - '_': '/tools/buildbot/bin/python'} 08:40:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:41 INFO - Downloading/unpacking blobuploader==1.2.4 08:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:43 INFO - Downloading blobuploader-1.2.4.tar.gz 08:40:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:40:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:40:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40:44 INFO - Downloading docopt-0.6.1.tar.gz 08:40:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:40:44 INFO - Installing collected packages: blobuploader, requests, docopt 08:40:44 INFO - Running setup.py install for blobuploader 08:40:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:40:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:40:44 INFO - Running setup.py install for requests 08:40:44 INFO - Running setup.py install for docopt 08:40:45 INFO - Successfully installed blobuploader requests docopt 08:40:45 INFO - Cleaning up... 08:40:45 INFO - Return code: 0 08:40:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b73b0>, '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 0x28b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b8740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144', '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 08:40:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:40:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:40:45 INFO - Using env: {'DISPLAY': ':0', 08:40:45 INFO - 'HOME': '/home/cltbld', 08:40:45 INFO - 'LANG': 'en_US.UTF-8', 08:40:45 INFO - 'LANGUAGE': 'en_US:en', 08:40:45 INFO - 'LOGNAME': 'cltbld', 08:40:45 INFO - 'MAIL': '/var/mail/cltbld', 08:40:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:45 INFO - 'MOZ_NO_REMOTE': '1', 08:40:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:45 INFO - 'NO_EM_RESTART': '1', 08:40:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:45 INFO - 'PWD': '/builds/slave/test', 08:40:45 INFO - 'SHELL': '/bin/bash', 08:40:45 INFO - 'SHLVL': '1', 08:40:45 INFO - 'TERM': 'linux', 08:40:45 INFO - 'TMOUT': '86400', 08:40:45 INFO - 'USER': 'cltbld', 08:40:45 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144', 08:40:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:45 INFO - '_': '/tools/buildbot/bin/python'} 08:40:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:40:45 INFO - Running setup.py (path:/tmp/pip-A1yrQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:40:45 INFO - Running setup.py (path:/tmp/pip-xjtgDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:40:45 INFO - Running setup.py (path:/tmp/pip-ajolb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:40:45 INFO - Running setup.py (path:/tmp/pip-pqCW3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:40:45 INFO - Running setup.py (path:/tmp/pip-Qrydea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:40:45 INFO - Running setup.py (path:/tmp/pip-YYfFo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:40:45 INFO - Running setup.py (path:/tmp/pip-JoXksu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:40:45 INFO - Running setup.py (path:/tmp/pip-4bm55w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:40:45 INFO - Running setup.py (path:/tmp/pip-g2LQby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:40:45 INFO - Running setup.py (path:/tmp/pip-FPMMJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:40:46 INFO - Running setup.py (path:/tmp/pip-5LWTob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:40:46 INFO - Running setup.py (path:/tmp/pip-N7Hb7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:40:46 INFO - Running setup.py (path:/tmp/pip-R75qXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:40:46 INFO - Running setup.py (path:/tmp/pip-DdhN9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:46 INFO - Running setup.py (path:/tmp/pip-NxX3IX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:40:46 INFO - Running setup.py (path:/tmp/pip-vYvlP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:40:46 INFO - Running setup.py (path:/tmp/pip-A8JNYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:40:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:40:46 INFO - Running setup.py install for manifestparser 08:40:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:40:46 INFO - Running setup.py install for mozcrash 08:40:46 INFO - Running setup.py install for mozdebug 08:40:46 INFO - Running setup.py install for mozdevice 08:40:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:40:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:40:47 INFO - Running setup.py install for mozfile 08:40:47 INFO - Running setup.py install for mozhttpd 08:40:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:40:47 INFO - Running setup.py install for mozinfo 08:40:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:40:47 INFO - Running setup.py install for mozInstall 08:40:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:40:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:40:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:40:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:40:47 INFO - Running setup.py install for mozleak 08:40:47 INFO - Running setup.py install for mozlog 08:40:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:40:47 INFO - Running setup.py install for moznetwork 08:40:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:40:47 INFO - Running setup.py install for mozprocess 08:40:47 INFO - Running setup.py install for mozprofile 08:40:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:40:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:40:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:40:47 INFO - Running setup.py install for mozrunner 08:40:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:40:48 INFO - Running setup.py install for mozscreenshot 08:40:48 INFO - Running setup.py install for moztest 08:40:48 INFO - Running setup.py install for mozversion 08:40:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:40:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:40:48 INFO - Cleaning up... 08:40:48 INFO - Return code: 0 08:40:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b73b0>, '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 0x28b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b8740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144', '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 08:40:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:40:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:40:48 INFO - Using env: {'DISPLAY': ':0', 08:40:48 INFO - 'HOME': '/home/cltbld', 08:40:48 INFO - 'LANG': 'en_US.UTF-8', 08:40:48 INFO - 'LANGUAGE': 'en_US:en', 08:40:48 INFO - 'LOGNAME': 'cltbld', 08:40:48 INFO - 'MAIL': '/var/mail/cltbld', 08:40:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:48 INFO - 'MOZ_NO_REMOTE': '1', 08:40:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:48 INFO - 'NO_EM_RESTART': '1', 08:40:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:48 INFO - 'PWD': '/builds/slave/test', 08:40:48 INFO - 'SHELL': '/bin/bash', 08:40:48 INFO - 'SHLVL': '1', 08:40:48 INFO - 'TERM': 'linux', 08:40:48 INFO - 'TMOUT': '86400', 08:40:48 INFO - 'USER': 'cltbld', 08:40:48 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144', 08:40:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:48 INFO - '_': '/tools/buildbot/bin/python'} 08:40:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:40:48 INFO - Running setup.py (path:/tmp/pip-yNYG1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:40:48 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)) 08:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:40:48 INFO - Running setup.py (path:/tmp/pip-BXyVK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:40:48 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)) 08:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:40:48 INFO - Running setup.py (path:/tmp/pip-OBf_Jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:40:48 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)) 08:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:40:48 INFO - Running setup.py (path:/tmp/pip-VKCB0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:40:48 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)) 08:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:40:48 INFO - Running setup.py (path:/tmp/pip-nF17Ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:40:48 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)) 08:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:40:48 INFO - Running setup.py (path:/tmp/pip-ZrCukQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:40:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:40:49 INFO - Running setup.py (path:/tmp/pip-iPmFUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:40:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:40:49 INFO - Running setup.py (path:/tmp/pip-AAVBki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:40:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:40:49 INFO - Running setup.py (path:/tmp/pip-RqyGUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:40:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:40:49 INFO - Running setup.py (path:/tmp/pip-kM3Hya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:40:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:40:49 INFO - Running setup.py (path:/tmp/pip-jAEBWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:40:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:40:49 INFO - Running setup.py (path:/tmp/pip-iFHrkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:40:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:40:49 INFO - Running setup.py (path:/tmp/pip-X3HLlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:40:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:40:49 INFO - Running setup.py (path:/tmp/pip-LEIeCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:40:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:49 INFO - Running setup.py (path:/tmp/pip-YPcXnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:49 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)) 08:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:40:49 INFO - Running setup.py (path:/tmp/pip-gHGD0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:40:49 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)) 08:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:40:49 INFO - Running setup.py (path:/tmp/pip-qM_HOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:40:49 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)) 08:40:49 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)) 08:40:49 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)) 08:40:49 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)) 08:40:49 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)) 08:40:49 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)) 08:40:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:51 INFO - Downloading blessings-1.6.tar.gz 08:40:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:40:51 INFO - Installing collected packages: blessings 08:40:51 INFO - Running setup.py install for blessings 08:40:51 INFO - Successfully installed blessings 08:40:51 INFO - Cleaning up... 08:40:51 INFO - Return code: 0 08:40:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:40:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:40:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:40:52 INFO - Reading from file tmpfile_stdout 08:40:52 INFO - Current package versions: 08:40:52 INFO - argparse == 1.2.1 08:40:52 INFO - blessings == 1.6 08:40:52 INFO - blobuploader == 1.2.4 08:40:52 INFO - docopt == 0.6.1 08:40:52 INFO - functools32 == 3.2.3-2 08:40:52 INFO - jsonschema == 2.5.1 08:40:52 INFO - manifestparser == 1.1 08:40:52 INFO - mozInstall == 1.12 08:40:52 INFO - mozcrash == 0.17 08:40:52 INFO - mozdebug == 0.1 08:40:52 INFO - mozdevice == 0.48 08:40:52 INFO - mozfile == 1.2 08:40:52 INFO - mozhttpd == 0.7 08:40:52 INFO - mozinfo == 0.9 08:40:52 INFO - mozleak == 0.1 08:40:52 INFO - mozlog == 3.2 08:40:52 INFO - moznetwork == 0.27 08:40:52 INFO - mozprocess == 0.22 08:40:52 INFO - mozprofile == 0.28 08:40:52 INFO - mozrunner == 6.11 08:40:52 INFO - mozscreenshot == 0.1 08:40:52 INFO - mozsystemmonitor == 0.3 08:40:52 INFO - moztest == 0.7 08:40:52 INFO - mozversion == 1.4 08:40:52 INFO - psutil == 3.1.1 08:40:52 INFO - requests == 1.2.3 08:40:52 INFO - wsgiref == 0.1.2 08:40:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b73b0>, '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 0x28b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b8740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144', '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 08:40:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:40:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:40:52 INFO - Using env: {'DISPLAY': ':0', 08:40:52 INFO - 'HOME': '/home/cltbld', 08:40:52 INFO - 'LANG': 'en_US.UTF-8', 08:40:52 INFO - 'LANGUAGE': 'en_US:en', 08:40:52 INFO - 'LOGNAME': 'cltbld', 08:40:52 INFO - 'MAIL': '/var/mail/cltbld', 08:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:52 INFO - 'MOZ_NO_REMOTE': '1', 08:40:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:52 INFO - 'NO_EM_RESTART': '1', 08:40:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:52 INFO - 'PWD': '/builds/slave/test', 08:40:52 INFO - 'SHELL': '/bin/bash', 08:40:52 INFO - 'SHLVL': '1', 08:40:52 INFO - 'TERM': 'linux', 08:40:52 INFO - 'TMOUT': '86400', 08:40:52 INFO - 'USER': 'cltbld', 08:40:52 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144', 08:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:52 INFO - '_': '/tools/buildbot/bin/python'} 08:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:40:52 INFO - Cleaning up... 08:40:52 INFO - Return code: 0 08:40:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b73b0>, '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 0x28b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b8740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144', '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 08:40:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:40:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:40:52 INFO - Using env: {'DISPLAY': ':0', 08:40:52 INFO - 'HOME': '/home/cltbld', 08:40:52 INFO - 'LANG': 'en_US.UTF-8', 08:40:52 INFO - 'LANGUAGE': 'en_US:en', 08:40:52 INFO - 'LOGNAME': 'cltbld', 08:40:52 INFO - 'MAIL': '/var/mail/cltbld', 08:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:52 INFO - 'MOZ_NO_REMOTE': '1', 08:40:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:52 INFO - 'NO_EM_RESTART': '1', 08:40:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:52 INFO - 'PWD': '/builds/slave/test', 08:40:52 INFO - 'SHELL': '/bin/bash', 08:40:52 INFO - 'SHLVL': '1', 08:40:52 INFO - 'TERM': 'linux', 08:40:52 INFO - 'TMOUT': '86400', 08:40:52 INFO - 'USER': 'cltbld', 08:40:52 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144', 08:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:52 INFO - '_': '/tools/buildbot/bin/python'} 08:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:40:52 INFO - Cleaning up... 08:40:52 INFO - Return code: 0 08:40:52 INFO - Running post-action listener: _resource_record_post_action 08:40:52 INFO - Running post-action listener: _start_resource_monitoring 08:40:52 INFO - Starting resource monitoring. 08:40:52 INFO - ##### 08:40:52 INFO - ##### Finished create-virtualenv step (success) 08:40:52 INFO - ##### 08:40:52 INFO - ##### 08:40:52 INFO - ##### Running install step. 08:40:52 INFO - ##### 08:40:52 INFO - Running pre-action listener: _resource_record_pre_action 08:40:52 INFO - Running main action method: install 08:40:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:40:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:40:52 INFO - Reading from file tmpfile_stdout 08:40:52 INFO - Detecting whether we're running mozinstall >=1.0... 08:40:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:40:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:40:52 INFO - Reading from file tmpfile_stdout 08:40:52 INFO - Output received: 08:40:52 INFO - Usage: mozinstall [options] installer 08:40:52 INFO - Options: 08:40:52 INFO - -h, --help show this help message and exit 08:40:52 INFO - -d DEST, --destination=DEST 08:40:52 INFO - Directory to install application into. [default: 08:40:52 INFO - "/builds/slave/test"] 08:40:52 INFO - --app=APP Application being installed. [default: firefox] 08:40:52 INFO - mkdir: /builds/slave/test/build/application 08:40:52 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'] 08:40:52 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 08:41:09 INFO - Reading from file tmpfile_stdout 08:41:09 INFO - Output received: 08:41:09 INFO - /builds/slave/test/build/application/firefox/firefox 08:41:09 INFO - Running post-action listener: _resource_record_post_action 08:41:09 INFO - ##### 08:41:09 INFO - ##### Finished install step (success) 08:41:09 INFO - ##### 08:41:09 INFO - ##### 08:41:09 INFO - ##### Running run-tests step. 08:41:09 INFO - ##### 08:41:09 INFO - Running pre-action listener: _resource_record_pre_action 08:41:09 INFO - Running main action method: run_tests 08:41:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:41:09 INFO - Python 2.7.3 08:41:09 INFO - Return code: 0 08:41:09 INFO - grabbing minidump binary from tooltool 08:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:09 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b73b0>, '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 0x28b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b8740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:41:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:41:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:41:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:41:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:41:09 INFO - Return code: 0 08:41:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:41:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:41:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:41:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:41:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:41:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KiZeecaPTG2HC5zCggZj6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 08:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KiZeecaPTG2HC5zCggZj6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 08:41:09 INFO - Using env: {'DISPLAY': ':0', 08:41:09 INFO - 'HOME': '/home/cltbld', 08:41:09 INFO - 'LANG': 'en_US.UTF-8', 08:41:09 INFO - 'LANGUAGE': 'en_US:en', 08:41:09 INFO - 'LOGNAME': 'cltbld', 08:41:09 INFO - 'MAIL': '/var/mail/cltbld', 08:41:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:41:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:09 INFO - 'MOZ_NO_REMOTE': '1', 08:41:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:09 INFO - 'NO_EM_RESTART': '1', 08:41:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:09 INFO - 'PWD': '/builds/slave/test', 08:41:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:41:09 INFO - 'SHELL': '/bin/bash', 08:41:09 INFO - 'SHLVL': '1', 08:41:09 INFO - 'TERM': 'linux', 08:41:09 INFO - 'TMOUT': '86400', 08:41:09 INFO - 'USER': 'cltbld', 08:41:09 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144', 08:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:09 INFO - '_': '/tools/buildbot/bin/python'} 08:41:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KiZeecaPTG2HC5zCggZj6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 08:41:09 INFO - mozversion application_buildid: 20160706075222 08:41:09 INFO - mozversion application_changeset: 3705eb1dc2cce4582cc3f95af52aeec700801fae 08:41:09 INFO - mozversion application_display_name: Nightly 08:41:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:41:09 INFO - mozversion application_name: Firefox 08:41:09 INFO - mozversion application_remotingname: firefox 08:41:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:41:09 INFO - mozversion application_vendor: Mozilla 08:41:09 INFO - mozversion application_version: 50.0a1 08:41:09 INFO - mozversion platform_buildid: 20160706075222 08:41:09 INFO - mozversion platform_changeset: 3705eb1dc2cce4582cc3f95af52aeec700801fae 08:41:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:41:09 INFO - mozversion platform_version: 50.0a1 08:41:09 INFO - using testdate: 1467819669 08:41:09 INFO - actual date: 1467819669 08:41:09 INFO - starting webserver on 'localhost:56007' 08:41:09 INFO - SUITE-START | Running 2 tests 08:41:09 INFO - TEST-START | dromaeo_css 08:41:09 INFO - operating with platform_type : linux_ 08:41:09 INFO - Initialising browser for dromaeo_css test... 08:41:09 INFO - TEST-INFO | started process 7964 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVnaBR9/profile http://localhost:56007/getInfo.html) 08:41:14 INFO - PROCESS | 7964 | __metrics Screen width/height:1600/1200 08:41:14 INFO - PROCESS | 7964 | colorDepth:24 08:41:14 INFO - PROCESS | 7964 | Browser inner width/height: 1024/697 08:41:14 INFO - PROCESS | 7964 | __metrics 08:41:15 INFO - PROCESS | 7964 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:41:16 INFO - TEST-INFO | 7964: exit 0 08:41:16 INFO - Browser initialized. 08:41:16 INFO - Running cycle 1/1 for dromaeo_css test... 08:41:16 INFO - TEST-INFO | started process 8046 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVnaBR9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:28 INFO - PROCESS | 8046 | RSS: Main: 158846976 08:41:28 INFO - PROCESS | 8046 | 08:42:20 INFO - PROCESS | 8046 | 1467819740199 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] 08:44:32 INFO - PROCESS | 8046 | Cycle 1(1): loaded http://localhost:56007/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56007/tests/dromaeo/cssquery-ext.html) 08:44:33 INFO - PROCESS | 8046 | RSS: Main: 262201344 08:44:33 INFO - PROCESS | 8046 | 08:47:35 INFO - PROCESS | 8046 | Cycle 1(1): loaded http://localhost:56007/tests/dromaeo/cssquery-ext.html (next: http://localhost:56007/tests/dromaeo/cssquery-jquery.html) 08:47:36 INFO - PROCESS | 8046 | RSS: Main: 236814336 08:47:36 INFO - PROCESS | 8046 | 08:50:38 INFO - PROCESS | 8046 | Cycle 1(1): loaded http://localhost:56007/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56007/tests/dromaeo/cssquery-mootools.html) 08:50:39 INFO - PROCESS | 8046 | RSS: Main: 233955328 08:50:39 INFO - PROCESS | 8046 | 08:53:41 INFO - PROCESS | 8046 | Cycle 1(1): loaded http://localhost:56007/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56007/tests/dromaeo/cssquery-prototype.html) 08:53:41 INFO - PROCESS | 8046 | RSS: Main: 238952448 08:53:41 INFO - PROCESS | 8046 | 08:56:45 INFO - PROCESS | 8046 | Cycle 1(1): loaded http://localhost:56007/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56007/tests/dromaeo/cssquery-yui.html) 08:56:45 INFO - PROCESS | 8046 | RSS: Main: 225800192 08:56:45 INFO - PROCESS | 8046 | 08:59:48 INFO - PROCESS | 8046 | Cycle 1(1): loaded http://localhost:56007/tests/dromaeo/cssquery-yui.html (next: http://localhost:56007/tests/dromaeo/cssquery-dojo.html) 08:59:48 INFO - PROCESS | 8046 | RSS: Main: 283615232 08:59:48 INFO - PROCESS | 8046 | 08:59:48 INFO - PROCESS | 8046 | __start_tp_report 08:59:48 INFO - PROCESS | 8046 | _x_x_mozilla_page_load 08:59:48 INFO - PROCESS | 8046 | _x_x_mozilla_page_load_details 08:59:48 INFO - PROCESS | 8046 | |i|pagename|runs| 08:59:48 INFO - PROCESS | 8046 | |0;dojo.html;2593.3386986318487;2597.3766296088943;2648.2717252755497;2653.4958357911983;2658.3619931216513;4620;4667;4701.15379231739;4703.835365762195;4723.787429565669;4641.860744177671;4700.647451441138;4715.811367545294;4716.905661886769;4759.809607615691;4249.553796851333;4280.764557949312;4289.9356509652225;4335.349697545362;4340.7829608519605;4348.608625223729;4368.694191406603;4445.155420470117;4483.148201841656;4503.932441013388;4216.47294088239;4338.652907767371;4349.043210493686;4375.234333991539;4381.16757816014;4231.1114665920195;4280.5719428057255;4283.100548884738;4283.400323954649;4311.698181127291;4244.08752118293;4303.354496825501;4303.376010478463;4306.569343065699;4349.913001739979;4603.447586289667;4704.1767690654;4705.435347758256;4720.976395118037;4736.550027747358;5004.5495905368325;5066.771995260222;5072.873178170576;5109.20807274873;5126.923096153523;5072.771725272371;5115.437301896788;5135.794568217267;5151.098557752378;5159.380874295071;4570.840020599263;4595.609373203249;4746.905061898743;4748.19280722278;4797.832075877328;5053.9241911371355;5126.231065340155;5142.919986802814;5157.458466860926;5182.067227899014;4926.3842019747535;4927.975360123177;4968.22992436173;4973.55238028572;4975.825846095369;4837.758112094381;4945.406551213878;5008.12357837377;5016.6237532184505;5058.924116138261;4947.431045429749;4957.405111386584;4991.3511243538105;4994.600431965434;5037.11850426174;4954.133026720309;4958.330625365602;4971.4282857471135;4975.626827987915;5020.673656212334;4043.8180281887385;4102.50769907613;4104.42538044674;4181.498220213593;4227.598378154071;3639.763415377992;3677.5403074615674;3692.5568931727826;3692.9630703693156;3730.925381492355;4343.1530851484285;4343.869683909425;4346.500152482505;4351.0645211279725;4391.275439552502;4913.213885778258;4966.453690094087;5050.090983622983;5050.72221027847;5087.109755792721;4329.047609525899;4353.956460435418;4370.125974804988;4372.475302963665;4376.037271800199;4510.503844577094;4511.481179664315;4512.706674066175;4553.954460455419;4561.589456948891;4675.064987002545;4744.4543877454535;4790.041991601694;4800.279958006327;4803.5916947059895;5020.849374518771;5027.4218464877;5056.544910958031;5060.063888180698;5105.387353517602;4762.6189904808225;4782.952170478251;4785.545373189541;4790.4969978153185;4834.419869615528;4779.091972525209;4935.087008903364;4962.751862406937;4988.251762235694;5032.471590482946;5023.799048038038;5073.467285934924;5074;5079.466656001215;5103.821366252163;4893.657443978887;4894.33926419943;4905.4113506378035;4907.582855457326;4927.039227350776;4761.880952976203;4783.019481006316;4846.103470857903;4853.6602437829015;4946.579540739078;4756.619470442287;4781.784819683053;4785.114753770425;4827.348307978378;4837.56461918415;4888.755562221946;4897.755112244445;4905.558499735041;4914.9017019658695;4955.058538877602;4624.491305956275;4692.131955588227;4694.483606803181;4760.571548560646;4760.97639007615 08:59:48 INFO - PROCESS | 8046 | |1;ext.html;537.3657158839255;565.4402141879541;568.2612603615299;587.2805812879222;593.8723174517478;26507.20478385649;29080.709192908093;29198.85400572997;39915.800420997926;40361.798191009075;40627.796861015726;40850.59149408505;40940.38589421153;40940.795296023556;40947.33842300248;7667.616619169034;7800.453968222227;7817.061952565672;7826.5695386753705;7837.804054898645;7723.0732312122345;7814.140444551123;7814.570198639072;7826.2565056319845;7835.138134805167;7861.213878612121;7861.449698521106;7904.841903161933;7909.920900791005;7918.247766462206;7839.764807055797;7864.134945156028;7879.6454159563245;7880.408969327324;7880.802979925547;7711.2288771123;7766.145723970359;7766.922330776733;7768;7775.611219439062;38399.808000960096;38703;38741.61258387436;38742.062896855045;38742.22515549673;2875.8418286994206;3110.779188449091;3336.799792012487;3446.8965931022108;3584.193556449804;28731.856340718372;29017.70982290171;29333.35995766741;29338.266543336373;29617.259568510744;3238.7085162335266;3273.672632736731;3274.3123943971796;3305.0250176197837;3339.5658564386717;246979;249899;250090.74954625292;250481;250694;51064.234036489484;51430;51460.485395146316;51503.74248128735;51574;32762;33597.66402335994;33719.831400842835;35013;35046.649533504846;14868.553943381716;14965.251737413086;14977;15016.624584385478;15038.849611503963;11444.713882152846;11516.827247591293;11517.884821151849;11518.251313664585;11527.654170374903;18278.26886924535;18311.63376732458;18329.90835045816;18428.170732317078;18450.26198952027;6811.557248778813;6870;6912.896306555405;6931.861362772716;7140.500164988401;840.4243093480985;966.4539535162611;970.4759429907771;1018.2821111116644;1024.4263212600968;27669.308267293076;28470.149440286314;28578.857105714338;29147.85426072856;29381.11856644304;794.4756460735887;973.1484950668165;975.302658599105;1003.8494225866178;1015.1523477896039;14629.414823407158;14662.266886655625;14709.779353309708;15164.848351516564;15203.847961520465;384247;384355;385163;387306;388311;49264.7536762321;49822;49932;49969.25046124311;50004.74997625061;1058.380847204394;1098.4782228441427;1181.4565299961941;1189.9524019039316;1193.1349771415655;25176;28914.13257602191;29274.853625731736;29620;29783.702162978094;40145.59854401419;40670;40677.186456270116;40680;41275;306066;307902;307909;309430;309987;21084;22209.777902220772;25215.36961575975;25921.08022811057;26174.60738088892;42010.369844452965;42355;42542.78728606337;42639.786801067035;43220.351694725236;35710.64289357073;35743.28513429769;36702.63297366992;36706.44940325844;36839.63160368362;36017.639823602476;36323.63676363203;36445.635543644225;36446;36662.450063248536;31748.206294842814;31963.36073278475;36641.26717465689;37333.253334932604;37428.43857342197;31529;32721.672783271864;33960;33980.66019339874;34075.829620851735;25149.622755659046;25269.74730252674;25576.616350755125;25841.870790645928;26262.73737262603 08:59:48 INFO - PROCESS | 8046 | |2;jquery.html;372.170060764495;375.16525730250197;375.8609314553615;381.2508420952831;389.8927794856414;16148.43480478182;17052.488425347245;18008.63982720345;18045.458636240903;18061.36785212518;16136.83863161368;16290;17043.74434383482;17079.060651664153;17701.734473982902;4629.444466664005;4802.687825291362;4825.517448255164;4835.879103022417;4837.661363704542;3566.946495802552;3734.7945862977526;4551.476580193287;5258.079836028699;5524.58565607579;5545;5550.250716153308;5559.499645031946;5569.749361278732;5578.776848926038;5435.211894275328;5455.372632147294;5516.668999860021;5519.199716041152;5524.1989911463015;3420.9144771380666;5060.898782024339;5362.115250983583;5362.6782393056155;5370.731463426852;12824.166429182073;12832.486700531968;12901.548445804352;15361.462348817739;21279.14883404662;1925.3261358524544;1946.0756140833132;2002.929897453582;2023.494126468383;2359.1624973134462;9201.401908875901;9259.907400925971;9320.953395233048;9598.6640467584;9660.75848103803;1756.2360373237682;1785.7410675451986;1809.6742586334456;1834.4588346437833;1871.419859843453;66638.66680666566;68808;69136.30863691348;69715.30284697139;71096.28903710948;10092.798144037079;10102.898971010343;10165.440900750382;10227.539760710637;10329;14106.647333816736;14228.14631122136;14235.3629332626;14249.501267455797;14256.501022464165;7233.385162261162;7240.96379518099;7346.449016323797;7405.555666660018;7438.925610743823;6958.965205173941;7159.105111861018;7201.3518783309755;7371.226021267797;7416.925830741731;4362.17118747437;4430.800613972379;4471.28459446487;4525.683202175816;4533.7279763213655;1663.5841039740064;1754.921028553718;1760.3574695236146;1890.3100368365722;1895.4029480713532;795.9164287749819;838.6268110690806;883.6377085394957;910.6767097680228;911.5032307392487;16494.2577584009;16769.7484537732;16993;17141.48575542736;17481.388151414638;854.107457706698;861.2162931732094;866.2680035370103;898.7124120281447;900.4777229207044;9210.81578368429;9679.322447428753;9773.755656108511;9826.263030272758;9828.11546960777;363599;367318;393401;396729;399031;78061.04847378748;78183.21816781873;78484.21515784883;78729.60635196787;79149;874.6457684637732;889.9644014239487;893.1024320557927;893.8391089603933;903.859901715222;14858.85141148618;15285.923570382522;15408;17124.571885702957;17363.662962246573;38747.806260968515;39883.80058099691;40056;40571.1885762289;41227.7938610317;49129.75435122802;49597.504024960734;53492;54131;54436.45563544472;6005.489533389711;7045.330693584101;7791.766247012599;7998.840023199387;8091.676332946617;10889.727756806144;11750.588729394773;12271.386430678253;12286.631401057983;12350.75298494043;10001.649942251986;10320.43237621938;10744.946275268887;10835.187360948117;10974.012338889539;10259.7435064124;10457.058864702214;10560.577576896838;10699.94650026745;10815.945920270347;10382.688519344432;10568.471576421302;10661.09380702649;10804.405757683402;10851.077658398808;6937.861242775217;7136.357727804522;7249.710011599688;7830.569318687527;8233.46482478637;10572.365658060233;10828.296160749525;11027.897210278908;11053.613123540637;11114.388708621103 08:59:48 INFO - PROCESS | 8046 | |3;mootools.html;1350.7028453740174;1420.8650178233067;1503.8270598881131;1693.8052124005742;1737.9478615641526;6925.37671609555;7174.067371241731;7594.2785435383685;8155.469894456864;8164.714235001768;7573.77278681639;7873.842523149548;7877.094134174572;8027.478213916106;8041;2225.9220927267547;2271.82961277904;2274.238130226368;2275.874826884529;2276.112316196685;1898.5443493561515;2116.9259075932346;2195.8462907596477;2241.3388050525136;2246.135237933391;2241.6413373860187;2264.558411109834;2271.205078222617;2271.8636881787065;2273.920412785553;2128.7658357580654;2172.543765809182;2172.5980693571582;2173.7934896184756;2174.9782502174935;2195.8023777859908;2205.1730601024615;2227.4765430123907;2228.1310288987306;2230.56503981722;8071.434999550034;8155.388345874024;8158.836823263561;8163;8166.224208700223;4622.791974361128;4717.575418212343;4752.643551733634;4757.833475828364;4761.285807128924;2845.061129827173;2903.724146206107;2964.273752930524;2966.718161774628;2982.4631566318053;879.9164079412445;882.9823403531893;899.1817446123996;908.68650315641;913.5797533134765;10975.560977560888;11004.504797284062;11062.22564420491;11081.168912331608;11092.1126309895;4167.937480937789;4248.7678573213425;4405;4413.16149931512;4418.359337895987;9249.907500924905;9281.953590232006;9286.767830804283;9289.303302252358;9294.070592940787;4828.275758636162;4831;4831.106245344552;4838.225883858566;4839.370881785346;4343.370211319341;4383.189110014594;4402.735835849795;4406.317020861771;4410.29435290352;3613.4760459733716;3665.780053196763;3702.851885924587;3714.3871261241593;3744.3260213161893;1065.6856227412932;1151.6199654114123;1152.141654467427;1177.7927624185108;1187.1867770577182;702.9121359830021;718.270954980695;797.57728403946;814.5886327404622;818.7625588579365;5143.6399452037995;5158.63889527737;5193.974030129825;5229.947700523022;5272.340957380327;846.4709556527171;882.9867551986725;883.8055627761883;885.9955700221458;897.1656359585648;3336.5996080470013;3381.7970921744773;3408.3694516514524;3426.3489936912406;3463.5324231228965;9729.61081556744;9962.651307204213;10040.849387259197;10068.597256109673;10116.797664046679;9801.509924503745;9979.151772099307;10007.849882251772;10011.549480273405;10011.849822252672;7430.851382972311;7550.320471157622;7567.205443428361;7574.204708505527;7578.583177925157;4897.363342765418;4988.625853060962;5015.322931404214;5093.694378337312;5163.3545806774155;9307.255419566283;9316.254699623878;9327.113924177193;9354.766130846783;9374.015728348699;9208.12522810332;9528.761780955532;9574.329796914428;9581.952090239503;9599.568019439002;6502.902456463063;6572.671366431755;6579.4736421087155;6594.307597702364;6601.141851559267;7545.924540754741;7591.620418978919;7601.3918886490055;7603.0496187976505;7623.580703061163;6663;6788.422984046411;6918.584884906922;6963.825904352431;7090.539114957512;6888.862222755617;6892.931070689429;6956.339147780953;7001.684924178322;7053.259407762111;5632.070708333079;5812.796552120655;5818.970905145447;5940.108983652487;5941.31674857397;4122.876313710593;4169.97915010423;4195.349720793282;4277.165952639206;4285.742855428684;4350.434443522448;4358.237308471068;4368.126374725004;4461.286194208911;4471.217536930959 08:59:48 INFO - PROCESS | 8046 | |4;prototype.html;298.7714398485158;299.6045220309192;303.93617340358514;307.38522954091803;307.9584256125425;4831.396075490564;4852.68457550259;4858.781354839032;4861.2708093785905;4868.902621947568;4784.114938736337;4808.663393562452;4809.100405339897;4811.711297322155;4821.722243605447;3617.2222972060936;3741.438784182381;3746.30693321735;3806.276807406584;3838.078861073336;3753.7372383933134;3836.5396152461744;3847.6729477994263;3853.807309634521;3858.9228215435674;3772.6981841452616;3791.393377059671;3797.525309336333;3810.79040652764;3837.4627552142724;3625.256822351425;3662.487251784739;3787.9242415151816;3808.733388662795;3826.1773718650625;3379.2227787608986;3381.205416727067;3399.3031428557088;3399.5240666306736;3408.7613867029318;4702.083093796711;4704.882377940545;4721.811127554894;4724.928796282409;4734.19518681825;4253.532111467736;4349.086691794727;4353.782310884475;4362.214801335758;4375.890602734957;5008.624353173526;5029.899402011976;5038;5041.773120209599;5043.621728370387;3722.516072910504;3726.2920045191327;3728.9677125966414;3732.4246270073563;3738.2897249522503;5012.949870501321;5231.503007214346;5302.390225124122;5307.442718514578;5318.149096144598;3773.6226377362595;3786.3184626767447;3790.6209379061875;3793.4499497572697;3809.8285577149095;3839.731218814712;3843;3843.5195600549932;3846.000039989623;3852.0339338709596;4283.528811830696;4289.678274129453;4293.334533147367;4303.849365272263;4317.805698743564;4746.620270378361;4986.800527978913;5025.39695236574;5032.295478632995;5054.570361519239;1272.2366580051894;1283.7239993401276;1285.2930888011556;1285.8392700912386;1287.6008437384442;825.5459497276474;826.2398593294183;832.3341326938425;837.1335667584143;861.7543999959981;4412.382266482695;4419.977900110479;4436.334549817553;4442.68901176921;4443;5116.820911268088;5119.283300337956;5120.18077107661;5136.43499215086;5137.922931156036;4302.623160588581;4413.3821265022925;4420.425344705232;4425.822967081345;4431.556844315607;2710.6340644012807;2728.7953403494816;2730.1400058981358;2733.8633068346503;2736.712645172268;4832.275158726219;4843.4430040545085;4845.2732090186755;4857.4171099467585;4875.34182885313;5057.924131138036;5186.766595503212;5204.9739751301;5209;5233.371995360505;4832.420109586872;4847.418309802776;4862.878428039327;4869.683470574401;4875.195592727231;5091.312672789126;5099.184130539096;5101.571559963216;5106.029854327814;5109.9744501277255;4814.459373000746;5026.47222041695;5027.924581131213;5043.773030213576;5154.639175257696;4933.9506604933495;4944;4969.403671559436;4970.304157418037;4970.676906001243;3671.6144804795113;3673;3695.8336874841234;3702.111493241549;3708.6463440844436;5062.249712541008;5228.058949388995;5247.632665713516;5260.526552610283;5268.841934741964;5006.299118123393;5017.347744793154;5033.13773903658;5041.495850414929;5058.241263810458;5010.847505073781;5011.323471331323;5014.4676938146;5024.799008039638;5037.848864534069;4686.437627484724;4934.432540257916;4952.752362381794;4960;4965.155923493087;4834.927476087932;4980.302757613865;4981.676191047571;4986.950130498649;5054.721990290423;4820.807167713392;4883.902321953612;4886.169351210374;4953;4981.62637802159 08:59:48 INFO - PROCESS | 8046 | |5;yui.html;678.0676569716643;711.0010435338352;730.6273800361815;744.6797876912927;748.8652042632324;12617.747645047106;13234.53679121231;13258.867411325884;13264.204147751117;13268.20390776554;11476.598319058834;12785.296808675519;12797.936010319936;12807.487700491969;12815.871841281585;757.7840315510094;770.1951460723558;773.736929443989;774.481097664566;776.0997243197892;626.1609443345916;762.6339357108591;769.6305773228853;772.8686123359014;793.6269953122023;825.6821123867294;830.024720952881;833.9833203335929;834.8580741273998;834.9373796965222;655.7508146904194;827.5489858027329;829.3158144530756;829.3531045784327;829.701307529289;582.1820342418908;595.2291782142137;597.8146774499919;599.4365296621206;600.2526854066672;11456.770864582662;11476.139289553317;11483.311001339946;11497.425128743529;11498.885011149949;11573.42132893352;11777.11671624623;11886.940565297118;11957.521699132025;12021.699457513545;11242.831357529643;11270.43647817614;11439.142064345207;11503.539858405653;11701.590444334493;3916.4908561886773;3946.881593552198;3976.0855003349393;4014.5383280922483;4100.610442008035;61795;61824.38175618231;62395.37604623941;63535.68232158856;63596;8961.840767647767;9131.452112873249;9169.449833010041;9292.7676808079;9406.529673516434;16444.6711065778;16446;16456.424025159064;16489.505314840335;16506.75239871403;6674.799756007327;6685.598864068172;6772.11962444879;6794.150731158606;6931.514793964475;3607.5851277102943;3641.7997010164167;3648.087978005499;3665.4501824726503;3678.963210367862;2688.368233465134;2764.7926405519665;2771.6119743235963;2778.6387769589824;2780.0547813743424;489.41270475429627;491.2336754662738;501.5937090956337;502.1313128288009;542.3112646938366;525.2751203339367;529.8728305206799;551.969641669712;557.5901712241499;560.4059696721488;7735.3424958878;7989.880151797728;8077.313428358538;8179.836403271901;8375.58122093905;523.7904838064728;539.9298091248113;593.8693487432757;594.4649815166384;599.1252770954368;3923.4507168996365;3931.724779265424;3931.9213615727526;3992.54085780139;4058.2695114879607;76048;104975;110393;113027.43486282516;115390.42304788422;82672;82758.17241827626;83712.58143709364;84232.57883710542;85730.57134714286;69599.3040069603;73784.63107684428;74535.25464745284;75076.62461687766;75616.62191689006;8305.480198044506;8355.456895301786;8432.957835210786;8515.446495977742;8764.824703506021;37222.813885930394;43178.56821431871;43814;44256.778716106215;44527.55472445234;57552;57923;60963.69518152558;64569.35430645821;64600;11003.449827508754;11207.887921121011;11386.829197561878;11431.828522572001;11570.479328430072;13121.671958201121;13252.801207981694;13381.866181338062;13575.117617354841;13609.863901360859;12038.398080096134;12414.317212553397;12806.167599106027;12949.158304710163;13018;12084;12117.636470905887;12172.573959911715;12568.30874301922;12757.55348562833;10378.896211037792;10610.946945265225;10611.575536978435;10689.786204276026;11012.669619911416;9710.660126895526;9959.836964885993;10067.798644026932;10473.633422830164;10569.894301056891;10485.842712359168;10504.212184086071;10649.840252396065;10671.46642667879;10817.350958942488 08:59:48 INFO - PROCESS | 8046 | __end_tp_report 08:59:48 INFO - PROCESS | 8046 | __start_cc_report 08:59:48 INFO - PROCESS | 8046 | _x_x_mozilla_cycle_collect,1007 08:59:48 INFO - PROCESS | 8046 | __end_cc_report 08:59:48 INFO - PROCESS | 8046 | __startTimestamp1467820788774__endTimestamp 08:59:48 INFO - PROCESS | 8046 | 08:59:48 INFO - PROCESS | 8046 | ------- Summary: start ------- 08:59:48 INFO - PROCESS | 8046 | Number of tests: 6 08:59:48 INFO - PROCESS | 8046 | 08:59:48 INFO - PROCESS | 8046 | [#0] dojo.html Cycles:165 Average:4640.26 Median:4761.88 stddev:491.01 (10.3%) stddev-sans-first:465.52 08:59:48 INFO - PROCESS | 8046 | Values: 2593.3 2597.4 2648.3 2653.5 2658.4 4620.0 4667.0 4701.2 4703.8 4723.8 4641.9 4700.6 4715.8 4716.9 4759.8 4249.6 4280.8 4289.9 4335.3 4340.8 4348.6 4368.7 4445.2 4483.1 4503.9 4216.5 4338.7 4349.0 4375.2 4381.2 4231.1 4280.6 4283.1 4283.4 4311.7 4244.1 4303.4 4303.4 4306.6 4349.9 4603.4 4704.2 4705.4 4721.0 4736.6 5004.5 5066.8 5072.9 5109.2 5126.9 5072.8 5115.4 5135.8 5151.1 5159.4 4570.8 4595.6 4746.9 4748.2 4797.8 5053.9 5126.2 5142.9 5157.5 5182.1 4926.4 4928.0 4968.2 4973.6 4975.8 4837.8 4945.4 5008.1 5016.6 5058.9 4947.4 4957.4 4991.4 4994.6 5037.1 4954.1 4958.3 4971.4 4975.6 5020.7 4043.8 4102.5 4104.4 4181.5 4227.6 3639.8 3677.5 3692.6 3693.0 3730.9 4343.2 4343.9 4346.5 4351.1 4391.3 4913.2 4966.5 5050.1 5050.7 5087.1 4329.0 4354.0 4370.1 4372.5 4376.0 4510.5 4511.5 4512.7 4554.0 4561.6 4675.1 4744.5 4790.0 4800.3 4803.6 5020.8 5027.4 5056.5 5060.1 5105.4 4762.6 4783.0 4785.5 4790.5 4834.4 4779.1 4935.1 4962.8 4988.3 5032.5 5023.8 5073.5 5074.0 5079.5 5103.8 4893.7 4894.3 4905.4 4907.6 4927.0 4761.9 4783.0 4846.1 4853.7 4946.6 4756.6 4781.8 4785.1 4827.3 4837.6 4888.8 4897.8 4905.6 4914.9 4955.1 4624.5 4692.1 4694.5 4760.6 4761.0 08:59:48 INFO - PROCESS | 8046 | 08:59:48 INFO - PROCESS | 8046 | [#1] ext.html Cycles:180 Average:46329.77 Median:19800.92 stddev:84069.69 (424.6%) stddev-sans-first:84235.22 08:59:48 INFO - PROCESS | 8046 | Values: 537.4 565.4 568.3 587.3 593.9 26507.2 29080.7 29198.9 39915.8 40361.8 40627.8 40850.6 40940.4 40940.8 40947.3 7667.6 7800.5 7817.1 7826.6 7837.8 7723.1 7814.1 7814.6 7826.3 7835.1 7861.2 7861.4 7904.8 7909.9 7918.2 7839.8 7864.1 7879.6 7880.4 7880.8 7711.2 7766.1 7766.9 7768.0 7775.6 38399.8 38703.0 38741.6 38742.1 38742.2 2875.8 3110.8 3336.8 3446.9 3584.2 28731.9 29017.7 29333.4 29338.3 29617.3 3238.7 3273.7 3274.3 3305.0 3339.6 246979.0 249899.0 250090.7 250481.0 250694.0 51064.2 51430.0 51460.5 51503.7 51574.0 32762.0 33597.7 33719.8 35013.0 35046.6 14868.6 14965.3 14977.0 15016.6 15038.8 11444.7 11516.8 11517.9 11518.3 11527.7 18278.3 18311.6 18329.9 18428.2 18450.3 6811.6 6870.0 6912.9 6931.9 7140.5 840.4 966.5 970.5 1018.3 1024.4 27669.3 28470.1 28578.9 29147.9 29381.1 794.5 973.1 975.3 1003.8 1015.2 14629.4 14662.3 14709.8 15164.8 15203.8 384247.0 384355.0 385163.0 387306.0 388311.0 49264.8 49822.0 49932.0 49969.3 50004.7 1058.4 1098.5 1181.5 1190.0 1193.1 25176.0 28914.1 29274.9 29620.0 29783.7 40145.6 40670.0 40677.2 40680.0 41275.0 306066.0 307902.0 307909.0 309430.0 309987.0 21084.0 22209.8 25215.4 25921.1 26174.6 42010.4 42355.0 42542.8 42639.8 43220.4 35710.6 35743.3 36702.6 36706.4 36839.6 36017.6 36323.6 36445.6 36446.0 36662.5 31748.2 31963.4 36641.3 37333.3 37428.4 31529.0 32721.7 33960.0 33980.7 34075.8 25149.6 25269.7 25576.6 25841.9 26262.7 08:59:48 INFO - PROCESS | 8046 | 08:59:48 INFO - PROCESS | 8046 | [#2] jquery.html Cycles:180 Average:24225.79 Median:40313.59 stddev:63573.04 (157.7%) stddev-sans-first:63726.15 08:59:48 INFO - PROCESS | 8046 | Values: 372.2 375.2 375.9 381.3 389.9 16148.4 17052.5 18008.6 18045.5 18061.4 16136.8 16290.0 17043.7 17079.1 17701.7 4629.4 4802.7 4825.5 4835.9 4837.7 3566.9 3734.8 4551.5 5258.1 5524.6 5545.0 5550.3 5559.5 5569.7 5578.8 5435.2 5455.4 5516.7 5519.2 5524.2 3420.9 5060.9 5362.1 5362.7 5370.7 12824.2 12832.5 12901.5 15361.5 21279.1 1925.3 1946.1 2002.9 2023.5 2359.2 9201.4 9259.9 9321.0 9598.7 9660.8 1756.2 1785.7 1809.7 1834.5 1871.4 66638.7 68808.0 69136.3 69715.3 71096.3 10092.8 10102.9 10165.4 10227.5 10329.0 14106.6 14228.1 14235.4 14249.5 14256.5 7233.4 7241.0 7346.4 7405.6 7438.9 6959.0 7159.1 7201.4 7371.2 7416.9 4362.2 4430.8 4471.3 4525.7 4533.7 1663.6 1754.9 1760.4 1890.3 1895.4 795.9 838.6 883.6 910.7 911.5 16494.3 16769.7 16993.0 17141.5 17481.4 854.1 861.2 866.3 898.7 900.5 9210.8 9679.3 9773.8 9826.3 9828.1 363599.0 367318.0 393401.0 396729.0 399031.0 78061.0 78183.2 78484.2 78729.6 79149.0 874.6 890.0 893.1 893.8 903.9 14858.9 15285.9 15408.0 17124.6 17363.7 38747.8 39883.8 40056.0 40571.2 41227.8 49129.8 49597.5 53492.0 54131.0 54436.5 6005.5 7045.3 7791.8 7998.8 8091.7 10889.7 11750.6 12271.4 12286.6 12350.8 10001.6 10320.4 10744.9 10835.2 10974.0 10259.7 10457.1 10560.6 10699.9 10815.9 10382.7 10568.5 10661.1 10804.4 10851.1 6937.9 7136.4 7249.7 7830.6 8233.5 10572.4 10828.3 11027.9 11053.6 11114.4 08:59:48 INFO - PROCESS | 8046 | 08:59:48 INFO - PROCESS | 8046 | [#3] mootools.html Cycles:180 Average:5209.27 Median:4868.37 stddev:2984.20 (61.3%) stddev-sans-first:2978.48 08:59:48 INFO - PROCESS | 8046 | Values: 1350.7 1420.9 1503.8 1693.8 1737.9 6925.4 7174.1 7594.3 8155.5 8164.7 7573.8 7873.8 7877.1 8027.5 8041.0 2225.9 2271.8 2274.2 2275.9 2276.1 1898.5 2116.9 2195.8 2241.3 2246.1 2241.6 2264.6 2271.2 2271.9 2273.9 2128.8 2172.5 2172.6 2173.8 2175.0 2195.8 2205.2 2227.5 2228.1 2230.6 8071.4 8155.4 8158.8 8163.0 8166.2 4622.8 4717.6 4752.6 4757.8 4761.3 2845.1 2903.7 2964.3 2966.7 2982.5 879.9 883.0 899.2 908.7 913.6 10975.6 11004.5 11062.2 11081.2 11092.1 4167.9 4248.8 4405.0 4413.2 4418.4 9249.9 9282.0 9286.8 9289.3 9294.1 4828.3 4831.0 4831.1 4838.2 4839.4 4343.4 4383.2 4402.7 4406.3 4410.3 3613.5 3665.8 3702.9 3714.4 3744.3 1065.7 1151.6 1152.1 1177.8 1187.2 702.9 718.3 797.6 814.6 818.8 5143.6 5158.6 5194.0 5229.9 5272.3 846.5 883.0 883.8 886.0 897.2 3336.6 3381.8 3408.4 3426.3 3463.5 9729.6 9962.7 10040.8 10068.6 10116.8 9801.5 9979.2 10007.8 10011.5 10011.8 7430.9 7550.3 7567.2 7574.2 7578.6 4897.4 4988.6 5015.3 5093.7 5163.4 9307.3 9316.3 9327.1 9354.8 9374.0 9208.1 9528.8 9574.3 9582.0 9599.6 6502.9 6572.7 6579.5 6594.3 6601.1 7545.9 7591.6 7601.4 7603.0 7623.6 6663.0 6788.4 6918.6 6963.8 7090.5 6888.9 6892.9 6956.3 7001.7 7053.3 5632.1 5812.8 5819.0 5940.1 5941.3 4122.9 4170.0 4195.3 4277.2 4285.7 4350.4 4358.2 4368.1 4461.3 4471.2 08:59:48 INFO - PROCESS | 8046 | 08:59:48 INFO - PROCESS | 8046 | [#4] prototype.html Cycles:180 Average:4192.46 Median:4813.09 stddev:1200.77 (24.9%) stddev-sans-first:1168.03 08:59:48 INFO - PROCESS | 8046 | Values: 298.8 299.6 303.9 307.4 308.0 4831.4 4852.7 4858.8 4861.3 4868.9 4784.1 4808.7 4809.1 4811.7 4821.7 3617.2 3741.4 3746.3 3806.3 3838.1 3753.7 3836.5 3847.7 3853.8 3858.9 3772.7 3791.4 3797.5 3810.8 3837.5 3625.3 3662.5 3787.9 3808.7 3826.2 3379.2 3381.2 3399.3 3399.5 3408.8 4702.1 4704.9 4721.8 4724.9 4734.2 4253.5 4349.1 4353.8 4362.2 4375.9 5008.6 5029.9 5038.0 5041.8 5043.6 3722.5 3726.3 3729.0 3732.4 3738.3 5012.9 5231.5 5302.4 5307.4 5318.1 3773.6 3786.3 3790.6 3793.4 3809.8 3839.7 3843.0 3843.5 3846.0 3852.0 4283.5 4289.7 4293.3 4303.8 4317.8 4746.6 4986.8 5025.4 5032.3 5054.6 1272.2 1283.7 1285.3 1285.8 1287.6 825.5 826.2 832.3 837.1 861.8 4412.4 4420.0 4436.3 4442.7 4443.0 5116.8 5119.3 5120.2 5136.4 5137.9 4302.6 4413.4 4420.4 4425.8 4431.6 2710.6 2728.8 2730.1 2733.9 2736.7 4832.3 4843.4 4845.3 4857.4 4875.3 5057.9 5186.8 5205.0 5209.0 5233.4 4832.4 4847.4 4862.9 4869.7 4875.2 5091.3 5099.2 5101.6 5106.0 5110.0 4814.5 5026.5 5027.9 5043.8 5154.6 4934.0 4944.0 4969.4 4970.3 4970.7 3671.6 3673.0 3695.8 3702.1 3708.6 5062.2 5228.1 5247.6 5260.5 5268.8 5006.3 5017.3 5033.1 5041.5 5058.2 5010.8 5011.3 5014.5 5024.8 5037.8 4686.4 4934.4 4952.8 4960.0 4965.2 4834.9 4980.3 4981.7 4987.0 5054.7 4820.8 4883.9 4886.2 4953.0 4981.6 08:59:48 INFO - PROCESS | 8046 | 08:59:48 INFO - PROCESS | 8046 | [#5] yui.html Cycles:180 Average:17745.64 Median:44392.17 stddev:25845.79 (58.2%) stddev-sans-first:25886.52 08:59:48 INFO - PROCESS | 8046 | Values: 678.1 711.0 730.6 744.7 748.9 12617.7 13234.5 13258.9 13264.2 13268.2 11476.6 12785.3 12797.9 12807.5 12815.9 757.8 770.2 773.7 774.5 776.1 626.2 762.6 769.6 772.9 793.6 825.7 830.0 834.0 834.9 834.9 655.8 827.5 829.3 829.4 829.7 582.2 595.2 597.8 599.4 600.3 11456.8 11476.1 11483.3 11497.4 11498.9 11573.4 11777.1 11886.9 11957.5 12021.7 11242.8 11270.4 11439.1 11503.5 11701.6 3916.5 3946.9 3976.1 4014.5 4100.6 61795.0 61824.4 62395.4 63535.7 63596.0 8961.8 9131.5 9169.4 9292.8 9406.5 16444.7 16446.0 16456.4 16489.5 16506.8 6674.8 6685.6 6772.1 6794.2 6931.5 3607.6 3641.8 3648.1 3665.5 3679.0 2688.4 2764.8 2771.6 2778.6 2780.1 489.4 491.2 501.6 502.1 542.3 525.3 529.9 552.0 557.6 560.4 7735.3 7989.9 8077.3 8179.8 8375.6 523.8 539.9 593.9 594.5 599.1 3923.5 3931.7 3931.9 3992.5 4058.3 76048.0 104975.0 110393.0 113027.4 115390.4 82672.0 82758.2 83712.6 84232.6 85730.6 69599.3 73784.6 74535.3 75076.6 75616.6 8305.5 8355.5 8433.0 8515.4 8764.8 37222.8 43178.6 43814.0 44256.8 44527.6 57552.0 57923.0 60963.7 64569.4 64600.0 11003.4 11207.9 11386.8 11431.8 11570.5 13121.7 13252.8 13381.9 13575.1 13609.9 12038.4 12414.3 12806.2 12949.2 13018.0 12084.0 12117.6 12172.6 12568.3 12757.6 10378.9 10610.9 10611.6 10689.8 11012.7 9710.7 9959.8 10067.8 10473.6 10569.9 10485.8 10504.2 10649.8 10671.5 10817.4 08:59:48 INFO - PROCESS | 8046 | -------- Summary: end -------- 08:59:48 INFO - PROCESS | 8046 | 08:59:49 INFO - TEST-INFO | 8046: exit 0 08:59:49 INFO - TEST-OK | dromaeo_css | took 1120038ms 08:59:49 INFO - TEST-START | kraken 08:59:49 INFO - operating with platform_type : linux_ 08:59:49 INFO - Initialising browser for kraken test... 08:59:49 INFO - TEST-INFO | started process 8236 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQQUDas/profile http://localhost:56007/getInfo.html) 08:59:53 INFO - PROCESS | 8236 | __metrics Screen width/height:1600/1200 08:59:53 INFO - PROCESS | 8236 | colorDepth:24 08:59:53 INFO - PROCESS | 8236 | Browser inner width/height: 1024/697 08:59:53 INFO - PROCESS | 8236 | __metrics 08:59:54 INFO - PROCESS | 8236 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:59:55 INFO - TEST-INFO | 8236: exit 0 08:59:55 INFO - Browser initialized. 08:59:55 INFO - Running cycle 1/1 for kraken test... 08:59:55 INFO - TEST-INFO | started process 8321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQQUDas/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:07 INFO - PROCESS | 8321 | RSS: Main: 158793728 09:00:07 INFO - PROCESS | 8321 | 09:00:10 INFO - PROCESS | 8321 | Cycle 1(1): loaded http://localhost:56007/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56007/tests/kraken/driver.html?testName=audio-beat-detection) 09:00:11 INFO - PROCESS | 8321 | RSS: Main: 216698880 09:00:11 INFO - PROCESS | 8321 | 09:00:14 INFO - PROCESS | 8321 | Cycle 1(1): loaded http://localhost:56007/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56007/tests/kraken/driver.html?testName=audio-dft) 09:00:14 INFO - PROCESS | 8321 | RSS: Main: 205762560 09:00:14 INFO - PROCESS | 8321 | 09:00:18 INFO - PROCESS | 8321 | Cycle 1(1): loaded http://localhost:56007/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56007/tests/kraken/driver.html?testName=audio-fft) 09:00:18 INFO - PROCESS | 8321 | RSS: Main: 271187968 09:00:18 INFO - PROCESS | 8321 | 09:00:20 INFO - PROCESS | 8321 | Cycle 1(1): loaded http://localhost:56007/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56007/tests/kraken/driver.html?testName=audio-oscillator) 09:00:21 INFO - PROCESS | 8321 | RSS: Main: 181571584 09:00:21 INFO - PROCESS | 8321 | 09:00:23 INFO - PROCESS | 8321 | Cycle 1(1): loaded http://localhost:56007/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56007/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:00:24 INFO - PROCESS | 8321 | RSS: Main: 186142720 09:00:24 INFO - PROCESS | 8321 | 09:00:27 INFO - PROCESS | 8321 | Cycle 1(1): loaded http://localhost:56007/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56007/tests/kraken/driver.html?testName=imaging-darkroom) 09:00:28 INFO - PROCESS | 8321 | RSS: Main: 221589504 09:00:28 INFO - PROCESS | 8321 | 09:00:31 INFO - PROCESS | 8321 | Cycle 1(1): loaded http://localhost:56007/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56007/tests/kraken/driver.html?testName=imaging-desaturate) 09:00:32 INFO - PROCESS | 8321 | RSS: Main: 218333184 09:00:32 INFO - PROCESS | 8321 | 09:00:35 INFO - PROCESS | 8321 | Cycle 1(1): loaded http://localhost:56007/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56007/tests/kraken/driver.html?testName=json-parse-financial) 09:00:35 INFO - PROCESS | 8321 | RSS: Main: 220098560 09:00:35 INFO - PROCESS | 8321 | 09:00:37 INFO - PROCESS | 8321 | Cycle 1(1): loaded http://localhost:56007/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56007/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:00:37 INFO - PROCESS | 8321 | RSS: Main: 207446016 09:00:37 INFO - PROCESS | 8321 | 09:00:39 INFO - PROCESS | 8321 | Cycle 1(1): loaded http://localhost:56007/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56007/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:00:40 INFO - PROCESS | 8321 | RSS: Main: 211955712 09:00:40 INFO - PROCESS | 8321 | 09:00:42 INFO - PROCESS | 8321 | Cycle 1(1): loaded http://localhost:56007/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56007/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:00:43 INFO - PROCESS | 8321 | RSS: Main: 212221952 09:00:43 INFO - PROCESS | 8321 | 09:00:46 INFO - PROCESS | 8321 | Cycle 1(1): loaded http://localhost:56007/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:00:46 INFO - PROCESS | 8321 | RSS: Main: 224145408 09:00:46 INFO - PROCESS | 8321 | 09:00:49 INFO - PROCESS | 8321 | Cycle 1(1): loaded http://localhost:56007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:00:50 INFO - PROCESS | 8321 | RSS: Main: 224751616 09:00:50 INFO - PROCESS | 8321 | 09:00:51 INFO - PROCESS | 8321 | Cycle 1(1): loaded http://localhost:56007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56007/tests/kraken/driver.html?testName=ai-astar) 09:00:52 INFO - PROCESS | 8321 | RSS: Main: 268214272 09:00:52 INFO - PROCESS | 8321 | 09:00:52 INFO - PROCESS | 8321 | __start_tp_report 09:00:52 INFO - PROCESS | 8321 | _x_x_mozilla_page_load 09:00:52 INFO - PROCESS | 8321 | _x_x_mozilla_page_load_details 09:00:52 INFO - PROCESS | 8321 | |i|pagename|runs| 09:00:52 INFO - PROCESS | 8321 | |0;ai-astar;104;113;113;115;112;112;114;111;111;111 09:00:52 INFO - PROCESS | 8321 | |1;audio-beat-detection;147;123;125;180;122;123;142;123;152;122 09:00:52 INFO - PROCESS | 8321 | |2;audio-dft;163;161;160;161;159;162;163;162;161;161 09:00:52 INFO - PROCESS | 8321 | |3;audio-fft;77;76;75;128;76;77;81;76;100;76 09:00:52 INFO - PROCESS | 8321 | |4;audio-oscillator;85;85;114;85;86;85;118;85;86;130 09:00:52 INFO - PROCESS | 8321 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;117;117 09:00:52 INFO - PROCESS | 8321 | |6;imaging-darkroom;146;146;147;147;146;147;147;147;147;145 09:00:52 INFO - PROCESS | 8321 | |7;imaging-desaturate;95;94;96;96;96;96;95;96;96;95 09:00:52 INFO - PROCESS | 8321 | |8;json-parse-financial;64;63;64;63;63;63;63;63;64;64 09:00:52 INFO - PROCESS | 8321 | |9;json-stringify-tinderbox;65;64;65;64;65;66;65;65;66;66 09:00:52 INFO - PROCESS | 8321 | |10;stanford-crypto-aes;87;81;78;84;80;79;88;80;80;79 09:00:52 INFO - PROCESS | 8321 | |11;stanford-crypto-ccm;143;133;143;135;129;128;126;129;185;131 09:00:52 INFO - PROCESS | 8321 | |12;stanford-crypto-pbkdf2;172;170;168;166;168;165;165;168;173;166 09:00:52 INFO - PROCESS | 8321 | |13;stanford-crypto-sha256-iterative;66;67;66;66;65;66;67;66;66;66 09:00:52 INFO - PROCESS | 8321 | __end_tp_report 09:00:52 INFO - PROCESS | 8321 | __start_cc_report 09:00:52 INFO - PROCESS | 8321 | _x_x_mozilla_cycle_collect,1882 09:00:52 INFO - PROCESS | 8321 | __end_cc_report 09:00:52 INFO - PROCESS | 8321 | __startTimestamp1467820852173__endTimestamp 09:00:52 INFO - PROCESS | 8321 | 09:00:52 INFO - PROCESS | 8321 | ------- Summary: start ------- 09:00:52 INFO - PROCESS | 8321 | Number of tests: 14 09:00:52 INFO - PROCESS | 8321 | 09:00:52 INFO - PROCESS | 8321 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.50 stddev:2.99 (2.7%) stddev-sans-first:1.42 09:00:52 INFO - PROCESS | 8321 | Values: 104.0 113.0 113.0 115.0 112.0 112.0 114.0 111.0 111.0 111.0 09:00:52 INFO - PROCESS | 8321 | 09:00:52 INFO - PROCESS | 8321 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:133.50 stddev:19.35 (14.5%) stddev-sans-first:20.10 09:00:52 INFO - PROCESS | 8321 | Values: 147.0 123.0 125.0 180.0 122.0 123.0 142.0 123.0 152.0 122.0 09:00:52 INFO - PROCESS | 8321 | 09:00:52 INFO - PROCESS | 8321 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.17 09:00:52 INFO - PROCESS | 8321 | Values: 163.0 161.0 160.0 161.0 159.0 162.0 163.0 162.0 161.0 161.0 09:00:52 INFO - PROCESS | 8321 | 09:00:52 INFO - PROCESS | 8321 | [#3] audio-fft Cycles:10 Average:84.20 Median:76.00 stddev:17.11 (22.5%) stddev-sans-first:17.95 09:00:52 INFO - PROCESS | 8321 | Values: 77.0 76.0 75.0 128.0 76.0 77.0 81.0 76.0 100.0 76.0 09:00:52 INFO - PROCESS | 8321 | 09:00:52 INFO - PROCESS | 8321 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:85.00 stddev:17.54 (20.6%) stddev-sans-first:18.16 09:00:52 INFO - PROCESS | 8321 | Values: 85.0 85.0 114.0 85.0 86.0 85.0 118.0 85.0 86.0 130.0 09:00:52 INFO - PROCESS | 8321 | 09:00:52 INFO - PROCESS | 8321 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:00:52 INFO - PROCESS | 8321 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 09:00:52 INFO - PROCESS | 8321 | 09:00:52 INFO - PROCESS | 8321 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 09:00:52 INFO - PROCESS | 8321 | Values: 146.0 146.0 147.0 147.0 146.0 147.0 147.0 147.0 147.0 145.0 09:00:52 INFO - PROCESS | 8321 | 09:00:52 INFO - PROCESS | 8321 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.71 (0.7%) stddev-sans-first:0.73 09:00:52 INFO - PROCESS | 8321 | Values: 95.0 94.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 09:00:52 INFO - PROCESS | 8321 | 09:00:52 INFO - PROCESS | 8321 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:63.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 09:00:52 INFO - PROCESS | 8321 | Values: 64.0 63.0 64.0 63.0 63.0 63.0 63.0 63.0 64.0 64.0 09:00:52 INFO - PROCESS | 8321 | 09:00:52 INFO - PROCESS | 8321 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 09:00:52 INFO - PROCESS | 8321 | Values: 65.0 64.0 65.0 64.0 65.0 66.0 65.0 65.0 66.0 66.0 09:00:52 INFO - PROCESS | 8321 | 09:00:52 INFO - PROCESS | 8321 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:80.50 stddev:3.50 (4.4%) stddev-sans-first:3.12 09:00:52 INFO - PROCESS | 8321 | Values: 87.0 81.0 78.0 84.0 80.0 79.0 88.0 80.0 80.0 79.0 09:00:52 INFO - PROCESS | 8321 | 09:00:52 INFO - PROCESS | 8321 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:134.00 stddev:17.47 (13.0%) stddev-sans-first:18.45 09:00:52 INFO - PROCESS | 8321 | Values: 143.0 133.0 143.0 135.0 129.0 128.0 126.0 129.0 185.0 131.0 09:00:52 INFO - PROCESS | 8321 | 09:00:52 INFO - PROCESS | 8321 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:168.00 stddev:2.81 (1.7%) stddev-sans-first:2.60 09:00:52 INFO - PROCESS | 8321 | Values: 172.0 170.0 168.0 166.0 168.0 165.0 165.0 168.0 173.0 166.0 09:00:52 INFO - PROCESS | 8321 | 09:00:52 INFO - PROCESS | 8321 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 09:00:52 INFO - PROCESS | 8321 | Values: 66.0 67.0 66.0 66.0 65.0 66.0 67.0 66.0 66.0 66.0 09:00:52 INFO - PROCESS | 8321 | -------- Summary: end -------- 09:00:52 INFO - PROCESS | 8321 | 09:00:53 INFO - TEST-INFO | 8321: exit 0 09:00:53 INFO - TEST-OK | kraken | took 63622ms 09:00:53 INFO - SUITE-END | took 1183s 09:00:53 INFO - Completed test suite (00:19:43) 09:00:53 INFO - javascript benchmark 09:00:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2593.3386986318487, 2597.3766296088943, 2648.2717252755497, 2653.4958357911983, 2658.3619931216513, 4620.0, 4667.0, 4701.15379231739, 4703.835365762195, 4723.787429565669, 4641.860744177671, 4700.647451441138, 4715.811367545294, 4716.905661886769, 4759.809607615691, 4249.553796851333, 4280.764557949312, 4289.9356509652225, 4335.349697545362, 4340.7829608519605, 4348.608625223729, 4368.694191406603, 4445.155420470117, 4483.148201841656, 4503.932441013388, 4216.47294088239, 4338.652907767371, 4349.043210493686, 4375.234333991539, 4381.16757816014, 4231.1114665920195, 4280.5719428057255, 4283.100548884738, 4283.400323954649, 4311.698181127291, 4244.08752118293, 4303.354496825501, 4303.376010478463, 4306.569343065699, 4349.913001739979, 4603.447586289667, 4704.1767690654, 4705.435347758256, 4720.976395118037, 4736.550027747358, 5004.5495905368325, 5066.771995260222, 5072.873178170576, 5109.20807274873, 5126.923096153523, 5072.771725272371, 5115.437301896788, 5135.794568217267, 5151.098557752378, 5159.380874295071, 4570.840020599263, 4595.609373203249, 4746.905061898743, 4748.19280722278, 4797.832075877328, 5053.9241911371355, 5126.231065340155, 5142.919986802814, 5157.458466860926, 5182.067227899014, 4926.3842019747535, 4927.975360123177, 4968.22992436173, 4973.55238028572, 4975.825846095369, 4837.758112094381, 4945.406551213878, 5008.12357837377, 5016.6237532184505, 5058.924116138261, 4947.431045429749, 4957.405111386584, 4991.3511243538105, 4994.600431965434, 5037.11850426174, 4954.133026720309, 4958.330625365602, 4971.4282857471135, 4975.626827987915, 5020.673656212334, 4043.8180281887385, 4102.50769907613, 4104.42538044674, 4181.498220213593, 4227.598378154071, 3639.763415377992, 3677.5403074615674, 3692.5568931727826, 3692.9630703693156, 3730.925381492355, 4343.1530851484285, 4343.869683909425, 4346.500152482505, 4351.0645211279725, 4391.275439552502, 4913.213885778258, 4966.453690094087, 5050.090983622983, 5050.72221027847, 5087.109755792721, 4329.047609525899, 4353.956460435418, 4370.125974804988, 4372.475302963665, 4376.037271800199, 4510.503844577094, 4511.481179664315, 4512.706674066175, 4553.954460455419, 4561.589456948891, 4675.064987002545, 4744.4543877454535, 4790.041991601694, 4800.279958006327, 4803.5916947059895, 5020.849374518771, 5027.4218464877, 5056.544910958031, 5060.063888180698, 5105.387353517602, 4762.6189904808225, 4782.952170478251, 4785.545373189541, 4790.4969978153185, 4834.419869615528, 4779.091972525209, 4935.087008903364, 4962.751862406937, 4988.251762235694, 5032.471590482946, 5023.799048038038, 5073.467285934924, 5074.0, 5079.466656001215, 5103.821366252163, 4893.657443978887, 4894.33926419943, 4905.4113506378035, 4907.582855457326, 4927.039227350776, 4761.880952976203, 4783.019481006316, 4846.103470857903, 4853.6602437829015, 4946.579540739078, 4756.619470442287, 4781.784819683053, 4785.114753770425, 4827.348307978378, 4837.56461918415, 4888.755562221946, 4897.755112244445, 4905.558499735041, 4914.9017019658695, 4955.058538877602, 4624.491305956275, 4692.131955588227, 4694.483606803181, 4760.571548560646, 4760.97639007615], "value": 4608.729059248382, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.3657158839255, 565.4402141879541, 568.2612603615299, 587.2805812879222, 593.8723174517478, 26507.20478385649, 29080.709192908093, 29198.85400572997, 39915.800420997926, 40361.798191009075, 40627.796861015726, 40850.59149408505, 40940.38589421153, 40940.795296023556, 40947.33842300248, 7667.616619169034, 7800.453968222227, 7817.061952565672, 7826.5695386753705, 7837.804054898645, 7723.0732312122345, 7814.140444551123, 7814.570198639072, 7826.2565056319845, 7835.138134805167, 7861.213878612121, 7861.449698521106, 7904.841903161933, 7909.920900791005, 7918.247766462206, 7839.764807055797, 7864.134945156028, 7879.6454159563245, 7880.408969327324, 7880.802979925547, 7711.2288771123, 7766.145723970359, 7766.922330776733, 7768.0, 7775.611219439062, 38399.808000960096, 38703.0, 38741.61258387436, 38742.062896855045, 38742.22515549673, 2875.8418286994206, 3110.779188449091, 3336.799792012487, 3446.8965931022108, 3584.193556449804, 28731.856340718372, 29017.70982290171, 29333.35995766741, 29338.266543336373, 29617.259568510744, 3238.7085162335266, 3273.672632736731, 3274.3123943971796, 3305.0250176197837, 3339.5658564386717, 246979.0, 249899.0, 250090.74954625292, 250481.0, 250694.0, 51064.234036489484, 51430.0, 51460.485395146316, 51503.74248128735, 51574.0, 32762.0, 33597.66402335994, 33719.831400842835, 35013.0, 35046.649533504846, 14868.553943381716, 14965.251737413086, 14977.0, 15016.624584385478, 15038.849611503963, 11444.713882152846, 11516.827247591293, 11517.884821151849, 11518.251313664585, 11527.654170374903, 18278.26886924535, 18311.63376732458, 18329.90835045816, 18428.170732317078, 18450.26198952027, 6811.557248778813, 6870.0, 6912.896306555405, 6931.861362772716, 7140.500164988401, 840.4243093480985, 966.4539535162611, 970.4759429907771, 1018.2821111116644, 1024.4263212600968, 27669.308267293076, 28470.149440286314, 28578.857105714338, 29147.85426072856, 29381.11856644304, 794.4756460735887, 973.1484950668165, 975.302658599105, 1003.8494225866178, 1015.1523477896039, 14629.414823407158, 14662.266886655625, 14709.779353309708, 15164.848351516564, 15203.847961520465, 384247.0, 384355.0, 385163.0, 387306.0, 388311.0, 49264.7536762321, 49822.0, 49932.0, 49969.25046124311, 50004.74997625061, 1058.380847204394, 1098.4782228441427, 1181.4565299961941, 1189.9524019039316, 1193.1349771415655, 25176.0, 28914.13257602191, 29274.853625731736, 29620.0, 29783.702162978094, 40145.59854401419, 40670.0, 40677.186456270116, 40680.0, 41275.0, 306066.0, 307902.0, 307909.0, 309430.0, 309987.0, 21084.0, 22209.777902220772, 25215.36961575975, 25921.08022811057, 26174.60738088892, 42010.369844452965, 42355.0, 42542.78728606337, 42639.786801067035, 43220.351694725236, 35710.64289357073, 35743.28513429769, 36702.63297366992, 36706.44940325844, 36839.63160368362, 36017.639823602476, 36323.63676363203, 36445.635543644225, 36446.0, 36662.450063248536, 31748.206294842814, 31963.36073278475, 36641.26717465689, 37333.253334932604, 37428.43857342197, 31529.0, 32721.672783271864, 33960.0, 33980.66019339874, 34075.829620851735, 25149.622755659046, 25269.74730252674, 25576.616350755125, 25841.870790645928, 26262.73737262603], "value": 17240.997416552025, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.170060764495, 375.16525730250197, 375.8609314553615, 381.2508420952831, 389.8927794856414, 16148.43480478182, 17052.488425347245, 18008.63982720345, 18045.458636240903, 18061.36785212518, 16136.83863161368, 16290.0, 17043.74434383482, 17079.060651664153, 17701.734473982902, 4629.444466664005, 4802.687825291362, 4825.517448255164, 4835.879103022417, 4837.661363704542, 3566.946495802552, 3734.7945862977526, 4551.476580193287, 5258.079836028699, 5524.58565607579, 5545.0, 5550.250716153308, 5559.499645031946, 5569.749361278732, 5578.776848926038, 5435.211894275328, 5455.372632147294, 5516.668999860021, 5519.199716041152, 5524.1989911463015, 3420.9144771380666, 5060.898782024339, 5362.115250983583, 5362.6782393056155, 5370.731463426852, 12824.166429182073, 12832.486700531968, 12901.548445804352, 15361.462348817739, 21279.14883404662, 1925.3261358524544, 1946.0756140833132, 2002.929897453582, 2023.494126468383, 2359.1624973134462, 9201.401908875901, 9259.907400925971, 9320.953395233048, 9598.6640467584, 9660.75848103803, 1756.2360373237682, 1785.7410675451986, 1809.6742586334456, 1834.4588346437833, 1871.419859843453, 66638.66680666566, 68808.0, 69136.30863691348, 69715.30284697139, 71096.28903710948, 10092.798144037079, 10102.898971010343, 10165.440900750382, 10227.539760710637, 10329.0, 14106.647333816736, 14228.14631122136, 14235.3629332626, 14249.501267455797, 14256.501022464165, 7233.385162261162, 7240.96379518099, 7346.449016323797, 7405.555666660018, 7438.925610743823, 6958.965205173941, 7159.105111861018, 7201.3518783309755, 7371.226021267797, 7416.925830741731, 4362.17118747437, 4430.800613972379, 4471.28459446487, 4525.683202175816, 4533.7279763213655, 1663.5841039740064, 1754.921028553718, 1760.3574695236146, 1890.3100368365722, 1895.4029480713532, 795.9164287749819, 838.6268110690806, 883.6377085394957, 910.6767097680228, 911.5032307392487, 16494.2577584009, 16769.7484537732, 16993.0, 17141.48575542736, 17481.388151414638, 854.107457706698, 861.2162931732094, 866.2680035370103, 898.7124120281447, 900.4777229207044, 9210.81578368429, 9679.322447428753, 9773.755656108511, 9826.263030272758, 9828.11546960777, 363599.0, 367318.0, 393401.0, 396729.0, 399031.0, 78061.04847378748, 78183.21816781873, 78484.21515784883, 78729.60635196787, 79149.0, 874.6457684637732, 889.9644014239487, 893.1024320557927, 893.8391089603933, 903.859901715222, 14858.85141148618, 15285.923570382522, 15408.0, 17124.571885702957, 17363.662962246573, 38747.806260968515, 39883.80058099691, 40056.0, 40571.1885762289, 41227.7938610317, 49129.75435122802, 49597.504024960734, 53492.0, 54131.0, 54436.45563544472, 6005.489533389711, 7045.330693584101, 7791.766247012599, 7998.840023199387, 8091.676332946617, 10889.727756806144, 11750.588729394773, 12271.386430678253, 12286.631401057983, 12350.75298494043, 10001.649942251986, 10320.43237621938, 10744.946275268887, 10835.187360948117, 10974.012338889539, 10259.7435064124, 10457.058864702214, 10560.577576896838, 10699.94650026745, 10815.945920270347, 10382.688519344432, 10568.471576421302, 10661.09380702649, 10804.405757683402, 10851.077658398808, 6937.861242775217, 7136.357727804522, 7249.710011599688, 7830.569318687527, 8233.46482478637, 10572.365658060233, 10828.296160749525, 11027.897210278908, 11053.613123540637, 11114.388708621103], "value": 8197.208891025602, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.7028453740174, 1420.8650178233067, 1503.8270598881131, 1693.8052124005742, 1737.9478615641526, 6925.37671609555, 7174.067371241731, 7594.2785435383685, 8155.469894456864, 8164.714235001768, 7573.77278681639, 7873.842523149548, 7877.094134174572, 8027.478213916106, 8041.0, 2225.9220927267547, 2271.82961277904, 2274.238130226368, 2275.874826884529, 2276.112316196685, 1898.5443493561515, 2116.9259075932346, 2195.8462907596477, 2241.3388050525136, 2246.135237933391, 2241.6413373860187, 2264.558411109834, 2271.205078222617, 2271.8636881787065, 2273.920412785553, 2128.7658357580654, 2172.543765809182, 2172.5980693571582, 2173.7934896184756, 2174.9782502174935, 2195.8023777859908, 2205.1730601024615, 2227.4765430123907, 2228.1310288987306, 2230.56503981722, 8071.434999550034, 8155.388345874024, 8158.836823263561, 8163.0, 8166.224208700223, 4622.791974361128, 4717.575418212343, 4752.643551733634, 4757.833475828364, 4761.285807128924, 2845.061129827173, 2903.724146206107, 2964.273752930524, 2966.718161774628, 2982.4631566318053, 879.9164079412445, 882.9823403531893, 899.1817446123996, 908.68650315641, 913.5797533134765, 10975.560977560888, 11004.504797284062, 11062.22564420491, 11081.168912331608, 11092.1126309895, 4167.937480937789, 4248.7678573213425, 4405.0, 4413.16149931512, 4418.359337895987, 9249.907500924905, 9281.953590232006, 9286.767830804283, 9289.303302252358, 9294.070592940787, 4828.275758636162, 4831.0, 4831.106245344552, 4838.225883858566, 4839.370881785346, 4343.370211319341, 4383.189110014594, 4402.735835849795, 4406.317020861771, 4410.29435290352, 3613.4760459733716, 3665.780053196763, 3702.851885924587, 3714.3871261241593, 3744.3260213161893, 1065.6856227412932, 1151.6199654114123, 1152.141654467427, 1177.7927624185108, 1187.1867770577182, 702.9121359830021, 718.270954980695, 797.57728403946, 814.5886327404622, 818.7625588579365, 5143.6399452037995, 5158.63889527737, 5193.974030129825, 5229.947700523022, 5272.340957380327, 846.4709556527171, 882.9867551986725, 883.8055627761883, 885.9955700221458, 897.1656359585648, 3336.5996080470013, 3381.7970921744773, 3408.3694516514524, 3426.3489936912406, 3463.5324231228965, 9729.61081556744, 9962.651307204213, 10040.849387259197, 10068.597256109673, 10116.797664046679, 9801.509924503745, 9979.151772099307, 10007.849882251772, 10011.549480273405, 10011.849822252672, 7430.851382972311, 7550.320471157622, 7567.205443428361, 7574.204708505527, 7578.583177925157, 4897.363342765418, 4988.625853060962, 5015.322931404214, 5093.694378337312, 5163.3545806774155, 9307.255419566283, 9316.254699623878, 9327.113924177193, 9354.766130846783, 9374.015728348699, 9208.12522810332, 9528.761780955532, 9574.329796914428, 9581.952090239503, 9599.568019439002, 6502.902456463063, 6572.671366431755, 6579.4736421087155, 6594.307597702364, 6601.141851559267, 7545.924540754741, 7591.620418978919, 7601.3918886490055, 7603.0496187976505, 7623.580703061163, 6663.0, 6788.422984046411, 6918.584884906922, 6963.825904352431, 7090.539114957512, 6888.862222755617, 6892.931070689429, 6956.339147780953, 7001.684924178322, 7053.259407762111, 5632.070708333079, 5812.796552120655, 5818.970905145447, 5940.108983652487, 5941.31674857397, 4122.876313710593, 4169.97915010423, 4195.349720793282, 4277.165952639206, 4285.742855428684, 4350.434443522448, 4358.237308471068, 4368.126374725004, 4461.286194208911, 4471.217536930959], "value": 4165.682544695468, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.7714398485158, 299.6045220309192, 303.93617340358514, 307.38522954091803, 307.9584256125425, 4831.396075490564, 4852.68457550259, 4858.781354839032, 4861.2708093785905, 4868.902621947568, 4784.114938736337, 4808.663393562452, 4809.100405339897, 4811.711297322155, 4821.722243605447, 3617.2222972060936, 3741.438784182381, 3746.30693321735, 3806.276807406584, 3838.078861073336, 3753.7372383933134, 3836.5396152461744, 3847.6729477994263, 3853.807309634521, 3858.9228215435674, 3772.6981841452616, 3791.393377059671, 3797.525309336333, 3810.79040652764, 3837.4627552142724, 3625.256822351425, 3662.487251784739, 3787.9242415151816, 3808.733388662795, 3826.1773718650625, 3379.2227787608986, 3381.205416727067, 3399.3031428557088, 3399.5240666306736, 3408.7613867029318, 4702.083093796711, 4704.882377940545, 4721.811127554894, 4724.928796282409, 4734.19518681825, 4253.532111467736, 4349.086691794727, 4353.782310884475, 4362.214801335758, 4375.890602734957, 5008.624353173526, 5029.899402011976, 5038.0, 5041.773120209599, 5043.621728370387, 3722.516072910504, 3726.2920045191327, 3728.9677125966414, 3732.4246270073563, 3738.2897249522503, 5012.949870501321, 5231.503007214346, 5302.390225124122, 5307.442718514578, 5318.149096144598, 3773.6226377362595, 3786.3184626767447, 3790.6209379061875, 3793.4499497572697, 3809.8285577149095, 3839.731218814712, 3843.0, 3843.5195600549932, 3846.000039989623, 3852.0339338709596, 4283.528811830696, 4289.678274129453, 4293.334533147367, 4303.849365272263, 4317.805698743564, 4746.620270378361, 4986.800527978913, 5025.39695236574, 5032.295478632995, 5054.570361519239, 1272.2366580051894, 1283.7239993401276, 1285.2930888011556, 1285.8392700912386, 1287.6008437384442, 825.5459497276474, 826.2398593294183, 832.3341326938425, 837.1335667584143, 861.7543999959981, 4412.382266482695, 4419.977900110479, 4436.334549817553, 4442.68901176921, 4443.0, 5116.820911268088, 5119.283300337956, 5120.18077107661, 5136.43499215086, 5137.922931156036, 4302.623160588581, 4413.3821265022925, 4420.425344705232, 4425.822967081345, 4431.556844315607, 2710.6340644012807, 2728.7953403494816, 2730.1400058981358, 2733.8633068346503, 2736.712645172268, 4832.275158726219, 4843.4430040545085, 4845.2732090186755, 4857.4171099467585, 4875.34182885313, 5057.924131138036, 5186.766595503212, 5204.9739751301, 5209.0, 5233.371995360505, 4832.420109586872, 4847.418309802776, 4862.878428039327, 4869.683470574401, 4875.195592727231, 5091.312672789126, 5099.184130539096, 5101.571559963216, 5106.029854327814, 5109.9744501277255, 4814.459373000746, 5026.47222041695, 5027.924581131213, 5043.773030213576, 5154.639175257696, 4933.9506604933495, 4944.0, 4969.403671559436, 4970.304157418037, 4970.676906001243, 3671.6144804795113, 3673.0, 3695.8336874841234, 3702.111493241549, 3708.6463440844436, 5062.249712541008, 5228.058949388995, 5247.632665713516, 5260.526552610283, 5268.841934741964, 5006.299118123393, 5017.347744793154, 5033.13773903658, 5041.495850414929, 5058.241263810458, 5010.847505073781, 5011.323471331323, 5014.4676938146, 5024.799008039638, 5037.848864534069, 4686.437627484724, 4934.432540257916, 4952.752362381794, 4960.0, 4965.155923493087, 4834.927476087932, 4980.302757613865, 4981.676191047571, 4986.950130498649, 5054.721990290423, 4820.807167713392, 4883.902321953612, 4886.169351210374, 4953.0, 4981.62637802159], "value": 3808.829105575687, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.0676569716643, 711.0010435338352, 730.6273800361815, 744.6797876912927, 748.8652042632324, 12617.747645047106, 13234.53679121231, 13258.867411325884, 13264.204147751117, 13268.20390776554, 11476.598319058834, 12785.296808675519, 12797.936010319936, 12807.487700491969, 12815.871841281585, 757.7840315510094, 770.1951460723558, 773.736929443989, 774.481097664566, 776.0997243197892, 626.1609443345916, 762.6339357108591, 769.6305773228853, 772.8686123359014, 793.6269953122023, 825.6821123867294, 830.024720952881, 833.9833203335929, 834.8580741273998, 834.9373796965222, 655.7508146904194, 827.5489858027329, 829.3158144530756, 829.3531045784327, 829.701307529289, 582.1820342418908, 595.2291782142137, 597.8146774499919, 599.4365296621206, 600.2526854066672, 11456.770864582662, 11476.139289553317, 11483.311001339946, 11497.425128743529, 11498.885011149949, 11573.42132893352, 11777.11671624623, 11886.940565297118, 11957.521699132025, 12021.699457513545, 11242.831357529643, 11270.43647817614, 11439.142064345207, 11503.539858405653, 11701.590444334493, 3916.4908561886773, 3946.881593552198, 3976.0855003349393, 4014.5383280922483, 4100.610442008035, 61795.0, 61824.38175618231, 62395.37604623941, 63535.68232158856, 63596.0, 8961.840767647767, 9131.452112873249, 9169.449833010041, 9292.7676808079, 9406.529673516434, 16444.6711065778, 16446.0, 16456.424025159064, 16489.505314840335, 16506.75239871403, 6674.799756007327, 6685.598864068172, 6772.11962444879, 6794.150731158606, 6931.514793964475, 3607.5851277102943, 3641.7997010164167, 3648.087978005499, 3665.4501824726503, 3678.963210367862, 2688.368233465134, 2764.7926405519665, 2771.6119743235963, 2778.6387769589824, 2780.0547813743424, 489.41270475429627, 491.2336754662738, 501.5937090956337, 502.1313128288009, 542.3112646938366, 525.2751203339367, 529.8728305206799, 551.969641669712, 557.5901712241499, 560.4059696721488, 7735.3424958878, 7989.880151797728, 8077.313428358538, 8179.836403271901, 8375.58122093905, 523.7904838064728, 539.9298091248113, 593.8693487432757, 594.4649815166384, 599.1252770954368, 3923.4507168996365, 3931.724779265424, 3931.9213615727526, 3992.54085780139, 4058.2695114879607, 76048.0, 104975.0, 110393.0, 113027.43486282516, 115390.42304788422, 82672.0, 82758.17241827626, 83712.58143709364, 84232.57883710542, 85730.57134714286, 69599.3040069603, 73784.63107684428, 74535.25464745284, 75076.62461687766, 75616.62191689006, 8305.480198044506, 8355.456895301786, 8432.957835210786, 8515.446495977742, 8764.824703506021, 37222.813885930394, 43178.56821431871, 43814.0, 44256.778716106215, 44527.55472445234, 57552.0, 57923.0, 60963.69518152558, 64569.35430645821, 64600.0, 11003.449827508754, 11207.887921121011, 11386.829197561878, 11431.828522572001, 11570.479328430072, 13121.671958201121, 13252.801207981694, 13381.866181338062, 13575.117617354841, 13609.863901360859, 12038.398080096134, 12414.317212553397, 12806.167599106027, 12949.158304710163, 13018.0, 12084.0, 12117.636470905887, 12172.573959911715, 12568.30874301922, 12757.55348562833, 10378.896211037792, 10610.946945265225, 10611.575536978435, 10689.786204276026, 11012.669619911416, 9710.660126895526, 9959.836964885993, 10067.798644026932, 10473.633422830164, 10569.894301056891, 10485.842712359168, 10504.212184086071, 10649.840252396065, 10671.46642667879, 10817.350958942488], "value": 6524.6855150142255, "unit": "score"}], "name": "dromaeo_css", "value": 6379.930300486966, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 113.0, 115.0, 112.0, 112.0, 114.0, 111.0, 111.0, 111.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 123.0, 125.0, 180.0, 122.0, 123.0, 142.0, 123.0, 152.0, 122.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 161.0, 159.0, 162.0, 163.0, 162.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 128.0, 76.0, 77.0, 81.0, 76.0, 100.0, 76.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 114.0, 85.0, 86.0, 85.0, 118.0, 85.0, 86.0, 130.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 145.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0, 64.0, 64.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 65.0, 66.0, 65.0, 65.0, 66.0, 66.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 81.0, 78.0, 84.0, 80.0, 79.0, 88.0, 80.0, 80.0, 79.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 133.0, 143.0, 135.0, 129.0, 128.0, 126.0, 129.0, 185.0, 131.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 170.0, 168.0, 166.0, 168.0, 165.0, 165.0, 168.0, 173.0, 166.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 65.0, 66.0, 67.0, 66.0, 66.0, 66.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1530.1999999999996, "alertThreshold": 2.0}]} 09:00:53 INFO - Return code: 0 09:00:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:00:53 INFO - # TBPL SUCCESS # 09:00:53 INFO - Running post-action listener: _resource_record_post_action 09:00:53 INFO - ##### 09:00:53 INFO - ##### Finished run-tests step (success) 09:00:53 INFO - ##### 09:00:53 INFO - Running post-run listener: _resource_record_post_run 09:00:53 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534777856; Read time: 20; Write time: 648744 09:00:53 INFO - TinderboxPrint: CPU usage
13.0% 09:00:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 09:00:53 INFO - TinderboxPrint: I/O write bytes / time
534,777,856 / 648,744 09:00:53 INFO - TinderboxPrint: CPU idle
8,333.0 (87.0%) 09:00:53 INFO - TinderboxPrint: CPU user
1,198.6 (12.5%) 09:00:53 INFO - TinderboxPrint: Swap in / out
0 / 0 09:00:53 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 245796864; Read time: 0; Write time: 408616 09:00:53 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 288219136; Read time: 0; Write time: 240108 09:00:54 INFO - Running post-run listener: _upload_blobber_files 09:00:54 INFO - Blob upload gear active. 09:00:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:00:54 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 09:00:54 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'] 09:00:54 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 09:00:54 INFO - (blobuploader) - INFO - Open directory for files ... 09:00:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:00:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:00:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:57 INFO - (blobuploader) - INFO - Done attempting. 09:00:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:00:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:00:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:58 INFO - (blobuploader) - INFO - Done attempting. 09:00:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:00:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:00:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:59 INFO - (blobuploader) - INFO - Done attempting. 09:00:59 INFO - (blobuploader) - INFO - Iteration through files over. 09:00:59 INFO - Return code: 0 09:00:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:00:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:00:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4eeed6e519f43e78d239c5df8b49338d83a52df6fccefd6e93772eba910b2bb54aaff64a89ea8208ba00f1ae92c366d8c76bcf46a9653a75fb8b4604facdacc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/77204de55a112ae8e6a3bbb81ff2bf18369c49f62b4b9848cfe8a1426a54980ed4e3da2ca2c1c328244c014c211bcebcfbaebed45ad9b5f8a8ab32a240d86753", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e0f2a4ea35c04453d3fe9855fcf441fdca2ae7c517bc1a0344f3d4535cde08b72ee635f82750c155216d09a094948173709146dac2e3930275d8171027611f5"} 09:00:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:00:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:00:59 INFO - Contents: 09:00:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4eeed6e519f43e78d239c5df8b49338d83a52df6fccefd6e93772eba910b2bb54aaff64a89ea8208ba00f1ae92c366d8c76bcf46a9653a75fb8b4604facdacc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/77204de55a112ae8e6a3bbb81ff2bf18369c49f62b4b9848cfe8a1426a54980ed4e3da2ca2c1c328244c014c211bcebcfbaebed45ad9b5f8a8ab32a240d86753", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e0f2a4ea35c04453d3fe9855fcf441fdca2ae7c517bc1a0344f3d4535cde08b72ee635f82750c155216d09a094948173709146dac2e3930275d8171027611f5"} 09:00:59 INFO - Running post-run listener: copy_logs_to_upload_dir 09:00:59 INFO - Copying logs to upload dir... 09:00:59 INFO - mkdir: /builds/slave/test/build/upload/logs 09:00:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.912809 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-06 09:00:59.146609) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 09:00:59.149933) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144 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/4eeed6e519f43e78d239c5df8b49338d83a52df6fccefd6e93772eba910b2bb54aaff64a89ea8208ba00f1ae92c366d8c76bcf46a9653a75fb8b4604facdacc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/77204de55a112ae8e6a3bbb81ff2bf18369c49f62b4b9848cfe8a1426a54980ed4e3da2ca2c1c328244c014c211bcebcfbaebed45ad9b5f8a8ab32a240d86753", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e0f2a4ea35c04453d3fe9855fcf441fdca2ae7c517bc1a0344f3d4535cde08b72ee635f82750c155216d09a094948173709146dac2e3930275d8171027611f5"} build_url:https://queue.taskcluster.net/v1/task/KiZeecaPTG2HC5zCggZj6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011194 build_url: 'https://queue.taskcluster.net/v1/task/KiZeecaPTG2HC5zCggZj6Q/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/4eeed6e519f43e78d239c5df8b49338d83a52df6fccefd6e93772eba910b2bb54aaff64a89ea8208ba00f1ae92c366d8c76bcf46a9653a75fb8b4604facdacc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/77204de55a112ae8e6a3bbb81ff2bf18369c49f62b4b9848cfe8a1426a54980ed4e3da2ca2c1c328244c014c211bcebcfbaebed45ad9b5f8a8ab32a240d86753", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e0f2a4ea35c04453d3fe9855fcf441fdca2ae7c517bc1a0344f3d4535cde08b72ee635f82750c155216d09a094948173709146dac2e3930275d8171027611f5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 09:00:59.178968) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:00:59.179289) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467819031.252442-291771144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:00:59.272750) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 09:00:59.273056) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 09:00:59.273332) ========= ========= Total master_lag: 0.17 =========