builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-039 starttime: 1467814200.66 results: success (0) buildid: 20160706043019 builduid: ac2a7c0e75904f8db8df90682f09d318 revision: 95ffbc4ff63584631c408e8d9912961fcf68bb09 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 07:10:00.665148) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 07:10:00.665606) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 07:10:00.665879) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 07:10:00.684510) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 07:10:00.684784) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 07:10:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-07-06 07:10:00 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126572 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 07:10:00.825819) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 07:10:00.826124) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015417 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 07:10:00.875253) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 07:10:00.875609) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 95ffbc4ff63584631c408e8d9912961fcf68bb09 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 95ffbc4ff63584631c408e8d9912961fcf68bb09 --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=5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 07:10:01,077 truncating revision to first 12 chars 2016-07-06 07:10:01,077 Setting DEBUG logging. 2016-07-06 07:10:01,077 attempt 1/10 2016-07-06 07:10:01,077 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/95ffbc4ff635?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 07:10:01,521 unpacking tar archive at: mozilla-central-95ffbc4ff635/testing/mozharness/ program finished with exit code 0 elapsedTime=0.766706 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 07:10:01.658617) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 07:10:01.658900) ========= script_repo_revision: 95ffbc4ff63584631c408e8d9912961fcf68bb09 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 07:10:01.659259) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 07:10:01.659565) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 07:10:01.673820) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-06 07:10:01.674090) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:10:01 INFO - MultiFileLogger online at 20160706 07:10:01 in /builds/slave/test 07:10:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:10:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:10:01 INFO - {'append_to_log': False, 07:10:01 INFO - 'base_work_dir': '/builds/slave/test', 07:10:01 INFO - 'blob_upload_branch': 'Firefox', 07:10:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:10:01 INFO - 'branch': 'Firefox', 07:10:01 INFO - 'buildbot_json_path': 'buildprops.json', 07:10:01 INFO - 'config_files': ('talos/linux_config.py',), 07:10:01 INFO - 'default_actions': ('clobber', 07:10:01 INFO - 'read-buildbot-config', 07:10:01 INFO - 'download-and-extract', 07:10:01 INFO - 'populate-webroot', 07:10:01 INFO - 'create-virtualenv', 07:10:01 INFO - 'install', 07:10:01 INFO - 'run-tests'), 07:10:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:10:01 INFO - 'download_minidump_stackwalk': True, 07:10:01 INFO - 'download_symbols': 'ondemand', 07:10:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:10:01 INFO - 'tooltool.py': '/tools/tooltool.py', 07:10:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:10:01 INFO - '/tools/misc-python/virtualenv.py')}, 07:10:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:10:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:10:01 INFO - 'installer_path': 'installer.exe', 07:10:01 INFO - 'log_level': 'info', 07:10:01 INFO - 'log_name': 'talos', 07:10:01 INFO - 'log_to_console': True, 07:10:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:10:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:10:01 INFO - 'opt_config_files': (), 07:10:01 INFO - 'pip_index': False, 07:10:01 INFO - 'sps_profile': False, 07:10:01 INFO - 'sps_profile_interval': 0, 07:10:01 INFO - 'suite': 'dromaeojs', 07:10:01 INFO - 'system_bits': '32', 07:10:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:10:01 INFO - 'title': 'talos-linux64-ix-039', 07:10:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:10:01 INFO - 'use_talos_json': True, 07:10:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:10:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:10:01 INFO - 'work_dir': 'build'} 07:10:01 INFO - ##### 07:10:01 INFO - ##### Running clobber step. 07:10:01 INFO - ##### 07:10:01 INFO - Running pre-action listener: _resource_record_pre_action 07:10:01 INFO - Running main action method: clobber 07:10:01 INFO - rmtree: /builds/slave/test/build 07:10:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:10:02 INFO - Running post-action listener: _resource_record_post_action 07:10:02 INFO - ##### 07:10:02 INFO - ##### Finished clobber step (success) 07:10:02 INFO - ##### 07:10:02 INFO - ##### 07:10:02 INFO - ##### Running read-buildbot-config step. 07:10:02 INFO - ##### 07:10:02 INFO - Running pre-action listener: _resource_record_pre_action 07:10:02 INFO - Running main action method: read_buildbot_config 07:10:02 INFO - Using buildbot properties: 07:10:02 INFO - { 07:10:02 INFO - "project": "", 07:10:02 INFO - "product": "firefox", 07:10:02 INFO - "script_repo_revision": "production", 07:10:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:10:02 INFO - "repository": "", 07:10:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:10:02 INFO - "buildid": "20160706043019", 07:10:02 INFO - "pgo_build": "True", 07:10:02 INFO - "basedir": "/builds/slave/test", 07:10:02 INFO - "buildnumber": 368, 07:10:02 INFO - "slavename": "talos-linux64-ix-039", 07:10:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:10:02 INFO - "platform": "ubuntu64_hw", 07:10:02 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:10:02 INFO - "branch": "mozilla-central", 07:10:02 INFO - "repo_path": "mozilla-central", 07:10:02 INFO - "revision": "95ffbc4ff63584631c408e8d9912961fcf68bb09", 07:10:02 INFO - "stage_platform": "linux64-pgo", 07:10:02 INFO - "builduid": "ac2a7c0e75904f8db8df90682f09d318", 07:10:02 INFO - "slavebuilddir": "test" 07:10:02 INFO - } 07:10:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/bnrB5DbETWi0HLZtrnganQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:10:02 INFO - Running post-action listener: _resource_record_post_action 07:10:02 INFO - ##### 07:10:02 INFO - ##### Finished read-buildbot-config step (success) 07:10:02 INFO - ##### 07:10:02 INFO - ##### 07:10:02 INFO - ##### Running download-and-extract step. 07:10:02 INFO - ##### 07:10:02 INFO - Running pre-action listener: _resource_record_pre_action 07:10:02 INFO - Running main action method: download_and_extract 07:10:02 INFO - mkdir: /builds/slave/test/build/tests 07:10: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')]} 07:10:02 INFO - https://queue.taskcluster.net/v1/task/bnrB5DbETWi0HLZtrnganQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:10:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnrB5DbETWi0HLZtrnganQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:10:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnrB5DbETWi0HLZtrnganQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:10:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnrB5DbETWi0HLZtrnganQ/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 07:10:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnrB5DbETWi0HLZtrnganQ/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 07:10:06 INFO - Downloaded 1361 bytes. 07:10:06 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:10:06 INFO - Using the following test package requirements: 07:10:06 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:10:06 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:10:06 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:10:06 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:06 INFO - u'jsshell-linux-x86_64.zip'], 07:10:06 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:10:06 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:10:06 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:10:06 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:10:06 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:10:06 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:10:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:06 INFO - https://queue.taskcluster.net/v1/task/bnrB5DbETWi0HLZtrnganQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:10:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnrB5DbETWi0HLZtrnganQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:10:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnrB5DbETWi0HLZtrnganQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:10:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnrB5DbETWi0HLZtrnganQ/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 07:10:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnrB5DbETWi0HLZtrnganQ/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 07:10:07 INFO - Downloaded 24302495 bytes. 07:10:07 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'] 07:10:07 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 07:10:08 INFO - Return code: 0 07:10:08 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 07:10: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')]} 07:10:08 INFO - https://queue.taskcluster.net/v1/task/bnrB5DbETWi0HLZtrnganQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:10:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnrB5DbETWi0HLZtrnganQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:10:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnrB5DbETWi0HLZtrnganQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:10:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnrB5DbETWi0HLZtrnganQ/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 07:10:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnrB5DbETWi0HLZtrnganQ/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 07:10:11 INFO - Downloaded 24302495 bytes. 07:10:11 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'] 07:10:11 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 07:10:13 INFO - Return code: 0 07:10: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')]} 07:10:13 INFO - https://queue.taskcluster.net/v1/task/bnrB5DbETWi0HLZtrnganQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:10:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnrB5DbETWi0HLZtrnganQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:10:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnrB5DbETWi0HLZtrnganQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:10:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnrB5DbETWi0HLZtrnganQ/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 07:10:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnrB5DbETWi0HLZtrnganQ/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 07:10:14 INFO - Downloaded 14403333 bytes. 07:10:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:10:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:10:14 INFO - Return code: 0 07:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:14 INFO - https://queue.taskcluster.net/v1/task/bnrB5DbETWi0HLZtrnganQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:10:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnrB5DbETWi0HLZtrnganQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:10:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnrB5DbETWi0HLZtrnganQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:10:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnrB5DbETWi0HLZtrnganQ/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 07:10:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnrB5DbETWi0HLZtrnganQ/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 07:10:15 INFO - Downloaded 60353920 bytes. 07:10:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bnrB5DbETWi0HLZtrnganQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:10:15 INFO - mkdir: /builds/slave/test/properties 07:10:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:10:15 INFO - Writing to file /builds/slave/test/properties/build_url 07:10:15 INFO - Contents: 07:10:15 INFO - build_url:https://queue.taskcluster.net/v1/task/bnrB5DbETWi0HLZtrnganQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:10:16 INFO - Running post-action listener: _resource_record_post_action 07:10:16 INFO - Running post-action listener: set_extra_try_arguments 07:10:16 INFO - ##### 07:10:16 INFO - ##### Finished download-and-extract step (success) 07:10:16 INFO - ##### 07:10:16 INFO - ##### 07:10:16 INFO - ##### Running populate-webroot step. 07:10:16 INFO - ##### 07:10:16 INFO - Running pre-action listener: _resource_record_pre_action 07:10:16 INFO - Running main action method: populate_webroot 07:10:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:10:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:10:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:10:16 INFO - '--tppagecycles', 07:10:16 INFO - '7'], 07:10:16 INFO - 'tests': ['tsvgm']}}, 07:10:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:10:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:10:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:10:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:10:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:10:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:10:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:16 INFO - 'talos_options': ['--disable-e10s'], 07:10:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:10:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:10:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:16 INFO - 'talos_options': ['--disable-e10s'], 07:10:16 INFO - 'tests': ['damp', 'tps']}, 07:10:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:16 INFO - 'tests': ['damp', 'tps']}, 07:10:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:10:16 INFO - 'tests': ['dromaeo_dom']}, 07:10:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:10:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:10:16 INFO - 'tests': ['basic_compositor_video']}, 07:10:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:10:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:10:16 INFO - 'tests': ['a11yr', 07:10:16 INFO - 'ts_paint', 07:10:16 INFO - 'tpaint', 07:10:16 INFO - 'sessionrestore', 07:10:16 INFO - 'sessionrestore_no_auto_restore', 07:10:16 INFO - 'tabpaint']}, 07:10:16 INFO - 'other-e10s': {'tests': ['a11yr', 07:10:16 INFO - 'ts_paint', 07:10:16 INFO - 'tpaint', 07:10:16 INFO - 'sessionrestore', 07:10:16 INFO - 'sessionrestore_no_auto_restore', 07:10:16 INFO - 'tabpaint']}, 07:10:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:10:16 INFO - 'ts_paint', 07:10:16 INFO - 'tpaint', 07:10:16 INFO - 'sessionrestore', 07:10:16 INFO - 'sessionrestore_no_auto_restore', 07:10:16 INFO - 'tabpaint']}, 07:10:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:10:16 INFO - 'ts_paint', 07:10:16 INFO - 'tpaint', 07:10:16 INFO - 'sessionrestore', 07:10:16 INFO - 'sessionrestore_no_auto_restore', 07:10:16 INFO - 'tabpaint']}, 07:10:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:10:16 INFO - 'tests': ['a11yr', 07:10:16 INFO - 'ts_paint', 07:10:16 INFO - 'tpaint', 07:10:16 INFO - 'sessionrestore', 07:10:16 INFO - 'sessionrestore_no_auto_restore', 07:10:16 INFO - 'tabpaint']}, 07:10:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:10:16 INFO - 'tests': ['a11yr', 07:10:16 INFO - 'ts_paint', 07:10:16 INFO - 'tpaint', 07:10:16 INFO - 'sessionrestore', 07:10:16 INFO - 'sessionrestore_no_auto_restore', 07:10:16 INFO - 'tabpaint']}, 07:10:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:10:16 INFO - 'tests': ['tsvgx', 07:10:16 INFO - 'tsvgr_opacity', 07:10:16 INFO - 'tart', 07:10:16 INFO - 'tscrollx', 07:10:16 INFO - 'cart']}, 07:10:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:10:16 INFO - 'tsvgr_opacity', 07:10:16 INFO - 'tart', 07:10:16 INFO - 'tscrollx', 07:10:16 INFO - 'cart']}, 07:10:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:16 INFO - 'talos_options': ['--disable-e10s'], 07:10:16 INFO - 'tests': ['tp5o']}, 07:10:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:16 INFO - 'tests': ['tp5o']}, 07:10:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:16 INFO - 'talos_options': ['--disable-e10s', 07:10:16 INFO - '--xperf_path', 07:10:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:10:16 INFO - 'tests': ['tp5n']}, 07:10:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:16 INFO - 'talos_options': ['--xperf_path', 07:10:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:10:16 INFO - 'tests': ['tp5n']}}, 07:10:16 INFO - 'talos.zip': {'path': '', 07:10:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:10:16 INFO - Running post-action listener: _resource_record_post_action 07:10:16 INFO - ##### 07:10:16 INFO - ##### Finished populate-webroot step (success) 07:10:16 INFO - ##### 07:10:16 INFO - ##### 07:10:16 INFO - ##### Running create-virtualenv step. 07:10:16 INFO - ##### 07:10:16 INFO - Running pre-action listener: _resource_record_pre_action 07:10:16 INFO - Running main action method: create_virtualenv 07:10:16 INFO - Creating virtualenv /builds/slave/test/build/venv 07:10:16 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 07:10:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:10:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:10:16 INFO - Using real prefix '/usr' 07:10:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:10:17 INFO - Installing distribute.............................................................................................................................................................................................done. 07:10:19 INFO - Installing pip.................done. 07:10:19 INFO - Return code: 0 07:10:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:10: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')]} 07:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10: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')]} 07:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6b3b0>, '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 0x2c6c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428', '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 07:10:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:10:19 INFO - Using env: {'DISPLAY': ':0', 07:10:19 INFO - 'HOME': '/home/cltbld', 07:10:19 INFO - 'LANG': 'en_US.UTF-8', 07:10:19 INFO - 'LANGUAGE': 'en_US:en', 07:10:19 INFO - 'LOGNAME': 'cltbld', 07:10:19 INFO - 'MAIL': '/var/mail/cltbld', 07:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:19 INFO - 'MOZ_NO_REMOTE': '1', 07:10:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:19 INFO - 'NO_EM_RESTART': '1', 07:10:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:19 INFO - 'PWD': '/builds/slave/test', 07:10:19 INFO - 'SHELL': '/bin/bash', 07:10:19 INFO - 'SHLVL': '1', 07:10:19 INFO - 'TERM': 'linux', 07:10:19 INFO - 'TMOUT': '86400', 07:10:19 INFO - 'USER': 'cltbld', 07:10:19 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428', 07:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:19 INFO - '_': '/tools/buildbot/bin/python'} 07:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:19 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 07:10:19 INFO - Cleaning up... 07:10:19 INFO - Return code: 0 07:10:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:10: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')]} 07:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10: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')]} 07:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6b3b0>, '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 0x2c6c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428', '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 07:10:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:10:19 INFO - Using env: {'DISPLAY': ':0', 07:10:19 INFO - 'HOME': '/home/cltbld', 07:10:19 INFO - 'LANG': 'en_US.UTF-8', 07:10:19 INFO - 'LANGUAGE': 'en_US:en', 07:10:19 INFO - 'LOGNAME': 'cltbld', 07:10:19 INFO - 'MAIL': '/var/mail/cltbld', 07:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:19 INFO - 'MOZ_NO_REMOTE': '1', 07:10:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:19 INFO - 'NO_EM_RESTART': '1', 07:10:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:19 INFO - 'PWD': '/builds/slave/test', 07:10:19 INFO - 'SHELL': '/bin/bash', 07:10:19 INFO - 'SHLVL': '1', 07:10:19 INFO - 'TERM': 'linux', 07:10:19 INFO - 'TMOUT': '86400', 07:10:19 INFO - 'USER': 'cltbld', 07:10:19 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428', 07:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:19 INFO - '_': '/tools/buildbot/bin/python'} 07:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:19 INFO - Downloading/unpacking psutil>=3.1.1 07:10:19 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 07:10:19 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 07:10:19 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 07:10:19 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 07:10:19 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 07:10:19 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 07:10:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:10:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:10:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:10:21 INFO - Installing collected packages: psutil 07:10:21 INFO - Running setup.py install for psutil 07:10:21 INFO - building 'psutil._psutil_linux' extension 07:10:21 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 07:10:21 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 07:10:21 INFO - building 'psutil._psutil_posix' extension 07:10:21 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 07:10:21 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 07:10:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:10:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:10:22 INFO - Successfully installed psutil 07:10:22 INFO - Cleaning up... 07:10:22 INFO - Return code: 0 07:10:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:10: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')]} 07:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10: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')]} 07:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6b3b0>, '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 0x2c6c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428', '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 07:10:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:10:22 INFO - Using env: {'DISPLAY': ':0', 07:10:22 INFO - 'HOME': '/home/cltbld', 07:10:22 INFO - 'LANG': 'en_US.UTF-8', 07:10:22 INFO - 'LANGUAGE': 'en_US:en', 07:10:22 INFO - 'LOGNAME': 'cltbld', 07:10:22 INFO - 'MAIL': '/var/mail/cltbld', 07:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:22 INFO - 'MOZ_NO_REMOTE': '1', 07:10:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:22 INFO - 'NO_EM_RESTART': '1', 07:10:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:22 INFO - 'PWD': '/builds/slave/test', 07:10:22 INFO - 'SHELL': '/bin/bash', 07:10:22 INFO - 'SHLVL': '1', 07:10:22 INFO - 'TERM': 'linux', 07:10:22 INFO - 'TMOUT': '86400', 07:10:22 INFO - 'USER': 'cltbld', 07:10:22 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428', 07:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:22 INFO - '_': '/tools/buildbot/bin/python'} 07:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:10:22 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 07:10:22 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 07:10:22 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 07:10:22 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 07:10:22 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 07:10:22 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 07:10:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:10:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:10:24 INFO - Installing collected packages: mozsystemmonitor 07:10:24 INFO - Running setup.py install for mozsystemmonitor 07:10:24 INFO - Successfully installed mozsystemmonitor 07:10:24 INFO - Cleaning up... 07:10:24 INFO - Return code: 0 07:10:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:24 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 0x29ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6b3b0>, '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 0x2c6c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428', '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 07:10:24 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 07:10:24 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 07:10:24 INFO - Using env: {'DISPLAY': ':0', 07:10:24 INFO - 'HOME': '/home/cltbld', 07:10:24 INFO - 'LANG': 'en_US.UTF-8', 07:10:24 INFO - 'LANGUAGE': 'en_US:en', 07:10:24 INFO - 'LOGNAME': 'cltbld', 07:10:24 INFO - 'MAIL': '/var/mail/cltbld', 07:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:24 INFO - 'MOZ_NO_REMOTE': '1', 07:10:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:24 INFO - 'NO_EM_RESTART': '1', 07:10:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:24 INFO - 'PWD': '/builds/slave/test', 07:10:24 INFO - 'SHELL': '/bin/bash', 07:10:24 INFO - 'SHLVL': '1', 07:10:24 INFO - 'TERM': 'linux', 07:10:24 INFO - 'TMOUT': '86400', 07:10:24 INFO - 'USER': 'cltbld', 07:10:24 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428', 07:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:24 INFO - '_': '/tools/buildbot/bin/python'} 07:10:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:24 INFO - Downloading/unpacking jsonschema==2.5.1 07:10: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 07:10: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 07:10: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 07:10: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 07:10: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 07:10: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 07:10:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:10:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:10:26 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 07:10:26 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 07:10:26 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 07:10:26 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 07:10:26 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 07:10:26 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 07:10:26 INFO - Downloading functools32-3.2.3-2.tar.gz 07:10:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:10:26 INFO - warning: no files found matching '*.txt' 07:10:26 INFO - no previously-included directories found matching 'build' 07:10:26 INFO - no previously-included directories found matching 'dist' 07:10:26 INFO - no previously-included directories found matching '.git*' 07:10:26 INFO - Installing collected packages: jsonschema, functools32 07:10:26 INFO - Running setup.py install for functools32 07:10:26 INFO - warning: no files found matching '*.txt' 07:10:26 INFO - no previously-included directories found matching 'build' 07:10:26 INFO - no previously-included directories found matching 'dist' 07:10:26 INFO - no previously-included directories found matching '.git*' 07:10:26 INFO - Successfully installed jsonschema functools32 07:10:26 INFO - Cleaning up... 07:10:27 INFO - Return code: 0 07:10:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6b3b0>, '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 0x2c6c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428', '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 07:10:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:10:27 INFO - Using env: {'DISPLAY': ':0', 07:10:27 INFO - 'HOME': '/home/cltbld', 07:10:27 INFO - 'LANG': 'en_US.UTF-8', 07:10:27 INFO - 'LANGUAGE': 'en_US:en', 07:10:27 INFO - 'LOGNAME': 'cltbld', 07:10:27 INFO - 'MAIL': '/var/mail/cltbld', 07:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:27 INFO - 'MOZ_NO_REMOTE': '1', 07:10:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:27 INFO - 'NO_EM_RESTART': '1', 07:10:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:27 INFO - 'PWD': '/builds/slave/test', 07:10:27 INFO - 'SHELL': '/bin/bash', 07:10:27 INFO - 'SHLVL': '1', 07:10:27 INFO - 'TERM': 'linux', 07:10:27 INFO - 'TMOUT': '86400', 07:10:27 INFO - 'USER': 'cltbld', 07:10:27 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428', 07:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:27 INFO - '_': '/tools/buildbot/bin/python'} 07:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:27 INFO - Downloading/unpacking blobuploader==1.2.4 07:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:29 INFO - Downloading blobuploader-1.2.4.tar.gz 07:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:10:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:10:29 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 07:10:29 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 07:10:29 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 07:10:29 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 07:10:29 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 07:10:29 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 07:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:10:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:10:29 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 07:10:29 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 07:10:29 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 07:10:29 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 07:10:29 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 07:10:29 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 07:10:29 INFO - Downloading docopt-0.6.1.tar.gz 07:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:10:29 INFO - Installing collected packages: blobuploader, requests, docopt 07:10:29 INFO - Running setup.py install for blobuploader 07:10:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:10:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:10:29 INFO - Running setup.py install for requests 07:10:30 INFO - Running setup.py install for docopt 07:10:30 INFO - Successfully installed blobuploader requests docopt 07:10:30 INFO - Cleaning up... 07:10:30 INFO - Return code: 0 07:10:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10:30 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')]} 07:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:30 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')]} 07:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:30 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 0x29ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6b3b0>, '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 0x2c6c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428', '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 07:10:30 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 07:10:30 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 07:10:30 INFO - Using env: {'DISPLAY': ':0', 07:10:30 INFO - 'HOME': '/home/cltbld', 07:10:30 INFO - 'LANG': 'en_US.UTF-8', 07:10:30 INFO - 'LANGUAGE': 'en_US:en', 07:10:30 INFO - 'LOGNAME': 'cltbld', 07:10:30 INFO - 'MAIL': '/var/mail/cltbld', 07:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:30 INFO - 'MOZ_NO_REMOTE': '1', 07:10:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:30 INFO - 'NO_EM_RESTART': '1', 07:10:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:30 INFO - 'PWD': '/builds/slave/test', 07:10:30 INFO - 'SHELL': '/bin/bash', 07:10:30 INFO - 'SHLVL': '1', 07:10:30 INFO - 'TERM': 'linux', 07:10:30 INFO - 'TMOUT': '86400', 07:10:30 INFO - 'USER': 'cltbld', 07:10:30 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428', 07:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:30 INFO - '_': '/tools/buildbot/bin/python'} 07:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:10:30 INFO - Running setup.py (path:/tmp/pip-F9GWls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:10:30 INFO - Running setup.py (path:/tmp/pip-3Nqq8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:10:30 INFO - Running setup.py (path:/tmp/pip-ZLgaHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:10:30 INFO - Running setup.py (path:/tmp/pip-Q9xKfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:10:30 INFO - Running setup.py (path:/tmp/pip-9zTFeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:10:31 INFO - Running setup.py (path:/tmp/pip-ZwvrMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:10:31 INFO - Running setup.py (path:/tmp/pip-0XisN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:10:31 INFO - Running setup.py (path:/tmp/pip-HWrDab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:10:31 INFO - Running setup.py (path:/tmp/pip-o0ALfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:10:31 INFO - Running setup.py (path:/tmp/pip-bAyolh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:10:31 INFO - Running setup.py (path:/tmp/pip-6jY1QP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:10:31 INFO - Running setup.py (path:/tmp/pip-j7jEYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:10:31 INFO - Running setup.py (path:/tmp/pip-Atg_tJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:10:31 INFO - Running setup.py (path:/tmp/pip-gOZuwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:31 INFO - Running setup.py (path:/tmp/pip-sgyLtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:10:31 INFO - Running setup.py (path:/tmp/pip-d0wqaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:10:31 INFO - Running setup.py (path:/tmp/pip-fmeyWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:10:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:10:31 INFO - Running setup.py install for manifestparser 07:10:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:10:32 INFO - Running setup.py install for mozcrash 07:10:32 INFO - Running setup.py install for mozdebug 07:10:32 INFO - Running setup.py install for mozdevice 07:10:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:10:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:10:32 INFO - Running setup.py install for mozfile 07:10:32 INFO - Running setup.py install for mozhttpd 07:10:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:10:32 INFO - Running setup.py install for mozinfo 07:10:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:10:32 INFO - Running setup.py install for mozInstall 07:10:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:10:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:10:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:10:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:10:32 INFO - Running setup.py install for mozleak 07:10:32 INFO - Running setup.py install for mozlog 07:10:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:10:32 INFO - Running setup.py install for moznetwork 07:10:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:10:33 INFO - Running setup.py install for mozprocess 07:10:33 INFO - Running setup.py install for mozprofile 07:10:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:10:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:10:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:10:33 INFO - Running setup.py install for mozrunner 07:10:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:10:33 INFO - Running setup.py install for mozscreenshot 07:10:33 INFO - Running setup.py install for moztest 07:10:33 INFO - Running setup.py install for mozversion 07:10:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:10:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:10:33 INFO - Cleaning up... 07:10:33 INFO - Return code: 0 07:10:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:33 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 0x29ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6b3b0>, '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 0x2c6c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428', '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 07:10:33 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 07:10:33 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 07:10:33 INFO - Using env: {'DISPLAY': ':0', 07:10:33 INFO - 'HOME': '/home/cltbld', 07:10:33 INFO - 'LANG': 'en_US.UTF-8', 07:10:33 INFO - 'LANGUAGE': 'en_US:en', 07:10:33 INFO - 'LOGNAME': 'cltbld', 07:10:33 INFO - 'MAIL': '/var/mail/cltbld', 07:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:33 INFO - 'MOZ_NO_REMOTE': '1', 07:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:33 INFO - 'NO_EM_RESTART': '1', 07:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:33 INFO - 'PWD': '/builds/slave/test', 07:10:33 INFO - 'SHELL': '/bin/bash', 07:10:33 INFO - 'SHLVL': '1', 07:10:33 INFO - 'TERM': 'linux', 07:10:33 INFO - 'TMOUT': '86400', 07:10:33 INFO - 'USER': 'cltbld', 07:10:33 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428', 07:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:33 INFO - '_': '/tools/buildbot/bin/python'} 07:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:10:33 INFO - Running setup.py (path:/tmp/pip-RgMkU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:10:33 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)) 07:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:10:33 INFO - Running setup.py (path:/tmp/pip-DfjWOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:10:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:10:34 INFO - Running setup.py (path:/tmp/pip-503scG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:10:34 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)) 07:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:10:34 INFO - Running setup.py (path:/tmp/pip-9hkBc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:10:34 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)) 07:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:10:34 INFO - Running setup.py (path:/tmp/pip-clba9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:10:34 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)) 07:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:10:34 INFO - Running setup.py (path:/tmp/pip-HJ851o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:10:34 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)) 07:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:10:34 INFO - Running setup.py (path:/tmp/pip-y3XTbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:10:34 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)) 07:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:10:34 INFO - Running setup.py (path:/tmp/pip-kwb2KR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:10:34 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)) 07:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:10:34 INFO - Running setup.py (path:/tmp/pip-kzR9q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:10:34 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)) 07:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:10:34 INFO - Running setup.py (path:/tmp/pip-cdIWCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:10:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:10:34 INFO - Running setup.py (path:/tmp/pip-xbhsRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:10:34 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)) 07:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:10:34 INFO - Running setup.py (path:/tmp/pip-6vpVnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:10:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:10:34 INFO - Running setup.py (path:/tmp/pip-IwPCBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:10:34 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)) 07:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:10:34 INFO - Running setup.py (path:/tmp/pip-F4v1vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:10:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:34 INFO - Running setup.py (path:/tmp/pip-LqNiok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:10:35 INFO - Running setup.py (path:/tmp/pip-DuGRvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:10:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:10:35 INFO - Running setup.py (path:/tmp/pip-R5IOhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:10:35 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)) 07:10:35 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)) 07:10:35 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)) 07:10:35 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)) 07:10:35 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)) 07:10:35 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)) 07:10:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:37 INFO - Downloading blessings-1.6.tar.gz 07:10:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:10:37 INFO - Installing collected packages: blessings 07:10:37 INFO - Running setup.py install for blessings 07:10:37 INFO - Successfully installed blessings 07:10:37 INFO - Cleaning up... 07:10:37 INFO - Return code: 0 07:10:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:10:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:10:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:10:37 INFO - Reading from file tmpfile_stdout 07:10:37 INFO - Current package versions: 07:10:37 INFO - argparse == 1.2.1 07:10:37 INFO - blessings == 1.6 07:10:37 INFO - blobuploader == 1.2.4 07:10:37 INFO - docopt == 0.6.1 07:10:37 INFO - functools32 == 3.2.3-2 07:10:37 INFO - jsonschema == 2.5.1 07:10:37 INFO - manifestparser == 1.1 07:10:37 INFO - mozInstall == 1.12 07:10:37 INFO - mozcrash == 0.17 07:10:37 INFO - mozdebug == 0.1 07:10:37 INFO - mozdevice == 0.48 07:10:37 INFO - mozfile == 1.2 07:10:37 INFO - mozhttpd == 0.7 07:10:37 INFO - mozinfo == 0.9 07:10:37 INFO - mozleak == 0.1 07:10:37 INFO - mozlog == 3.2 07:10:37 INFO - moznetwork == 0.27 07:10:37 INFO - mozprocess == 0.22 07:10:37 INFO - mozprofile == 0.28 07:10:37 INFO - mozrunner == 6.11 07:10:37 INFO - mozscreenshot == 0.1 07:10:37 INFO - mozsystemmonitor == 0.3 07:10:37 INFO - moztest == 0.7 07:10:37 INFO - mozversion == 1.4 07:10:37 INFO - psutil == 3.1.1 07:10:37 INFO - requests == 1.2.3 07:10:37 INFO - wsgiref == 0.1.2 07:10:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10:37 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')]} 07:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:37 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')]} 07:10:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:37 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 0x29ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6b3b0>, '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 0x2c6c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428', '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 07:10:37 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 07:10:37 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 07:10:37 INFO - Using env: {'DISPLAY': ':0', 07:10:37 INFO - 'HOME': '/home/cltbld', 07:10:37 INFO - 'LANG': 'en_US.UTF-8', 07:10:37 INFO - 'LANGUAGE': 'en_US:en', 07:10:37 INFO - 'LOGNAME': 'cltbld', 07:10:37 INFO - 'MAIL': '/var/mail/cltbld', 07:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:37 INFO - 'MOZ_NO_REMOTE': '1', 07:10:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:37 INFO - 'NO_EM_RESTART': '1', 07:10:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:37 INFO - 'PWD': '/builds/slave/test', 07:10:37 INFO - 'SHELL': '/bin/bash', 07:10:37 INFO - 'SHLVL': '1', 07:10:37 INFO - 'TERM': 'linux', 07:10:37 INFO - 'TMOUT': '86400', 07:10:37 INFO - 'USER': 'cltbld', 07:10:37 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428', 07:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:37 INFO - '_': '/tools/buildbot/bin/python'} 07:10:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:37 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)) 07:10:37 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)) 07:10:37 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)) 07:10:37 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)) 07:10:37 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)) 07:10:37 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)) 07:10:37 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)) 07:10:37 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)) 07:10:37 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)) 07:10:37 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)) 07:10:37 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)) 07:10:37 INFO - Cleaning up... 07:10:37 INFO - Return code: 0 07:10:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:10:37 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')]} 07:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:37 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')]} 07:10:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:37 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 0x29ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6b3b0>, '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 0x2c6c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428', '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 07:10:37 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 07:10:37 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 07:10:37 INFO - Using env: {'DISPLAY': ':0', 07:10:37 INFO - 'HOME': '/home/cltbld', 07:10:37 INFO - 'LANG': 'en_US.UTF-8', 07:10:37 INFO - 'LANGUAGE': 'en_US:en', 07:10:37 INFO - 'LOGNAME': 'cltbld', 07:10:37 INFO - 'MAIL': '/var/mail/cltbld', 07:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:37 INFO - 'MOZ_NO_REMOTE': '1', 07:10:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:37 INFO - 'NO_EM_RESTART': '1', 07:10:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:37 INFO - 'PWD': '/builds/slave/test', 07:10:37 INFO - 'SHELL': '/bin/bash', 07:10:37 INFO - 'SHLVL': '1', 07:10:37 INFO - 'TERM': 'linux', 07:10:37 INFO - 'TMOUT': '86400', 07:10:37 INFO - 'USER': 'cltbld', 07:10:37 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428', 07:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:37 INFO - '_': '/tools/buildbot/bin/python'} 07:10:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:10:37 INFO - Cleaning up... 07:10:37 INFO - Return code: 0 07:10:37 INFO - Running post-action listener: _resource_record_post_action 07:10:37 INFO - Running post-action listener: _start_resource_monitoring 07:10:38 INFO - Starting resource monitoring. 07:10:38 INFO - ##### 07:10:38 INFO - ##### Finished create-virtualenv step (success) 07:10:38 INFO - ##### 07:10:38 INFO - ##### 07:10:38 INFO - ##### Running install step. 07:10:38 INFO - ##### 07:10:38 INFO - Running pre-action listener: _resource_record_pre_action 07:10:38 INFO - Running main action method: install 07:10:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:10:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:10:38 INFO - Reading from file tmpfile_stdout 07:10:38 INFO - Detecting whether we're running mozinstall >=1.0... 07:10:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:10:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:10:38 INFO - Reading from file tmpfile_stdout 07:10:38 INFO - Output received: 07:10:38 INFO - Usage: mozinstall [options] installer 07:10:38 INFO - Options: 07:10:38 INFO - -h, --help show this help message and exit 07:10:38 INFO - -d DEST, --destination=DEST 07:10:38 INFO - Directory to install application into. [default: 07:10:38 INFO - "/builds/slave/test"] 07:10:38 INFO - --app=APP Application being installed. [default: firefox] 07:10:38 INFO - mkdir: /builds/slave/test/build/application 07:10:38 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'] 07:10:38 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 07:10:55 INFO - Reading from file tmpfile_stdout 07:10:55 INFO - Output received: 07:10:55 INFO - /builds/slave/test/build/application/firefox/firefox 07:10:55 INFO - Running post-action listener: _resource_record_post_action 07:10:55 INFO - ##### 07:10:55 INFO - ##### Finished install step (success) 07:10:55 INFO - ##### 07:10:55 INFO - ##### 07:10:55 INFO - ##### Running run-tests step. 07:10:55 INFO - ##### 07:10:55 INFO - Running pre-action listener: _resource_record_pre_action 07:10:55 INFO - Running main action method: run_tests 07:10:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:10:55 INFO - Python 2.7.3 07:10:55 INFO - Return code: 0 07:10:55 INFO - grabbing minidump binary from tooltool 07:10: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')]} 07:10:55 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6b3b0>, '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 0x2c6c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:10:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:10:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:10:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:10:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:10:55 INFO - Return code: 0 07:10:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:10:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:10:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:10:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:10:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:10:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bnrB5DbETWi0HLZtrnganQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bnrB5DbETWi0HLZtrnganQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:10:55 INFO - Using env: {'DISPLAY': ':0', 07:10:55 INFO - 'HOME': '/home/cltbld', 07:10:55 INFO - 'LANG': 'en_US.UTF-8', 07:10:55 INFO - 'LANGUAGE': 'en_US:en', 07:10:55 INFO - 'LOGNAME': 'cltbld', 07:10:55 INFO - 'MAIL': '/var/mail/cltbld', 07:10:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:10:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:55 INFO - 'MOZ_NO_REMOTE': '1', 07:10:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:10:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:55 INFO - 'NO_EM_RESTART': '1', 07:10:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:55 INFO - 'PWD': '/builds/slave/test', 07:10:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:10:55 INFO - 'SHELL': '/bin/bash', 07:10:55 INFO - 'SHLVL': '1', 07:10:55 INFO - 'TERM': 'linux', 07:10:55 INFO - 'TMOUT': '86400', 07:10:55 INFO - 'USER': 'cltbld', 07:10:55 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428', 07:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:55 INFO - '_': '/tools/buildbot/bin/python'} 07:10:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bnrB5DbETWi0HLZtrnganQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:10:55 INFO - mozversion application_buildid: 20160706043019 07:10:55 INFO - mozversion application_changeset: 95ffbc4ff63584631c408e8d9912961fcf68bb09 07:10:55 INFO - mozversion application_display_name: Nightly 07:10:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:10:55 INFO - mozversion application_name: Firefox 07:10:55 INFO - mozversion application_remotingname: firefox 07:10:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:10:55 INFO - mozversion application_vendor: Mozilla 07:10:55 INFO - mozversion application_version: 50.0a1 07:10:55 INFO - mozversion platform_buildid: 20160706043019 07:10:55 INFO - mozversion platform_changeset: 95ffbc4ff63584631c408e8d9912961fcf68bb09 07:10:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:10:55 INFO - mozversion platform_version: 50.0a1 07:10:55 INFO - using testdate: 1467814255 07:10:55 INFO - actual date: 1467814255 07:10:55 INFO - starting webserver on 'localhost:40200' 07:10:55 INFO - SUITE-START | Running 2 tests 07:10:55 INFO - TEST-START | dromaeo_css 07:10:55 INFO - operating with platform_type : linux_ 07:10:55 INFO - Initialising browser for dromaeo_css test... 07:10:55 INFO - TEST-INFO | started process 32090 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuT0TWv/profile http://localhost:40200/getInfo.html) 07:10:59 INFO - PROCESS | 32090 | __metrics Screen width/height:1600/1200 07:10:59 INFO - PROCESS | 32090 | colorDepth:24 07:10:59 INFO - PROCESS | 32090 | Browser inner width/height: 1024/697 07:10:59 INFO - PROCESS | 32090 | __metrics 07:11:01 INFO - PROCESS | 32090 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:11:01 INFO - TEST-INFO | 32090: exit 0 07:11:01 INFO - Browser initialized. 07:11:01 INFO - Running cycle 1/1 for dromaeo_css test... 07:11:01 INFO - TEST-INFO | started process 32173 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuT0TWv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:11:13 INFO - PROCESS | 32173 | RSS: Main: 156819456 07:11:13 INFO - PROCESS | 32173 | 07:12:04 INFO - PROCESS | 32173 | 1467814324558 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] 07:14:13 INFO - PROCESS | 32173 | Cycle 1(1): loaded http://localhost:40200/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40200/tests/dromaeo/cssquery-ext.html) 07:14:14 INFO - PROCESS | 32173 | RSS: Main: 291737600 07:14:14 INFO - PROCESS | 32173 | 07:17:17 INFO - PROCESS | 32173 | Cycle 1(1): loaded http://localhost:40200/tests/dromaeo/cssquery-ext.html (next: http://localhost:40200/tests/dromaeo/cssquery-jquery.html) 07:17:18 INFO - PROCESS | 32173 | RSS: Main: 237719552 07:17:18 INFO - PROCESS | 32173 | 07:20:19 INFO - PROCESS | 32173 | Cycle 1(1): loaded http://localhost:40200/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40200/tests/dromaeo/cssquery-mootools.html) 07:20:20 INFO - PROCESS | 32173 | RSS: Main: 245485568 07:20:20 INFO - PROCESS | 32173 | 07:23:22 INFO - PROCESS | 32173 | Cycle 1(1): loaded http://localhost:40200/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40200/tests/dromaeo/cssquery-prototype.html) 07:23:23 INFO - PROCESS | 32173 | RSS: Main: 233103360 07:23:23 INFO - PROCESS | 32173 | 07:26:25 INFO - PROCESS | 32173 | Cycle 1(1): loaded http://localhost:40200/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40200/tests/dromaeo/cssquery-yui.html) 07:26:26 INFO - PROCESS | 32173 | RSS: Main: 227672064 07:26:26 INFO - PROCESS | 32173 | 07:29:29 INFO - PROCESS | 32173 | Cycle 1(1): loaded http://localhost:40200/tests/dromaeo/cssquery-yui.html (next: http://localhost:40200/tests/dromaeo/cssquery-dojo.html) 07:29:29 INFO - PROCESS | 32173 | RSS: Main: 343638016 07:29:29 INFO - PROCESS | 32173 | 07:29:29 INFO - PROCESS | 32173 | __start_tp_report 07:29:29 INFO - PROCESS | 32173 | _x_x_mozilla_page_load 07:29:29 INFO - PROCESS | 32173 | _x_x_mozilla_page_load_details 07:29:29 INFO - PROCESS | 32173 | |i|pagename|runs| 07:29:29 INFO - PROCESS | 32173 | |0;dojo.html;3077.984610076949;3120.126364617905;3158.936821263575;3161.9209519762003;3180.586523751912;5374.247605335257;5393.029254734146;5424.159255315422;5463.125899856024;5464.672119672818;5471.206675032118;5499.340079190492;5507.008738427082;5565;5605.635633683808;4801.639877009229;4837.903241935159;4843.612510999129;4935.432425271086;5063.949360506403;5014.69911805291;5100.387953445592;5112.130937740593;5114.948850511484;5159.071367153911;4871.732054736988;4877.561019508261;5006.199008158677;5038.370203724535;5115.10485665009;4862.3192753014255;4899.2896030075435;4923.556879880828;4923.950760492385;4941.332920055783;4905.730184839832;4945.035718034985;4983.053219888209;5001.374828146481;5037.395512538482;5360.16917377807;5408.621396502246;5493.2034854945805;5539.501444869981;5562.221289019541;5766.942330576724;5798.82603521895;5802.535797136219;5874.530037596982;5899.793507227227;5838.182654428383;5902.61632993854;5934.406559344031;5937.139114828326;5945.672987985659;5353.491418315254;5520.834374968757;5524.226608274845;5528.308961379827;5531.612787104864;5832.1834943108;5890.057590785454;5893.351731309553;5922.437368449991;5931.673757943355;5696.031674615242;5713.085906255063;5751.964646363611;5756.654600723886;5757.740901659352;5642;5724.656520608777;5780.335261444903;5839.386864379264;5851.444112809277;5748.338941021752;5760;5770.19217309577;5779.566532510079;5825.271841019872;5773.913391299134;5775.5668324875805;5805.10020946754;5816.360200377955;5819.447152520504;4338.82644694215;4399.428074350314;4421.778911054499;4444.533324000998;4459.598636122764;3981;3981.5620281768984;3992.261431635157;4029.6373326400767;4031.7580945143386;5534.308211473566;5535.474129957647;5535.474129957728;5536.252605898152;5543.362513311021;5701.116326969326;5831.941680583224;5897.5871688982215;5904.1734157218025;5922.526197904157;5539.2522009529;5545.500904918576;5560.165975103767;5562.666240025612;5564.944350556523;4927.630427717935;5074.492550744896;5077.974610126926;5087.771050302746;5118.744062796845;5971.731272092767;6011.248593925759;6026.849328766816;6038.939610603926;6043.728032238648;5837.182794408871;5844.211031510862;5849.473547380756;5850.12248162762;5858.648481091148;5856;5883.764649413975;6038.094285856981;6044.184035155197;6052.0921861719335;5591.273134492652;5636.605437619327;5668.121441176624;5677.432256774455;5723;5735.8566035849435;5768.423157684366;5769.07694768835;5774.913376299275;5802.303723553032;5572.526335261386;5609.018421776092;5648.85877853057;5652.576056795675;5680.971595142163;5736.282964629421;5741.224934633771;5743.655380677173;5747.281589801275;5785.884282314246;5679.829605111688;5681.971590142023;5687.203791469115;5689.886202276014;5700.942990570207;5582.358028826737;5612;5675.205471233948;5726.599138060295;5743.3395159557185;5518.117101263779;5521.47545983147;5531.806386776443;5532.114861622121;5579.972100139474 07:29:29 INFO - PROCESS | 32173 | |1;ext.html;590.9409059094091;619.5879739972918;622.4677900395162;622.7540121651945;634.4828964394019;30560.541591876114;42116.57883421165;43162.03636581794;43260;43365.91585210367;44742.776286118526;45094;45141.774291128495;45188.096238075304;45195.32207016889;8038.356931445471;8930.464172149692;9076.727698169065;9079.500627465486;9086.227670648002;10496.265261431665;10759.515821788038;10763.654543182101;11119.110471162328;11126.443677816076;10910.563577456933;11008.669739907815;11014.834777478345;11022.228444008922;11060.336379817236;8084.717034903809;10884.891151088466;10887.727806804854;10953.726156846104;11153.665390038312;10612.575496980111;11000.669979900616;11008.779824403468;11012.39431831249;11016.394098324588;42820.78589607032;43122;43249.13501729979;43272.783636081615;43301.56698433007;3012.7288544031144;3636.1273294409416;3708.740388172829;3814.6948244140403;3868.709846761476;32416.83791581027;32596.348073038407;32823.50764738531;33151;33482.162945926306;4453.131639330332;4462.531434199394;4468.374427580141;4483.327500874862;4483.596476317147;329601;334731;334958;335510.3224483886;336087;62389.68805156036;62512.37487625157;62879.6856015717;63056;63060;34387.82806086003;35210.29579408398;35264.471032934525;36931.81534092366;67238.66380668065;16868;17125.657486850192;17130.48608541746;17133.400330988356;17142.657146856993;11003.944980275208;12709.17390369623;12744.872551274553;13107.14803537767;13149.079564430589;20344;20543.178272868918;20561.48596285105;20631;20634.58730825375;7631.3894888408795;7776.183500732342;7857.2928436441;7896.565688887052;7917.7624671259955;1033.7932413517326;1084.4415126210008;1109.9334039957466;1122.169594500064;1159.084323384517;31825.363492730015;31961.680383196337;32223.67776322207;32355.676443235265;32525.349493010006;1110.7722916802036;1145.6963904565298;1167.8365028895962;1170.1633332167542;1175.488662431845;16830.83169168317;17026.659466810594;17140.65718685619;17311;17414.216360263566;415258;420187;420672;420948;421214;56569.15146272809;56607.716961415754;57053.14420283699;57197.42802571921;57217.713911430175;1233.6730766346925;1286.4789760147155;1347.5957212836306;1368.8631136886431;1393.324237744693;30104.397912041197;34114.48828267528;34210;34512.30975380428;34622.65377346295;51222;51231.74384128056;51865.22202166895;51881;51916.48083519116;403953;404249;404955;405308;405491;24358.26925192247;25011.499770004863;25193.244202673948;25232.49535009253;28556.143315700563;46611.30083048689;46928;47570.524294758;48404.273935891695;48535;40719.38920916248;41400.37899431451;41533.79233103815;41841.79079104707;42752.57247427486;39528.40707389334;41234;41590.1681966365;41884.58115418928;42482.57517424786;40223.396649049704;41077.38383924303;41755;41869;42095.7895210522;35754.64245357513;36954.26091478209;36966.260674785815;37457.19071069626;37521.81239093896;27940.580891287053;28059.796627724965;28192.85903570469;28259.82694190826;28273.717262827107 07:29:29 INFO - PROCESS | 32173 | |2;jquery.html;397.658014107867;403.5278723893045;406.5629448343031;407.8001779128228;419.230711644133;18525.444236672905;20136.395908122762;20144.395668129942;20179.09194086268;21552.568948621018;20059.09734061967;20562.48593785156;20599.176032958665;20613.1754729811;20625.484362890937;5458.5087342139195;5871.735771890275;5874.089516125007;5913.586048976574;5918.881622367571;5716.8856622867515;5830.183774271605;5869.911951320733;5902.3507414184405;5904.35052144266;5875.7062146892695;5921.082232253986;5921.319048309435;5928.081147422135;5929.1995580596495;5790.7973220937065;5861.824145275648;5864.354920958691;5864.560157988147;6145.385461453819;6005.069214271794;6022.638641681469;6033.879322413571;6044.184035155242;6050.42520960508;14556.344964476624;14667.193304368255;14933.626659333495;14936.62658433537;15008.699826003529;2510.57320255557;2513.384220865881;2875.7411832934927;2882.524383476724;3060.739837113848;10580.78838423235;10825;11045.061169800576;11085.168612354026;12107.636770896886;1932.951676208092;1943.0867492278605;2004.4988752811796;2046.549759053006;2049.11887888208;84235.57882210611;87610.5619471905;89077;89769;90462.54768726115;10832.945835270773;11070.723231919266;11142;11350.14873884462;11380.772384552429;15622.29699663518;15664.843351566338;15730.764038539432;15733.842661573466;15758.606034849221;7962.442629016029;8075.798105047421;8172.468789528781;8181.181881811771;8296.419250652396;7855.450118491765;7856.410769192219;7861.095973962953;7991;8012.1186669466315;4616.676832621684;4745.027269409763;4769.928451073237;4884.5603895649565;4897.804087836518;1810.6016676331449;1921.9519512012032;1930.44982180078;1941.26232031827;2034.532057626754;871.4422769427572;971.5385192033868;979.4172467381896;1006.6527048168371;1035.1563475767225;20117.79882201159;20708.378748637566;20778.48053798637;20780.896095519427;20911.477213069797;1011.812814629296;1030.4538594544754;1030.8917563655857;1042.6090216168936;1053.694428615693;11143.944280278709;11639.301641901513;11726.413679316;11743.647690569296;11746.119041071783;439180;443202;443953;446158;446788;95057.52471237599;96869;97190;97719;97821.5108924465;1003.7440452684518;1005.3163848582888;1014.1531820929459;1015.062699413822;1017.8982101789762;17937.192826322585;17959;18103.09484525742;18104.81895181084;18218.34897147219;42599.5740042608;43241.567584323755;43405.56594434015;44153.55846441494;44266.55733442753;55565.444345556025;56528.15207771969;59023.704881475314;59973;60128.39871601228;7934.444588878723;8229.382796290183;8279.37904657141;8474.957625211835;9285.025072367303;10659.4137322448;14515.78226326627;14555.19946402958;14665.853341466449;14728.77906831377;12236.082293828176;12466.314352710326;12496.937515312366;12509.56216532417;12515.483278059855;12038;12564.308963007123;12592.433340499883;12786.36068196605;13110.606681799562;12660.556880509506;12715.287265764699;12977.805332920203;13121.934390327988;13318.600441986757;8298.128696487023;8359;8376.49741015541;8406.579671016303;8564.143585641386;9302.883653961297;12302.938485307515;12506.624801255977;12638.052146089263;13046.673833153867 07:29:29 INFO - PROCESS | 32173 | |3;mootools.html;1368.8357397112345;1468.9485867994615;1607.1642745772199;1764.8146944570829;1794.1208807684238;8968.192862642361;9530.76173095673;9597.184239339656;9623.230141588674;9644.758881027969;8023.558704271263;8280.585970701455;8287.129851365595;8548.40161188717;9415.905840941588;2304.112916527141;2383.8212134089927;2393.3896856301617;2401.411654144737;2414.541237164933;2356.8939397727145;2388.4984153327823;2388.7969522590515;2413.0830284491867;2428.805695544352;2019.1721394228368;2327.243645815117;2373.0626402570974;2380.416797884512;2383.0586918167314;2386.868722220277;2425.9514809703883;2427.830051896368;2429.441228517451;2430.185887727596;2345.6012477878803;2355.234548771639;2387.140629373424;2389.092144984912;2394.030417680842;9533.809323813553;9588.328816982814;9591.856122158173;9597.376170548892;9599.90400095997;5510.448955104497;5545.223668686387;5577.358603760538;5586.776528938837;5654.943450565483;3372.865085396581;3417.6582341765875;3490.89527314181;3491.703205227533;3501.229729459515;1097.0948967102092;1112.3159257056932;1127.785720713062;1138.0667852361066;1141.925774824642;12997.415116319788;13129.60611181666;13151.079424440197;13155.802662960063;13163;4778.307145463958;4832.492588278251;4911.140550403737;4920.138975679241;5061.6962982221185;11112.666620001413;11172.10623150146;11207.047400970845;11231.943840280746;11240.775184496264;5698.2592263005545;5703.17303990919;5704.372519022904;5705.657660540381;5708.115242137475;5125.718085505258;5175.560077393388;5189.377274727057;5226.869328266747;5228.241904923765;4141.233871733739;4151.190517849051;4195;4214.093969796509;4233.343831706091;1307.457405176841;1340.376724822962;1345.327336331834;1354.2754626274896;1365.1058556645414;933.8785957825439;1013.7212266626589;1027.912627426677;1027.912627426677;1035.3270374256792;6209.348018458088;6285.182926219562;6317.652529110943;6346.9682651586445;6397.072424498421;452.49320760747514;458.5460394209708;459.05663860766447;461.789885602057;481.9084373968935;4282.164977829356;4365.738055716667;4437.378766972626;4465.486469056035;4470.329450582373;11060.723481913017;11482.77034459323;11528;11571.074314054855;11590.188686791844;11453.370064646524;11459.197856150156;11459.369734664673;11477.368744718953;11489.71275718097;8266.751997440086;8585.441946273471;8618.956905215433;8727.781805454915;8729.738107856774;6309.242890853127;6523.967380163069;6541.836454088686;6545.410913017851;6558.475321974135;10885.23803333759;10989.890101099207;10995.670129896116;11139.72150696239;11158.88841111611;9926;10265.486725663837;10930.070943969851;11096.61161859331;11386.259893106922;7945.205479452008;8169.223923727236;8220.753377398687;8233;8234.588270586328;9066.138716821892;9170.358074934691;9170.670252813437;9175.311851611023;9193.310501712265;8073.990751156105;8093.676252949816;8197.672093116209;8215.301699355621;8233.012038555411;8076.515409075474;8145;8197.754067377988;8280.668773249003;8409.159084091541;7065.187503437171;7078.221395646578;7142.750003749844;7145.4640901931525;7145.571265724073;5543.52880005204;5615.213870058114;5635.211070450058;5668.489835914787;5775.335836378702;5323.121684922099;5591.9720401397735;5724.856878578069;5821.79623713168;5926.992411290004 07:29:29 INFO - PROCESS | 32173 | |4;prototype.html;314.95593597551897;326.688012947635;331.85895994202457;331.9245644113074;333.6130089096647;5263.236830659562;5344.412114667393;5430.484104010117;5434.836954891354;5475.123980163175;5401.243825864382;5410.188471729242;5412.729363531827;5424.1321388577835;5434.2935418395555;4254.59581339773;4269.466316710411;4282.871513854574;4287.528371879091;4311.611954924057;3999.800009999503;4110.547839737626;4225.232472730351;4277.165952639237;4282.892927676818;4152.958470415288;4177.3107437272965;4186.476690413699;4187.183499217654;4216.283231850577;4150.460440142792;4167.124903770212;4175.457190565207;4176.832926682929;4189.832406703728;3617.656322649344;3719.200371920023;3726.9813650931574;3729.5710993235584;3762.3415902217275;5253.50091741284;5268.1834315681135;5283.471652834686;5291.3650361956425;5297.311349524575;4782.378290822171;4795.6163506919365;4803.366855269225;4805;4818.759062046884;5363.731813409353;5589.720513974285;5592.6085174037835;5603.187537807036;5645.717714114319;4037.6769858411258;4081.551029386765;4082.510098788164;4098.172261139834;4117.888170194061;5840.875131804464;5846.824595262149;5853.5902486825935;5882.441168088982;5921.644701317935;3957.584453632385;4159.376093585986;4180.686448516373;4182.247195504839;4183.686223533247;4209.3896385024;4212.85255016073;4216.659753836589;4233.576642335804;4257.552956939477;4827.975860120747;4830.516948305141;4837.685550439281;4839.879003024953;4841.370621819211;5486.341639003345;5677.233573467612;5688.488036076773;5698.230738850285;5720.8283751487525;1345.3138899161302;1386.6533366658336;1435.2464955898238;1437.3460075665548;1438.3958737330347;955.8088382323563;966.5501747378931;975.9121679048919;986.3785814936545;997.2570435025953;5358.240506139341;5369.48989845964;5386.272853164851;5397.2443857859935;5414.8917021659345;5674.319081710221;5685.744141513642;5718.855429214044;5739.311282646109;5740.913886291709;5159.998612370748;5379.569634429236;5395.865103372368;5415.810446634349;5419.647722897999;2688.1720430107325;2697.2852194168167;2712.5524288492575;2738.8082834201414;2742.835429874214;5267.26258323835;5275.4460781618145;5287.4448182941005;5294.444083371268;5298.198612471778;5225.007248622749;5566.54873978128;6062.484688801413;6062.575619706667;6071.3928607139815;6041.758329666852;6095.66473843934;6097;6124.785632502841;6131.233595800525;5590.357108932362;5865.882682346414;5866.3547009828035;5875.0612297940725;5883.852903677443;5767.711614419346;5801.245838041028;5815.156802263733;5832.183494310715;5837.416258374129;6013.458788708862;6014.609050411709;6017;6028.306744724413;6093.146959425595;3933.685305175636;4114.333694853589;4123.958760412357;4129.132882094794;4154.1068670236045;5621.690807005654;5777.6822274775295;5810;5839.912401313899;5852.561057920588;5528.198411230269;5613.831585052455;5618.887622247614;5643.463870932255;5651.802186923438;5680.557360335096;5688.829335119953;5691.686957217393;5696.401877802937;5701.942980570141;5523.254360661259;5579.735854524986;5652.604317697722;5666;5676.120201368794;5681.857953551194;5683.493874123444;5687.260656114679;5704.60067795267;5746.367899530965;5442.428545002717;5526.530244929226;5573.108302671553;5595.356533998643;5596 07:29:29 INFO - PROCESS | 32173 | |5;yui.html;757.2654525110643;791.8218400859804;836.9414141010128;852.0584753846995;886.5567216391802;15041.548753537398;15503.224838758073;15517.92241038796;15531.45639902605;18325.083745812724;17499.38752143675;17581.91209043956;17609.647807043882;17619.47141585751;17622.11889405528;681.1145510835918;802.3861745764494;809.8137428391474;836.2390224895346;838.9916100838974;818.4639061414753;838.2037064788445;838.5723281126608;839.0602525171786;840.4243093480954;867.1978419961542;873.1268731268731;874.1957399192726;874.4403581707712;875.3609864798701;694.0734119949898;837.0541288344132;866.4844417571535;870.3037569944051;870.5473153959937;632.4434497642092;632.7026297640102;634.1185751804994;634.5938599296454;634.7048622390611;15919.602009949727;15994.600134996603;15996.920015399965;16005.679886402324;16030;13933.442662293597;14398.92800536001;14466.71066578673;14478.1313121212;14485.130892146399;13816.93091534546;13848.169109853441;13952.2326272055;14059.71880562383;14065.85934140666;4564.863054108382;4618.237990731525;4675.696079754839;4722.197226471508;4783.449903261135;61827.38172618261;62384.37615623831;82512;83111;83859.16140838574;11430.599929002445;11444.542218311175;12103.232871257629;12213.877861221452;12308.938455307667;21491.247806326704;22960.196393126495;22964;22967.42581435444;22997.54004919926;8775.824483510421;8812.118788121137;8898.644054237759;8979.955100224457;9205.217556507772;4833.250846118857;4912.680675756064;4965.329680493087;5068.619853511002;5096.261042148868;3510.543629328222;3601.5318008659233;3601.675849173587;3607.603163651996;3612.710983121344;597.0745344715673;608.3581821178699;611.7981066248127;613.9693015349304;630.0360448513782;699.0283505926766;719.4388377065897;738.8706976279129;744.7951813251291;747.7121308296345;9285.442873427615;9449.244060475145;9475.995608344063;9647.758806029766;10032.614685047418;635.8569321902535;649.473926119835;667.3693359775064;724.6847621284758;732.2321624260304;4566.041131362451;4581.358609794632;4613.215753321943;4623.976880115578;4687.086018226413;72006;97419;107502;113683;113952;59546.40453595408;73437.26562734411;98117;98378;105913.47043264889;96011;96960;97175.14124293615;98303.50848245712;99650;8918.19736223743;9102.089791020844;9269.397489163453;9775.14769319675;10446.42544660051;42247.57752422436;46791.532084678714;52194;52372.21441678302;53565;76320.61839690767;77693;78727.60636196782;78942;80368;13188;13280.415658730655;13845.515406960709;13929.303534823015;14308.356123974654;15790.605234869221;15948.441804536786;16169.67660646757;16185.514434566981;16829.747553786947;10055.245856560641;13747.656308592364;14561.92719036398;15101.697966040838;15403.768943465633;15184.240787960336;15264.3894244229;15939.840601593836;16186.838131618533;16423.83576164271;14414.42342306338;14720.337584808494;15203;15295.61760955985;15321.770173447185;12101.878981210075;12433.37833108359;12656;12820.679483013;12911.354432278536;12188.390580470763;12752.68118297013;12786.68033299175;12945.288009159587;13119.27843968591 07:29:29 INFO - PROCESS | 32173 | __end_tp_report 07:29:29 INFO - PROCESS | 32173 | __start_cc_report 07:29:29 INFO - PROCESS | 32173 | _x_x_mozilla_cycle_collect,1090 07:29:29 INFO - PROCESS | 32173 | __end_cc_report 07:29:29 INFO - PROCESS | 32173 | __startTimestamp1467815369358__endTimestamp 07:29:29 INFO - PROCESS | 32173 | 07:29:29 INFO - PROCESS | 32173 | ------- Summary: start ------- 07:29:29 INFO - PROCESS | 32173 | Number of tests: 6 07:29:29 INFO - PROCESS | 32173 | 07:29:29 INFO - PROCESS | 32173 | [#0] dojo.html Cycles:165 Average:5411.99 Median:5605.64 stddev:608.64 (10.9%) stddev-sans-first:582.31 07:29:29 INFO - PROCESS | 32173 | Values: 3078.0 3120.1 3158.9 3161.9 3180.6 5374.2 5393.0 5424.2 5463.1 5464.7 5471.2 5499.3 5507.0 5565.0 5605.6 4801.6 4837.9 4843.6 4935.4 5063.9 5014.7 5100.4 5112.1 5114.9 5159.1 4871.7 4877.6 5006.2 5038.4 5115.1 4862.3 4899.3 4923.6 4924.0 4941.3 4905.7 4945.0 4983.1 5001.4 5037.4 5360.2 5408.6 5493.2 5539.5 5562.2 5766.9 5798.8 5802.5 5874.5 5899.8 5838.2 5902.6 5934.4 5937.1 5945.7 5353.5 5520.8 5524.2 5528.3 5531.6 5832.2 5890.1 5893.4 5922.4 5931.7 5696.0 5713.1 5752.0 5756.7 5757.7 5642.0 5724.7 5780.3 5839.4 5851.4 5748.3 5760.0 5770.2 5779.6 5825.3 5773.9 5775.6 5805.1 5816.4 5819.4 4338.8 4399.4 4421.8 4444.5 4459.6 3981.0 3981.6 3992.3 4029.6 4031.8 5534.3 5535.5 5535.5 5536.3 5543.4 5701.1 5831.9 5897.6 5904.2 5922.5 5539.3 5545.5 5560.2 5562.7 5564.9 4927.6 5074.5 5078.0 5087.8 5118.7 5971.7 6011.2 6026.8 6038.9 6043.7 5837.2 5844.2 5849.5 5850.1 5858.6 5856.0 5883.8 6038.1 6044.2 6052.1 5591.3 5636.6 5668.1 5677.4 5723.0 5735.9 5768.4 5769.1 5774.9 5802.3 5572.5 5609.0 5648.9 5652.6 5681.0 5736.3 5741.2 5743.7 5747.3 5785.9 5679.8 5682.0 5687.2 5689.9 5700.9 5582.4 5612.0 5675.2 5726.6 5743.3 5518.1 5521.5 5531.8 5532.1 5580.0 07:29:29 INFO - PROCESS | 32173 | 07:29:29 INFO - PROCESS | 32173 | [#1] ext.html Cycles:180 Average:55590.19 Median:20283.97 stddev:102075.94 (503.2%) stddev-sans-first:102278.76 07:29:29 INFO - PROCESS | 32173 | Values: 590.9 619.6 622.5 622.8 634.5 30560.5 42116.6 43162.0 43260.0 43365.9 44742.8 45094.0 45141.8 45188.1 45195.3 8038.4 8930.5 9076.7 9079.5 9086.2 10496.3 10759.5 10763.7 11119.1 11126.4 10910.6 11008.7 11014.8 11022.2 11060.3 8084.7 10884.9 10887.7 10953.7 11153.7 10612.6 11000.7 11008.8 11012.4 11016.4 42820.8 43122.0 43249.1 43272.8 43301.6 3012.7 3636.1 3708.7 3814.7 3868.7 32416.8 32596.3 32823.5 33151.0 33482.2 4453.1 4462.5 4468.4 4483.3 4483.6 329601.0 334731.0 334958.0 335510.3 336087.0 62389.7 62512.4 62879.7 63056.0 63060.0 34387.8 35210.3 35264.5 36931.8 67238.7 16868.0 17125.7 17130.5 17133.4 17142.7 11003.9 12709.2 12744.9 13107.1 13149.1 20344.0 20543.2 20561.5 20631.0 20634.6 7631.4 7776.2 7857.3 7896.6 7917.8 1033.8 1084.4 1109.9 1122.2 1159.1 31825.4 31961.7 32223.7 32355.7 32525.3 1110.8 1145.7 1167.8 1170.2 1175.5 16830.8 17026.7 17140.7 17311.0 17414.2 415258.0 420187.0 420672.0 420948.0 421214.0 56569.2 56607.7 57053.1 57197.4 57217.7 1233.7 1286.5 1347.6 1368.9 1393.3 30104.4 34114.5 34210.0 34512.3 34622.7 51222.0 51231.7 51865.2 51881.0 51916.5 403953.0 404249.0 404955.0 405308.0 405491.0 24358.3 25011.5 25193.2 25232.5 28556.1 46611.3 46928.0 47570.5 48404.3 48535.0 40719.4 41400.4 41533.8 41841.8 42752.6 39528.4 41234.0 41590.2 41884.6 42482.6 40223.4 41077.4 41755.0 41869.0 42095.8 35754.6 36954.3 36966.3 37457.2 37521.8 27940.6 28059.8 28192.9 28259.8 28273.7 07:29:29 INFO - PROCESS | 32173 | 07:29:29 INFO - PROCESS | 32173 | [#2] jquery.html Cycles:180 Average:28211.93 Median:12031.57 stddev:73722.92 (612.7%) stddev-sans-first:73900.16 07:29:29 INFO - PROCESS | 32173 | Values: 397.7 403.5 406.6 407.8 419.2 18525.4 20136.4 20144.4 20179.1 21552.6 20059.1 20562.5 20599.2 20613.2 20625.5 5458.5 5871.7 5874.1 5913.6 5918.9 5716.9 5830.2 5869.9 5902.4 5904.4 5875.7 5921.1 5921.3 5928.1 5929.2 5790.8 5861.8 5864.4 5864.6 6145.4 6005.1 6022.6 6033.9 6044.2 6050.4 14556.3 14667.2 14933.6 14936.6 15008.7 2510.6 2513.4 2875.7 2882.5 3060.7 10580.8 10825.0 11045.1 11085.2 12107.6 1933.0 1943.1 2004.5 2046.5 2049.1 84235.6 87610.6 89077.0 89769.0 90462.5 10832.9 11070.7 11142.0 11350.1 11380.8 15622.3 15664.8 15730.8 15733.8 15758.6 7962.4 8075.8 8172.5 8181.2 8296.4 7855.5 7856.4 7861.1 7991.0 8012.1 4616.7 4745.0 4769.9 4884.6 4897.8 1810.6 1922.0 1930.4 1941.3 2034.5 871.4 971.5 979.4 1006.7 1035.2 20117.8 20708.4 20778.5 20780.9 20911.5 1011.8 1030.5 1030.9 1042.6 1053.7 11143.9 11639.3 11726.4 11743.6 11746.1 439180.0 443202.0 443953.0 446158.0 446788.0 95057.5 96869.0 97190.0 97719.0 97821.5 1003.7 1005.3 1014.2 1015.1 1017.9 17937.2 17959.0 18103.1 18104.8 18218.3 42599.6 43241.6 43405.6 44153.6 44266.6 55565.4 56528.2 59023.7 59973.0 60128.4 7934.4 8229.4 8279.4 8475.0 9285.0 10659.4 14515.8 14555.2 14665.9 14728.8 12236.1 12466.3 12496.9 12509.6 12515.5 12038.0 12564.3 12592.4 12786.4 13110.6 12660.6 12715.3 12977.8 13121.9 13318.6 8298.1 8359.0 8376.5 8406.6 8564.1 9302.9 12302.9 12506.6 12638.1 13046.7 07:29:29 INFO - PROCESS | 32173 | 07:29:29 INFO - PROCESS | 32173 | [#3] mootools.html Cycles:180 Average:6136.08 Median:460.42 stddev:3543.78 (769.7%) stddev-sans-first:3535.61 07:29:29 INFO - PROCESS | 32173 | Values: 1368.8 1468.9 1607.2 1764.8 1794.1 8968.2 9530.8 9597.2 9623.2 9644.8 8023.6 8280.6 8287.1 8548.4 9415.9 2304.1 2383.8 2393.4 2401.4 2414.5 2356.9 2388.5 2388.8 2413.1 2428.8 2019.2 2327.2 2373.1 2380.4 2383.1 2386.9 2426.0 2427.8 2429.4 2430.2 2345.6 2355.2 2387.1 2389.1 2394.0 9533.8 9588.3 9591.9 9597.4 9599.9 5510.4 5545.2 5577.4 5586.8 5654.9 3372.9 3417.7 3490.9 3491.7 3501.2 1097.1 1112.3 1127.8 1138.1 1141.9 12997.4 13129.6 13151.1 13155.8 13163.0 4778.3 4832.5 4911.1 4920.1 5061.7 11112.7 11172.1 11207.0 11231.9 11240.8 5698.3 5703.2 5704.4 5705.7 5708.1 5125.7 5175.6 5189.4 5226.9 5228.2 4141.2 4151.2 4195.0 4214.1 4233.3 1307.5 1340.4 1345.3 1354.3 1365.1 933.9 1013.7 1027.9 1027.9 1035.3 6209.3 6285.2 6317.7 6347.0 6397.1 452.5 458.5 459.1 461.8 481.9 4282.2 4365.7 4437.4 4465.5 4470.3 11060.7 11482.8 11528.0 11571.1 11590.2 11453.4 11459.2 11459.4 11477.4 11489.7 8266.8 8585.4 8619.0 8727.8 8729.7 6309.2 6524.0 6541.8 6545.4 6558.5 10885.2 10989.9 10995.7 11139.7 11158.9 9926.0 10265.5 10930.1 11096.6 11386.3 7945.2 8169.2 8220.8 8233.0 8234.6 9066.1 9170.4 9170.7 9175.3 9193.3 8074.0 8093.7 8197.7 8215.3 8233.0 8076.5 8145.0 8197.8 8280.7 8409.2 7065.2 7078.2 7142.8 7145.5 7145.6 5543.5 5615.2 5635.2 5668.5 5775.3 5323.1 5592.0 5724.9 5821.8 5927.0 07:29:29 INFO - PROCESS | 32173 | 07:29:29 INFO - PROCESS | 32173 | [#4] prototype.html Cycles:180 Average:4737.10 Median:5399.24 stddev:1406.10 (26.0%) stddev-sans-first:1370.31 07:29:29 INFO - PROCESS | 32173 | Values: 315.0 326.7 331.9 331.9 333.6 5263.2 5344.4 5430.5 5434.8 5475.1 5401.2 5410.2 5412.7 5424.1 5434.3 4254.6 4269.5 4282.9 4287.5 4311.6 3999.8 4110.5 4225.2 4277.2 4282.9 4153.0 4177.3 4186.5 4187.2 4216.3 4150.5 4167.1 4175.5 4176.8 4189.8 3617.7 3719.2 3727.0 3729.6 3762.3 5253.5 5268.2 5283.5 5291.4 5297.3 4782.4 4795.6 4803.4 4805.0 4818.8 5363.7 5589.7 5592.6 5603.2 5645.7 4037.7 4081.6 4082.5 4098.2 4117.9 5840.9 5846.8 5853.6 5882.4 5921.6 3957.6 4159.4 4180.7 4182.2 4183.7 4209.4 4212.9 4216.7 4233.6 4257.6 4828.0 4830.5 4837.7 4839.9 4841.4 5486.3 5677.2 5688.5 5698.2 5720.8 1345.3 1386.7 1435.2 1437.3 1438.4 955.8 966.6 975.9 986.4 997.3 5358.2 5369.5 5386.3 5397.2 5414.9 5674.3 5685.7 5718.9 5739.3 5740.9 5160.0 5379.6 5395.9 5415.8 5419.6 2688.2 2697.3 2712.6 2738.8 2742.8 5267.3 5275.4 5287.4 5294.4 5298.2 5225.0 5566.5 6062.5 6062.6 6071.4 6041.8 6095.7 6097.0 6124.8 6131.2 5590.4 5865.9 5866.4 5875.1 5883.9 5767.7 5801.2 5815.2 5832.2 5837.4 6013.5 6014.6 6017.0 6028.3 6093.1 3933.7 4114.3 4124.0 4129.1 4154.1 5621.7 5777.7 5810.0 5839.9 5852.6 5528.2 5613.8 5618.9 5643.5 5651.8 5680.6 5688.8 5691.7 5696.4 5701.9 5523.3 5579.7 5652.6 5666.0 5676.1 5681.9 5683.5 5687.3 5704.6 5746.4 5442.4 5526.5 5573.1 5595.4 5596.0 07:29:29 INFO - PROCESS | 32173 | 07:29:29 INFO - PROCESS | 32173 | [#5] yui.html Cycles:180 Average:20919.73 Median:4704.64 stddev:28980.96 (616.0%) stddev-sans-first:29022.71 07:29:29 INFO - PROCESS | 32173 | Values: 757.3 791.8 836.9 852.1 886.6 15041.5 15503.2 15517.9 15531.5 18325.1 17499.4 17581.9 17609.6 17619.5 17622.1 681.1 802.4 809.8 836.2 839.0 818.5 838.2 838.6 839.1 840.4 867.2 873.1 874.2 874.4 875.4 694.1 837.1 866.5 870.3 870.5 632.4 632.7 634.1 634.6 634.7 15919.6 15994.6 15996.9 16005.7 16030.0 13933.4 14398.9 14466.7 14478.1 14485.1 13816.9 13848.2 13952.2 14059.7 14065.9 4564.9 4618.2 4675.7 4722.2 4783.4 61827.4 62384.4 82512.0 83111.0 83859.2 11430.6 11444.5 12103.2 12213.9 12308.9 21491.2 22960.2 22964.0 22967.4 22997.5 8775.8 8812.1 8898.6 8980.0 9205.2 4833.3 4912.7 4965.3 5068.6 5096.3 3510.5 3601.5 3601.7 3607.6 3612.7 597.1 608.4 611.8 614.0 630.0 699.0 719.4 738.9 744.8 747.7 9285.4 9449.2 9476.0 9647.8 10032.6 635.9 649.5 667.4 724.7 732.2 4566.0 4581.4 4613.2 4624.0 4687.1 72006.0 97419.0 107502.0 113683.0 113952.0 59546.4 73437.3 98117.0 98378.0 105913.5 96011.0 96960.0 97175.1 98303.5 99650.0 8918.2 9102.1 9269.4 9775.1 10446.4 42247.6 46791.5 52194.0 52372.2 53565.0 76320.6 77693.0 78727.6 78942.0 80368.0 13188.0 13280.4 13845.5 13929.3 14308.4 15790.6 15948.4 16169.7 16185.5 16829.7 10055.2 13747.7 14561.9 15101.7 15403.8 15184.2 15264.4 15939.8 16186.8 16423.8 14414.4 14720.3 15203.0 15295.6 15321.8 12101.9 12433.4 12656.0 12820.7 12911.4 12188.4 12752.7 12786.7 12945.3 13119.3 07:29:29 INFO - PROCESS | 32173 | -------- Summary: end -------- 07:29:29 INFO - PROCESS | 32173 | 07:29:30 INFO - TEST-INFO | 32173: exit 0 07:29:30 INFO - TEST-OK | dromaeo_css | took 1114359ms 07:29:30 INFO - TEST-START | kraken 07:29:30 INFO - operating with platform_type : linux_ 07:29:30 INFO - Initialising browser for kraken test... 07:29:30 INFO - TEST-INFO | started process 32370 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE4qFIv/profile http://localhost:40200/getInfo.html) 07:29:34 INFO - PROCESS | 32370 | __metrics Screen width/height:1600/1200 07:29:34 INFO - PROCESS | 32370 | colorDepth:24 07:29:34 INFO - PROCESS | 32370 | Browser inner width/height: 1024/697 07:29:34 INFO - PROCESS | 32370 | __metrics 07:29:35 INFO - PROCESS | 32370 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:29:36 INFO - TEST-INFO | 32370: exit 0 07:29:36 INFO - Browser initialized. 07:29:36 INFO - Running cycle 1/1 for kraken test... 07:29:36 INFO - TEST-INFO | started process 32451 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE4qFIv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:29:47 INFO - PROCESS | 32451 | RSS: Main: 157081600 07:29:47 INFO - PROCESS | 32451 | 07:29:50 INFO - PROCESS | 32451 | Cycle 1(1): loaded http://localhost:40200/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40200/tests/kraken/driver.html?testName=audio-beat-detection) 07:29:51 INFO - PROCESS | 32451 | RSS: Main: 214851584 07:29:51 INFO - PROCESS | 32451 | 07:29:53 INFO - PROCESS | 32451 | Cycle 1(1): loaded http://localhost:40200/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40200/tests/kraken/driver.html?testName=audio-dft) 07:29:54 INFO - PROCESS | 32451 | RSS: Main: 204636160 07:29:54 INFO - PROCESS | 32451 | 07:29:57 INFO - PROCESS | 32451 | Cycle 1(1): loaded http://localhost:40200/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40200/tests/kraken/driver.html?testName=audio-fft) 07:29:58 INFO - PROCESS | 32451 | RSS: Main: 269262848 07:29:58 INFO - PROCESS | 32451 | 07:30:00 INFO - PROCESS | 32451 | Cycle 1(1): loaded http://localhost:40200/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40200/tests/kraken/driver.html?testName=audio-oscillator) 07:30:00 INFO - PROCESS | 32451 | RSS: Main: 180719616 07:30:00 INFO - PROCESS | 32451 | 07:30:03 INFO - PROCESS | 32451 | Cycle 1(1): loaded http://localhost:40200/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40200/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:30:03 INFO - PROCESS | 32451 | RSS: Main: 185081856 07:30:03 INFO - PROCESS | 32451 | 07:30:06 INFO - PROCESS | 32451 | Cycle 1(1): loaded http://localhost:40200/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40200/tests/kraken/driver.html?testName=imaging-darkroom) 07:30:07 INFO - PROCESS | 32451 | RSS: Main: 219013120 07:30:07 INFO - PROCESS | 32451 | 07:30:10 INFO - PROCESS | 32451 | Cycle 1(1): loaded http://localhost:40200/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40200/tests/kraken/driver.html?testName=imaging-desaturate) 07:30:11 INFO - PROCESS | 32451 | RSS: Main: 220704768 07:30:11 INFO - PROCESS | 32451 | 07:30:13 INFO - PROCESS | 32451 | Cycle 1(1): loaded http://localhost:40200/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40200/tests/kraken/driver.html?testName=json-parse-financial) 07:30:14 INFO - PROCESS | 32451 | RSS: Main: 221011968 07:30:14 INFO - PROCESS | 32451 | 07:30:16 INFO - PROCESS | 32451 | Cycle 1(1): loaded http://localhost:40200/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40200/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:30:16 INFO - PROCESS | 32451 | RSS: Main: 209793024 07:30:16 INFO - PROCESS | 32451 | 07:30:18 INFO - PROCESS | 32451 | Cycle 1(1): loaded http://localhost:40200/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40200/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:30:19 INFO - PROCESS | 32451 | RSS: Main: 212766720 07:30:19 INFO - PROCESS | 32451 | 07:30:21 INFO - PROCESS | 32451 | Cycle 1(1): loaded http://localhost:40200/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40200/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:30:21 INFO - PROCESS | 32451 | RSS: Main: 213831680 07:30:21 INFO - PROCESS | 32451 | 07:30:24 INFO - PROCESS | 32451 | Cycle 1(1): loaded http://localhost:40200/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40200/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:30:24 INFO - PROCESS | 32451 | RSS: Main: 223854592 07:30:24 INFO - PROCESS | 32451 | 07:30:27 INFO - PROCESS | 32451 | Cycle 1(1): loaded http://localhost:40200/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40200/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:30:28 INFO - PROCESS | 32451 | RSS: Main: 224534528 07:30:28 INFO - PROCESS | 32451 | 07:30:29 INFO - PROCESS | 32451 | Cycle 1(1): loaded http://localhost:40200/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40200/tests/kraken/driver.html?testName=ai-astar) 07:30:30 INFO - PROCESS | 32451 | RSS: Main: 266366976 07:30:30 INFO - PROCESS | 32451 | 07:30:30 INFO - PROCESS | 32451 | __start_tp_report 07:30:30 INFO - PROCESS | 32451 | _x_x_mozilla_page_load 07:30:30 INFO - PROCESS | 32451 | _x_x_mozilla_page_load_details 07:30:30 INFO - PROCESS | 32451 | |i|pagename|runs| 07:30:30 INFO - PROCESS | 32451 | |0;ai-astar;101;110;109;107;111;110;109;109;109;108 07:30:30 INFO - PROCESS | 32451 | |1;audio-beat-detection;142;116;122;167;118;120;147;118;160;116 07:30:30 INFO - PROCESS | 32451 | |2;audio-dft;159;161;161;159;159;159;159;160;161;159 07:30:30 INFO - PROCESS | 32451 | |3;audio-fft;74;75;75;124;75;76;74;75;103;75 07:30:30 INFO - PROCESS | 32451 | |4;audio-oscillator;83;84;115;84;84;83;116;85;84;130 07:30:30 INFO - PROCESS | 32451 | |5;imaging-gaussian-blur;117;117;116;116;117;116;117;116;117;116 07:30:30 INFO - PROCESS | 32451 | |6;imaging-darkroom;146;146;146;145;145;146;146;152;145;145 07:30:30 INFO - PROCESS | 32451 | |7;imaging-desaturate;95;95;96;95;95;96;96;95;95;95 07:30:30 INFO - PROCESS | 32451 | |8;json-parse-financial;53;52;53;51;52;52;52;51;51;52 07:30:30 INFO - PROCESS | 32451 | |9;json-stringify-tinderbox;62;63;62;62;62;62;62;63;62;63 07:30:30 INFO - PROCESS | 32451 | |10;stanford-crypto-aes;76;76;84;85;75;77;76;75;75;79 07:30:30 INFO - PROCESS | 32451 | |11;stanford-crypto-ccm;124;122;126;118;118;117;119;118;163;122 07:30:30 INFO - PROCESS | 32451 | |12;stanford-crypto-pbkdf2;156;158;159;159;160;157;161;163;158;163 07:30:30 INFO - PROCESS | 32451 | |13;stanford-crypto-sha256-iterative;65;66;62;63;63;61;67;63;62;62 07:30:30 INFO - PROCESS | 32451 | __end_tp_report 07:30:30 INFO - PROCESS | 32451 | __start_cc_report 07:30:30 INFO - PROCESS | 32451 | _x_x_mozilla_cycle_collect,1647 07:30:30 INFO - PROCESS | 32451 | __end_cc_report 07:30:30 INFO - PROCESS | 32451 | __startTimestamp1467815430017__endTimestamp 07:30:30 INFO - PROCESS | 32451 | 07:30:30 INFO - PROCESS | 32451 | ------- Summary: start ------- 07:30:30 INFO - PROCESS | 32451 | Number of tests: 14 07:30:30 INFO - PROCESS | 32451 | 07:30:30 INFO - PROCESS | 32451 | [#0] ai-astar Cycles:10 Average:108.30 Median:109.00 stddev:2.79 (2.6%) stddev-sans-first:1.17 07:30:30 INFO - PROCESS | 32451 | Values: 101.0 110.0 109.0 107.0 111.0 110.0 109.0 109.0 109.0 108.0 07:30:30 INFO - PROCESS | 32451 | 07:30:30 INFO - PROCESS | 32451 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:132.00 stddev:19.66 (14.9%) stddev-sans-first:20.56 07:30:30 INFO - PROCESS | 32451 | Values: 142.0 116.0 122.0 167.0 118.0 120.0 147.0 118.0 160.0 116.0 07:30:30 INFO - PROCESS | 32451 | 07:30:30 INFO - PROCESS | 32451 | [#2] audio-dft Cycles:10 Average:159.70 Median:159.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 07:30:30 INFO - PROCESS | 32451 | Values: 159.0 161.0 161.0 159.0 159.0 159.0 159.0 160.0 161.0 159.0 07:30:30 INFO - PROCESS | 32451 | 07:30:30 INFO - PROCESS | 32451 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:17.03 (22.7%) stddev-sans-first:17.78 07:30:30 INFO - PROCESS | 32451 | Values: 74.0 75.0 75.0 124.0 75.0 76.0 74.0 75.0 103.0 75.0 07:30:30 INFO - PROCESS | 32451 | 07:30:30 INFO - PROCESS | 32451 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:84.00 stddev:18.07 (21.5%) stddev-sans-first:18.65 07:30:30 INFO - PROCESS | 32451 | Values: 83.0 84.0 115.0 84.0 84.0 83.0 116.0 85.0 84.0 130.0 07:30:30 INFO - PROCESS | 32451 | 07:30:30 INFO - PROCESS | 32451 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:30:30 INFO - PROCESS | 32451 | Values: 117.0 117.0 116.0 116.0 117.0 116.0 117.0 116.0 117.0 116.0 07:30:30 INFO - PROCESS | 32451 | 07:30:30 INFO - PROCESS | 32451 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:2.10 (1.4%) stddev-sans-first:2.22 07:30:30 INFO - PROCESS | 32451 | Values: 146.0 146.0 146.0 145.0 145.0 146.0 146.0 152.0 145.0 145.0 07:30:30 INFO - PROCESS | 32451 | 07:30:30 INFO - PROCESS | 32451 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:30:30 INFO - PROCESS | 32451 | Values: 95.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 07:30:30 INFO - PROCESS | 32451 | 07:30:30 INFO - PROCESS | 32451 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.74 (1.4%) stddev-sans-first:0.67 07:30:30 INFO - PROCESS | 32451 | Values: 53.0 52.0 53.0 51.0 52.0 52.0 52.0 51.0 51.0 52.0 07:30:30 INFO - PROCESS | 32451 | 07:30:30 INFO - PROCESS | 32451 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 07:30:30 INFO - PROCESS | 32451 | Values: 62.0 63.0 62.0 62.0 62.0 62.0 62.0 63.0 62.0 63.0 07:30:30 INFO - PROCESS | 32451 | 07:30:30 INFO - PROCESS | 32451 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:76.50 stddev:3.74 (4.9%) stddev-sans-first:3.91 07:30:30 INFO - PROCESS | 32451 | Values: 76.0 76.0 84.0 85.0 75.0 77.0 76.0 75.0 75.0 79.0 07:30:30 INFO - PROCESS | 32451 | 07:30:30 INFO - PROCESS | 32451 | [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:122.00 stddev:13.78 (11.3%) stddev-sans-first:14.62 07:30:30 INFO - PROCESS | 32451 | Values: 124.0 122.0 126.0 118.0 118.0 117.0 119.0 118.0 163.0 122.0 07:30:30 INFO - PROCESS | 32451 | 07:30:30 INFO - PROCESS | 32451 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.40 Median:159.50 stddev:2.37 (1.5%) stddev-sans-first:2.17 07:30:30 INFO - PROCESS | 32451 | Values: 156.0 158.0 159.0 159.0 160.0 157.0 161.0 163.0 158.0 163.0 07:30:30 INFO - PROCESS | 32451 | 07:30:30 INFO - PROCESS | 32451 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.00 stddev:1.96 (3.1%) stddev-sans-first:1.99 07:30:30 INFO - PROCESS | 32451 | Values: 65.0 66.0 62.0 63.0 63.0 61.0 67.0 63.0 62.0 62.0 07:30:30 INFO - PROCESS | 32451 | -------- Summary: end -------- 07:30:30 INFO - PROCESS | 32451 | 07:30:30 INFO - TEST-INFO | 32451: exit 0 07:30:31 INFO - TEST-OK | kraken | took 60884ms 07:30:31 INFO - SUITE-END | took 1175s 07:30:31 INFO - Completed test suite (00:19:35) 07:30:31 INFO - javascript benchmark 07:30:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3077.984610076949, 3120.126364617905, 3158.936821263575, 3161.9209519762003, 3180.586523751912, 5374.247605335257, 5393.029254734146, 5424.159255315422, 5463.125899856024, 5464.672119672818, 5471.206675032118, 5499.340079190492, 5507.008738427082, 5565.0, 5605.635633683808, 4801.639877009229, 4837.903241935159, 4843.612510999129, 4935.432425271086, 5063.949360506403, 5014.69911805291, 5100.387953445592, 5112.130937740593, 5114.948850511484, 5159.071367153911, 4871.732054736988, 4877.561019508261, 5006.199008158677, 5038.370203724535, 5115.10485665009, 4862.3192753014255, 4899.2896030075435, 4923.556879880828, 4923.950760492385, 4941.332920055783, 4905.730184839832, 4945.035718034985, 4983.053219888209, 5001.374828146481, 5037.395512538482, 5360.16917377807, 5408.621396502246, 5493.2034854945805, 5539.501444869981, 5562.221289019541, 5766.942330576724, 5798.82603521895, 5802.535797136219, 5874.530037596982, 5899.793507227227, 5838.182654428383, 5902.61632993854, 5934.406559344031, 5937.139114828326, 5945.672987985659, 5353.491418315254, 5520.834374968757, 5524.226608274845, 5528.308961379827, 5531.612787104864, 5832.1834943108, 5890.057590785454, 5893.351731309553, 5922.437368449991, 5931.673757943355, 5696.031674615242, 5713.085906255063, 5751.964646363611, 5756.654600723886, 5757.740901659352, 5642.0, 5724.656520608777, 5780.335261444903, 5839.386864379264, 5851.444112809277, 5748.338941021752, 5760.0, 5770.19217309577, 5779.566532510079, 5825.271841019872, 5773.913391299134, 5775.5668324875805, 5805.10020946754, 5816.360200377955, 5819.447152520504, 4338.82644694215, 4399.428074350314, 4421.778911054499, 4444.533324000998, 4459.598636122764, 3981.0, 3981.5620281768984, 3992.261431635157, 4029.6373326400767, 4031.7580945143386, 5534.308211473566, 5535.474129957647, 5535.474129957728, 5536.252605898152, 5543.362513311021, 5701.116326969326, 5831.941680583224, 5897.5871688982215, 5904.1734157218025, 5922.526197904157, 5539.2522009529, 5545.500904918576, 5560.165975103767, 5562.666240025612, 5564.944350556523, 4927.630427717935, 5074.492550744896, 5077.974610126926, 5087.771050302746, 5118.744062796845, 5971.731272092767, 6011.248593925759, 6026.849328766816, 6038.939610603926, 6043.728032238648, 5837.182794408871, 5844.211031510862, 5849.473547380756, 5850.12248162762, 5858.648481091148, 5856.0, 5883.764649413975, 6038.094285856981, 6044.184035155197, 6052.0921861719335, 5591.273134492652, 5636.605437619327, 5668.121441176624, 5677.432256774455, 5723.0, 5735.8566035849435, 5768.423157684366, 5769.07694768835, 5774.913376299275, 5802.303723553032, 5572.526335261386, 5609.018421776092, 5648.85877853057, 5652.576056795675, 5680.971595142163, 5736.282964629421, 5741.224934633771, 5743.655380677173, 5747.281589801275, 5785.884282314246, 5679.829605111688, 5681.971590142023, 5687.203791469115, 5689.886202276014, 5700.942990570207, 5582.358028826737, 5612.0, 5675.205471233948, 5726.599138060295, 5743.3395159557185, 5518.117101263779, 5521.47545983147, 5531.806386776443, 5532.114861622121, 5579.972100139474], "value": 5370.995662125832, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.9409059094091, 619.5879739972918, 622.4677900395162, 622.7540121651945, 634.4828964394019, 30560.541591876114, 42116.57883421165, 43162.03636581794, 43260.0, 43365.91585210367, 44742.776286118526, 45094.0, 45141.774291128495, 45188.096238075304, 45195.32207016889, 8038.356931445471, 8930.464172149692, 9076.727698169065, 9079.500627465486, 9086.227670648002, 10496.265261431665, 10759.515821788038, 10763.654543182101, 11119.110471162328, 11126.443677816076, 10910.563577456933, 11008.669739907815, 11014.834777478345, 11022.228444008922, 11060.336379817236, 8084.717034903809, 10884.891151088466, 10887.727806804854, 10953.726156846104, 11153.665390038312, 10612.575496980111, 11000.669979900616, 11008.779824403468, 11012.39431831249, 11016.394098324588, 42820.78589607032, 43122.0, 43249.13501729979, 43272.783636081615, 43301.56698433007, 3012.7288544031144, 3636.1273294409416, 3708.740388172829, 3814.6948244140403, 3868.709846761476, 32416.83791581027, 32596.348073038407, 32823.50764738531, 33151.0, 33482.162945926306, 4453.131639330332, 4462.531434199394, 4468.374427580141, 4483.327500874862, 4483.596476317147, 329601.0, 334731.0, 334958.0, 335510.3224483886, 336087.0, 62389.68805156036, 62512.37487625157, 62879.6856015717, 63056.0, 63060.0, 34387.82806086003, 35210.29579408398, 35264.471032934525, 36931.81534092366, 67238.66380668065, 16868.0, 17125.657486850192, 17130.48608541746, 17133.400330988356, 17142.657146856993, 11003.944980275208, 12709.17390369623, 12744.872551274553, 13107.14803537767, 13149.079564430589, 20344.0, 20543.178272868918, 20561.48596285105, 20631.0, 20634.58730825375, 7631.3894888408795, 7776.183500732342, 7857.2928436441, 7896.565688887052, 7917.7624671259955, 1033.7932413517326, 1084.4415126210008, 1109.9334039957466, 1122.169594500064, 1159.084323384517, 31825.363492730015, 31961.680383196337, 32223.67776322207, 32355.676443235265, 32525.349493010006, 1110.7722916802036, 1145.6963904565298, 1167.8365028895962, 1170.1633332167542, 1175.488662431845, 16830.83169168317, 17026.659466810594, 17140.65718685619, 17311.0, 17414.216360263566, 415258.0, 420187.0, 420672.0, 420948.0, 421214.0, 56569.15146272809, 56607.716961415754, 57053.14420283699, 57197.42802571921, 57217.713911430175, 1233.6730766346925, 1286.4789760147155, 1347.5957212836306, 1368.8631136886431, 1393.324237744693, 30104.397912041197, 34114.48828267528, 34210.0, 34512.30975380428, 34622.65377346295, 51222.0, 51231.74384128056, 51865.22202166895, 51881.0, 51916.48083519116, 403953.0, 404249.0, 404955.0, 405308.0, 405491.0, 24358.26925192247, 25011.499770004863, 25193.244202673948, 25232.49535009253, 28556.143315700563, 46611.30083048689, 46928.0, 47570.524294758, 48404.273935891695, 48535.0, 40719.38920916248, 41400.37899431451, 41533.79233103815, 41841.79079104707, 42752.57247427486, 39528.40707389334, 41234.0, 41590.1681966365, 41884.58115418928, 42482.57517424786, 40223.396649049704, 41077.38383924303, 41755.0, 41869.0, 42095.7895210522, 35754.64245357513, 36954.26091478209, 36966.260674785815, 37457.19071069626, 37521.81239093896, 27940.580891287053, 28059.796627724965, 28192.85903570469, 28259.82694190826, 28273.717262827107], "value": 20367.17741022487, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.658014107867, 403.5278723893045, 406.5629448343031, 407.8001779128228, 419.230711644133, 18525.444236672905, 20136.395908122762, 20144.395668129942, 20179.09194086268, 21552.568948621018, 20059.09734061967, 20562.48593785156, 20599.176032958665, 20613.1754729811, 20625.484362890937, 5458.5087342139195, 5871.735771890275, 5874.089516125007, 5913.586048976574, 5918.881622367571, 5716.8856622867515, 5830.183774271605, 5869.911951320733, 5902.3507414184405, 5904.35052144266, 5875.7062146892695, 5921.082232253986, 5921.319048309435, 5928.081147422135, 5929.1995580596495, 5790.7973220937065, 5861.824145275648, 5864.354920958691, 5864.560157988147, 6145.385461453819, 6005.069214271794, 6022.638641681469, 6033.879322413571, 6044.184035155242, 6050.42520960508, 14556.344964476624, 14667.193304368255, 14933.626659333495, 14936.62658433537, 15008.699826003529, 2510.57320255557, 2513.384220865881, 2875.7411832934927, 2882.524383476724, 3060.739837113848, 10580.78838423235, 10825.0, 11045.061169800576, 11085.168612354026, 12107.636770896886, 1932.951676208092, 1943.0867492278605, 2004.4988752811796, 2046.549759053006, 2049.11887888208, 84235.57882210611, 87610.5619471905, 89077.0, 89769.0, 90462.54768726115, 10832.945835270773, 11070.723231919266, 11142.0, 11350.14873884462, 11380.772384552429, 15622.29699663518, 15664.843351566338, 15730.764038539432, 15733.842661573466, 15758.606034849221, 7962.442629016029, 8075.798105047421, 8172.468789528781, 8181.181881811771, 8296.419250652396, 7855.450118491765, 7856.410769192219, 7861.095973962953, 7991.0, 8012.1186669466315, 4616.676832621684, 4745.027269409763, 4769.928451073237, 4884.5603895649565, 4897.804087836518, 1810.6016676331449, 1921.9519512012032, 1930.44982180078, 1941.26232031827, 2034.532057626754, 871.4422769427572, 971.5385192033868, 979.4172467381896, 1006.6527048168371, 1035.1563475767225, 20117.79882201159, 20708.378748637566, 20778.48053798637, 20780.896095519427, 20911.477213069797, 1011.812814629296, 1030.4538594544754, 1030.8917563655857, 1042.6090216168936, 1053.694428615693, 11143.944280278709, 11639.301641901513, 11726.413679316, 11743.647690569296, 11746.119041071783, 439180.0, 443202.0, 443953.0, 446158.0, 446788.0, 95057.52471237599, 96869.0, 97190.0, 97719.0, 97821.5108924465, 1003.7440452684518, 1005.3163848582888, 1014.1531820929459, 1015.062699413822, 1017.8982101789762, 17937.192826322585, 17959.0, 18103.09484525742, 18104.81895181084, 18218.34897147219, 42599.5740042608, 43241.567584323755, 43405.56594434015, 44153.55846441494, 44266.55733442753, 55565.444345556025, 56528.15207771969, 59023.704881475314, 59973.0, 60128.39871601228, 7934.444588878723, 8229.382796290183, 8279.37904657141, 8474.957625211835, 9285.025072367303, 10659.4137322448, 14515.78226326627, 14555.19946402958, 14665.853341466449, 14728.77906831377, 12236.082293828176, 12466.314352710326, 12496.937515312366, 12509.56216532417, 12515.483278059855, 12038.0, 12564.308963007123, 12592.433340499883, 12786.36068196605, 13110.606681799562, 12660.556880509506, 12715.287265764699, 12977.805332920203, 13121.934390327988, 13318.600441986757, 8298.128696487023, 8359.0, 8376.49741015541, 8406.579671016303, 8564.143585641386, 9302.883653961297, 12302.938485307515, 12506.624801255977, 12638.052146089263, 13046.673833153867], "value": 9418.15925058906, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.8357397112345, 1468.9485867994615, 1607.1642745772199, 1764.8146944570829, 1794.1208807684238, 8968.192862642361, 9530.76173095673, 9597.184239339656, 9623.230141588674, 9644.758881027969, 8023.558704271263, 8280.585970701455, 8287.129851365595, 8548.40161188717, 9415.905840941588, 2304.112916527141, 2383.8212134089927, 2393.3896856301617, 2401.411654144737, 2414.541237164933, 2356.8939397727145, 2388.4984153327823, 2388.7969522590515, 2413.0830284491867, 2428.805695544352, 2019.1721394228368, 2327.243645815117, 2373.0626402570974, 2380.416797884512, 2383.0586918167314, 2386.868722220277, 2425.9514809703883, 2427.830051896368, 2429.441228517451, 2430.185887727596, 2345.6012477878803, 2355.234548771639, 2387.140629373424, 2389.092144984912, 2394.030417680842, 9533.809323813553, 9588.328816982814, 9591.856122158173, 9597.376170548892, 9599.90400095997, 5510.448955104497, 5545.223668686387, 5577.358603760538, 5586.776528938837, 5654.943450565483, 3372.865085396581, 3417.6582341765875, 3490.89527314181, 3491.703205227533, 3501.229729459515, 1097.0948967102092, 1112.3159257056932, 1127.785720713062, 1138.0667852361066, 1141.925774824642, 12997.415116319788, 13129.60611181666, 13151.079424440197, 13155.802662960063, 13163.0, 4778.307145463958, 4832.492588278251, 4911.140550403737, 4920.138975679241, 5061.6962982221185, 11112.666620001413, 11172.10623150146, 11207.047400970845, 11231.943840280746, 11240.775184496264, 5698.2592263005545, 5703.17303990919, 5704.372519022904, 5705.657660540381, 5708.115242137475, 5125.718085505258, 5175.560077393388, 5189.377274727057, 5226.869328266747, 5228.241904923765, 4141.233871733739, 4151.190517849051, 4195.0, 4214.093969796509, 4233.343831706091, 1307.457405176841, 1340.376724822962, 1345.327336331834, 1354.2754626274896, 1365.1058556645414, 933.8785957825439, 1013.7212266626589, 1027.912627426677, 1027.912627426677, 1035.3270374256792, 6209.348018458088, 6285.182926219562, 6317.652529110943, 6346.9682651586445, 6397.072424498421, 452.49320760747514, 458.5460394209708, 459.05663860766447, 461.789885602057, 481.9084373968935, 4282.164977829356, 4365.738055716667, 4437.378766972626, 4465.486469056035, 4470.329450582373, 11060.723481913017, 11482.77034459323, 11528.0, 11571.074314054855, 11590.188686791844, 11453.370064646524, 11459.197856150156, 11459.369734664673, 11477.368744718953, 11489.71275718097, 8266.751997440086, 8585.441946273471, 8618.956905215433, 8727.781805454915, 8729.738107856774, 6309.242890853127, 6523.967380163069, 6541.836454088686, 6545.410913017851, 6558.475321974135, 10885.23803333759, 10989.890101099207, 10995.670129896116, 11139.72150696239, 11158.88841111611, 9926.0, 10265.486725663837, 10930.070943969851, 11096.61161859331, 11386.259893106922, 7945.205479452008, 8169.223923727236, 8220.753377398687, 8233.0, 8234.588270586328, 9066.138716821892, 9170.358074934691, 9170.670252813437, 9175.311851611023, 9193.310501712265, 8073.990751156105, 8093.676252949816, 8197.672093116209, 8215.301699355621, 8233.012038555411, 8076.515409075474, 8145.0, 8197.754067377988, 8280.668773249003, 8409.159084091541, 7065.187503437171, 7078.221395646578, 7142.750003749844, 7145.4640901931525, 7145.571265724073, 5543.52880005204, 5615.213870058114, 5635.211070450058, 5668.489835914787, 5775.335836378702, 5323.121684922099, 5591.9720401397735, 5724.856878578069, 5821.79623713168, 5926.992411290004], "value": 4790.042906783171, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.95593597551897, 326.688012947635, 331.85895994202457, 331.9245644113074, 333.6130089096647, 5263.236830659562, 5344.412114667393, 5430.484104010117, 5434.836954891354, 5475.123980163175, 5401.243825864382, 5410.188471729242, 5412.729363531827, 5424.1321388577835, 5434.2935418395555, 4254.59581339773, 4269.466316710411, 4282.871513854574, 4287.528371879091, 4311.611954924057, 3999.800009999503, 4110.547839737626, 4225.232472730351, 4277.165952639237, 4282.892927676818, 4152.958470415288, 4177.3107437272965, 4186.476690413699, 4187.183499217654, 4216.283231850577, 4150.460440142792, 4167.124903770212, 4175.457190565207, 4176.832926682929, 4189.832406703728, 3617.656322649344, 3719.200371920023, 3726.9813650931574, 3729.5710993235584, 3762.3415902217275, 5253.50091741284, 5268.1834315681135, 5283.471652834686, 5291.3650361956425, 5297.311349524575, 4782.378290822171, 4795.6163506919365, 4803.366855269225, 4805.0, 4818.759062046884, 5363.731813409353, 5589.720513974285, 5592.6085174037835, 5603.187537807036, 5645.717714114319, 4037.6769858411258, 4081.551029386765, 4082.510098788164, 4098.172261139834, 4117.888170194061, 5840.875131804464, 5846.824595262149, 5853.5902486825935, 5882.441168088982, 5921.644701317935, 3957.584453632385, 4159.376093585986, 4180.686448516373, 4182.247195504839, 4183.686223533247, 4209.3896385024, 4212.85255016073, 4216.659753836589, 4233.576642335804, 4257.552956939477, 4827.975860120747, 4830.516948305141, 4837.685550439281, 4839.879003024953, 4841.370621819211, 5486.341639003345, 5677.233573467612, 5688.488036076773, 5698.230738850285, 5720.8283751487525, 1345.3138899161302, 1386.6533366658336, 1435.2464955898238, 1437.3460075665548, 1438.3958737330347, 955.8088382323563, 966.5501747378931, 975.9121679048919, 986.3785814936545, 997.2570435025953, 5358.240506139341, 5369.48989845964, 5386.272853164851, 5397.2443857859935, 5414.8917021659345, 5674.319081710221, 5685.744141513642, 5718.855429214044, 5739.311282646109, 5740.913886291709, 5159.998612370748, 5379.569634429236, 5395.865103372368, 5415.810446634349, 5419.647722897999, 2688.1720430107325, 2697.2852194168167, 2712.5524288492575, 2738.8082834201414, 2742.835429874214, 5267.26258323835, 5275.4460781618145, 5287.4448182941005, 5294.444083371268, 5298.198612471778, 5225.007248622749, 5566.54873978128, 6062.484688801413, 6062.575619706667, 6071.3928607139815, 6041.758329666852, 6095.66473843934, 6097.0, 6124.785632502841, 6131.233595800525, 5590.357108932362, 5865.882682346414, 5866.3547009828035, 5875.0612297940725, 5883.852903677443, 5767.711614419346, 5801.245838041028, 5815.156802263733, 5832.183494310715, 5837.416258374129, 6013.458788708862, 6014.609050411709, 6017.0, 6028.306744724413, 6093.146959425595, 3933.685305175636, 4114.333694853589, 4123.958760412357, 4129.132882094794, 4154.1068670236045, 5621.690807005654, 5777.6822274775295, 5810.0, 5839.912401313899, 5852.561057920588, 5528.198411230269, 5613.831585052455, 5618.887622247614, 5643.463870932255, 5651.802186923438, 5680.557360335096, 5688.829335119953, 5691.686957217393, 5696.401877802937, 5701.942980570141, 5523.254360661259, 5579.735854524986, 5652.604317697722, 5666.0, 5676.120201368794, 5681.857953551194, 5683.493874123444, 5687.260656114679, 5704.60067795267, 5746.367899530965, 5442.428545002717, 5526.530244929226, 5573.108302671553, 5595.356533998643, 5596.0], "value": 4285.328851520344, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.2654525110643, 791.8218400859804, 836.9414141010128, 852.0584753846995, 886.5567216391802, 15041.548753537398, 15503.224838758073, 15517.92241038796, 15531.45639902605, 18325.083745812724, 17499.38752143675, 17581.91209043956, 17609.647807043882, 17619.47141585751, 17622.11889405528, 681.1145510835918, 802.3861745764494, 809.8137428391474, 836.2390224895346, 838.9916100838974, 818.4639061414753, 838.2037064788445, 838.5723281126608, 839.0602525171786, 840.4243093480954, 867.1978419961542, 873.1268731268731, 874.1957399192726, 874.4403581707712, 875.3609864798701, 694.0734119949898, 837.0541288344132, 866.4844417571535, 870.3037569944051, 870.5473153959937, 632.4434497642092, 632.7026297640102, 634.1185751804994, 634.5938599296454, 634.7048622390611, 15919.602009949727, 15994.600134996603, 15996.920015399965, 16005.679886402324, 16030.0, 13933.442662293597, 14398.92800536001, 14466.71066578673, 14478.1313121212, 14485.130892146399, 13816.93091534546, 13848.169109853441, 13952.2326272055, 14059.71880562383, 14065.85934140666, 4564.863054108382, 4618.237990731525, 4675.696079754839, 4722.197226471508, 4783.449903261135, 61827.38172618261, 62384.37615623831, 82512.0, 83111.0, 83859.16140838574, 11430.599929002445, 11444.542218311175, 12103.232871257629, 12213.877861221452, 12308.938455307667, 21491.247806326704, 22960.196393126495, 22964.0, 22967.42581435444, 22997.54004919926, 8775.824483510421, 8812.118788121137, 8898.644054237759, 8979.955100224457, 9205.217556507772, 4833.250846118857, 4912.680675756064, 4965.329680493087, 5068.619853511002, 5096.261042148868, 3510.543629328222, 3601.5318008659233, 3601.675849173587, 3607.603163651996, 3612.710983121344, 597.0745344715673, 608.3581821178699, 611.7981066248127, 613.9693015349304, 630.0360448513782, 699.0283505926766, 719.4388377065897, 738.8706976279129, 744.7951813251291, 747.7121308296345, 9285.442873427615, 9449.244060475145, 9475.995608344063, 9647.758806029766, 10032.614685047418, 635.8569321902535, 649.473926119835, 667.3693359775064, 724.6847621284758, 732.2321624260304, 4566.041131362451, 4581.358609794632, 4613.215753321943, 4623.976880115578, 4687.086018226413, 72006.0, 97419.0, 107502.0, 113683.0, 113952.0, 59546.40453595408, 73437.26562734411, 98117.0, 98378.0, 105913.47043264889, 96011.0, 96960.0, 97175.14124293615, 98303.50848245712, 99650.0, 8918.19736223743, 9102.089791020844, 9269.397489163453, 9775.14769319675, 10446.42544660051, 42247.57752422436, 46791.532084678714, 52194.0, 52372.21441678302, 53565.0, 76320.61839690767, 77693.0, 78727.60636196782, 78942.0, 80368.0, 13188.0, 13280.415658730655, 13845.515406960709, 13929.303534823015, 14308.356123974654, 15790.605234869221, 15948.441804536786, 16169.67660646757, 16185.514434566981, 16829.747553786947, 10055.245856560641, 13747.656308592364, 14561.92719036398, 15101.697966040838, 15403.768943465633, 15184.240787960336, 15264.3894244229, 15939.840601593836, 16186.838131618533, 16423.83576164271, 14414.42342306338, 14720.337584808494, 15203.0, 15295.61760955985, 15321.770173447185, 12101.878981210075, 12433.37833108359, 12656.0, 12820.679483013, 12911.354432278536, 12188.390580470763, 12752.68118297013, 12786.68033299175, 12945.288009159587, 13119.27843968591], "value": 7856.366095197499, "unit": "score"}], "name": "dromaeo_css", "value": 7414.641901312243, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 109.0, 107.0, 111.0, 110.0, 109.0, 109.0, 109.0, 108.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 116.0, 122.0, 167.0, 118.0, 120.0, 147.0, 118.0, 160.0, 116.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 161.0, 159.0, 159.0, 159.0, 159.0, 160.0, 161.0, 159.0], "value": 159.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 124.0, 75.0, 76.0, 74.0, 75.0, 103.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 115.0, 84.0, 84.0, 83.0, 116.0, 85.0, 84.0, 130.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 152.0, 145.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 51.0, 52.0, 52.0, 52.0, 51.0, 51.0, 52.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 84.0, 85.0, 75.0, 77.0, 76.0, 75.0, 75.0, 79.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 122.0, 126.0, 118.0, 118.0, 117.0, 119.0, 118.0, 163.0, 122.0], "value": 124.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 158.0, 159.0, 159.0, 160.0, 157.0, 161.0, 163.0, 158.0, 163.0], "value": 159.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 62.0, 63.0, 63.0, 61.0, 67.0, 63.0, 62.0, 62.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1475.5, "alertThreshold": 2.0}]} 07:30:31 INFO - Return code: 0 07:30:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:30:31 INFO - # TBPL SUCCESS # 07:30:31 INFO - Running post-action listener: _resource_record_post_action 07:30:31 INFO - ##### 07:30:31 INFO - ##### Finished run-tests step (success) 07:30:31 INFO - ##### 07:30:31 INFO - Running post-run listener: _resource_record_post_run 07:30:31 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 569319424; Read time: 12; Write time: 561628 07:30:31 INFO - TinderboxPrint: CPU usage
12.9% 07:30:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:30:31 INFO - TinderboxPrint: I/O write bytes / time
569,319,424 / 561,628 07:30:31 INFO - TinderboxPrint: CPU idle
8,288.2 (87.0%) 07:30:31 INFO - TinderboxPrint: CPU user
1,188.8 (12.5%) 07:30:31 INFO - TinderboxPrint: Swap in / out
0 / 0 07:30:31 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 273661952; Read time: 0; Write time: 289180 07:30:31 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 295235584; Read time: 0; Write time: 272416 07:30:31 INFO - Running post-run listener: _upload_blobber_files 07:30:31 INFO - Blob upload gear active. 07:30:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:30:31 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 07:30:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:30:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:30:32 INFO - (blobuploader) - INFO - Open directory for files ... 07:30:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:30:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:30:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:36 INFO - (blobuploader) - INFO - Done attempting. 07:30:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:30:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:30:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:37 INFO - (blobuploader) - INFO - Done attempting. 07:30:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:30:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:30:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:38 INFO - (blobuploader) - INFO - Done attempting. 07:30:38 INFO - (blobuploader) - INFO - Iteration through files over. 07:30:38 INFO - Return code: 0 07:30:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:30:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:30:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae36a4b7efa80af35221eef0a8136cc8ea81916f7dabc2a0f149d82d522c1a5917f3c40cfe493c1483e626f35248391900b993c68c92ac92344de96c9f992d39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/685f7698509a58bd36fa11125a91a33ce0e16ef45efab8db676bb4ab4e2b271fc226ea56a5a8e0a0659983f3aaee79ccd6b302de955e6b5e1a14287afa68c3ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8680ba9fa4749262b683f672d7e36c34957aff2f369c73dba637eb6764571b6a0654e5109f3b6357de7fb49996930bfb28a95b1ed357ea8b4d0521b3439f028"} 07:30:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:30:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:30:38 INFO - Contents: 07:30:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae36a4b7efa80af35221eef0a8136cc8ea81916f7dabc2a0f149d82d522c1a5917f3c40cfe493c1483e626f35248391900b993c68c92ac92344de96c9f992d39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/685f7698509a58bd36fa11125a91a33ce0e16ef45efab8db676bb4ab4e2b271fc226ea56a5a8e0a0659983f3aaee79ccd6b302de955e6b5e1a14287afa68c3ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8680ba9fa4749262b683f672d7e36c34957aff2f369c73dba637eb6764571b6a0654e5109f3b6357de7fb49996930bfb28a95b1ed357ea8b4d0521b3439f028"} 07:30:38 INFO - Running post-run listener: copy_logs_to_upload_dir 07:30:38 INFO - Copying logs to upload dir... 07:30:38 INFO - mkdir: /builds/slave/test/build/upload/logs 07:30:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.045627 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-06 07:30:38.729459) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 07:30:38.732900) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae36a4b7efa80af35221eef0a8136cc8ea81916f7dabc2a0f149d82d522c1a5917f3c40cfe493c1483e626f35248391900b993c68c92ac92344de96c9f992d39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/685f7698509a58bd36fa11125a91a33ce0e16ef45efab8db676bb4ab4e2b271fc226ea56a5a8e0a0659983f3aaee79ccd6b302de955e6b5e1a14287afa68c3ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8680ba9fa4749262b683f672d7e36c34957aff2f369c73dba637eb6764571b6a0654e5109f3b6357de7fb49996930bfb28a95b1ed357ea8b4d0521b3439f028"} build_url:https://queue.taskcluster.net/v1/task/bnrB5DbETWi0HLZtrnganQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011352 build_url: 'https://queue.taskcluster.net/v1/task/bnrB5DbETWi0HLZtrnganQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae36a4b7efa80af35221eef0a8136cc8ea81916f7dabc2a0f149d82d522c1a5917f3c40cfe493c1483e626f35248391900b993c68c92ac92344de96c9f992d39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/685f7698509a58bd36fa11125a91a33ce0e16ef45efab8db676bb4ab4e2b271fc226ea56a5a8e0a0659983f3aaee79ccd6b302de955e6b5e1a14287afa68c3ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8680ba9fa4749262b683f672d7e36c34957aff2f369c73dba637eb6764571b6a0654e5109f3b6357de7fb49996930bfb28a95b1ed357ea8b4d0521b3439f028"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 07:30:38.758355) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 07:30:38.758677) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467814147.907065-1054849428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 07:30:38.841491) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 07:30:38.841808) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 07:30:38.842104) ========= ========= Total master_lag: 0.17 =========