builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-054 starttime: 1468235470.48 results: success (0) buildid: 20160711024832 builduid: adfde23437bc4ea9866eda05deae5038 revision: 1bee8d2da23ec894980fb14f516210fd83e5b9f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 04:11:10.482138) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 04:11:10.482696) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 04:11:10.483027) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 04:11:10.499149) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:11:10.499473) ========= 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=cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 04:11:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-07-11 04:11:11 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107639 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:11:10.621270) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:11:10.621668) ========= 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=cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017073 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:11:10.673911) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:11:10.674639) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1bee8d2da23ec894980fb14f516210fd83e5b9f9 --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 1bee8d2da23ec894980fb14f516210fd83e5b9f9 --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=cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 04:11:11,513 truncating revision to first 12 chars 2016-07-11 04:11:11,513 Setting DEBUG logging. 2016-07-11 04:11:11,513 attempt 1/10 2016-07-11 04:11:11,513 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1bee8d2da23e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 04:11:11,844 unpacking tar archive at: mozilla-central-1bee8d2da23e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.669348 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:11:11.359417) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 04:11:11.359777) ========= script_repo_revision: 1bee8d2da23ec894980fb14f516210fd83e5b9f9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 04:11:11.360218) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 04:11:11.360544) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 04:11:11.370057) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 7 secs) (at 2016-07-11 04:11:11.370504) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:11:12 INFO - MultiFileLogger online at 20160711 04:11:12 in /builds/slave/test 04:11:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:11:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:11:12 INFO - {'append_to_log': False, 04:11:12 INFO - 'base_work_dir': '/builds/slave/test', 04:11:12 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:11:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:11:12 INFO - 'branch': 'Firefox-Non-PGO', 04:11:12 INFO - 'buildbot_json_path': 'buildprops.json', 04:11:12 INFO - 'config_files': ('talos/linux_config.py',), 04:11:12 INFO - 'default_actions': ('clobber', 04:11:12 INFO - 'read-buildbot-config', 04:11:12 INFO - 'download-and-extract', 04:11:12 INFO - 'populate-webroot', 04:11:12 INFO - 'create-virtualenv', 04:11:12 INFO - 'install', 04:11:12 INFO - 'run-tests'), 04:11:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:11:12 INFO - 'download_minidump_stackwalk': True, 04:11:12 INFO - 'download_symbols': 'ondemand', 04:11:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:11:12 INFO - 'tooltool.py': '/tools/tooltool.py', 04:11:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:11:12 INFO - '/tools/misc-python/virtualenv.py')}, 04:11:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:11:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:11:12 INFO - 'installer_path': 'installer.exe', 04:11:12 INFO - 'log_level': 'info', 04:11:12 INFO - 'log_name': 'talos', 04:11:12 INFO - 'log_to_console': True, 04:11:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:11:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:11:12 INFO - 'opt_config_files': (), 04:11:12 INFO - 'pip_index': False, 04:11:12 INFO - 'sps_profile': False, 04:11:12 INFO - 'sps_profile_interval': 0, 04:11:12 INFO - 'suite': 'dromaeojs-e10s', 04:11:12 INFO - 'system_bits': '32', 04:11:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:11:12 INFO - 'title': 'talos-linux64-ix-054', 04:11:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:11:12 INFO - 'use_talos_json': True, 04:11:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:11:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:11:12 INFO - 'work_dir': 'build'} 04:11:12 INFO - ##### 04:11:12 INFO - ##### Running clobber step. 04:11:12 INFO - ##### 04:11:12 INFO - Running pre-action listener: _resource_record_pre_action 04:11:12 INFO - Running main action method: clobber 04:11:12 INFO - rmtree: /builds/slave/test/build 04:11:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:11:13 INFO - Running post-action listener: _resource_record_post_action 04:11:13 INFO - ##### 04:11:13 INFO - ##### Finished clobber step (success) 04:11:13 INFO - ##### 04:11:13 INFO - ##### 04:11:13 INFO - ##### Running read-buildbot-config step. 04:11:13 INFO - ##### 04:11:13 INFO - Running pre-action listener: _resource_record_pre_action 04:11:13 INFO - Running main action method: read_buildbot_config 04:11:13 INFO - Using buildbot properties: 04:11:13 INFO - { 04:11:13 INFO - "project": "", 04:11:13 INFO - "product": "firefox", 04:11:13 INFO - "script_repo_revision": "production", 04:11:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:11:13 INFO - "repository": "", 04:11:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:11:13 INFO - "buildid": "20160711024832", 04:11:13 INFO - "pgo_build": "False", 04:11:13 INFO - "basedir": "/builds/slave/test", 04:11:13 INFO - "buildnumber": 110, 04:11:13 INFO - "slavename": "talos-linux64-ix-054", 04:11:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:11:13 INFO - "platform": "ubuntu64_hw", 04:11:13 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:11:13 INFO - "branch": "mozilla-central", 04:11:13 INFO - "repo_path": "mozilla-central", 04:11:13 INFO - "revision": "1bee8d2da23ec894980fb14f516210fd83e5b9f9", 04:11:13 INFO - "stage_platform": "linux64", 04:11:13 INFO - "builduid": "adfde23437bc4ea9866eda05deae5038", 04:11:13 INFO - "slavebuilddir": "test" 04:11:13 INFO - } 04:11:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:11:13 INFO - Running post-action listener: _resource_record_post_action 04:11:13 INFO - ##### 04:11:13 INFO - ##### Finished read-buildbot-config step (success) 04:11:13 INFO - ##### 04:11:13 INFO - ##### 04:11:13 INFO - ##### Running download-and-extract step. 04:11:13 INFO - ##### 04:11:13 INFO - Running pre-action listener: _resource_record_pre_action 04:11:13 INFO - Running main action method: download_and_extract 04:11:13 INFO - mkdir: /builds/slave/test/build/tests 04:11:13 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')]} 04:11:13 INFO - https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:11:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:11:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:11:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/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 04:11:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/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 04:11:14 INFO - Downloaded 1361 bytes. 04:11:14 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:11:14 INFO - Using the following test package requirements: 04:11:14 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:11:14 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:11:14 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:11:14 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:14 INFO - u'jsshell-linux-x86_64.zip'], 04:11:14 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:11:14 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:11:14 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:11:14 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:11:14 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:11:14 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:11:14 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:11:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:14 INFO - https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:11:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:11:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:11:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/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 04:11:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/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 04:11:15 INFO - Downloaded 22735220 bytes. 04:11:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:11:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:11:17 INFO - Return code: 0 04:11:17 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:11:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:17 INFO - https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:11:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:11:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:11:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/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 04:11:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/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 04:11:18 INFO - Downloaded 22735220 bytes. 04:11:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:11:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:11:20 INFO - Return code: 0 04:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:20 INFO - https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:11:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:11:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:11:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/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 04:11:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/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 04:11:22 INFO - Downloaded 14403333 bytes. 04:11:22 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'] 04:11:22 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 04:11:22 INFO - Return code: 0 04:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:22 INFO - https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:11:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:11:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:11:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/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 04:11:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yq16t2pIQSGR7KWreNKxJA/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 04:11:25 INFO - Downloaded 56656866 bytes. 04:11:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:11:25 INFO - mkdir: /builds/slave/test/properties 04:11:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:11:25 INFO - Writing to file /builds/slave/test/properties/build_url 04:11:25 INFO - Contents: 04:11:25 INFO - build_url:https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:11:25 INFO - Running post-action listener: _resource_record_post_action 04:11:25 INFO - Running post-action listener: set_extra_try_arguments 04:11:25 INFO - ##### 04:11:25 INFO - ##### Finished download-and-extract step (success) 04:11:25 INFO - ##### 04:11:25 INFO - ##### 04:11:25 INFO - ##### Running populate-webroot step. 04:11:25 INFO - ##### 04:11:25 INFO - Running pre-action listener: _resource_record_pre_action 04:11:25 INFO - Running main action method: populate_webroot 04:11:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:11:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:11:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:11:25 INFO - '--tppagecycles', 04:11:25 INFO - '7'], 04:11:25 INFO - 'tests': ['tsvgm']}}, 04:11:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:11:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:11:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:11:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:11:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:11:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:11:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:25 INFO - 'talos_options': ['--disable-e10s'], 04:11:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:25 INFO - 'talos_options': ['--disable-e10s'], 04:11:25 INFO - 'tests': ['damp', 'tps']}, 04:11:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:25 INFO - 'tests': ['damp', 'tps']}, 04:11:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:11:25 INFO - 'tests': ['dromaeo_dom']}, 04:11:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:11:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:11:25 INFO - 'tests': ['basic_compositor_video']}, 04:11:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:11:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:11:25 INFO - 'tests': ['a11yr', 04:11:25 INFO - 'ts_paint', 04:11:25 INFO - 'tpaint', 04:11:25 INFO - 'sessionrestore', 04:11:25 INFO - 'sessionrestore_no_auto_restore', 04:11:25 INFO - 'tabpaint']}, 04:11:25 INFO - 'other-e10s': {'tests': ['a11yr', 04:11:25 INFO - 'ts_paint', 04:11:25 INFO - 'tpaint', 04:11:25 INFO - 'sessionrestore', 04:11:25 INFO - 'sessionrestore_no_auto_restore', 04:11:25 INFO - 'tabpaint']}, 04:11:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:11:25 INFO - 'ts_paint', 04:11:25 INFO - 'tpaint', 04:11:25 INFO - 'sessionrestore', 04:11:25 INFO - 'sessionrestore_no_auto_restore', 04:11:25 INFO - 'tabpaint']}, 04:11:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:11:25 INFO - 'ts_paint', 04:11:25 INFO - 'tpaint', 04:11:25 INFO - 'sessionrestore', 04:11:25 INFO - 'sessionrestore_no_auto_restore', 04:11:25 INFO - 'tabpaint']}, 04:11:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:11:25 INFO - 'tests': ['a11yr', 04:11:25 INFO - 'ts_paint', 04:11:25 INFO - 'tpaint', 04:11:25 INFO - 'sessionrestore', 04:11:25 INFO - 'sessionrestore_no_auto_restore', 04:11:25 INFO - 'tabpaint']}, 04:11:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:11:25 INFO - 'tests': ['a11yr', 04:11:25 INFO - 'ts_paint', 04:11:25 INFO - 'tpaint', 04:11:25 INFO - 'sessionrestore', 04:11:25 INFO - 'sessionrestore_no_auto_restore', 04:11:25 INFO - 'tabpaint']}, 04:11:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:11:25 INFO - 'tests': ['tsvgx', 04:11:25 INFO - 'tsvgr_opacity', 04:11:25 INFO - 'tart', 04:11:25 INFO - 'tscrollx', 04:11:25 INFO - 'cart']}, 04:11:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:11:25 INFO - 'tsvgr_opacity', 04:11:25 INFO - 'tart', 04:11:25 INFO - 'tscrollx', 04:11:25 INFO - 'cart']}, 04:11:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:25 INFO - 'talos_options': ['--disable-e10s'], 04:11:25 INFO - 'tests': ['tp5o']}, 04:11:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:25 INFO - 'tests': ['tp5o']}, 04:11:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:25 INFO - 'talos_options': ['--disable-e10s', 04:11:25 INFO - '--xperf_path', 04:11:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:25 INFO - 'tests': ['tp5n']}, 04:11:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:25 INFO - 'talos_options': ['--xperf_path', 04:11:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:25 INFO - 'tests': ['tp5n']}}, 04:11:25 INFO - 'talos.zip': {'path': '', 04:11:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:11:25 INFO - Running post-action listener: _resource_record_post_action 04:11:25 INFO - ##### 04:11:25 INFO - ##### Finished populate-webroot step (success) 04:11:25 INFO - ##### 04:11:25 INFO - ##### 04:11:25 INFO - ##### Running create-virtualenv step. 04:11:25 INFO - ##### 04:11:25 INFO - Running pre-action listener: _resource_record_pre_action 04:11:25 INFO - Running main action method: create_virtualenv 04:11:25 INFO - Creating virtualenv /builds/slave/test/build/venv 04:11:25 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 04:11:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:11:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:11:25 INFO - Using real prefix '/usr' 04:11:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:11:26 INFO - Installing distribute.............................................................................................................................................................................................done. 04:11:28 INFO - Installing pip.................done. 04:11:28 INFO - Return code: 0 04:11:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1616400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5570>, '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 0x16a6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a6900>, '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': 'cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349', '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 04:11:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:11:28 INFO - Using env: {'DISPLAY': ':0', 04:11:28 INFO - 'HOME': '/home/cltbld', 04:11:28 INFO - 'LANG': 'en_US.UTF-8', 04:11:28 INFO - 'LANGUAGE': 'en_US:en', 04:11:28 INFO - 'LOGNAME': 'cltbld', 04:11:28 INFO - 'MAIL': '/var/mail/cltbld', 04:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:28 INFO - 'MOZ_NO_REMOTE': '1', 04:11:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:28 INFO - 'NO_EM_RESTART': '1', 04:11:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:28 INFO - 'PWD': '/builds/slave/test', 04:11:28 INFO - 'SHELL': '/bin/bash', 04:11:28 INFO - 'SHLVL': '1', 04:11:28 INFO - 'TERM': 'linux', 04:11:28 INFO - 'TMOUT': '86400', 04:11:28 INFO - 'USER': 'cltbld', 04:11:28 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349', 04:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:28 INFO - '_': '/tools/buildbot/bin/python'} 04:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:28 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 04:11:28 INFO - Cleaning up... 04:11:28 INFO - Return code: 0 04:11:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13e7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1616400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5570>, '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 0x16a6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a6900>, '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': 'cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349', '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 04:11:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:11:28 INFO - Using env: {'DISPLAY': ':0', 04:11:28 INFO - 'HOME': '/home/cltbld', 04:11:28 INFO - 'LANG': 'en_US.UTF-8', 04:11:28 INFO - 'LANGUAGE': 'en_US:en', 04:11:28 INFO - 'LOGNAME': 'cltbld', 04:11:28 INFO - 'MAIL': '/var/mail/cltbld', 04:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:28 INFO - 'MOZ_NO_REMOTE': '1', 04:11:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:28 INFO - 'NO_EM_RESTART': '1', 04:11:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:28 INFO - 'PWD': '/builds/slave/test', 04:11:28 INFO - 'SHELL': '/bin/bash', 04:11:28 INFO - 'SHLVL': '1', 04:11:28 INFO - 'TERM': 'linux', 04:11:28 INFO - 'TMOUT': '86400', 04:11:28 INFO - 'USER': 'cltbld', 04:11:28 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349', 04:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:28 INFO - '_': '/tools/buildbot/bin/python'} 04:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:28 INFO - Downloading/unpacking psutil>=3.1.1 04:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:11:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:30 INFO - Installing collected packages: psutil 04:11:30 INFO - Running setup.py install for psutil 04:11:30 INFO - building 'psutil._psutil_linux' extension 04:11:30 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 04:11:31 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 04:11:31 INFO - building 'psutil._psutil_posix' extension 04:11:31 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 04:11:31 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 04:11:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:31 INFO - Successfully installed psutil 04:11:31 INFO - Cleaning up... 04:11:31 INFO - Return code: 0 04:11:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1616400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5570>, '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 0x16a6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a6900>, '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': 'cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349', '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 04:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:11:31 INFO - Using env: {'DISPLAY': ':0', 04:11:31 INFO - 'HOME': '/home/cltbld', 04:11:31 INFO - 'LANG': 'en_US.UTF-8', 04:11:31 INFO - 'LANGUAGE': 'en_US:en', 04:11:31 INFO - 'LOGNAME': 'cltbld', 04:11:31 INFO - 'MAIL': '/var/mail/cltbld', 04:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:31 INFO - 'MOZ_NO_REMOTE': '1', 04:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:31 INFO - 'NO_EM_RESTART': '1', 04:11:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:31 INFO - 'PWD': '/builds/slave/test', 04:11:31 INFO - 'SHELL': '/bin/bash', 04:11:31 INFO - 'SHLVL': '1', 04:11:31 INFO - 'TERM': 'linux', 04:11:31 INFO - 'TMOUT': '86400', 04:11:31 INFO - 'USER': 'cltbld', 04:11:31 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349', 04:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:31 INFO - '_': '/tools/buildbot/bin/python'} 04:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:11:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:11:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:11:33 INFO - Installing collected packages: mozsystemmonitor 04:11:33 INFO - Running setup.py install for mozsystemmonitor 04:11:33 INFO - Successfully installed mozsystemmonitor 04:11:33 INFO - Cleaning up... 04:11:33 INFO - Return code: 0 04:11:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13e7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1616400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5570>, '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 0x16a6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a6900>, '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': 'cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349', '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 04:11:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:11:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:11:33 INFO - Using env: {'DISPLAY': ':0', 04:11:33 INFO - 'HOME': '/home/cltbld', 04:11:33 INFO - 'LANG': 'en_US.UTF-8', 04:11:33 INFO - 'LANGUAGE': 'en_US:en', 04:11:33 INFO - 'LOGNAME': 'cltbld', 04:11:33 INFO - 'MAIL': '/var/mail/cltbld', 04:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:33 INFO - 'MOZ_NO_REMOTE': '1', 04:11:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:33 INFO - 'NO_EM_RESTART': '1', 04:11:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:33 INFO - 'PWD': '/builds/slave/test', 04:11:33 INFO - 'SHELL': '/bin/bash', 04:11:33 INFO - 'SHLVL': '1', 04:11:33 INFO - 'TERM': 'linux', 04:11:33 INFO - 'TMOUT': '86400', 04:11:33 INFO - 'USER': 'cltbld', 04:11:33 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349', 04:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:33 INFO - '_': '/tools/buildbot/bin/python'} 04:11:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:33 INFO - Downloading/unpacking jsonschema==2.5.1 04:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:11:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:36 INFO - Downloading functools32-3.2.3-2.tar.gz 04:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:11:36 INFO - warning: no files found matching '*.txt' 04:11:36 INFO - no previously-included directories found matching 'build' 04:11:36 INFO - no previously-included directories found matching 'dist' 04:11:36 INFO - no previously-included directories found matching '.git*' 04:11:36 INFO - Installing collected packages: jsonschema, functools32 04:11:36 INFO - Running setup.py install for functools32 04:11:36 INFO - warning: no files found matching '*.txt' 04:11:36 INFO - no previously-included directories found matching 'build' 04:11:36 INFO - no previously-included directories found matching 'dist' 04:11:36 INFO - no previously-included directories found matching '.git*' 04:11:36 INFO - Successfully installed jsonschema functools32 04:11:36 INFO - Cleaning up... 04:11:36 INFO - Return code: 0 04:11:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:11: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')]} 04:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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')]} 04:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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', '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 0x13e7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1616400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5570>, '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 0x16a6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a6900>, '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': 'cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349', '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 04:11: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:11: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 blobuploader==1.2.4 04:11:36 INFO - Using env: {'DISPLAY': ':0', 04:11:36 INFO - 'HOME': '/home/cltbld', 04:11:36 INFO - 'LANG': 'en_US.UTF-8', 04:11:36 INFO - 'LANGUAGE': 'en_US:en', 04:11:36 INFO - 'LOGNAME': 'cltbld', 04:11:36 INFO - 'MAIL': '/var/mail/cltbld', 04:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:36 INFO - 'MOZ_NO_REMOTE': '1', 04:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:36 INFO - 'NO_EM_RESTART': '1', 04:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:36 INFO - 'PWD': '/builds/slave/test', 04:11:36 INFO - 'SHELL': '/bin/bash', 04:11:36 INFO - 'SHLVL': '1', 04:11:36 INFO - 'TERM': 'linux', 04:11:36 INFO - 'TMOUT': '86400', 04:11:36 INFO - 'USER': 'cltbld', 04:11:36 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349', 04:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:36 INFO - '_': '/tools/buildbot/bin/python'} 04:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:36 INFO - Downloading/unpacking blobuploader==1.2.4 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:11:38 INFO - Downloading blobuploader-1.2.4.tar.gz 04:11:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:11:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:11:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:11:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:11:39 INFO - Downloading docopt-0.6.1.tar.gz 04:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:11:39 INFO - Installing collected packages: blobuploader, requests, docopt 04:11:39 INFO - Running setup.py install for blobuploader 04:11:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:11:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:11:39 INFO - Running setup.py install for requests 04:11:39 INFO - Running setup.py install for docopt 04:11:39 INFO - Successfully installed blobuploader requests docopt 04:11:39 INFO - Cleaning up... 04:11:39 INFO - Return code: 0 04:11:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:39 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 0x13e7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1616400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5570>, '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 0x16a6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a6900>, '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': 'cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349', '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 04:11:39 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 04:11:39 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 04:11:39 INFO - Using env: {'DISPLAY': ':0', 04:11:39 INFO - 'HOME': '/home/cltbld', 04:11:39 INFO - 'LANG': 'en_US.UTF-8', 04:11:39 INFO - 'LANGUAGE': 'en_US:en', 04:11:39 INFO - 'LOGNAME': 'cltbld', 04:11:39 INFO - 'MAIL': '/var/mail/cltbld', 04:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:39 INFO - 'MOZ_NO_REMOTE': '1', 04:11:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:39 INFO - 'NO_EM_RESTART': '1', 04:11:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:39 INFO - 'PWD': '/builds/slave/test', 04:11:39 INFO - 'SHELL': '/bin/bash', 04:11:39 INFO - 'SHLVL': '1', 04:11:39 INFO - 'TERM': 'linux', 04:11:39 INFO - 'TMOUT': '86400', 04:11:39 INFO - 'USER': 'cltbld', 04:11:39 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349', 04:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:39 INFO - '_': '/tools/buildbot/bin/python'} 04:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:11:40 INFO - Running setup.py (path:/tmp/pip-Jh7aji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:11:40 INFO - Running setup.py (path:/tmp/pip-6_U5ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:11:40 INFO - Running setup.py (path:/tmp/pip-n8DYg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:11:40 INFO - Running setup.py (path:/tmp/pip-1AEpeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:11:40 INFO - Running setup.py (path:/tmp/pip-7hRJkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:11:40 INFO - Running setup.py (path:/tmp/pip-uwoHld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:11:40 INFO - Running setup.py (path:/tmp/pip-DtG712-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:11:40 INFO - Running setup.py (path:/tmp/pip-tM8fE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:11:40 INFO - Running setup.py (path:/tmp/pip-fj1UNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:11:40 INFO - Running setup.py (path:/tmp/pip-Rooqzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:11:40 INFO - Running setup.py (path:/tmp/pip-WpjkrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:11:40 INFO - Running setup.py (path:/tmp/pip-djaCl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:11:40 INFO - Running setup.py (path:/tmp/pip-xoQAMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:11:40 INFO - Running setup.py (path:/tmp/pip-nVWfau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:41 INFO - Running setup.py (path:/tmp/pip-e0aJEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:11:41 INFO - Running setup.py (path:/tmp/pip-tsUrsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:11:41 INFO - Running setup.py (path:/tmp/pip-yUiWJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:11:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:11:41 INFO - Running setup.py install for manifestparser 04:11:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:11:41 INFO - Running setup.py install for mozcrash 04:11:41 INFO - Running setup.py install for mozdebug 04:11:41 INFO - Running setup.py install for mozdevice 04:11:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:11:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:11:41 INFO - Running setup.py install for mozfile 04:11:41 INFO - Running setup.py install for mozhttpd 04:11:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:11:41 INFO - Running setup.py install for mozinfo 04:11:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:11:41 INFO - Running setup.py install for mozInstall 04:11:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:11:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:11:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:11:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:11:42 INFO - Running setup.py install for mozleak 04:11:42 INFO - Running setup.py install for mozlog 04:11:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:11:42 INFO - Running setup.py install for moznetwork 04:11:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:11:42 INFO - Running setup.py install for mozprocess 04:11:42 INFO - Running setup.py install for mozprofile 04:11:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:11:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:11:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:11:42 INFO - Running setup.py install for mozrunner 04:11:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:11:42 INFO - Running setup.py install for mozscreenshot 04:11:42 INFO - Running setup.py install for moztest 04:11:42 INFO - Running setup.py install for mozversion 04:11:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:11:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:11:43 INFO - Cleaning up... 04:11:43 INFO - Return code: 0 04:11:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:43 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')]} 04:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:43 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')]} 04:11:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:43 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 0x13e7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1616400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5570>, '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 0x16a6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a6900>, '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': 'cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349', '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 04:11:43 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 04:11:43 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 04:11:43 INFO - Using env: {'DISPLAY': ':0', 04:11:43 INFO - 'HOME': '/home/cltbld', 04:11:43 INFO - 'LANG': 'en_US.UTF-8', 04:11:43 INFO - 'LANGUAGE': 'en_US:en', 04:11:43 INFO - 'LOGNAME': 'cltbld', 04:11:43 INFO - 'MAIL': '/var/mail/cltbld', 04:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:43 INFO - 'MOZ_NO_REMOTE': '1', 04:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:43 INFO - 'NO_EM_RESTART': '1', 04:11:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:43 INFO - 'PWD': '/builds/slave/test', 04:11:43 INFO - 'SHELL': '/bin/bash', 04:11:43 INFO - 'SHLVL': '1', 04:11:43 INFO - 'TERM': 'linux', 04:11:43 INFO - 'TMOUT': '86400', 04:11:43 INFO - 'USER': 'cltbld', 04:11:43 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349', 04:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:43 INFO - '_': '/tools/buildbot/bin/python'} 04:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:11:43 INFO - Running setup.py (path:/tmp/pip-o6HXJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:11:43 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)) 04:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:11:43 INFO - Running setup.py (path:/tmp/pip-VC40y1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:11:43 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)) 04:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:11:43 INFO - Running setup.py (path:/tmp/pip-EgWuYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:11:43 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)) 04:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:11:43 INFO - Running setup.py (path:/tmp/pip-cv269f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:11:43 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)) 04:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:11:43 INFO - Running setup.py (path:/tmp/pip-G94yO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:11:43 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)) 04:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:11:43 INFO - Running setup.py (path:/tmp/pip-9bkqHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:11:43 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)) 04:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:11:43 INFO - Running setup.py (path:/tmp/pip-v3bjeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:11:43 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)) 04:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:11:43 INFO - Running setup.py (path:/tmp/pip-kMkBRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:11:43 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)) 04:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:11:43 INFO - Running setup.py (path:/tmp/pip-I4jNWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:11:43 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)) 04:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:11:43 INFO - Running setup.py (path:/tmp/pip-iXZhX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:11:43 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)) 04:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:11:43 INFO - Running setup.py (path:/tmp/pip-EbkwA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:11:44 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)) 04:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:11:44 INFO - Running setup.py (path:/tmp/pip-NDaDgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:11:44 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)) 04:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:11:44 INFO - Running setup.py (path:/tmp/pip-sLVdYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:11:44 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)) 04:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:11:44 INFO - Running setup.py (path:/tmp/pip-ASnZA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:11:44 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)) 04:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:44 INFO - Running setup.py (path:/tmp/pip-5JdeIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:44 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)) 04:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:11:44 INFO - Running setup.py (path:/tmp/pip-Sy7BJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:11:44 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)) 04:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:11:44 INFO - Running setup.py (path:/tmp/pip-dogOA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:11:44 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)) 04:11:44 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)) 04:11:44 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)) 04:11:44 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)) 04:11:44 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)) 04:11:44 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)) 04:11:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:46 INFO - Downloading blessings-1.6.tar.gz 04:11:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:11:46 INFO - Installing collected packages: blessings 04:11:46 INFO - Running setup.py install for blessings 04:11:46 INFO - Successfully installed blessings 04:11:46 INFO - Cleaning up... 04:11:46 INFO - Return code: 0 04:11:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:11:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:11:46 INFO - Reading from file tmpfile_stdout 04:11:46 INFO - Current package versions: 04:11:46 INFO - argparse == 1.2.1 04:11:46 INFO - blessings == 1.6 04:11:46 INFO - blobuploader == 1.2.4 04:11:46 INFO - docopt == 0.6.1 04:11:46 INFO - functools32 == 3.2.3-2 04:11:46 INFO - jsonschema == 2.5.1 04:11:46 INFO - manifestparser == 1.1 04:11:46 INFO - mozInstall == 1.12 04:11:46 INFO - mozcrash == 0.17 04:11:46 INFO - mozdebug == 0.1 04:11:46 INFO - mozdevice == 0.48 04:11:46 INFO - mozfile == 1.2 04:11:46 INFO - mozhttpd == 0.7 04:11:46 INFO - mozinfo == 0.9 04:11:46 INFO - mozleak == 0.1 04:11:46 INFO - mozlog == 3.2 04:11:46 INFO - moznetwork == 0.27 04:11:46 INFO - mozprocess == 0.23 04:11:46 INFO - mozprofile == 0.28 04:11:46 INFO - mozrunner == 6.12 04:11:46 INFO - mozscreenshot == 0.1 04:11:46 INFO - mozsystemmonitor == 0.3 04:11:46 INFO - moztest == 0.7 04:11:46 INFO - mozversion == 1.4 04:11:46 INFO - psutil == 3.1.1 04:11:46 INFO - requests == 1.2.3 04:11:46 INFO - wsgiref == 0.1.2 04:11:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:46 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 0x13e7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1616400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5570>, '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 0x16a6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a6900>, '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': 'cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349', '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 04:11:46 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 04:11:46 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 04:11:46 INFO - Using env: {'DISPLAY': ':0', 04:11:46 INFO - 'HOME': '/home/cltbld', 04:11:46 INFO - 'LANG': 'en_US.UTF-8', 04:11:46 INFO - 'LANGUAGE': 'en_US:en', 04:11:46 INFO - 'LOGNAME': 'cltbld', 04:11:46 INFO - 'MAIL': '/var/mail/cltbld', 04:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:46 INFO - 'MOZ_NO_REMOTE': '1', 04:11:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:46 INFO - 'NO_EM_RESTART': '1', 04:11:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:46 INFO - 'PWD': '/builds/slave/test', 04:11:46 INFO - 'SHELL': '/bin/bash', 04:11:46 INFO - 'SHLVL': '1', 04:11:46 INFO - 'TERM': 'linux', 04:11:46 INFO - 'TMOUT': '86400', 04:11:46 INFO - 'USER': 'cltbld', 04:11:46 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349', 04:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:46 INFO - '_': '/tools/buildbot/bin/python'} 04:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:47 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)) 04:11:47 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)) 04:11:47 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)) 04:11:47 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)) 04:11:47 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)) 04:11:47 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)) 04:11:47 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)) 04:11:47 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)) 04:11:47 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)) 04:11:47 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)) 04:11:47 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)) 04:11:47 INFO - Cleaning up... 04:11:47 INFO - Return code: 0 04:11:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:47 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 0x13e7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1616400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5570>, '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 0x16a6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a6900>, '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': 'cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349', '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 04:11:47 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 04:11:47 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 04:11:47 INFO - Using env: {'DISPLAY': ':0', 04:11:47 INFO - 'HOME': '/home/cltbld', 04:11:47 INFO - 'LANG': 'en_US.UTF-8', 04:11:47 INFO - 'LANGUAGE': 'en_US:en', 04:11:47 INFO - 'LOGNAME': 'cltbld', 04:11:47 INFO - 'MAIL': '/var/mail/cltbld', 04:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:47 INFO - 'MOZ_NO_REMOTE': '1', 04:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:47 INFO - 'NO_EM_RESTART': '1', 04:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:47 INFO - 'PWD': '/builds/slave/test', 04:11:47 INFO - 'SHELL': '/bin/bash', 04:11:47 INFO - 'SHLVL': '1', 04:11:47 INFO - 'TERM': 'linux', 04:11:47 INFO - 'TMOUT': '86400', 04:11:47 INFO - 'USER': 'cltbld', 04:11:47 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349', 04:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:47 INFO - '_': '/tools/buildbot/bin/python'} 04:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:11:47 INFO - Cleaning up... 04:11:47 INFO - Return code: 0 04:11:47 INFO - Running post-action listener: _resource_record_post_action 04:11:47 INFO - Running post-action listener: _start_resource_monitoring 04:11:47 INFO - Starting resource monitoring. 04:11:47 INFO - ##### 04:11:47 INFO - ##### Finished create-virtualenv step (success) 04:11:47 INFO - ##### 04:11:47 INFO - ##### 04:11:47 INFO - ##### Running install step. 04:11:47 INFO - ##### 04:11:47 INFO - Running pre-action listener: _resource_record_pre_action 04:11:47 INFO - Running main action method: install 04:11:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:11:47 INFO - Reading from file tmpfile_stdout 04:11:47 INFO - Detecting whether we're running mozinstall >=1.0... 04:11:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:11:47 INFO - Reading from file tmpfile_stdout 04:11:47 INFO - Output received: 04:11:47 INFO - Usage: mozinstall [options] installer 04:11:47 INFO - Options: 04:11:47 INFO - -h, --help show this help message and exit 04:11:47 INFO - -d DEST, --destination=DEST 04:11:47 INFO - Directory to install application into. [default: 04:11:47 INFO - "/builds/slave/test"] 04:11:47 INFO - --app=APP Application being installed. [default: firefox] 04:11:47 INFO - mkdir: /builds/slave/test/build/application 04:11:47 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'] 04:11:47 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 04:12:03 INFO - Reading from file tmpfile_stdout 04:12:03 INFO - Output received: 04:12:03 INFO - /builds/slave/test/build/application/firefox/firefox 04:12:03 INFO - Running post-action listener: _resource_record_post_action 04:12:03 INFO - ##### 04:12:03 INFO - ##### Finished install step (success) 04:12:03 INFO - ##### 04:12:03 INFO - ##### 04:12:03 INFO - ##### Running run-tests step. 04:12:03 INFO - ##### 04:12:03 INFO - Running pre-action listener: _resource_record_pre_action 04:12:03 INFO - Running main action method: run_tests 04:12:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:12:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:12:03 INFO - Python 2.7.3 04:12:03 INFO - Return code: 0 04:12:03 INFO - grabbing minidump binary from tooltool 04:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:03 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 0x16a5570>, '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 0x16a6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a6900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:12:03 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 04:12:03 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 04:12:03 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 04:12:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:12:03 INFO - Return code: 0 04:12:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:12:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:12:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:12:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:12:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:12:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 04:12:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 04:12:03 INFO - Using env: {'DISPLAY': ':0', 04:12:03 INFO - 'HOME': '/home/cltbld', 04:12:03 INFO - 'LANG': 'en_US.UTF-8', 04:12:03 INFO - 'LANGUAGE': 'en_US:en', 04:12:03 INFO - 'LOGNAME': 'cltbld', 04:12:03 INFO - 'MAIL': '/var/mail/cltbld', 04:12:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:12:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:03 INFO - 'MOZ_NO_REMOTE': '1', 04:12:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:03 INFO - 'NO_EM_RESTART': '1', 04:12:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:03 INFO - 'PWD': '/builds/slave/test', 04:12:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:12:03 INFO - 'SHELL': '/bin/bash', 04:12:03 INFO - 'SHLVL': '1', 04:12:03 INFO - 'TERM': 'linux', 04:12:03 INFO - 'TMOUT': '86400', 04:12:03 INFO - 'USER': 'cltbld', 04:12:03 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349', 04:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:03 INFO - '_': '/tools/buildbot/bin/python'} 04:12:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 04:12:04 INFO - mozversion application_buildid: 20160711024832 04:12:04 INFO - mozversion application_changeset: 1bee8d2da23ec894980fb14f516210fd83e5b9f9 04:12:04 INFO - mozversion application_display_name: Nightly 04:12:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:12:04 INFO - mozversion application_name: Firefox 04:12:04 INFO - mozversion application_remotingname: firefox 04:12:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:12:04 INFO - mozversion application_vendor: Mozilla 04:12:04 INFO - mozversion application_version: 50.0a1 04:12:04 INFO - mozversion platform_buildid: 20160711024832 04:12:04 INFO - mozversion platform_changeset: 1bee8d2da23ec894980fb14f516210fd83e5b9f9 04:12:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:12:04 INFO - mozversion platform_version: 50.0a1 04:12:04 INFO - using testdate: 1468235524 04:12:04 INFO - actual date: 1468235524 04:12:04 INFO - starting webserver on 'localhost:41547' 04:12:04 INFO - SUITE-START | Running 2 tests 04:12:04 INFO - TEST-START | dromaeo_css 04:12:04 INFO - operating with platform_type : linux_ 04:12:04 INFO - Initialising browser for dromaeo_css test... 04:12:04 INFO - TEST-INFO | started process 22550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9pjNkv/profile http://localhost:41547/getInfo.html) 04:12:09 INFO - PROCESS | 22550 | __metrics Screen width/height:1600/1200 04:12:09 INFO - PROCESS | 22550 | colorDepth:24 04:12:09 INFO - PROCESS | 22550 | Browser inner width/height: 1024/697 04:12:09 INFO - PROCESS | 22550 | __metrics 04:12:09 ERROR - PROCESS | 22550 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 04:12:10 INFO - TEST-INFO | 22550: exit 0 04:12:10 INFO - Browser initialized. 04:12:10 INFO - Running cycle 1/1 for dromaeo_css test... 04:12:10 INFO - TEST-INFO | started process 22671 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9pjNkv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:22 INFO - PROCESS | 22671 | RSS: Main: 168685568 04:12:22 INFO - PROCESS | 22671 | 04:13:12 INFO - PROCESS | 22671 | 1468235592430 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] 04:15:25 INFO - PROCESS | 22671 | Cycle 1(1): loaded http://localhost:41547/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41547/tests/dromaeo/cssquery-ext.html) 04:15:26 INFO - PROCESS | 22671 | RSS: Main: 168804352 04:15:26 INFO - PROCESS | 22671 | 04:18:28 INFO - PROCESS | 22671 | Cycle 1(1): loaded http://localhost:41547/tests/dromaeo/cssquery-ext.html (next: http://localhost:41547/tests/dromaeo/cssquery-jquery.html) 04:18:29 INFO - PROCESS | 22671 | RSS: Main: 168816640 04:18:29 INFO - PROCESS | 22671 | 04:21:31 INFO - PROCESS | 22671 | Cycle 1(1): loaded http://localhost:41547/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41547/tests/dromaeo/cssquery-mootools.html) 04:21:32 INFO - PROCESS | 22671 | RSS: Main: 172003328 04:21:32 INFO - PROCESS | 22671 | 04:24:34 INFO - PROCESS | 22671 | Cycle 1(1): loaded http://localhost:41547/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41547/tests/dromaeo/cssquery-prototype.html) 04:24:34 INFO - PROCESS | 22671 | RSS: Main: 167534592 04:24:34 INFO - PROCESS | 22671 | 04:27:37 INFO - PROCESS | 22671 | Cycle 1(1): loaded http://localhost:41547/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41547/tests/dromaeo/cssquery-yui.html) 04:27:38 INFO - PROCESS | 22671 | RSS: Main: 169168896 04:27:38 INFO - PROCESS | 22671 | 04:30:40 INFO - PROCESS | 22671 | Cycle 1(1): loaded http://localhost:41547/tests/dromaeo/cssquery-yui.html (next: http://localhost:41547/tests/dromaeo/cssquery-dojo.html) 04:30:40 INFO - PROCESS | 22671 | RSS: Main: 170807296 04:30:40 INFO - PROCESS | 22671 | 04:30:40 INFO - PROCESS | 22671 | __start_tp_report 04:30:40 INFO - PROCESS | 22671 | _x_x_mozilla_page_load 04:30:40 INFO - PROCESS | 22671 | _x_x_mozilla_page_load_details 04:30:40 INFO - PROCESS | 22671 | |i|pagename|runs| 04:30:40 INFO - PROCESS | 22671 | |0;dojo.html;2567.499337629162;2586.6895972483303;2591.7537833905776;2597.06505657963;2607.8696065196737;4662.417197850269;4667.416572928384;4728.4798672146035;4766.880827979294;4789;4637.953620463794;4713.198756211444;4732.455767586728;4753.619710423167;4763.38076050113;4287.6569874410125;4319.654427645781;4390.64874810016;4391.86824395267;4405.955940440603;4343.847965321214;4362.149380870732;4369.73781573105;4424.690271680984;4438.068005718803;4252.064545799919;4311.676624253194;4336.176126535979;4342.739435633841;4423.491298500681;4294.398784170218;4307.504636966726;4347.760873151976;4354.804033818486;4355;4328.5455027222315;4349.304111342201;4362.716423432466;4367.606915377632;4368.170047690928;4706.152892479352;4770.570648641604;4775.355327030841;4777.140114779339;4796.376471058775;5061.974690126563;5087.033463641897;5095.159298715707;5104.999080045982;5155.432902380735;4980.775865086043;5077.0607437623785;5104.846854594368;5114.667546609458;5182.844514664528;4778.450478194983;4802.855914322576;4811.807527698923;4831.154547954094;4868.880157563709;5268.262443257947;5268.367795864521;5279.41926388097;5302.973485132627;5313.468653134656;4929.162042452792;4966.503349665077;4999.275105109811;5051.696898186121;5052.317937078521;5002.674826136362;5078.7460626968505;5095.745212739348;5104.515071068243;5149.510796474329;4935.87660308488;4978.65149439543;4981.37732783402;4996.725180115129;4999.925001124986;4948.727819969864;4971.403431588233;4973.055119527278;4976.377952755905;5028.296038554606;4273.166732487197;4279.657627389864;4304.332828411601;4305.095929854703;4311.590398912098;3747.831347589365;3753.7560058596105;3759.7368184226843;3769.6418840210135;3786.6402691744793;4243.533211346749;4330.805113769888;4376.737395756265;4417.712848664891;4422.823087076546;5063.417706963746;5092.185250359925;5098.668586541863;5099.566536844335;5144.176931690911;4343.1096625192395;4348.195583817004;4353.151135528541;4357.346398040319;4401.9875428651585;4469.776511174493;4528.320751887243;4536.047430039728;4537.137943790669;4554.111948170075;4716.316134160459;4718.292256161603;4729.881752956066;4772.427308723045;4776.068666609977;5113.386393632788;5127.2052831811125;5130.050940575856;5139.768710408115;5143.691378517151;4612.4003879496795;4721.504242054535;4748.620110391092;4773.3555969945;4784.138855006132;4908.337374454403;4910.631702622389;4919;4933.136701077369;4971.875703107306;5142.331496905378;5146.0479811233545;5164.535191832753;5169.61227907916;5204.115300399017;4655.18534256497;4669.7898594564;4757.191277482767;4772.188727916193;4801.207800712843;4720.858374248778;4751.976240118777;4756;4807.735574543294;4818.6626936114135;4702.059588082466;4736.455307639666;4758.857234282977;4785.880352991203;4798.712077275235;4737.478877323423;4821.831235906727;4839.322494850653;4849.030193961293;4865.95134048655;4713.2458806590785;4720.197566413649;4730.692504987165;4774.40319960005;4838.03239352138 04:30:40 INFO - PROCESS | 22671 | |1;ext.html;551.531198481291;564.5257983294033;568.8236646639542;578.0721941284239;596.4542443664047;35623.821880890595;40511;40527.59472405275;40536.79731601345;40625;40329.39505907414;40696;40818.59181408185;40838.18323633526;40861.18277634445;7940.285374316325;8019.077806052291;8035.2366525180305;8052.19478052196;8090.959545202266;7950.045994480671;8026.959865200666;8035.196480351977;8047.315978141865;8052.557109358983;7918.643661035238;8051.9597402013205;8054.315383192436;8065.717699880476;8079.394045446615;7999.120096789348;8008.879866802003;8029.915961345202;8040.718574849881;8058.959705201495;7929.801754956115;7998.920010799934;8032.598370081472;8053.838923221561;8066.959665201636;38492.80753596242;39089.43642254306;39090.80454597737;39091.21817563661;39201;2948.8083274587084;3319.6348401676037;3448.583405178844;3630.4009838376637;3736.4955730976244;29792.255193620116;30107.849460752775;30187.849060754776;30859.074227773202;30911.227219319473;3084.195973300696;3134.4828103362915;3164.889228877001;3211.1008917503136;3218.3241519280978;193191;193240;193254;194284;194367;54531.454685453435;54554;54572.72713636406;54860.17709734357;55030.72484637551;33533.16167095842;33655.15862103467;33708.83145584256;58805.70597146987;59073.40926590765;12897.226166430044;13014.804777928339;13017.869821301856;13038.41327140281;13048.804267935988;9571.664991725256;9591.760205994906;9606.471644059644;9616.374935629301;9715.36850104741;18808.153633086546;18878.150483228288;18909.7163542547;18923.43229703111;19014.90492547556;6811.4210292124735;6969.82575435608;7024.964875175591;7043.330883566053;7242.601656908815;791.686790780585;889.9377043607014;937.7749340158313;990.4305024610877;992.6178421307849;29007.7099229005;29509.26226844303;31451.685483144876;31908.202294942814;32454.188645284055;897.7935074932672;923.8614207868739;934.4159900062461;945.9304556713508;971.577363846729;14290.214038227788;15090;15186.240687965557;15203.695926081416;15306.464273750365;429793;430636;432879;436724;436853;51254.23118653223;52965.2055219172;53021.204681929805;53042;53049;1157.5138441854274;1195.862475815275;1211.2127117373777;1222.5354365341113;1230.1880758699215;27065.45869082647;27334.738187737596;28050.57924131099;28111.71888281091;28422.85788571044;43245.3513197296;43816.342754858066;44155.77922110369;44349;44385.11229775322;370101.0464633725;374032;374341;378081;381501;25825.354366140997;26229.868850655625;26240.21279361622;26243.212703618923;26260.343491412867;42374.576254238294;42767.572324276356;43100.56899430966;43411;44453;37680;37794.81102594469;37880.43179352367;38395.23209535849;38441.42337864878;36097.63902361048;36848.44727329146;37339.813300933325;37524;37752.62247377491;36044.45933311055;36791;37019.25961480809;37155.25689486249;38504.80747596244;32646.34707305888;35080.82459587686;35773.284534308645;35849.64150358463;35853.64146358503;25276.620850686886;25599.6160057603;25683.10109146171;25728.485430291665;25771.484570308865 04:30:40 INFO - PROCESS | 22671 | |2;jquery.html;362.1308858739027;365.2803976166952;366.35155774279525;381.9465274861518;386.6925793993776;16306.755398669015;16728.581785455368;18007.18967646459;18015.54961125971;18054.27782888686;17014.48956531303;17354.305827766904;17938.730919036225;17943.91028044858;17990.460286191403;5146.897062058766;5323.387810401815;5328.866778330554;5337.572994160458;5348.224507446418;5246.5802735781235;5282.7622756976025;5339.599530035243;5360.410354860982;5363.9463605363835;5166.405863325709;5261.263423120766;5283.894322113555;5296.602754793386;5306.655067420625;5212.76542555584;5323.201519772046;5334.27987221724;5336.946630533684;5345.064613692627;4711.811527538895;4745.145873742725;4753.952460475385;4760.619150467955;4762.952370476286;20270.087846046965;21441.356759297247;21660.78339216619;21783.45541361463;21804.236851710273;1967.0459826983902;2006.5986802639532;2174.282486779359;2476.73994230605;2490.9875450622812;13319.600411987656;13408.061435699505;13575.864241357658;13705.314734263347;13831.308434578332;1695.7710709054365;1715.6997525433123;1739.765131707216;1745.3367720266217;1812.1754601656346;69103;70440.2955970444;70536.6473167636;71082.64458677673;72098.27901720969;9349.579268932914;9507.286953478379;9745.951270243746;9781.41311521311;9894.307398482037;13259.270740109387;13356.6660833478;13390.866091339156;13402.463901443833;13422.530211442749;6545.345465453416;6637.070810086591;6703.4972377070935;6781.62701051437;6814.182298124257;6168.352323006109;6264.619340800651;6295.779647712308;6299.960506516465;6316.684165791784;6058.818235452944;6084.787032453843;6098.298695649968;6165.753369865245;6221.097940798559;1749.1516614441985;1761.9647607047787;1763.5943732941496;1766.0728117738033;1776.2983621469705;833.3250067445389;854.8247609240091;858.2147335188357;884.6417201033591;925.9490728010024;17271.65456690859;17426.65146697059;17940.551486212687;18011.72982405265;18455;881.828043531518;892.830362231174;901.2879824938357;903.6791938861741;945.9877930614176;9832;10349.99400695205;10385.324953877975;10387.324823886423;10387.857335693068;386608;393143;396834;397267;400211;52390.47609523856;60225.69887150624;61243;70205.64897175583;70445;916.757059379265;937.1940131486916;941.8069295794346;943.0192599696239;944.0040757001292;14427.92786036063;16501.257443414834;16614.58463538373;16718.832811671728;17108.230129643947;33754.493682594286;35158;36494.4525832118;36588.26823463569;37127.6287237135;45992.31011534896;46197.307040393745;48492.75753621209;48579.27131093107;48742;7629.3133617974645;7651.655675494505;7670.578118203553;7681.7695469136015;7740;11644.767104658029;12209.816852747039;12258.325792081521;12387.504499820267;12556.686082848002;9485.288603354915;10523.78952420932;10532;10717.196210284104;10722.517486713272;9446.574904129468;9780.168685661798;10214.897851021395;10624.096951759188;10753.032227099598;10083;10545.261831672016;10571.207159463225;10574.15406767472;10645.361278323326;7475.7009719610605;7496.362809161283;7518.774436766906;7564.924350756422;7581.962090189514;10275.434851083262;10417.322874013165;10493.9475302623;10571.154307655215;10735.194860385345 04:30:41 INFO - PROCESS | 22671 | |3;mootools.html;1375.7454870848894;1425.5153247895717;1478.3347493627864;1661.9085950272731;1713.0920612075588;6728.4953628477815;7447.888281675772;7534.246575342463;7854.057513098429;7993.080795708495;7645.885311720329;7830.451868369217;7914.327282181007;7918.168592297812;7933.2463415975535;2152.300502336739;2173.1850556041486;2181.694562761215;2191.22211614876;2200.4058904095887;2121.554473560554;2141.7751136130714;2179.923702670407;2197.2748992832408;2198.9450263743374;2187.0377034104945;2192.7039849620337;2198.5932602468592;2202.3062735238427;2213.1700612270397;2150.1721837092755;2172.0443005077714;2175.1734340950497;2181.8472706910366;2184.344696591016;2061.5773766377856;2083.3125068727436;2086.5096702274955;2086.895655217248;2090.310197634792;7732.724100523407;7764.922350776533;7785.844283114363;7794.961025194894;7809.336206422461;4585.082983403333;4661.836835710767;4726.291056341542;4735;4746.169420351424;2729.7952653551065;2759.9724002759917;2792.4833905727505;2845.9857700711573;2852;866.6793286484042;877.3419935048713;894.552723638181;894.6823877523516;902.4630344944748;10326.22553308505;10386.688399347957;10390.532426040847;10424.635137770141;10466.52900619474;4011.4183443400543;4034.253663072341;4167.979160104241;4220.662347012231;4374.147041326911;8948.149925757043;8963;8978.910210897939;8982.595783189772;8983.865242021375;4724.929126063112;4726.291056341576;4767.046590681877;4775.2598347256235;4777.402824646919;3777.697784177259;4171.728837625545;4296.312589985588;4344.674149438742;4347.804348804311;3498.317828023511;3522.5772907251294;3622.0582648511577;3625.7643253188457;3642.745007849478;1125.6566747142201;1130.8925652063042;1147.7073346296809;1153.4002318794348;1168.1589255735857;746.3357611725569;769.6536558548676;789.3290702902601;804.6620419423856;806.5040000399829;4877.829275975324;4916.237983112624;5010.599152067826;5147.6654017488745;5162.870928226749;405.88635182149045;406;410.8705757686379;413.89445691348516;430.29646527927065;3742;3744.120131769032;3793.260314238752;3798.0694729791376;3810.8666196682984;8987.41581797181;9351.39215950961;9538.23694104484;9543.093406126407;9546.761330966781;9402.106799854002;9402.764930876783;9417.340786145041;9420.434773913586;9436.150746432853;6796.52424330302;7132.572045677276;7199.604021778852;7200.459965502609;7203.711851525985;5380.273663055594;5432.972835135799;5487.176923461513;5507.091329930517;5608.7195640217005;8962.058983806606;8962.058983806866;9061.13919177677;9161.129692679186;9161.77095572616;8694.565271736261;9039.548022598976;9186.540672966192;9200.861987070333;9249.30630202751;6226.813195604139;6449.322821103717;6480.870382592416;6615.305392933673;6748.93251067483;7163.856722865409;7168.17565979919;7189.532680375759;7192.856142877218;7236.167840698176;6386.105945167587;6536.7712130075215;6539.607623542603;6585.473162147113;6662.500312476681;6298.401651843067;6345.587536810092;6353.841153971188;6477.935220647733;6486.0919471275;6067;6108.75564977396;6126.663033533198;6130.877382452237;6143.047827586731;4244.8514301999285;4403.911921761611;4460.1525710114975;4465.866024019155;4468.240399132221;4263.467066616673;4322.74063556175;4337.869863904088;4351;4400.031992961543 04:30:41 INFO - PROCESS | 22671 | |4;prototype.html;291.2021062289327;301.4573767219006;305.4715342457548;305.5676218151316;309.18375488709796;4868.415790105192;4967;5043.848684539461;5064.265681476184;5096.286519887214;5001.424836143845;5018.039356779499;5020.322256495381;5030.29575859379;5030.723310217945;3912.921741565167;3964.8612298569556;3968.1468484275874;3973.5033120859894;3980.1840622672426;3879.321118804198;3889.6888248940018;3962.6829853611644;3964.5440774311037;3975.423563583279;3930.3121953658137;3936.720565816121;3943.9211215775667;3952.901177470572;3958.9406158907495;3913.217356528677;3944.5660977292473;3949;3957.812656203142;3958.9010274743073;3491.2319289756215;3492.4237500812337;3493.510908472816;3498.7201023918024;3501.544799176116;4642.75007494755;4952.380952380952;4957.652964292501;4958.132326842824;4997.275395067695;4430.4240448741775;4452.3989261449615;4452.977735111303;4475.418195634579;4476.820927162909;5279.287296215;5282.550983166436;5293.655912365684;5304.946950530484;5305.867353316159;3626.9455958160647;3721.441783732435;3731.7014638828828;3735.7198210134347;3736.3834967230373;5489.725513724337;5496.422875598085;5532.917006244909;5533.557315414757;5539.8892022159735;3797.9620203798163;3814.790186539767;3815.5039844819994;3816.904577385588;3817.1411432428035;3761.9811900940867;3857.5949525300002;3861.517310336208;3862.787546684959;3865.111024464333;4400.471943366816;4402;4417.779111044435;4425.933610995838;4430.202563538594;5240.213967904769;5255.710935898563;5257.921131183035;5265.52610265078;5277.63056586043;1246.3830403950103;1287.9806802897965;1323.3317174826843;1330.7870740681444;1332.9600111996656;880.4761167105562;890.643742503004;895.1317222294364;903.9288443194835;915.9221466175317;4475.9634366363225;4490.236659767847;4492.932606010912;4495.662825288116;4504.774761261924;5342.065138600729;5345.70598617072;5390.434004429557;5391.757370918318;5405.621606487587;4386.1666283406685;4497.865064048084;4549.0447006128425;4551.8179272829375;4563.247064234431;2539.095678241319;2575.0815642346197;2578.7034491033396;2589.6633437653363;2590.0445163901136;4395.824167033346;4419.292913133883;4419.756913369795;4421.823127074881;4428.512863585003;4561.429821272341;4809.95190048102;4846.418429788448;4861.927071093936;4881.170201065827;4353.67213000038;4362.3892655027685;4394.956050439519;4396.85681722748;4491.640668746492;4666.8133274668635;4672.77114211639;4696.647751418589;4716.245400735866;4735.550122738472;4662.254039353687;4662.836800711959;4664.86005419838;4683.501279590499;4689.226277664284;4587.632989360776;5061.266116413173;5063.215201643751;5063.949360506348;5081.8729531762;3678;3704.259148170323;3722.143906901482;3734.3838266685693;3745.1198968242984;5170.3278573785165;5406.83779486616;5417.349918009864;5441.891162176655;5470.699111548903;4963.6525443218625;5123.154679477993;5126.102931986962;5128.512791284971;5136.434992150786;5096.617753668415;5106.795728170831;5108.795648174031;5111.667741596784;5117.667351622133;4878.536539028786;5025.522575355335;5049;5049.5960323174795;5057.443681194992;5117.462666419972;5123.205903085028;5139.537441630271;5140.151874940742;5142.100132476877;4952.628552858478;5005.724685142352;5009.273655320031;5037.395512538519;5046.268291097844 04:30:41 INFO - PROCESS | 22671 | |5;yui.html;586.426304280221;643.9871202575948;650.6063831382016;701.5510073552924;733.9412846972243;12503.874961250385;13104.934475327635;13158.539451119213;13173.60479185626;13193.868061319385;12519.311437870914;12680.61958141255;12712.936435317833;12715;12717.109802313842;626.6146320013205;762.0436352377772;770.1451388958252;784.2392878907451;791.0112359550562;773.1765669561898;777.5839925639784;778.01581000035;779.4621711019407;780.5628847845196;829.4774292195908;831.2975535672347;832.629479881453;834.6661335465801;839.5844057191699;823.7199352220244;824.1223097401279;824.3734761581181;824.5464994253136;832.3590835056972;603.0471854469927;608.1850320570412;608.2002167150183;608.2883026858586;608.9299730530958;13534;13614.591562253148;13659.590212293648;13659.658508537266;13682;13242.933785331108;13259.138156019828;13312.534061307904;13407.932960335136;13466.797998030037;10475.738106547396;10513.52689128991;10648.57405703771;10650.786984260272;10712.892871071268;3213.501907204387;3246.9675303247136;3258.2017405735746;3260.836958152083;3298.5876765404323;60529.09206361908;62083.6895815518;62107.68946155286;62238;63450.99999999954;10066.194704423628;10283.177345812317;10477.580896764197;10498.737531561772;10555.84166237507;19186.80813191878;19433.90283048604;19434.12546435414;19438.4168474946;19481.220751169796;6432.839179020562;6438.839029024218;6477.967610161919;6496.837579060561;6651.567648102858;3315.966840331566;3349.514320423525;3350.597928248626;3354.0943945135164;3479.6520347965507;2706.8917243310443;2802.285417218596;2819.647544056993;2820.309024289062;2821.8730157142977;502.8667403138171;505.89376230991166;520.0223579670196;520.6875874475285;523.3275241314892;519.6076961893822;555.7388027627009;565.2623326558798;570.4352690836042;572.68788510262;8275.54484503358;8347.95826020866;8391.580420978926;8523.445976011664;8716.041235464094;541.4531323363432;610.8381278961078;616.0767159826652;623.1556241293073;623.8845813524513;3724.6275372462537;3745.550533935945;3844.615538446133;3851.6533511984057;3872.7095467840027;50059.74970125126;92945.53527232456;93016.53491732634;93764;94286.5285673581;46161;73484.63257683677;82011;82220.17779822244;83554.16445835585;72829.6358518204;73522.26477735261;73808;73982;75600.24399755932;7293.343599076109;7311.3785328247695;7388.482806203514;7465.253474652709;7625.923740762521;44576.331355029055;45136.77431612821;45209;45616.77191614154;45811;48323;61922.690386549584;62753.37246627658;62918;62991.68504157633;9062.954685226532;9562.61749530011;9846.950765246127;9896.703098907044;10182.032706892833;10803.621873234399;11058.170637202404;11088.501017454073;11189.72025699364;11347.37589432589;10676.572937082741;11148.219624626197;11252.718682033015;11649.475773590038;11828.881711183123;10407.843882341922;10448.582056717647;10510.842337365099;10758.408287543947;11016.1187105033;8999.505027223566;11061.778764424827;11364.204505684853;11965.401729913643;12288.692782680504;9510.95244523773;9956.850647240153;10002.599896004078;10077.294589378966;10118.949405252926;9838.704838854846;9885.209183265179;10000.549975251277;10276.691699249035;10369.68890933243 04:30:41 INFO - PROCESS | 22671 | __end_tp_report 04:30:41 INFO - PROCESS | 22671 | __start_cc_report 04:30:41 INFO - PROCESS | 22671 | _x_x_mozilla_cycle_collect,375 04:30:41 INFO - PROCESS | 22671 | __end_cc_report 04:30:41 INFO - PROCESS | 22671 | __startTimestamp1468236640990__endTimestamp 04:30:41 INFO - PROCESS | 22671 | 04:30:41 INFO - PROCESS | 22671 | ------- Summary: start ------- 04:30:41 INFO - PROCESS | 22671 | Number of tests: 6 04:30:41 INFO - PROCESS | 22671 | 04:30:41 INFO - PROCESS | 22671 | [#0] dojo.html Cycles:165 Average:4661.87 Median:4763.38 stddev:496.15 (10.4%) stddev-sans-first:469.68 04:30:41 INFO - PROCESS | 22671 | Values: 2567.5 2586.7 2591.8 2597.1 2607.9 4662.4 4667.4 4728.5 4766.9 4789.0 4638.0 4713.2 4732.5 4753.6 4763.4 4287.7 4319.7 4390.6 4391.9 4406.0 4343.8 4362.1 4369.7 4424.7 4438.1 4252.1 4311.7 4336.2 4342.7 4423.5 4294.4 4307.5 4347.8 4354.8 4355.0 4328.5 4349.3 4362.7 4367.6 4368.2 4706.2 4770.6 4775.4 4777.1 4796.4 5062.0 5087.0 5095.2 5105.0 5155.4 4980.8 5077.1 5104.8 5114.7 5182.8 4778.5 4802.9 4811.8 4831.2 4868.9 5268.3 5268.4 5279.4 5303.0 5313.5 4929.2 4966.5 4999.3 5051.7 5052.3 5002.7 5078.7 5095.7 5104.5 5149.5 4935.9 4978.7 4981.4 4996.7 4999.9 4948.7 4971.4 4973.1 4976.4 5028.3 4273.2 4279.7 4304.3 4305.1 4311.6 3747.8 3753.8 3759.7 3769.6 3786.6 4243.5 4330.8 4376.7 4417.7 4422.8 5063.4 5092.2 5098.7 5099.6 5144.2 4343.1 4348.2 4353.2 4357.3 4402.0 4469.8 4528.3 4536.0 4537.1 4554.1 4716.3 4718.3 4729.9 4772.4 4776.1 5113.4 5127.2 5130.1 5139.8 5143.7 4612.4 4721.5 4748.6 4773.4 4784.1 4908.3 4910.6 4919.0 4933.1 4971.9 5142.3 5146.0 5164.5 5169.6 5204.1 4655.2 4669.8 4757.2 4772.2 4801.2 4720.9 4752.0 4756.0 4807.7 4818.7 4702.1 4736.5 4758.9 4785.9 4798.7 4737.5 4821.8 4839.3 4849.0 4866.0 4713.2 4720.2 4730.7 4774.4 4838.0 04:30:41 INFO - PROCESS | 22671 | 04:30:41 INFO - PROCESS | 22671 | [#1] ext.html Cycles:180 Average:48951.90 Median:39090.12 stddev:92635.81 (237.0%) stddev-sans-first:92824.40 04:30:41 INFO - PROCESS | 22671 | Values: 551.5 564.5 568.8 578.1 596.5 35623.8 40511.0 40527.6 40536.8 40625.0 40329.4 40696.0 40818.6 40838.2 40861.2 7940.3 8019.1 8035.2 8052.2 8091.0 7950.0 8027.0 8035.2 8047.3 8052.6 7918.6 8052.0 8054.3 8065.7 8079.4 7999.1 8008.9 8029.9 8040.7 8059.0 7929.8 7998.9 8032.6 8053.8 8067.0 38492.8 39089.4 39090.8 39091.2 39201.0 2948.8 3319.6 3448.6 3630.4 3736.5 29792.3 30107.8 30187.8 30859.1 30911.2 3084.2 3134.5 3164.9 3211.1 3218.3 193191.0 193240.0 193254.0 194284.0 194367.0 54531.5 54554.0 54572.7 54860.2 55030.7 33533.2 33655.2 33708.8 58805.7 59073.4 12897.2 13014.8 13017.9 13038.4 13048.8 9571.7 9591.8 9606.5 9616.4 9715.4 18808.2 18878.2 18909.7 18923.4 19014.9 6811.4 6969.8 7025.0 7043.3 7242.6 791.7 889.9 937.8 990.4 992.6 29007.7 29509.3 31451.7 31908.2 32454.2 897.8 923.9 934.4 945.9 971.6 14290.2 15090.0 15186.2 15203.7 15306.5 429793.0 430636.0 432879.0 436724.0 436853.0 51254.2 52965.2 53021.2 53042.0 53049.0 1157.5 1195.9 1211.2 1222.5 1230.2 27065.5 27334.7 28050.6 28111.7 28422.9 43245.4 43816.3 44155.8 44349.0 44385.1 370101.0 374032.0 374341.0 378081.0 381501.0 25825.4 26229.9 26240.2 26243.2 26260.3 42374.6 42767.6 43100.6 43411.0 44453.0 37680.0 37794.8 37880.4 38395.2 38441.4 36097.6 36848.4 37339.8 37524.0 37752.6 36044.5 36791.0 37019.3 37155.3 38504.8 32646.3 35080.8 35773.3 35849.6 35853.6 25276.6 25599.6 25683.1 25728.5 25771.5 04:30:41 INFO - PROCESS | 22671 | 04:30:41 INFO - PROCESS | 22671 | [#2] jquery.html Cycles:180 Average:24222.38 Median:223101.66 stddev:64839.79 (29.1%) stddev-sans-first:64996.93 04:30:41 INFO - PROCESS | 22671 | Values: 362.1 365.3 366.4 381.9 386.7 16306.8 16728.6 18007.2 18015.5 18054.3 17014.5 17354.3 17938.7 17943.9 17990.5 5146.9 5323.4 5328.9 5337.6 5348.2 5246.6 5282.8 5339.6 5360.4 5363.9 5166.4 5261.3 5283.9 5296.6 5306.7 5212.8 5323.2 5334.3 5336.9 5345.1 4711.8 4745.1 4754.0 4760.6 4763.0 20270.1 21441.4 21660.8 21783.5 21804.2 1967.0 2006.6 2174.3 2476.7 2491.0 13319.6 13408.1 13575.9 13705.3 13831.3 1695.8 1715.7 1739.8 1745.3 1812.2 69103.0 70440.3 70536.6 71082.6 72098.3 9349.6 9507.3 9746.0 9781.4 9894.3 13259.3 13356.7 13390.9 13402.5 13422.5 6545.3 6637.1 6703.5 6781.6 6814.2 6168.4 6264.6 6295.8 6300.0 6316.7 6058.8 6084.8 6098.3 6165.8 6221.1 1749.2 1762.0 1763.6 1766.1 1776.3 833.3 854.8 858.2 884.6 925.9 17271.7 17426.7 17940.6 18011.7 18455.0 881.8 892.8 901.3 903.7 946.0 9832.0 10350.0 10385.3 10387.3 10387.9 386608.0 393143.0 396834.0 397267.0 400211.0 52390.5 60225.7 61243.0 70205.6 70445.0 916.8 937.2 941.8 943.0 944.0 14427.9 16501.3 16614.6 16718.8 17108.2 33754.5 35158.0 36494.5 36588.3 37127.6 45992.3 46197.3 48492.8 48579.3 48742.0 7629.3 7651.7 7670.6 7681.8 7740.0 11644.8 12209.8 12258.3 12387.5 12556.7 9485.3 10523.8 10532.0 10717.2 10722.5 9446.6 9780.2 10214.9 10624.1 10753.0 10083.0 10545.3 10571.2 10574.2 10645.4 7475.7 7496.4 7518.8 7564.9 7582.0 10275.4 10417.3 10493.9 10571.2 10735.2 04:30:41 INFO - PROCESS | 22671 | 04:30:41 INFO - PROCESS | 22671 | [#3] mootools.html Cycles:180 Average:5057.35 Median:4897.03 stddev:2847.39 (58.1%) stddev-sans-first:2841.94 04:30:41 INFO - PROCESS | 22671 | Values: 1375.7 1425.5 1478.3 1661.9 1713.1 6728.5 7447.9 7534.2 7854.1 7993.1 7645.9 7830.5 7914.3 7918.2 7933.2 2152.3 2173.2 2181.7 2191.2 2200.4 2121.6 2141.8 2179.9 2197.3 2198.9 2187.0 2192.7 2198.6 2202.3 2213.2 2150.2 2172.0 2175.2 2181.8 2184.3 2061.6 2083.3 2086.5 2086.9 2090.3 7732.7 7764.9 7785.8 7795.0 7809.3 4585.1 4661.8 4726.3 4735.0 4746.2 2729.8 2760.0 2792.5 2846.0 2852.0 866.7 877.3 894.6 894.7 902.5 10326.2 10386.7 10390.5 10424.6 10466.5 4011.4 4034.3 4168.0 4220.7 4374.1 8948.1 8963.0 8978.9 8982.6 8983.9 4724.9 4726.3 4767.0 4775.3 4777.4 3777.7 4171.7 4296.3 4344.7 4347.8 3498.3 3522.6 3622.1 3625.8 3642.7 1125.7 1130.9 1147.7 1153.4 1168.2 746.3 769.7 789.3 804.7 806.5 4877.8 4916.2 5010.6 5147.7 5162.9 405.9 406.0 410.9 413.9 430.3 3742.0 3744.1 3793.3 3798.1 3810.9 8987.4 9351.4 9538.2 9543.1 9546.8 9402.1 9402.8 9417.3 9420.4 9436.2 6796.5 7132.6 7199.6 7200.5 7203.7 5380.3 5433.0 5487.2 5507.1 5608.7 8962.1 8962.1 9061.1 9161.1 9161.8 8694.6 9039.5 9186.5 9200.9 9249.3 6226.8 6449.3 6480.9 6615.3 6748.9 7163.9 7168.2 7189.5 7192.9 7236.2 6386.1 6536.8 6539.6 6585.5 6662.5 6298.4 6345.6 6353.8 6477.9 6486.1 6067.0 6108.8 6126.7 6130.9 6143.0 4244.9 4403.9 4460.2 4465.9 4468.2 4263.5 4322.7 4337.9 4351.0 4400.0 04:30:41 INFO - PROCESS | 22671 | 04:30:41 INFO - PROCESS | 22671 | [#4] prototype.html Cycles:180 Average:4232.79 Median:4575.44 stddev:1216.37 (26.6%) stddev-sans-first:1183.26 04:30:41 INFO - PROCESS | 22671 | Values: 291.2 301.5 305.5 305.6 309.2 4868.4 4967.0 5043.8 5064.3 5096.3 5001.4 5018.0 5020.3 5030.3 5030.7 3912.9 3964.9 3968.1 3973.5 3980.2 3879.3 3889.7 3962.7 3964.5 3975.4 3930.3 3936.7 3943.9 3952.9 3958.9 3913.2 3944.6 3949.0 3957.8 3958.9 3491.2 3492.4 3493.5 3498.7 3501.5 4642.8 4952.4 4957.7 4958.1 4997.3 4430.4 4452.4 4453.0 4475.4 4476.8 5279.3 5282.6 5293.7 5304.9 5305.9 3626.9 3721.4 3731.7 3735.7 3736.4 5489.7 5496.4 5532.9 5533.6 5539.9 3798.0 3814.8 3815.5 3816.9 3817.1 3762.0 3857.6 3861.5 3862.8 3865.1 4400.5 4402.0 4417.8 4425.9 4430.2 5240.2 5255.7 5257.9 5265.5 5277.6 1246.4 1288.0 1323.3 1330.8 1333.0 880.5 890.6 895.1 903.9 915.9 4476.0 4490.2 4492.9 4495.7 4504.8 5342.1 5345.7 5390.4 5391.8 5405.6 4386.2 4497.9 4549.0 4551.8 4563.2 2539.1 2575.1 2578.7 2589.7 2590.0 4395.8 4419.3 4419.8 4421.8 4428.5 4561.4 4810.0 4846.4 4861.9 4881.2 4353.7 4362.4 4395.0 4396.9 4491.6 4666.8 4672.8 4696.6 4716.2 4735.6 4662.3 4662.8 4664.9 4683.5 4689.2 4587.6 5061.3 5063.2 5063.9 5081.9 3678.0 3704.3 3722.1 3734.4 3745.1 5170.3 5406.8 5417.3 5441.9 5470.7 4963.7 5123.2 5126.1 5128.5 5136.4 5096.6 5106.8 5108.8 5111.7 5117.7 4878.5 5025.5 5049.0 5049.6 5057.4 5117.5 5123.2 5139.5 5140.2 5142.1 4952.6 5005.7 5009.3 5037.4 5046.3 04:30:41 INFO - PROCESS | 22671 | 04:30:41 INFO - PROCESS | 22671 | [#5] yui.html Cycles:180 Average:16889.80 Median:512.75 stddev:23693.94 (4620.9%) stddev-sans-first:23728.78 04:30:41 INFO - PROCESS | 22671 | Values: 586.4 644.0 650.6 701.6 733.9 12503.9 13104.9 13158.5 13173.6 13193.9 12519.3 12680.6 12712.9 12715.0 12717.1 626.6 762.0 770.1 784.2 791.0 773.2 777.6 778.0 779.5 780.6 829.5 831.3 832.6 834.7 839.6 823.7 824.1 824.4 824.5 832.4 603.0 608.2 608.2 608.3 608.9 13534.0 13614.6 13659.6 13659.7 13682.0 13242.9 13259.1 13312.5 13407.9 13466.8 10475.7 10513.5 10648.6 10650.8 10712.9 3213.5 3247.0 3258.2 3260.8 3298.6 60529.1 62083.7 62107.7 62238.0 63451.0 10066.2 10283.2 10477.6 10498.7 10555.8 19186.8 19433.9 19434.1 19438.4 19481.2 6432.8 6438.8 6478.0 6496.8 6651.6 3316.0 3349.5 3350.6 3354.1 3479.7 2706.9 2802.3 2819.6 2820.3 2821.9 502.9 505.9 520.0 520.7 523.3 519.6 555.7 565.3 570.4 572.7 8275.5 8348.0 8391.6 8523.4 8716.0 541.5 610.8 616.1 623.2 623.9 3724.6 3745.6 3844.6 3851.7 3872.7 50059.7 92945.5 93016.5 93764.0 94286.5 46161.0 73484.6 82011.0 82220.2 83554.2 72829.6 73522.3 73808.0 73982.0 75600.2 7293.3 7311.4 7388.5 7465.3 7625.9 44576.3 45136.8 45209.0 45616.8 45811.0 48323.0 61922.7 62753.4 62918.0 62991.7 9063.0 9562.6 9847.0 9896.7 10182.0 10803.6 11058.2 11088.5 11189.7 11347.4 10676.6 11148.2 11252.7 11649.5 11828.9 10407.8 10448.6 10510.8 10758.4 11016.1 8999.5 11061.8 11364.2 11965.4 12288.7 9511.0 9956.9 10002.6 10077.3 10118.9 9838.7 9885.2 10000.5 10276.7 10369.7 04:30:41 INFO - PROCESS | 22671 | -------- Summary: end -------- 04:30:41 INFO - PROCESS | 22671 | 04:30:41 INFO - TEST-INFO | 22671: exit 0 04:30:41 INFO - TEST-OK | dromaeo_css | took 1117567ms 04:30:41 INFO - TEST-START | kraken 04:30:41 INFO - operating with platform_type : linux_ 04:30:41 INFO - Initialising browser for kraken test... 04:30:41 INFO - TEST-INFO | started process 22916 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGl6R7w/profile http://localhost:41547/getInfo.html) 04:30:46 INFO - PROCESS | 22916 | __metrics Screen width/height:1600/1200 04:30:46 INFO - PROCESS | 22916 | colorDepth:24 04:30:46 INFO - PROCESS | 22916 | Browser inner width/height: 1024/697 04:30:46 INFO - PROCESS | 22916 | __metrics 04:30:47 ERROR - PROCESS | 22916 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 04:30:48 INFO - TEST-INFO | 22916: exit 0 04:30:48 INFO - Browser initialized. 04:30:48 INFO - Running cycle 1/1 for kraken test... 04:30:48 INFO - TEST-INFO | started process 23040 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGl6R7w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:31:00 INFO - PROCESS | 23040 | RSS: Main: 168669184 04:31:00 INFO - PROCESS | 23040 | 04:31:02 INFO - PROCESS | 23040 | Cycle 1(1): loaded http://localhost:41547/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41547/tests/kraken/driver.html?testName=audio-beat-detection) 04:31:03 INFO - PROCESS | 23040 | RSS: Main: 173903872 04:31:03 INFO - PROCESS | 23040 | 04:31:06 INFO - PROCESS | 23040 | Cycle 1(1): loaded http://localhost:41547/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41547/tests/kraken/driver.html?testName=audio-dft) 04:31:07 INFO - PROCESS | 23040 | RSS: Main: 173658112 04:31:07 INFO - PROCESS | 23040 | 04:31:10 INFO - PROCESS | 23040 | Cycle 1(1): loaded http://localhost:41547/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41547/tests/kraken/driver.html?testName=audio-fft) 04:31:10 INFO - PROCESS | 23040 | RSS: Main: 167874560 04:31:10 INFO - PROCESS | 23040 | 04:31:12 INFO - PROCESS | 23040 | Cycle 1(1): loaded http://localhost:41547/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41547/tests/kraken/driver.html?testName=audio-oscillator) 04:31:13 INFO - PROCESS | 23040 | RSS: Main: 168693760 04:31:13 INFO - PROCESS | 23040 | 04:31:15 INFO - PROCESS | 23040 | Cycle 1(1): loaded http://localhost:41547/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41547/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:31:16 INFO - PROCESS | 23040 | RSS: Main: 169275392 04:31:16 INFO - PROCESS | 23040 | 04:31:19 INFO - PROCESS | 23040 | Cycle 1(1): loaded http://localhost:41547/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41547/tests/kraken/driver.html?testName=imaging-darkroom) 04:31:20 INFO - PROCESS | 23040 | RSS: Main: 169496576 04:31:20 INFO - PROCESS | 23040 | 04:31:23 INFO - PROCESS | 23040 | Cycle 1(1): loaded http://localhost:41547/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41547/tests/kraken/driver.html?testName=imaging-desaturate) 04:31:24 INFO - PROCESS | 23040 | RSS: Main: 167534592 04:31:24 INFO - PROCESS | 23040 | 04:31:27 INFO - PROCESS | 23040 | Cycle 1(1): loaded http://localhost:41547/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41547/tests/kraken/driver.html?testName=json-parse-financial) 04:31:28 INFO - PROCESS | 23040 | RSS: Main: 168521728 04:31:28 INFO - PROCESS | 23040 | 04:31:29 INFO - PROCESS | 23040 | Cycle 1(1): loaded http://localhost:41547/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41547/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:31:30 INFO - PROCESS | 23040 | RSS: Main: 168734720 04:31:30 INFO - PROCESS | 23040 | 04:31:32 INFO - PROCESS | 23040 | Cycle 1(1): loaded http://localhost:41547/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41547/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:31:32 INFO - PROCESS | 23040 | RSS: Main: 168755200 04:31:32 INFO - PROCESS | 23040 | 04:31:35 INFO - PROCESS | 23040 | Cycle 1(1): loaded http://localhost:41547/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41547/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:31:35 INFO - PROCESS | 23040 | RSS: Main: 169730048 04:31:35 INFO - PROCESS | 23040 | 04:31:38 INFO - PROCESS | 23040 | Cycle 1(1): loaded http://localhost:41547/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41547/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:31:39 INFO - PROCESS | 23040 | RSS: Main: 169562112 04:31:39 INFO - PROCESS | 23040 | 04:31:42 INFO - PROCESS | 23040 | Cycle 1(1): loaded http://localhost:41547/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41547/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:31:42 INFO - PROCESS | 23040 | RSS: Main: 169529344 04:31:42 INFO - PROCESS | 23040 | 04:31:44 INFO - PROCESS | 23040 | Cycle 1(1): loaded http://localhost:41547/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41547/tests/kraken/driver.html?testName=ai-astar) 04:31:44 INFO - PROCESS | 23040 | RSS: Main: 170631168 04:31:44 INFO - PROCESS | 23040 | 04:31:44 INFO - PROCESS | 23040 | __start_tp_report 04:31:44 INFO - PROCESS | 23040 | _x_x_mozilla_page_load 04:31:44 INFO - PROCESS | 23040 | _x_x_mozilla_page_load_details 04:31:44 INFO - PROCESS | 23040 | |i|pagename|runs| 04:31:44 INFO - PROCESS | 23040 | |0;ai-astar;106;116;108;117;116;115;117;114;115;113 04:31:44 INFO - PROCESS | 23040 | |1;audio-beat-detection;148;125;151;185;126;153;152;126;184;124 04:31:44 INFO - PROCESS | 23040 | |2;audio-dft;165;162;166;178;164;164;164;166;163;162 04:31:44 INFO - PROCESS | 23040 | |3;audio-fft;76;77;79;159;79;77;77;76;162;77 04:31:44 INFO - PROCESS | 23040 | |4;audio-oscillator;85;85;137;86;85;86;138;87;91;144 04:31:44 INFO - PROCESS | 23040 | |5;imaging-gaussian-blur;117;117;117;117;118;118;118;118;118;117 04:31:44 INFO - PROCESS | 23040 | |6;imaging-darkroom;148;147;148;149;147;148;148;148;148;148 04:31:44 INFO - PROCESS | 23040 | |7;imaging-desaturate;95;96;96;96;96;96;96;96;96;96 04:31:44 INFO - PROCESS | 23040 | |8;json-parse-financial;66;66;65;65;65;64;65;64;64;64 04:31:44 INFO - PROCESS | 23040 | |9;json-stringify-tinderbox;66;65;66;64;64;65;65;64;64;64 04:31:44 INFO - PROCESS | 23040 | |10;stanford-crypto-aes;80;80;83;80;80;86;83;79;91;78 04:31:44 INFO - PROCESS | 23040 | |11;stanford-crypto-ccm;134;129;133;141;147;141;132;134;168;133 04:31:44 INFO - PROCESS | 23040 | |12;stanford-crypto-pbkdf2;170;171;171;170;176;172;171;172;172;168 04:31:44 INFO - PROCESS | 23040 | |13;stanford-crypto-sha256-iterative;69;73;69;68;69;69;68;71;67;69 04:31:44 INFO - PROCESS | 23040 | __end_tp_report 04:31:44 INFO - PROCESS | 23040 | __start_cc_report 04:31:44 INFO - PROCESS | 23040 | _x_x_mozilla_cycle_collect,959 04:31:44 INFO - PROCESS | 23040 | __end_cc_report 04:31:44 INFO - PROCESS | 23040 | __startTimestamp1468236704772__endTimestamp 04:31:44 INFO - PROCESS | 23040 | 04:31:44 INFO - PROCESS | 23040 | ------- Summary: start ------- 04:31:44 INFO - PROCESS | 23040 | Number of tests: 14 04:31:44 INFO - PROCESS | 23040 | 04:31:44 INFO - PROCESS | 23040 | [#0] ai-astar Cycles:10 Average:113.70 Median:115.50 stddev:3.77 (3.3%) stddev-sans-first:2.79 04:31:44 INFO - PROCESS | 23040 | Values: 106.0 116.0 108.0 117.0 116.0 115.0 117.0 114.0 115.0 113.0 04:31:44 INFO - PROCESS | 23040 | 04:31:44 INFO - PROCESS | 23040 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:151.50 stddev:23.06 (15.2%) stddev-sans-first:24.45 04:31:44 INFO - PROCESS | 23040 | Values: 148.0 125.0 151.0 185.0 126.0 153.0 152.0 126.0 184.0 124.0 04:31:44 INFO - PROCESS | 23040 | 04:31:44 INFO - PROCESS | 23040 | [#2] audio-dft Cycles:10 Average:165.40 Median:164.50 stddev:4.65 (2.8%) stddev-sans-first:4.93 04:31:44 INFO - PROCESS | 23040 | Values: 165.0 162.0 166.0 178.0 164.0 164.0 164.0 166.0 163.0 162.0 04:31:44 INFO - PROCESS | 23040 | 04:31:44 INFO - PROCESS | 23040 | [#3] audio-fft Cycles:10 Average:93.90 Median:77.00 stddev:35.12 (45.6%) stddev-sans-first:36.65 04:31:44 INFO - PROCESS | 23040 | Values: 76.0 77.0 79.0 159.0 79.0 77.0 77.0 76.0 162.0 77.0 04:31:44 INFO - PROCESS | 23040 | 04:31:44 INFO - PROCESS | 23040 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:85.50 stddev:25.84 (30.2%) stddev-sans-first:26.63 04:31:44 INFO - PROCESS | 23040 | Values: 85.0 85.0 137.0 86.0 85.0 86.0 138.0 87.0 91.0 144.0 04:31:44 INFO - PROCESS | 23040 | 04:31:44 INFO - PROCESS | 23040 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:31:44 INFO - PROCESS | 23040 | Values: 117.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 117.0 04:31:44 INFO - PROCESS | 23040 | 04:31:44 INFO - PROCESS | 23040 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 04:31:44 INFO - PROCESS | 23040 | Values: 148.0 147.0 148.0 149.0 147.0 148.0 148.0 148.0 148.0 148.0 04:31:44 INFO - PROCESS | 23040 | 04:31:44 INFO - PROCESS | 23040 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 04:31:44 INFO - PROCESS | 23040 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 04:31:44 INFO - PROCESS | 23040 | 04:31:44 INFO - PROCESS | 23040 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.71 04:31:44 INFO - PROCESS | 23040 | Values: 66.0 66.0 65.0 65.0 65.0 64.0 65.0 64.0 64.0 64.0 04:31:44 INFO - PROCESS | 23040 | 04:31:44 INFO - PROCESS | 23040 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.73 04:31:44 INFO - PROCESS | 23040 | Values: 66.0 65.0 66.0 64.0 64.0 65.0 65.0 64.0 64.0 64.0 04:31:44 INFO - PROCESS | 23040 | 04:31:44 INFO - PROCESS | 23040 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.50 stddev:3.94 (4.8%) stddev-sans-first:4.12 04:31:44 INFO - PROCESS | 23040 | Values: 80.0 80.0 83.0 80.0 80.0 86.0 83.0 79.0 91.0 78.0 04:31:44 INFO - PROCESS | 23040 | 04:31:44 INFO - PROCESS | 23040 | [#11] stanford-crypto-ccm Cycles:10 Average:139.20 Median:137.50 stddev:11.47 (8.3%) stddev-sans-first:12.01 04:31:44 INFO - PROCESS | 23040 | Values: 134.0 129.0 133.0 141.0 147.0 141.0 132.0 134.0 168.0 133.0 04:31:44 INFO - PROCESS | 23040 | 04:31:44 INFO - PROCESS | 23040 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:171.50 stddev:2.06 (1.2%) stddev-sans-first:2.13 04:31:44 INFO - PROCESS | 23040 | Values: 170.0 171.0 171.0 170.0 176.0 172.0 171.0 172.0 172.0 168.0 04:31:44 INFO - PROCESS | 23040 | 04:31:44 INFO - PROCESS | 23040 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:1.69 (2.4%) stddev-sans-first:1.79 04:31:44 INFO - PROCESS | 23040 | Values: 69.0 73.0 69.0 68.0 69.0 69.0 68.0 71.0 67.0 69.0 04:31:44 INFO - PROCESS | 23040 | -------- Summary: end -------- 04:31:44 INFO - PROCESS | 23040 | 04:31:45 INFO - TEST-INFO | 23040: exit 0 04:31:45 INFO - TEST-OK | kraken | took 64128ms 04:31:45 INFO - SUITE-END | took 1181s 04:31:45 INFO - Completed test suite (00:19:41) 04:31:45 INFO - javascript benchmark 04:31:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6376.48703361063, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2567.499337629162, 2586.6895972483303, 2591.7537833905776, 2597.06505657963, 2607.8696065196737, 4662.417197850269, 4667.416572928384, 4728.4798672146035, 4766.880827979294, 4789.0, 4637.953620463794, 4713.198756211444, 4732.455767586728, 4753.619710423167, 4763.38076050113, 4287.6569874410125, 4319.654427645781, 4390.64874810016, 4391.86824395267, 4405.955940440603, 4343.847965321214, 4362.149380870732, 4369.73781573105, 4424.690271680984, 4438.068005718803, 4252.064545799919, 4311.676624253194, 4336.176126535979, 4342.739435633841, 4423.491298500681, 4294.398784170218, 4307.504636966726, 4347.760873151976, 4354.804033818486, 4355.0, 4328.5455027222315, 4349.304111342201, 4362.716423432466, 4367.606915377632, 4368.170047690928, 4706.152892479352, 4770.570648641604, 4775.355327030841, 4777.140114779339, 4796.376471058775, 5061.974690126563, 5087.033463641897, 5095.159298715707, 5104.999080045982, 5155.432902380735, 4980.775865086043, 5077.0607437623785, 5104.846854594368, 5114.667546609458, 5182.844514664528, 4778.450478194983, 4802.855914322576, 4811.807527698923, 4831.154547954094, 4868.880157563709, 5268.262443257947, 5268.367795864521, 5279.41926388097, 5302.973485132627, 5313.468653134656, 4929.162042452792, 4966.503349665077, 4999.275105109811, 5051.696898186121, 5052.317937078521, 5002.674826136362, 5078.7460626968505, 5095.745212739348, 5104.515071068243, 5149.510796474329, 4935.87660308488, 4978.65149439543, 4981.37732783402, 4996.725180115129, 4999.925001124986, 4948.727819969864, 4971.403431588233, 4973.055119527278, 4976.377952755905, 5028.296038554606, 4273.166732487197, 4279.657627389864, 4304.332828411601, 4305.095929854703, 4311.590398912098, 3747.831347589365, 3753.7560058596105, 3759.7368184226843, 3769.6418840210135, 3786.6402691744793, 4243.533211346749, 4330.805113769888, 4376.737395756265, 4417.712848664891, 4422.823087076546, 5063.417706963746, 5092.185250359925, 5098.668586541863, 5099.566536844335, 5144.176931690911, 4343.1096625192395, 4348.195583817004, 4353.151135528541, 4357.346398040319, 4401.9875428651585, 4469.776511174493, 4528.320751887243, 4536.047430039728, 4537.137943790669, 4554.111948170075, 4716.316134160459, 4718.292256161603, 4729.881752956066, 4772.427308723045, 4776.068666609977, 5113.386393632788, 5127.2052831811125, 5130.050940575856, 5139.768710408115, 5143.691378517151, 4612.4003879496795, 4721.504242054535, 4748.620110391092, 4773.3555969945, 4784.138855006132, 4908.337374454403, 4910.631702622389, 4919.0, 4933.136701077369, 4971.875703107306, 5142.331496905378, 5146.0479811233545, 5164.535191832753, 5169.61227907916, 5204.115300399017, 4655.18534256497, 4669.7898594564, 4757.191277482767, 4772.188727916193, 4801.207800712843, 4720.858374248778, 4751.976240118777, 4756.0, 4807.735574543294, 4818.6626936114135, 4702.059588082466, 4736.455307639666, 4758.857234282977, 4785.880352991203, 4798.712077275235, 4737.478877323423, 4821.831235906727, 4839.322494850653, 4849.030193961293, 4865.95134048655, 4713.2458806590785, 4720.197566413649, 4730.692504987165, 4774.40319960005, 4838.03239352138], "value": 4629.494908856201, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.531198481291, 564.5257983294033, 568.8236646639542, 578.0721941284239, 596.4542443664047, 35623.821880890595, 40511.0, 40527.59472405275, 40536.79731601345, 40625.0, 40329.39505907414, 40696.0, 40818.59181408185, 40838.18323633526, 40861.18277634445, 7940.285374316325, 8019.077806052291, 8035.2366525180305, 8052.19478052196, 8090.959545202266, 7950.045994480671, 8026.959865200666, 8035.196480351977, 8047.315978141865, 8052.557109358983, 7918.643661035238, 8051.9597402013205, 8054.315383192436, 8065.717699880476, 8079.394045446615, 7999.120096789348, 8008.879866802003, 8029.915961345202, 8040.718574849881, 8058.959705201495, 7929.801754956115, 7998.920010799934, 8032.598370081472, 8053.838923221561, 8066.959665201636, 38492.80753596242, 39089.43642254306, 39090.80454597737, 39091.21817563661, 39201.0, 2948.8083274587084, 3319.6348401676037, 3448.583405178844, 3630.4009838376637, 3736.4955730976244, 29792.255193620116, 30107.849460752775, 30187.849060754776, 30859.074227773202, 30911.227219319473, 3084.195973300696, 3134.4828103362915, 3164.889228877001, 3211.1008917503136, 3218.3241519280978, 193191.0, 193240.0, 193254.0, 194284.0, 194367.0, 54531.454685453435, 54554.0, 54572.72713636406, 54860.17709734357, 55030.72484637551, 33533.16167095842, 33655.15862103467, 33708.83145584256, 58805.70597146987, 59073.40926590765, 12897.226166430044, 13014.804777928339, 13017.869821301856, 13038.41327140281, 13048.804267935988, 9571.664991725256, 9591.760205994906, 9606.471644059644, 9616.374935629301, 9715.36850104741, 18808.153633086546, 18878.150483228288, 18909.7163542547, 18923.43229703111, 19014.90492547556, 6811.4210292124735, 6969.82575435608, 7024.964875175591, 7043.330883566053, 7242.601656908815, 791.686790780585, 889.9377043607014, 937.7749340158313, 990.4305024610877, 992.6178421307849, 29007.7099229005, 29509.26226844303, 31451.685483144876, 31908.202294942814, 32454.188645284055, 897.7935074932672, 923.8614207868739, 934.4159900062461, 945.9304556713508, 971.577363846729, 14290.214038227788, 15090.0, 15186.240687965557, 15203.695926081416, 15306.464273750365, 429793.0, 430636.0, 432879.0, 436724.0, 436853.0, 51254.23118653223, 52965.2055219172, 53021.204681929805, 53042.0, 53049.0, 1157.5138441854274, 1195.862475815275, 1211.2127117373777, 1222.5354365341113, 1230.1880758699215, 27065.45869082647, 27334.738187737596, 28050.57924131099, 28111.71888281091, 28422.85788571044, 43245.3513197296, 43816.342754858066, 44155.77922110369, 44349.0, 44385.11229775322, 370101.0464633725, 374032.0, 374341.0, 378081.0, 381501.0, 25825.354366140997, 26229.868850655625, 26240.21279361622, 26243.212703618923, 26260.343491412867, 42374.576254238294, 42767.572324276356, 43100.56899430966, 43411.0, 44453.0, 37680.0, 37794.81102594469, 37880.43179352367, 38395.23209535849, 38441.42337864878, 36097.63902361048, 36848.44727329146, 37339.813300933325, 37524.0, 37752.62247377491, 36044.45933311055, 36791.0, 37019.25961480809, 37155.25689486249, 38504.80747596244, 32646.34707305888, 35080.82459587686, 35773.284534308645, 35849.64150358463, 35853.64146358503, 25276.620850686886, 25599.6160057603, 25683.10109146171, 25728.485430291665, 25771.484570308865], "value": 17679.93914503324, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.1308858739027, 365.2803976166952, 366.35155774279525, 381.9465274861518, 386.6925793993776, 16306.755398669015, 16728.581785455368, 18007.18967646459, 18015.54961125971, 18054.27782888686, 17014.48956531303, 17354.305827766904, 17938.730919036225, 17943.91028044858, 17990.460286191403, 5146.897062058766, 5323.387810401815, 5328.866778330554, 5337.572994160458, 5348.224507446418, 5246.5802735781235, 5282.7622756976025, 5339.599530035243, 5360.410354860982, 5363.9463605363835, 5166.405863325709, 5261.263423120766, 5283.894322113555, 5296.602754793386, 5306.655067420625, 5212.76542555584, 5323.201519772046, 5334.27987221724, 5336.946630533684, 5345.064613692627, 4711.811527538895, 4745.145873742725, 4753.952460475385, 4760.619150467955, 4762.952370476286, 20270.087846046965, 21441.356759297247, 21660.78339216619, 21783.45541361463, 21804.236851710273, 1967.0459826983902, 2006.5986802639532, 2174.282486779359, 2476.73994230605, 2490.9875450622812, 13319.600411987656, 13408.061435699505, 13575.864241357658, 13705.314734263347, 13831.308434578332, 1695.7710709054365, 1715.6997525433123, 1739.765131707216, 1745.3367720266217, 1812.1754601656346, 69103.0, 70440.2955970444, 70536.6473167636, 71082.64458677673, 72098.27901720969, 9349.579268932914, 9507.286953478379, 9745.951270243746, 9781.41311521311, 9894.307398482037, 13259.270740109387, 13356.6660833478, 13390.866091339156, 13402.463901443833, 13422.530211442749, 6545.345465453416, 6637.070810086591, 6703.4972377070935, 6781.62701051437, 6814.182298124257, 6168.352323006109, 6264.619340800651, 6295.779647712308, 6299.960506516465, 6316.684165791784, 6058.818235452944, 6084.787032453843, 6098.298695649968, 6165.753369865245, 6221.097940798559, 1749.1516614441985, 1761.9647607047787, 1763.5943732941496, 1766.0728117738033, 1776.2983621469705, 833.3250067445389, 854.8247609240091, 858.2147335188357, 884.6417201033591, 925.9490728010024, 17271.65456690859, 17426.65146697059, 17940.551486212687, 18011.72982405265, 18455.0, 881.828043531518, 892.830362231174, 901.2879824938357, 903.6791938861741, 945.9877930614176, 9832.0, 10349.99400695205, 10385.324953877975, 10387.324823886423, 10387.857335693068, 386608.0, 393143.0, 396834.0, 397267.0, 400211.0, 52390.47609523856, 60225.69887150624, 61243.0, 70205.64897175583, 70445.0, 916.757059379265, 937.1940131486916, 941.8069295794346, 943.0192599696239, 944.0040757001292, 14427.92786036063, 16501.257443414834, 16614.58463538373, 16718.832811671728, 17108.230129643947, 33754.493682594286, 35158.0, 36494.4525832118, 36588.26823463569, 37127.6287237135, 45992.31011534896, 46197.307040393745, 48492.75753621209, 48579.27131093107, 48742.0, 7629.3133617974645, 7651.655675494505, 7670.578118203553, 7681.7695469136015, 7740.0, 11644.767104658029, 12209.816852747039, 12258.325792081521, 12387.504499820267, 12556.686082848002, 9485.288603354915, 10523.78952420932, 10532.0, 10717.196210284104, 10722.517486713272, 9446.574904129468, 9780.168685661798, 10214.897851021395, 10624.096951759188, 10753.032227099598, 10083.0, 10545.261831672016, 10571.207159463225, 10574.15406767472, 10645.361278323326, 7475.7009719610605, 7496.362809161283, 7518.774436766906, 7564.924350756422, 7581.962090189514, 10275.434851083262, 10417.322874013165, 10493.9475302623, 10571.154307655215, 10735.194860385345], "value": 8352.126050094732, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1375.7454870848894, 1425.5153247895717, 1478.3347493627864, 1661.9085950272731, 1713.0920612075588, 6728.4953628477815, 7447.888281675772, 7534.246575342463, 7854.057513098429, 7993.080795708495, 7645.885311720329, 7830.451868369217, 7914.327282181007, 7918.168592297812, 7933.2463415975535, 2152.300502336739, 2173.1850556041486, 2181.694562761215, 2191.22211614876, 2200.4058904095887, 2121.554473560554, 2141.7751136130714, 2179.923702670407, 2197.2748992832408, 2198.9450263743374, 2187.0377034104945, 2192.7039849620337, 2198.5932602468592, 2202.3062735238427, 2213.1700612270397, 2150.1721837092755, 2172.0443005077714, 2175.1734340950497, 2181.8472706910366, 2184.344696591016, 2061.5773766377856, 2083.3125068727436, 2086.5096702274955, 2086.895655217248, 2090.310197634792, 7732.724100523407, 7764.922350776533, 7785.844283114363, 7794.961025194894, 7809.336206422461, 4585.082983403333, 4661.836835710767, 4726.291056341542, 4735.0, 4746.169420351424, 2729.7952653551065, 2759.9724002759917, 2792.4833905727505, 2845.9857700711573, 2852.0, 866.6793286484042, 877.3419935048713, 894.552723638181, 894.6823877523516, 902.4630344944748, 10326.22553308505, 10386.688399347957, 10390.532426040847, 10424.635137770141, 10466.52900619474, 4011.4183443400543, 4034.253663072341, 4167.979160104241, 4220.662347012231, 4374.147041326911, 8948.149925757043, 8963.0, 8978.910210897939, 8982.595783189772, 8983.865242021375, 4724.929126063112, 4726.291056341576, 4767.046590681877, 4775.2598347256235, 4777.402824646919, 3777.697784177259, 4171.728837625545, 4296.312589985588, 4344.674149438742, 4347.804348804311, 3498.317828023511, 3522.5772907251294, 3622.0582648511577, 3625.7643253188457, 3642.745007849478, 1125.6566747142201, 1130.8925652063042, 1147.7073346296809, 1153.4002318794348, 1168.1589255735857, 746.3357611725569, 769.6536558548676, 789.3290702902601, 804.6620419423856, 806.5040000399829, 4877.829275975324, 4916.237983112624, 5010.599152067826, 5147.6654017488745, 5162.870928226749, 405.88635182149045, 406.0, 410.8705757686379, 413.89445691348516, 430.29646527927065, 3742.0, 3744.120131769032, 3793.260314238752, 3798.0694729791376, 3810.8666196682984, 8987.41581797181, 9351.39215950961, 9538.23694104484, 9543.093406126407, 9546.761330966781, 9402.106799854002, 9402.764930876783, 9417.340786145041, 9420.434773913586, 9436.150746432853, 6796.52424330302, 7132.572045677276, 7199.604021778852, 7200.459965502609, 7203.711851525985, 5380.273663055594, 5432.972835135799, 5487.176923461513, 5507.091329930517, 5608.7195640217005, 8962.058983806606, 8962.058983806866, 9061.13919177677, 9161.129692679186, 9161.77095572616, 8694.565271736261, 9039.548022598976, 9186.540672966192, 9200.861987070333, 9249.30630202751, 6226.813195604139, 6449.322821103717, 6480.870382592416, 6615.305392933673, 6748.93251067483, 7163.856722865409, 7168.17565979919, 7189.532680375759, 7192.856142877218, 7236.167840698176, 6386.105945167587, 6536.7712130075215, 6539.607623542603, 6585.473162147113, 6662.500312476681, 6298.401651843067, 6345.587536810092, 6353.841153971188, 6477.935220647733, 6486.0919471275, 6067.0, 6108.75564977396, 6126.663033533198, 6130.877382452237, 6143.047827586731, 4244.8514301999285, 4403.911921761611, 4460.1525710114975, 4465.866024019155, 4468.240399132221, 4263.467066616673, 4322.74063556175, 4337.869863904088, 4351.0, 4400.031992961543], "value": 4003.3037109517873, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.2021062289327, 301.4573767219006, 305.4715342457548, 305.5676218151316, 309.18375488709796, 4868.415790105192, 4967.0, 5043.848684539461, 5064.265681476184, 5096.286519887214, 5001.424836143845, 5018.039356779499, 5020.322256495381, 5030.29575859379, 5030.723310217945, 3912.921741565167, 3964.8612298569556, 3968.1468484275874, 3973.5033120859894, 3980.1840622672426, 3879.321118804198, 3889.6888248940018, 3962.6829853611644, 3964.5440774311037, 3975.423563583279, 3930.3121953658137, 3936.720565816121, 3943.9211215775667, 3952.901177470572, 3958.9406158907495, 3913.217356528677, 3944.5660977292473, 3949.0, 3957.812656203142, 3958.9010274743073, 3491.2319289756215, 3492.4237500812337, 3493.510908472816, 3498.7201023918024, 3501.544799176116, 4642.75007494755, 4952.380952380952, 4957.652964292501, 4958.132326842824, 4997.275395067695, 4430.4240448741775, 4452.3989261449615, 4452.977735111303, 4475.418195634579, 4476.820927162909, 5279.287296215, 5282.550983166436, 5293.655912365684, 5304.946950530484, 5305.867353316159, 3626.9455958160647, 3721.441783732435, 3731.7014638828828, 3735.7198210134347, 3736.3834967230373, 5489.725513724337, 5496.422875598085, 5532.917006244909, 5533.557315414757, 5539.8892022159735, 3797.9620203798163, 3814.790186539767, 3815.5039844819994, 3816.904577385588, 3817.1411432428035, 3761.9811900940867, 3857.5949525300002, 3861.517310336208, 3862.787546684959, 3865.111024464333, 4400.471943366816, 4402.0, 4417.779111044435, 4425.933610995838, 4430.202563538594, 5240.213967904769, 5255.710935898563, 5257.921131183035, 5265.52610265078, 5277.63056586043, 1246.3830403950103, 1287.9806802897965, 1323.3317174826843, 1330.7870740681444, 1332.9600111996656, 880.4761167105562, 890.643742503004, 895.1317222294364, 903.9288443194835, 915.9221466175317, 4475.9634366363225, 4490.236659767847, 4492.932606010912, 4495.662825288116, 4504.774761261924, 5342.065138600729, 5345.70598617072, 5390.434004429557, 5391.757370918318, 5405.621606487587, 4386.1666283406685, 4497.865064048084, 4549.0447006128425, 4551.8179272829375, 4563.247064234431, 2539.095678241319, 2575.0815642346197, 2578.7034491033396, 2589.6633437653363, 2590.0445163901136, 4395.824167033346, 4419.292913133883, 4419.756913369795, 4421.823127074881, 4428.512863585003, 4561.429821272341, 4809.95190048102, 4846.418429788448, 4861.927071093936, 4881.170201065827, 4353.67213000038, 4362.3892655027685, 4394.956050439519, 4396.85681722748, 4491.640668746492, 4666.8133274668635, 4672.77114211639, 4696.647751418589, 4716.245400735866, 4735.550122738472, 4662.254039353687, 4662.836800711959, 4664.86005419838, 4683.501279590499, 4689.226277664284, 4587.632989360776, 5061.266116413173, 5063.215201643751, 5063.949360506348, 5081.8729531762, 3678.0, 3704.259148170323, 3722.143906901482, 3734.3838266685693, 3745.1198968242984, 5170.3278573785165, 5406.83779486616, 5417.349918009864, 5441.891162176655, 5470.699111548903, 4963.6525443218625, 5123.154679477993, 5126.102931986962, 5128.512791284971, 5136.434992150786, 5096.617753668415, 5106.795728170831, 5108.795648174031, 5111.667741596784, 5117.667351622133, 4878.536539028786, 5025.522575355335, 5049.0, 5049.5960323174795, 5057.443681194992, 5117.462666419972, 5123.205903085028, 5139.537441630271, 5140.151874940742, 5142.100132476877, 4952.628552858478, 5005.724685142352, 5009.273655320031, 5037.395512538519, 5046.268291097844], "value": 3847.507000735948, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.426304280221, 643.9871202575948, 650.6063831382016, 701.5510073552924, 733.9412846972243, 12503.874961250385, 13104.934475327635, 13158.539451119213, 13173.60479185626, 13193.868061319385, 12519.311437870914, 12680.61958141255, 12712.936435317833, 12715.0, 12717.109802313842, 626.6146320013205, 762.0436352377772, 770.1451388958252, 784.2392878907451, 791.0112359550562, 773.1765669561898, 777.5839925639784, 778.01581000035, 779.4621711019407, 780.5628847845196, 829.4774292195908, 831.2975535672347, 832.629479881453, 834.6661335465801, 839.5844057191699, 823.7199352220244, 824.1223097401279, 824.3734761581181, 824.5464994253136, 832.3590835056972, 603.0471854469927, 608.1850320570412, 608.2002167150183, 608.2883026858586, 608.9299730530958, 13534.0, 13614.591562253148, 13659.590212293648, 13659.658508537266, 13682.0, 13242.933785331108, 13259.138156019828, 13312.534061307904, 13407.932960335136, 13466.797998030037, 10475.738106547396, 10513.52689128991, 10648.57405703771, 10650.786984260272, 10712.892871071268, 3213.501907204387, 3246.9675303247136, 3258.2017405735746, 3260.836958152083, 3298.5876765404323, 60529.09206361908, 62083.6895815518, 62107.68946155286, 62238.0, 63450.99999999954, 10066.194704423628, 10283.177345812317, 10477.580896764197, 10498.737531561772, 10555.84166237507, 19186.80813191878, 19433.90283048604, 19434.12546435414, 19438.4168474946, 19481.220751169796, 6432.839179020562, 6438.839029024218, 6477.967610161919, 6496.837579060561, 6651.567648102858, 3315.966840331566, 3349.514320423525, 3350.597928248626, 3354.0943945135164, 3479.6520347965507, 2706.8917243310443, 2802.285417218596, 2819.647544056993, 2820.309024289062, 2821.8730157142977, 502.8667403138171, 505.89376230991166, 520.0223579670196, 520.6875874475285, 523.3275241314892, 519.6076961893822, 555.7388027627009, 565.2623326558798, 570.4352690836042, 572.68788510262, 8275.54484503358, 8347.95826020866, 8391.580420978926, 8523.445976011664, 8716.041235464094, 541.4531323363432, 610.8381278961078, 616.0767159826652, 623.1556241293073, 623.8845813524513, 3724.6275372462537, 3745.550533935945, 3844.615538446133, 3851.6533511984057, 3872.7095467840027, 50059.74970125126, 92945.53527232456, 93016.53491732634, 93764.0, 94286.5285673581, 46161.0, 73484.63257683677, 82011.0, 82220.17779822244, 83554.16445835585, 72829.6358518204, 73522.26477735261, 73808.0, 73982.0, 75600.24399755932, 7293.343599076109, 7311.3785328247695, 7388.482806203514, 7465.253474652709, 7625.923740762521, 44576.331355029055, 45136.77431612821, 45209.0, 45616.77191614154, 45811.0, 48323.0, 61922.690386549584, 62753.37246627658, 62918.0, 62991.68504157633, 9062.954685226532, 9562.61749530011, 9846.950765246127, 9896.703098907044, 10182.032706892833, 10803.621873234399, 11058.170637202404, 11088.501017454073, 11189.72025699364, 11347.37589432589, 10676.572937082741, 11148.219624626197, 11252.718682033015, 11649.475773590038, 11828.881711183123, 10407.843882341922, 10448.582056717647, 10510.842337365099, 10758.408287543947, 11016.1187105033, 8999.505027223566, 11061.778764424827, 11364.204505684853, 11965.401729913643, 12288.692782680504, 9510.95244523773, 9956.850647240153, 10002.599896004078, 10077.294589378966, 10118.949405252926, 9838.704838854846, 9885.209183265179, 10000.549975251277, 10276.691699249035, 10369.68890933243], "value": 6383.052352620238, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 108.0, 117.0, 116.0, 115.0, 117.0, 114.0, 115.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 125.0, 151.0, 185.0, 126.0, 153.0, 152.0, 126.0, 184.0, 124.0], "value": 147.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 166.0, 178.0, 164.0, 164.0, 164.0, 166.0, 163.0, 162.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 79.0, 159.0, 79.0, 77.0, 77.0, 76.0, 162.0, 77.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 137.0, 86.0, 85.0, 86.0, 138.0, 87.0, 91.0, 144.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 149.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 65.0, 64.0, 65.0, 64.0, 64.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 64.0, 64.0, 65.0, 65.0, 64.0, 64.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 83.0, 80.0, 80.0, 86.0, 83.0, 79.0, 91.0, 78.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 129.0, 133.0, 141.0, 147.0, 141.0, 132.0, 134.0, 168.0, 133.0], "value": 139.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 171.0, 170.0, 176.0, 172.0, 171.0, 172.0, 172.0, 168.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 69.0, 68.0, 69.0, 69.0, 68.0, 71.0, 67.0, 69.0], "value": 69.2, "unit": "score"}]}]} 04:31:46 INFO - Return code: 0 04:31:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:31:46 ERROR - # TBPL SUCCESS # 04:31:46 INFO - Running post-action listener: _resource_record_post_action 04:31:46 INFO - ##### 04:31:46 INFO - ##### Finished run-tests step (success) 04:31:46 INFO - ##### 04:31:46 INFO - Running post-run listener: _resource_record_post_run 04:31:46 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551665664; Read time: 16; Write time: 529688 04:31:46 INFO - TinderboxPrint: CPU usage
13.4% 04:31:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:31:46 INFO - TinderboxPrint: I/O write bytes / time
551,665,664 / 529,688 04:31:46 INFO - TinderboxPrint: CPU idle
8,282.0 (86.6%) 04:31:46 INFO - TinderboxPrint: CPU user
1,221.0 (12.8%) 04:31:46 INFO - TinderboxPrint: Swap in / out
0 / 0 04:31:46 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 245960704; Read time: 0; Write time: 315076 04:31:46 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 288706560; Read time: 0; Write time: 208244 04:31:46 INFO - Running post-run listener: _upload_blobber_files 04:31:46 INFO - Blob upload gear active. 04:31:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:31:46 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 04:31:46 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:31:46 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:31:47 INFO - (blobuploader) - INFO - Open directory for files ... 04:31:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:31:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:31:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:51 INFO - (blobuploader) - INFO - Done attempting. 04:31:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:31:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:31:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:52 INFO - (blobuploader) - INFO - Done attempting. 04:31:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:31:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:31:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:53 INFO - (blobuploader) - INFO - Done attempting. 04:31:53 INFO - (blobuploader) - INFO - Iteration through files over. 04:31:53 INFO - Return code: 0 04:31:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:31:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:31:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c2d7218c07cd3af7276a2bccb163c6745c6553570f96888351baab681ba6e0d7e4bcf2f3dd4cf28f94d3010c0c43413f790093bfab9dea55354400788ad749c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cab74de05956ea42973ccbb867507118e1355beafa6026a0a29de68b62b9f349acc81097bf0b41ba0be4dc0c0b8b1e0c791e3e7c3fb8b5aa6b4dfca7bcc7ff6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56f239d3cb79aacb2c1ca1154da5e5a40bc503fe99a39016d7bc82024c0adf2ef4461b1abd44bbc17102d1476d5240f2e597a942541849c8c438587fe4ed17fd"} 04:31:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:31:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:31:53 INFO - Contents: 04:31:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c2d7218c07cd3af7276a2bccb163c6745c6553570f96888351baab681ba6e0d7e4bcf2f3dd4cf28f94d3010c0c43413f790093bfab9dea55354400788ad749c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cab74de05956ea42973ccbb867507118e1355beafa6026a0a29de68b62b9f349acc81097bf0b41ba0be4dc0c0b8b1e0c791e3e7c3fb8b5aa6b4dfca7bcc7ff6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56f239d3cb79aacb2c1ca1154da5e5a40bc503fe99a39016d7bc82024c0adf2ef4461b1abd44bbc17102d1476d5240f2e597a942541849c8c438587fe4ed17fd"} 04:31:53 INFO - Running post-run listener: copy_logs_to_upload_dir 04:31:53 INFO - Copying logs to upload dir... 04:31:53 INFO - mkdir: /builds/slave/test/build/upload/logs 04:31:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.217912 ========= master_lag: 86.29 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 7 secs) (at 2016-07-11 04:33:18.876530) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 04:33:18.879689) ========= 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=cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349 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-Non-PGO/sha512/4c2d7218c07cd3af7276a2bccb163c6745c6553570f96888351baab681ba6e0d7e4bcf2f3dd4cf28f94d3010c0c43413f790093bfab9dea55354400788ad749c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cab74de05956ea42973ccbb867507118e1355beafa6026a0a29de68b62b9f349acc81097bf0b41ba0be4dc0c0b8b1e0c791e3e7c3fb8b5aa6b4dfca7bcc7ff6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56f239d3cb79aacb2c1ca1154da5e5a40bc503fe99a39016d7bc82024c0adf2ef4461b1abd44bbc17102d1476d5240f2e597a942541849c8c438587fe4ed17fd"} build_url:https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/Yq16t2pIQSGR7KWreNKxJA/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-Non-PGO/sha512/4c2d7218c07cd3af7276a2bccb163c6745c6553570f96888351baab681ba6e0d7e4bcf2f3dd4cf28f94d3010c0c43413f790093bfab9dea55354400788ad749c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cab74de05956ea42973ccbb867507118e1355beafa6026a0a29de68b62b9f349acc81097bf0b41ba0be4dc0c0b8b1e0c791e3e7c3fb8b5aa6b4dfca7bcc7ff6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56f239d3cb79aacb2c1ca1154da5e5a40bc503fe99a39016d7bc82024c0adf2ef4461b1abd44bbc17102d1476d5240f2e597a942541849c8c438587fe4ed17fd"}' ========= master_lag: 0.32 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 04:33:19.206771) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:33:19.207099) ========= 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=cbe409c6de289db6ac707de3000001d4-1468235470.134756-345523349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004600 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:33:19.245715) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-07-11 04:33:19.245988) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-07-11 04:33:20.349132) ========= ========= Total master_lag: 86.70 =========