builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-015 starttime: 1469104853.7 results: success (0) buildid: 20160721023907 builduid: 437fdc748e7f4dd882e107bda6f84ddd revision: c6e4b6a744697056dcebe1cf298ed3b7de85311c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 05:40:53.700230) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 05:40:53.700782) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 05:40:53.701068) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 05:40:53.715927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:40:53.716253) ========= 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=20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 05:40:53-- 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% 37.7M=0s 2016-07-21 05:40:53 (37.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082843 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:40:53.813477) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:40:53.813847) ========= 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=20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018033 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:40:53.863777) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:40:53.864156) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c6e4b6a744697056dcebe1cf298ed3b7de85311c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c6e4b6a744697056dcebe1cf298ed3b7de85311c --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=20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 05:40:53,912 truncating revision to first 12 chars 2016-07-21 05:40:53,912 Setting DEBUG logging. 2016-07-21 05:40:53,912 attempt 1/10 2016-07-21 05:40:53,912 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c6e4b6a74469?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 05:40:54,219 unpacking tar archive at: fx-team-c6e4b6a74469/testing/mozharness/ program finished with exit code 0 elapsedTime=0.627660 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:40:54.506325) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 05:40:54.506694) ========= script_repo_revision: c6e4b6a744697056dcebe1cf298ed3b7de85311c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 05:40:54.507096) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 05:40:54.507380) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 05:40:54.519674) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-21 05:40:54.520056) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:40:54 INFO - MultiFileLogger online at 20160721 05:40:54 in /builds/slave/test 05:40:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:40:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:40:54 INFO - {'append_to_log': False, 05:40:54 INFO - 'base_work_dir': '/builds/slave/test', 05:40:54 INFO - 'blob_upload_branch': 'Fx-Team', 05:40:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:40:54 INFO - 'branch': 'Fx-Team', 05:40:54 INFO - 'buildbot_json_path': 'buildprops.json', 05:40:54 INFO - 'config_files': ('talos/linux_config.py',), 05:40:54 INFO - 'default_actions': ('clobber', 05:40:54 INFO - 'read-buildbot-config', 05:40:54 INFO - 'download-and-extract', 05:40:54 INFO - 'populate-webroot', 05:40:54 INFO - 'create-virtualenv', 05:40:54 INFO - 'install', 05:40:54 INFO - 'run-tests'), 05:40:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:40:54 INFO - 'download_minidump_stackwalk': True, 05:40:54 INFO - 'download_symbols': 'ondemand', 05:40:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:40:54 INFO - 'tooltool.py': '/tools/tooltool.py', 05:40:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:40:54 INFO - '/tools/misc-python/virtualenv.py')}, 05:40:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:40:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:40:54 INFO - 'installer_path': 'installer.exe', 05:40:54 INFO - 'log_level': 'info', 05:40:54 INFO - 'log_name': 'talos', 05:40:54 INFO - 'log_to_console': True, 05:40:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:40:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:40:54 INFO - 'opt_config_files': (), 05:40:54 INFO - 'pip_index': False, 05:40:54 INFO - 'sps_profile': False, 05:40:54 INFO - 'sps_profile_interval': 0, 05:40:54 INFO - 'suite': 'dromaeojs-e10s', 05:40:54 INFO - 'system_bits': '32', 05:40:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:40:54 INFO - 'title': 'talos-linux64-ix-015', 05:40:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:40:54 INFO - 'use_talos_json': True, 05:40:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:40:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:40:54 INFO - 'work_dir': 'build'} 05:40:54 INFO - [mozharness: 2016-07-21 12:40:54.662178Z] Running clobber step. 05:40:54 INFO - Running pre-action listener: _resource_record_pre_action 05:40:54 INFO - Running main action method: clobber 05:40:54 INFO - rmtree: /builds/slave/test/build 05:40:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:40:55 INFO - Running post-action listener: _resource_record_post_action 05:40:55 INFO - [mozharness: 2016-07-21 12:40:55.122878Z] Finished clobber step (success) 05:40:55 INFO - [mozharness: 2016-07-21 12:40:55.122978Z] Running read-buildbot-config step. 05:40:55 INFO - Running pre-action listener: _resource_record_pre_action 05:40:55 INFO - Running main action method: read_buildbot_config 05:40:55 INFO - Using buildbot properties: 05:40:55 INFO - { 05:40:55 INFO - "project": "", 05:40:55 INFO - "product": "firefox", 05:40:55 INFO - "script_repo_revision": "production", 05:40:55 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:40:55 INFO - "repository": "", 05:40:55 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:40:55 INFO - "buildid": "20160721023907", 05:40:55 INFO - "pgo_build": "True", 05:40:55 INFO - "basedir": "/builds/slave/test", 05:40:55 INFO - "buildnumber": 960, 05:40:55 INFO - "slavename": "talos-linux64-ix-015", 05:40:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:40:55 INFO - "platform": "ubuntu64_hw", 05:40:55 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:40:55 INFO - "branch": "fx-team", 05:40:55 INFO - "repo_path": "integration/fx-team", 05:40:55 INFO - "revision": "c6e4b6a744697056dcebe1cf298ed3b7de85311c", 05:40:55 INFO - "stage_platform": "linux64-pgo", 05:40:55 INFO - "builduid": "437fdc748e7f4dd882e107bda6f84ddd", 05:40:55 INFO - "slavebuilddir": "test" 05:40:55 INFO - } 05:40:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/bEEqB0Z3TC6mHWB38lcgNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:40:55 INFO - Running post-action listener: _resource_record_post_action 05:40:55 INFO - [mozharness: 2016-07-21 12:40:55.125408Z] Finished read-buildbot-config step (success) 05:40:55 INFO - [mozharness: 2016-07-21 12:40:55.125498Z] Running download-and-extract step. 05:40:55 INFO - Running pre-action listener: _resource_record_pre_action 05:40:55 INFO - Running main action method: download_and_extract 05:40:55 INFO - mkdir: /builds/slave/test/build/tests 05:40: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')]} 05:40:55 INFO - https://queue.taskcluster.net/v1/task/bEEqB0Z3TC6mHWB38lcgNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:40:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEEqB0Z3TC6mHWB38lcgNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:40:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEEqB0Z3TC6mHWB38lcgNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:40:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEEqB0Z3TC6mHWB38lcgNw/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 05:40:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEEqB0Z3TC6mHWB38lcgNw/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 05:40:55 INFO - Downloaded 1361 bytes. 05:40:55 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:40:55 INFO - Using the following test package requirements: 05:40:55 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:40:55 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:40:55 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:40:55 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:55 INFO - u'jsshell-linux-x86_64.zip'], 05:40:55 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:40:55 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:40:55 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:40:55 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:40:55 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:40:55 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:40:55 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:40: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')]} 05:40:55 INFO - https://queue.taskcluster.net/v1/task/bEEqB0Z3TC6mHWB38lcgNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:40:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEEqB0Z3TC6mHWB38lcgNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:40:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEEqB0Z3TC6mHWB38lcgNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:40:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEEqB0Z3TC6mHWB38lcgNw/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 05:40:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEEqB0Z3TC6mHWB38lcgNw/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 05:40:57 INFO - Downloaded 24342761 bytes. 05:40:57 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'] 05:40:57 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 05:40:58 INFO - Return code: 0 05:40:58 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 05:40:58 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')]} 05:40:58 INFO - https://queue.taskcluster.net/v1/task/bEEqB0Z3TC6mHWB38lcgNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:40:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEEqB0Z3TC6mHWB38lcgNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:40:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEEqB0Z3TC6mHWB38lcgNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:40:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEEqB0Z3TC6mHWB38lcgNw/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 05:40:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEEqB0Z3TC6mHWB38lcgNw/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 05:41:00 INFO - Downloaded 24342761 bytes. 05:41:00 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'] 05:41:00 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 05:41:02 INFO - Return code: 0 05:41:02 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')]} 05:41:02 INFO - https://queue.taskcluster.net/v1/task/bEEqB0Z3TC6mHWB38lcgNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:41:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEEqB0Z3TC6mHWB38lcgNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:41:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEEqB0Z3TC6mHWB38lcgNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:41:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEEqB0Z3TC6mHWB38lcgNw/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 05:41:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEEqB0Z3TC6mHWB38lcgNw/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 05:41:03 INFO - Downloaded 14403317 bytes. 05:41:03 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'] 05:41:03 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 05:41:03 INFO - Return code: 0 05:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:03 INFO - https://queue.taskcluster.net/v1/task/bEEqB0Z3TC6mHWB38lcgNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:41:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEEqB0Z3TC6mHWB38lcgNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEEqB0Z3TC6mHWB38lcgNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEEqB0Z3TC6mHWB38lcgNw/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 05:41:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEEqB0Z3TC6mHWB38lcgNw/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 05:41:04 INFO - Downloaded 60887945 bytes. 05:41:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bEEqB0Z3TC6mHWB38lcgNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:04 INFO - mkdir: /builds/slave/test/properties 05:41:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:41:04 INFO - Writing to file /builds/slave/test/properties/build_url 05:41:04 INFO - Contents: 05:41:04 INFO - build_url:https://queue.taskcluster.net/v1/task/bEEqB0Z3TC6mHWB38lcgNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:05 INFO - Running post-action listener: _resource_record_post_action 05:41:05 INFO - Running post-action listener: set_extra_try_arguments 05:41:05 INFO - [mozharness: 2016-07-21 12:41:05.475433Z] Finished download-and-extract step (success) 05:41:05 INFO - [mozharness: 2016-07-21 12:41:05.475665Z] Running populate-webroot step. 05:41:05 INFO - Running pre-action listener: _resource_record_pre_action 05:41:05 INFO - Running main action method: populate_webroot 05:41:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:41:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:41:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:41:05 INFO - '--tppagecycles', 05:41:05 INFO - '7'], 05:41:05 INFO - 'tests': ['tsvgm']}}, 05:41:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:41:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:41:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:41:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:41:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:41:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:41:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:05 INFO - 'talos_options': ['--disable-e10s'], 05:41:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:41:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:41:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:05 INFO - 'talos_options': ['--disable-e10s'], 05:41:05 INFO - 'tests': ['damp', 'tps']}, 05:41:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:05 INFO - 'tests': ['damp', 'tps']}, 05:41:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:41:05 INFO - 'tests': ['dromaeo_dom']}, 05:41:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:41:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:41:05 INFO - 'tests': ['basic_compositor_video']}, 05:41:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:41:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:41:05 INFO - 'tests': ['a11yr', 05:41:05 INFO - 'ts_paint', 05:41:05 INFO - 'tpaint', 05:41:05 INFO - 'sessionrestore', 05:41:05 INFO - 'sessionrestore_no_auto_restore', 05:41:05 INFO - 'tabpaint']}, 05:41:05 INFO - 'other-e10s': {'tests': ['a11yr', 05:41:05 INFO - 'ts_paint', 05:41:05 INFO - 'tpaint', 05:41:05 INFO - 'sessionrestore', 05:41:05 INFO - 'sessionrestore_no_auto_restore', 05:41:05 INFO - 'tabpaint']}, 05:41:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:41:05 INFO - 'ts_paint', 05:41:05 INFO - 'tpaint', 05:41:05 INFO - 'sessionrestore', 05:41:05 INFO - 'sessionrestore_no_auto_restore', 05:41:05 INFO - 'tabpaint']}, 05:41:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:41:05 INFO - 'ts_paint', 05:41:05 INFO - 'tpaint', 05:41:05 INFO - 'sessionrestore', 05:41:05 INFO - 'sessionrestore_no_auto_restore', 05:41:05 INFO - 'tabpaint']}, 05:41:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:41:05 INFO - 'tests': ['a11yr', 05:41:05 INFO - 'ts_paint', 05:41:05 INFO - 'tpaint', 05:41:05 INFO - 'sessionrestore', 05:41:05 INFO - 'sessionrestore_no_auto_restore', 05:41:05 INFO - 'tabpaint']}, 05:41:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:41:05 INFO - 'tests': ['a11yr', 05:41:05 INFO - 'ts_paint', 05:41:05 INFO - 'tpaint', 05:41:05 INFO - 'sessionrestore', 05:41:05 INFO - 'sessionrestore_no_auto_restore', 05:41:05 INFO - 'tabpaint']}, 05:41:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:41:05 INFO - 'tests': ['tsvgx', 05:41:05 INFO - 'tsvgr_opacity', 05:41:05 INFO - 'tart', 05:41:05 INFO - 'tscrollx', 05:41:05 INFO - 'cart']}, 05:41:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:41:05 INFO - 'tsvgr_opacity', 05:41:05 INFO - 'tart', 05:41:05 INFO - 'tscrollx', 05:41:05 INFO - 'cart']}, 05:41:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:05 INFO - 'talos_options': ['--disable-e10s'], 05:41:05 INFO - 'tests': ['tp5o']}, 05:41:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:05 INFO - 'tests': ['tp5o']}, 05:41:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:05 INFO - 'talos_options': ['--disable-e10s', 05:41:05 INFO - '--xperf_path', 05:41:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:41:05 INFO - 'tests': ['tp5n']}, 05:41:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:05 INFO - 'talos_options': ['--xperf_path', 05:41:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:41:05 INFO - 'tests': ['tp5n']}}, 05:41:05 INFO - 'talos.zip': {'path': '', 05:41:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:41:05 INFO - Running post-action listener: _resource_record_post_action 05:41:05 INFO - [mozharness: 2016-07-21 12:41:05.495163Z] Finished populate-webroot step (success) 05:41:05 INFO - [mozharness: 2016-07-21 12:41:05.495252Z] Running create-virtualenv step. 05:41:05 INFO - Running pre-action listener: _resource_record_pre_action 05:41:05 INFO - Running main action method: create_virtualenv 05:41:05 INFO - Creating virtualenv /builds/slave/test/build/venv 05:41:05 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 05:41:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:41:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:41:05 INFO - Using real prefix '/usr' 05:41:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:41:06 INFO - Installing distribute.............................................................................................................................................................................................done. 05:41:08 INFO - Installing pip.................done. 05:41:08 INFO - Return code: 0 05:41:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:41:08 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')]} 05:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:08 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')]} 05:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:08 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 0x2090030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2351180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f3b0>, '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 0x23502b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2350740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602', '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 05:41:08 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 05:41:08 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 05:41:08 INFO - Using env: {'DISPLAY': ':0', 05:41:08 INFO - 'HOME': '/home/cltbld', 05:41:08 INFO - 'LANG': 'en_US.UTF-8', 05:41:08 INFO - 'LANGUAGE': 'en_US:en', 05:41:08 INFO - 'LOGNAME': 'cltbld', 05:41:08 INFO - 'MAIL': '/var/mail/cltbld', 05:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:08 INFO - 'MOZ_NO_REMOTE': '1', 05:41:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:08 INFO - 'NO_EM_RESTART': '1', 05:41:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:08 INFO - 'PWD': '/builds/slave/test', 05:41:08 INFO - 'SHELL': '/bin/bash', 05:41:08 INFO - 'SHLVL': '1', 05:41:08 INFO - 'TERM': 'linux', 05:41:08 INFO - 'TMOUT': '86400', 05:41:08 INFO - 'USER': 'cltbld', 05:41:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602', 05:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:08 INFO - '_': '/tools/buildbot/bin/python'} 05:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:08 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 05:41:08 INFO - Cleaning up... 05:41:08 INFO - Return code: 0 05:41:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:41:08 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')]} 05:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:08 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')]} 05:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:08 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 0x2090030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2351180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f3b0>, '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 0x23502b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2350740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602', '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 05:41:08 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 05:41:08 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 05:41:08 INFO - Using env: {'DISPLAY': ':0', 05:41:08 INFO - 'HOME': '/home/cltbld', 05:41:08 INFO - 'LANG': 'en_US.UTF-8', 05:41:08 INFO - 'LANGUAGE': 'en_US:en', 05:41:08 INFO - 'LOGNAME': 'cltbld', 05:41:08 INFO - 'MAIL': '/var/mail/cltbld', 05:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:08 INFO - 'MOZ_NO_REMOTE': '1', 05:41:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:08 INFO - 'NO_EM_RESTART': '1', 05:41:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:08 INFO - 'PWD': '/builds/slave/test', 05:41:08 INFO - 'SHELL': '/bin/bash', 05:41:08 INFO - 'SHLVL': '1', 05:41:08 INFO - 'TERM': 'linux', 05:41:08 INFO - 'TMOUT': '86400', 05:41:08 INFO - 'USER': 'cltbld', 05:41:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602', 05:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:08 INFO - '_': '/tools/buildbot/bin/python'} 05:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:08 INFO - Downloading/unpacking psutil>=3.1.1 05:41:08 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 05:41:08 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 05:41:08 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 05:41:08 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 05:41:08 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 05:41:08 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 05:41:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:41:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:41:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:41:10 INFO - Installing collected packages: psutil 05:41:10 INFO - Running setup.py install for psutil 05:41:10 INFO - building 'psutil._psutil_linux' extension 05:41:10 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 05:41:10 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 05:41:10 INFO - building 'psutil._psutil_posix' extension 05:41:10 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 05:41:10 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 05:41:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:41:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:41:11 INFO - Successfully installed psutil 05:41:11 INFO - Cleaning up... 05:41:11 INFO - Return code: 0 05:41:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:41: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')]} 05:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41: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')]} 05:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:11 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 0x2090030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2351180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f3b0>, '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 0x23502b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2350740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602', '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 05:41:11 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 05:41:11 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 05:41:11 INFO - Using env: {'DISPLAY': ':0', 05:41:11 INFO - 'HOME': '/home/cltbld', 05:41:11 INFO - 'LANG': 'en_US.UTF-8', 05:41:11 INFO - 'LANGUAGE': 'en_US:en', 05:41:11 INFO - 'LOGNAME': 'cltbld', 05:41:11 INFO - 'MAIL': '/var/mail/cltbld', 05:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:11 INFO - 'MOZ_NO_REMOTE': '1', 05:41:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:11 INFO - 'NO_EM_RESTART': '1', 05:41:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:11 INFO - 'PWD': '/builds/slave/test', 05:41:11 INFO - 'SHELL': '/bin/bash', 05:41:11 INFO - 'SHLVL': '1', 05:41:11 INFO - 'TERM': 'linux', 05:41:11 INFO - 'TMOUT': '86400', 05:41:11 INFO - 'USER': 'cltbld', 05:41:11 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602', 05:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:11 INFO - '_': '/tools/buildbot/bin/python'} 05:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:41:11 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 05:41:11 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 05:41:11 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 05:41:11 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 05:41:11 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 05:41:11 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 05:41:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:41:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:41:13 INFO - Installing collected packages: mozsystemmonitor 05:41:13 INFO - Running setup.py install for mozsystemmonitor 05:41:13 INFO - Successfully installed mozsystemmonitor 05:41:13 INFO - Cleaning up... 05:41:13 INFO - Return code: 0 05:41:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:41: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')]} 05:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41: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')]} 05:41:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:13 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 0x2090030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2351180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f3b0>, '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 0x23502b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2350740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602', '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 05:41:13 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 05:41:13 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 05:41:13 INFO - Using env: {'DISPLAY': ':0', 05:41:13 INFO - 'HOME': '/home/cltbld', 05:41:13 INFO - 'LANG': 'en_US.UTF-8', 05:41:13 INFO - 'LANGUAGE': 'en_US:en', 05:41:13 INFO - 'LOGNAME': 'cltbld', 05:41:13 INFO - 'MAIL': '/var/mail/cltbld', 05:41:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:13 INFO - 'MOZ_NO_REMOTE': '1', 05:41:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:13 INFO - 'NO_EM_RESTART': '1', 05:41:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:13 INFO - 'PWD': '/builds/slave/test', 05:41:13 INFO - 'SHELL': '/bin/bash', 05:41:13 INFO - 'SHLVL': '1', 05:41:13 INFO - 'TERM': 'linux', 05:41:13 INFO - 'TMOUT': '86400', 05:41:13 INFO - 'USER': 'cltbld', 05:41:13 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602', 05:41:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:13 INFO - '_': '/tools/buildbot/bin/python'} 05:41:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:13 INFO - Downloading/unpacking jsonschema==2.5.1 05:41:13 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 05:41:13 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 05:41:13 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 05:41:13 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 05:41:13 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 05:41:13 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 05:41:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:41:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:41:15 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 05:41:15 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 05:41:15 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 05:41:15 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 05:41:15 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 05:41:15 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 05:41:15 INFO - Downloading functools32-3.2.3-2.tar.gz 05:41:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:41:15 INFO - warning: no files found matching '*.txt' 05:41:15 INFO - no previously-included directories found matching 'build' 05:41:15 INFO - no previously-included directories found matching 'dist' 05:41:15 INFO - no previously-included directories found matching '.git*' 05:41:15 INFO - Installing collected packages: jsonschema, functools32 05:41:15 INFO - Running setup.py install for functools32 05:41:15 INFO - warning: no files found matching '*.txt' 05:41:15 INFO - no previously-included directories found matching 'build' 05:41:15 INFO - no previously-included directories found matching 'dist' 05:41:15 INFO - no previously-included directories found matching '.git*' 05:41:15 INFO - Successfully installed jsonschema functools32 05:41:15 INFO - Cleaning up... 05:41:16 INFO - Return code: 0 05:41:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:41:16 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')]} 05:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:16 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')]} 05:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:16 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 0x2090030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2351180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f3b0>, '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 0x23502b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2350740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602', '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 05:41:16 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 05:41:16 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 05:41:16 INFO - Using env: {'DISPLAY': ':0', 05:41:16 INFO - 'HOME': '/home/cltbld', 05:41:16 INFO - 'LANG': 'en_US.UTF-8', 05:41:16 INFO - 'LANGUAGE': 'en_US:en', 05:41:16 INFO - 'LOGNAME': 'cltbld', 05:41:16 INFO - 'MAIL': '/var/mail/cltbld', 05:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:16 INFO - 'MOZ_NO_REMOTE': '1', 05:41:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:16 INFO - 'NO_EM_RESTART': '1', 05:41:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:16 INFO - 'PWD': '/builds/slave/test', 05:41:16 INFO - 'SHELL': '/bin/bash', 05:41:16 INFO - 'SHLVL': '1', 05:41:16 INFO - 'TERM': 'linux', 05:41:16 INFO - 'TMOUT': '86400', 05:41:16 INFO - 'USER': 'cltbld', 05:41:16 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602', 05:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:16 INFO - '_': '/tools/buildbot/bin/python'} 05:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:16 INFO - Downloading/unpacking blobuploader==1.2.4 05:41:16 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 05:41:16 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 05:41:16 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 05:41:16 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 05:41:16 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 05:41:16 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 05:41:18 INFO - Downloading blobuploader-1.2.4.tar.gz 05:41:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:41:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:41:18 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 05:41:18 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 05:41:18 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 05:41:18 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 05:41:18 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 05:41:18 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 05:41:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:41:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:41:18 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 05:41:18 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 05:41:18 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 05:41:18 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 05:41:18 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 05:41:18 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 05:41:18 INFO - Downloading docopt-0.6.1.tar.gz 05:41:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:41:18 INFO - Installing collected packages: blobuploader, requests, docopt 05:41:18 INFO - Running setup.py install for blobuploader 05:41:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:41:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:41:18 INFO - Running setup.py install for requests 05:41:19 INFO - Running setup.py install for docopt 05:41:19 INFO - Successfully installed blobuploader requests docopt 05:41:19 INFO - Cleaning up... 05:41:19 INFO - Return code: 0 05:41:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:41: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')]} 05:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41: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')]} 05:41:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:19 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 0x2090030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2351180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f3b0>, '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 0x23502b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2350740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602', '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 05:41:19 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 05:41:19 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 05:41:19 INFO - Using env: {'DISPLAY': ':0', 05:41:19 INFO - 'HOME': '/home/cltbld', 05:41:19 INFO - 'LANG': 'en_US.UTF-8', 05:41:19 INFO - 'LANGUAGE': 'en_US:en', 05:41:19 INFO - 'LOGNAME': 'cltbld', 05:41:19 INFO - 'MAIL': '/var/mail/cltbld', 05:41:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:19 INFO - 'MOZ_NO_REMOTE': '1', 05:41:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:19 INFO - 'NO_EM_RESTART': '1', 05:41:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:19 INFO - 'PWD': '/builds/slave/test', 05:41:19 INFO - 'SHELL': '/bin/bash', 05:41:19 INFO - 'SHLVL': '1', 05:41:19 INFO - 'TERM': 'linux', 05:41:19 INFO - 'TMOUT': '86400', 05:41:19 INFO - 'USER': 'cltbld', 05:41:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602', 05:41:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:19 INFO - '_': '/tools/buildbot/bin/python'} 05:41:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:41:19 INFO - Running setup.py (path:/tmp/pip-0DIZZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:41:19 INFO - Running setup.py (path:/tmp/pip-_1FzJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:41:19 INFO - Running setup.py (path:/tmp/pip-wmq1T6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:41:19 INFO - Running setup.py (path:/tmp/pip-ie8qT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:41:20 INFO - Running setup.py (path:/tmp/pip-jStEda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:41:20 INFO - Running setup.py (path:/tmp/pip-S_33cK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:41:20 INFO - Running setup.py (path:/tmp/pip-bCIYOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:41:20 INFO - Running setup.py (path:/tmp/pip-VlI4ye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:41:20 INFO - Running setup.py (path:/tmp/pip-3OHbEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:41:20 INFO - Running setup.py (path:/tmp/pip-bUqEq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:41:20 INFO - Running setup.py (path:/tmp/pip-zfrOeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:41:20 INFO - Running setup.py (path:/tmp/pip-pHLYTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:41:20 INFO - Running setup.py (path:/tmp/pip-fLxNrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:41:20 INFO - Running setup.py (path:/tmp/pip-0H5ISC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:20 INFO - Running setup.py (path:/tmp/pip-DvBjEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:41:20 INFO - Running setup.py (path:/tmp/pip-fEgO6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:41:20 INFO - Running setup.py (path:/tmp/pip-YlI8jJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:41:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:41:20 INFO - Running setup.py install for manifestparser 05:41:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:41:21 INFO - Running setup.py install for mozcrash 05:41:21 INFO - Running setup.py install for mozdebug 05:41:21 INFO - Running setup.py install for mozdevice 05:41:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:41:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:41:21 INFO - Running setup.py install for mozfile 05:41:21 INFO - Running setup.py install for mozhttpd 05:41:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:41:21 INFO - Running setup.py install for mozinfo 05:41:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:41:21 INFO - Running setup.py install for mozInstall 05:41:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:41:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:41:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:41:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:41:21 INFO - Running setup.py install for mozleak 05:41:21 INFO - Running setup.py install for mozlog 05:41:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:41:22 INFO - Running setup.py install for moznetwork 05:41:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:41:22 INFO - Running setup.py install for mozprocess 05:41:22 INFO - Running setup.py install for mozprofile 05:41:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:41:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:41:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:41:22 INFO - Running setup.py install for mozrunner 05:41:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:41:22 INFO - Running setup.py install for mozscreenshot 05:41:22 INFO - Running setup.py install for moztest 05:41:22 INFO - Running setup.py install for mozversion 05:41:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:41:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:41:22 INFO - Cleaning up... 05:41:22 INFO - Return code: 0 05:41:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:41: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')]} 05:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41: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')]} 05:41:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:22 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 0x2090030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2351180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f3b0>, '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 0x23502b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2350740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602', '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 05:41:22 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 05:41:22 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 05:41:22 INFO - Using env: {'DISPLAY': ':0', 05:41:22 INFO - 'HOME': '/home/cltbld', 05:41:22 INFO - 'LANG': 'en_US.UTF-8', 05:41:22 INFO - 'LANGUAGE': 'en_US:en', 05:41:22 INFO - 'LOGNAME': 'cltbld', 05:41:22 INFO - 'MAIL': '/var/mail/cltbld', 05:41:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:22 INFO - 'MOZ_NO_REMOTE': '1', 05:41:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:22 INFO - 'NO_EM_RESTART': '1', 05:41:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:22 INFO - 'PWD': '/builds/slave/test', 05:41:22 INFO - 'SHELL': '/bin/bash', 05:41:22 INFO - 'SHLVL': '1', 05:41:22 INFO - 'TERM': 'linux', 05:41:22 INFO - 'TMOUT': '86400', 05:41:22 INFO - 'USER': 'cltbld', 05:41:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602', 05:41:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:22 INFO - '_': '/tools/buildbot/bin/python'} 05:41:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:41:22 INFO - Running setup.py (path:/tmp/pip-uhOhBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:41:23 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)) 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:41:23 INFO - Running setup.py (path:/tmp/pip-VMy1nq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:41:23 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)) 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:41:23 INFO - Running setup.py (path:/tmp/pip-NYf4xM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:41:23 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)) 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:41:23 INFO - Running setup.py (path:/tmp/pip-aqgoit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:41:23 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)) 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:41:23 INFO - Running setup.py (path:/tmp/pip-ePnaVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:41:23 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)) 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:41:23 INFO - Running setup.py (path:/tmp/pip-onzpFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:41:23 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)) 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:41:23 INFO - Running setup.py (path:/tmp/pip-Or5ZF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:41:23 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)) 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:41:23 INFO - Running setup.py (path:/tmp/pip-ofSbP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:41:23 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)) 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:41:23 INFO - Running setup.py (path:/tmp/pip-Cnaz4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:41:23 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)) 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:41:23 INFO - Running setup.py (path:/tmp/pip-nJ_gjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:41:23 INFO - Running setup.py (path:/tmp/pip-lefJjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:41:23 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)) 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:41:23 INFO - Running setup.py (path:/tmp/pip-ZAtDZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:41:23 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)) 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:41:23 INFO - Running setup.py (path:/tmp/pip-7thscD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:41:23 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)) 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:41:23 INFO - Running setup.py (path:/tmp/pip-AgNvFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:41:23 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)) 05:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:23 INFO - Running setup.py (path:/tmp/pip-gbv4PH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:24 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)) 05:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:41:24 INFO - Running setup.py (path:/tmp/pip-0owkZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:41:24 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)) 05:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:41:24 INFO - Running setup.py (path:/tmp/pip-oEp4Hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:41:24 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)) 05:41:24 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)) 05:41:24 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)) 05:41:24 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)) 05:41:24 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)) 05:41:24 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)) 05:41:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:41:24 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 05:41:24 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 05:41:24 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 05:41:24 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 05:41:24 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 05:41:24 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 05:41:26 INFO - Downloading blessings-1.6.tar.gz 05:41:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:41:26 INFO - Installing collected packages: blessings 05:41:26 INFO - Running setup.py install for blessings 05:41:26 INFO - Successfully installed blessings 05:41:26 INFO - Cleaning up... 05:41:26 INFO - Return code: 0 05:41:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:41:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:41:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:41:26 INFO - Reading from file tmpfile_stdout 05:41:26 INFO - Current package versions: 05:41:26 INFO - argparse == 1.2.1 05:41:26 INFO - blessings == 1.6 05:41:26 INFO - blobuploader == 1.2.4 05:41:26 INFO - docopt == 0.6.1 05:41:26 INFO - functools32 == 3.2.3-2 05:41:26 INFO - jsonschema == 2.5.1 05:41:26 INFO - manifestparser == 1.1 05:41:26 INFO - mozInstall == 1.12 05:41:26 INFO - mozcrash == 0.17 05:41:26 INFO - mozdebug == 0.1 05:41:26 INFO - mozdevice == 0.48 05:41:26 INFO - mozfile == 1.2 05:41:26 INFO - mozhttpd == 0.7 05:41:26 INFO - mozinfo == 0.9 05:41:26 INFO - mozleak == 0.1 05:41:26 INFO - mozlog == 3.3 05:41:26 INFO - moznetwork == 0.27 05:41:26 INFO - mozprocess == 0.23 05:41:26 INFO - mozprofile == 0.28 05:41:26 INFO - mozrunner == 6.12 05:41:26 INFO - mozscreenshot == 0.1 05:41:26 INFO - mozsystemmonitor == 0.3 05:41:26 INFO - moztest == 0.7 05:41:26 INFO - mozversion == 1.4 05:41:26 INFO - psutil == 3.1.1 05:41:26 INFO - requests == 1.2.3 05:41:26 INFO - wsgiref == 0.1.2 05:41:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:41:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:26 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 0x2090030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2351180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f3b0>, '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 0x23502b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2350740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602', '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 05:41:26 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 05:41:26 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 05:41:26 INFO - Using env: {'DISPLAY': ':0', 05:41:26 INFO - 'HOME': '/home/cltbld', 05:41:26 INFO - 'LANG': 'en_US.UTF-8', 05:41:26 INFO - 'LANGUAGE': 'en_US:en', 05:41:26 INFO - 'LOGNAME': 'cltbld', 05:41:26 INFO - 'MAIL': '/var/mail/cltbld', 05:41:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:26 INFO - 'MOZ_NO_REMOTE': '1', 05:41:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:26 INFO - 'NO_EM_RESTART': '1', 05:41:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:26 INFO - 'PWD': '/builds/slave/test', 05:41:26 INFO - 'SHELL': '/bin/bash', 05:41:26 INFO - 'SHLVL': '1', 05:41:26 INFO - 'TERM': 'linux', 05:41:26 INFO - 'TMOUT': '86400', 05:41:26 INFO - 'USER': 'cltbld', 05:41:26 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602', 05:41:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:26 INFO - '_': '/tools/buildbot/bin/python'} 05:41:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:26 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)) 05:41:26 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)) 05:41:26 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)) 05:41:26 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)) 05:41:26 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)) 05:41:26 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)) 05:41:26 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)) 05:41:26 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)) 05:41:26 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)) 05:41:26 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)) 05:41:26 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)) 05:41:26 INFO - Cleaning up... 05:41:26 INFO - Return code: 0 05:41:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:41:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:26 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 0x2090030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2351180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f3b0>, '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 0x23502b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2350740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602', '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 05:41:26 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 05:41:26 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 05:41:26 INFO - Using env: {'DISPLAY': ':0', 05:41:26 INFO - 'HOME': '/home/cltbld', 05:41:26 INFO - 'LANG': 'en_US.UTF-8', 05:41:26 INFO - 'LANGUAGE': 'en_US:en', 05:41:26 INFO - 'LOGNAME': 'cltbld', 05:41:26 INFO - 'MAIL': '/var/mail/cltbld', 05:41:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:26 INFO - 'MOZ_NO_REMOTE': '1', 05:41:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:26 INFO - 'NO_EM_RESTART': '1', 05:41:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:26 INFO - 'PWD': '/builds/slave/test', 05:41:26 INFO - 'SHELL': '/bin/bash', 05:41:26 INFO - 'SHLVL': '1', 05:41:26 INFO - 'TERM': 'linux', 05:41:26 INFO - 'TMOUT': '86400', 05:41:26 INFO - 'USER': 'cltbld', 05:41:26 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602', 05:41:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:26 INFO - '_': '/tools/buildbot/bin/python'} 05:41:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:41:27 INFO - Cleaning up... 05:41:27 INFO - Return code: 0 05:41:27 INFO - Running post-action listener: _resource_record_post_action 05:41:27 INFO - Running post-action listener: _start_resource_monitoring 05:41:27 INFO - Starting resource monitoring. 05:41:27 INFO - [mozharness: 2016-07-21 12:41:27.053935Z] Finished create-virtualenv step (success) 05:41:27 INFO - [mozharness: 2016-07-21 12:41:27.054414Z] Running install step. 05:41:27 INFO - Running pre-action listener: _resource_record_pre_action 05:41:27 INFO - Running main action method: install 05:41:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:41:27 INFO - Reading from file tmpfile_stdout 05:41:27 INFO - Detecting whether we're running mozinstall >=1.0... 05:41:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:41:27 INFO - Reading from file tmpfile_stdout 05:41:27 INFO - Output received: 05:41:27 INFO - Usage: mozinstall [options] installer 05:41:27 INFO - Options: 05:41:27 INFO - -h, --help show this help message and exit 05:41:27 INFO - -d DEST, --destination=DEST 05:41:27 INFO - Directory to install application into. [default: 05:41:27 INFO - "/builds/slave/test"] 05:41:27 INFO - --app=APP Application being installed. [default: firefox] 05:41:27 INFO - mkdir: /builds/slave/test/build/application 05:41:27 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'] 05:41:27 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 05:41:44 INFO - Reading from file tmpfile_stdout 05:41:44 INFO - Output received: 05:41:44 INFO - /builds/slave/test/build/application/firefox/firefox 05:41:44 INFO - Running post-action listener: _resource_record_post_action 05:41:44 INFO - [mozharness: 2016-07-21 12:41:44.587612Z] Finished install step (success) 05:41:44 INFO - [mozharness: 2016-07-21 12:41:44.587893Z] Running run-tests step. 05:41:44 INFO - Running pre-action listener: _resource_record_pre_action 05:41:44 INFO - Running main action method: run_tests 05:41:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:41:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:41:44 INFO - Python 2.7.3 05:41:44 INFO - Return code: 0 05:41:44 INFO - grabbing minidump binary from tooltool 05:41:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:44 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 0x234f3b0>, '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 0x23502b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2350740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:41:44 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 05:41:44 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 05:41:44 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 05:41:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:41:44 INFO - Return code: 0 05:41:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:41:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:41:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:41:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:41:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:41:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bEEqB0Z3TC6mHWB38lcgNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 05:41:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bEEqB0Z3TC6mHWB38lcgNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 05:41:44 INFO - Using env: {'DISPLAY': ':0', 05:41:44 INFO - 'HOME': '/home/cltbld', 05:41:44 INFO - 'LANG': 'en_US.UTF-8', 05:41:44 INFO - 'LANGUAGE': 'en_US:en', 05:41:44 INFO - 'LOGNAME': 'cltbld', 05:41:44 INFO - 'MAIL': '/var/mail/cltbld', 05:41:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:41:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:41:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:44 INFO - 'MOZ_NO_REMOTE': '1', 05:41:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:41:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:44 INFO - 'NO_EM_RESTART': '1', 05:41:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:44 INFO - 'PWD': '/builds/slave/test', 05:41:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:41:44 INFO - 'SHELL': '/bin/bash', 05:41:44 INFO - 'SHLVL': '1', 05:41:44 INFO - 'TERM': 'linux', 05:41:44 INFO - 'TMOUT': '86400', 05:41:44 INFO - 'USER': 'cltbld', 05:41:44 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602', 05:41:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:44 INFO - '_': '/tools/buildbot/bin/python'} 05:41:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bEEqB0Z3TC6mHWB38lcgNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 05:41:44 INFO - mozversion application_buildid: 20160721023907 05:41:44 INFO - mozversion application_changeset: c6e4b6a744697056dcebe1cf298ed3b7de85311c 05:41:44 INFO - mozversion application_display_name: Nightly 05:41:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:41:44 INFO - mozversion application_name: Firefox 05:41:44 INFO - mozversion application_remotingname: firefox 05:41:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:41:44 INFO - mozversion application_vendor: Mozilla 05:41:44 INFO - mozversion application_version: 50.0a1 05:41:44 INFO - mozversion platform_buildid: 20160721023907 05:41:44 INFO - mozversion platform_changeset: c6e4b6a744697056dcebe1cf298ed3b7de85311c 05:41:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:41:44 INFO - mozversion platform_version: 50.0a1 05:41:44 INFO - using testdate: 1469104904 05:41:44 INFO - actual date: 1469104904 05:41:44 INFO - starting webserver on 'localhost:36440' 05:41:44 INFO - SUITE-START | Running 2 tests 05:41:44 INFO - TEST-START | dromaeo_css 05:41:44 INFO - operating with platform_type : linux_ 05:41:44 INFO - Initialising browser for dromaeo_css test... 05:41:44 INFO - TEST-INFO | started process 4144 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp76CBRJ/profile http://localhost:36440/getInfo.html) 05:41:49 INFO - PROCESS | 4144 | __metrics Screen width/height:1600/1200 05:41:49 INFO - PROCESS | 4144 | colorDepth:24 05:41:49 INFO - PROCESS | 4144 | Browser inner width/height: 1024/697 05:41:49 INFO - PROCESS | 4144 | __metrics 05:41:49 ERROR - PROCESS | 4144 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:41:50 INFO - TEST-INFO | 4144: exit 0 05:41:50 INFO - Browser initialized. 05:41:50 INFO - Running cycle 1/1 for dromaeo_css test... 05:41:50 INFO - TEST-INFO | started process 4263 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp76CBRJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:42:02 INFO - PROCESS | 4263 | RSS: Main: 167305216 05:42:02 INFO - PROCESS | 4263 | 05:42:51 INFO - PROCESS | 4263 | 1469104971934 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] 05:44:59 INFO - PROCESS | 4263 | Cycle 1(1): loaded http://localhost:36440/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36440/tests/dromaeo/cssquery-ext.html) 05:45:01 INFO - PROCESS | 4263 | RSS: Main: 172756992 05:45:01 INFO - PROCESS | 4263 | 05:48:03 INFO - PROCESS | 4263 | Cycle 1(1): loaded http://localhost:36440/tests/dromaeo/cssquery-ext.html (next: http://localhost:36440/tests/dromaeo/cssquery-jquery.html) 05:48:03 INFO - PROCESS | 4263 | RSS: Main: 168792064 05:48:03 INFO - PROCESS | 4263 | 05:51:05 INFO - PROCESS | 4263 | Cycle 1(1): loaded http://localhost:36440/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36440/tests/dromaeo/cssquery-mootools.html) 05:51:06 INFO - PROCESS | 4263 | RSS: Main: 173355008 05:51:06 INFO - PROCESS | 4263 | 05:54:08 INFO - PROCESS | 4263 | Cycle 1(1): loaded http://localhost:36440/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36440/tests/dromaeo/cssquery-prototype.html) 05:54:08 INFO - PROCESS | 4263 | RSS: Main: 167780352 05:54:08 INFO - PROCESS | 4263 | 05:57:11 INFO - PROCESS | 4263 | Cycle 1(1): loaded http://localhost:36440/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36440/tests/dromaeo/cssquery-yui.html) 05:57:12 INFO - PROCESS | 4263 | RSS: Main: 170024960 05:57:12 INFO - PROCESS | 4263 | 06:00:15 INFO - PROCESS | 4263 | Cycle 1(1): loaded http://localhost:36440/tests/dromaeo/cssquery-yui.html (next: http://localhost:36440/tests/dromaeo/cssquery-dojo.html) 06:00:15 INFO - PROCESS | 4263 | RSS: Main: 170831872 06:00:15 INFO - PROCESS | 4263 | 06:00:15 INFO - PROCESS | 4263 | __start_tp_report 06:00:15 INFO - PROCESS | 4263 | _x_x_mozilla_page_load 06:00:15 INFO - PROCESS | 4263 | _x_x_mozilla_page_load_details 06:00:15 INFO - PROCESS | 4263 | |i|pagename|runs| 06:00:15 INFO - PROCESS | 4263 | |0;dojo.html;3078.1535077853587;3088.1044497095836;3088.4132014917163;3110.3157305392806;3118.3295591447836;5424.430434804348;5453.972730136354;5465.262189604402;5509.090999984997;5517.310336207974;5372.409035006156;5395.271638328824;5407.351117865852;5481.780728770855;5491.890162196763;4930.580900623433;5011.498850114996;5016.172331565296;5017.247412888078;5035.320231768719;673.4530689637011;5034.672746271499;5080.339555857752;5096.235564665311;5140.588752899777;4983.22759972203;5038.773255203506;5039.546440820325;5049.570786483153;5073.670211436245;4962.4789397113145;4979.47715489872;5000.574951129159;5006.949930500721;5035.345405097314;4957.652964292501;4970;4975.875603109915;5029.698218106925;5037.420696619899;5343.465653434664;5411.621186516945;5418.187271909206;5473.863153421156;5517.613767036309;5876.206712093898;5894.852628684317;5898.734556944948;5907.940920590782;5930.7924222652;5903.763849446017;5928.081147422156;5958.5828991970575;5962.70186490678;5963.612365196292;5389.137737961907;5448.99999999996;5467.043267428184;5494.780208791643;5582.581306402036;6041.8489537761025;6062.120992456157;6063.575549711478;6064.4541991221;6070.878582428327;5769.1923130761725;5807;5810.7628563003545;5836;5844.561657875676;5781.94218057814;5791.305043394736;5820.708964551755;5831.183634291203;5888.057910734262;5790.10253410722;5821.505172060422;5868.970655146697;5869.647821130746;5883.94116058834;5754.280714910637;5825.2135961644635;5826.2134611827705;5827.76688932438;5838.94161058384;4427.070315233773;4456.77716114193;4488.281874900001;4496.662750293741;4553.704009239389;4001.9399709004388;4006.1787333596544;4013.7591744495426;4016.4577781999055;4045.3931910213705;5663.235463212496;5682.943170568324;5692.060809966392;5705.5435565154685;5710.172025056344;5732.856678583069;5802.419758024248;5831.737571809279;5868.823935281948;5869.970650146722;5675.687837168995;5678.261825962681;5693.0891057431445;5693.5160511357;5741.741621627037;5114.616403769732;5128.8461346159675;5141.845744627667;5143.485651434827;5145.691258524501;5974.462298393166;6085.513158947274;6094.695265236721;6128.050152226412;6153.292371377349;5965.701714914324;5971.462568368867;5972.193753843176;5984.162217289496;6002.669853158118;6143.354947730602;6144.662043587646;6161.753529858755;6176.413240742122;6183.752649893954;5687.090065589651;5725.2843394575675;5762.394948530512;5789.363170051207;5813.866296072225;5939.673317967553;5940.851478713067;5941.287045554561;5942.376050514634;5945.3757355477055;5754.05058165398;5798.043322851682;5803.535717142534;5804.1874137619925;5806.5645076618575;5663.716814159358;5704.458076482728;5743.4256574342235;5743.971280143573;5779.2775903012125;5701.144828275792;5702.45826646468;5707.086866101404;5740.339860916049;5749.108888122348;5789.8263052108505;5819.94180058194;5828.562857785599;5834.737436815439;5886.440788125121;5576.77692892296;5657.745401456862;5691.203231547669;5723.112917497794;5731.541476681939 06:00:15 INFO - PROCESS | 4263 | |1;ext.html;574.494444888498;587.239524815364;587.409653298435;605.7576969212314;626.3423405424303;40074.398884016766;43357.566424335746;43380.78309608447;43398.56601433985;43459;43424.348634770504;43732.78133609328;43737;43779.3433098503;43801.780991095;8797.340199485032;8966.372353935227;9022.413543119676;9031.187193152615;9037.819243615124;8884.15600517953;8922.840030795987;8942.105789421072;9014.954925225398;9015.963164236131;8898.822023559558;8920.553972301392;8944.597493112826;8977.102289771003;9001.95499022504;8948;8990.730278091667;9022.639094436214;9040.367174297802;9059.139381758789;8629.395942284043;8763.912360876373;8767.167119123673;8805.25155361795;8809.075047120088;41592.79203603993;41836.79081604603;41919.7904010478;42075.36886946698;42159.1568168638;2975.9851200743856;3335.96664033359;3336.6996970272794;3413.1296519387397;3433.6909678128836;28635.57046644302;29443;30748.38503229945;31413.528797068062;31674.524882126785;4276.764777937212;4332.783360831946;4335.328024156261;4342.739435633841;4352.673549483801;333343;333989;335046;336030;336889;35486.29027419437;35713;35809.10477238038;35883.82058089745;35923;35515.82242088773;36405.81797090998;36511;36544.63455365466;36786;15931.601709957344;16069.67860642804;16196.676066478605;16211.35154593803;16218.189090545426;12137.332446715516;12139.393030348447;12256.632301030982;12266.754664906652;12278.263304201777;19506.804931950497;19567.60864782725;19608.70586941197;19640.017999100273;19643.410697679094;6886.2769409212315;6956.373926346653;7088.645567721594;7132.572045677276;7280.199178090405;1020.6121673763922;1024.6925922223304;1066.157735389034;1119.7536541960756;1174.5947648061406;33993.57253884751;34191.48712769311;34338.313233735185;34435.311293773986;34567.65432345695;1137.0846468592697;1143.954241830334;1145.2498613408231;1146.8681101673415;1164.394514852289;17592;17636.735448968277;17685.292588296583;17724.20241089154;17809.3982437373;607155;611423;612650;613473;614876;59911.700441497516;60427.395726042174;60476;60633.393666063654;60668;1293.340396397844;1313.5533918467577;1327.6481732340937;1357.7623915814693;1372.7597670407638;31485.212869677525;31965.840170798998;33052.83473582617;33283.33433331368;34622.65377346194;58534.414655852896;59188;59232.40767592441;59300;59400.70299648647;523106;524360;526000;527555;528178;45570.31644525401;45860.770696146305;46056.53943460523;46136.307955381366;46265.53734462612;50132.24801627905;50370;51449.742751286;51810;52532.7373363146;41336.793316033225;42896.78551607222;43781;44450.777746112355;44501.33248001347;42684.78657606692;43152.784236078616;43154.136917262105;43649;44692.10615787601;40964.38553421761;41508.792456037525;41853.58146418619;42342.78828605837;42809;34937.30125397427;37971.43042854304;38020.61979380171;38199;38932.80533597314;29158;29171.562426564044;29571.556426653187;29631.85184074066;29661.703382966756 06:00:15 INFO - PROCESS | 4263 | |2;jquery.html;386.51878411377857;387.1386165781139;398.07844839197264;404.5691338724258;410.9630133288005;13125.671858203526;18690.345837895675;19408.223671053176;20259.99999999998;20438.89780551097;19166.137523811427;19219.231230750753;19622.60754784907;19981.700274495895;20096.196152153934;5662.745176467049;5761.567882408815;5803.564732645047;5832;5865.32548756892;5702.686352250625;5735.426457354252;5745.798897038604;5756.165356023374;5769.740361683714;5551.361593416748;5675.716214189295;5677.17680936264;5704.857378565527;5721.141828725683;5653;5677.829665110054;5680.573956953245;5680.715964201794;5688;4797.18447863864;5022.949770502285;5069.163588008011;5089.185730283174;5127.743612819381;12961.870381296161;13122.015848811378;13167.144135631153;13372.197668139943;13492.325383730873;2452.5340185364726;2683.2486903667004;2837.205582436921;2862.298736809495;2862.4561333346596;10167.796644067152;10292;10798.73003174919;11143.554257829677;14301.57095287143;1699.8895071820293;1801.1894647408587;1832.221305944968;1832.3586744639404;1836.4674244469088;81098;84340.57829710873;85393.14606853976;85462.57268713617;85670;10008.899911000797;10495.212859035602;10704.732381690521;10841.403722795165;10946.562137514411;14459.421623134956;14493.565193044225;14500.274986250644;14527.273636318141;14559.490417835324;7636;7788.337991270692;7810.960945195351;8010.5994700264755;8166.305864001508;7566;7566.31903128721;7706.884396734054;7872.56700881457;7888.723894663774;4063.5733248009124;4364.869053928387;4414.690971631955;4509.413776209072;4560.863174104782;1844.382131985773;1871.1953859840398;1901.2585091814203;1902.7621547306587;1977.7923318051685;926.7868390270276;967.3422072990294;976.2921881635757;1041.3699711674478;1084.452351562456;19765.22113009836;20402;20421.897890510452;20492.59014819725;20574.69137962932;980.0983095552109;981.9852702209473;986.6743974488402;1031.504877658713;1034.7361422837128;9520.571574279036;10829.052681877867;11194.10447164225;11329.320240785579;11355.489002994886;500146;502069;503689;508258;508840;94326;95135;96494.51752741332;96646;99246.50376748215;1029.902159294866;1086.2124959404368;1105.6682995101437;1117.754094099297;1119.1829964126234;17879;17956.371526996492;18624.627507450045;18807;19058;42537.5746242546;43373.3493997584;43418;43882;44787;58822.411775881694;59077.40922590891;59257;60689.69655151696;62301;7748.92251077482;7797.961010195139;7863.921360786548;7998.240167184108;8223.54770487605;12086.45610947527;12641.178323409316;12695.42870570808;12846.807297890353;12894.29081400532;10943.83584246253;11138.498767555317;11270.380129092979;11330.093592512743;11558.826617600575;10638.73403164927;10906.781864362827;10954.233203675667;11125.666230013112;11555.2489088209;10513.211509136692;10677.412742299248;10710.464476775975;11040.227184097357;11201.38392388394;6904.723811047502;6992.685329160302;7422.925770742223;7474.439417043634;7475.663595138123;10043.497825108569;10051.145652619316;10308.226882983656;10689.198310126927;11059.778804423706 06:00:15 INFO - PROCESS | 4263 | |3;mootools.html;1503.70677717845;1512.9167895765731;1676.9329226830928;1784.9107544622766;1817.7091665333548;8163.673453061885;8865.246454051397;8894.866577001341;9543.618255269797;9550.80898382032;8874.290056795457;9237.307201959846;9268.351215414923;9314.254859611232;9327.953360233207;2379.5716770981257;2416.867072311022;2423.006567307404;2423.5758742220128;2424.781769640732;2356.5051339218785;2371.2767605880285;2414.396400899775;2414.601590737535;2418.093215044358;2374.905003799846;2382.916597919073;2407.711074671042;2416.613341865302;2417.3231495181376;2284.3375421127935;2298.069281940817;2301.8158547316175;2307.3193407944614;2371.4782747795457;2261.9434514137115;2276.704028476304;2280.942976425586;2305.5158416732506;2309.21486694523;9291.76770580734;9315.115064068903;9365.11031452011;9401.435913845124;9427.434353938717;5427.294451721291;5525.419830917736;5564.777408903639;5567.47109024646;5569.888602227973;3456.2396272819938;3505.439129739255;3522.4011917974008;3524.4360902255517;3554.0937061049526;1164.6913567904512;1169.6724917023162;1183.3314177489776;1192.320377384891;2078.189506092625;12629.557965471164;13011.21932684042;13026.41381137851;13028.609141725763;13061.804072938914;4342.522322544518;4559.430071241095;4629.537046295411;4669.369635099286;4736.905261894743;10107.090361867467;10114.342567733222;10119.544620492095;10229.59081636741;10238.232132590085;5419.078756611386;5437.265969094122;5441.374241962225;5445.237666726662;5457.126859702428;4306.547812479707;4873.537013983666;4963.801447942042;5005.499450055038;5104.795808167706;3797.1646237827636;3885.261800257942;3951.4665520154986;3955.2287303976022;4014.458048163519;1162.8255761635821;1171.7949358862336;1176.6528873982024;1180.2446434282067;1203.1036877526299;901.8557030875029;946.8721722567503;979.9514519464105;984.4487087231173;1005.1104772276442;5808.854778630568;5890.558208134321;6037.969810150921;6102.786402475892;6125.938740612626;431.73448329277267;440.1922472263432;442.4668274728944;449.7841036302593;463.4531253121282;3859.826307816099;4045.110075783323;4100.856470023535;4105;4112.300908845504;11201.887981120084;11583.362915039754;11601.651950441501;11695.76608467843;11719.941400292944;11508.94245528767;11594.594189203337;11595.536178552764;11599;11621.128415368881;8470.618822153017;8545.84631074797;8589.828203436022;8626.654933802578;8693.913060869438;5900.7049647518315;6033.9698301508215;6043.395660434097;6111;6122.6938653068055;10654.8934510657;10671.679849604525;10696.304740191863;10747.731306717082;10867.836982445428;10797.784044318912;10845.78308433811;10933.671989840317;10964.671059868217;11093.22347435704;6826.726930922708;7455.478116531791;7582.54504729718;7659.655315510704;7846.33306168982;8906.287497000094;8918.331125165769;8946.776330591527;8978.551072446482;8987.236084932854;7423.8144046399275;7595.3164215220895;7766.417518686234;7983.121856595653;8107.635156417858;7554.6600402983095;7627.237276272328;7648.80877978055;7788.532688038509;7797.532148070907;6826.93173068263;6890.379865812101;6903.585784852925;6925.238223795479;6934.826629334307;4752.239641657318;4818.614510839055;4872.366592342973;5019.598432125348;5069.949300506948;5001.924971125509;5076.5431111198695;5108.029474399852;5228.1112210923475;5243.501867322599 06:00:15 INFO - PROCESS | 4263 | |4;prototype.html;319.32622167227134;321.95814544109265;327.5463483075939;329.65715655718054;329.73785840256994;5468.26178465907;5477.5070243678065;5622.156676498522;5661.462161094694;5684.715764211794;5484.61607687462;5519.365272993607;5538.9169162462595;5564.081926482136;5576.247206627104;4334.566543345656;4355.629771469413;4362.716423432466;4368.803403846835;4369.519352871182;4080.3471444568877;4265.893352666177;4290.377895205193;4371.6229387742915;4375.278079116942;4244.851430199944;4249.617534421902;4253.914921701564;4258.723182993111;4265.893352666177;4217.746935183899;4256.616904478597;4260.467441569804;4270.167317373113;4278.764667943262;3481.756277060607;3692.2061756722164;3715.8142092895246;3717.460968159629;3720.5535335759882;5359.705216213107;5393.1370980643305;5420.430854760233;5421.430749771257;5460.153676180198;4886.70679759212;4905.509449055102;4907.312976183337;4908.9754551227015;4909.975450122726;5505.917411238835;5754.424557544254;5810.82567522975;5823.767049318065;5827.679477628729;4066.410370496291;4083.9795801020805;4085;4087.121268927165;4088.9795551022053;5984.311804142536;6035.336113027563;6037.879242415127;6037.969810151009;6055.152278680944;4045.8786236412957;4093.07625416054;4118.299889018874;4150.27370210212;4157.833686652561;4191.979040104841;4201.663866890642;4202.831886724497;4206.653870761388;4213.094184750294;4852.888993287931;4855.223164293767;4855.514448555116;4864.95135048645;4871.585915197248;5591.944080559224;5815.73829177688;5815.970920145457;5825.504832089235;5857.384974577608;1446.9421223151166;1455.1269238456841;1455.294182321573;1460.1312219229542;1467.669774300795;861.4615865084322;905.3843386497246;911.2345629671108;920.636348642296;924.4222361024359;5031.421386540522;5032.874178145576;5066.898662026739;5072.51811077947;5101.107306221396;5316.288692766717;5330.147176451749;5356.3572371315695;5358.410574836765;5366.463353664602;5044.2937988681615;5073.771680274396;5103.234514822732;5351.705656188869;5802.419758024248;3202.343519578481;3202.9270194484643;3213.742900567949;3235.980666090174;3243.5621191139367;6184.412480814405;6286.277078135981;6288.748450061947;6296.024116261987;6299.937000629935;6122.632642041492;6129.969350153221;6131.754729810847;6142.385761423822;6146.692665366803;6250.312465628777;6277.18396608438;6277.7175027123885;6292.46514046302;6304.501001943965;5843.766249350148;5994.7111371055435;6035.637861728311;6073.635581865102;6075.1798507200965;5974.641521508724;5981.192539007178;6001.159837622824;6002.95899394208;6004.279486461478;5939.881202376015;6240.032794916795;6253.6230435564285;6285.905711414241;6287.874242515216;4060.2285565743596;4145.191687620885;4198.139381426739;4200.264953633041;4200.9369859452745;5997.940020599913;6007.438066102932;6008.699565021644;6020.367861374492;6021.488173505126;5727.8568035799435;5813.56398270123;5827.883442331215;5845.503132233808;5846.1815345852465;5778.266520043886;5830.912536311874;5856.59003869725;5869.325027621878;5869.53043756507;5785.537157027344;5786.218860453953;5797.681127538026;5799.188113664006;5799.797007104731;5705.372409035086;5874.177615133799;5905.232319798399;5907.940920590911;5920.674362909909;5707.514861236841;5763.164341170591;5776.8555786104;5796.188533605383;5799.507041901317 06:00:15 INFO - PROCESS | 4263 | |5;yui.html;704.3555147040455;729.3472342253682;741.055154677786;780.1496368957835;785.1677222144527;14525.564233072999;15627.687446251068;15682.451114211004;15691.52925412238;15699.60750981226;13620.455181792717;13714.31428428577;13715.451381944735;13733.862661373383;13749.725005499884;647.5305403582389;761.9161892191854;767.9424043196755;785.4698078796818;795.1333046978792;780.8126049748076;795.0499153511556;795.5028107432854;796.1083586383259;797.103258833812;854.5897968974896;858.4849090545686;859.8280343931208;861.7888617288774;863.5164307987516;852.2755657690975;854.6752234151014;856.3021137772757;856.8329175810751;860.7073594977707;625.1591609285504;629.4649547884308;630;630.6247782569363;633.3413250219766;12868.22790632565;12931.224126552437;13033.934830325883;13061.934690326583;13096.803547946789;15369;15405.22973851303;15455.459058932996;15569.455069072528;15822.208889555477;11670.008049315818;11952.52189912411;11996.340201288926;12065.638030859;12414.62756117318;3776.6978641708597;3870.3807390817615;3873.2447172801317;3913.960860391388;4014.036631208489;78283;80148;80265;80614.59692701558;80640.19359806445;10735.624253151102;10749.08632766208;10766.138708903269;10796.946015269874;11053.557857685764;21917.452063698536;22076.116955321606;22081.668774968388;22082.558348833256;22091.889540552194;8066.395020373496;8094.473859199134;8200.958995204986;8349.03986041613;8556.18716221958;4503.234450143484;4602.907941841145;4634.374359461497;4685.8594242172785;4820.373351464287;3438.484227365865;3529.294141171776;3544.794769778288;3547.467879817996;3558.5018097466377;600.6846405636988;613.9348230819525;613.9662318572522;621.6767281013938;624.8843963866699;625.4652272307203;661.497262080822;703.5919166883195;708.9326513981164;726.9745558905519;9062.184403403726;9619.290222308315;9822.440498677743;9846.113849753556;10057.899421005697;611.3916652930362;689.018149137477;690.1304356510732;706.7526365771938;740.1636151149168;4285.3360376877945;4590.54094590545;4637.721736695809;4691.366665500182;4722.291656251589;113332.43333783279;115623;115716.42141789237;119019.40490297493;119716;77162.61418692871;84492;97580;98231.50884245677;98456.50771746096;84857;85641.57179214065;86776;88545.55727221452;91150.54424727833;8931.062238464867;9068;9187.862182067409;9263.953680231556;9316.534173291444;51269;51395;52657.210141847136;52895.20657190222;53033;68290.65854670695;68394;72437.63781181061;76116.23883761313;76920;13048.673783155496;13490.325483725579;13518.526851560147;13567;13578.185308881499;14725.410983560538;15276.770848437505;15827.446039388566;16241.269142888363;16270.918645406697;13748.793768093687;14188.432462701376;14465.204413757345;14555.12669239849;14762.557123286319;14193.432262709788;14532.636684082983;14872.7769083466;15018;15032.549023529311;13935;14515.346809393392;14730.852691472948;14754.409823606935;15050.247487625795;11098.500567474644;11337.546498139982;11391;11419.429028548706;11458.255213411101;9755.853662195215;10458.477076146315;11199.88800112021;11718.70703232426;11801.35092569917 06:00:15 INFO - PROCESS | 4263 | __end_tp_report 06:00:15 INFO - PROCESS | 4263 | __start_cc_report 06:00:15 INFO - PROCESS | 4263 | _x_x_mozilla_cycle_collect,359 06:00:15 INFO - PROCESS | 4263 | __end_cc_report 06:00:15 INFO - PROCESS | 4263 | __startTimestamp1469106015325__endTimestamp 06:00:15 INFO - PROCESS | 4263 | 06:00:15 INFO - PROCESS | 4263 | ------- Summary: start ------- 06:00:15 INFO - PROCESS | 4263 | Number of tests: 6 06:00:15 INFO - PROCESS | 4263 | 06:00:15 INFO - PROCESS | 4263 | [#0] dojo.html Cycles:165 Average:5450.51 Median:5723.11 stddev:735.61 (12.9%) stddev-sans-first:713.94 06:00:15 INFO - PROCESS | 4263 | Values: 3078.2 3088.1 3088.4 3110.3 3118.3 5424.4 5454.0 5465.3 5509.1 5517.3 5372.4 5395.3 5407.4 5481.8 5491.9 4930.6 5011.5 5016.2 5017.2 5035.3 673.5 5034.7 5080.3 5096.2 5140.6 4983.2 5038.8 5039.5 5049.6 5073.7 4962.5 4979.5 5000.6 5006.9 5035.3 4957.7 4970.0 4975.9 5029.7 5037.4 5343.5 5411.6 5418.2 5473.9 5517.6 5876.2 5894.9 5898.7 5907.9 5930.8 5903.8 5928.1 5958.6 5962.7 5963.6 5389.1 5449.0 5467.0 5494.8 5582.6 6041.8 6062.1 6063.6 6064.5 6070.9 5769.2 5807.0 5810.8 5836.0 5844.6 5781.9 5791.3 5820.7 5831.2 5888.1 5790.1 5821.5 5869.0 5869.6 5883.9 5754.3 5825.2 5826.2 5827.8 5838.9 4427.1 4456.8 4488.3 4496.7 4553.7 4001.9 4006.2 4013.8 4016.5 4045.4 5663.2 5682.9 5692.1 5705.5 5710.2 5732.9 5802.4 5831.7 5868.8 5870.0 5675.7 5678.3 5693.1 5693.5 5741.7 5114.6 5128.8 5141.8 5143.5 5145.7 5974.5 6085.5 6094.7 6128.1 6153.3 5965.7 5971.5 5972.2 5984.2 6002.7 6143.4 6144.7 6161.8 6176.4 6183.8 5687.1 5725.3 5762.4 5789.4 5813.9 5939.7 5940.9 5941.3 5942.4 5945.4 5754.1 5798.0 5803.5 5804.2 5806.6 5663.7 5704.5 5743.4 5744.0 5779.3 5701.1 5702.5 5707.1 5740.3 5749.1 5789.8 5819.9 5828.6 5834.7 5886.4 5576.8 5657.7 5691.2 5723.1 5731.5 06:00:15 INFO - PROCESS | 4263 | 06:00:15 INFO - PROCESS | 4263 | [#1] ext.html Cycles:180 Average:64237.92 Median:42513.79 stddev:134459.55 (316.3%) stddev-sans-first:134751.79 06:00:15 INFO - PROCESS | 4263 | Values: 574.5 587.2 587.4 605.8 626.3 40074.4 43357.6 43380.8 43398.6 43459.0 43424.3 43732.8 43737.0 43779.3 43801.8 8797.3 8966.4 9022.4 9031.2 9037.8 8884.2 8922.8 8942.1 9015.0 9016.0 8898.8 8920.6 8944.6 8977.1 9002.0 8948.0 8990.7 9022.6 9040.4 9059.1 8629.4 8763.9 8767.2 8805.3 8809.1 41592.8 41836.8 41919.8 42075.4 42159.2 2976.0 3336.0 3336.7 3413.1 3433.7 28635.6 29443.0 30748.4 31413.5 31674.5 4276.8 4332.8 4335.3 4342.7 4352.7 333343.0 333989.0 335046.0 336030.0 336889.0 35486.3 35713.0 35809.1 35883.8 35923.0 35515.8 36405.8 36511.0 36544.6 36786.0 15931.6 16069.7 16196.7 16211.4 16218.2 12137.3 12139.4 12256.6 12266.8 12278.3 19506.8 19567.6 19608.7 19640.0 19643.4 6886.3 6956.4 7088.6 7132.6 7280.2 1020.6 1024.7 1066.2 1119.8 1174.6 33993.6 34191.5 34338.3 34435.3 34567.7 1137.1 1144.0 1145.2 1146.9 1164.4 17592.0 17636.7 17685.3 17724.2 17809.4 607155.0 611423.0 612650.0 613473.0 614876.0 59911.7 60427.4 60476.0 60633.4 60668.0 1293.3 1313.6 1327.6 1357.8 1372.8 31485.2 31965.8 33052.8 33283.3 34622.7 58534.4 59188.0 59232.4 59300.0 59400.7 523106.0 524360.0 526000.0 527555.0 528178.0 45570.3 45860.8 46056.5 46136.3 46265.5 50132.2 50370.0 51449.7 51810.0 52532.7 41336.8 42896.8 43781.0 44450.8 44501.3 42684.8 43152.8 43154.1 43649.0 44692.1 40964.4 41508.8 41853.6 42342.8 42809.0 34937.3 37971.4 38020.6 38199.0 38932.8 29158.0 29171.6 29571.6 29631.9 29661.7 06:00:15 INFO - PROCESS | 4263 | 06:00:15 INFO - PROCESS | 4263 | [#2] jquery.html Cycles:180 Average:29318.62 Median:2849.75 stddev:83382.82 (2926.0%) stddev-sans-first:83588.44 06:00:15 INFO - PROCESS | 4263 | Values: 386.5 387.1 398.1 404.6 411.0 13125.7 18690.3 19408.2 20260.0 20438.9 19166.1 19219.2 19622.6 19981.7 20096.2 5662.7 5761.6 5803.6 5832.0 5865.3 5702.7 5735.4 5745.8 5756.2 5769.7 5551.4 5675.7 5677.2 5704.9 5721.1 5653.0 5677.8 5680.6 5680.7 5688.0 4797.2 5022.9 5069.2 5089.2 5127.7 12961.9 13122.0 13167.1 13372.2 13492.3 2452.5 2683.2 2837.2 2862.3 2862.5 10167.8 10292.0 10798.7 11143.6 14301.6 1699.9 1801.2 1832.2 1832.4 1836.5 81098.0 84340.6 85393.1 85462.6 85670.0 10008.9 10495.2 10704.7 10841.4 10946.6 14459.4 14493.6 14500.3 14527.3 14559.5 7636.0 7788.3 7811.0 8010.6 8166.3 7566.0 7566.3 7706.9 7872.6 7888.7 4063.6 4364.9 4414.7 4509.4 4560.9 1844.4 1871.2 1901.3 1902.8 1977.8 926.8 967.3 976.3 1041.4 1084.5 19765.2 20402.0 20421.9 20492.6 20574.7 980.1 982.0 986.7 1031.5 1034.7 9520.6 10829.1 11194.1 11329.3 11355.5 500146.0 502069.0 503689.0 508258.0 508840.0 94326.0 95135.0 96494.5 96646.0 99246.5 1029.9 1086.2 1105.7 1117.8 1119.2 17879.0 17956.4 18624.6 18807.0 19058.0 42537.6 43373.3 43418.0 43882.0 44787.0 58822.4 59077.4 59257.0 60689.7 62301.0 7748.9 7798.0 7863.9 7998.2 8223.5 12086.5 12641.2 12695.4 12846.8 12894.3 10943.8 11138.5 11270.4 11330.1 11558.8 10638.7 10906.8 10954.2 11125.7 11555.2 10513.2 10677.4 10710.5 11040.2 11201.4 6904.7 6992.7 7422.9 7474.4 7475.7 10043.5 10051.1 10308.2 10689.2 11059.8 06:00:15 INFO - PROCESS | 4263 | 06:00:15 INFO - PROCESS | 4263 | [#3] mootools.html Cycles:180 Average:5950.45 Median:446.13 stddev:3490.92 (782.5%) stddev-sans-first:3484.72 06:00:15 INFO - PROCESS | 4263 | Values: 1503.7 1512.9 1676.9 1784.9 1817.7 8163.7 8865.2 8894.9 9543.6 9550.8 8874.3 9237.3 9268.4 9314.3 9328.0 2379.6 2416.9 2423.0 2423.6 2424.8 2356.5 2371.3 2414.4 2414.6 2418.1 2374.9 2382.9 2407.7 2416.6 2417.3 2284.3 2298.1 2301.8 2307.3 2371.5 2261.9 2276.7 2280.9 2305.5 2309.2 9291.8 9315.1 9365.1 9401.4 9427.4 5427.3 5525.4 5564.8 5567.5 5569.9 3456.2 3505.4 3522.4 3524.4 3554.1 1164.7 1169.7 1183.3 1192.3 2078.2 12629.6 13011.2 13026.4 13028.6 13061.8 4342.5 4559.4 4629.5 4669.4 4736.9 10107.1 10114.3 10119.5 10229.6 10238.2 5419.1 5437.3 5441.4 5445.2 5457.1 4306.5 4873.5 4963.8 5005.5 5104.8 3797.2 3885.3 3951.5 3955.2 4014.5 1162.8 1171.8 1176.7 1180.2 1203.1 901.9 946.9 980.0 984.4 1005.1 5808.9 5890.6 6038.0 6102.8 6125.9 431.7 440.2 442.5 449.8 463.5 3859.8 4045.1 4100.9 4105.0 4112.3 11201.9 11583.4 11601.7 11695.8 11719.9 11508.9 11594.6 11595.5 11599.0 11621.1 8470.6 8545.8 8589.8 8626.7 8693.9 5900.7 6034.0 6043.4 6111.0 6122.7 10654.9 10671.7 10696.3 10747.7 10867.8 10797.8 10845.8 10933.7 10964.7 11093.2 6826.7 7455.5 7582.5 7659.7 7846.3 8906.3 8918.3 8946.8 8978.6 8987.2 7423.8 7595.3 7766.4 7983.1 8107.6 7554.7 7627.2 7648.8 7788.5 7797.5 6826.9 6890.4 6903.6 6925.2 6934.8 4752.2 4818.6 4872.4 5019.6 5069.9 5001.9 5076.5 5108.0 5228.1 5243.5 06:00:15 INFO - PROCESS | 4263 | 06:00:15 INFO - PROCESS | 4263 | [#4] prototype.html Cycles:180 Average:4855.13 Median:5481.06 stddev:1458.43 (26.6%) stddev-sans-first:1422.23 06:00:15 INFO - PROCESS | 4263 | Values: 319.3 322.0 327.5 329.7 329.7 5468.3 5477.5 5622.2 5661.5 5684.7 5484.6 5519.4 5538.9 5564.1 5576.2 4334.6 4355.6 4362.7 4368.8 4369.5 4080.3 4265.9 4290.4 4371.6 4375.3 4244.9 4249.6 4253.9 4258.7 4265.9 4217.7 4256.6 4260.5 4270.2 4278.8 3481.8 3692.2 3715.8 3717.5 3720.6 5359.7 5393.1 5420.4 5421.4 5460.2 4886.7 4905.5 4907.3 4909.0 4910.0 5505.9 5754.4 5810.8 5823.8 5827.7 4066.4 4084.0 4085.0 4087.1 4089.0 5984.3 6035.3 6037.9 6038.0 6055.2 4045.9 4093.1 4118.3 4150.3 4157.8 4192.0 4201.7 4202.8 4206.7 4213.1 4852.9 4855.2 4855.5 4865.0 4871.6 5591.9 5815.7 5816.0 5825.5 5857.4 1446.9 1455.1 1455.3 1460.1 1467.7 861.5 905.4 911.2 920.6 924.4 5031.4 5032.9 5066.9 5072.5 5101.1 5316.3 5330.1 5356.4 5358.4 5366.5 5044.3 5073.8 5103.2 5351.7 5802.4 3202.3 3202.9 3213.7 3236.0 3243.6 6184.4 6286.3 6288.7 6296.0 6299.9 6122.6 6130.0 6131.8 6142.4 6146.7 6250.3 6277.2 6277.7 6292.5 6304.5 5843.8 5994.7 6035.6 6073.6 6075.2 5974.6 5981.2 6001.2 6003.0 6004.3 5939.9 6240.0 6253.6 6285.9 6287.9 4060.2 4145.2 4198.1 4200.3 4200.9 5997.9 6007.4 6008.7 6020.4 6021.5 5727.9 5813.6 5827.9 5845.5 5846.2 5778.3 5830.9 5856.6 5869.3 5869.5 5785.5 5786.2 5797.7 5799.2 5799.8 5705.4 5874.2 5905.2 5907.9 5920.7 5707.5 5763.2 5776.9 5796.2 5799.5 06:00:15 INFO - PROCESS | 4263 | 06:00:15 INFO - PROCESS | 4263 | [#5] yui.html Cycles:180 Average:20776.86 Median:4661.79 stddev:29767.18 (638.5%) stddev-sans-first:29812.53 06:00:15 INFO - PROCESS | 4263 | Values: 704.4 729.3 741.1 780.1 785.2 14525.6 15627.7 15682.5 15691.5 15699.6 13620.5 13714.3 13715.5 13733.9 13749.7 647.5 761.9 767.9 785.5 795.1 780.8 795.0 795.5 796.1 797.1 854.6 858.5 859.8 861.8 863.5 852.3 854.7 856.3 856.8 860.7 625.2 629.5 630.0 630.6 633.3 12868.2 12931.2 13033.9 13061.9 13096.8 15369.0 15405.2 15455.5 15569.5 15822.2 11670.0 11952.5 11996.3 12065.6 12414.6 3776.7 3870.4 3873.2 3914.0 4014.0 78283.0 80148.0 80265.0 80614.6 80640.2 10735.6 10749.1 10766.1 10796.9 11053.6 21917.5 22076.1 22081.7 22082.6 22091.9 8066.4 8094.5 8201.0 8349.0 8556.2 4503.2 4602.9 4634.4 4685.9 4820.4 3438.5 3529.3 3544.8 3547.5 3558.5 600.7 613.9 614.0 621.7 624.9 625.5 661.5 703.6 708.9 727.0 9062.2 9619.3 9822.4 9846.1 10057.9 611.4 689.0 690.1 706.8 740.2 4285.3 4590.5 4637.7 4691.4 4722.3 113332.4 115623.0 115716.4 119019.4 119716.0 77162.6 84492.0 97580.0 98231.5 98456.5 84857.0 85641.6 86776.0 88545.6 91150.5 8931.1 9068.0 9187.9 9264.0 9316.5 51269.0 51395.0 52657.2 52895.2 53033.0 68290.7 68394.0 72437.6 76116.2 76920.0 13048.7 13490.3 13518.5 13567.0 13578.2 14725.4 15276.8 15827.4 16241.3 16270.9 13748.8 14188.4 14465.2 14555.1 14762.6 14193.4 14532.6 14872.8 15018.0 15032.5 13935.0 14515.3 14730.9 14754.4 15050.2 11098.5 11337.5 11391.0 11419.4 11458.3 9755.9 10458.5 11199.9 11718.7 11801.4 06:00:15 INFO - PROCESS | 4263 | -------- Summary: end -------- 06:00:15 INFO - PROCESS | 4263 | 06:00:16 INFO - TEST-INFO | 4263: exit 0 06:00:16 INFO - TEST-OK | dromaeo_css | took 1111172ms 06:00:16 INFO - TEST-START | kraken 06:00:16 INFO - operating with platform_type : linux_ 06:00:16 INFO - Initialising browser for kraken test... 06:00:16 INFO - TEST-INFO | started process 4510 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgZNziH/profile http://localhost:36440/getInfo.html) 06:00:20 INFO - PROCESS | 4510 | __metrics Screen width/height:1600/1200 06:00:20 INFO - PROCESS | 4510 | colorDepth:24 06:00:20 INFO - PROCESS | 4510 | Browser inner width/height: 1024/697 06:00:20 INFO - PROCESS | 4510 | __metrics 06:00:21 ERROR - PROCESS | 4510 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 06:00:21 INFO - TEST-INFO | 4510: exit 0 06:00:21 INFO - Browser initialized. 06:00:21 INFO - Running cycle 1/1 for kraken test... 06:00:21 INFO - TEST-INFO | started process 4631 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgZNziH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:00:33 INFO - PROCESS | 4631 | RSS: Main: 167272448 06:00:33 INFO - PROCESS | 4631 | 06:00:36 INFO - PROCESS | 4631 | Cycle 1(1): loaded http://localhost:36440/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36440/tests/kraken/driver.html?testName=audio-beat-detection) 06:00:37 INFO - PROCESS | 4631 | RSS: Main: 172609536 06:00:37 INFO - PROCESS | 4631 | 06:00:39 INFO - PROCESS | 4631 | Cycle 1(1): loaded http://localhost:36440/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36440/tests/kraken/driver.html?testName=audio-dft) 06:00:40 INFO - PROCESS | 4631 | RSS: Main: 171466752 06:00:40 INFO - PROCESS | 4631 | 06:00:43 INFO - PROCESS | 4631 | Cycle 1(1): loaded http://localhost:36440/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36440/tests/kraken/driver.html?testName=audio-fft) 06:00:43 INFO - PROCESS | 4631 | RSS: Main: 167636992 06:00:43 INFO - PROCESS | 4631 | 06:00:45 INFO - PROCESS | 4631 | Cycle 1(1): loaded http://localhost:36440/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36440/tests/kraken/driver.html?testName=audio-oscillator) 06:00:46 INFO - PROCESS | 4631 | RSS: Main: 168697856 06:00:46 INFO - PROCESS | 4631 | 06:00:48 INFO - PROCESS | 4631 | Cycle 1(1): loaded http://localhost:36440/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36440/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:00:49 INFO - PROCESS | 4631 | RSS: Main: 168865792 06:00:49 INFO - PROCESS | 4631 | 06:00:52 INFO - PROCESS | 4631 | Cycle 1(1): loaded http://localhost:36440/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36440/tests/kraken/driver.html?testName=imaging-darkroom) 06:00:53 INFO - PROCESS | 4631 | RSS: Main: 168787968 06:00:53 INFO - PROCESS | 4631 | 06:00:56 INFO - PROCESS | 4631 | Cycle 1(1): loaded http://localhost:36440/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36440/tests/kraken/driver.html?testName=imaging-desaturate) 06:00:57 INFO - PROCESS | 4631 | RSS: Main: 166445056 06:00:57 INFO - PROCESS | 4631 | 06:01:00 INFO - PROCESS | 4631 | Cycle 1(1): loaded http://localhost:36440/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36440/tests/kraken/driver.html?testName=json-parse-financial) 06:01:00 INFO - PROCESS | 4631 | RSS: Main: 167927808 06:01:00 INFO - PROCESS | 4631 | 06:01:02 INFO - PROCESS | 4631 | Cycle 1(1): loaded http://localhost:36440/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36440/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:01:02 INFO - PROCESS | 4631 | RSS: Main: 168370176 06:01:02 INFO - PROCESS | 4631 | 06:01:04 INFO - PROCESS | 4631 | Cycle 1(1): loaded http://localhost:36440/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36440/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:01:05 INFO - PROCESS | 4631 | RSS: Main: 168964096 06:01:05 INFO - PROCESS | 4631 | 06:01:07 INFO - PROCESS | 4631 | Cycle 1(1): loaded http://localhost:36440/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36440/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:01:08 INFO - PROCESS | 4631 | RSS: Main: 169328640 06:01:08 INFO - PROCESS | 4631 | 06:01:10 INFO - PROCESS | 4631 | Cycle 1(1): loaded http://localhost:36440/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36440/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:01:11 INFO - PROCESS | 4631 | RSS: Main: 169689088 06:01:11 INFO - PROCESS | 4631 | 06:01:14 INFO - PROCESS | 4631 | Cycle 1(1): loaded http://localhost:36440/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36440/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:01:14 INFO - PROCESS | 4631 | RSS: Main: 169799680 06:01:14 INFO - PROCESS | 4631 | 06:01:16 INFO - PROCESS | 4631 | Cycle 1(1): loaded http://localhost:36440/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36440/tests/kraken/driver.html?testName=ai-astar) 06:01:16 INFO - PROCESS | 4631 | RSS: Main: 170049536 06:01:16 INFO - PROCESS | 4631 | 06:01:16 INFO - PROCESS | 4631 | __start_tp_report 06:01:16 INFO - PROCESS | 4631 | _x_x_mozilla_page_load 06:01:16 INFO - PROCESS | 4631 | _x_x_mozilla_page_load_details 06:01:16 INFO - PROCESS | 4631 | |i|pagename|runs| 06:01:16 INFO - PROCESS | 4631 | |0;ai-astar;101;111;105;111;114;113;112;110;112;111 06:01:16 INFO - PROCESS | 4631 | |1;audio-beat-detection;153;120;156;200;122;144;147;124;174;116 06:01:16 INFO - PROCESS | 4631 | |2;audio-dft;162;161;161;162;163;165;168;166;161;162 06:01:16 INFO - PROCESS | 4631 | |3;audio-fft;75;76;75;156;77;74;74;75;161;76 06:01:16 INFO - PROCESS | 4631 | |4;audio-oscillator;87;85;155;86;86;85;144;86;85;139 06:01:16 INFO - PROCESS | 4631 | |5;imaging-gaussian-blur;118;117;118;118;118;118;118;118;117;117 06:01:16 INFO - PROCESS | 4631 | |6;imaging-darkroom;148;147;147;147;148;147;147;147;148;147 06:01:16 INFO - PROCESS | 4631 | |7;imaging-desaturate;97;98;96;96;96;96;96;97;96;95 06:01:16 INFO - PROCESS | 4631 | |8;json-parse-financial;53;58;52;51;51;52;55;54;51;53 06:01:16 INFO - PROCESS | 4631 | |9;json-stringify-tinderbox;63;64;63;64;63;63;63;63;63;64 06:01:16 INFO - PROCESS | 4631 | |10;stanford-crypto-aes;76;77;78;81;79;76;77;80;81;76 06:01:16 INFO - PROCESS | 4631 | |11;stanford-crypto-ccm;132;122;121;123;120;129;129;125;156;122 06:01:16 INFO - PROCESS | 4631 | |12;stanford-crypto-pbkdf2;168;158;158;156;161;159;161;157;159;162 06:01:16 INFO - PROCESS | 4631 | |13;stanford-crypto-sha256-iterative;64;65;63;63;63;63;63;68;63;63 06:01:16 INFO - PROCESS | 4631 | __end_tp_report 06:01:16 INFO - PROCESS | 4631 | __start_cc_report 06:01:16 INFO - PROCESS | 4631 | _x_x_mozilla_cycle_collect,940 06:01:16 INFO - PROCESS | 4631 | __end_cc_report 06:01:16 INFO - PROCESS | 4631 | __startTimestamp1469106076587__endTimestamp 06:01:16 INFO - PROCESS | 4631 | 06:01:16 INFO - PROCESS | 4631 | ------- Summary: start ------- 06:01:16 INFO - PROCESS | 4631 | Number of tests: 14 06:01:16 INFO - PROCESS | 4631 | 06:01:16 INFO - PROCESS | 4631 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.50 stddev:3.97 (3.6%) stddev-sans-first:2.55 06:01:16 INFO - PROCESS | 4631 | Values: 101.0 111.0 105.0 111.0 114.0 113.0 112.0 110.0 112.0 111.0 06:01:16 INFO - PROCESS | 4631 | 06:01:16 INFO - PROCESS | 4631 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:150.00 stddev:26.85 (17.9%) stddev-sans-first:28.35 06:01:16 INFO - PROCESS | 4631 | Values: 153.0 120.0 156.0 200.0 122.0 144.0 147.0 124.0 174.0 116.0 06:01:16 INFO - PROCESS | 4631 | 06:01:16 INFO - PROCESS | 4631 | [#2] audio-dft Cycles:10 Average:163.10 Median:162.50 stddev:2.42 (1.5%) stddev-sans-first:2.54 06:01:16 INFO - PROCESS | 4631 | Values: 162.0 161.0 161.0 162.0 163.0 165.0 168.0 166.0 161.0 162.0 06:01:16 INFO - PROCESS | 4631 | 06:01:16 INFO - PROCESS | 4631 | [#3] audio-fft Cycles:10 Average:91.90 Median:75.00 stddev:35.13 (46.8%) stddev-sans-first:36.73 06:01:16 INFO - PROCESS | 4631 | Values: 75.0 76.0 75.0 156.0 77.0 74.0 74.0 75.0 161.0 76.0 06:01:16 INFO - PROCESS | 4631 | 06:01:16 INFO - PROCESS | 4631 | [#4] audio-oscillator Cycles:10 Average:103.80 Median:85.50 stddev:29.38 (34.4%) stddev-sans-first:30.53 06:01:16 INFO - PROCESS | 4631 | Values: 87.0 85.0 155.0 86.0 86.0 85.0 144.0 86.0 85.0 139.0 06:01:16 INFO - PROCESS | 4631 | 06:01:16 INFO - PROCESS | 4631 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:01:16 INFO - PROCESS | 4631 | Values: 118.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 117.0 117.0 06:01:16 INFO - PROCESS | 4631 | 06:01:16 INFO - PROCESS | 4631 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 06:01:16 INFO - PROCESS | 4631 | Values: 148.0 147.0 147.0 147.0 148.0 147.0 147.0 147.0 148.0 147.0 06:01:16 INFO - PROCESS | 4631 | 06:01:16 INFO - PROCESS | 4631 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 06:01:16 INFO - PROCESS | 4631 | Values: 97.0 98.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 95.0 06:01:16 INFO - PROCESS | 4631 | 06:01:16 INFO - PROCESS | 4631 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:2.21 (4.2%) stddev-sans-first:2.35 06:01:16 INFO - PROCESS | 4631 | Values: 53.0 58.0 52.0 51.0 51.0 52.0 55.0 54.0 51.0 53.0 06:01:16 INFO - PROCESS | 4631 | 06:01:16 INFO - PROCESS | 4631 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 06:01:16 INFO - PROCESS | 4631 | Values: 63.0 64.0 63.0 64.0 63.0 63.0 63.0 63.0 63.0 64.0 06:01:16 INFO - PROCESS | 4631 | 06:01:16 INFO - PROCESS | 4631 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:78.50 stddev:2.02 (2.6%) stddev-sans-first:2.00 06:01:16 INFO - PROCESS | 4631 | Values: 76.0 77.0 78.0 81.0 79.0 76.0 77.0 80.0 81.0 76.0 06:01:16 INFO - PROCESS | 4631 | 06:01:16 INFO - PROCESS | 4631 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:127.00 stddev:10.65 (8.4%) stddev-sans-first:11.19 06:01:16 INFO - PROCESS | 4631 | Values: 132.0 122.0 121.0 123.0 120.0 129.0 129.0 125.0 156.0 122.0 06:01:16 INFO - PROCESS | 4631 | 06:01:16 INFO - PROCESS | 4631 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.90 Median:160.00 stddev:3.41 (2.1%) stddev-sans-first:2.00 06:01:16 INFO - PROCESS | 4631 | Values: 168.0 158.0 158.0 156.0 161.0 159.0 161.0 157.0 159.0 162.0 06:01:16 INFO - PROCESS | 4631 | 06:01:16 INFO - PROCESS | 4631 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.00 stddev:1.62 (2.6%) stddev-sans-first:1.72 06:01:16 INFO - PROCESS | 4631 | Values: 64.0 65.0 63.0 63.0 63.0 63.0 63.0 68.0 63.0 63.0 06:01:16 INFO - PROCESS | 4631 | -------- Summary: end -------- 06:01:16 INFO - PROCESS | 4631 | 06:01:17 INFO - TEST-INFO | 4631: exit 0 06:01:17 INFO - TEST-OK | kraken | took 61567ms 06:01:17 INFO - SUITE-END | took 1172s 06:01:17 INFO - Completed test suite (00:19:32) 06:01:17 INFO - javascript benchmark 06:01:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7295.771025796499, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3078.1535077853587, 3088.1044497095836, 3088.4132014917163, 3110.3157305392806, 3118.3295591447836, 5424.430434804348, 5453.972730136354, 5465.262189604402, 5509.090999984997, 5517.310336207974, 5372.409035006156, 5395.271638328824, 5407.351117865852, 5481.780728770855, 5491.890162196763, 4930.580900623433, 5011.498850114996, 5016.172331565296, 5017.247412888078, 5035.320231768719, 673.4530689637011, 5034.672746271499, 5080.339555857752, 5096.235564665311, 5140.588752899777, 4983.22759972203, 5038.773255203506, 5039.546440820325, 5049.570786483153, 5073.670211436245, 4962.4789397113145, 4979.47715489872, 5000.574951129159, 5006.949930500721, 5035.345405097314, 4957.652964292501, 4970.0, 4975.875603109915, 5029.698218106925, 5037.420696619899, 5343.465653434664, 5411.621186516945, 5418.187271909206, 5473.863153421156, 5517.613767036309, 5876.206712093898, 5894.852628684317, 5898.734556944948, 5907.940920590782, 5930.7924222652, 5903.763849446017, 5928.081147422156, 5958.5828991970575, 5962.70186490678, 5963.612365196292, 5389.137737961907, 5448.99999999996, 5467.043267428184, 5494.780208791643, 5582.581306402036, 6041.8489537761025, 6062.120992456157, 6063.575549711478, 6064.4541991221, 6070.878582428327, 5769.1923130761725, 5807.0, 5810.7628563003545, 5836.0, 5844.561657875676, 5781.94218057814, 5791.305043394736, 5820.708964551755, 5831.183634291203, 5888.057910734262, 5790.10253410722, 5821.505172060422, 5868.970655146697, 5869.647821130746, 5883.94116058834, 5754.280714910637, 5825.2135961644635, 5826.2134611827705, 5827.76688932438, 5838.94161058384, 4427.070315233773, 4456.77716114193, 4488.281874900001, 4496.662750293741, 4553.704009239389, 4001.9399709004388, 4006.1787333596544, 4013.7591744495426, 4016.4577781999055, 4045.3931910213705, 5663.235463212496, 5682.943170568324, 5692.060809966392, 5705.5435565154685, 5710.172025056344, 5732.856678583069, 5802.419758024248, 5831.737571809279, 5868.823935281948, 5869.970650146722, 5675.687837168995, 5678.261825962681, 5693.0891057431445, 5693.5160511357, 5741.741621627037, 5114.616403769732, 5128.8461346159675, 5141.845744627667, 5143.485651434827, 5145.691258524501, 5974.462298393166, 6085.513158947274, 6094.695265236721, 6128.050152226412, 6153.292371377349, 5965.701714914324, 5971.462568368867, 5972.193753843176, 5984.162217289496, 6002.669853158118, 6143.354947730602, 6144.662043587646, 6161.753529858755, 6176.413240742122, 6183.752649893954, 5687.090065589651, 5725.2843394575675, 5762.394948530512, 5789.363170051207, 5813.866296072225, 5939.673317967553, 5940.851478713067, 5941.287045554561, 5942.376050514634, 5945.3757355477055, 5754.05058165398, 5798.043322851682, 5803.535717142534, 5804.1874137619925, 5806.5645076618575, 5663.716814159358, 5704.458076482728, 5743.4256574342235, 5743.971280143573, 5779.2775903012125, 5701.144828275792, 5702.45826646468, 5707.086866101404, 5740.339860916049, 5749.108888122348, 5789.8263052108505, 5819.94180058194, 5828.562857785599, 5834.737436815439, 5886.440788125121, 5576.77692892296, 5657.745401456862, 5691.203231547669, 5723.112917497794, 5731.541476681939], "value": 5401.561988203838, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.494444888498, 587.239524815364, 587.409653298435, 605.7576969212314, 626.3423405424303, 40074.398884016766, 43357.566424335746, 43380.78309608447, 43398.56601433985, 43459.0, 43424.348634770504, 43732.78133609328, 43737.0, 43779.3433098503, 43801.780991095, 8797.340199485032, 8966.372353935227, 9022.413543119676, 9031.187193152615, 9037.819243615124, 8884.15600517953, 8922.840030795987, 8942.105789421072, 9014.954925225398, 9015.963164236131, 8898.822023559558, 8920.553972301392, 8944.597493112826, 8977.102289771003, 9001.95499022504, 8948.0, 8990.730278091667, 9022.639094436214, 9040.367174297802, 9059.139381758789, 8629.395942284043, 8763.912360876373, 8767.167119123673, 8805.25155361795, 8809.075047120088, 41592.79203603993, 41836.79081604603, 41919.7904010478, 42075.36886946698, 42159.1568168638, 2975.9851200743856, 3335.96664033359, 3336.6996970272794, 3413.1296519387397, 3433.6909678128836, 28635.57046644302, 29443.0, 30748.38503229945, 31413.528797068062, 31674.524882126785, 4276.764777937212, 4332.783360831946, 4335.328024156261, 4342.739435633841, 4352.673549483801, 333343.0, 333989.0, 335046.0, 336030.0, 336889.0, 35486.29027419437, 35713.0, 35809.10477238038, 35883.82058089745, 35923.0, 35515.82242088773, 36405.81797090998, 36511.0, 36544.63455365466, 36786.0, 15931.601709957344, 16069.67860642804, 16196.676066478605, 16211.35154593803, 16218.189090545426, 12137.332446715516, 12139.393030348447, 12256.632301030982, 12266.754664906652, 12278.263304201777, 19506.804931950497, 19567.60864782725, 19608.70586941197, 19640.017999100273, 19643.410697679094, 6886.2769409212315, 6956.373926346653, 7088.645567721594, 7132.572045677276, 7280.199178090405, 1020.6121673763922, 1024.6925922223304, 1066.157735389034, 1119.7536541960756, 1174.5947648061406, 33993.57253884751, 34191.48712769311, 34338.313233735185, 34435.311293773986, 34567.65432345695, 1137.0846468592697, 1143.954241830334, 1145.2498613408231, 1146.8681101673415, 1164.394514852289, 17592.0, 17636.735448968277, 17685.292588296583, 17724.20241089154, 17809.3982437373, 607155.0, 611423.0, 612650.0, 613473.0, 614876.0, 59911.700441497516, 60427.395726042174, 60476.0, 60633.393666063654, 60668.0, 1293.340396397844, 1313.5533918467577, 1327.6481732340937, 1357.7623915814693, 1372.7597670407638, 31485.212869677525, 31965.840170798998, 33052.83473582617, 33283.33433331368, 34622.65377346194, 58534.414655852896, 59188.0, 59232.40767592441, 59300.0, 59400.70299648647, 523106.0, 524360.0, 526000.0, 527555.0, 528178.0, 45570.31644525401, 45860.770696146305, 46056.53943460523, 46136.307955381366, 46265.53734462612, 50132.24801627905, 50370.0, 51449.742751286, 51810.0, 52532.7373363146, 41336.793316033225, 42896.78551607222, 43781.0, 44450.777746112355, 44501.33248001347, 42684.78657606692, 43152.784236078616, 43154.136917262105, 43649.0, 44692.10615787601, 40964.38553421761, 41508.792456037525, 41853.58146418619, 42342.78828605837, 42809.0, 34937.30125397427, 37971.43042854304, 38020.61979380171, 38199.0, 38932.80533597314, 29158.0, 29171.562426564044, 29571.556426653187, 29631.85184074066, 29661.703382966756], "value": 20248.841700689252, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.51878411377857, 387.1386165781139, 398.07844839197264, 404.5691338724258, 410.9630133288005, 13125.671858203526, 18690.345837895675, 19408.223671053176, 20259.99999999998, 20438.89780551097, 19166.137523811427, 19219.231230750753, 19622.60754784907, 19981.700274495895, 20096.196152153934, 5662.745176467049, 5761.567882408815, 5803.564732645047, 5832.0, 5865.32548756892, 5702.686352250625, 5735.426457354252, 5745.798897038604, 5756.165356023374, 5769.740361683714, 5551.361593416748, 5675.716214189295, 5677.17680936264, 5704.857378565527, 5721.141828725683, 5653.0, 5677.829665110054, 5680.573956953245, 5680.715964201794, 5688.0, 4797.18447863864, 5022.949770502285, 5069.163588008011, 5089.185730283174, 5127.743612819381, 12961.870381296161, 13122.015848811378, 13167.144135631153, 13372.197668139943, 13492.325383730873, 2452.5340185364726, 2683.2486903667004, 2837.205582436921, 2862.298736809495, 2862.4561333346596, 10167.796644067152, 10292.0, 10798.73003174919, 11143.554257829677, 14301.57095287143, 1699.8895071820293, 1801.1894647408587, 1832.221305944968, 1832.3586744639404, 1836.4674244469088, 81098.0, 84340.57829710873, 85393.14606853976, 85462.57268713617, 85670.0, 10008.899911000797, 10495.212859035602, 10704.732381690521, 10841.403722795165, 10946.562137514411, 14459.421623134956, 14493.565193044225, 14500.274986250644, 14527.273636318141, 14559.490417835324, 7636.0, 7788.337991270692, 7810.960945195351, 8010.5994700264755, 8166.305864001508, 7566.0, 7566.31903128721, 7706.884396734054, 7872.56700881457, 7888.723894663774, 4063.5733248009124, 4364.869053928387, 4414.690971631955, 4509.413776209072, 4560.863174104782, 1844.382131985773, 1871.1953859840398, 1901.2585091814203, 1902.7621547306587, 1977.7923318051685, 926.7868390270276, 967.3422072990294, 976.2921881635757, 1041.3699711674478, 1084.452351562456, 19765.22113009836, 20402.0, 20421.897890510452, 20492.59014819725, 20574.69137962932, 980.0983095552109, 981.9852702209473, 986.6743974488402, 1031.504877658713, 1034.7361422837128, 9520.571574279036, 10829.052681877867, 11194.10447164225, 11329.320240785579, 11355.489002994886, 500146.0, 502069.0, 503689.0, 508258.0, 508840.0, 94326.0, 95135.0, 96494.51752741332, 96646.0, 99246.50376748215, 1029.902159294866, 1086.2124959404368, 1105.6682995101437, 1117.754094099297, 1119.1829964126234, 17879.0, 17956.371526996492, 18624.627507450045, 18807.0, 19058.0, 42537.5746242546, 43373.3493997584, 43418.0, 43882.0, 44787.0, 58822.411775881694, 59077.40922590891, 59257.0, 60689.69655151696, 62301.0, 7748.92251077482, 7797.961010195139, 7863.921360786548, 7998.240167184108, 8223.54770487605, 12086.45610947527, 12641.178323409316, 12695.42870570808, 12846.807297890353, 12894.29081400532, 10943.83584246253, 11138.498767555317, 11270.380129092979, 11330.093592512743, 11558.826617600575, 10638.73403164927, 10906.781864362827, 10954.233203675667, 11125.666230013112, 11555.2489088209, 10513.211509136692, 10677.412742299248, 10710.464476775975, 11040.227184097357, 11201.38392388394, 6904.723811047502, 6992.685329160302, 7422.925770742223, 7474.439417043634, 7475.663595138123, 10043.497825108569, 10051.145652619316, 10308.226882983656, 10689.198310126927, 11059.778804423706], "value": 8990.810428826437, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1503.70677717845, 1512.9167895765731, 1676.9329226830928, 1784.9107544622766, 1817.7091665333548, 8163.673453061885, 8865.246454051397, 8894.866577001341, 9543.618255269797, 9550.80898382032, 8874.290056795457, 9237.307201959846, 9268.351215414923, 9314.254859611232, 9327.953360233207, 2379.5716770981257, 2416.867072311022, 2423.006567307404, 2423.5758742220128, 2424.781769640732, 2356.5051339218785, 2371.2767605880285, 2414.396400899775, 2414.601590737535, 2418.093215044358, 2374.905003799846, 2382.916597919073, 2407.711074671042, 2416.613341865302, 2417.3231495181376, 2284.3375421127935, 2298.069281940817, 2301.8158547316175, 2307.3193407944614, 2371.4782747795457, 2261.9434514137115, 2276.704028476304, 2280.942976425586, 2305.5158416732506, 2309.21486694523, 9291.76770580734, 9315.115064068903, 9365.11031452011, 9401.435913845124, 9427.434353938717, 5427.294451721291, 5525.419830917736, 5564.777408903639, 5567.47109024646, 5569.888602227973, 3456.2396272819938, 3505.439129739255, 3522.4011917974008, 3524.4360902255517, 3554.0937061049526, 1164.6913567904512, 1169.6724917023162, 1183.3314177489776, 1192.320377384891, 2078.189506092625, 12629.557965471164, 13011.21932684042, 13026.41381137851, 13028.609141725763, 13061.804072938914, 4342.522322544518, 4559.430071241095, 4629.537046295411, 4669.369635099286, 4736.905261894743, 10107.090361867467, 10114.342567733222, 10119.544620492095, 10229.59081636741, 10238.232132590085, 5419.078756611386, 5437.265969094122, 5441.374241962225, 5445.237666726662, 5457.126859702428, 4306.547812479707, 4873.537013983666, 4963.801447942042, 5005.499450055038, 5104.795808167706, 3797.1646237827636, 3885.261800257942, 3951.4665520154986, 3955.2287303976022, 4014.458048163519, 1162.8255761635821, 1171.7949358862336, 1176.6528873982024, 1180.2446434282067, 1203.1036877526299, 901.8557030875029, 946.8721722567503, 979.9514519464105, 984.4487087231173, 1005.1104772276442, 5808.854778630568, 5890.558208134321, 6037.969810150921, 6102.786402475892, 6125.938740612626, 431.73448329277267, 440.1922472263432, 442.4668274728944, 449.7841036302593, 463.4531253121282, 3859.826307816099, 4045.110075783323, 4100.856470023535, 4105.0, 4112.300908845504, 11201.887981120084, 11583.362915039754, 11601.651950441501, 11695.76608467843, 11719.941400292944, 11508.94245528767, 11594.594189203337, 11595.536178552764, 11599.0, 11621.128415368881, 8470.618822153017, 8545.84631074797, 8589.828203436022, 8626.654933802578, 8693.913060869438, 5900.7049647518315, 6033.9698301508215, 6043.395660434097, 6111.0, 6122.6938653068055, 10654.8934510657, 10671.679849604525, 10696.304740191863, 10747.731306717082, 10867.836982445428, 10797.784044318912, 10845.78308433811, 10933.671989840317, 10964.671059868217, 11093.22347435704, 6826.726930922708, 7455.478116531791, 7582.54504729718, 7659.655315510704, 7846.33306168982, 8906.287497000094, 8918.331125165769, 8946.776330591527, 8978.551072446482, 8987.236084932854, 7423.8144046399275, 7595.3164215220895, 7766.417518686234, 7983.121856595653, 8107.635156417858, 7554.6600402983095, 7627.237276272328, 7648.80877978055, 7788.532688038509, 7797.532148070907, 6826.93173068263, 6890.379865812101, 6903.585784852925, 6925.238223795479, 6934.826629334307, 4752.239641657318, 4818.614510839055, 4872.366592342973, 5019.598432125348, 5069.949300506948, 5001.924971125509, 5076.5431111198695, 5108.029474399852, 5228.1112210923475, 5243.501867322599], "value": 4651.808049222691, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.32622167227134, 321.95814544109265, 327.5463483075939, 329.65715655718054, 329.73785840256994, 5468.26178465907, 5477.5070243678065, 5622.156676498522, 5661.462161094694, 5684.715764211794, 5484.61607687462, 5519.365272993607, 5538.9169162462595, 5564.081926482136, 5576.247206627104, 4334.566543345656, 4355.629771469413, 4362.716423432466, 4368.803403846835, 4369.519352871182, 4080.3471444568877, 4265.893352666177, 4290.377895205193, 4371.6229387742915, 4375.278079116942, 4244.851430199944, 4249.617534421902, 4253.914921701564, 4258.723182993111, 4265.893352666177, 4217.746935183899, 4256.616904478597, 4260.467441569804, 4270.167317373113, 4278.764667943262, 3481.756277060607, 3692.2061756722164, 3715.8142092895246, 3717.460968159629, 3720.5535335759882, 5359.705216213107, 5393.1370980643305, 5420.430854760233, 5421.430749771257, 5460.153676180198, 4886.70679759212, 4905.509449055102, 4907.312976183337, 4908.9754551227015, 4909.975450122726, 5505.917411238835, 5754.424557544254, 5810.82567522975, 5823.767049318065, 5827.679477628729, 4066.410370496291, 4083.9795801020805, 4085.0, 4087.121268927165, 4088.9795551022053, 5984.311804142536, 6035.336113027563, 6037.879242415127, 6037.969810151009, 6055.152278680944, 4045.8786236412957, 4093.07625416054, 4118.299889018874, 4150.27370210212, 4157.833686652561, 4191.979040104841, 4201.663866890642, 4202.831886724497, 4206.653870761388, 4213.094184750294, 4852.888993287931, 4855.223164293767, 4855.514448555116, 4864.95135048645, 4871.585915197248, 5591.944080559224, 5815.73829177688, 5815.970920145457, 5825.504832089235, 5857.384974577608, 1446.9421223151166, 1455.1269238456841, 1455.294182321573, 1460.1312219229542, 1467.669774300795, 861.4615865084322, 905.3843386497246, 911.2345629671108, 920.636348642296, 924.4222361024359, 5031.421386540522, 5032.874178145576, 5066.898662026739, 5072.51811077947, 5101.107306221396, 5316.288692766717, 5330.147176451749, 5356.3572371315695, 5358.410574836765, 5366.463353664602, 5044.2937988681615, 5073.771680274396, 5103.234514822732, 5351.705656188869, 5802.419758024248, 3202.343519578481, 3202.9270194484643, 3213.742900567949, 3235.980666090174, 3243.5621191139367, 6184.412480814405, 6286.277078135981, 6288.748450061947, 6296.024116261987, 6299.937000629935, 6122.632642041492, 6129.969350153221, 6131.754729810847, 6142.385761423822, 6146.692665366803, 6250.312465628777, 6277.18396608438, 6277.7175027123885, 6292.46514046302, 6304.501001943965, 5843.766249350148, 5994.7111371055435, 6035.637861728311, 6073.635581865102, 6075.1798507200965, 5974.641521508724, 5981.192539007178, 6001.159837622824, 6002.95899394208, 6004.279486461478, 5939.881202376015, 6240.032794916795, 6253.6230435564285, 6285.905711414241, 6287.874242515216, 4060.2285565743596, 4145.191687620885, 4198.139381426739, 4200.264953633041, 4200.9369859452745, 5997.940020599913, 6007.438066102932, 6008.699565021644, 6020.367861374492, 6021.488173505126, 5727.8568035799435, 5813.56398270123, 5827.883442331215, 5845.503132233808, 5846.1815345852465, 5778.266520043886, 5830.912536311874, 5856.59003869725, 5869.325027621878, 5869.53043756507, 5785.537157027344, 5786.218860453953, 5797.681127538026, 5799.188113664006, 5799.797007104731, 5705.372409035086, 5874.177615133799, 5905.232319798399, 5907.940920590911, 5920.674362909909, 5707.514861236841, 5763.164341170591, 5776.8555786104, 5796.188533605383, 5799.507041901317], "value": 4379.830507837715, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.3555147040455, 729.3472342253682, 741.055154677786, 780.1496368957835, 785.1677222144527, 14525.564233072999, 15627.687446251068, 15682.451114211004, 15691.52925412238, 15699.60750981226, 13620.455181792717, 13714.31428428577, 13715.451381944735, 13733.862661373383, 13749.725005499884, 647.5305403582389, 761.9161892191854, 767.9424043196755, 785.4698078796818, 795.1333046978792, 780.8126049748076, 795.0499153511556, 795.5028107432854, 796.1083586383259, 797.103258833812, 854.5897968974896, 858.4849090545686, 859.8280343931208, 861.7888617288774, 863.5164307987516, 852.2755657690975, 854.6752234151014, 856.3021137772757, 856.8329175810751, 860.7073594977707, 625.1591609285504, 629.4649547884308, 630.0, 630.6247782569363, 633.3413250219766, 12868.22790632565, 12931.224126552437, 13033.934830325883, 13061.934690326583, 13096.803547946789, 15369.0, 15405.22973851303, 15455.459058932996, 15569.455069072528, 15822.208889555477, 11670.008049315818, 11952.52189912411, 11996.340201288926, 12065.638030859, 12414.62756117318, 3776.6978641708597, 3870.3807390817615, 3873.2447172801317, 3913.960860391388, 4014.036631208489, 78283.0, 80148.0, 80265.0, 80614.59692701558, 80640.19359806445, 10735.624253151102, 10749.08632766208, 10766.138708903269, 10796.946015269874, 11053.557857685764, 21917.452063698536, 22076.116955321606, 22081.668774968388, 22082.558348833256, 22091.889540552194, 8066.395020373496, 8094.473859199134, 8200.958995204986, 8349.03986041613, 8556.18716221958, 4503.234450143484, 4602.907941841145, 4634.374359461497, 4685.8594242172785, 4820.373351464287, 3438.484227365865, 3529.294141171776, 3544.794769778288, 3547.467879817996, 3558.5018097466377, 600.6846405636988, 613.9348230819525, 613.9662318572522, 621.6767281013938, 624.8843963866699, 625.4652272307203, 661.497262080822, 703.5919166883195, 708.9326513981164, 726.9745558905519, 9062.184403403726, 9619.290222308315, 9822.440498677743, 9846.113849753556, 10057.899421005697, 611.3916652930362, 689.018149137477, 690.1304356510732, 706.7526365771938, 740.1636151149168, 4285.3360376877945, 4590.54094590545, 4637.721736695809, 4691.366665500182, 4722.291656251589, 113332.43333783279, 115623.0, 115716.42141789237, 119019.40490297493, 119716.0, 77162.61418692871, 84492.0, 97580.0, 98231.50884245677, 98456.50771746096, 84857.0, 85641.57179214065, 86776.0, 88545.55727221452, 91150.54424727833, 8931.062238464867, 9068.0, 9187.862182067409, 9263.953680231556, 9316.534173291444, 51269.0, 51395.0, 52657.210141847136, 52895.20657190222, 53033.0, 68290.65854670695, 68394.0, 72437.63781181061, 76116.23883761313, 76920.0, 13048.673783155496, 13490.325483725579, 13518.526851560147, 13567.0, 13578.185308881499, 14725.410983560538, 15276.770848437505, 15827.446039388566, 16241.269142888363, 16270.918645406697, 13748.793768093687, 14188.432462701376, 14465.204413757345, 14555.12669239849, 14762.557123286319, 14193.432262709788, 14532.636684082983, 14872.7769083466, 15018.0, 15032.549023529311, 13935.0, 14515.346809393392, 14730.852691472948, 14754.409823606935, 15050.247487625795, 11098.500567474644, 11337.546498139982, 11391.0, 11419.429028548706, 11458.255213411101, 9755.853662195215, 10458.477076146315, 11199.88800112021, 11718.70703232426, 11801.35092569917], "value": 7526.386032581586, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 105.0, 111.0, 114.0, 113.0, 112.0, 110.0, 112.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 120.0, 156.0, 200.0, 122.0, 144.0, 147.0, 124.0, 174.0, 116.0], "value": 145.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 163.0, 165.0, 168.0, 166.0, 161.0, 162.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 156.0, 77.0, 74.0, 74.0, 75.0, 161.0, 76.0], "value": 91.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 155.0, 86.0, 86.0, 85.0, 144.0, 86.0, 85.0, 139.0], "value": 103.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 95.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 58.0, 52.0, 51.0, 51.0, 52.0, 55.0, 54.0, 51.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0, 64.0], "value": 63.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 78.0, 81.0, 79.0, 76.0, 77.0, 80.0, 81.0, 76.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 122.0, 121.0, 123.0, 120.0, 129.0, 129.0, 125.0, 156.0, 122.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 158.0, 158.0, 156.0, 161.0, 159.0, 161.0, 157.0, 159.0, 162.0], "value": 159.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 63.0, 63.0, 63.0, 63.0, 63.0, 68.0, 63.0, 63.0], "value": 63.8, "unit": "score"}]}]} 06:01:17 INFO - Return code: 0 06:01:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:01:17 ERROR - # TBPL SUCCESS # 06:01:17 INFO - Running post-action listener: _resource_record_post_action 06:01:17 INFO - [mozharness: 2016-07-21 13:01:17.872707Z] Finished run-tests step (success) 06:01:17 INFO - Running post-run listener: _resource_record_post_run 06:01:17 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 566616064; Read time: 92; Write time: 454300 06:01:17 INFO - TinderboxPrint: CPU usage
13.3% 06:01:17 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 92 06:01:17 INFO - TinderboxPrint: I/O write bytes / time
566,616,064 / 454,300 06:01:17 INFO - TinderboxPrint: CPU idle
8,227.2 (86.6%) 06:01:17 INFO - TinderboxPrint: CPU user
1,210.2 (12.7%) 06:01:17 INFO - TinderboxPrint: Swap in / out
0 / 0 06:01:17 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 264605696; Read time: 0; Write time: 238044 06:01:17 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297439232; Read time: 76; Write time: 215884 06:01:18 INFO - Running post-run listener: _upload_blobber_files 06:01:18 INFO - Blob upload gear active. 06:01:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:01:18 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 06:01:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:01:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:01:18 INFO - (blobuploader) - INFO - Open directory for files ... 06:01:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:01:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:01:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:19 INFO - (blobuploader) - INFO - Done attempting. 06:01:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:01:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:01:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:24 INFO - (blobuploader) - INFO - Done attempting. 06:01:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:01:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:01:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:24 INFO - (blobuploader) - INFO - Done attempting. 06:01:24 INFO - (blobuploader) - INFO - Iteration through files over. 06:01:24 INFO - Return code: 0 06:01:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:01:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:01:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ccb5a1b0efa43833c287f85fcec29ec928216acfa2b3ae303fedb34c5c83649e956845618bf75db1f806e9576e86b745c9b053064cecfa0cc299998713874d58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f401074b5f4abbe29eb52012926fa20640b6b92036ed0fe3545ea0deaf138a823a6fbe0498053c51e2da8e5af7cdcc028a9dfc3840083721d4935284a58401d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32803ecf4b8516aea6b7767f8e758b773c48d14f2023dd61bd44b7626719414170011ce18cfa35f9bf776c2a4e4f78e9b3feb971332cbe9baccb307686b4c879"} 06:01:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:01:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:01:24 INFO - Contents: 06:01:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ccb5a1b0efa43833c287f85fcec29ec928216acfa2b3ae303fedb34c5c83649e956845618bf75db1f806e9576e86b745c9b053064cecfa0cc299998713874d58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f401074b5f4abbe29eb52012926fa20640b6b92036ed0fe3545ea0deaf138a823a6fbe0498053c51e2da8e5af7cdcc028a9dfc3840083721d4935284a58401d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32803ecf4b8516aea6b7767f8e758b773c48d14f2023dd61bd44b7626719414170011ce18cfa35f9bf776c2a4e4f78e9b3feb971332cbe9baccb307686b4c879"} 06:01:24 INFO - Running post-run listener: copy_logs_to_upload_dir 06:01:24 INFO - Copying logs to upload dir... 06:01:24 INFO - mkdir: /builds/slave/test/build/upload/logs 06:01:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.487540 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-21 06:01:25.026902) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 06:01:25.030792) ========= 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=20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602 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/Fx-Team/sha512/ccb5a1b0efa43833c287f85fcec29ec928216acfa2b3ae303fedb34c5c83649e956845618bf75db1f806e9576e86b745c9b053064cecfa0cc299998713874d58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f401074b5f4abbe29eb52012926fa20640b6b92036ed0fe3545ea0deaf138a823a6fbe0498053c51e2da8e5af7cdcc028a9dfc3840083721d4935284a58401d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32803ecf4b8516aea6b7767f8e758b773c48d14f2023dd61bd44b7626719414170011ce18cfa35f9bf776c2a4e4f78e9b3feb971332cbe9baccb307686b4c879"} build_url:https://queue.taskcluster.net/v1/task/bEEqB0Z3TC6mHWB38lcgNw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011474 build_url: 'https://queue.taskcluster.net/v1/task/bEEqB0Z3TC6mHWB38lcgNw/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/Fx-Team/sha512/ccb5a1b0efa43833c287f85fcec29ec928216acfa2b3ae303fedb34c5c83649e956845618bf75db1f806e9576e86b745c9b053064cecfa0cc299998713874d58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f401074b5f4abbe29eb52012926fa20640b6b92036ed0fe3545ea0deaf138a823a6fbe0498053c51e2da8e5af7cdcc028a9dfc3840083721d4935284a58401d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32803ecf4b8516aea6b7767f8e758b773c48d14f2023dd61bd44b7626719414170011ce18cfa35f9bf776c2a4e4f78e9b3feb971332cbe9baccb307686b4c879"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 06:01:25.057055) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 06:01:25.057403) ========= 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=20e666a3d4cfbb71505a330e000001b4-1469104852.811937-1017625602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004649 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 06:01:25.143677) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 06:01:25.144024) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 06:01:25.144386) ========= ========= Total master_lag: 0.18 =========