builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1468894740.2 results: success (0) buildid: 20160718163032 builduid: 4bd2f579fa7d4c45b91d9fd4e80327cd revision: feaaf1af1065257b9178faca8b67eed9657b4a17 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:00.199172) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:00.199649) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:00.199921) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:00.237680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:00.237966) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 19:19:00-- 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% 24.1M=0s 2016-07-18 19:19:00 (24.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179412 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:00.438880) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:00.439208) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017627 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:00.488522) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:00.488879) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev feaaf1af1065257b9178faca8b67eed9657b4a17 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev feaaf1af1065257b9178faca8b67eed9657b4a17 --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=a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 19:19:00,648 truncating revision to first 12 chars 2016-07-18 19:19:00,648 Setting DEBUG logging. 2016-07-18 19:19:00,648 attempt 1/10 2016-07-18 19:19:00,648 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/feaaf1af1065?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 19:19:00,963 unpacking tar archive at: mozilla-central-feaaf1af1065/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661744 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:01.163965) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:01.164280) ========= script_repo_revision: feaaf1af1065257b9178faca8b67eed9657b4a17 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:01.164709) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:01.164971) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 19:19:01.173954) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-18 19:19:01.174229) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:19:01 INFO - MultiFileLogger online at 20160718 19:19:01 in /builds/slave/test 19:19:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:19:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:19:01 INFO - {'append_to_log': False, 19:19:01 INFO - 'base_work_dir': '/builds/slave/test', 19:19:01 INFO - 'blob_upload_branch': 'Firefox', 19:19:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:19:01 INFO - 'branch': 'Firefox', 19:19:01 INFO - 'buildbot_json_path': 'buildprops.json', 19:19:01 INFO - 'config_files': ('talos/linux_config.py',), 19:19:01 INFO - 'default_actions': ('clobber', 19:19:01 INFO - 'read-buildbot-config', 19:19:01 INFO - 'download-and-extract', 19:19:01 INFO - 'populate-webroot', 19:19:01 INFO - 'create-virtualenv', 19:19:01 INFO - 'install', 19:19:01 INFO - 'run-tests'), 19:19:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:19:01 INFO - 'download_minidump_stackwalk': True, 19:19:01 INFO - 'download_symbols': 'ondemand', 19:19:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:19:01 INFO - 'tooltool.py': '/tools/tooltool.py', 19:19:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:19:01 INFO - '/tools/misc-python/virtualenv.py')}, 19:19:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:19:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:19:01 INFO - 'installer_path': 'installer.exe', 19:19:01 INFO - 'log_level': 'info', 19:19:01 INFO - 'log_name': 'talos', 19:19:01 INFO - 'log_to_console': True, 19:19:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:19:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:19:01 INFO - 'opt_config_files': (), 19:19:01 INFO - 'pip_index': False, 19:19:01 INFO - 'sps_profile': False, 19:19:01 INFO - 'sps_profile_interval': 0, 19:19:01 INFO - 'suite': 'dromaeojs-e10s', 19:19:01 INFO - 'system_bits': '32', 19:19:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:19:01 INFO - 'title': 'talos-linux64-ix-062', 19:19:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:19:01 INFO - 'use_talos_json': True, 19:19:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:19:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:19:01 INFO - 'work_dir': 'build'} 19:19:01 INFO - ##### 19:19:01 INFO - ##### Running clobber step. 19:19:01 INFO - ##### 19:19:01 INFO - Running pre-action listener: _resource_record_pre_action 19:19:01 INFO - Running main action method: clobber 19:19:01 INFO - rmtree: /builds/slave/test/build 19:19:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:19:01 INFO - Running post-action listener: _resource_record_post_action 19:19:01 INFO - ##### 19:19:01 INFO - ##### Finished clobber step (success) 19:19:01 INFO - ##### 19:19:01 INFO - ##### 19:19:01 INFO - ##### Running read-buildbot-config step. 19:19:01 INFO - ##### 19:19:01 INFO - Running pre-action listener: _resource_record_pre_action 19:19:01 INFO - Running main action method: read_buildbot_config 19:19:01 INFO - Using buildbot properties: 19:19:01 INFO - { 19:19:01 INFO - "project": "", 19:19:01 INFO - "product": "firefox", 19:19:01 INFO - "script_repo_revision": "production", 19:19:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:19:01 INFO - "repository": "", 19:19:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 19:19:01 INFO - "buildid": "20160718163032", 19:19:01 INFO - "pgo_build": "True", 19:19:01 INFO - "basedir": "/builds/slave/test", 19:19:01 INFO - "buildnumber": 9, 19:19:01 INFO - "slavename": "talos-linux64-ix-062", 19:19:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:19:01 INFO - "platform": "ubuntu64_hw", 19:19:01 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:19:01 INFO - "branch": "mozilla-central", 19:19:01 INFO - "repo_path": "mozilla-central", 19:19:01 INFO - "revision": "feaaf1af1065257b9178faca8b67eed9657b4a17", 19:19:01 INFO - "stage_platform": "linux64-pgo", 19:19:01 INFO - "builduid": "4bd2f579fa7d4c45b91d9fd4e80327cd", 19:19:01 INFO - "slavebuilddir": "test" 19:19:01 INFO - } 19:19:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:19:01 INFO - Running post-action listener: _resource_record_post_action 19:19:01 INFO - ##### 19:19:01 INFO - ##### Finished read-buildbot-config step (success) 19:19:01 INFO - ##### 19:19:01 INFO - ##### 19:19:01 INFO - ##### Running download-and-extract step. 19:19:01 INFO - ##### 19:19:01 INFO - Running pre-action listener: _resource_record_pre_action 19:19:01 INFO - Running main action method: download_and_extract 19:19:01 INFO - mkdir: /builds/slave/test/build/tests 19:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:01 INFO - https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:19:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:19:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:19:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/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 19:19:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/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 19:19:04 INFO - Downloaded 1361 bytes. 19:19:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:19:04 INFO - Using the following test package requirements: 19:19:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:19:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:19:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:19:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:19:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:19:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:19:04 INFO - u'jsshell-linux-x86_64.zip'], 19:19:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:19:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:19:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:19:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:19:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:19:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:19:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:19:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:19:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:19:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:19:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:19:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:04 INFO - https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:19:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:19:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:19:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/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 19:19:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/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 19:19:05 INFO - Downloaded 24333956 bytes. 19:19:05 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'] 19:19:05 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 19:19:06 INFO - Return code: 0 19:19:06 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 19:19:06 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')]} 19:19:06 INFO - https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:19:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:19:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:19:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/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 19:19:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/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 19:19:23 INFO - Downloaded 24333956 bytes. 19:19: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'] 19:19: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 19:19:24 INFO - Return code: 0 19:19: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')]} 19:19:24 INFO - https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:19:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:19:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:19:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/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 19:19:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/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 19:19:26 INFO - Downloaded 14403317 bytes. 19:19:26 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'] 19:19:26 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 19:19:26 INFO - Return code: 0 19:19:26 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')]} 19:19:26 INFO - https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:19:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:19:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:19:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/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 19:19:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U4lFs8IqS3OxMBbfrIxyvw/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 19:19:28 INFO - Downloaded 60836145 bytes. 19:19:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:19:28 INFO - mkdir: /builds/slave/test/properties 19:19:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:19:28 INFO - Writing to file /builds/slave/test/properties/build_url 19:19:28 INFO - Contents: 19:19:28 INFO - build_url:https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:19:29 INFO - Running post-action listener: _resource_record_post_action 19:19:29 INFO - Running post-action listener: set_extra_try_arguments 19:19:29 INFO - ##### 19:19:29 INFO - ##### Finished download-and-extract step (success) 19:19:29 INFO - ##### 19:19:29 INFO - ##### 19:19:29 INFO - ##### Running populate-webroot step. 19:19:29 INFO - ##### 19:19:29 INFO - Running pre-action listener: _resource_record_pre_action 19:19:29 INFO - Running main action method: populate_webroot 19:19:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:19:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:19:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:19:29 INFO - '--tppagecycles', 19:19:29 INFO - '7'], 19:19:29 INFO - 'tests': ['tsvgm']}}, 19:19:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:19:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:19:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:19:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:19:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:19:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:19:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:29 INFO - 'talos_options': ['--disable-e10s'], 19:19:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:19:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:19:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:29 INFO - 'talos_options': ['--disable-e10s'], 19:19:29 INFO - 'tests': ['damp', 'tps']}, 19:19:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:29 INFO - 'tests': ['damp', 'tps']}, 19:19:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:19:29 INFO - 'tests': ['dromaeo_dom']}, 19:19:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:19:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:19:29 INFO - 'tests': ['basic_compositor_video']}, 19:19:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:19:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:19:29 INFO - 'tests': ['a11yr', 19:19:29 INFO - 'ts_paint', 19:19:29 INFO - 'tpaint', 19:19:29 INFO - 'sessionrestore', 19:19:29 INFO - 'sessionrestore_no_auto_restore', 19:19:29 INFO - 'tabpaint']}, 19:19:29 INFO - 'other-e10s': {'tests': ['a11yr', 19:19:29 INFO - 'ts_paint', 19:19:29 INFO - 'tpaint', 19:19:29 INFO - 'sessionrestore', 19:19:29 INFO - 'sessionrestore_no_auto_restore', 19:19:29 INFO - 'tabpaint']}, 19:19:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:19:29 INFO - 'ts_paint', 19:19:29 INFO - 'tpaint', 19:19:29 INFO - 'sessionrestore', 19:19:29 INFO - 'sessionrestore_no_auto_restore', 19:19:29 INFO - 'tabpaint']}, 19:19:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:19:29 INFO - 'ts_paint', 19:19:29 INFO - 'tpaint', 19:19:29 INFO - 'sessionrestore', 19:19:29 INFO - 'sessionrestore_no_auto_restore', 19:19:29 INFO - 'tabpaint']}, 19:19:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:19:29 INFO - 'tests': ['a11yr', 19:19:29 INFO - 'ts_paint', 19:19:29 INFO - 'tpaint', 19:19:29 INFO - 'sessionrestore', 19:19:29 INFO - 'sessionrestore_no_auto_restore', 19:19:29 INFO - 'tabpaint']}, 19:19:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:19:29 INFO - 'tests': ['a11yr', 19:19:29 INFO - 'ts_paint', 19:19:29 INFO - 'tpaint', 19:19:29 INFO - 'sessionrestore', 19:19:29 INFO - 'sessionrestore_no_auto_restore', 19:19:29 INFO - 'tabpaint']}, 19:19:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:19:29 INFO - 'tests': ['tsvgx', 19:19:29 INFO - 'tsvgr_opacity', 19:19:29 INFO - 'tart', 19:19:29 INFO - 'tscrollx', 19:19:29 INFO - 'cart']}, 19:19:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:19:29 INFO - 'tsvgr_opacity', 19:19:29 INFO - 'tart', 19:19:29 INFO - 'tscrollx', 19:19:29 INFO - 'cart']}, 19:19:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:29 INFO - 'talos_options': ['--disable-e10s'], 19:19:29 INFO - 'tests': ['tp5o']}, 19:19:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:29 INFO - 'tests': ['tp5o']}, 19:19:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:29 INFO - 'talos_options': ['--disable-e10s', 19:19:29 INFO - '--xperf_path', 19:19:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:19:29 INFO - 'tests': ['tp5n']}, 19:19:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:29 INFO - 'talos_options': ['--xperf_path', 19:19:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:19:29 INFO - 'tests': ['tp5n']}}, 19:19:29 INFO - 'talos.zip': {'path': '', 19:19:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:19:29 INFO - Running post-action listener: _resource_record_post_action 19:19:29 INFO - ##### 19:19:29 INFO - ##### Finished populate-webroot step (success) 19:19:29 INFO - ##### 19:19:29 INFO - ##### 19:19:29 INFO - ##### Running create-virtualenv step. 19:19:29 INFO - ##### 19:19:29 INFO - Running pre-action listener: _resource_record_pre_action 19:19:29 INFO - Running main action method: create_virtualenv 19:19:29 INFO - Creating virtualenv /builds/slave/test/build/venv 19:19:29 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 19:19:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:19:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:19:29 INFO - Using real prefix '/usr' 19:19:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:19:30 INFO - Installing distribute.............................................................................................................................................................................................done. 19:19:31 INFO - Installing pip.................done. 19:19:32 INFO - Return code: 0 19:19:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:32 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 0xb1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde3b0>, '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 0xddf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddf740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183', '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 19:19:32 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 19:19:32 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 19:19:32 INFO - Using env: {'DISPLAY': ':0', 19:19:32 INFO - 'HOME': '/home/cltbld', 19:19:32 INFO - 'LANG': 'en_US.UTF-8', 19:19:32 INFO - 'LANGUAGE': 'en_US:en', 19:19:32 INFO - 'LOGNAME': 'cltbld', 19:19:32 INFO - 'MAIL': '/var/mail/cltbld', 19:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:32 INFO - 'MOZ_NO_REMOTE': '1', 19:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:32 INFO - 'NO_EM_RESTART': '1', 19:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:32 INFO - 'PWD': '/builds/slave/test', 19:19:32 INFO - 'SHELL': '/bin/bash', 19:19:32 INFO - 'SHLVL': '1', 19:19:32 INFO - 'TERM': 'linux', 19:19:32 INFO - 'TMOUT': '86400', 19:19:32 INFO - 'USER': 'cltbld', 19:19:32 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183', 19:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:32 INFO - '_': '/tools/buildbot/bin/python'} 19:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:32 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 19:19:32 INFO - Cleaning up... 19:19:32 INFO - Return code: 0 19:19:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:32 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 0xb1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde3b0>, '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 0xddf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddf740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183', '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 19:19:32 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 19:19:32 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 19:19:32 INFO - Using env: {'DISPLAY': ':0', 19:19:32 INFO - 'HOME': '/home/cltbld', 19:19:32 INFO - 'LANG': 'en_US.UTF-8', 19:19:32 INFO - 'LANGUAGE': 'en_US:en', 19:19:32 INFO - 'LOGNAME': 'cltbld', 19:19:32 INFO - 'MAIL': '/var/mail/cltbld', 19:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:32 INFO - 'MOZ_NO_REMOTE': '1', 19:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:32 INFO - 'NO_EM_RESTART': '1', 19:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:32 INFO - 'PWD': '/builds/slave/test', 19:19:32 INFO - 'SHELL': '/bin/bash', 19:19:32 INFO - 'SHLVL': '1', 19:19:32 INFO - 'TERM': 'linux', 19:19:32 INFO - 'TMOUT': '86400', 19:19:32 INFO - 'USER': 'cltbld', 19:19:32 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183', 19:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:32 INFO - '_': '/tools/buildbot/bin/python'} 19:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:32 INFO - Downloading/unpacking psutil>=3.1.1 19:19:32 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 19:19:32 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 19:19:32 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 19:19:32 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 19:19:32 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 19:19:32 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 19:19:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:19:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:19:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:19:34 INFO - Installing collected packages: psutil 19:19:34 INFO - Running setup.py install for psutil 19:19:34 INFO - building 'psutil._psutil_linux' extension 19:19:34 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 19:19:35 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 19:19:35 INFO - building 'psutil._psutil_posix' extension 19:19:35 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 19:19: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 19:19:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:19:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:19:36 INFO - Successfully installed psutil 19:19:36 INFO - Cleaning up... 19:19:36 INFO - Return code: 0 19:19:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:19: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')]} 19:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19: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')]} 19:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19: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 0xb1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde3b0>, '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 0xddf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddf740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183', '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 19:19: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 19:19: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 19:19:36 INFO - Using env: {'DISPLAY': ':0', 19:19:36 INFO - 'HOME': '/home/cltbld', 19:19:36 INFO - 'LANG': 'en_US.UTF-8', 19:19:36 INFO - 'LANGUAGE': 'en_US:en', 19:19:36 INFO - 'LOGNAME': 'cltbld', 19:19:36 INFO - 'MAIL': '/var/mail/cltbld', 19:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:36 INFO - 'MOZ_NO_REMOTE': '1', 19:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:36 INFO - 'NO_EM_RESTART': '1', 19:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:36 INFO - 'PWD': '/builds/slave/test', 19:19:36 INFO - 'SHELL': '/bin/bash', 19:19:36 INFO - 'SHLVL': '1', 19:19:36 INFO - 'TERM': 'linux', 19:19:36 INFO - 'TMOUT': '86400', 19:19:36 INFO - 'USER': 'cltbld', 19:19:36 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183', 19:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:36 INFO - '_': '/tools/buildbot/bin/python'} 19:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:19: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 19:19: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 19:19: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 19:19: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 19:19: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 19:19: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 19:19:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:19:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:19:38 INFO - Installing collected packages: mozsystemmonitor 19:19:38 INFO - Running setup.py install for mozsystemmonitor 19:19:38 INFO - Successfully installed mozsystemmonitor 19:19:38 INFO - Cleaning up... 19:19:38 INFO - Return code: 0 19:19:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:19: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')]} 19:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19: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')]} 19:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19: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 0xb1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde3b0>, '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 0xddf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddf740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183', '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 19:19: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 19:19: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 19:19:38 INFO - Using env: {'DISPLAY': ':0', 19:19:38 INFO - 'HOME': '/home/cltbld', 19:19:38 INFO - 'LANG': 'en_US.UTF-8', 19:19:38 INFO - 'LANGUAGE': 'en_US:en', 19:19:38 INFO - 'LOGNAME': 'cltbld', 19:19:38 INFO - 'MAIL': '/var/mail/cltbld', 19:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:38 INFO - 'MOZ_NO_REMOTE': '1', 19:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:38 INFO - 'NO_EM_RESTART': '1', 19:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:38 INFO - 'PWD': '/builds/slave/test', 19:19:38 INFO - 'SHELL': '/bin/bash', 19:19:38 INFO - 'SHLVL': '1', 19:19:38 INFO - 'TERM': 'linux', 19:19:38 INFO - 'TMOUT': '86400', 19:19:38 INFO - 'USER': 'cltbld', 19:19:38 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183', 19:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:38 INFO - '_': '/tools/buildbot/bin/python'} 19:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:38 INFO - Downloading/unpacking jsonschema==2.5.1 19:19:38 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 19:19:38 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 19:19:38 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 19:19:38 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 19:19:38 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 19:19:38 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 19:19:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:19:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:19:40 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 19:19:40 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 19:19:40 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 19:19:40 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 19:19:40 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 19:19:40 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 19:19:41 INFO - Downloading functools32-3.2.3-2.tar.gz 19:19:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:19:41 INFO - warning: no files found matching '*.txt' 19:19:41 INFO - no previously-included directories found matching 'build' 19:19:41 INFO - no previously-included directories found matching 'dist' 19:19:41 INFO - no previously-included directories found matching '.git*' 19:19:41 INFO - Installing collected packages: jsonschema, functools32 19:19:41 INFO - Running setup.py install for functools32 19:19:41 INFO - warning: no files found matching '*.txt' 19:19:41 INFO - no previously-included directories found matching 'build' 19:19:41 INFO - no previously-included directories found matching 'dist' 19:19:41 INFO - no previously-included directories found matching '.git*' 19:19:41 INFO - Successfully installed jsonschema functools32 19:19:41 INFO - Cleaning up... 19:19:41 INFO - Return code: 0 19:19:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:19: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')]} 19:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19: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')]} 19:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19: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 0xb1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde3b0>, '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 0xddf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddf740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183', '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 19:19: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 19:19: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 19:19:41 INFO - Using env: {'DISPLAY': ':0', 19:19:41 INFO - 'HOME': '/home/cltbld', 19:19:41 INFO - 'LANG': 'en_US.UTF-8', 19:19:41 INFO - 'LANGUAGE': 'en_US:en', 19:19:41 INFO - 'LOGNAME': 'cltbld', 19:19:41 INFO - 'MAIL': '/var/mail/cltbld', 19:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:41 INFO - 'MOZ_NO_REMOTE': '1', 19:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:41 INFO - 'NO_EM_RESTART': '1', 19:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:41 INFO - 'PWD': '/builds/slave/test', 19:19:41 INFO - 'SHELL': '/bin/bash', 19:19:41 INFO - 'SHLVL': '1', 19:19:41 INFO - 'TERM': 'linux', 19:19:41 INFO - 'TMOUT': '86400', 19:19:41 INFO - 'USER': 'cltbld', 19:19:41 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183', 19:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:41 INFO - '_': '/tools/buildbot/bin/python'} 19:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:41 INFO - Downloading/unpacking blobuploader==1.2.4 19:19: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 19:19: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 19:19: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 19:19: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 19:19: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 19:19: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 19:19:43 INFO - Downloading blobuploader-1.2.4.tar.gz 19:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:19:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:19: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 19:19: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 19:19: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 19:19: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 19:19: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 19:19: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 19:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:19:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:19: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 19:19: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 19:19: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 19:19: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 19:19: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 19:19: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 19:19:44 INFO - Downloading docopt-0.6.1.tar.gz 19:19:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:19:44 INFO - Installing collected packages: blobuploader, requests, docopt 19:19:44 INFO - Running setup.py install for blobuploader 19:19:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:19:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:19:44 INFO - Running setup.py install for requests 19:19:44 INFO - Running setup.py install for docopt 19:19:44 INFO - Successfully installed blobuploader requests docopt 19:19:44 INFO - Cleaning up... 19:19:44 INFO - Return code: 0 19:19:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:44 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 0xb1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde3b0>, '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 0xddf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddf740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183', '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 19:19:44 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 19:19:44 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 19:19:44 INFO - Using env: {'DISPLAY': ':0', 19:19:44 INFO - 'HOME': '/home/cltbld', 19:19:44 INFO - 'LANG': 'en_US.UTF-8', 19:19:44 INFO - 'LANGUAGE': 'en_US:en', 19:19:44 INFO - 'LOGNAME': 'cltbld', 19:19:44 INFO - 'MAIL': '/var/mail/cltbld', 19:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:44 INFO - 'MOZ_NO_REMOTE': '1', 19:19:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:44 INFO - 'NO_EM_RESTART': '1', 19:19:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:44 INFO - 'PWD': '/builds/slave/test', 19:19:44 INFO - 'SHELL': '/bin/bash', 19:19:44 INFO - 'SHLVL': '1', 19:19:44 INFO - 'TERM': 'linux', 19:19:44 INFO - 'TMOUT': '86400', 19:19:44 INFO - 'USER': 'cltbld', 19:19:44 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183', 19:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:44 INFO - '_': '/tools/buildbot/bin/python'} 19:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:19:45 INFO - Running setup.py (path:/tmp/pip-Xf1BwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:19:45 INFO - Running setup.py (path:/tmp/pip-9nctCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:19:45 INFO - Running setup.py (path:/tmp/pip-D0j_6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:19:45 INFO - Running setup.py (path:/tmp/pip-4c4OEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:19:45 INFO - Running setup.py (path:/tmp/pip-yMM0XN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:19:45 INFO - Running setup.py (path:/tmp/pip-ByAc7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:19:45 INFO - Running setup.py (path:/tmp/pip-sGigDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:19:45 INFO - Running setup.py (path:/tmp/pip-BUx5pU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:19:45 INFO - Running setup.py (path:/tmp/pip-pEGDqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:19:45 INFO - Running setup.py (path:/tmp/pip-20iY7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:19:45 INFO - Running setup.py (path:/tmp/pip-HLkDam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:19:45 INFO - Running setup.py (path:/tmp/pip-hVjQpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:19:45 INFO - Running setup.py (path:/tmp/pip-81MWuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:19:46 INFO - Running setup.py (path:/tmp/pip-mWbM4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:19:46 INFO - Running setup.py (path:/tmp/pip-fLgN2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:19:46 INFO - Running setup.py (path:/tmp/pip-BryDL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:19:46 INFO - Running setup.py (path:/tmp/pip-h0o7fB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:19:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:19:46 INFO - Running setup.py install for manifestparser 19:19:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:19:46 INFO - Running setup.py install for mozcrash 19:19:46 INFO - Running setup.py install for mozdebug 19:19:46 INFO - Running setup.py install for mozdevice 19:19:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:19:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:19:46 INFO - Running setup.py install for mozfile 19:19:46 INFO - Running setup.py install for mozhttpd 19:19:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:19:46 INFO - Running setup.py install for mozinfo 19:19:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:19:47 INFO - Running setup.py install for mozInstall 19:19:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:19:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:19:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:19:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:19:47 INFO - Running setup.py install for mozleak 19:19:47 INFO - Running setup.py install for mozlog 19:19:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:19:47 INFO - Running setup.py install for moznetwork 19:19:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:19:47 INFO - Running setup.py install for mozprocess 19:19:47 INFO - Running setup.py install for mozprofile 19:19:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:19:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:19:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:19:47 INFO - Running setup.py install for mozrunner 19:19:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:19:47 INFO - Running setup.py install for mozscreenshot 19:19:47 INFO - Running setup.py install for moztest 19:19:47 INFO - Running setup.py install for mozversion 19:19:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:19:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:19:48 INFO - Cleaning up... 19:19:48 INFO - Return code: 0 19:19:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:19: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')]} 19:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19: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')]} 19:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19: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 0xb1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde3b0>, '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 0xddf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddf740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183', '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 19:19: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 19:19: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 19:19:48 INFO - Using env: {'DISPLAY': ':0', 19:19:48 INFO - 'HOME': '/home/cltbld', 19:19:48 INFO - 'LANG': 'en_US.UTF-8', 19:19:48 INFO - 'LANGUAGE': 'en_US:en', 19:19:48 INFO - 'LOGNAME': 'cltbld', 19:19:48 INFO - 'MAIL': '/var/mail/cltbld', 19:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:48 INFO - 'MOZ_NO_REMOTE': '1', 19:19:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:48 INFO - 'NO_EM_RESTART': '1', 19:19:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:48 INFO - 'PWD': '/builds/slave/test', 19:19:48 INFO - 'SHELL': '/bin/bash', 19:19:48 INFO - 'SHLVL': '1', 19:19:48 INFO - 'TERM': 'linux', 19:19:48 INFO - 'TMOUT': '86400', 19:19:48 INFO - 'USER': 'cltbld', 19:19:48 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183', 19:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:48 INFO - '_': '/tools/buildbot/bin/python'} 19:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:19:48 INFO - Running setup.py (path:/tmp/pip-000f4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:19: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)) 19:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:19:48 INFO - Running setup.py (path:/tmp/pip-o1bwBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:19: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)) 19:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:19:48 INFO - Running setup.py (path:/tmp/pip-PtNt8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:19: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)) 19:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:19:48 INFO - Running setup.py (path:/tmp/pip-ZavPGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:19: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)) 19:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:19:48 INFO - Running setup.py (path:/tmp/pip-onYo9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:19: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)) 19:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:19:48 INFO - Running setup.py (path:/tmp/pip-P3wcKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:19:48 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)) 19:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:19:48 INFO - Running setup.py (path:/tmp/pip-r0Qt44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:19:48 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)) 19:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:19:48 INFO - Running setup.py (path:/tmp/pip-wyMNHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:19:48 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)) 19:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:19:48 INFO - Running setup.py (path:/tmp/pip-IqxpnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:19:48 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)) 19:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:19:48 INFO - Running setup.py (path:/tmp/pip-R5hd7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:19: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)) 19:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:19:49 INFO - Running setup.py (path:/tmp/pip-0f9oHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:19: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)) 19:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:19:49 INFO - Running setup.py (path:/tmp/pip-_9Sv7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:19:49 INFO - Running setup.py (path:/tmp/pip-m9ErfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:19: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)) 19:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:19:49 INFO - Running setup.py (path:/tmp/pip-AVSuyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:19:49 INFO - Running setup.py (path:/tmp/pip-ucyDBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:19: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)) 19:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:19:49 INFO - Running setup.py (path:/tmp/pip-tS5S9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:19: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)) 19:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:19:49 INFO - Running setup.py (path:/tmp/pip-HplnTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:19: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)) 19:19: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)) 19:19: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)) 19:19: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)) 19:19: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)) 19:19: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)) 19:19:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:19: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 19:19: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 19:19: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 19:19: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 19:19: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 19:19: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 19:19:51 INFO - Downloading blessings-1.6.tar.gz 19:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:19:51 INFO - Installing collected packages: blessings 19:19:51 INFO - Running setup.py install for blessings 19:19:51 INFO - Successfully installed blessings 19:19:51 INFO - Cleaning up... 19:19:51 INFO - Return code: 0 19:19:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:19:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:19:51 INFO - Reading from file tmpfile_stdout 19:19:51 INFO - Current package versions: 19:19:51 INFO - argparse == 1.2.1 19:19:51 INFO - blessings == 1.6 19:19:51 INFO - blobuploader == 1.2.4 19:19:51 INFO - docopt == 0.6.1 19:19:51 INFO - functools32 == 3.2.3-2 19:19:51 INFO - jsonschema == 2.5.1 19:19:51 INFO - manifestparser == 1.1 19:19:51 INFO - mozInstall == 1.12 19:19:51 INFO - mozcrash == 0.17 19:19:51 INFO - mozdebug == 0.1 19:19:51 INFO - mozdevice == 0.48 19:19:51 INFO - mozfile == 1.2 19:19:51 INFO - mozhttpd == 0.7 19:19:51 INFO - mozinfo == 0.9 19:19:51 INFO - mozleak == 0.1 19:19:51 INFO - mozlog == 3.2 19:19:51 INFO - moznetwork == 0.27 19:19:51 INFO - mozprocess == 0.23 19:19:51 INFO - mozprofile == 0.28 19:19:51 INFO - mozrunner == 6.12 19:19:51 INFO - mozscreenshot == 0.1 19:19:51 INFO - mozsystemmonitor == 0.3 19:19:51 INFO - moztest == 0.7 19:19:51 INFO - mozversion == 1.4 19:19:51 INFO - psutil == 3.1.1 19:19:51 INFO - requests == 1.2.3 19:19:51 INFO - wsgiref == 0.1.2 19:19:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:51 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 0xb1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde3b0>, '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 0xddf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddf740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183', '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 19:19:51 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 19:19:51 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 19:19:51 INFO - Using env: {'DISPLAY': ':0', 19:19:51 INFO - 'HOME': '/home/cltbld', 19:19:51 INFO - 'LANG': 'en_US.UTF-8', 19:19:51 INFO - 'LANGUAGE': 'en_US:en', 19:19:51 INFO - 'LOGNAME': 'cltbld', 19:19:51 INFO - 'MAIL': '/var/mail/cltbld', 19:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:51 INFO - 'MOZ_NO_REMOTE': '1', 19:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:51 INFO - 'NO_EM_RESTART': '1', 19:19:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:51 INFO - 'PWD': '/builds/slave/test', 19:19:51 INFO - 'SHELL': '/bin/bash', 19:19:51 INFO - 'SHLVL': '1', 19:19:51 INFO - 'TERM': 'linux', 19:19:52 INFO - 'TMOUT': '86400', 19:19:52 INFO - 'USER': 'cltbld', 19:19:52 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183', 19:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:52 INFO - '_': '/tools/buildbot/bin/python'} 19:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19: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)) 19:19: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)) 19:19: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)) 19:19: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)) 19:19: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)) 19:19: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)) 19:19: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)) 19:19: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)) 19:19: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)) 19:19: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)) 19:19: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)) 19:19:52 INFO - Cleaning up... 19:19:52 INFO - Return code: 0 19:19:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:19: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')]} 19:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19: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')]} 19:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19: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 0xb1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde3b0>, '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 0xddf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddf740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183', '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 19:19: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 19:19: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 19:19:52 INFO - Using env: {'DISPLAY': ':0', 19:19:52 INFO - 'HOME': '/home/cltbld', 19:19:52 INFO - 'LANG': 'en_US.UTF-8', 19:19:52 INFO - 'LANGUAGE': 'en_US:en', 19:19:52 INFO - 'LOGNAME': 'cltbld', 19:19:52 INFO - 'MAIL': '/var/mail/cltbld', 19:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:52 INFO - 'MOZ_NO_REMOTE': '1', 19:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:52 INFO - 'NO_EM_RESTART': '1', 19:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:52 INFO - 'PWD': '/builds/slave/test', 19:19:52 INFO - 'SHELL': '/bin/bash', 19:19:52 INFO - 'SHLVL': '1', 19:19:52 INFO - 'TERM': 'linux', 19:19:52 INFO - 'TMOUT': '86400', 19:19:52 INFO - 'USER': 'cltbld', 19:19:52 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183', 19:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:52 INFO - '_': '/tools/buildbot/bin/python'} 19:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:19:52 INFO - Cleaning up... 19:19:52 INFO - Return code: 0 19:19:52 INFO - Running post-action listener: _resource_record_post_action 19:19:52 INFO - Running post-action listener: _start_resource_monitoring 19:19:52 INFO - Starting resource monitoring. 19:19:52 INFO - ##### 19:19:52 INFO - ##### Finished create-virtualenv step (success) 19:19:52 INFO - ##### 19:19:52 INFO - ##### 19:19:52 INFO - ##### Running install step. 19:19:52 INFO - ##### 19:19:52 INFO - Running pre-action listener: _resource_record_pre_action 19:19:52 INFO - Running main action method: install 19:19:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:19:52 INFO - Reading from file tmpfile_stdout 19:19:52 INFO - Detecting whether we're running mozinstall >=1.0... 19:19:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:19:52 INFO - Reading from file tmpfile_stdout 19:19:52 INFO - Output received: 19:19:52 INFO - Usage: mozinstall [options] installer 19:19:52 INFO - Options: 19:19:52 INFO - -h, --help show this help message and exit 19:19:52 INFO - -d DEST, --destination=DEST 19:19:52 INFO - Directory to install application into. [default: 19:19:52 INFO - "/builds/slave/test"] 19:19:52 INFO - --app=APP Application being installed. [default: firefox] 19:19:52 INFO - mkdir: /builds/slave/test/build/application 19:19: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'] 19:19: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 19:20:09 INFO - Reading from file tmpfile_stdout 19:20:09 INFO - Output received: 19:20:09 INFO - /builds/slave/test/build/application/firefox/firefox 19:20:09 INFO - Running post-action listener: _resource_record_post_action 19:20:09 INFO - ##### 19:20:09 INFO - ##### Finished install step (success) 19:20:09 INFO - ##### 19:20:09 INFO - ##### 19:20:09 INFO - ##### Running run-tests step. 19:20:09 INFO - ##### 19:20:09 INFO - Running pre-action listener: _resource_record_pre_action 19:20:09 INFO - Running main action method: run_tests 19:20:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:20:09 INFO - Python 2.7.3 19:20:09 INFO - Return code: 0 19:20:09 INFO - grabbing minidump binary from tooltool 19:20: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')]} 19:20: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 0xdde3b0>, '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 0xddf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddf740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:20: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 19:20: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 19:20: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 19:20:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:20:10 INFO - Return code: 0 19:20:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:20:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:20:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:20:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:20:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:20:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:20:10 INFO - Using env: {'DISPLAY': ':0', 19:20:10 INFO - 'HOME': '/home/cltbld', 19:20:10 INFO - 'LANG': 'en_US.UTF-8', 19:20:10 INFO - 'LANGUAGE': 'en_US:en', 19:20:10 INFO - 'LOGNAME': 'cltbld', 19:20:10 INFO - 'MAIL': '/var/mail/cltbld', 19:20:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:20:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:20:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:20:10 INFO - 'MOZ_NO_REMOTE': '1', 19:20:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:20:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:20:10 INFO - 'NO_EM_RESTART': '1', 19:20:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:20:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:20:10 INFO - 'PWD': '/builds/slave/test', 19:20:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:20:10 INFO - 'SHELL': '/bin/bash', 19:20:10 INFO - 'SHLVL': '1', 19:20:10 INFO - 'TERM': 'linux', 19:20:10 INFO - 'TMOUT': '86400', 19:20:10 INFO - 'USER': 'cltbld', 19:20:10 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183', 19:20:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:20:10 INFO - '_': '/tools/buildbot/bin/python'} 19:20:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:20:10 INFO - mozversion application_buildid: 20160718163032 19:20:10 INFO - mozversion application_changeset: feaaf1af1065257b9178faca8b67eed9657b4a17 19:20:10 INFO - mozversion application_display_name: Nightly 19:20:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:20:10 INFO - mozversion application_name: Firefox 19:20:10 INFO - mozversion application_remotingname: firefox 19:20:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:20:10 INFO - mozversion application_vendor: Mozilla 19:20:10 INFO - mozversion application_version: 50.0a1 19:20:10 INFO - mozversion platform_buildid: 20160718163032 19:20:10 INFO - mozversion platform_changeset: feaaf1af1065257b9178faca8b67eed9657b4a17 19:20:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:20:10 INFO - mozversion platform_version: 50.0a1 19:20:10 INFO - using testdate: 1468894810 19:20:10 INFO - actual date: 1468894810 19:20:10 INFO - starting webserver on 'localhost:56703' 19:20:10 INFO - SUITE-START | Running 2 tests 19:20:10 INFO - TEST-START | dromaeo_css 19:20:10 INFO - operating with platform_type : linux_ 19:20:10 INFO - Initialising browser for dromaeo_css test... 19:20:10 INFO - TEST-INFO | started process 3319 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXD6cTm/profile http://localhost:56703/getInfo.html) 19:20:17 INFO - PROCESS | 3319 | __metrics Screen width/height:1600/1200 19:20:17 INFO - PROCESS | 3319 | colorDepth:24 19:20:17 INFO - PROCESS | 3319 | Browser inner width/height: 1024/697 19:20:17 INFO - PROCESS | 3319 | __metrics 19:20:18 ERROR - PROCESS | 3319 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 19:20:18 INFO - TEST-INFO | 3319: exit 0 19:20:18 INFO - Browser initialized. 19:20:18 INFO - Running cycle 1/1 for dromaeo_css test... 19:20:18 INFO - TEST-INFO | started process 3439 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXD6cTm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:20:30 INFO - PROCESS | 3439 | RSS: Main: 167673856 19:20:30 INFO - PROCESS | 3439 | 19:21:20 INFO - PROCESS | 3439 | 1468894880226 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] 19:23:28 INFO - PROCESS | 3439 | Cycle 1(1): loaded http://localhost:56703/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56703/tests/dromaeo/cssquery-ext.html) 19:23:29 INFO - PROCESS | 3439 | RSS: Main: 172552192 19:23:29 INFO - PROCESS | 3439 | 19:26:31 INFO - PROCESS | 3439 | Cycle 1(1): loaded http://localhost:56703/tests/dromaeo/cssquery-ext.html (next: http://localhost:56703/tests/dromaeo/cssquery-jquery.html) 19:26:31 INFO - PROCESS | 3439 | RSS: Main: 168771584 19:26:31 INFO - PROCESS | 3439 | 19:29:33 INFO - PROCESS | 3439 | Cycle 1(1): loaded http://localhost:56703/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56703/tests/dromaeo/cssquery-mootools.html) 19:29:34 INFO - PROCESS | 3439 | RSS: Main: 172048384 19:29:34 INFO - PROCESS | 3439 | 19:32:36 INFO - PROCESS | 3439 | Cycle 1(1): loaded http://localhost:56703/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56703/tests/dromaeo/cssquery-prototype.html) 19:32:37 INFO - PROCESS | 3439 | RSS: Main: 166834176 19:32:37 INFO - PROCESS | 3439 | 19:35:39 INFO - PROCESS | 3439 | Cycle 1(1): loaded http://localhost:56703/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56703/tests/dromaeo/cssquery-yui.html) 19:35:40 INFO - PROCESS | 3439 | RSS: Main: 168996864 19:35:40 INFO - PROCESS | 3439 | 19:38:43 INFO - PROCESS | 3439 | Cycle 1(1): loaded http://localhost:56703/tests/dromaeo/cssquery-yui.html (next: http://localhost:56703/tests/dromaeo/cssquery-dojo.html) 19:38:43 INFO - PROCESS | 3439 | RSS: Main: 170643456 19:38:43 INFO - PROCESS | 3439 | 19:38:43 INFO - PROCESS | 3439 | __start_tp_report 19:38:43 INFO - PROCESS | 3439 | _x_x_mozilla_page_load 19:38:43 INFO - PROCESS | 3439 | _x_x_mozilla_page_load_details 19:38:43 INFO - PROCESS | 3439 | |i|pagename|runs| 19:38:43 INFO - PROCESS | 3439 | |0;dojo.html;3040.635123785146;3068.8005279656827;3075.0774767569737;3082.4759790835556;3099;5315.867103322414;5340.225667278247;5426.484483974026;5427.240186373911;5446.863828404292;5294.126469132598;5394.352677678674;5420.457954204578;5447.12845944649;5529.861753456155;4971.204607262839;5003.024410240005;5042.420121685998;5081.771320290577;5124.308218390507;617.4383658274891;4875.561199492045;4876.390451193601;4943.431505376891;5013.598912087043;4884.096442158212;4937.851864444036;4944.851654450372;4947.604191664658;4982.676126051813;4920.458749537548;4930.211166213388;4940.925886111711;4979.576735977446;4991.7753701083175;4860.927086093711;4880.389951256093;4917.114919314522;4939.431965323998;4962.528559786851;5328.760205790749;5375.75809088592;5397.54120899724;5420.457954204548;5435.695994828845;5634.690092044936;5783.5084017858535;5791.420857914175;5814.331351894544;5863.794767183171;5797.072468405077;5852.385499522531;5855.355910849803;5856.00447923854;5883.6469811811;5402.865398266369;5413.675179489243;5448.536874365684;5456.645318054353;5460.563154947635;5775.537956963432;5916.349201587822;5934.673592952429;5990.580659353804;5991.191189189491;5714.314282286152;5775.393583673654;5803.129530570363;5804.042333015005;5837.3287071986415;5843.853903652443;5846.444587764156;5849.707514624337;5870.3249126350165;5874.853128671817;5511.559075273968;5720;5770.826875193751;5814.30228372598;5832.154337621021;5765.884682306414;5765.913511297334;5768.077107662753;5768.971155144198;5776.942230577641;4403.229434848953;4423.1153769246275;4441.844535441244;4463.330500424897;4485.573870482299;3879.127196380848;3894.182221733411;3909.5308562972627;3927.4108883667677;3983.183447393277;5378.1663842104535;5399.460053994648;5404.594655400861;5431.565474762009;5495.697736624524;5768.1636162757;5776.191333213354;5793.710314484259;5812.215350927655;5812.912806307909;5463.289772329572;5562.332520097614;5562.554995600342;5609.27079479665;5639.689817060019;5033.622478314068;5071.492850714899;5082.542571168538;5104.4895510449405;5133.101707201225;5895.587308888423;6102.664353460602;6108.839320529085;6113.388661133851;6138.1099740537375;5777.884442311214;5789.247397838254;5793;5878.735456904364;5889.146073819358;6026.668533230539;6063.787767428119;6071.119687645355;6071.817845464467;6085.4523092921845;5615.775368985195;5646.181303710857;5742.483176514133;5746.885062298814;5775.104858746901;5813.563982701399;5834.18321434991;5855.268091488564;5889.381614930542;5924.407559244041;5698.430156984434;5711.571632127524;5715.8856822864145;5717.313922329347;5729.197912292199;5511.917321240105;5596.356419011866;5652.349979752381;5716.485516303553;5731.598788084794;5660.547156227574;5665.008623490955;5667.4332566743;5673.035583950656;5713.143028545752;5647.915281270702;5704.857378565569;5710.229119068873;5728.598998070095;5779.7110144493445;5434.918476222939;5482.835514934558;5503.9174412383045;5591.776328946959;5646.0683987141665 19:38:43 INFO - PROCESS | 3439 | |1;ext.html;556.0533772492797;585.3590318601132;598.291025135215;607.6840043177547;642.6722371590488;38823.22353552931;43703;43984;44445.33332000019;44562;43507;44102;44597.77701111498;44695.32957005648;44772.328415073716;8858.512781796982;8887.111288871125;8985.505797181153;8991.28069754418;9007.909920900805;8873.20141187293;8907.910920890772;8929.285657147413;8930.19628233462;8970.147835955606;8994.055624159468;9039.683611073613;9089.863652045224;9091.136342047495;9100.726978190665;8949.77625559363;8961;8969.192772650493;8984.326175536828;9015.413998090104;8880.689175878877;8904.643814247422;8962.82074358509;8988.191062804313;8990;33607;41998.580014199775;42275.36586951198;42291;42532.78733606343;3221.1785994571233;3571.8921941623466;3686.502322186524;3805.219929914361;4042.171354872244;32375.514367284508;32885.83557082223;32924.17689557756;35225;35321.82339088314;4513.52607976161;4563.247064234397;4569.314602809605;4589.724616523019;4654.045920586272;369128;373211;375064;375389;377083;58599.4140058594;58896.705516472146;59112.7044364784;59156;59246;36857;37967.62032379696;38047.809760951015;69239;69544.6522767393;15672;15697.13665748372;15800.60498487547;15936.601584960468;16023.839761602469;12115.818262726067;12315.384230788424;12350.938245308897;12366.381680916098;12375.75248495025;20853;21260.893695531733;21339.78660213409;21345.679814802792;21441.571168576542;7710.995141263312;7928.7224947127725;7951.483153594998;8061.669824479012;8194.951262184453;967.2455484721928;1041.8228901086834;1055.9577616895237;1060.8408738689104;1112.9121530797715;34390.82804585961;34460.138496537285;34478.31043379169;34628.30743385118;34630;1117.3184357542054;1138.3056335635256;1140.0309736723718;1187.0562902492538;1194.4087676600138;17784.822151778317;17984.640307193782;18018;18091.72862407065;18192.545186370447;566325;579554;581534;584860;585006.8246246497;60370.698146509865;61466.69266653638;62174;62471.375286247465;62922.685386572775;1353.9187648741106;1376.4631793600704;1376.7934809778612;1382.5299398204659;1388.645895296693;31633.683663163993;34561.827190863885;35440.64559354373;36539.19551909568;38368;56394.43605563892;61119.38880611137;61491;61522.69238653778;61776.382236177065;464157;477922;478284;479498;481877;47352;47590;47771.5222847781;47853.521464786296;47968.520314796406;51463;52232.73883630557;52432.475675244285;53075;53664.463355365944;44621.330680040475;45307.38866296076;45622;46460.53539464562;46502.76748616235;43892;45278.54721452743;45393.09213815639;45480.54519454763;46346.59707327798;38915.6108438912;44011.59884011573;44709;44995;45610;36607.45088823616;39564.2087158261;40195.79902100471;40331.79834100811;40344;29946.700532995263;30542;30988.69011309858;31021.759129635466;31273.530897036107 19:38:43 INFO - PROCESS | 3439 | |2;jquery.html;390.3266864658464;392.5191640240704;395.24705436144137;395.7269484056001;422.3938648040063;14418.423263069491;19291.807081929175;20325.898370508163;20976.790232097694;21064.262750803726;18864.717029244573;19788;20009.1996320147;20029.399118026482;20283.290084847034;5347.41178470368;5853.356130825606;5980.252468441445;6032.065029920347;6032.125341825433;5422.728863556826;5744.626599271055;5749.712514374264;5834.299884013924;5898.41015898411;5762.164486149506;5769.624974376673;5781.595288329819;5813.30240371156;6302.0861975013595;6315.179026726519;6459.741610335581;6557.377049180321;6591.11020012297;6605.339466053404;5794.62334948227;5813.47678708914;5895.115732640095;5927.881442371172;5929.347771745104;14412.279386030657;14505.637359066108;14715.705685886329;14776.187309697962;14852.628684282872;2247.7077979862515;2308.9653655195184;2354.835161538693;2380.8690522021284;2388.3073908566494;10322.329048611817;10472.68581942543;10702.625408110756;10792.892071079266;11095.50070246841;1962.7939066398108;1990.7810140884492;2022.2618744158276;2031.1570698160247;2033.4509682385674;80060;89265.55367223188;91790;92040.53979730059;92534.5373273136;11121.777564448666;11380.487878045507;11453.370064646359;11468;11522.711932201762;15962.281697323648;16049.839501605067;16105.436309729103;16199.43301984425;16221.2700428481;7886.802829929297;8120.390970677105;8220.547869867214;8325.791855203548;8325.916740832514;7595.202503737139;7716.228377162239;7716.498427602301;7891.368690504746;7903.288704016666;4806.543378379049;4820.855374338776;4896.290037944478;4900.534449227318;5039.26930595069;1964.361582485698;2039.9698152432927;2047.7747447780732;2068.307117115753;2092.550101728136;969.7963427680126;978.8433850583872;994.7115336552318;1023.0741179232806;1061.145777649;20069.799302007086;20727.792722072587;21165.68251476229;21200.363989080353;21469.14123435076;968.941863488193;995.323180237431;1000.8348622477355;1013.7871047080196;1033.102148473539;10893.291936024134;11156.94009069137;11420.486078126503;11742.647720568397;12065.457054432572;546874;553987;569163;579671;580506;58666.41333586695;59198.40801591929;98190.50904745431;100600.49699751455;102027;1026.625281772148;1031.8761748590218;1062.744941214103;1072.983905241422;1078.1482628723377;17712.55718607045;17835.286588536314;18567.814321856607;18603.81396186075;18671.719924200876;43660.78169609132;44628;45991;46263.53736462727;46537;64527.67736161289;65860.67069664621;67339;67811.66094169498;68425.65787171232;7540.811479713051;8328.958355208186;8584.270337021424;8654.264387527131;8705.651773928972;12707.809382859079;12797.97616190721;13183.274919879499;13337.799933000819;13364.465421383036;10838.403887786248;10949.45252737344;11269.830952535882;11440.48517816717;11536.192466527262;10975.83536246941;11178.776424471302;11369.2609980351;11404.885951140383;11459.942700286445;10970.945145274223;11139.888601113886;11371.943140284246;11594.188406811441;11974.820377694168;8072.515649060841;8140.715074972584;8149;8156.265936065783;8203.179682031749;10496.527656255334;11087.72280692989;11348;11389.544418223179;11805.291682499077 19:38:43 INFO - PROCESS | 3439 | |3;mootools.html;1465.1721777195883;1497.0867770659897;1639.8524132828043;1761.0652102414863;1786.1069465267358;7484.9251507484905;8297.543635100075;8386.790330241747;8837.513936733485;8978.551072446377;8568.314534837215;8680.56597170142;8751.518666473341;8796.91203087969;8811.074837142089;2331.94170145746;2360.7757263060066;2384.9284521464297;2385.034061205206;2392.820538459614;2313.7454879963275;2326.895289711967;2330.1029103795076;2337.5792357375667;2343.4375749820006;2316.0851463671925;2320.8607483550954;2329.231353653299;2334.673145759595;2347.1550241912983;2277.7266727992746;2296.2651951375565;2297.5634629420356;2300.056976639578;2313.1556981701556;2295.093438091961;2296.712910886139;2298.333708061642;2299.6435552489224;2311;8613.870791938063;8657.350698697559;8664.740057798275;8686.522241276727;8767.561621918941;5102.591792656579;5185.611079169077;5209.29674493946;5239.318888544503;5240.4497527759795;3269.7251334783423;3347.2636020075543;3392.932141357184;3407.863685452579;3424.8630054797777;1123.2338039887686;1137.124414201069;1156.7859945910034;1164.2199726183478;1167.6497050884786;11299.096072314194;11431.714207144887;11528.596499122574;11663.766724665544;11692.181547291693;4450.532694067077;4567.383403240587;4646.117237724821;4670.042641258602;4675.0883577702025;10028.047335503115;10092.646757363604;10109.595616175418;10143;10155.39067655943;5314.256004159421;5331.413544510101;5334.119870221448;5334.333208348957;5347.572194224453;4343.478782546114;4702.4592171899985;4785.282207668877;4811.711297322172;4830.830920917751;3820.331441997639;3916.6083391661177;3916.96083039166;3928.508936382952;4021.638052575224;1260.8802163794426;1265.2787910890704;1269.1560112525067;1270.6378682075565;1281.0264199208668;970.1268858027831;988.1205726903062;996.6511720897628;1002.5688953749958;1039.5062345385882;5746.770129194869;5747;5754.568407369464;5992.0712289595185;6041.124037014696;480.6299149654816;481.925306566359;482.2404712577704;489.7624652043756;491.2582001178247;4169.791510424528;4181.372794080851;4290;4362.389265502832;4370.213361594943;10114.342567733222;10481.633142839964;10592;10606.734831629272;10752.516136773864;10412.167026637851;10492.842607360895;10508.422036787897;10543.736406589744;10579.259451838298;7651.196624354363;7883.842323153504;8064.55644939534;8089.635966381527;8120.269175774209;5874.941250587611;5975.760969561343;6058.212432383762;6163.7842675506145;6224.221972253468;9086.22767064807;9610.95194524051;9615.326927115315;9851.950740246253;9915.355501892354;9611.711648650551;9912.900870991487;9968.850467242852;10024.599016039278;10028.247881408777;7317.378022868116;7416.517926334771;7606.20134885829;7653.88519172224;7681.731139410093;8180.7954801130445;8282.585870706562;8319.875201872097;8337.583120844054;8340;7350;7459.365953893763;7467.589282589292;7519;7542.396608271435;7150.141982962078;7224.494285399972;7281.781546553612;7356.816079597838;7392;7138.964305178441;7205.279472052753;7206.243344448757;7231.4937954342695;7258.346748792423;4987.850364489072;5059.367579052619;5116.692998419958;5315.867103322448;5364.356277246756;5153.098207813543;5195.893150097503;5226.869328266824;5261.896679114121;5396.028714831368 19:38:43 INFO - PROCESS | 3439 | |4;prototype.html;334.97990120592766;337.96958273755365;343.5653897819259;347.7200853313082;353.7081907426374;5536.169574563813;5560.415281644732;5563.916541251884;5606.971965140179;5619.83140505785;5488.313960754906;5498.81775418286;5500.5874559408;5501.284832971718;5506.5870059745475;4116.629503344699;4219.409282700424;4319.1211822857;4332.480102387718;4336.197803406364;4298.935515967263;4325.52419233884;4330.761808100553;4341.717788343748;4347.760873151976;4288.313869780835;4294.871153865373;4297.935530967023;4310.353446982962;4331.45856767904;4074.1647962167685;4292.978535107304;4305.397244385788;4313.374560688714;4315.130438258554;3774.0564858785306;3790.564085130218;3795.8291876865605;3800.600936901641;3803.2773772983046;5355.651882627617;5375.650582712111;5397.54120899724;5415.675059496442;5420.7018613976215;4812.35033270511;4822.95177048232;4832.710037397767;4854.538818812207;4882.487338829407;5723.51350135239;5739;5767.88464230713;5771.5082375163265;5775.393583673737;4053.837846486137;4058.431819545266;4062.7765472898977;4063.6342729154517;4076.8369265229353;5852.414758524156;5969.910451343233;5992.760289588411;5996.571388587629;6003.249593800775;4206.137741762931;4234.703570750018;4237.279662457328;4252.234597772369;4257.318828987347;4255.5956534343595;4279.165562715303;4281.593248641374;4284.007936309631;4300.16146851361;4700.764961751899;4883.609311255091;4904.55858972687;4942.406911170682;4949.876253093629;5773.913391299134;5784.942150578525;5828.65028098307;5829.854253643608;5831.88336233273;1465.8973871829082;1478.5510200003841;1490.2772155504572;1490.6795039066653;1496.1696258576376;943.6744323208482;951.9528518629452;976.6972238606055;1014.7412409835445;1020.0921180149672;5570.025245582007;5582.86042848932;5593.916091258634;5606.467385598362;5609.335565606304;5873.530117590668;5928.347881733006;5930.673812940329;5945;5984.281886173687;5436.891262174734;5609.382967873531;5732.799352022659;5739.397363276879;5764.654120752768;3190.888318908827;3209.8876539321477;3212.3414699986447;3231.0145405651033;3233.544904792853;6027.101463039128;6085.6348619083;6190.442860142609;6194.938050619527;6213;6050.515958723292;6091.116788065706;6103.176071230416;6113.227164122443;6156.199694039746;6157.33751886988;6158.353372895782;6162.506999440034;6170.876582468325;6233.594816336833;5732.340780810094;6026.764513274856;6042.516598672184;6051.878962420815;6062.090686396899;5896.9115463268945;5920.615160014585;5930.28836539618;5941.881162376815;5951.851203719942;5874.618149820248;6159.23009623797;6184.257889053342;6202.4417802398;6203.131561581473;4226.387173859835;4235.597618226264;4242.915141697211;4255.55305699218;4266.893327666833;5749.770009199752;5885.676287804212;5983.581149319506;5999.520038397005;6029.583047983632;5794.884102318014;5844.736986835517;5864.654138344526;5880.26496687914;5881.500072493886;5779.757352169304;5848.678322692293;5862.208601838697;5883.794067207627;5899.882002360015;5631.211630371669;5846.649201047951;5854.0340843760305;5863;5870;5868.618539794899;5878.706064696834;5905.704714764331;5919.556033297434;5923.763049477972;5485.080221922295;5749.396313387034;5790.276215473066;5802.622829516068;5831.512964194103 19:38:43 INFO - PROCESS | 3439 | |5;yui.html;755.3088923634871;781.6482582837724;809.3507318913977;845.7505036014376;871.1114663043695;15502.534923952271;16637.750433743502;16684.83315166848;16812.74780878288;16828.57928551787;14743.705125897503;14860.777088343684;14936.701265974674;15051.871109666765;15082.396704131848;816.1634324817065;832.1179549677331;833.170994860115;836.7949852286198;837.0374069819695;668.4151367553391;800.0998876264202;827.4414770030236;828.1139181076251;831.2186544648011;885.5350940756123;886.9689560865371;895.444824208988;896.274018045382;900.6757567275776;887.8046829697456;888.1695614600337;892.6518657723493;896.0412358776113;897.3718397122041;651.0494677770461;653.7025653327725;654.3750718064284;654.6203202142746;656.7701304543419;15428.691426171414;15500.612484687861;15505.534833955;15531.378744850306;15564.221788910509;15853.92073039639;15861.682766344724;15869.44456944013;15918.681626367523;16227.91886040574;12753.61739147827;12781.360931953459;12913.935430322883;13141.408636611375;13402.195868247838;3940.487736594253;3952.3873799560824;3986.063275130371;4002.1595464952393;4171.019810344566;68165.65917170432;70226.94659580161;71703.64148179277;74371.62814185949;75154;12126.878731212752;12361.876381236252;12383.69040773988;12480.81278780819;12886.548970785978;22125.336239912827;22140;22146.22488212937;22203.55592888133;22216.777832221473;8798;8950.641974320954;9152.581349890777;9168;9215.216706580015;4882.36529251195;4986.152354099811;5039.041854064221;5100.897982040413;5180.689158650418;3445.0870519312402;3513.998510424568;3538.5046093546925;3547.1486843157454;3555.2178520725397;646.7380710812129;650.6649075726004;653.8398092467376;663.9502037347219;672.8486090629569;646.9514786391039;767.7773445700684;782.1123025366137;791.1850793682516;819.148085990575;9669.9033009669;10234.6417875374;10330.638427654996;10341.74145646365;10426.947865260625;632.8259728574678;684.7089986755708;704.3555147040503;726.7529040126383;786.7639708087551;5039.028059356526;5121;5136.178211486144;5207;5218.765155567932;112949;113765.43117284526;115837;116013.29900257515;118202.4089879545;101348.49325753472;103013.48493257485;103072;104206.47896760468;104567;89286.55356723175;90914;91382;91471;93384.53307733282;9564.808703826024;9790.314677972474;9805.656802012181;9816.411015339103;9878.703638890845;48648;49330.75334623304;50825;51084.97830043453;51519.48480515147;66977.66511167413;77617.223827761;78851;79396;79740.60129699546;11194.496247668712;11629.302241865515;11661.708457288636;12339.50641974311;12915.095943283879;13834.100783449043;13907.860921390657;14246.287685615885;14739.631509212355;14889.329980150702;13310.733785324046;13540.458381664623;13726.86273137256;13985.860141398864;14190.432382704576;13430.597082087554;13511.662208444868;13811.378487967864;14114.858851411765;14161.291935403395;13046.217226966033;13279.136856104322;13386.19682819034;13470.461181552628;13507.932460337635;10844.447967656672;10902;10924.160465417273;11183.552657893593;11261.155413344195;10598.20513461478;10711.250212485364;11643.88356116428;11820.468078936641;12088.335141566946 19:38:43 INFO - PROCESS | 3439 | __end_tp_report 19:38:43 INFO - PROCESS | 3439 | __start_cc_report 19:38:43 INFO - PROCESS | 3439 | _x_x_mozilla_cycle_collect,350 19:38:43 INFO - PROCESS | 3439 | __end_cc_report 19:38:43 INFO - PROCESS | 3439 | __startTimestamp1468895923355__endTimestamp 19:38:43 INFO - PROCESS | 3439 | 19:38:43 INFO - PROCESS | 3439 | ------- Summary: start ------- 19:38:43 INFO - PROCESS | 3439 | Number of tests: 6 19:38:43 INFO - PROCESS | 3439 | 19:38:43 INFO - PROCESS | 3439 | [#0] dojo.html Cycles:165 Average:5374.29 Median:5639.69 stddev:727.36 (12.9%) stddev-sans-first:706.17 19:38:43 INFO - PROCESS | 3439 | Values: 3040.6 3068.8 3075.1 3082.5 3099.0 5315.9 5340.2 5426.5 5427.2 5446.9 5294.1 5394.4 5420.5 5447.1 5529.9 4971.2 5003.0 5042.4 5081.8 5124.3 617.4 4875.6 4876.4 4943.4 5013.6 4884.1 4937.9 4944.9 4947.6 4982.7 4920.5 4930.2 4940.9 4979.6 4991.8 4860.9 4880.4 4917.1 4939.4 4962.5 5328.8 5375.8 5397.5 5420.5 5435.7 5634.7 5783.5 5791.4 5814.3 5863.8 5797.1 5852.4 5855.4 5856.0 5883.6 5402.9 5413.7 5448.5 5456.6 5460.6 5775.5 5916.3 5934.7 5990.6 5991.2 5714.3 5775.4 5803.1 5804.0 5837.3 5843.9 5846.4 5849.7 5870.3 5874.9 5511.6 5720.0 5770.8 5814.3 5832.2 5765.9 5765.9 5768.1 5769.0 5776.9 4403.2 4423.1 4441.8 4463.3 4485.6 3879.1 3894.2 3909.5 3927.4 3983.2 5378.2 5399.5 5404.6 5431.6 5495.7 5768.2 5776.2 5793.7 5812.2 5812.9 5463.3 5562.3 5562.6 5609.3 5639.7 5033.6 5071.5 5082.5 5104.5 5133.1 5895.6 6102.7 6108.8 6113.4 6138.1 5777.9 5789.2 5793.0 5878.7 5889.1 6026.7 6063.8 6071.1 6071.8 6085.5 5615.8 5646.2 5742.5 5746.9 5775.1 5813.6 5834.2 5855.3 5889.4 5924.4 5698.4 5711.6 5715.9 5717.3 5729.2 5511.9 5596.4 5652.3 5716.5 5731.6 5660.5 5665.0 5667.4 5673.0 5713.1 5647.9 5704.9 5710.2 5728.6 5779.7 5434.9 5482.8 5503.9 5591.8 5646.1 19:38:43 INFO - PROCESS | 3439 | 19:38:43 INFO - PROCESS | 3439 | [#1] ext.html Cycles:180 Average:64742.07 Median:44740.66 stddev:128356.84 (286.9%) stddev-sans-first:128626.44 19:38:43 INFO - PROCESS | 3439 | Values: 556.1 585.4 598.3 607.7 642.7 38823.2 43703.0 43984.0 44445.3 44562.0 43507.0 44102.0 44597.8 44695.3 44772.3 8858.5 8887.1 8985.5 8991.3 9007.9 8873.2 8907.9 8929.3 8930.2 8970.1 8994.1 9039.7 9089.9 9091.1 9100.7 8949.8 8961.0 8969.2 8984.3 9015.4 8880.7 8904.6 8962.8 8988.2 8990.0 33607.0 41998.6 42275.4 42291.0 42532.8 3221.2 3571.9 3686.5 3805.2 4042.2 32375.5 32885.8 32924.2 35225.0 35321.8 4513.5 4563.2 4569.3 4589.7 4654.0 369128.0 373211.0 375064.0 375389.0 377083.0 58599.4 58896.7 59112.7 59156.0 59246.0 36857.0 37967.6 38047.8 69239.0 69544.7 15672.0 15697.1 15800.6 15936.6 16023.8 12115.8 12315.4 12350.9 12366.4 12375.8 20853.0 21260.9 21339.8 21345.7 21441.6 7711.0 7928.7 7951.5 8061.7 8195.0 967.2 1041.8 1056.0 1060.8 1112.9 34390.8 34460.1 34478.3 34628.3 34630.0 1117.3 1138.3 1140.0 1187.1 1194.4 17784.8 17984.6 18018.0 18091.7 18192.5 566325.0 579554.0 581534.0 584860.0 585006.8 60370.7 61466.7 62174.0 62471.4 62922.7 1353.9 1376.5 1376.8 1382.5 1388.6 31633.7 34561.8 35440.6 36539.2 38368.0 56394.4 61119.4 61491.0 61522.7 61776.4 464157.0 477922.0 478284.0 479498.0 481877.0 47352.0 47590.0 47771.5 47853.5 47968.5 51463.0 52232.7 52432.5 53075.0 53664.5 44621.3 45307.4 45622.0 46460.5 46502.8 43892.0 45278.5 45393.1 45480.5 46346.6 38915.6 44011.6 44709.0 44995.0 45610.0 36607.5 39564.2 40195.8 40331.8 40344.0 29946.7 30542.0 30988.7 31021.8 31273.5 19:38:43 INFO - PROCESS | 3439 | 19:38:43 INFO - PROCESS | 3439 | [#2] jquery.html Cycles:180 Average:31356.98 Median:21334.75 stddev:93153.73 (436.6%) stddev-sans-first:93386.03 19:38:43 INFO - PROCESS | 3439 | Values: 390.3 392.5 395.2 395.7 422.4 14418.4 19291.8 20325.9 20976.8 21064.3 18864.7 19788.0 20009.2 20029.4 20283.3 5347.4 5853.4 5980.3 6032.1 6032.1 5422.7 5744.6 5749.7 5834.3 5898.4 5762.2 5769.6 5781.6 5813.3 6302.1 6315.2 6459.7 6557.4 6591.1 6605.3 5794.6 5813.5 5895.1 5927.9 5929.3 14412.3 14505.6 14715.7 14776.2 14852.6 2247.7 2309.0 2354.8 2380.9 2388.3 10322.3 10472.7 10702.6 10792.9 11095.5 1962.8 1990.8 2022.3 2031.2 2033.5 80060.0 89265.6 91790.0 92040.5 92534.5 11121.8 11380.5 11453.4 11468.0 11522.7 15962.3 16049.8 16105.4 16199.4 16221.3 7886.8 8120.4 8220.5 8325.8 8325.9 7595.2 7716.2 7716.5 7891.4 7903.3 4806.5 4820.9 4896.3 4900.5 5039.3 1964.4 2040.0 2047.8 2068.3 2092.6 969.8 978.8 994.7 1023.1 1061.1 20069.8 20727.8 21165.7 21200.4 21469.1 968.9 995.3 1000.8 1013.8 1033.1 10893.3 11156.9 11420.5 11742.6 12065.5 546874.0 553987.0 569163.0 579671.0 580506.0 58666.4 59198.4 98190.5 100600.5 102027.0 1026.6 1031.9 1062.7 1073.0 1078.1 17712.6 17835.3 18567.8 18603.8 18671.7 43660.8 44628.0 45991.0 46263.5 46537.0 64527.7 65860.7 67339.0 67811.7 68425.7 7540.8 8329.0 8584.3 8654.3 8705.7 12707.8 12798.0 13183.3 13337.8 13364.5 10838.4 10949.5 11269.8 11440.5 11536.2 10975.8 11178.8 11369.3 11404.9 11459.9 10970.9 11139.9 11371.9 11594.2 11974.8 8072.5 8140.7 8149.0 8156.3 8203.2 10496.5 11087.7 11348.0 11389.5 11805.3 19:38:43 INFO - PROCESS | 3439 | 19:38:43 INFO - PROCESS | 3439 | [#3] mootools.html Cycles:180 Average:5683.20 Median:2656.54 stddev:3165.18 (119.1%) stddev-sans-first:3158.18 19:38:43 INFO - PROCESS | 3439 | Values: 1465.2 1497.1 1639.9 1761.1 1786.1 7484.9 8297.5 8386.8 8837.5 8978.6 8568.3 8680.6 8751.5 8796.9 8811.1 2331.9 2360.8 2384.9 2385.0 2392.8 2313.7 2326.9 2330.1 2337.6 2343.4 2316.1 2320.9 2329.2 2334.7 2347.2 2277.7 2296.3 2297.6 2300.1 2313.2 2295.1 2296.7 2298.3 2299.6 2311.0 8613.9 8657.4 8664.7 8686.5 8767.6 5102.6 5185.6 5209.3 5239.3 5240.4 3269.7 3347.3 3392.9 3407.9 3424.9 1123.2 1137.1 1156.8 1164.2 1167.6 11299.1 11431.7 11528.6 11663.8 11692.2 4450.5 4567.4 4646.1 4670.0 4675.1 10028.0 10092.6 10109.6 10143.0 10155.4 5314.3 5331.4 5334.1 5334.3 5347.6 4343.5 4702.5 4785.3 4811.7 4830.8 3820.3 3916.6 3917.0 3928.5 4021.6 1260.9 1265.3 1269.2 1270.6 1281.0 970.1 988.1 996.7 1002.6 1039.5 5746.8 5747.0 5754.6 5992.1 6041.1 480.6 481.9 482.2 489.8 491.3 4169.8 4181.4 4290.0 4362.4 4370.2 10114.3 10481.6 10592.0 10606.7 10752.5 10412.2 10492.8 10508.4 10543.7 10579.3 7651.2 7883.8 8064.6 8089.6 8120.3 5874.9 5975.8 6058.2 6163.8 6224.2 9086.2 9611.0 9615.3 9852.0 9915.4 9611.7 9912.9 9968.9 10024.6 10028.2 7317.4 7416.5 7606.2 7653.9 7681.7 8180.8 8282.6 8319.9 8337.6 8340.0 7350.0 7459.4 7467.6 7519.0 7542.4 7150.1 7224.5 7281.8 7356.8 7392.0 7139.0 7205.3 7206.2 7231.5 7258.3 4987.9 5059.4 5116.7 5315.9 5364.4 5153.1 5195.9 5226.9 5261.9 5396.0 19:38:43 INFO - PROCESS | 3439 | 19:38:43 INFO - PROCESS | 3439 | [#4] prototype.html Cycles:180 Average:4895.52 Median:5606.72 stddev:1447.84 (25.8%) stddev-sans-first:1410.85 19:38:43 INFO - PROCESS | 3439 | Values: 335.0 338.0 343.6 347.7 353.7 5536.2 5560.4 5563.9 5607.0 5619.8 5488.3 5498.8 5500.6 5501.3 5506.6 4116.6 4219.4 4319.1 4332.5 4336.2 4298.9 4325.5 4330.8 4341.7 4347.8 4288.3 4294.9 4297.9 4310.4 4331.5 4074.2 4293.0 4305.4 4313.4 4315.1 3774.1 3790.6 3795.8 3800.6 3803.3 5355.7 5375.7 5397.5 5415.7 5420.7 4812.4 4823.0 4832.7 4854.5 4882.5 5723.5 5739.0 5767.9 5771.5 5775.4 4053.8 4058.4 4062.8 4063.6 4076.8 5852.4 5969.9 5992.8 5996.6 6003.2 4206.1 4234.7 4237.3 4252.2 4257.3 4255.6 4279.2 4281.6 4284.0 4300.2 4700.8 4883.6 4904.6 4942.4 4949.9 5773.9 5784.9 5828.7 5829.9 5831.9 1465.9 1478.6 1490.3 1490.7 1496.2 943.7 952.0 976.7 1014.7 1020.1 5570.0 5582.9 5593.9 5606.5 5609.3 5873.5 5928.3 5930.7 5945.0 5984.3 5436.9 5609.4 5732.8 5739.4 5764.7 3190.9 3209.9 3212.3 3231.0 3233.5 6027.1 6085.6 6190.4 6194.9 6213.0 6050.5 6091.1 6103.2 6113.2 6156.2 6157.3 6158.4 6162.5 6170.9 6233.6 5732.3 6026.8 6042.5 6051.9 6062.1 5896.9 5920.6 5930.3 5941.9 5951.9 5874.6 6159.2 6184.3 6202.4 6203.1 4226.4 4235.6 4242.9 4255.6 4266.9 5749.8 5885.7 5983.6 5999.5 6029.6 5794.9 5844.7 5864.7 5880.3 5881.5 5779.8 5848.7 5862.2 5883.8 5899.9 5631.2 5846.6 5854.0 5863.0 5870.0 5868.6 5878.7 5905.7 5919.6 5923.8 5485.1 5749.4 5790.3 5802.6 5831.5 19:38:43 INFO - PROCESS | 3439 | 19:38:43 INFO - PROCESS | 3439 | [#5] yui.html Cycles:180 Average:21177.84 Median:3969.23 stddev:30396.29 (765.8%) stddev-sans-first:30442.87 19:38:43 INFO - PROCESS | 3439 | Values: 755.3 781.6 809.4 845.8 871.1 15502.5 16637.8 16684.8 16812.7 16828.6 14743.7 14860.8 14936.7 15051.9 15082.4 816.2 832.1 833.2 836.8 837.0 668.4 800.1 827.4 828.1 831.2 885.5 887.0 895.4 896.3 900.7 887.8 888.2 892.7 896.0 897.4 651.0 653.7 654.4 654.6 656.8 15428.7 15500.6 15505.5 15531.4 15564.2 15853.9 15861.7 15869.4 15918.7 16227.9 12753.6 12781.4 12913.9 13141.4 13402.2 3940.5 3952.4 3986.1 4002.2 4171.0 68165.7 70226.9 71703.6 74371.6 75154.0 12126.9 12361.9 12383.7 12480.8 12886.5 22125.3 22140.0 22146.2 22203.6 22216.8 8798.0 8950.6 9152.6 9168.0 9215.2 4882.4 4986.2 5039.0 5100.9 5180.7 3445.1 3514.0 3538.5 3547.1 3555.2 646.7 650.7 653.8 664.0 672.8 647.0 767.8 782.1 791.2 819.1 9669.9 10234.6 10330.6 10341.7 10426.9 632.8 684.7 704.4 726.8 786.8 5039.0 5121.0 5136.2 5207.0 5218.8 112949.0 113765.4 115837.0 116013.3 118202.4 101348.5 103013.5 103072.0 104206.5 104567.0 89286.6 90914.0 91382.0 91471.0 93384.5 9564.8 9790.3 9805.7 9816.4 9878.7 48648.0 49330.8 50825.0 51085.0 51519.5 66977.7 77617.2 78851.0 79396.0 79740.6 11194.5 11629.3 11661.7 12339.5 12915.1 13834.1 13907.9 14246.3 14739.6 14889.3 13310.7 13540.5 13726.9 13985.9 14190.4 13430.6 13511.7 13811.4 14114.9 14161.3 13046.2 13279.1 13386.2 13470.5 13507.9 10844.4 10902.0 10924.2 11183.6 11261.2 10598.2 10711.3 11643.9 11820.5 12088.3 19:38:43 INFO - PROCESS | 3439 | -------- Summary: end -------- 19:38:43 INFO - PROCESS | 3439 | 19:38:44 INFO - TEST-INFO | 3439: exit 0 19:38:44 INFO - TEST-OK | dromaeo_css | took 1113739ms 19:38:44 INFO - TEST-START | kraken 19:38:44 INFO - operating with platform_type : linux_ 19:38:44 INFO - Initialising browser for kraken test... 19:38:44 INFO - TEST-INFO | started process 3687 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTITCvE/profile http://localhost:56703/getInfo.html) 19:38:49 INFO - PROCESS | 3687 | __metrics Screen width/height:1600/1200 19:38:49 INFO - PROCESS | 3687 | colorDepth:24 19:38:49 INFO - PROCESS | 3687 | Browser inner width/height: 1024/697 19:38:49 INFO - PROCESS | 3687 | __metrics 19:38:49 ERROR - PROCESS | 3687 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 19:38:50 INFO - TEST-INFO | 3687: exit 0 19:38:50 INFO - Browser initialized. 19:38:50 INFO - Running cycle 1/1 for kraken test... 19:38:50 INFO - TEST-INFO | started process 3809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTITCvE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:39:02 INFO - PROCESS | 3809 | RSS: Main: 167636992 19:39:02 INFO - PROCESS | 3809 | 19:39:04 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56703/tests/kraken/driver.html?testName=audio-beat-detection) 19:39:05 INFO - PROCESS | 3809 | RSS: Main: 173481984 19:39:05 INFO - PROCESS | 3809 | 19:39:08 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56703/tests/kraken/driver.html?testName=audio-dft) 19:39:09 INFO - PROCESS | 3809 | RSS: Main: 172425216 19:39:09 INFO - PROCESS | 3809 | 19:39:11 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56703/tests/kraken/driver.html?testName=audio-fft) 19:39:12 INFO - PROCESS | 3809 | RSS: Main: 167456768 19:39:12 INFO - PROCESS | 3809 | 19:39:14 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56703/tests/kraken/driver.html?testName=audio-oscillator) 19:39:15 INFO - PROCESS | 3809 | RSS: Main: 168398848 19:39:15 INFO - PROCESS | 3809 | 19:39:17 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56703/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:39:18 INFO - PROCESS | 3809 | RSS: Main: 168472576 19:39:18 INFO - PROCESS | 3809 | 19:39:21 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56703/tests/kraken/driver.html?testName=imaging-darkroom) 19:39:22 INFO - PROCESS | 3809 | RSS: Main: 168767488 19:39:22 INFO - PROCESS | 3809 | 19:39:25 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56703/tests/kraken/driver.html?testName=imaging-desaturate) 19:39:26 INFO - PROCESS | 3809 | RSS: Main: 166510592 19:39:26 INFO - PROCESS | 3809 | 19:39:29 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56703/tests/kraken/driver.html?testName=json-parse-financial) 19:39:29 INFO - PROCESS | 3809 | RSS: Main: 168124416 19:39:29 INFO - PROCESS | 3809 | 19:39:31 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56703/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:39:31 INFO - PROCESS | 3809 | RSS: Main: 168411136 19:39:31 INFO - PROCESS | 3809 | 19:39:33 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56703/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:39:34 INFO - PROCESS | 3809 | RSS: Main: 168464384 19:39:34 INFO - PROCESS | 3809 | 19:39:36 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56703/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:39:37 INFO - PROCESS | 3809 | RSS: Main: 168751104 19:39:37 INFO - PROCESS | 3809 | 19:39:39 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56703/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:39:40 INFO - PROCESS | 3809 | RSS: Main: 168894464 19:39:40 INFO - PROCESS | 3809 | 19:39:43 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56703/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:39:43 INFO - PROCESS | 3809 | RSS: Main: 168894464 19:39:43 INFO - PROCESS | 3809 | 19:39:45 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56703/tests/kraken/driver.html?testName=ai-astar) 19:39:45 INFO - PROCESS | 3809 | RSS: Main: 169803776 19:39:45 INFO - PROCESS | 3809 | 19:39:45 INFO - PROCESS | 3809 | __start_tp_report 19:39:45 INFO - PROCESS | 3809 | _x_x_mozilla_page_load 19:39:45 INFO - PROCESS | 3809 | _x_x_mozilla_page_load_details 19:39:45 INFO - PROCESS | 3809 | |i|pagename|runs| 19:39:45 INFO - PROCESS | 3809 | |0;ai-astar;108;113;107;113;114;114;114;114;113;114 19:39:45 INFO - PROCESS | 3809 | |1;audio-beat-detection;149;119;149;181;120;153;164;119;181;119 19:39:45 INFO - PROCESS | 3809 | |2;audio-dft;164;163;163;165;167;170;166;162;161;163 19:39:45 INFO - PROCESS | 3809 | |3;audio-fft;75;75;74;172;77;76;75;75;164;77 19:39:45 INFO - PROCESS | 3809 | |4;audio-oscillator;84;84;153;86;85;84;136;85;87;150 19:39:45 INFO - PROCESS | 3809 | |5;imaging-gaussian-blur;118;118;118;118;117;118;118;117;119;120 19:39:45 INFO - PROCESS | 3809 | |6;imaging-darkroom;147;147;149;148;147;148;147;148;147;147 19:39:45 INFO - PROCESS | 3809 | |7;imaging-desaturate;95;95;96;96;96;96;96;98;96;97 19:39:45 INFO - PROCESS | 3809 | |8;json-parse-financial;54;52;52;51;53;52;52;58;51;53 19:39:45 INFO - PROCESS | 3809 | |9;json-stringify-tinderbox;62;62;62;63;64;63;63;63;64;63 19:39:45 INFO - PROCESS | 3809 | |10;stanford-crypto-aes;76;78;82;77;76;77;77;84;84;76 19:39:45 INFO - PROCESS | 3809 | |11;stanford-crypto-ccm;135;123;121;128;130;126;137;135;158;131 19:39:45 INFO - PROCESS | 3809 | |12;stanford-crypto-pbkdf2;157;161;157;153;154;156;156;156;157;163 19:39:45 INFO - PROCESS | 3809 | |13;stanford-crypto-sha256-iterative;63;64;63;63;65;68;64;62;63;62 19:39:45 INFO - PROCESS | 3809 | __end_tp_report 19:39:45 INFO - PROCESS | 3809 | __start_cc_report 19:39:45 INFO - PROCESS | 3809 | _x_x_mozilla_cycle_collect,922 19:39:45 INFO - PROCESS | 3809 | __end_cc_report 19:39:45 INFO - PROCESS | 3809 | __startTimestamp1468895985568__endTimestamp 19:39:45 INFO - PROCESS | 3809 | 19:39:45 INFO - PROCESS | 3809 | ------- Summary: start ------- 19:39:45 INFO - PROCESS | 3809 | Number of tests: 14 19:39:45 INFO - PROCESS | 3809 | 19:39:45 INFO - PROCESS | 3809 | [#0] ai-astar Cycles:10 Average:112.40 Median:114.00 stddev:2.63 (2.3%) stddev-sans-first:2.26 19:39:45 INFO - PROCESS | 3809 | Values: 108.0 113.0 107.0 113.0 114.0 114.0 114.0 114.0 113.0 114.0 19:39:45 INFO - PROCESS | 3809 | 19:39:45 INFO - PROCESS | 3809 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:151.00 stddev:25.17 (16.7%) stddev-sans-first:26.66 19:39:45 INFO - PROCESS | 3809 | Values: 149.0 119.0 149.0 181.0 120.0 153.0 164.0 119.0 181.0 119.0 19:39:45 INFO - PROCESS | 3809 | 19:39:45 INFO - PROCESS | 3809 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.50 stddev:2.67 (1.6%) stddev-sans-first:2.83 19:39:45 INFO - PROCESS | 3809 | Values: 164.0 163.0 163.0 165.0 167.0 170.0 166.0 162.0 161.0 163.0 19:39:45 INFO - PROCESS | 3809 | 19:39:45 INFO - PROCESS | 3809 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.00 stddev:39.06 (52.1%) stddev-sans-first:40.82 19:39:45 INFO - PROCESS | 3809 | Values: 75.0 75.0 74.0 172.0 77.0 76.0 75.0 75.0 164.0 77.0 19:39:45 INFO - PROCESS | 3809 | 19:39:45 INFO - PROCESS | 3809 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:84.50 stddev:29.95 (35.4%) stddev-sans-first:30.93 19:39:45 INFO - PROCESS | 3809 | Values: 84.0 84.0 153.0 86.0 85.0 84.0 136.0 85.0 87.0 150.0 19:39:45 INFO - PROCESS | 3809 | 19:39:45 INFO - PROCESS | 3809 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 19:39:45 INFO - PROCESS | 3809 | Values: 118.0 118.0 118.0 118.0 117.0 118.0 118.0 117.0 119.0 120.0 19:39:45 INFO - PROCESS | 3809 | 19:39:45 INFO - PROCESS | 3809 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 19:39:45 INFO - PROCESS | 3809 | Values: 147.0 147.0 149.0 148.0 147.0 148.0 147.0 148.0 147.0 147.0 19:39:45 INFO - PROCESS | 3809 | 19:39:45 INFO - PROCESS | 3809 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.83 19:39:45 INFO - PROCESS | 3809 | Values: 95.0 95.0 96.0 96.0 96.0 96.0 96.0 98.0 96.0 97.0 19:39:45 INFO - PROCESS | 3809 | 19:39:45 INFO - PROCESS | 3809 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:52.50 stddev:2.04 (3.9%) stddev-sans-first:2.12 19:39:45 INFO - PROCESS | 3809 | Values: 54.0 52.0 52.0 51.0 53.0 52.0 52.0 58.0 51.0 53.0 19:39:45 INFO - PROCESS | 3809 | 19:39:45 INFO - PROCESS | 3809 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 19:39:45 INFO - PROCESS | 3809 | Values: 62.0 62.0 62.0 63.0 64.0 63.0 63.0 63.0 64.0 63.0 19:39:45 INFO - PROCESS | 3809 | 19:39:45 INFO - PROCESS | 3809 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:77.50 stddev:3.30 (4.3%) stddev-sans-first:3.35 19:39:45 INFO - PROCESS | 3809 | Values: 76.0 78.0 82.0 77.0 76.0 77.0 77.0 84.0 84.0 76.0 19:39:45 INFO - PROCESS | 3809 | 19:39:45 INFO - PROCESS | 3809 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:133.00 stddev:10.42 (7.8%) stddev-sans-first:11.01 19:39:45 INFO - PROCESS | 3809 | Values: 135.0 123.0 121.0 128.0 130.0 126.0 137.0 135.0 158.0 131.0 19:39:45 INFO - PROCESS | 3809 | 19:39:45 INFO - PROCESS | 3809 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.00 Median:157.00 stddev:2.98 (1.9%) stddev-sans-first:3.16 19:39:45 INFO - PROCESS | 3809 | Values: 157.0 161.0 157.0 153.0 154.0 156.0 156.0 156.0 157.0 163.0 19:39:45 INFO - PROCESS | 3809 | 19:39:45 INFO - PROCESS | 3809 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.50 stddev:1.77 (2.8%) stddev-sans-first:1.86 19:39:45 INFO - PROCESS | 3809 | Values: 63.0 64.0 63.0 63.0 65.0 68.0 64.0 62.0 63.0 62.0 19:39:45 INFO - PROCESS | 3809 | -------- Summary: end -------- 19:39:45 INFO - PROCESS | 3809 | 19:39:46 INFO - TEST-INFO | 3809: exit 0 19:39:46 INFO - TEST-OK | kraken | took 62415ms 19:39:46 INFO - SUITE-END | took 1176s 19:39:46 INFO - Completed test suite (00:19:36) 19:39:46 INFO - javascript benchmark 19:39:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7402.165920135781, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3040.635123785146, 3068.8005279656827, 3075.0774767569737, 3082.4759790835556, 3099.0, 5315.867103322414, 5340.225667278247, 5426.484483974026, 5427.240186373911, 5446.863828404292, 5294.126469132598, 5394.352677678674, 5420.457954204578, 5447.12845944649, 5529.861753456155, 4971.204607262839, 5003.024410240005, 5042.420121685998, 5081.771320290577, 5124.308218390507, 617.4383658274891, 4875.561199492045, 4876.390451193601, 4943.431505376891, 5013.598912087043, 4884.096442158212, 4937.851864444036, 4944.851654450372, 4947.604191664658, 4982.676126051813, 4920.458749537548, 4930.211166213388, 4940.925886111711, 4979.576735977446, 4991.7753701083175, 4860.927086093711, 4880.389951256093, 4917.114919314522, 4939.431965323998, 4962.528559786851, 5328.760205790749, 5375.75809088592, 5397.54120899724, 5420.457954204548, 5435.695994828845, 5634.690092044936, 5783.5084017858535, 5791.420857914175, 5814.331351894544, 5863.794767183171, 5797.072468405077, 5852.385499522531, 5855.355910849803, 5856.00447923854, 5883.6469811811, 5402.865398266369, 5413.675179489243, 5448.536874365684, 5456.645318054353, 5460.563154947635, 5775.537956963432, 5916.349201587822, 5934.673592952429, 5990.580659353804, 5991.191189189491, 5714.314282286152, 5775.393583673654, 5803.129530570363, 5804.042333015005, 5837.3287071986415, 5843.853903652443, 5846.444587764156, 5849.707514624337, 5870.3249126350165, 5874.853128671817, 5511.559075273968, 5720.0, 5770.826875193751, 5814.30228372598, 5832.154337621021, 5765.884682306414, 5765.913511297334, 5768.077107662753, 5768.971155144198, 5776.942230577641, 4403.229434848953, 4423.1153769246275, 4441.844535441244, 4463.330500424897, 4485.573870482299, 3879.127196380848, 3894.182221733411, 3909.5308562972627, 3927.4108883667677, 3983.183447393277, 5378.1663842104535, 5399.460053994648, 5404.594655400861, 5431.565474762009, 5495.697736624524, 5768.1636162757, 5776.191333213354, 5793.710314484259, 5812.215350927655, 5812.912806307909, 5463.289772329572, 5562.332520097614, 5562.554995600342, 5609.27079479665, 5639.689817060019, 5033.622478314068, 5071.492850714899, 5082.542571168538, 5104.4895510449405, 5133.101707201225, 5895.587308888423, 6102.664353460602, 6108.839320529085, 6113.388661133851, 6138.1099740537375, 5777.884442311214, 5789.247397838254, 5793.0, 5878.735456904364, 5889.146073819358, 6026.668533230539, 6063.787767428119, 6071.119687645355, 6071.817845464467, 6085.4523092921845, 5615.775368985195, 5646.181303710857, 5742.483176514133, 5746.885062298814, 5775.104858746901, 5813.563982701399, 5834.18321434991, 5855.268091488564, 5889.381614930542, 5924.407559244041, 5698.430156984434, 5711.571632127524, 5715.8856822864145, 5717.313922329347, 5729.197912292199, 5511.917321240105, 5596.356419011866, 5652.349979752381, 5716.485516303553, 5731.598788084794, 5660.547156227574, 5665.008623490955, 5667.4332566743, 5673.035583950656, 5713.143028545752, 5647.915281270702, 5704.857378565569, 5710.229119068873, 5728.598998070095, 5779.7110144493445, 5434.918476222939, 5482.835514934558, 5503.9174412383045, 5591.776328946959, 5646.0683987141665], "value": 5325.671111362136, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.0533772492797, 585.3590318601132, 598.291025135215, 607.6840043177547, 642.6722371590488, 38823.22353552931, 43703.0, 43984.0, 44445.33332000019, 44562.0, 43507.0, 44102.0, 44597.77701111498, 44695.32957005648, 44772.328415073716, 8858.512781796982, 8887.111288871125, 8985.505797181153, 8991.28069754418, 9007.909920900805, 8873.20141187293, 8907.910920890772, 8929.285657147413, 8930.19628233462, 8970.147835955606, 8994.055624159468, 9039.683611073613, 9089.863652045224, 9091.136342047495, 9100.726978190665, 8949.77625559363, 8961.0, 8969.192772650493, 8984.326175536828, 9015.413998090104, 8880.689175878877, 8904.643814247422, 8962.82074358509, 8988.191062804313, 8990.0, 33607.0, 41998.580014199775, 42275.36586951198, 42291.0, 42532.78733606343, 3221.1785994571233, 3571.8921941623466, 3686.502322186524, 3805.219929914361, 4042.171354872244, 32375.514367284508, 32885.83557082223, 32924.17689557756, 35225.0, 35321.82339088314, 4513.52607976161, 4563.247064234397, 4569.314602809605, 4589.724616523019, 4654.045920586272, 369128.0, 373211.0, 375064.0, 375389.0, 377083.0, 58599.4140058594, 58896.705516472146, 59112.7044364784, 59156.0, 59246.0, 36857.0, 37967.62032379696, 38047.809760951015, 69239.0, 69544.6522767393, 15672.0, 15697.13665748372, 15800.60498487547, 15936.601584960468, 16023.839761602469, 12115.818262726067, 12315.384230788424, 12350.938245308897, 12366.381680916098, 12375.75248495025, 20853.0, 21260.893695531733, 21339.78660213409, 21345.679814802792, 21441.571168576542, 7710.995141263312, 7928.7224947127725, 7951.483153594998, 8061.669824479012, 8194.951262184453, 967.2455484721928, 1041.8228901086834, 1055.9577616895237, 1060.8408738689104, 1112.9121530797715, 34390.82804585961, 34460.138496537285, 34478.31043379169, 34628.30743385118, 34630.0, 1117.3184357542054, 1138.3056335635256, 1140.0309736723718, 1187.0562902492538, 1194.4087676600138, 17784.822151778317, 17984.640307193782, 18018.0, 18091.72862407065, 18192.545186370447, 566325.0, 579554.0, 581534.0, 584860.0, 585006.8246246497, 60370.698146509865, 61466.69266653638, 62174.0, 62471.375286247465, 62922.685386572775, 1353.9187648741106, 1376.4631793600704, 1376.7934809778612, 1382.5299398204659, 1388.645895296693, 31633.683663163993, 34561.827190863885, 35440.64559354373, 36539.19551909568, 38368.0, 56394.43605563892, 61119.38880611137, 61491.0, 61522.69238653778, 61776.382236177065, 464157.0, 477922.0, 478284.0, 479498.0, 481877.0, 47352.0, 47590.0, 47771.5222847781, 47853.521464786296, 47968.520314796406, 51463.0, 52232.73883630557, 52432.475675244285, 53075.0, 53664.463355365944, 44621.330680040475, 45307.38866296076, 45622.0, 46460.53539464562, 46502.76748616235, 43892.0, 45278.54721452743, 45393.09213815639, 45480.54519454763, 46346.59707327798, 38915.6108438912, 44011.59884011573, 44709.0, 44995.0, 45610.0, 36607.45088823616, 39564.2087158261, 40195.79902100471, 40331.79834100811, 40344.0, 29946.700532995263, 30542.0, 30988.69011309858, 31021.759129635466, 31273.530897036107], "value": 21221.927480416074, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.3266864658464, 392.5191640240704, 395.24705436144137, 395.7269484056001, 422.3938648040063, 14418.423263069491, 19291.807081929175, 20325.898370508163, 20976.790232097694, 21064.262750803726, 18864.717029244573, 19788.0, 20009.1996320147, 20029.399118026482, 20283.290084847034, 5347.41178470368, 5853.356130825606, 5980.252468441445, 6032.065029920347, 6032.125341825433, 5422.728863556826, 5744.626599271055, 5749.712514374264, 5834.299884013924, 5898.41015898411, 5762.164486149506, 5769.624974376673, 5781.595288329819, 5813.30240371156, 6302.0861975013595, 6315.179026726519, 6459.741610335581, 6557.377049180321, 6591.11020012297, 6605.339466053404, 5794.62334948227, 5813.47678708914, 5895.115732640095, 5927.881442371172, 5929.347771745104, 14412.279386030657, 14505.637359066108, 14715.705685886329, 14776.187309697962, 14852.628684282872, 2247.7077979862515, 2308.9653655195184, 2354.835161538693, 2380.8690522021284, 2388.3073908566494, 10322.329048611817, 10472.68581942543, 10702.625408110756, 10792.892071079266, 11095.50070246841, 1962.7939066398108, 1990.7810140884492, 2022.2618744158276, 2031.1570698160247, 2033.4509682385674, 80060.0, 89265.55367223188, 91790.0, 92040.53979730059, 92534.5373273136, 11121.777564448666, 11380.487878045507, 11453.370064646359, 11468.0, 11522.711932201762, 15962.281697323648, 16049.839501605067, 16105.436309729103, 16199.43301984425, 16221.2700428481, 7886.802829929297, 8120.390970677105, 8220.547869867214, 8325.791855203548, 8325.916740832514, 7595.202503737139, 7716.228377162239, 7716.498427602301, 7891.368690504746, 7903.288704016666, 4806.543378379049, 4820.855374338776, 4896.290037944478, 4900.534449227318, 5039.26930595069, 1964.361582485698, 2039.9698152432927, 2047.7747447780732, 2068.307117115753, 2092.550101728136, 969.7963427680126, 978.8433850583872, 994.7115336552318, 1023.0741179232806, 1061.145777649, 20069.799302007086, 20727.792722072587, 21165.68251476229, 21200.363989080353, 21469.14123435076, 968.941863488193, 995.323180237431, 1000.8348622477355, 1013.7871047080196, 1033.102148473539, 10893.291936024134, 11156.94009069137, 11420.486078126503, 11742.647720568397, 12065.457054432572, 546874.0, 553987.0, 569163.0, 579671.0, 580506.0, 58666.41333586695, 59198.40801591929, 98190.50904745431, 100600.49699751455, 102027.0, 1026.625281772148, 1031.8761748590218, 1062.744941214103, 1072.983905241422, 1078.1482628723377, 17712.55718607045, 17835.286588536314, 18567.814321856607, 18603.81396186075, 18671.719924200876, 43660.78169609132, 44628.0, 45991.0, 46263.53736462727, 46537.0, 64527.67736161289, 65860.67069664621, 67339.0, 67811.66094169498, 68425.65787171232, 7540.811479713051, 8328.958355208186, 8584.270337021424, 8654.264387527131, 8705.651773928972, 12707.809382859079, 12797.97616190721, 13183.274919879499, 13337.799933000819, 13364.465421383036, 10838.403887786248, 10949.45252737344, 11269.830952535882, 11440.48517816717, 11536.192466527262, 10975.83536246941, 11178.776424471302, 11369.2609980351, 11404.885951140383, 11459.942700286445, 10970.945145274223, 11139.888601113886, 11371.943140284246, 11594.188406811441, 11974.820377694168, 8072.515649060841, 8140.715074972584, 8149.0, 8156.265936065783, 8203.179682031749, 10496.527656255334, 11087.72280692989, 11348.0, 11389.544418223179, 11805.291682499077], "value": 9336.977208372577, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1465.1721777195883, 1497.0867770659897, 1639.8524132828043, 1761.0652102414863, 1786.1069465267358, 7484.9251507484905, 8297.543635100075, 8386.790330241747, 8837.513936733485, 8978.551072446377, 8568.314534837215, 8680.56597170142, 8751.518666473341, 8796.91203087969, 8811.074837142089, 2331.94170145746, 2360.7757263060066, 2384.9284521464297, 2385.034061205206, 2392.820538459614, 2313.7454879963275, 2326.895289711967, 2330.1029103795076, 2337.5792357375667, 2343.4375749820006, 2316.0851463671925, 2320.8607483550954, 2329.231353653299, 2334.673145759595, 2347.1550241912983, 2277.7266727992746, 2296.2651951375565, 2297.5634629420356, 2300.056976639578, 2313.1556981701556, 2295.093438091961, 2296.712910886139, 2298.333708061642, 2299.6435552489224, 2311.0, 8613.870791938063, 8657.350698697559, 8664.740057798275, 8686.522241276727, 8767.561621918941, 5102.591792656579, 5185.611079169077, 5209.29674493946, 5239.318888544503, 5240.4497527759795, 3269.7251334783423, 3347.2636020075543, 3392.932141357184, 3407.863685452579, 3424.8630054797777, 1123.2338039887686, 1137.124414201069, 1156.7859945910034, 1164.2199726183478, 1167.6497050884786, 11299.096072314194, 11431.714207144887, 11528.596499122574, 11663.766724665544, 11692.181547291693, 4450.532694067077, 4567.383403240587, 4646.117237724821, 4670.042641258602, 4675.0883577702025, 10028.047335503115, 10092.646757363604, 10109.595616175418, 10143.0, 10155.39067655943, 5314.256004159421, 5331.413544510101, 5334.119870221448, 5334.333208348957, 5347.572194224453, 4343.478782546114, 4702.4592171899985, 4785.282207668877, 4811.711297322172, 4830.830920917751, 3820.331441997639, 3916.6083391661177, 3916.96083039166, 3928.508936382952, 4021.638052575224, 1260.8802163794426, 1265.2787910890704, 1269.1560112525067, 1270.6378682075565, 1281.0264199208668, 970.1268858027831, 988.1205726903062, 996.6511720897628, 1002.5688953749958, 1039.5062345385882, 5746.770129194869, 5747.0, 5754.568407369464, 5992.0712289595185, 6041.124037014696, 480.6299149654816, 481.925306566359, 482.2404712577704, 489.7624652043756, 491.2582001178247, 4169.791510424528, 4181.372794080851, 4290.0, 4362.389265502832, 4370.213361594943, 10114.342567733222, 10481.633142839964, 10592.0, 10606.734831629272, 10752.516136773864, 10412.167026637851, 10492.842607360895, 10508.422036787897, 10543.736406589744, 10579.259451838298, 7651.196624354363, 7883.842323153504, 8064.55644939534, 8089.635966381527, 8120.269175774209, 5874.941250587611, 5975.760969561343, 6058.212432383762, 6163.7842675506145, 6224.221972253468, 9086.22767064807, 9610.95194524051, 9615.326927115315, 9851.950740246253, 9915.355501892354, 9611.711648650551, 9912.900870991487, 9968.850467242852, 10024.599016039278, 10028.247881408777, 7317.378022868116, 7416.517926334771, 7606.20134885829, 7653.88519172224, 7681.731139410093, 8180.7954801130445, 8282.585870706562, 8319.875201872097, 8337.583120844054, 8340.0, 7350.0, 7459.365953893763, 7467.589282589292, 7519.0, 7542.396608271435, 7150.141982962078, 7224.494285399972, 7281.781546553612, 7356.816079597838, 7392.0, 7138.964305178441, 7205.279472052753, 7206.243344448757, 7231.4937954342695, 7258.346748792423, 4987.850364489072, 5059.367579052619, 5116.692998419958, 5315.867103322448, 5364.356277246756, 5153.098207813543, 5195.893150097503, 5226.869328266824, 5261.896679114121, 5396.028714831368], "value": 4521.337562386332, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.97990120592766, 337.96958273755365, 343.5653897819259, 347.7200853313082, 353.7081907426374, 5536.169574563813, 5560.415281644732, 5563.916541251884, 5606.971965140179, 5619.83140505785, 5488.313960754906, 5498.81775418286, 5500.5874559408, 5501.284832971718, 5506.5870059745475, 4116.629503344699, 4219.409282700424, 4319.1211822857, 4332.480102387718, 4336.197803406364, 4298.935515967263, 4325.52419233884, 4330.761808100553, 4341.717788343748, 4347.760873151976, 4288.313869780835, 4294.871153865373, 4297.935530967023, 4310.353446982962, 4331.45856767904, 4074.1647962167685, 4292.978535107304, 4305.397244385788, 4313.374560688714, 4315.130438258554, 3774.0564858785306, 3790.564085130218, 3795.8291876865605, 3800.600936901641, 3803.2773772983046, 5355.651882627617, 5375.650582712111, 5397.54120899724, 5415.675059496442, 5420.7018613976215, 4812.35033270511, 4822.95177048232, 4832.710037397767, 4854.538818812207, 4882.487338829407, 5723.51350135239, 5739.0, 5767.88464230713, 5771.5082375163265, 5775.393583673737, 4053.837846486137, 4058.431819545266, 4062.7765472898977, 4063.6342729154517, 4076.8369265229353, 5852.414758524156, 5969.910451343233, 5992.760289588411, 5996.571388587629, 6003.249593800775, 4206.137741762931, 4234.703570750018, 4237.279662457328, 4252.234597772369, 4257.318828987347, 4255.5956534343595, 4279.165562715303, 4281.593248641374, 4284.007936309631, 4300.16146851361, 4700.764961751899, 4883.609311255091, 4904.55858972687, 4942.406911170682, 4949.876253093629, 5773.913391299134, 5784.942150578525, 5828.65028098307, 5829.854253643608, 5831.88336233273, 1465.8973871829082, 1478.5510200003841, 1490.2772155504572, 1490.6795039066653, 1496.1696258576376, 943.6744323208482, 951.9528518629452, 976.6972238606055, 1014.7412409835445, 1020.0921180149672, 5570.025245582007, 5582.86042848932, 5593.916091258634, 5606.467385598362, 5609.335565606304, 5873.530117590668, 5928.347881733006, 5930.673812940329, 5945.0, 5984.281886173687, 5436.891262174734, 5609.382967873531, 5732.799352022659, 5739.397363276879, 5764.654120752768, 3190.888318908827, 3209.8876539321477, 3212.3414699986447, 3231.0145405651033, 3233.544904792853, 6027.101463039128, 6085.6348619083, 6190.442860142609, 6194.938050619527, 6213.0, 6050.515958723292, 6091.116788065706, 6103.176071230416, 6113.227164122443, 6156.199694039746, 6157.33751886988, 6158.353372895782, 6162.506999440034, 6170.876582468325, 6233.594816336833, 5732.340780810094, 6026.764513274856, 6042.516598672184, 6051.878962420815, 6062.090686396899, 5896.9115463268945, 5920.615160014585, 5930.28836539618, 5941.881162376815, 5951.851203719942, 5874.618149820248, 6159.23009623797, 6184.257889053342, 6202.4417802398, 6203.131561581473, 4226.387173859835, 4235.597618226264, 4242.915141697211, 4255.55305699218, 4266.893327666833, 5749.770009199752, 5885.676287804212, 5983.581149319506, 5999.520038397005, 6029.583047983632, 5794.884102318014, 5844.736986835517, 5864.654138344526, 5880.26496687914, 5881.500072493886, 5779.757352169304, 5848.678322692293, 5862.208601838697, 5883.794067207627, 5899.882002360015, 5631.211630371669, 5846.649201047951, 5854.0340843760305, 5863.0, 5870.0, 5868.618539794899, 5878.706064696834, 5905.704714764331, 5919.556033297434, 5923.763049477972, 5485.080221922295, 5749.396313387034, 5790.276215473066, 5802.622829516068, 5831.512964194103], "value": 4432.562253104722, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.3088923634871, 781.6482582837724, 809.3507318913977, 845.7505036014376, 871.1114663043695, 15502.534923952271, 16637.750433743502, 16684.83315166848, 16812.74780878288, 16828.57928551787, 14743.705125897503, 14860.777088343684, 14936.701265974674, 15051.871109666765, 15082.396704131848, 816.1634324817065, 832.1179549677331, 833.170994860115, 836.7949852286198, 837.0374069819695, 668.4151367553391, 800.0998876264202, 827.4414770030236, 828.1139181076251, 831.2186544648011, 885.5350940756123, 886.9689560865371, 895.444824208988, 896.274018045382, 900.6757567275776, 887.8046829697456, 888.1695614600337, 892.6518657723493, 896.0412358776113, 897.3718397122041, 651.0494677770461, 653.7025653327725, 654.3750718064284, 654.6203202142746, 656.7701304543419, 15428.691426171414, 15500.612484687861, 15505.534833955, 15531.378744850306, 15564.221788910509, 15853.92073039639, 15861.682766344724, 15869.44456944013, 15918.681626367523, 16227.91886040574, 12753.61739147827, 12781.360931953459, 12913.935430322883, 13141.408636611375, 13402.195868247838, 3940.487736594253, 3952.3873799560824, 3986.063275130371, 4002.1595464952393, 4171.019810344566, 68165.65917170432, 70226.94659580161, 71703.64148179277, 74371.62814185949, 75154.0, 12126.878731212752, 12361.876381236252, 12383.69040773988, 12480.81278780819, 12886.548970785978, 22125.336239912827, 22140.0, 22146.22488212937, 22203.55592888133, 22216.777832221473, 8798.0, 8950.641974320954, 9152.581349890777, 9168.0, 9215.216706580015, 4882.36529251195, 4986.152354099811, 5039.041854064221, 5100.897982040413, 5180.689158650418, 3445.0870519312402, 3513.998510424568, 3538.5046093546925, 3547.1486843157454, 3555.2178520725397, 646.7380710812129, 650.6649075726004, 653.8398092467376, 663.9502037347219, 672.8486090629569, 646.9514786391039, 767.7773445700684, 782.1123025366137, 791.1850793682516, 819.148085990575, 9669.9033009669, 10234.6417875374, 10330.638427654996, 10341.74145646365, 10426.947865260625, 632.8259728574678, 684.7089986755708, 704.3555147040503, 726.7529040126383, 786.7639708087551, 5039.028059356526, 5121.0, 5136.178211486144, 5207.0, 5218.765155567932, 112949.0, 113765.43117284526, 115837.0, 116013.29900257515, 118202.4089879545, 101348.49325753472, 103013.48493257485, 103072.0, 104206.47896760468, 104567.0, 89286.55356723175, 90914.0, 91382.0, 91471.0, 93384.53307733282, 9564.808703826024, 9790.314677972474, 9805.656802012181, 9816.411015339103, 9878.703638890845, 48648.0, 49330.75334623304, 50825.0, 51084.97830043453, 51519.48480515147, 66977.66511167413, 77617.223827761, 78851.0, 79396.0, 79740.60129699546, 11194.496247668712, 11629.302241865515, 11661.708457288636, 12339.50641974311, 12915.095943283879, 13834.100783449043, 13907.860921390657, 14246.287685615885, 14739.631509212355, 14889.329980150702, 13310.733785324046, 13540.458381664623, 13726.86273137256, 13985.860141398864, 14190.432382704576, 13430.597082087554, 13511.662208444868, 13811.378487967864, 14114.858851411765, 14161.291935403395, 13046.217226966033, 13279.136856104322, 13386.19682819034, 13470.461181552628, 13507.932460337635, 10844.447967656672, 10902.0, 10924.160465417273, 11183.552657893593, 11261.155413344195, 10598.20513461478, 10711.250212485364, 11643.88356116428, 11820.468078936641, 12088.335141566946], "value": 7777.12875404045, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.8000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 113.0, 107.0, 113.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 119.0, 149.0, 181.0, 120.0, 153.0, 164.0, 119.0, 181.0, 119.0], "value": 145.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 165.0, 167.0, 170.0, 166.0, 162.0, 161.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 172.0, 77.0, 76.0, 75.0, 75.0, 164.0, 77.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 153.0, 86.0, 85.0, 84.0, 136.0, 85.0, 87.0, 150.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 119.0, 120.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 149.0, 148.0, 147.0, 148.0, 147.0, 148.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 98.0, 96.0, 97.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 52.0, 51.0, 53.0, 52.0, 52.0, 58.0, 51.0, 53.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 64.0, 63.0, 63.0, 63.0, 64.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 82.0, 77.0, 76.0, 77.0, 77.0, 84.0, 84.0, 76.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 123.0, 121.0, 128.0, 130.0, 126.0, 137.0, 135.0, 158.0, 131.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 161.0, 157.0, 153.0, 154.0, 156.0, 156.0, 156.0, 157.0, 163.0], "value": 157.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 65.0, 68.0, 64.0, 62.0, 63.0, 62.0], "value": 63.7, "unit": "score"}]}]} 19:39:46 INFO - Return code: 0 19:39:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:39:46 ERROR - # TBPL SUCCESS # 19:39:46 INFO - Running post-action listener: _resource_record_post_action 19:39:46 INFO - ##### 19:39:46 INFO - ##### Finished run-tests step (success) 19:39:46 INFO - ##### 19:39:46 INFO - Running post-run listener: _resource_record_post_run 19:39:46 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 7761920; Write bytes: 376258560; Read time: 864; Write time: 385804 19:39:46 INFO - TinderboxPrint: CPU usage
13.3% 19:39:46 INFO - TinderboxPrint: I/O read bytes / time
7,761,920 / 864 19:39:46 INFO - TinderboxPrint: I/O write bytes / time
376,258,560 / 385,804 19:39:46 INFO - TinderboxPrint: CPU idle
8,254.3 (86.6%) 19:39:46 INFO - TinderboxPrint: CPU user
1,212.0 (12.7%) 19:39:46 INFO - TinderboxPrint: Swap in / out
0 / 0 19:39:46 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 167211008; Read time: 0; Write time: 182896 19:39:46 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 5541888; Write bytes: 209047552; Read time: 672; Write time: 202908 19:39:47 INFO - Running post-run listener: _upload_blobber_files 19:39:47 INFO - Blob upload gear active. 19:39:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:39:47 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 19:39:47 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:39:47 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:39:47 INFO - (blobuploader) - INFO - Open directory for files ... 19:39:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:39:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:39:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:39:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:39:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:39:48 INFO - (blobuploader) - INFO - Done attempting. 19:39:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:39:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:39:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:39:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:39:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:39:56 INFO - (blobuploader) - INFO - Done attempting. 19:39:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:39:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:39:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:39:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:39:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:39:56 INFO - (blobuploader) - INFO - Done attempting. 19:39:56 INFO - (blobuploader) - INFO - Iteration through files over. 19:39:56 INFO - Return code: 0 19:39:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:39:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:39:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a33e3e4217c5548632fe8013e4be5130cddcc9f82028182e5dca418b56b1bd72b060fd8556b31304f49212e5fd7c3b4948176b25a205ee05f83ecb57800160e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3021c58ebaa9b857df612288ab2beccf96c0c2ff7639e56b9401870721771cbfbd271aae65e8595ddecc86bf5bdf781ab654152c3186ebff3e713677bb2927c1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b948eed26b92d7794c19537c1aa34fb120a16f00ffec990a006803397fd83c3241efdc6cbd6e47042bef2507a208c53543ad329485d1bc372b3b43cf26e68ad"} 19:39:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:39:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:39:56 INFO - Contents: 19:39:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a33e3e4217c5548632fe8013e4be5130cddcc9f82028182e5dca418b56b1bd72b060fd8556b31304f49212e5fd7c3b4948176b25a205ee05f83ecb57800160e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3021c58ebaa9b857df612288ab2beccf96c0c2ff7639e56b9401870721771cbfbd271aae65e8595ddecc86bf5bdf781ab654152c3186ebff3e713677bb2927c1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b948eed26b92d7794c19537c1aa34fb120a16f00ffec990a006803397fd83c3241efdc6cbd6e47042bef2507a208c53543ad329485d1bc372b3b43cf26e68ad"} 19:39:56 INFO - Running post-run listener: copy_logs_to_upload_dir 19:39:56 INFO - Copying logs to upload dir... 19:39:56 INFO - mkdir: /builds/slave/test/build/upload/logs 19:39:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.680640 ========= master_lag: 0.47 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-18 19:39:57.326462) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 19:39:57.329776) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a33e3e4217c5548632fe8013e4be5130cddcc9f82028182e5dca418b56b1bd72b060fd8556b31304f49212e5fd7c3b4948176b25a205ee05f83ecb57800160e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3021c58ebaa9b857df612288ab2beccf96c0c2ff7639e56b9401870721771cbfbd271aae65e8595ddecc86bf5bdf781ab654152c3186ebff3e713677bb2927c1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b948eed26b92d7794c19537c1aa34fb120a16f00ffec990a006803397fd83c3241efdc6cbd6e47042bef2507a208c53543ad329485d1bc372b3b43cf26e68ad"} build_url:https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011131 build_url: 'https://queue.taskcluster.net/v1/task/U4lFs8IqS3OxMBbfrIxyvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a33e3e4217c5548632fe8013e4be5130cddcc9f82028182e5dca418b56b1bd72b060fd8556b31304f49212e5fd7c3b4948176b25a205ee05f83ecb57800160e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3021c58ebaa9b857df612288ab2beccf96c0c2ff7639e56b9401870721771cbfbd271aae65e8595ddecc86bf5bdf781ab654152c3186ebff3e713677bb2927c1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b948eed26b92d7794c19537c1aa34fb120a16f00ffec990a006803397fd83c3241efdc6cbd6e47042bef2507a208c53543ad329485d1bc372b3b43cf26e68ad"}' ========= master_lag: 0.16 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 19:39:57.501117) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 19:39:57.501470) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1468887014.576228-107323183 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.11 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 19:39:57.618658) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 19:39:57.618964) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 19:39:57.619270) ========= ========= Total master_lag: 0.81 =========