builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-041 starttime: 1468275545.17 results: success (0) buildid: 20160711135626 builduid: 2fd8c8a9b32d40b194e87be1e87c637a revision: 7eeec8b448489d9fc6ac6c11a01b7ba78ee56f9e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 15:19:05.172619) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 15:19:05.173144) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 15:19:05.173455) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 15:19:05.188381) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:19:05.188769) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 15:19:05-- 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% 46.0M=0s 2016-07-11 15:19:05 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096212 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:19:05.300117) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:19:05.300481) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023184 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:19:05.350653) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-11 15:19:05.351017) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7eeec8b448489d9fc6ac6c11a01b7ba78ee56f9e --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 7eeec8b448489d9fc6ac6c11a01b7ba78ee56f9e --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=8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 15:19:05,695 truncating revision to first 12 chars 2016-07-11 15:19:05,695 Setting DEBUG logging. 2016-07-11 15:19:05,695 attempt 1/10 2016-07-11 15:19:05,695 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7eeec8b44848?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 15:19:06,509 unpacking tar archive at: mozilla-central-7eeec8b44848/testing/mozharness/ program finished with exit code 0 elapsedTime=1.189135 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-11 15:19:06.554297) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 15:19:06.554648) ========= script_repo_revision: 7eeec8b448489d9fc6ac6c11a01b7ba78ee56f9e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 15:19:06.555109) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 15:19:06.555382) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 15:19:06.564313) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-11 15:19:06.564649) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:19:06 INFO - MultiFileLogger online at 20160711 15:19:06 in /builds/slave/test 15:19:06 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 15:19:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:19:06 INFO - {'append_to_log': False, 15:19:06 INFO - 'base_work_dir': '/builds/slave/test', 15:19:06 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:19:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:19:06 INFO - 'branch': 'Firefox-Non-PGO', 15:19:06 INFO - 'buildbot_json_path': 'buildprops.json', 15:19:06 INFO - 'config_files': ('talos/linux_config.py',), 15:19:06 INFO - 'default_actions': ('clobber', 15:19:06 INFO - 'read-buildbot-config', 15:19:06 INFO - 'download-and-extract', 15:19:06 INFO - 'populate-webroot', 15:19:06 INFO - 'create-virtualenv', 15:19:06 INFO - 'install', 15:19:06 INFO - 'run-tests'), 15:19:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:19:06 INFO - 'download_minidump_stackwalk': True, 15:19:06 INFO - 'download_symbols': 'ondemand', 15:19:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:19:06 INFO - 'tooltool.py': '/tools/tooltool.py', 15:19:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:19:06 INFO - '/tools/misc-python/virtualenv.py')}, 15:19:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:19:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:19:07 INFO - 'installer_path': 'installer.exe', 15:19:07 INFO - 'log_level': 'info', 15:19:07 INFO - 'log_name': 'talos', 15:19:07 INFO - 'log_to_console': True, 15:19:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:19:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:19:07 INFO - 'opt_config_files': (), 15:19:07 INFO - 'pip_index': False, 15:19:07 INFO - 'sps_profile': False, 15:19:07 INFO - 'sps_profile_interval': 0, 15:19:07 INFO - 'suite': 'dromaeojs-e10s', 15:19:07 INFO - 'system_bits': '32', 15:19:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:19:07 INFO - 'title': 'talos-linux64-ix-041', 15:19:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:19:07 INFO - 'use_talos_json': True, 15:19:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:19:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:19:07 INFO - 'work_dir': 'build'} 15:19:07 INFO - ##### 15:19:07 INFO - ##### Running clobber step. 15:19:07 INFO - ##### 15:19:07 INFO - Running pre-action listener: _resource_record_pre_action 15:19:07 INFO - Running main action method: clobber 15:19:07 INFO - rmtree: /builds/slave/test/build 15:19:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:19:07 INFO - Running post-action listener: _resource_record_post_action 15:19:07 INFO - ##### 15:19:07 INFO - ##### Finished clobber step (success) 15:19:07 INFO - ##### 15:19:07 INFO - ##### 15:19:07 INFO - ##### Running read-buildbot-config step. 15:19:07 INFO - ##### 15:19:07 INFO - Running pre-action listener: _resource_record_pre_action 15:19:07 INFO - Running main action method: read_buildbot_config 15:19:07 INFO - Using buildbot properties: 15:19:07 INFO - { 15:19:07 INFO - "project": "", 15:19:07 INFO - "product": "firefox", 15:19:07 INFO - "script_repo_revision": "production", 15:19:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:19:07 INFO - "repository": "", 15:19:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:19:07 INFO - "buildid": "20160711135626", 15:19:07 INFO - "pgo_build": "False", 15:19:07 INFO - "basedir": "/builds/slave/test", 15:19:07 INFO - "buildnumber": 379, 15:19:07 INFO - "slavename": "talos-linux64-ix-041", 15:19:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:19:07 INFO - "platform": "ubuntu64_hw", 15:19:07 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:19:07 INFO - "branch": "mozilla-central", 15:19:07 INFO - "repo_path": "mozilla-central", 15:19:07 INFO - "revision": "7eeec8b448489d9fc6ac6c11a01b7ba78ee56f9e", 15:19:07 INFO - "stage_platform": "linux64", 15:19:07 INFO - "builduid": "2fd8c8a9b32d40b194e87be1e87c637a", 15:19:07 INFO - "slavebuilddir": "test" 15:19:07 INFO - } 15:19:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/WXJTTgHKTi2JH2iR67V7IQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:19:07 INFO - Running post-action listener: _resource_record_post_action 15:19:07 INFO - ##### 15:19:07 INFO - ##### Finished read-buildbot-config step (success) 15:19:07 INFO - ##### 15:19:07 INFO - ##### 15:19:07 INFO - ##### Running download-and-extract step. 15:19:07 INFO - ##### 15:19:07 INFO - Running pre-action listener: _resource_record_pre_action 15:19:07 INFO - Running main action method: download_and_extract 15:19:07 INFO - mkdir: /builds/slave/test/build/tests 15:19:07 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')]} 15:19:07 INFO - https://queue.taskcluster.net/v1/task/WXJTTgHKTi2JH2iR67V7IQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:19:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WXJTTgHKTi2JH2iR67V7IQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:19:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WXJTTgHKTi2JH2iR67V7IQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:19:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WXJTTgHKTi2JH2iR67V7IQ/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 15:19:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WXJTTgHKTi2JH2iR67V7IQ/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 15:19:09 INFO - Downloaded 1361 bytes. 15:19:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:19:09 INFO - Using the following test package requirements: 15:19:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:19:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:19:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:19:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:19:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:19:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:19:09 INFO - u'jsshell-linux-x86_64.zip'], 15:19:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:19:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:19:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:19:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:19:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:19:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:19:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:19:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:19:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:19:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:19:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:19:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:09 INFO - https://queue.taskcluster.net/v1/task/WXJTTgHKTi2JH2iR67V7IQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:19:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WXJTTgHKTi2JH2iR67V7IQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:19:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WXJTTgHKTi2JH2iR67V7IQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:19:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WXJTTgHKTi2JH2iR67V7IQ/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 15:19:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WXJTTgHKTi2JH2iR67V7IQ/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 15:19:10 INFO - Downloaded 22737688 bytes. 15:19:10 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'] 15:19:10 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 15:19:11 INFO - Return code: 0 15:19:11 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 15:19:11 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')]} 15:19:11 INFO - https://queue.taskcluster.net/v1/task/WXJTTgHKTi2JH2iR67V7IQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:19:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WXJTTgHKTi2JH2iR67V7IQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:19:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WXJTTgHKTi2JH2iR67V7IQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:19:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WXJTTgHKTi2JH2iR67V7IQ/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 15:19:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WXJTTgHKTi2JH2iR67V7IQ/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 15:19:12 INFO - Downloaded 22737688 bytes. 15:19:12 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'] 15:19:12 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 15:19:13 INFO - Return code: 0 15:19: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')]} 15:19:13 INFO - https://queue.taskcluster.net/v1/task/WXJTTgHKTi2JH2iR67V7IQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:19:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WXJTTgHKTi2JH2iR67V7IQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:19:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WXJTTgHKTi2JH2iR67V7IQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:19:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WXJTTgHKTi2JH2iR67V7IQ/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 15:19:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WXJTTgHKTi2JH2iR67V7IQ/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 15:19:14 INFO - Downloaded 14403333 bytes. 15:19:14 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'] 15:19:14 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 15:19:15 INFO - Return code: 0 15:19:15 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')]} 15:19:15 INFO - https://queue.taskcluster.net/v1/task/WXJTTgHKTi2JH2iR67V7IQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:19:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WXJTTgHKTi2JH2iR67V7IQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:19:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WXJTTgHKTi2JH2iR67V7IQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:19:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WXJTTgHKTi2JH2iR67V7IQ/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 15:19:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WXJTTgHKTi2JH2iR67V7IQ/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 15:19:16 INFO - Downloaded 56650423 bytes. 15:19:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WXJTTgHKTi2JH2iR67V7IQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:19:16 INFO - mkdir: /builds/slave/test/properties 15:19:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:19:16 INFO - Writing to file /builds/slave/test/properties/build_url 15:19:16 INFO - Contents: 15:19:16 INFO - build_url:https://queue.taskcluster.net/v1/task/WXJTTgHKTi2JH2iR67V7IQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:19:17 INFO - Running post-action listener: _resource_record_post_action 15:19:17 INFO - Running post-action listener: set_extra_try_arguments 15:19:17 INFO - ##### 15:19:17 INFO - ##### Finished download-and-extract step (success) 15:19:17 INFO - ##### 15:19:17 INFO - ##### 15:19:17 INFO - ##### Running populate-webroot step. 15:19:17 INFO - ##### 15:19:17 INFO - Running pre-action listener: _resource_record_pre_action 15:19:17 INFO - Running main action method: populate_webroot 15:19:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:19:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:19:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:19:17 INFO - '--tppagecycles', 15:19:17 INFO - '7'], 15:19:17 INFO - 'tests': ['tsvgm']}}, 15:19:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:19:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:19:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:19:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:19:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:19:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:19:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:17 INFO - 'talos_options': ['--disable-e10s'], 15:19:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:19:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:19:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:17 INFO - 'talos_options': ['--disable-e10s'], 15:19:17 INFO - 'tests': ['damp', 'tps']}, 15:19:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:17 INFO - 'tests': ['damp', 'tps']}, 15:19:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:19:17 INFO - 'tests': ['dromaeo_dom']}, 15:19:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:19:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:19:17 INFO - 'tests': ['basic_compositor_video']}, 15:19:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:19:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:19:17 INFO - 'tests': ['a11yr', 15:19:17 INFO - 'ts_paint', 15:19:17 INFO - 'tpaint', 15:19:17 INFO - 'sessionrestore', 15:19:17 INFO - 'sessionrestore_no_auto_restore', 15:19:17 INFO - 'tabpaint']}, 15:19:17 INFO - 'other-e10s': {'tests': ['a11yr', 15:19:17 INFO - 'ts_paint', 15:19:17 INFO - 'tpaint', 15:19:17 INFO - 'sessionrestore', 15:19:17 INFO - 'sessionrestore_no_auto_restore', 15:19:17 INFO - 'tabpaint']}, 15:19:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:19:17 INFO - 'ts_paint', 15:19:17 INFO - 'tpaint', 15:19:17 INFO - 'sessionrestore', 15:19:17 INFO - 'sessionrestore_no_auto_restore', 15:19:17 INFO - 'tabpaint']}, 15:19:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:19:17 INFO - 'ts_paint', 15:19:17 INFO - 'tpaint', 15:19:17 INFO - 'sessionrestore', 15:19:17 INFO - 'sessionrestore_no_auto_restore', 15:19:17 INFO - 'tabpaint']}, 15:19:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:19:17 INFO - 'tests': ['a11yr', 15:19:17 INFO - 'ts_paint', 15:19:17 INFO - 'tpaint', 15:19:17 INFO - 'sessionrestore', 15:19:17 INFO - 'sessionrestore_no_auto_restore', 15:19:17 INFO - 'tabpaint']}, 15:19:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:19:17 INFO - 'tests': ['a11yr', 15:19:17 INFO - 'ts_paint', 15:19:17 INFO - 'tpaint', 15:19:17 INFO - 'sessionrestore', 15:19:17 INFO - 'sessionrestore_no_auto_restore', 15:19:17 INFO - 'tabpaint']}, 15:19:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:19:17 INFO - 'tests': ['tsvgx', 15:19:17 INFO - 'tsvgr_opacity', 15:19:17 INFO - 'tart', 15:19:17 INFO - 'tscrollx', 15:19:17 INFO - 'cart']}, 15:19:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:19:17 INFO - 'tsvgr_opacity', 15:19:17 INFO - 'tart', 15:19:17 INFO - 'tscrollx', 15:19:17 INFO - 'cart']}, 15:19:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:17 INFO - 'talos_options': ['--disable-e10s'], 15:19:17 INFO - 'tests': ['tp5o']}, 15:19:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:17 INFO - 'tests': ['tp5o']}, 15:19:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:17 INFO - 'talos_options': ['--disable-e10s', 15:19:17 INFO - '--xperf_path', 15:19:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:19:17 INFO - 'tests': ['tp5n']}, 15:19:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:17 INFO - 'talos_options': ['--xperf_path', 15:19:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:19:17 INFO - 'tests': ['tp5n']}}, 15:19:17 INFO - 'talos.zip': {'path': '', 15:19:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:19:17 INFO - Running post-action listener: _resource_record_post_action 15:19:17 INFO - ##### 15:19:17 INFO - ##### Finished populate-webroot step (success) 15:19:17 INFO - ##### 15:19:17 INFO - ##### 15:19:17 INFO - ##### Running create-virtualenv step. 15:19:17 INFO - ##### 15:19:17 INFO - Running pre-action listener: _resource_record_pre_action 15:19:17 INFO - Running main action method: create_virtualenv 15:19:17 INFO - Creating virtualenv /builds/slave/test/build/venv 15:19:17 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 15:19:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:19:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:19:17 INFO - Using real prefix '/usr' 15:19:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:19:17 INFO - Installing distribute.............................................................................................................................................................................................done. 15:19:19 INFO - Installing pip.................done. 15:19:19 INFO - Return code: 0 15:19:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:19 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 0x1455030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713570>, '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 0x1714470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1714900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208', '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 15:19:19 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 15:19:19 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 15:19:19 INFO - Using env: {'DISPLAY': ':0', 15:19:19 INFO - 'HOME': '/home/cltbld', 15:19:19 INFO - 'LANG': 'en_US.UTF-8', 15:19:19 INFO - 'LANGUAGE': 'en_US:en', 15:19:19 INFO - 'LOGNAME': 'cltbld', 15:19:19 INFO - 'MAIL': '/var/mail/cltbld', 15:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:19 INFO - 'MOZ_NO_REMOTE': '1', 15:19:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:19 INFO - 'NO_EM_RESTART': '1', 15:19:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:19 INFO - 'PWD': '/builds/slave/test', 15:19:19 INFO - 'SHELL': '/bin/bash', 15:19:19 INFO - 'SHLVL': '1', 15:19:19 INFO - 'TERM': 'linux', 15:19:19 INFO - 'TMOUT': '86400', 15:19:19 INFO - 'USER': 'cltbld', 15:19:19 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208', 15:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:19 INFO - '_': '/tools/buildbot/bin/python'} 15:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:20 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 15:19:20 INFO - Cleaning up... 15:19:20 INFO - Return code: 0 15:19:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:19: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')]} 15:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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')]} 15:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:20 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 0x1455030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713570>, '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 0x1714470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1714900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208', '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 15:19:20 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 15:19:20 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 15:19:20 INFO - Using env: {'DISPLAY': ':0', 15:19:20 INFO - 'HOME': '/home/cltbld', 15:19:20 INFO - 'LANG': 'en_US.UTF-8', 15:19:20 INFO - 'LANGUAGE': 'en_US:en', 15:19:20 INFO - 'LOGNAME': 'cltbld', 15:19:20 INFO - 'MAIL': '/var/mail/cltbld', 15:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:20 INFO - 'MOZ_NO_REMOTE': '1', 15:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:20 INFO - 'NO_EM_RESTART': '1', 15:19:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:20 INFO - 'PWD': '/builds/slave/test', 15:19:20 INFO - 'SHELL': '/bin/bash', 15:19:20 INFO - 'SHLVL': '1', 15:19:20 INFO - 'TERM': 'linux', 15:19:20 INFO - 'TMOUT': '86400', 15:19:20 INFO - 'USER': 'cltbld', 15:19:20 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208', 15:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:20 INFO - '_': '/tools/buildbot/bin/python'} 15:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:20 INFO - Downloading/unpacking psutil>=3.1.1 15:19:20 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 15:19:20 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 15:19:20 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 15:19:20 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 15:19:20 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 15:19:20 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 15:19:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:19:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:19:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:19:22 INFO - Installing collected packages: psutil 15:19:22 INFO - Running setup.py install for psutil 15:19:22 INFO - building 'psutil._psutil_linux' extension 15:19:22 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 15:19:22 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 15:19:22 INFO - building 'psutil._psutil_posix' extension 15:19:22 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 15:19:22 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 15:19:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:19:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:19:22 INFO - Successfully installed psutil 15:19:22 INFO - Cleaning up... 15:19:22 INFO - Return code: 0 15:19:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:19: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')]} 15:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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')]} 15:19:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:22 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 0x1455030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713570>, '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 0x1714470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1714900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208', '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 15:19:22 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 15:19:22 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 15:19:22 INFO - Using env: {'DISPLAY': ':0', 15:19:22 INFO - 'HOME': '/home/cltbld', 15:19:22 INFO - 'LANG': 'en_US.UTF-8', 15:19:22 INFO - 'LANGUAGE': 'en_US:en', 15:19:22 INFO - 'LOGNAME': 'cltbld', 15:19:22 INFO - 'MAIL': '/var/mail/cltbld', 15:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:22 INFO - 'MOZ_NO_REMOTE': '1', 15:19:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:22 INFO - 'NO_EM_RESTART': '1', 15:19:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:22 INFO - 'PWD': '/builds/slave/test', 15:19:22 INFO - 'SHELL': '/bin/bash', 15:19:22 INFO - 'SHLVL': '1', 15:19:22 INFO - 'TERM': 'linux', 15:19:22 INFO - 'TMOUT': '86400', 15:19:22 INFO - 'USER': 'cltbld', 15:19:22 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208', 15:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:22 INFO - '_': '/tools/buildbot/bin/python'} 15:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:19:23 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 15:19:23 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 15:19:23 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 15:19:23 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 15:19:23 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 15:19:23 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 15:19:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:19:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:19:25 INFO - Installing collected packages: mozsystemmonitor 15:19:25 INFO - Running setup.py install for mozsystemmonitor 15:19:25 INFO - Successfully installed mozsystemmonitor 15:19:25 INFO - Cleaning up... 15:19:25 INFO - Return code: 0 15:19:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1455030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713570>, '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 0x1714470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1714900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208', '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 15:19:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:19:25 INFO - Using env: {'DISPLAY': ':0', 15:19:25 INFO - 'HOME': '/home/cltbld', 15:19:25 INFO - 'LANG': 'en_US.UTF-8', 15:19:25 INFO - 'LANGUAGE': 'en_US:en', 15:19:25 INFO - 'LOGNAME': 'cltbld', 15:19:25 INFO - 'MAIL': '/var/mail/cltbld', 15:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:25 INFO - 'MOZ_NO_REMOTE': '1', 15:19:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:25 INFO - 'NO_EM_RESTART': '1', 15:19:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:25 INFO - 'PWD': '/builds/slave/test', 15:19:25 INFO - 'SHELL': '/bin/bash', 15:19:25 INFO - 'SHLVL': '1', 15:19:25 INFO - 'TERM': 'linux', 15:19:25 INFO - 'TMOUT': '86400', 15:19:25 INFO - 'USER': 'cltbld', 15:19:25 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208', 15:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:25 INFO - '_': '/tools/buildbot/bin/python'} 15:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:25 INFO - Downloading/unpacking jsonschema==2.5.1 15:19:25 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 15:19:25 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 15:19:25 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 15:19:25 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 15:19:25 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 15:19:25 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 15:19:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:19:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:19:27 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 15:19:27 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 15:19:27 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 15:19:27 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 15:19:27 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 15:19:27 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 15:19:27 INFO - Downloading functools32-3.2.3-2.tar.gz 15:19:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:19:27 INFO - warning: no files found matching '*.txt' 15:19:27 INFO - no previously-included directories found matching 'build' 15:19:27 INFO - no previously-included directories found matching 'dist' 15:19:27 INFO - no previously-included directories found matching '.git*' 15:19:27 INFO - Installing collected packages: jsonschema, functools32 15:19:27 INFO - Running setup.py install for functools32 15:19:27 INFO - warning: no files found matching '*.txt' 15:19:27 INFO - no previously-included directories found matching 'build' 15:19:27 INFO - no previously-included directories found matching 'dist' 15:19:27 INFO - no previously-included directories found matching '.git*' 15:19:27 INFO - Successfully installed jsonschema functools32 15:19:27 INFO - Cleaning up... 15:19:27 INFO - Return code: 0 15:19:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:27 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 0x1455030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713570>, '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 0x1714470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1714900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208', '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 15:19:27 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 15:19:27 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 15:19:27 INFO - Using env: {'DISPLAY': ':0', 15:19:27 INFO - 'HOME': '/home/cltbld', 15:19:27 INFO - 'LANG': 'en_US.UTF-8', 15:19:27 INFO - 'LANGUAGE': 'en_US:en', 15:19:27 INFO - 'LOGNAME': 'cltbld', 15:19:27 INFO - 'MAIL': '/var/mail/cltbld', 15:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:27 INFO - 'MOZ_NO_REMOTE': '1', 15:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:27 INFO - 'NO_EM_RESTART': '1', 15:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:27 INFO - 'PWD': '/builds/slave/test', 15:19:27 INFO - 'SHELL': '/bin/bash', 15:19:27 INFO - 'SHLVL': '1', 15:19:27 INFO - 'TERM': 'linux', 15:19:27 INFO - 'TMOUT': '86400', 15:19:27 INFO - 'USER': 'cltbld', 15:19:27 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208', 15:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:27 INFO - '_': '/tools/buildbot/bin/python'} 15:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:27 INFO - Downloading/unpacking blobuploader==1.2.4 15:19:27 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 15:19:27 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 15:19:27 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 15:19:27 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 15:19:27 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 15:19:27 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 15:19:29 INFO - Downloading blobuploader-1.2.4.tar.gz 15:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:19:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:19:30 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 15:19:30 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 15:19:30 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 15:19:30 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 15:19:30 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 15:19:30 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 15:19:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:19:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:19:30 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 15:19:30 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 15:19:30 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 15:19:30 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 15:19:30 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 15:19:30 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 15:19:30 INFO - Downloading docopt-0.6.1.tar.gz 15:19:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:19:30 INFO - Installing collected packages: blobuploader, requests, docopt 15:19:30 INFO - Running setup.py install for blobuploader 15:19:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:19:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:19:30 INFO - Running setup.py install for requests 15:19:31 INFO - Running setup.py install for docopt 15:19:31 INFO - Successfully installed blobuploader requests docopt 15:19:31 INFO - Cleaning up... 15:19:31 INFO - Return code: 0 15:19:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:19: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')]} 15:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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')]} 15:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:31 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 0x1455030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713570>, '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 0x1714470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1714900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208', '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 15:19:31 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 15:19:31 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 15:19:31 INFO - Using env: {'DISPLAY': ':0', 15:19:31 INFO - 'HOME': '/home/cltbld', 15:19:31 INFO - 'LANG': 'en_US.UTF-8', 15:19:31 INFO - 'LANGUAGE': 'en_US:en', 15:19:31 INFO - 'LOGNAME': 'cltbld', 15:19:31 INFO - 'MAIL': '/var/mail/cltbld', 15:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:31 INFO - 'MOZ_NO_REMOTE': '1', 15:19:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:31 INFO - 'NO_EM_RESTART': '1', 15:19:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:31 INFO - 'PWD': '/builds/slave/test', 15:19:31 INFO - 'SHELL': '/bin/bash', 15:19:31 INFO - 'SHLVL': '1', 15:19:31 INFO - 'TERM': 'linux', 15:19:31 INFO - 'TMOUT': '86400', 15:19:31 INFO - 'USER': 'cltbld', 15:19:31 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208', 15:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:31 INFO - '_': '/tools/buildbot/bin/python'} 15:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:19:31 INFO - Running setup.py (path:/tmp/pip-c9i3rl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:19:31 INFO - Running setup.py (path:/tmp/pip-YKmOUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:19:31 INFO - Running setup.py (path:/tmp/pip-bNfK6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:19:31 INFO - Running setup.py (path:/tmp/pip-SgXrK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:19:31 INFO - Running setup.py (path:/tmp/pip-4g8m0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:19:31 INFO - Running setup.py (path:/tmp/pip-J5CTtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:19:31 INFO - Running setup.py (path:/tmp/pip-4r_dy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:19:32 INFO - Running setup.py (path:/tmp/pip-xOckWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:19:32 INFO - Running setup.py (path:/tmp/pip-R3aZ73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:19:32 INFO - Running setup.py (path:/tmp/pip-Pc8Kdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:19:32 INFO - Running setup.py (path:/tmp/pip-AjswWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:19:32 INFO - Running setup.py (path:/tmp/pip-WneewF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:19:32 INFO - Running setup.py (path:/tmp/pip-NHL3nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:19:32 INFO - Running setup.py (path:/tmp/pip-nxwMxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:32 INFO - Running setup.py (path:/tmp/pip-QqKB8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:19:32 INFO - Running setup.py (path:/tmp/pip-LNNjMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:19:32 INFO - Running setup.py (path:/tmp/pip-PVH4IX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:19:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:19:32 INFO - Running setup.py install for manifestparser 15:19:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:19:32 INFO - Running setup.py install for mozcrash 15:19:32 INFO - Running setup.py install for mozdebug 15:19:33 INFO - Running setup.py install for mozdevice 15:19:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:19:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:19:33 INFO - Running setup.py install for mozfile 15:19:33 INFO - Running setup.py install for mozhttpd 15:19:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:19:33 INFO - Running setup.py install for mozinfo 15:19:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:19:33 INFO - Running setup.py install for mozInstall 15:19:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:19:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:19:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:19:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:19:33 INFO - Running setup.py install for mozleak 15:19:33 INFO - Running setup.py install for mozlog 15:19:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:19:33 INFO - Running setup.py install for moznetwork 15:19:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:19:33 INFO - Running setup.py install for mozprocess 15:19:33 INFO - Running setup.py install for mozprofile 15:19:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:19:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:19:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:19:34 INFO - Running setup.py install for mozrunner 15:19:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:19:34 INFO - Running setup.py install for mozscreenshot 15:19:34 INFO - Running setup.py install for moztest 15:19:34 INFO - Running setup.py install for mozversion 15:19:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:19:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:19:34 INFO - Cleaning up... 15:19:34 INFO - Return code: 0 15:19:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:19:34 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')]} 15:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:34 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')]} 15:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:34 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 0x1455030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713570>, '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 0x1714470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1714900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208', '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 15:19:34 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 15:19:34 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 15:19:34 INFO - Using env: {'DISPLAY': ':0', 15:19:34 INFO - 'HOME': '/home/cltbld', 15:19:34 INFO - 'LANG': 'en_US.UTF-8', 15:19:34 INFO - 'LANGUAGE': 'en_US:en', 15:19:34 INFO - 'LOGNAME': 'cltbld', 15:19:34 INFO - 'MAIL': '/var/mail/cltbld', 15:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:34 INFO - 'MOZ_NO_REMOTE': '1', 15:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:34 INFO - 'NO_EM_RESTART': '1', 15:19:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:34 INFO - 'PWD': '/builds/slave/test', 15:19:34 INFO - 'SHELL': '/bin/bash', 15:19:34 INFO - 'SHLVL': '1', 15:19:34 INFO - 'TERM': 'linux', 15:19:34 INFO - 'TMOUT': '86400', 15:19:34 INFO - 'USER': 'cltbld', 15:19:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208', 15:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:34 INFO - '_': '/tools/buildbot/bin/python'} 15:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:19:34 INFO - Running setup.py (path:/tmp/pip-9ciiM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:19:34 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)) 15:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:19:34 INFO - Running setup.py (path:/tmp/pip-yyBdLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:19:34 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)) 15:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:19:34 INFO - Running setup.py (path:/tmp/pip-sAV0RU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:19:35 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)) 15:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:19:35 INFO - Running setup.py (path:/tmp/pip-rmuaKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:19:35 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)) 15:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:19:35 INFO - Running setup.py (path:/tmp/pip-9TarV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:19:35 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)) 15:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:19:35 INFO - Running setup.py (path:/tmp/pip-5u1Cad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:19:35 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)) 15:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:19:35 INFO - Running setup.py (path:/tmp/pip-fXFxNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:19:35 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)) 15:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:19:35 INFO - Running setup.py (path:/tmp/pip-r8zaKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:19:35 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)) 15:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:19:35 INFO - Running setup.py (path:/tmp/pip-V0zFG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:19:35 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)) 15:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:19:35 INFO - Running setup.py (path:/tmp/pip-utWpsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:19:35 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)) 15:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:19:35 INFO - Running setup.py (path:/tmp/pip-eNqvPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:19:35 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)) 15:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:19:35 INFO - Running setup.py (path:/tmp/pip-cCyu0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:19:35 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)) 15:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:19:35 INFO - Running setup.py (path:/tmp/pip-NoiV4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:19:35 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)) 15:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:19:35 INFO - Running setup.py (path:/tmp/pip-Pj6FG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:19:35 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)) 15:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:35 INFO - Running setup.py (path:/tmp/pip-7tv_wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:35 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)) 15:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:19:35 INFO - Running setup.py (path:/tmp/pip-PGnQsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:19:35 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)) 15:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:19:35 INFO - Running setup.py (path:/tmp/pip-XIsCnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:19:36 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)) 15:19:36 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)) 15:19:36 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)) 15:19:36 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)) 15:19:36 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)) 15:19:36 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)) 15:19:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:37 INFO - Downloading blessings-1.6.tar.gz 15:19:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:19:38 INFO - Installing collected packages: blessings 15:19:38 INFO - Running setup.py install for blessings 15:19:38 INFO - Successfully installed blessings 15:19:38 INFO - Cleaning up... 15:19:38 INFO - Return code: 0 15:19:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:19:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:19:38 INFO - Reading from file tmpfile_stdout 15:19:38 INFO - Current package versions: 15:19:38 INFO - argparse == 1.2.1 15:19:38 INFO - blessings == 1.6 15:19:38 INFO - blobuploader == 1.2.4 15:19:38 INFO - docopt == 0.6.1 15:19:38 INFO - functools32 == 3.2.3-2 15:19:38 INFO - jsonschema == 2.5.1 15:19:38 INFO - manifestparser == 1.1 15:19:38 INFO - mozInstall == 1.12 15:19:38 INFO - mozcrash == 0.17 15:19:38 INFO - mozdebug == 0.1 15:19:38 INFO - mozdevice == 0.48 15:19:38 INFO - mozfile == 1.2 15:19:38 INFO - mozhttpd == 0.7 15:19:38 INFO - mozinfo == 0.9 15:19:38 INFO - mozleak == 0.1 15:19:38 INFO - mozlog == 3.2 15:19:38 INFO - moznetwork == 0.27 15:19:38 INFO - mozprocess == 0.23 15:19:38 INFO - mozprofile == 0.28 15:19:38 INFO - mozrunner == 6.12 15:19:38 INFO - mozscreenshot == 0.1 15:19:38 INFO - mozsystemmonitor == 0.3 15:19:38 INFO - moztest == 0.7 15:19:38 INFO - mozversion == 1.4 15:19:38 INFO - psutil == 3.1.1 15:19:38 INFO - requests == 1.2.3 15:19:38 INFO - wsgiref == 0.1.2 15:19:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:38 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 0x1455030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713570>, '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 0x1714470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1714900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208', '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 15:19:38 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 15:19:38 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 15:19:38 INFO - Using env: {'DISPLAY': ':0', 15:19:38 INFO - 'HOME': '/home/cltbld', 15:19:38 INFO - 'LANG': 'en_US.UTF-8', 15:19:38 INFO - 'LANGUAGE': 'en_US:en', 15:19:38 INFO - 'LOGNAME': 'cltbld', 15:19:38 INFO - 'MAIL': '/var/mail/cltbld', 15:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:38 INFO - 'MOZ_NO_REMOTE': '1', 15:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:38 INFO - 'NO_EM_RESTART': '1', 15:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:38 INFO - 'PWD': '/builds/slave/test', 15:19:38 INFO - 'SHELL': '/bin/bash', 15:19:38 INFO - 'SHLVL': '1', 15:19:38 INFO - 'TERM': 'linux', 15:19:38 INFO - 'TMOUT': '86400', 15:19:38 INFO - 'USER': 'cltbld', 15:19:38 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208', 15:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:38 INFO - '_': '/tools/buildbot/bin/python'} 15:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:38 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)) 15:19:38 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)) 15:19:38 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)) 15:19:38 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)) 15:19:38 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)) 15:19:38 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)) 15:19:38 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)) 15:19:38 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)) 15:19:38 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)) 15:19:38 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)) 15:19:38 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)) 15:19:38 INFO - Cleaning up... 15:19:38 INFO - Return code: 0 15:19:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1455030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713570>, '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 0x1714470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1714900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208', '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 15:19:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:19:38 INFO - Using env: {'DISPLAY': ':0', 15:19:38 INFO - 'HOME': '/home/cltbld', 15:19:38 INFO - 'LANG': 'en_US.UTF-8', 15:19:38 INFO - 'LANGUAGE': 'en_US:en', 15:19:38 INFO - 'LOGNAME': 'cltbld', 15:19:38 INFO - 'MAIL': '/var/mail/cltbld', 15:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:38 INFO - 'MOZ_NO_REMOTE': '1', 15:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:38 INFO - 'NO_EM_RESTART': '1', 15:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:38 INFO - 'PWD': '/builds/slave/test', 15:19:38 INFO - 'SHELL': '/bin/bash', 15:19:38 INFO - 'SHLVL': '1', 15:19:38 INFO - 'TERM': 'linux', 15:19:38 INFO - 'TMOUT': '86400', 15:19:38 INFO - 'USER': 'cltbld', 15:19:38 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208', 15:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:38 INFO - '_': '/tools/buildbot/bin/python'} 15:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:19:38 INFO - Cleaning up... 15:19:38 INFO - Return code: 0 15:19:38 INFO - Running post-action listener: _resource_record_post_action 15:19:38 INFO - Running post-action listener: _start_resource_monitoring 15:19:38 INFO - Starting resource monitoring. 15:19:38 INFO - ##### 15:19:38 INFO - ##### Finished create-virtualenv step (success) 15:19:38 INFO - ##### 15:19:38 INFO - ##### 15:19:38 INFO - ##### Running install step. 15:19:38 INFO - ##### 15:19:38 INFO - Running pre-action listener: _resource_record_pre_action 15:19:38 INFO - Running main action method: install 15:19:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:19:39 INFO - Reading from file tmpfile_stdout 15:19:39 INFO - Detecting whether we're running mozinstall >=1.0... 15:19:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:19:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:19:39 INFO - Reading from file tmpfile_stdout 15:19:39 INFO - Output received: 15:19:39 INFO - Usage: mozinstall [options] installer 15:19:39 INFO - Options: 15:19:39 INFO - -h, --help show this help message and exit 15:19:39 INFO - -d DEST, --destination=DEST 15:19:39 INFO - Directory to install application into. [default: 15:19:39 INFO - "/builds/slave/test"] 15:19:39 INFO - --app=APP Application being installed. [default: firefox] 15:19:39 INFO - mkdir: /builds/slave/test/build/application 15:19:39 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'] 15:19:39 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 15:19:55 INFO - Reading from file tmpfile_stdout 15:19:55 INFO - Output received: 15:19:55 INFO - /builds/slave/test/build/application/firefox/firefox 15:19:55 INFO - Running post-action listener: _resource_record_post_action 15:19:55 INFO - ##### 15:19:55 INFO - ##### Finished install step (success) 15:19:55 INFO - ##### 15:19:55 INFO - ##### 15:19:55 INFO - ##### Running run-tests step. 15:19:55 INFO - ##### 15:19:55 INFO - Running pre-action listener: _resource_record_pre_action 15:19:55 INFO - Running main action method: run_tests 15:19:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:19:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:19:55 INFO - Python 2.7.3 15:19:55 INFO - Return code: 0 15:19:55 INFO - grabbing minidump binary from tooltool 15:19:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:55 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 0x1713570>, '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 0x1714470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1714900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:19:55 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 15:19:55 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 15:19:55 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 15:19:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:19:55 INFO - Return code: 0 15:19:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:19:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:19:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:19:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:19:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:19:55 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/WXJTTgHKTi2JH2iR67V7IQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 15:19:55 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/WXJTTgHKTi2JH2iR67V7IQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 15:19:55 INFO - Using env: {'DISPLAY': ':0', 15:19:55 INFO - 'HOME': '/home/cltbld', 15:19:55 INFO - 'LANG': 'en_US.UTF-8', 15:19:55 INFO - 'LANGUAGE': 'en_US:en', 15:19:55 INFO - 'LOGNAME': 'cltbld', 15:19:55 INFO - 'MAIL': '/var/mail/cltbld', 15:19:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:19:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:55 INFO - 'MOZ_NO_REMOTE': '1', 15:19:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:55 INFO - 'NO_EM_RESTART': '1', 15:19:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:55 INFO - 'PWD': '/builds/slave/test', 15:19:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:19:55 INFO - 'SHELL': '/bin/bash', 15:19:55 INFO - 'SHLVL': '1', 15:19:55 INFO - 'TERM': 'linux', 15:19:55 INFO - 'TMOUT': '86400', 15:19:55 INFO - 'USER': 'cltbld', 15:19:55 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208', 15:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:55 INFO - '_': '/tools/buildbot/bin/python'} 15:19:55 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/WXJTTgHKTi2JH2iR67V7IQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 15:19:55 INFO - mozversion application_buildid: 20160711135626 15:19:55 INFO - mozversion application_changeset: 7eeec8b448489d9fc6ac6c11a01b7ba78ee56f9e 15:19:55 INFO - mozversion application_display_name: Nightly 15:19:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:19:55 INFO - mozversion application_name: Firefox 15:19:55 INFO - mozversion application_remotingname: firefox 15:19:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:19:55 INFO - mozversion application_vendor: Mozilla 15:19:55 INFO - mozversion application_version: 50.0a1 15:19:55 INFO - mozversion platform_buildid: 20160711135626 15:19:55 INFO - mozversion platform_changeset: 7eeec8b448489d9fc6ac6c11a01b7ba78ee56f9e 15:19:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:19:55 INFO - mozversion platform_version: 50.0a1 15:19:55 INFO - using testdate: 1468275595 15:19:55 INFO - actual date: 1468275595 15:19:55 INFO - starting webserver on 'localhost:57641' 15:19:55 INFO - SUITE-START | Running 2 tests 15:19:55 INFO - TEST-START | dromaeo_css 15:19:55 INFO - operating with platform_type : linux_ 15:19:55 INFO - Initialising browser for dromaeo_css test... 15:19:55 INFO - TEST-INFO | started process 20880 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp20u2Xr/profile http://localhost:57641/getInfo.html) 15:20:00 INFO - PROCESS | 20880 | __metrics Screen width/height:1600/1200 15:20:00 INFO - PROCESS | 20880 | colorDepth:24 15:20:00 INFO - PROCESS | 20880 | Browser inner width/height: 1024/697 15:20:00 INFO - PROCESS | 20880 | __metrics 15:20:01 ERROR - PROCESS | 20880 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 15:20:02 INFO - TEST-INFO | 20880: exit 0 15:20:02 INFO - Browser initialized. 15:20:02 INFO - Running cycle 1/1 for dromaeo_css test... 15:20:02 INFO - TEST-INFO | started process 20998 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp20u2Xr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:20:14 INFO - PROCESS | 20998 | RSS: Main: 168386560 15:20:14 INFO - PROCESS | 20998 | 15:21:03 INFO - PROCESS | 20998 | 1468275663755 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] 15:23:15 INFO - PROCESS | 20998 | Cycle 1(1): loaded http://localhost:57641/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57641/tests/dromaeo/cssquery-ext.html) 15:23:16 INFO - PROCESS | 20998 | RSS: Main: 168865792 15:23:16 INFO - PROCESS | 20998 | 15:26:18 INFO - PROCESS | 20998 | Cycle 1(1): loaded http://localhost:57641/tests/dromaeo/cssquery-ext.html (next: http://localhost:57641/tests/dromaeo/cssquery-jquery.html) 15:26:19 INFO - PROCESS | 20998 | RSS: Main: 168894464 15:26:19 INFO - PROCESS | 20998 | 15:29:21 INFO - PROCESS | 20998 | Cycle 1(1): loaded http://localhost:57641/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57641/tests/dromaeo/cssquery-mootools.html) 15:29:21 INFO - PROCESS | 20998 | RSS: Main: 171630592 15:29:21 INFO - PROCESS | 20998 | 15:32:23 INFO - PROCESS | 20998 | Cycle 1(1): loaded http://localhost:57641/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57641/tests/dromaeo/cssquery-prototype.html) 15:32:24 INFO - PROCESS | 20998 | RSS: Main: 167354368 15:32:24 INFO - PROCESS | 20998 | 15:35:27 INFO - PROCESS | 20998 | Cycle 1(1): loaded http://localhost:57641/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57641/tests/dromaeo/cssquery-yui.html) 15:35:27 INFO - PROCESS | 20998 | RSS: Main: 168779776 15:35:27 INFO - PROCESS | 20998 | 15:38:30 INFO - PROCESS | 20998 | Cycle 1(1): loaded http://localhost:57641/tests/dromaeo/cssquery-yui.html (next: http://localhost:57641/tests/dromaeo/cssquery-dojo.html) 15:38:30 INFO - PROCESS | 20998 | RSS: Main: 169558016 15:38:30 INFO - PROCESS | 20998 | 15:38:30 INFO - PROCESS | 20998 | __start_tp_report 15:38:30 INFO - PROCESS | 20998 | _x_x_mozilla_page_load 15:38:30 INFO - PROCESS | 20998 | _x_x_mozilla_page_load_details 15:38:30 INFO - PROCESS | 20998 | |i|pagename|runs| 15:38:30 INFO - PROCESS | 20998 | |0;dojo.html;2632.921012369629;2684.5704687250036;2688.354794849237;2723.27833124222;2724.7139050399705;4893.584045356145;4896.0697467481195;4970.055689419008;4984.800607975677;4986.451490336065;4736.147493451177;4783.067301876135;4812.518748125194;4847.12751704693;4858.659893807426;4419.4033805436175;4532.206863798839;4550.112728018038;4576.084783043405;4614.054118905617;4581.106684196583;4650.348951146842;4650.906981860361;4656.674032817704;4661.997670500841;58.750882145377595;4584.908301833978;4591.6556258280425;4622.8150873965005;4631.745254011028;4562.247229207177;4564.224081906051;4568.634509239253;4590.816367345302;4601.378813860119;4514.774261286955;4531.43357080365;4541.931871021938;4543.86368408945;4574.817007319703;4711.976440117812;4801.423829140491;4861;4865.343178670905;4940.851774446773;5206.557442617382;5229.660072095302;5233.712145831978;5235.110031294689;5235.659682120688;5267.710275934822;5271.815486457956;5278.736063196825;5301.0723123453245;5314.441983591744;4870.975645121787;4949.579285760715;5025.547700706918;5045.192769156917;5056.595472362203;5495.752691128909;5498.972505137449;5525.861853453695;5531.976584331912;5546.805861794818;4960.479149689303;5267.104592219332;5274.789008439696;5301.257823904656;5301.496357845998;5100.209467532539;5173.896522069537;5179.2749015137915;5238.633295669343;5270.183121616155;5211.661242019332;5219.817306394258;5223.059849227176;5227.372715274191;5227.555657769056;5160.09698302803;5216.58267338612;5217.243499692523;5247.291615631841;5263.184206448007;4404.427424434803;4426.667999900021;4495.550444955478;4498.2577874650315;4514.480834704051;3893.377059670439;3895.6883449323986;3909.58949310324;3952.4664170336637;3962.6037396260144;4367.10474352757;4491.326301054868;4501.7974191161475;4513.571210734975;4560.042391097841;5205.7917683293;5286.682799032071;5322.148456246982;5327.360716713942;5327.920081198785;4480.305552639346;4507.076049409863;4507.3915021471685;4518.774061296922;4552;4571.977140114278;4661.394018777537;4772.928406073912;4800.3759511263315;4843.806247750121;4844.2007068833245;4886.413630364379;4947.060058588857;4975.601951843916;4975.975120124376;5361.490658387447;5370.785168593369;5384.6230763847725;5384.784608615611;5397.163439666858;4786.6410019248;4963.354763880817;4972.627052970969;4981.676191047715;4988.875278117931;5119.539241468286;5183.688978661293;5205.869853253699;5222.3733152022005;5251.501107394792;5245.606579506476;5251.606129540223;5287.286216360742;5287.550558202596;5309.681419114865;5003.249512573143;5142.408623008402;5156.587473002226;5162.406323272721;5169.457206993212;5214.243934629533;5234.790608375774;5240.633155679066;5265.921011184912;5268.81559145428;5151.484851514819;5166.922496162636;5186.844394668166;5203.635745497779;5245.6852588844795;5034.949650503595;5182.6113041521285;5224.216367544746;5238.580913526833;5301.3373328333955;5060.266261392004;5085.338905942352;5108.131617624938;5115.974420127875;5135.204043373283 15:38:30 INFO - PROCESS | 20998 | |1;ext.html;531.2217601214223;557.0752550765728;559.3902646115733;570.7203470299553;596.3023262782549;34908.4763728544;39003.80498097509;39020.609793902055;39038.219235615274;39061.21877562447;39508.604913950854;40017.199656006866;40107;40158;40203.59796402035;7742.109657389402;7915.208479152067;7937.404694647925;7947.880781788278;7965.283124518792;7853.882191767099;7882.60586970652;7927.3658107351275;7947.364210863146;7951.284384405402;7953.562554059525;7982.760517184464;7997.160298168696;8005.6797728090805;8010.198980102002;7860.371170306362;7887.881681774778;7904.920950790476;7926.80182995424;7939.444238903279;7858.09631892334;7926.326262267714;7926.643301051467;7933.523988560705;7935.484193527403;37602;37815.24369512622;37938.24123517514;37946.241075178616;37986.240275194345;3022.2444388902773;3184.9203769905707;3198.8720451182157;3270.1824543864036;3440.552728145325;29024.41951160986;29362.706372936213;30070.24824379386;30110.849445752632;30720.69279307201;3445.586529616462;3449.844756985942;3482.320947415255;3502.807345595991;3601.45978103284;276483;278507;278596;278960;279882;31906.680933190833;33148.50277245843;52726.89092436336;53315;53490.465095349326;33896.830515847265;33988;34038.48942265868;34111.488327675106;34153.829230853684;11876.94061529704;11993;12001.579944701894;12004.639860804189;12019;10614.097801686788;10710.08964238033;10716.571337146583;10724.731881702864;10726.517306721216;7870.881936770953;7913.406494512935;7949.562774047483;8000.079990801132;8050.919490805134;3031.7726170536857;3060.6633270340244;3069.0946170879643;3106.0681795461273;3115.7818952673097;857.6140736668524;871.2115535440437;886.964521419136;919.5540163020929;976.4043933200742;28342.433151336856;28470.71529284722;28567.142985710463;28942.42115157685;29067.982620608178;906.8141031088611;985.1281615769952;990.9207263418909;1004.4626125023077;1024.5031159887449;14680.92659536717;14827.77758333626;15394.846051539565;15870.285837137357;16208.51374458768;384176;384754;385618;387603;387729;50322;50417.24374134391;50606.49393506091;50946;51519;1188.4324595534395;1212.2484059882752;1240.1814802230665;1252.4489224741085;1253.5800506830133;28102;29308.413831723672;29383.706162938954;29396.706032940252;29694.851525742233;42236.78881605572;43115.56884431116;43116;43155.136897262506;43212.35181472218;349135;352765;353506;353518;354882;24642.753572464047;24661.50676986486;24714.876425617756;24774;24975.500489990463;40045;40747.1850562993;40885.1822963545;41647.37528937129;41707.7914610425;35927.10182245465;35997;36062;36170.4574431389;36509.26981460409;36094.45858312075;36217.45673814948;36257.45613815848;36362.63637363698;36496;34800.129996750285;35719;35811.64188358187;36019.279614408086;36090.09774755547;30774.53838192384;31921.460303847;32712.83643581767;32767.508487373187;32788.83605581957;24735;25106.49787004213;25325.746742533076;25571.36071598225;25574.104906328932 15:38:30 INFO - PROCESS | 20998 | |2;jquery.html;366.2162971241542;368.362732472822;371.2723062796917;383.558907256655;388.30687223306404;16674.249658765355;16711.247993840276;17357.30570777169;17786.46640600784;17897.91051044743;18033.549161270974;18480;19039.143238554265;19062.809371906278;19819.306324278652;5800.216970708942;6033.758649654009;6105.755769769226;6123.969380153093;6140.232470941132;5870.970645146768;5932.3474417814;6083.543734219929;6110.96944515279;6114.938850611481;6014.699265036753;6053.818385448443;6068.059450785136;6078.027515597505;6082;6049.697515124226;6097.115918191859;6102.298235702907;6104.481119104881;6112.51099912006;5666.206731057655;5869.706514674292;5887.381824908366;5910.940890591082;5928.525717942554;24175;24285.150019749224;24798.628020579526;25384.873075634503;25413.11054113116;1865.1606776950428;1977.7626684797772;2083.812456878888;2316.2009106858277;2349.306954448442;14755.483558075523;15002.174880381575;15029.248537573187;15062.720064973271;15688.76466852998;1815.8638102142393;1857.1735577667944;1882.8023057578894;1935.6709359408935;1958.2950137950327;61605.691971540306;77566.61216693881;82728;84329.15670843335;86449;15854.274245552286;16830.579235518966;16893.493195204162;17196.82803171977;17253.654926901643;29158.562621560694;29329.85335073311;29462.11613651594;29470.263243419085;29689.703102969124;8723.60743766532;9213.63145474187;9349.439033658002;9479.857802132974;9525.19035881944;7417.740379086706;7429.328401109707;7429.9257007430315;7554.206808285051;7860.096088949729;8280.461769984931;8421.873671894926;8542.18849209324;8640.019193378275;8673.956630216808;3168.7855152646925;3175.539546765706;3317.6018877734828;3378.7465940054594;3577.266660334625;862.9525376104375;870.3385427075468;931.8322701913721;933.5892207428709;941.449252187478;17094.40169594058;17527.298908043536;17567.82432175662;17700.734488982675;18156.909215453838;821.9095899451175;853.7481442974338;856.092541905582;858.6994551906907;925.8611208318806;9719.514024298756;9719.708408747749;10089.899101009043;10437.843432348522;10451.68644940653;389761;390957;392705;393851;397726;58555;58875.82248355009;82909;83346;85591.57204214063;939.4410325856105;953.5137080089204;954.5561313989028;973.2165606686685;976.5703090640237;16294.944043177822;16316.184190790176;16643.916780416504;16725.41461048906;16924.238409271366;37497;37794.43308350432;37994.62005379911;38676.41985370166;38761;47410;50157.52303121143;51844.740776295876;52967.47032529626;53958;7454.776356709307;7536.171021187555;7570.772876813704;7617.5048621839405;7675.155732869268;9824.705258841961;10952.507137178687;11041.282316649393;11427.60003399877;11559.768804623693;9735.951320243354;9887.258455615714;10170.949145254226;10361.222908281758;10428.27002109845;10072.949635251776;10281.897181028393;10357.119644830274;10359.896401035892;10414.114800242065;9793.167580755715;9797.579350994209;10095.29332946716;10295.227857910537;10546.841797372892;7552.6223688816435;7596.924030759622;7632.427567932538;7638.197989211053;7839.02012248469;8696.869546956927;9236.445813251226;9993.450360229966;10049.14582260516;10088.344257623232 15:38:30 INFO - PROCESS | 20998 | |3;mootools.html;1366.043769361447;1408.760510713179;1483.8961272710908;1671.0976072920623;1696.1519240379803;6416.486681065515;7169.784906452808;7170.8565828683395;7638;7664.92335076649;7171.103612048494;7364.74223402181;7425.702971881118;7437.628118594076;7455.142658594264;2122.129926730037;2170.294654237371;2173.9891300543554;2178.172294528077;2179.2372669565602;2196.2971849008322;2206.878621675807;2207.4922767763424;2216.423729830248;2217.412385717786;2197.626403511399;2202.8347873909443;2204.3386983904843;2208.547247814194;2217.84475086744;2141.2077531313357;2144.0351841671154;2145.7854214578574;2148.591767564166;2153.6231159547174;2055.486128467883;2107.3888572314163;2109.95780084399;2116.947076323089;2117.4177101297114;7597.620118994028;7673.577953212571;7683.923160768377;7684.385249180108;7689.769306920745;4383;4479.193745125876;4509.098180363908;4520.073384956077;4543.886402839922;2810.901618443345;2848.4587928293763;2882.798204125712;2910.607068045808;2938.0598208573265;897.8024834536392;914.2000749344323;918;933.7245512573807;935.1910597333326;9880.160186384166;9897.802043959153;9914.206863450907;9915.157211637092;10010.699679009642;3930.0567863712504;4066.2477441673386;4144.834206631701;4162.146759914211;4170.874873753793;8443.113473085361;8500.787480313042;8501.787455313666;8503.107173746792;8510.361722870686;4559.840405585788;4568.657350698711;4578.473475550354;4586.403767510203;4587.288970209623;3384.8984530464127;4014.437978682987;4137.420761093449;4171.770552619635;4200.327947528381;3515.771474854126;3548.775672393072;3638.0904773806546;3648.5986541480415;3666.5416822897137;1137.8748337682848;1172.1209093180114;1181.1141643767176;1184.0527577937617;1197.8502687164105;813.1543195077054;823.1957387514672;830.8089139497829;869.2177040663454;870.0864092702764;4910.852674419773;5053.823116190915;5062.772175252123;5068.6451948364;5134.794608215704;412.67811107336325;419.49241417884093;429.628371458686;431.34866351808995;432.0322477650104;3433.124553238958;3442.208292092833;3465.306938612237;3477.009052420048;3530.417481115587;8755.649774009096;8940.32947528938;9063.637454501746;9092.954535227282;9113.134252246158;8887.200151986352;8976.730698079067;8979.14698103679;8982.371234013686;8984.101589841095;6958.199807022156;6961.65191740411;7015;7029.9648501757165;7035.085438892911;4846.684965477232;4883.892003658237;4926.975365123295;4970.95609921906;5023.8492845214705;8268.131846156068;8377.204165604258;8449.915500844912;8560.315174785877;8581.184787445183;8408.747737567883;8475.872861907199;8482.872756908528;8528.317734581342;8612.440191387539;5648.15277708347;6131.570790044654;6342.334054924351;6386.042093685985;6388.265349484869;7027.789166325018;7095.538789978635;7100.325469080429;7145.64271786419;7160.427165826617;6367.681615919093;6391.616503009835;6529.412352888263;6533.705983230671;6605.47156227491;6382.521310901794;6495.610263384212;6505.967470162619;6627.768028118992;6639.933600664125;5695.145728140812;5808.39011903744;5815.621984570989;5822.883542329215;5840.2991641003355;3908.1206728487;3962.0689138051957;4057.0871553901316;4071.5114186297833;4144.917101657889;4400.889977750582;4428.844990425319;4458.24209884327;4476.512005417604;4550.408446901882 15:38:30 INFO - PROCESS | 20998 | |4;prototype.html;289.20468711044623;292.5494738103321;296.4116229284869;302.94092651932857;305.4974566837551;5111.795528178873;5161.690298582088;5163.664361816484;5176.145935920574;5185.714785686786;5053.343065401502;5064.189729643258;5070.442251352358;5079.746012699368;5084.669496482726;3804.84780608776;3851.9792255052434;3994.1412596291793;4001.6198461146146;4007.8797636070963;3975.185087057146;3987.7407968482103;4005.399190121476;4030.3954406838916;4054.351303791394;4002.4196491508715;4029.2948733971584;4031.701929899958;4032.0323122450695;4042.656374208181;3728.440733889911;3925.509311336083;3941.527016757979;4018.7990600470152;4029.576894426087;3413.1808365992233;3426.468897320919;3435.3644575753315;3447.7761843610983;3457.878974235915;4976.129177393977;4991.326170966946;4996.600271978269;4997.450280469146;5003.17447621142;4270.398600524803;4498.167838949805;4513.0973805238755;4531.909361812778;4535.8639240822495;5322.733863306819;5365;5373.274607927919;5376.220448035052;5407.513323800877;3787.62123787619;3797.715171362159;3800.8669696560487;3803.1823158021157;3803.695704343646;5373.328333958255;5616.326040875121;5630.8029218977545;5646.350669672999;5647.01177293976;3889.144388234584;3900.6099390060767;3906.277338692351;3909.3745000799736;3928.8035598219976;3963.2667956428154;3968.3650615901893;3968.8015599219925;3973.2450834341385;3980.9402858957137;4529.909401811945;4550.203714350042;4556.817727290938;4568.70303430276;4573.565511276423;5072.923906141411;5385.865353366119;5390.164524498709;5404.027275090443;5425.647332923348;1323.1597935311147;1337.806018127366;1344.1800501693958;1346.7575836349552;1349.2174538767492;863.6804382378434;872.725820302353;883.2139395937621;885.1635204731467;900.4012331799411;4517.81928722854;4551.816527702821;4588.587027167571;4622.121796858653;4626.352310676508;5453.15476101205;5462.672239665632;5472.398036216013;5475.808346707846;5478.835634930959;4430.246858034142;4542.931856022096;4547.295169248771;4581.74800385982;4606.493285738566;2936.7974019485387;2940.4709551033343;2941.8970336038137;2964.644242690848;2967.471752047697;5119.795208191631;5151.304573882553;5159.561437277874;5169.508896654812;5175.637705360588;5465.9726701366235;5666.546676265889;5675.1770993205755;5683.754916807838;5692.288463942007;5103.948960510422;5162.225666150108;5170.663906846043;5185.818496352609;5190.351206099238;5490.670559766427;5506.504414602705;5552.722363881709;5557.61022760217;5572.554195664256;5303.7082960436;5375.247465354932;5429.592780541396;5444.727763611882;5447.727613619382;5133.305014867225;5137.51193636604;5148.665336753099;5149.330587023663;5162.612804039637;3865.4538184726334;3922.5489068757456;3926.7447615904875;3927.3716205407;3940.7832569208967;5416.322959630046;5512.862178445571;5513.641613295123;5527.143292789624;5533.280673512418;5375.435579264121;5379.757910894097;5384.246205531151;5421.078416669096;5442.673439593637;5181.2798280901325;5267.920981185209;5285.471452854684;5321.483377237469;5337.386200586827;5243.951209757987;5285.207218917193;5287.894242115213;5294.894102117859;5316.2823018893505;5150.536451719363;5213.739313034409;5369.758360873848;5379.973100134474;5399.866028134136;5240.71176085319;5278.181881808326;5289.6297259193025;5290.994711004897;5293.44418836032 15:38:30 INFO - PROCESS | 20998 | |5;yui.html;597.0149253731342;622.0296337713168;633.2306247908792;674.6763878103189;704.9295070492948;11654.883451165486;11721.824172637418;12455.750884982295;12578.559750408738;12606.495740170394;12377.257364558132;12605.558805441811;12612.243265404082;12620.179688320275;12663.936680316609;631.1195881744964;769.2768797330506;776.3866545429104;793.2860425616933;796.55791035975;791.2443616346376;792.156353483541;794.3764145146062;794.5034353529045;794.6185830801219;837.8826964224983;839.8740188971642;840.4369072721291;840.5671079394117;844.1136806353335;821.40858581821;828.3000864269683;829.8713699376576;830.0578843013163;831.0733532111713;606.8573885136989;613.923259592551;613.9416755408229;614.3273115938041;614.8862460444832;12484.126111172221;12519;12522.311272879988;12558.434870430852;12598.055145864006;12826.166299190523;12958.222506649538;13116.606501804961;13363.933180334134;13407.46370145193;10386.792264154674;10408.687739367755;10582.682519524427;10591.682249532527;10794.406307653077;3301.8679252829857;3305.471124620049;3328.367610154063;3340.5490258814993;3415.5389022482145;60292.698536507036;60304;62774.68612656953;64058.35941640571;64582.354176458575;9683.370580912218;10236.48817559119;10258.17934565248;10625.893741062646;10636.946815266028;17041.233144508526;17736.733948990775;17759.644807103785;18490.44528664142;18508.629827403376;6804.625745583941;6812.965935170292;6822.079019332326;6842.7605033824575;6857.588544687334;3438.948415773765;3711.257748450321;3768.510093687858;3809.371453710107;3814.0655539392474;2641.735826417343;2733.0024541042376;2738.7124351943157;2741.0543362539893;2744.684361298436;494.7130664214747;507.55588859747724;509.0811085989824;509.5617768718899;511.5498361441982;536.6779932040745;618.3136718242747;632.6520413772407;635.0284065379976;657.7073202424971;8037.598120093972;8269.21442462965;8273.131321211307;8290.046644635824;8390.496570205807;551.0824477245342;580.8141394753638;606.266417634667;633.4267487923437;644.8806970710434;3754.305453491113;3932.7640341579595;4065.2072845794787;4070.8371665133654;4132.421460995463;55125;77834.22165778383;80634;82061;90994.54502727443;80689.19310806817;81025.59487202644;81144;82269;82345.17654823375;61087;71612.64193678998;72130.2786972134;72514;73275.63362183262;8816.250618697482;9309.44143351401;9382.343235973416;9412.67055653049;9413.623455061996;31087.84456077705;43349.13301733885;44196.55803442053;44740.32889506725;44979.77510112429;53721.462785371645;61594.69202654137;61912;62756.37243627688;62863.37136628575;11389.544418223179;11431.169194492895;11619.302841829518;11630.069594432256;11687;12472.812907806572;12473.376331183586;12499.437525311565;12504.249745015328;12822.935885320514;11831.11266654987;11974.521019159136;12461.563845265373;12559.309237991998;12564;12136;12168.148229623841;12197.451114700038;12371.69070773238;12740.617781466572;11856;12155.574554890536;12334.876651233373;12472.812907806572;12667.30329831868;9506.47714375716;9693.757656058655;9820.508974551101;10231.795364092824;10247.84628230592;10063.144632706302;10064.39613623185;10073.445960472245;10102.343347682377;10167.339122956984 15:38:30 INFO - PROCESS | 20998 | __end_tp_report 15:38:30 INFO - PROCESS | 20998 | __start_cc_report 15:38:30 INFO - PROCESS | 20998 | _x_x_mozilla_cycle_collect,369 15:38:30 INFO - PROCESS | 20998 | __end_cc_report 15:38:30 INFO - PROCESS | 20998 | __startTimestamp1468276710754__endTimestamp 15:38:30 INFO - PROCESS | 20998 | 15:38:30 INFO - PROCESS | 20998 | ------- Summary: start ------- 15:38:30 INFO - PROCESS | 20998 | Number of tests: 6 15:38:30 INFO - PROCESS | 20998 | 15:38:30 INFO - PROCESS | 20998 | [#0] dojo.html Cycles:165 Average:4852.98 Median:5003.25 stddev:644.74 (12.9%) stddev-sans-first:622.75 15:38:30 INFO - PROCESS | 20998 | Values: 2632.9 2684.6 2688.4 2723.3 2724.7 4893.6 4896.1 4970.1 4984.8 4986.5 4736.1 4783.1 4812.5 4847.1 4858.7 4419.4 4532.2 4550.1 4576.1 4614.1 4581.1 4650.3 4650.9 4656.7 4662.0 58.8 4584.9 4591.7 4622.8 4631.7 4562.2 4564.2 4568.6 4590.8 4601.4 4514.8 4531.4 4541.9 4543.9 4574.8 4712.0 4801.4 4861.0 4865.3 4940.9 5206.6 5229.7 5233.7 5235.1 5235.7 5267.7 5271.8 5278.7 5301.1 5314.4 4871.0 4949.6 5025.5 5045.2 5056.6 5495.8 5499.0 5525.9 5532.0 5546.8 4960.5 5267.1 5274.8 5301.3 5301.5 5100.2 5173.9 5179.3 5238.6 5270.2 5211.7 5219.8 5223.1 5227.4 5227.6 5160.1 5216.6 5217.2 5247.3 5263.2 4404.4 4426.7 4495.6 4498.3 4514.5 3893.4 3895.7 3909.6 3952.5 3962.6 4367.1 4491.3 4501.8 4513.6 4560.0 5205.8 5286.7 5322.1 5327.4 5327.9 4480.3 4507.1 4507.4 4518.8 4552.0 4572.0 4661.4 4772.9 4800.4 4843.8 4844.2 4886.4 4947.1 4975.6 4976.0 5361.5 5370.8 5384.6 5384.8 5397.2 4786.6 4963.4 4972.6 4981.7 4988.9 5119.5 5183.7 5205.9 5222.4 5251.5 5245.6 5251.6 5287.3 5287.6 5309.7 5003.2 5142.4 5156.6 5162.4 5169.5 5214.2 5234.8 5240.6 5265.9 5268.8 5151.5 5166.9 5186.8 5203.6 5245.7 5034.9 5182.6 5224.2 5238.6 5301.3 5060.3 5085.3 5108.1 5116.0 5135.2 15:38:30 INFO - PROCESS | 20998 | 15:38:30 INFO - PROCESS | 20998 | [#1] ext.html Cycles:180 Average:47892.62 Median:36040.64 stddev:90304.29 (250.6%) stddev-sans-first:90487.60 15:38:30 INFO - PROCESS | 20998 | Values: 531.2 557.1 559.4 570.7 596.3 34908.5 39003.8 39020.6 39038.2 39061.2 39508.6 40017.2 40107.0 40158.0 40203.6 7742.1 7915.2 7937.4 7947.9 7965.3 7853.9 7882.6 7927.4 7947.4 7951.3 7953.6 7982.8 7997.2 8005.7 8010.2 7860.4 7887.9 7904.9 7926.8 7939.4 7858.1 7926.3 7926.6 7933.5 7935.5 37602.0 37815.2 37938.2 37946.2 37986.2 3022.2 3184.9 3198.9 3270.2 3440.6 29024.4 29362.7 30070.2 30110.8 30720.7 3445.6 3449.8 3482.3 3502.8 3601.5 276483.0 278507.0 278596.0 278960.0 279882.0 31906.7 33148.5 52726.9 53315.0 53490.5 33896.8 33988.0 34038.5 34111.5 34153.8 11876.9 11993.0 12001.6 12004.6 12019.0 10614.1 10710.1 10716.6 10724.7 10726.5 7870.9 7913.4 7949.6 8000.1 8050.9 3031.8 3060.7 3069.1 3106.1 3115.8 857.6 871.2 887.0 919.6 976.4 28342.4 28470.7 28567.1 28942.4 29068.0 906.8 985.1 990.9 1004.5 1024.5 14680.9 14827.8 15394.8 15870.3 16208.5 384176.0 384754.0 385618.0 387603.0 387729.0 50322.0 50417.2 50606.5 50946.0 51519.0 1188.4 1212.2 1240.2 1252.4 1253.6 28102.0 29308.4 29383.7 29396.7 29694.9 42236.8 43115.6 43116.0 43155.1 43212.4 349135.0 352765.0 353506.0 353518.0 354882.0 24642.8 24661.5 24714.9 24774.0 24975.5 40045.0 40747.2 40885.2 41647.4 41707.8 35927.1 35997.0 36062.0 36170.5 36509.3 36094.5 36217.5 36257.5 36362.6 36496.0 34800.1 35719.0 35811.6 36019.3 36090.1 30774.5 31921.5 32712.8 32767.5 32788.8 24735.0 25106.5 25325.7 25571.4 25574.1 15:38:30 INFO - PROCESS | 20998 | 15:38:30 INFO - PROCESS | 20998 | [#2] jquery.html Cycles:180 Average:25931.34 Median:48783.76 stddev:64856.44 (132.9%) stddev-sans-first:65009.97 15:38:30 INFO - PROCESS | 20998 | Values: 366.2 368.4 371.3 383.6 388.3 16674.2 16711.2 17357.3 17786.5 17897.9 18033.5 18480.0 19039.1 19062.8 19819.3 5800.2 6033.8 6105.8 6124.0 6140.2 5871.0 5932.3 6083.5 6111.0 6114.9 6014.7 6053.8 6068.1 6078.0 6082.0 6049.7 6097.1 6102.3 6104.5 6112.5 5666.2 5869.7 5887.4 5910.9 5928.5 24175.0 24285.2 24798.6 25384.9 25413.1 1865.2 1977.8 2083.8 2316.2 2349.3 14755.5 15002.2 15029.2 15062.7 15688.8 1815.9 1857.2 1882.8 1935.7 1958.3 61605.7 77566.6 82728.0 84329.2 86449.0 15854.3 16830.6 16893.5 17196.8 17253.7 29158.6 29329.9 29462.1 29470.3 29689.7 8723.6 9213.6 9349.4 9479.9 9525.2 7417.7 7429.3 7429.9 7554.2 7860.1 8280.5 8421.9 8542.2 8640.0 8674.0 3168.8 3175.5 3317.6 3378.7 3577.3 863.0 870.3 931.8 933.6 941.4 17094.4 17527.3 17567.8 17700.7 18156.9 821.9 853.7 856.1 858.7 925.9 9719.5 9719.7 10089.9 10437.8 10451.7 389761.0 390957.0 392705.0 393851.0 397726.0 58555.0 58875.8 82909.0 83346.0 85591.6 939.4 953.5 954.6 973.2 976.6 16294.9 16316.2 16643.9 16725.4 16924.2 37497.0 37794.4 37994.6 38676.4 38761.0 47410.0 50157.5 51844.7 52967.5 53958.0 7454.8 7536.2 7570.8 7617.5 7675.2 9824.7 10952.5 11041.3 11427.6 11559.8 9736.0 9887.3 10170.9 10361.2 10428.3 10072.9 10281.9 10357.1 10359.9 10414.1 9793.2 9797.6 10095.3 10295.2 10546.8 7552.6 7596.9 7632.4 7638.2 7839.0 8696.9 9236.4 9993.5 10049.1 10088.3 15:38:30 INFO - PROCESS | 20998 | 15:38:30 INFO - PROCESS | 20998 | [#3] mootools.html Cycles:180 Average:4887.20 Median:4997.40 stddev:2689.70 (53.8%) stddev-sans-first:2684.23 15:38:30 INFO - PROCESS | 20998 | Values: 1366.0 1408.8 1483.9 1671.1 1696.2 6416.5 7169.8 7170.9 7638.0 7664.9 7171.1 7364.7 7425.7 7437.6 7455.1 2122.1 2170.3 2174.0 2178.2 2179.2 2196.3 2206.9 2207.5 2216.4 2217.4 2197.6 2202.8 2204.3 2208.5 2217.8 2141.2 2144.0 2145.8 2148.6 2153.6 2055.5 2107.4 2110.0 2116.9 2117.4 7597.6 7673.6 7683.9 7684.4 7689.8 4383.0 4479.2 4509.1 4520.1 4543.9 2810.9 2848.5 2882.8 2910.6 2938.1 897.8 914.2 918.0 933.7 935.2 9880.2 9897.8 9914.2 9915.2 10010.7 3930.1 4066.2 4144.8 4162.1 4170.9 8443.1 8500.8 8501.8 8503.1 8510.4 4559.8 4568.7 4578.5 4586.4 4587.3 3384.9 4014.4 4137.4 4171.8 4200.3 3515.8 3548.8 3638.1 3648.6 3666.5 1137.9 1172.1 1181.1 1184.1 1197.9 813.2 823.2 830.8 869.2 870.1 4910.9 5053.8 5062.8 5068.6 5134.8 412.7 419.5 429.6 431.3 432.0 3433.1 3442.2 3465.3 3477.0 3530.4 8755.6 8940.3 9063.6 9093.0 9113.1 8887.2 8976.7 8979.1 8982.4 8984.1 6958.2 6961.7 7015.0 7030.0 7035.1 4846.7 4883.9 4927.0 4971.0 5023.8 8268.1 8377.2 8449.9 8560.3 8581.2 8408.7 8475.9 8482.9 8528.3 8612.4 5648.2 6131.6 6342.3 6386.0 6388.3 7027.8 7095.5 7100.3 7145.6 7160.4 6367.7 6391.6 6529.4 6533.7 6605.5 6382.5 6495.6 6506.0 6627.8 6639.9 5695.1 5808.4 5815.6 5822.9 5840.3 3908.1 3962.1 4057.1 4071.5 4144.9 4400.9 4428.8 4458.2 4476.5 4550.4 15:38:30 INFO - PROCESS | 20998 | 15:38:30 INFO - PROCESS | 20998 | [#4] prototype.html Cycles:180 Average:4433.59 Median:5094.31 stddev:1295.89 (25.4%) stddev-sans-first:1261.64 15:38:30 INFO - PROCESS | 20998 | Values: 289.2 292.5 296.4 302.9 305.5 5111.8 5161.7 5163.7 5176.1 5185.7 5053.3 5064.2 5070.4 5079.7 5084.7 3804.8 3852.0 3994.1 4001.6 4007.9 3975.2 3987.7 4005.4 4030.4 4054.4 4002.4 4029.3 4031.7 4032.0 4042.7 3728.4 3925.5 3941.5 4018.8 4029.6 3413.2 3426.5 3435.4 3447.8 3457.9 4976.1 4991.3 4996.6 4997.5 5003.2 4270.4 4498.2 4513.1 4531.9 4535.9 5322.7 5365.0 5373.3 5376.2 5407.5 3787.6 3797.7 3800.9 3803.2 3803.7 5373.3 5616.3 5630.8 5646.4 5647.0 3889.1 3900.6 3906.3 3909.4 3928.8 3963.3 3968.4 3968.8 3973.2 3980.9 4529.9 4550.2 4556.8 4568.7 4573.6 5072.9 5385.9 5390.2 5404.0 5425.6 1323.2 1337.8 1344.2 1346.8 1349.2 863.7 872.7 883.2 885.2 900.4 4517.8 4551.8 4588.6 4622.1 4626.4 5453.2 5462.7 5472.4 5475.8 5478.8 4430.2 4542.9 4547.3 4581.7 4606.5 2936.8 2940.5 2941.9 2964.6 2967.5 5119.8 5151.3 5159.6 5169.5 5175.6 5466.0 5666.5 5675.2 5683.8 5692.3 5103.9 5162.2 5170.7 5185.8 5190.4 5490.7 5506.5 5552.7 5557.6 5572.6 5303.7 5375.2 5429.6 5444.7 5447.7 5133.3 5137.5 5148.7 5149.3 5162.6 3865.5 3922.5 3926.7 3927.4 3940.8 5416.3 5512.9 5513.6 5527.1 5533.3 5375.4 5379.8 5384.2 5421.1 5442.7 5181.3 5267.9 5285.5 5321.5 5337.4 5244.0 5285.2 5287.9 5294.9 5316.3 5150.5 5213.7 5369.8 5380.0 5399.9 5240.7 5278.2 5289.6 5291.0 5293.4 15:38:30 INFO - PROCESS | 20998 | 15:38:30 INFO - PROCESS | 20998 | [#5] yui.html Cycles:180 Average:16891.47 Median:22737.24 stddev:23126.68 (101.7%) stddev-sans-first:23159.19 15:38:30 INFO - PROCESS | 20998 | Values: 597.0 622.0 633.2 674.7 704.9 11654.9 11721.8 12455.8 12578.6 12606.5 12377.3 12605.6 12612.2 12620.2 12663.9 631.1 769.3 776.4 793.3 796.6 791.2 792.2 794.4 794.5 794.6 837.9 839.9 840.4 840.6 844.1 821.4 828.3 829.9 830.1 831.1 606.9 613.9 613.9 614.3 614.9 12484.1 12519.0 12522.3 12558.4 12598.1 12826.2 12958.2 13116.6 13363.9 13407.5 10386.8 10408.7 10582.7 10591.7 10794.4 3301.9 3305.5 3328.4 3340.5 3415.5 60292.7 60304.0 62774.7 64058.4 64582.4 9683.4 10236.5 10258.2 10625.9 10636.9 17041.2 17736.7 17759.6 18490.4 18508.6 6804.6 6813.0 6822.1 6842.8 6857.6 3438.9 3711.3 3768.5 3809.4 3814.1 2641.7 2733.0 2738.7 2741.1 2744.7 494.7 507.6 509.1 509.6 511.5 536.7 618.3 632.7 635.0 657.7 8037.6 8269.2 8273.1 8290.0 8390.5 551.1 580.8 606.3 633.4 644.9 3754.3 3932.8 4065.2 4070.8 4132.4 55125.0 77834.2 80634.0 82061.0 90994.5 80689.2 81025.6 81144.0 82269.0 82345.2 61087.0 71612.6 72130.3 72514.0 73275.6 8816.3 9309.4 9382.3 9412.7 9413.6 31087.8 43349.1 44196.6 44740.3 44979.8 53721.5 61594.7 61912.0 62756.4 62863.4 11389.5 11431.2 11619.3 11630.1 11687.0 12472.8 12473.4 12499.4 12504.2 12822.9 11831.1 11974.5 12461.6 12559.3 12564.0 12136.0 12168.1 12197.5 12371.7 12740.6 11856.0 12155.6 12334.9 12472.8 12667.3 9506.5 9693.8 9820.5 10231.8 10247.8 10063.1 10064.4 10073.4 10102.3 10167.3 15:38:30 INFO - PROCESS | 20998 | -------- Summary: end -------- 15:38:30 INFO - PROCESS | 20998 | 15:38:31 INFO - TEST-INFO | 20998: exit 0 15:38:31 INFO - TEST-OK | dromaeo_css | took 1115678ms 15:38:31 INFO - TEST-START | kraken 15:38:31 INFO - operating with platform_type : linux_ 15:38:31 INFO - Initialising browser for kraken test... 15:38:31 INFO - TEST-INFO | started process 21241 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoByTpJ/profile http://localhost:57641/getInfo.html) 15:38:36 INFO - PROCESS | 21241 | __metrics Screen width/height:1600/1200 15:38:36 INFO - PROCESS | 21241 | colorDepth:24 15:38:36 INFO - PROCESS | 21241 | Browser inner width/height: 1024/697 15:38:36 INFO - PROCESS | 21241 | __metrics 15:38:36 ERROR - PROCESS | 21241 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 15:38:37 INFO - TEST-INFO | 21241: exit 0 15:38:37 INFO - Browser initialized. 15:38:37 INFO - Running cycle 1/1 for kraken test... 15:38:37 INFO - TEST-INFO | started process 21363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoByTpJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:38:49 INFO - PROCESS | 21363 | RSS: Main: 168255488 15:38:49 INFO - PROCESS | 21363 | 15:38:52 INFO - PROCESS | 21363 | Cycle 1(1): loaded http://localhost:57641/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57641/tests/kraken/driver.html?testName=audio-beat-detection) 15:38:53 INFO - PROCESS | 21363 | RSS: Main: 173375488 15:38:53 INFO - PROCESS | 21363 | 15:38:56 INFO - PROCESS | 21363 | Cycle 1(1): loaded http://localhost:57641/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57641/tests/kraken/driver.html?testName=audio-dft) 15:38:56 INFO - PROCESS | 21363 | RSS: Main: 173490176 15:38:56 INFO - PROCESS | 21363 | 15:38:59 INFO - PROCESS | 21363 | Cycle 1(1): loaded http://localhost:57641/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57641/tests/kraken/driver.html?testName=audio-fft) 15:39:00 INFO - PROCESS | 21363 | RSS: Main: 167915520 15:39:00 INFO - PROCESS | 21363 | 15:39:02 INFO - PROCESS | 21363 | Cycle 1(1): loaded http://localhost:57641/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57641/tests/kraken/driver.html?testName=audio-oscillator) 15:39:03 INFO - PROCESS | 21363 | RSS: Main: 168886272 15:39:03 INFO - PROCESS | 21363 | 15:39:05 INFO - PROCESS | 21363 | Cycle 1(1): loaded http://localhost:57641/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57641/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:39:05 INFO - PROCESS | 21363 | RSS: Main: 168947712 15:39:05 INFO - PROCESS | 21363 | 15:39:09 INFO - PROCESS | 21363 | Cycle 1(1): loaded http://localhost:57641/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57641/tests/kraken/driver.html?testName=imaging-darkroom) 15:39:09 INFO - PROCESS | 21363 | RSS: Main: 169381888 15:39:09 INFO - PROCESS | 21363 | 15:39:13 INFO - PROCESS | 21363 | Cycle 1(1): loaded http://localhost:57641/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57641/tests/kraken/driver.html?testName=imaging-desaturate) 15:39:13 INFO - PROCESS | 21363 | RSS: Main: 166903808 15:39:13 INFO - PROCESS | 21363 | 15:39:16 INFO - PROCESS | 21363 | Cycle 1(1): loaded http://localhost:57641/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57641/tests/kraken/driver.html?testName=json-parse-financial) 15:39:17 INFO - PROCESS | 21363 | RSS: Main: 168329216 15:39:17 INFO - PROCESS | 21363 | 15:39:19 INFO - PROCESS | 21363 | Cycle 1(1): loaded http://localhost:57641/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57641/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:39:19 INFO - PROCESS | 21363 | RSS: Main: 168488960 15:39:19 INFO - PROCESS | 21363 | 15:39:21 INFO - PROCESS | 21363 | Cycle 1(1): loaded http://localhost:57641/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57641/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:39:22 INFO - PROCESS | 21363 | RSS: Main: 168636416 15:39:22 INFO - PROCESS | 21363 | 15:39:24 INFO - PROCESS | 21363 | Cycle 1(1): loaded http://localhost:57641/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57641/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:39:25 INFO - PROCESS | 21363 | RSS: Main: 169320448 15:39:25 INFO - PROCESS | 21363 | 15:39:28 INFO - PROCESS | 21363 | Cycle 1(1): loaded http://localhost:57641/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57641/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:39:28 INFO - PROCESS | 21363 | RSS: Main: 169463808 15:39:28 INFO - PROCESS | 21363 | 15:39:31 INFO - PROCESS | 21363 | Cycle 1(1): loaded http://localhost:57641/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57641/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:39:32 INFO - PROCESS | 21363 | RSS: Main: 169263104 15:39:32 INFO - PROCESS | 21363 | 15:39:34 INFO - PROCESS | 21363 | Cycle 1(1): loaded http://localhost:57641/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57641/tests/kraken/driver.html?testName=ai-astar) 15:39:34 INFO - PROCESS | 21363 | RSS: Main: 170471424 15:39:34 INFO - PROCESS | 21363 | 15:39:34 INFO - PROCESS | 21363 | __start_tp_report 15:39:34 INFO - PROCESS | 21363 | _x_x_mozilla_page_load 15:39:34 INFO - PROCESS | 21363 | _x_x_mozilla_page_load_details 15:39:34 INFO - PROCESS | 21363 | |i|pagename|runs| 15:39:34 INFO - PROCESS | 21363 | |0;ai-astar;106;115;108;116;116;116;117;115;115;115 15:39:34 INFO - PROCESS | 21363 | |1;audio-beat-detection;157;126;150;178;129;154;150;126;197;125 15:39:34 INFO - PROCESS | 21363 | |2;audio-dft;163;163;164;168;167;164;163;164;168;163 15:39:34 INFO - PROCESS | 21363 | |3;audio-fft;76;79;76;152;78;76;76;77;155;78 15:39:34 INFO - PROCESS | 21363 | |4;audio-oscillator;87;85;145;87;85;85;132;85;87;141 15:39:34 INFO - PROCESS | 21363 | |5;imaging-gaussian-blur;118;118;117;118;117;117;117;118;117;118 15:39:34 INFO - PROCESS | 21363 | |6;imaging-darkroom;148;149;149;147;148;149;148;147;164;148 15:39:34 INFO - PROCESS | 21363 | |7;imaging-desaturate;96;96;96;96;95;96;96;96;96;95 15:39:34 INFO - PROCESS | 21363 | |8;json-parse-financial;63;63;63;63;62;63;62;68;62;64 15:39:34 INFO - PROCESS | 21363 | |9;json-stringify-tinderbox;66;66;66;71;66;66;65;65;67;66 15:39:34 INFO - PROCESS | 21363 | |10;stanford-crypto-aes;81;81;80;101;83;79;85;84;89;80 15:39:34 INFO - PROCESS | 21363 | |11;stanford-crypto-ccm;134;132;131;137;130;131;139;136;179;132 15:39:34 INFO - PROCESS | 21363 | |12;stanford-crypto-pbkdf2;168;169;168;171;173;167;170;174;170;169 15:39:34 INFO - PROCESS | 21363 | |13;stanford-crypto-sha256-iterative;68;69;70;68;69;68;67;67;70;69 15:39:34 INFO - PROCESS | 21363 | __end_tp_report 15:39:34 INFO - PROCESS | 21363 | __start_cc_report 15:39:34 INFO - PROCESS | 21363 | _x_x_mozilla_cycle_collect,964 15:39:34 INFO - PROCESS | 21363 | __end_cc_report 15:39:34 INFO - PROCESS | 21363 | __startTimestamp1468276774314__endTimestamp 15:39:34 INFO - PROCESS | 21363 | 15:39:34 INFO - PROCESS | 21363 | ------- Summary: start ------- 15:39:34 INFO - PROCESS | 21363 | Number of tests: 14 15:39:34 INFO - PROCESS | 21363 | 15:39:34 INFO - PROCESS | 21363 | [#0] ai-astar Cycles:10 Average:113.90 Median:115.50 stddev:3.73 (3.2%) stddev-sans-first:2.64 15:39:34 INFO - PROCESS | 21363 | Values: 106.0 115.0 108.0 116.0 116.0 116.0 117.0 115.0 115.0 115.0 15:39:34 INFO - PROCESS | 21363 | 15:39:34 INFO - PROCESS | 21363 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:152.00 stddev:24.20 (15.9%) stddev-sans-first:25.50 15:39:34 INFO - PROCESS | 21363 | Values: 157.0 126.0 150.0 178.0 129.0 154.0 150.0 126.0 197.0 125.0 15:39:34 INFO - PROCESS | 21363 | 15:39:34 INFO - PROCESS | 21363 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.00 stddev:2.11 (1.3%) stddev-sans-first:2.15 15:39:34 INFO - PROCESS | 21363 | Values: 163.0 163.0 164.0 168.0 167.0 164.0 163.0 164.0 168.0 163.0 15:39:34 INFO - PROCESS | 21363 | 15:39:34 INFO - PROCESS | 21363 | [#3] audio-fft Cycles:10 Average:92.30 Median:76.50 stddev:32.28 (42.2%) stddev-sans-first:33.70 15:39:34 INFO - PROCESS | 21363 | Values: 76.0 79.0 76.0 152.0 78.0 76.0 76.0 77.0 155.0 78.0 15:39:34 INFO - PROCESS | 21363 | 15:39:34 INFO - PROCESS | 21363 | [#4] audio-oscillator Cycles:10 Average:101.90 Median:85.00 stddev:26.04 (30.6%) stddev-sans-first:27.05 15:39:34 INFO - PROCESS | 21363 | Values: 87.0 85.0 145.0 87.0 85.0 85.0 132.0 85.0 87.0 141.0 15:39:34 INFO - PROCESS | 21363 | 15:39:34 INFO - PROCESS | 21363 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 15:39:34 INFO - PROCESS | 21363 | Values: 118.0 118.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 118.0 15:39:34 INFO - PROCESS | 21363 | 15:39:34 INFO - PROCESS | 21363 | [#6] imaging-darkroom Cycles:10 Average:149.70 Median:148.50 stddev:5.08 (3.4%) stddev-sans-first:5.35 15:39:34 INFO - PROCESS | 21363 | Values: 148.0 149.0 149.0 147.0 148.0 149.0 148.0 147.0 164.0 148.0 15:39:34 INFO - PROCESS | 21363 | 15:39:34 INFO - PROCESS | 21363 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:39:34 INFO - PROCESS | 21363 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 15:39:34 INFO - PROCESS | 21363 | 15:39:34 INFO - PROCESS | 21363 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:63.00 stddev:1.77 (2.8%) stddev-sans-first:1.87 15:39:34 INFO - PROCESS | 21363 | Values: 63.0 63.0 63.0 63.0 62.0 63.0 62.0 68.0 62.0 64.0 15:39:34 INFO - PROCESS | 21363 | 15:39:34 INFO - PROCESS | 21363 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.00 stddev:1.71 (2.6%) stddev-sans-first:1.81 15:39:34 INFO - PROCESS | 21363 | Values: 66.0 66.0 66.0 71.0 66.0 66.0 65.0 65.0 67.0 66.0 15:39:34 INFO - PROCESS | 21363 | 15:39:34 INFO - PROCESS | 21363 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:82.00 stddev:6.58 (8.0%) stddev-sans-first:6.87 15:39:34 INFO - PROCESS | 21363 | Values: 81.0 81.0 80.0 101.0 83.0 79.0 85.0 84.0 89.0 80.0 15:39:34 INFO - PROCESS | 21363 | 15:39:34 INFO - PROCESS | 21363 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:135.00 stddev:14.67 (10.9%) stddev-sans-first:15.48 15:39:34 INFO - PROCESS | 21363 | Values: 134.0 132.0 131.0 137.0 130.0 131.0 139.0 136.0 179.0 132.0 15:39:34 INFO - PROCESS | 21363 | 15:39:34 INFO - PROCESS | 21363 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:170.00 stddev:2.23 (1.3%) stddev-sans-first:2.26 15:39:34 INFO - PROCESS | 21363 | Values: 168.0 169.0 168.0 171.0 173.0 167.0 170.0 174.0 170.0 169.0 15:39:34 INFO - PROCESS | 21363 | 15:39:34 INFO - PROCESS | 21363 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.08 (1.6%) stddev-sans-first:1.13 15:39:34 INFO - PROCESS | 21363 | Values: 68.0 69.0 70.0 68.0 69.0 68.0 67.0 67.0 70.0 69.0 15:39:34 INFO - PROCESS | 21363 | -------- Summary: end -------- 15:39:34 INFO - PROCESS | 21363 | 15:39:35 INFO - TEST-INFO | 21363: exit 0 15:39:35 INFO - TEST-OK | kraken | took 63919ms 15:39:35 INFO - SUITE-END | took 1179s 15:39:35 INFO - Completed test suite (00:19:39) 15:39:35 INFO - javascript benchmark 15:39:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6513.687857977122, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2632.921012369629, 2684.5704687250036, 2688.354794849237, 2723.27833124222, 2724.7139050399705, 4893.584045356145, 4896.0697467481195, 4970.055689419008, 4984.800607975677, 4986.451490336065, 4736.147493451177, 4783.067301876135, 4812.518748125194, 4847.12751704693, 4858.659893807426, 4419.4033805436175, 4532.206863798839, 4550.112728018038, 4576.084783043405, 4614.054118905617, 4581.106684196583, 4650.348951146842, 4650.906981860361, 4656.674032817704, 4661.997670500841, 58.750882145377595, 4584.908301833978, 4591.6556258280425, 4622.8150873965005, 4631.745254011028, 4562.247229207177, 4564.224081906051, 4568.634509239253, 4590.816367345302, 4601.378813860119, 4514.774261286955, 4531.43357080365, 4541.931871021938, 4543.86368408945, 4574.817007319703, 4711.976440117812, 4801.423829140491, 4861.0, 4865.343178670905, 4940.851774446773, 5206.557442617382, 5229.660072095302, 5233.712145831978, 5235.110031294689, 5235.659682120688, 5267.710275934822, 5271.815486457956, 5278.736063196825, 5301.0723123453245, 5314.441983591744, 4870.975645121787, 4949.579285760715, 5025.547700706918, 5045.192769156917, 5056.595472362203, 5495.752691128909, 5498.972505137449, 5525.861853453695, 5531.976584331912, 5546.805861794818, 4960.479149689303, 5267.104592219332, 5274.789008439696, 5301.257823904656, 5301.496357845998, 5100.209467532539, 5173.896522069537, 5179.2749015137915, 5238.633295669343, 5270.183121616155, 5211.661242019332, 5219.817306394258, 5223.059849227176, 5227.372715274191, 5227.555657769056, 5160.09698302803, 5216.58267338612, 5217.243499692523, 5247.291615631841, 5263.184206448007, 4404.427424434803, 4426.667999900021, 4495.550444955478, 4498.2577874650315, 4514.480834704051, 3893.377059670439, 3895.6883449323986, 3909.58949310324, 3952.4664170336637, 3962.6037396260144, 4367.10474352757, 4491.326301054868, 4501.7974191161475, 4513.571210734975, 4560.042391097841, 5205.7917683293, 5286.682799032071, 5322.148456246982, 5327.360716713942, 5327.920081198785, 4480.305552639346, 4507.076049409863, 4507.3915021471685, 4518.774061296922, 4552.0, 4571.977140114278, 4661.394018777537, 4772.928406073912, 4800.3759511263315, 4843.806247750121, 4844.2007068833245, 4886.413630364379, 4947.060058588857, 4975.601951843916, 4975.975120124376, 5361.490658387447, 5370.785168593369, 5384.6230763847725, 5384.784608615611, 5397.163439666858, 4786.6410019248, 4963.354763880817, 4972.627052970969, 4981.676191047715, 4988.875278117931, 5119.539241468286, 5183.688978661293, 5205.869853253699, 5222.3733152022005, 5251.501107394792, 5245.606579506476, 5251.606129540223, 5287.286216360742, 5287.550558202596, 5309.681419114865, 5003.249512573143, 5142.408623008402, 5156.587473002226, 5162.406323272721, 5169.457206993212, 5214.243934629533, 5234.790608375774, 5240.633155679066, 5265.921011184912, 5268.81559145428, 5151.484851514819, 5166.922496162636, 5186.844394668166, 5203.635745497779, 5245.6852588844795, 5034.949650503595, 5182.6113041521285, 5224.216367544746, 5238.580913526833, 5301.3373328333955, 5060.266261392004, 5085.338905942352, 5108.131617624938, 5115.974420127875, 5135.204043373283], "value": 4813.721427045082, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.2217601214223, 557.0752550765728, 559.3902646115733, 570.7203470299553, 596.3023262782549, 34908.4763728544, 39003.80498097509, 39020.609793902055, 39038.219235615274, 39061.21877562447, 39508.604913950854, 40017.199656006866, 40107.0, 40158.0, 40203.59796402035, 7742.109657389402, 7915.208479152067, 7937.404694647925, 7947.880781788278, 7965.283124518792, 7853.882191767099, 7882.60586970652, 7927.3658107351275, 7947.364210863146, 7951.284384405402, 7953.562554059525, 7982.760517184464, 7997.160298168696, 8005.6797728090805, 8010.198980102002, 7860.371170306362, 7887.881681774778, 7904.920950790476, 7926.80182995424, 7939.444238903279, 7858.09631892334, 7926.326262267714, 7926.643301051467, 7933.523988560705, 7935.484193527403, 37602.0, 37815.24369512622, 37938.24123517514, 37946.241075178616, 37986.240275194345, 3022.2444388902773, 3184.9203769905707, 3198.8720451182157, 3270.1824543864036, 3440.552728145325, 29024.41951160986, 29362.706372936213, 30070.24824379386, 30110.849445752632, 30720.69279307201, 3445.586529616462, 3449.844756985942, 3482.320947415255, 3502.807345595991, 3601.45978103284, 276483.0, 278507.0, 278596.0, 278960.0, 279882.0, 31906.680933190833, 33148.50277245843, 52726.89092436336, 53315.0, 53490.465095349326, 33896.830515847265, 33988.0, 34038.48942265868, 34111.488327675106, 34153.829230853684, 11876.94061529704, 11993.0, 12001.579944701894, 12004.639860804189, 12019.0, 10614.097801686788, 10710.08964238033, 10716.571337146583, 10724.731881702864, 10726.517306721216, 7870.881936770953, 7913.406494512935, 7949.562774047483, 8000.079990801132, 8050.919490805134, 3031.7726170536857, 3060.6633270340244, 3069.0946170879643, 3106.0681795461273, 3115.7818952673097, 857.6140736668524, 871.2115535440437, 886.964521419136, 919.5540163020929, 976.4043933200742, 28342.433151336856, 28470.71529284722, 28567.142985710463, 28942.42115157685, 29067.982620608178, 906.8141031088611, 985.1281615769952, 990.9207263418909, 1004.4626125023077, 1024.5031159887449, 14680.92659536717, 14827.77758333626, 15394.846051539565, 15870.285837137357, 16208.51374458768, 384176.0, 384754.0, 385618.0, 387603.0, 387729.0, 50322.0, 50417.24374134391, 50606.49393506091, 50946.0, 51519.0, 1188.4324595534395, 1212.2484059882752, 1240.1814802230665, 1252.4489224741085, 1253.5800506830133, 28102.0, 29308.413831723672, 29383.706162938954, 29396.706032940252, 29694.851525742233, 42236.78881605572, 43115.56884431116, 43116.0, 43155.136897262506, 43212.35181472218, 349135.0, 352765.0, 353506.0, 353518.0, 354882.0, 24642.753572464047, 24661.50676986486, 24714.876425617756, 24774.0, 24975.500489990463, 40045.0, 40747.1850562993, 40885.1822963545, 41647.37528937129, 41707.7914610425, 35927.10182245465, 35997.0, 36062.0, 36170.4574431389, 36509.26981460409, 36094.45858312075, 36217.45673814948, 36257.45613815848, 36362.63637363698, 36496.0, 34800.129996750285, 35719.0, 35811.64188358187, 36019.279614408086, 36090.09774755547, 30774.53838192384, 31921.460303847, 32712.83643581767, 32767.508487373187, 32788.83605581957, 24735.0, 25106.49787004213, 25325.746742533076, 25571.36071598225, 25574.104906328932], "value": 16542.42189446451, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.2162971241542, 368.362732472822, 371.2723062796917, 383.558907256655, 388.30687223306404, 16674.249658765355, 16711.247993840276, 17357.30570777169, 17786.46640600784, 17897.91051044743, 18033.549161270974, 18480.0, 19039.143238554265, 19062.809371906278, 19819.306324278652, 5800.216970708942, 6033.758649654009, 6105.755769769226, 6123.969380153093, 6140.232470941132, 5870.970645146768, 5932.3474417814, 6083.543734219929, 6110.96944515279, 6114.938850611481, 6014.699265036753, 6053.818385448443, 6068.059450785136, 6078.027515597505, 6082.0, 6049.697515124226, 6097.115918191859, 6102.298235702907, 6104.481119104881, 6112.51099912006, 5666.206731057655, 5869.706514674292, 5887.381824908366, 5910.940890591082, 5928.525717942554, 24175.0, 24285.150019749224, 24798.628020579526, 25384.873075634503, 25413.11054113116, 1865.1606776950428, 1977.7626684797772, 2083.812456878888, 2316.2009106858277, 2349.306954448442, 14755.483558075523, 15002.174880381575, 15029.248537573187, 15062.720064973271, 15688.76466852998, 1815.8638102142393, 1857.1735577667944, 1882.8023057578894, 1935.6709359408935, 1958.2950137950327, 61605.691971540306, 77566.61216693881, 82728.0, 84329.15670843335, 86449.0, 15854.274245552286, 16830.579235518966, 16893.493195204162, 17196.82803171977, 17253.654926901643, 29158.562621560694, 29329.85335073311, 29462.11613651594, 29470.263243419085, 29689.703102969124, 8723.60743766532, 9213.63145474187, 9349.439033658002, 9479.857802132974, 9525.19035881944, 7417.740379086706, 7429.328401109707, 7429.9257007430315, 7554.206808285051, 7860.096088949729, 8280.461769984931, 8421.873671894926, 8542.18849209324, 8640.019193378275, 8673.956630216808, 3168.7855152646925, 3175.539546765706, 3317.6018877734828, 3378.7465940054594, 3577.266660334625, 862.9525376104375, 870.3385427075468, 931.8322701913721, 933.5892207428709, 941.449252187478, 17094.40169594058, 17527.298908043536, 17567.82432175662, 17700.734488982675, 18156.909215453838, 821.9095899451175, 853.7481442974338, 856.092541905582, 858.6994551906907, 925.8611208318806, 9719.514024298756, 9719.708408747749, 10089.899101009043, 10437.843432348522, 10451.68644940653, 389761.0, 390957.0, 392705.0, 393851.0, 397726.0, 58555.0, 58875.82248355009, 82909.0, 83346.0, 85591.57204214063, 939.4410325856105, 953.5137080089204, 954.5561313989028, 973.2165606686685, 976.5703090640237, 16294.944043177822, 16316.184190790176, 16643.916780416504, 16725.41461048906, 16924.238409271366, 37497.0, 37794.43308350432, 37994.62005379911, 38676.41985370166, 38761.0, 47410.0, 50157.52303121143, 51844.740776295876, 52967.47032529626, 53958.0, 7454.776356709307, 7536.171021187555, 7570.772876813704, 7617.5048621839405, 7675.155732869268, 9824.705258841961, 10952.507137178687, 11041.282316649393, 11427.60003399877, 11559.768804623693, 9735.951320243354, 9887.258455615714, 10170.949145254226, 10361.222908281758, 10428.27002109845, 10072.949635251776, 10281.897181028393, 10357.119644830274, 10359.896401035892, 10414.114800242065, 9793.167580755715, 9797.579350994209, 10095.29332946716, 10295.227857910537, 10546.841797372892, 7552.6223688816435, 7596.924030759622, 7632.427567932538, 7638.197989211053, 7839.02012248469, 8696.869546956927, 9236.445813251226, 9993.450360229966, 10049.14582260516, 10088.344257623232], "value": 9353.319452159465, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.043769361447, 1408.760510713179, 1483.8961272710908, 1671.0976072920623, 1696.1519240379803, 6416.486681065515, 7169.784906452808, 7170.8565828683395, 7638.0, 7664.92335076649, 7171.103612048494, 7364.74223402181, 7425.702971881118, 7437.628118594076, 7455.142658594264, 2122.129926730037, 2170.294654237371, 2173.9891300543554, 2178.172294528077, 2179.2372669565602, 2196.2971849008322, 2206.878621675807, 2207.4922767763424, 2216.423729830248, 2217.412385717786, 2197.626403511399, 2202.8347873909443, 2204.3386983904843, 2208.547247814194, 2217.84475086744, 2141.2077531313357, 2144.0351841671154, 2145.7854214578574, 2148.591767564166, 2153.6231159547174, 2055.486128467883, 2107.3888572314163, 2109.95780084399, 2116.947076323089, 2117.4177101297114, 7597.620118994028, 7673.577953212571, 7683.923160768377, 7684.385249180108, 7689.769306920745, 4383.0, 4479.193745125876, 4509.098180363908, 4520.073384956077, 4543.886402839922, 2810.901618443345, 2848.4587928293763, 2882.798204125712, 2910.607068045808, 2938.0598208573265, 897.8024834536392, 914.2000749344323, 918.0, 933.7245512573807, 935.1910597333326, 9880.160186384166, 9897.802043959153, 9914.206863450907, 9915.157211637092, 10010.699679009642, 3930.0567863712504, 4066.2477441673386, 4144.834206631701, 4162.146759914211, 4170.874873753793, 8443.113473085361, 8500.787480313042, 8501.787455313666, 8503.107173746792, 8510.361722870686, 4559.840405585788, 4568.657350698711, 4578.473475550354, 4586.403767510203, 4587.288970209623, 3384.8984530464127, 4014.437978682987, 4137.420761093449, 4171.770552619635, 4200.327947528381, 3515.771474854126, 3548.775672393072, 3638.0904773806546, 3648.5986541480415, 3666.5416822897137, 1137.8748337682848, 1172.1209093180114, 1181.1141643767176, 1184.0527577937617, 1197.8502687164105, 813.1543195077054, 823.1957387514672, 830.8089139497829, 869.2177040663454, 870.0864092702764, 4910.852674419773, 5053.823116190915, 5062.772175252123, 5068.6451948364, 5134.794608215704, 412.67811107336325, 419.49241417884093, 429.628371458686, 431.34866351808995, 432.0322477650104, 3433.124553238958, 3442.208292092833, 3465.306938612237, 3477.009052420048, 3530.417481115587, 8755.649774009096, 8940.32947528938, 9063.637454501746, 9092.954535227282, 9113.134252246158, 8887.200151986352, 8976.730698079067, 8979.14698103679, 8982.371234013686, 8984.101589841095, 6958.199807022156, 6961.65191740411, 7015.0, 7029.9648501757165, 7035.085438892911, 4846.684965477232, 4883.892003658237, 4926.975365123295, 4970.95609921906, 5023.8492845214705, 8268.131846156068, 8377.204165604258, 8449.915500844912, 8560.315174785877, 8581.184787445183, 8408.747737567883, 8475.872861907199, 8482.872756908528, 8528.317734581342, 8612.440191387539, 5648.15277708347, 6131.570790044654, 6342.334054924351, 6386.042093685985, 6388.265349484869, 7027.789166325018, 7095.538789978635, 7100.325469080429, 7145.64271786419, 7160.427165826617, 6367.681615919093, 6391.616503009835, 6529.412352888263, 6533.705983230671, 6605.47156227491, 6382.521310901794, 6495.610263384212, 6505.967470162619, 6627.768028118992, 6639.933600664125, 5695.145728140812, 5808.39011903744, 5815.621984570989, 5822.883542329215, 5840.2991641003355, 3908.1206728487, 3962.0689138051957, 4057.0871553901316, 4071.5114186297833, 4144.917101657889, 4400.889977750582, 4428.844990425319, 4458.24209884327, 4476.512005417604, 4550.408446901882], "value": 3919.703147250886, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.20468711044623, 292.5494738103321, 296.4116229284869, 302.94092651932857, 305.4974566837551, 5111.795528178873, 5161.690298582088, 5163.664361816484, 5176.145935920574, 5185.714785686786, 5053.343065401502, 5064.189729643258, 5070.442251352358, 5079.746012699368, 5084.669496482726, 3804.84780608776, 3851.9792255052434, 3994.1412596291793, 4001.6198461146146, 4007.8797636070963, 3975.185087057146, 3987.7407968482103, 4005.399190121476, 4030.3954406838916, 4054.351303791394, 4002.4196491508715, 4029.2948733971584, 4031.701929899958, 4032.0323122450695, 4042.656374208181, 3728.440733889911, 3925.509311336083, 3941.527016757979, 4018.7990600470152, 4029.576894426087, 3413.1808365992233, 3426.468897320919, 3435.3644575753315, 3447.7761843610983, 3457.878974235915, 4976.129177393977, 4991.326170966946, 4996.600271978269, 4997.450280469146, 5003.17447621142, 4270.398600524803, 4498.167838949805, 4513.0973805238755, 4531.909361812778, 4535.8639240822495, 5322.733863306819, 5365.0, 5373.274607927919, 5376.220448035052, 5407.513323800877, 3787.62123787619, 3797.715171362159, 3800.8669696560487, 3803.1823158021157, 3803.695704343646, 5373.328333958255, 5616.326040875121, 5630.8029218977545, 5646.350669672999, 5647.01177293976, 3889.144388234584, 3900.6099390060767, 3906.277338692351, 3909.3745000799736, 3928.8035598219976, 3963.2667956428154, 3968.3650615901893, 3968.8015599219925, 3973.2450834341385, 3980.9402858957137, 4529.909401811945, 4550.203714350042, 4556.817727290938, 4568.70303430276, 4573.565511276423, 5072.923906141411, 5385.865353366119, 5390.164524498709, 5404.027275090443, 5425.647332923348, 1323.1597935311147, 1337.806018127366, 1344.1800501693958, 1346.7575836349552, 1349.2174538767492, 863.6804382378434, 872.725820302353, 883.2139395937621, 885.1635204731467, 900.4012331799411, 4517.81928722854, 4551.816527702821, 4588.587027167571, 4622.121796858653, 4626.352310676508, 5453.15476101205, 5462.672239665632, 5472.398036216013, 5475.808346707846, 5478.835634930959, 4430.246858034142, 4542.931856022096, 4547.295169248771, 4581.74800385982, 4606.493285738566, 2936.7974019485387, 2940.4709551033343, 2941.8970336038137, 2964.644242690848, 2967.471752047697, 5119.795208191631, 5151.304573882553, 5159.561437277874, 5169.508896654812, 5175.637705360588, 5465.9726701366235, 5666.546676265889, 5675.1770993205755, 5683.754916807838, 5692.288463942007, 5103.948960510422, 5162.225666150108, 5170.663906846043, 5185.818496352609, 5190.351206099238, 5490.670559766427, 5506.504414602705, 5552.722363881709, 5557.61022760217, 5572.554195664256, 5303.7082960436, 5375.247465354932, 5429.592780541396, 5444.727763611882, 5447.727613619382, 5133.305014867225, 5137.51193636604, 5148.665336753099, 5149.330587023663, 5162.612804039637, 3865.4538184726334, 3922.5489068757456, 3926.7447615904875, 3927.3716205407, 3940.7832569208967, 5416.322959630046, 5512.862178445571, 5513.641613295123, 5527.143292789624, 5533.280673512418, 5375.435579264121, 5379.757910894097, 5384.246205531151, 5421.078416669096, 5442.673439593637, 5181.2798280901325, 5267.920981185209, 5285.471452854684, 5321.483377237469, 5337.386200586827, 5243.951209757987, 5285.207218917193, 5287.894242115213, 5294.894102117859, 5316.2823018893505, 5150.536451719363, 5213.739313034409, 5369.758360873848, 5379.973100134474, 5399.866028134136, 5240.71176085319, 5278.181881808326, 5289.6297259193025, 5290.994711004897, 5293.44418836032], "value": 4013.5054828272387, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.0149253731342, 622.0296337713168, 633.2306247908792, 674.6763878103189, 704.9295070492948, 11654.883451165486, 11721.824172637418, 12455.750884982295, 12578.559750408738, 12606.495740170394, 12377.257364558132, 12605.558805441811, 12612.243265404082, 12620.179688320275, 12663.936680316609, 631.1195881744964, 769.2768797330506, 776.3866545429104, 793.2860425616933, 796.55791035975, 791.2443616346376, 792.156353483541, 794.3764145146062, 794.5034353529045, 794.6185830801219, 837.8826964224983, 839.8740188971642, 840.4369072721291, 840.5671079394117, 844.1136806353335, 821.40858581821, 828.3000864269683, 829.8713699376576, 830.0578843013163, 831.0733532111713, 606.8573885136989, 613.923259592551, 613.9416755408229, 614.3273115938041, 614.8862460444832, 12484.126111172221, 12519.0, 12522.311272879988, 12558.434870430852, 12598.055145864006, 12826.166299190523, 12958.222506649538, 13116.606501804961, 13363.933180334134, 13407.46370145193, 10386.792264154674, 10408.687739367755, 10582.682519524427, 10591.682249532527, 10794.406307653077, 3301.8679252829857, 3305.471124620049, 3328.367610154063, 3340.5490258814993, 3415.5389022482145, 60292.698536507036, 60304.0, 62774.68612656953, 64058.35941640571, 64582.354176458575, 9683.370580912218, 10236.48817559119, 10258.17934565248, 10625.893741062646, 10636.946815266028, 17041.233144508526, 17736.733948990775, 17759.644807103785, 18490.44528664142, 18508.629827403376, 6804.625745583941, 6812.965935170292, 6822.079019332326, 6842.7605033824575, 6857.588544687334, 3438.948415773765, 3711.257748450321, 3768.510093687858, 3809.371453710107, 3814.0655539392474, 2641.735826417343, 2733.0024541042376, 2738.7124351943157, 2741.0543362539893, 2744.684361298436, 494.7130664214747, 507.55588859747724, 509.0811085989824, 509.5617768718899, 511.5498361441982, 536.6779932040745, 618.3136718242747, 632.6520413772407, 635.0284065379976, 657.7073202424971, 8037.598120093972, 8269.21442462965, 8273.131321211307, 8290.046644635824, 8390.496570205807, 551.0824477245342, 580.8141394753638, 606.266417634667, 633.4267487923437, 644.8806970710434, 3754.305453491113, 3932.7640341579595, 4065.2072845794787, 4070.8371665133654, 4132.421460995463, 55125.0, 77834.22165778383, 80634.0, 82061.0, 90994.54502727443, 80689.19310806817, 81025.59487202644, 81144.0, 82269.0, 82345.17654823375, 61087.0, 71612.64193678998, 72130.2786972134, 72514.0, 73275.63362183262, 8816.250618697482, 9309.44143351401, 9382.343235973416, 9412.67055653049, 9413.623455061996, 31087.84456077705, 43349.13301733885, 44196.55803442053, 44740.32889506725, 44979.77510112429, 53721.462785371645, 61594.69202654137, 61912.0, 62756.37243627688, 62863.37136628575, 11389.544418223179, 11431.169194492895, 11619.302841829518, 11630.069594432256, 11687.0, 12472.812907806572, 12473.376331183586, 12499.437525311565, 12504.249745015328, 12822.935885320514, 11831.11266654987, 11974.521019159136, 12461.563845265373, 12559.309237991998, 12564.0, 12136.0, 12168.148229623841, 12197.451114700038, 12371.69070773238, 12740.617781466572, 11856.0, 12155.574554890536, 12334.876651233373, 12472.812907806572, 12667.30329831868, 9506.47714375716, 9693.757656058655, 9820.508974551101, 10231.795364092824, 10247.84628230592, 10063.144632706302, 10064.39613623185, 10073.445960472245, 10102.343347682377, 10167.339122956984], "value": 6517.639260582929, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 108.0, 116.0, 116.0, 116.0, 117.0, 115.0, 115.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 150.0, 178.0, 129.0, 154.0, 150.0, 126.0, 197.0, 125.0], "value": 149.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 168.0, 167.0, 164.0, 163.0, 164.0, 168.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 76.0, 152.0, 78.0, 76.0, 76.0, 77.0, 155.0, 78.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 145.0, 87.0, 85.0, 85.0, 132.0, 85.0, 87.0, 141.0], "value": 101.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 149.0, 147.0, 148.0, 149.0, 148.0, 147.0, 164.0, 148.0], "value": 149.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 62.0, 63.0, 62.0, 68.0, 62.0, 64.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 71.0, 66.0, 66.0, 65.0, 65.0, 67.0, 66.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 80.0, 101.0, 83.0, 79.0, 85.0, 84.0, 89.0, 80.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 132.0, 131.0, 137.0, 130.0, 131.0, 139.0, 136.0, 179.0, 132.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 168.0, 171.0, 173.0, 167.0, 170.0, 174.0, 170.0, 169.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 70.0, 68.0, 69.0, 68.0, 67.0, 67.0, 70.0, 69.0], "value": 68.5, "unit": "score"}]}]} 15:39:35 INFO - Return code: 0 15:39:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:39:35 ERROR - # TBPL SUCCESS # 15:39:35 INFO - Running post-action listener: _resource_record_post_action 15:39:35 INFO - ##### 15:39:35 INFO - ##### Finished run-tests step (success) 15:39:35 INFO - ##### 15:39:35 INFO - Running post-run listener: _resource_record_post_run 15:39:35 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 12288; Write bytes: 539156480; Read time: 172; Write time: 398772 15:39:35 INFO - TinderboxPrint: CPU usage
13.3% 15:39:35 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 172 15:39:35 INFO - TinderboxPrint: I/O write bytes / time
539,156,480 / 398,772 15:39:35 INFO - TinderboxPrint: CPU idle
8,272.0 (86.7%) 15:39:35 INFO - TinderboxPrint: CPU user
1,216.9 (12.8%) 15:39:35 INFO - TinderboxPrint: Swap in / out
0 / 0 15:39:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 246169600; Read time: 124; Write time: 200396 15:39:35 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288452608; Read time: 40; Write time: 197600 15:39:36 INFO - Running post-run listener: _upload_blobber_files 15:39:36 INFO - Blob upload gear active. 15:39:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:39:36 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 15:39:36 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'] 15:39:36 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 15:39:36 INFO - (blobuploader) - INFO - Open directory for files ... 15:39:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:39:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:39:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:40 INFO - (blobuploader) - INFO - Done attempting. 15:39:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:39:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:39:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:41 INFO - (blobuploader) - INFO - Done attempting. 15:39:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:39:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:39:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:42 INFO - (blobuploader) - INFO - Done attempting. 15:39:42 INFO - (blobuploader) - INFO - Iteration through files over. 15:39:42 INFO - Return code: 0 15:39:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:39:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:39:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/261a0ce47ae5a3e935411ea1f360aa2ba2677115518bca0b886190c9d764787f6e93b3b73f36f873a1cc958594e67774c1aac65f257499406daab2272c48ccd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dccd21af21f4897fd6d30da0955d6c3ebcd3065b194a5f5fd18fb83894d6af82521f817626098600657da7a13780f26381309384b5da88770bc2e3aede41d7aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0cea19a217fae1788a9bf59b349ab2515b31f5b1f30da4578ef0907cec946c7e470507648c01e656a42de5eded58b87cea613dc65b81dd23a9fb0a91de8648d6"} 15:39:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:39:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:39:42 INFO - Contents: 15:39:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/261a0ce47ae5a3e935411ea1f360aa2ba2677115518bca0b886190c9d764787f6e93b3b73f36f873a1cc958594e67774c1aac65f257499406daab2272c48ccd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dccd21af21f4897fd6d30da0955d6c3ebcd3065b194a5f5fd18fb83894d6af82521f817626098600657da7a13780f26381309384b5da88770bc2e3aede41d7aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0cea19a217fae1788a9bf59b349ab2515b31f5b1f30da4578ef0907cec946c7e470507648c01e656a42de5eded58b87cea613dc65b81dd23a9fb0a91de8648d6"} 15:39:42 INFO - Running post-run listener: copy_logs_to_upload_dir 15:39:42 INFO - Copying logs to upload dir... 15:39:42 INFO - mkdir: /builds/slave/test/build/upload/logs 15:39:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.241345 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-11 15:39:41.822464) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 15:39:41.826049) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208 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/261a0ce47ae5a3e935411ea1f360aa2ba2677115518bca0b886190c9d764787f6e93b3b73f36f873a1cc958594e67774c1aac65f257499406daab2272c48ccd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dccd21af21f4897fd6d30da0955d6c3ebcd3065b194a5f5fd18fb83894d6af82521f817626098600657da7a13780f26381309384b5da88770bc2e3aede41d7aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0cea19a217fae1788a9bf59b349ab2515b31f5b1f30da4578ef0907cec946c7e470507648c01e656a42de5eded58b87cea613dc65b81dd23a9fb0a91de8648d6"} build_url:https://queue.taskcluster.net/v1/task/WXJTTgHKTi2JH2iR67V7IQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011549 build_url: 'https://queue.taskcluster.net/v1/task/WXJTTgHKTi2JH2iR67V7IQ/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/261a0ce47ae5a3e935411ea1f360aa2ba2677115518bca0b886190c9d764787f6e93b3b73f36f873a1cc958594e67774c1aac65f257499406daab2272c48ccd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dccd21af21f4897fd6d30da0955d6c3ebcd3065b194a5f5fd18fb83894d6af82521f817626098600657da7a13780f26381309384b5da88770bc2e3aede41d7aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0cea19a217fae1788a9bf59b349ab2515b31f5b1f30da4578ef0907cec946c7e470507648c01e656a42de5eded58b87cea613dc65b81dd23a9fb0a91de8648d6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 15:39:41.851966) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:39:41.852345) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1468275544.697888-1297585208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:39:41.936571) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 15:39:41.936904) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 15:39:41.937270) ========= ========= Total master_lag: 0.17 =========