builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-055 starttime: 1468094941.25 results: success (0) buildid: 20160709103021 builduid: 6ffb37c8e420465fa9dfb1af5c043bec revision: 679118259e91f40d4a8f968f03ec4cff066cdb5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 13:09:01.247485) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 13:09:01.248228) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 13:09:01.248499) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 13:09:01.315356) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 13:09:01.315626) ========= 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=bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-09 13:09:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.4M=0s 2016-07-09 13:09:01 (42.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110522 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 13:09:01.445115) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 13:09:01.445401) ========= 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=bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018985 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 13:09:01.495120) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 13:09:01.495459) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 679118259e91f40d4a8f968f03ec4cff066cdb5b --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 679118259e91f40d4a8f968f03ec4cff066cdb5b --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=bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-09 13:09:01,787 truncating revision to first 12 chars 2016-07-09 13:09:01,787 Setting DEBUG logging. 2016-07-09 13:09:01,787 attempt 1/10 2016-07-09 13:09:01,787 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/679118259e91?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-09 13:09:02,313 unpacking tar archive at: mozilla-central-679118259e91/testing/mozharness/ program finished with exit code 0 elapsedTime=0.859846 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 13:09:02.368568) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 13:09:02.368896) ========= script_repo_revision: 679118259e91f40d4a8f968f03ec4cff066cdb5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 13:09:02.369293) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 13:09:02.369571) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 13:09:02.379239) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-09 13:09:02.379661) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:09:02 INFO - MultiFileLogger online at 20160709 13:09:02 in /builds/slave/test 13:09:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:09:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:09:02 INFO - {'append_to_log': False, 13:09:02 INFO - 'base_work_dir': '/builds/slave/test', 13:09:02 INFO - 'blob_upload_branch': 'Firefox', 13:09:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:09:02 INFO - 'branch': 'Firefox', 13:09:02 INFO - 'buildbot_json_path': 'buildprops.json', 13:09:02 INFO - 'config_files': ('talos/linux_config.py',), 13:09:02 INFO - 'default_actions': ('clobber', 13:09:02 INFO - 'read-buildbot-config', 13:09:02 INFO - 'download-and-extract', 13:09:02 INFO - 'populate-webroot', 13:09:02 INFO - 'create-virtualenv', 13:09:02 INFO - 'install', 13:09:02 INFO - 'run-tests'), 13:09:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:09:02 INFO - 'download_minidump_stackwalk': True, 13:09:02 INFO - 'download_symbols': 'ondemand', 13:09:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:09:02 INFO - 'tooltool.py': '/tools/tooltool.py', 13:09:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:09:02 INFO - '/tools/misc-python/virtualenv.py')}, 13:09:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:09:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:09:02 INFO - 'installer_path': 'installer.exe', 13:09:02 INFO - 'log_level': 'info', 13:09:02 INFO - 'log_name': 'talos', 13:09:02 INFO - 'log_to_console': True, 13:09:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:09:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:09:02 INFO - 'opt_config_files': (), 13:09:02 INFO - 'pip_index': False, 13:09:02 INFO - 'sps_profile': False, 13:09:02 INFO - 'sps_profile_interval': 0, 13:09:02 INFO - 'suite': 'dromaeojs-e10s', 13:09:02 INFO - 'system_bits': '32', 13:09:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:09:02 INFO - 'title': 'talos-linux64-ix-055', 13:09:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:09:02 INFO - 'use_talos_json': True, 13:09:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:09:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:09:02 INFO - 'work_dir': 'build'} 13:09:02 INFO - ##### 13:09:02 INFO - ##### Running clobber step. 13:09:02 INFO - ##### 13:09:02 INFO - Running pre-action listener: _resource_record_pre_action 13:09:02 INFO - Running main action method: clobber 13:09:02 INFO - rmtree: /builds/slave/test/build 13:09:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:09:03 INFO - Running post-action listener: _resource_record_post_action 13:09:03 INFO - ##### 13:09:03 INFO - ##### Finished clobber step (success) 13:09:03 INFO - ##### 13:09:03 INFO - ##### 13:09:03 INFO - ##### Running read-buildbot-config step. 13:09:03 INFO - ##### 13:09:03 INFO - Running pre-action listener: _resource_record_pre_action 13:09:03 INFO - Running main action method: read_buildbot_config 13:09:03 INFO - Using buildbot properties: 13:09:03 INFO - { 13:09:03 INFO - "project": "", 13:09:03 INFO - "product": "firefox", 13:09:03 INFO - "script_repo_revision": "production", 13:09:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 13:09:03 INFO - "repository": "", 13:09:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 13:09:03 INFO - "buildid": "20160709103021", 13:09:03 INFO - "pgo_build": "True", 13:09:03 INFO - "basedir": "/builds/slave/test", 13:09:03 INFO - "buildnumber": 287, 13:09:03 INFO - "slavename": "talos-linux64-ix-055", 13:09:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:09:03 INFO - "platform": "ubuntu64_hw", 13:09:03 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 13:09:03 INFO - "branch": "mozilla-central", 13:09:03 INFO - "repo_path": "mozilla-central", 13:09:03 INFO - "revision": "679118259e91f40d4a8f968f03ec4cff066cdb5b", 13:09:03 INFO - "stage_platform": "linux64-pgo", 13:09:03 INFO - "builduid": "6ffb37c8e420465fa9dfb1af5c043bec", 13:09:03 INFO - "slavebuilddir": "test" 13:09:03 INFO - } 13:09:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:09:03 INFO - Running post-action listener: _resource_record_post_action 13:09:03 INFO - ##### 13:09:03 INFO - ##### Finished read-buildbot-config step (success) 13:09:03 INFO - ##### 13:09:03 INFO - ##### 13:09:03 INFO - ##### Running download-and-extract step. 13:09:03 INFO - ##### 13:09:03 INFO - Running pre-action listener: _resource_record_pre_action 13:09:03 INFO - Running main action method: download_and_extract 13:09:03 INFO - mkdir: /builds/slave/test/build/tests 13:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:03 INFO - https://queue.taskcluster.net/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:09:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:09:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:09:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/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 13:09:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/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 13:09:03 INFO - Downloaded 1361 bytes. 13:09:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:09:03 INFO - Using the following test package requirements: 13:09:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:09:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:09:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:09:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:03 INFO - u'jsshell-linux-x86_64.zip'], 13:09:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:09:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:09:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:09:03 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:09:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:09:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:09:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:03 INFO - https://queue.taskcluster.net/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:09:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:09:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:09:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/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 13:09:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/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 13:09:05 INFO - Downloaded 24305230 bytes. 13:09:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:09:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:09:07 INFO - Return code: 0 13:09:07 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 13:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:07 INFO - https://queue.taskcluster.net/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:09:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:09:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:09:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/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 13:09:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/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 13:09:17 INFO - Downloaded 24305230 bytes. 13:09:17 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'] 13:09:17 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 13:09:18 INFO - Return code: 0 13:09:18 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')]} 13:09:18 INFO - https://queue.taskcluster.net/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:09:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:09:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:09:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/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 13:09:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/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 13:09:19 INFO - Downloaded 14403333 bytes. 13:09:19 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'] 13:09:19 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 13:09:20 INFO - Return code: 0 13:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:20 INFO - https://queue.taskcluster.net/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:09:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:09:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:09:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/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 13:09:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/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 13:09:21 INFO - Downloaded 60490111 bytes. 13:09:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:09:21 INFO - mkdir: /builds/slave/test/properties 13:09:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:09:21 INFO - Writing to file /builds/slave/test/properties/build_url 13:09:21 INFO - Contents: 13:09:21 INFO - build_url:https://queue.taskcluster.net/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:09:22 INFO - Running post-action listener: _resource_record_post_action 13:09:22 INFO - Running post-action listener: set_extra_try_arguments 13:09:22 INFO - ##### 13:09:22 INFO - ##### Finished download-and-extract step (success) 13:09:22 INFO - ##### 13:09:22 INFO - ##### 13:09:22 INFO - ##### Running populate-webroot step. 13:09:22 INFO - ##### 13:09:22 INFO - Running pre-action listener: _resource_record_pre_action 13:09:22 INFO - Running main action method: populate_webroot 13:09:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:09:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:09:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:09:22 INFO - '--tppagecycles', 13:09:22 INFO - '7'], 13:09:22 INFO - 'tests': ['tsvgm']}}, 13:09:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:09:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:09:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:09:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:09:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:09:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:09:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:22 INFO - 'talos_options': ['--disable-e10s'], 13:09:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:09:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:09:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:22 INFO - 'talos_options': ['--disable-e10s'], 13:09:22 INFO - 'tests': ['damp', 'tps']}, 13:09:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:22 INFO - 'tests': ['damp', 'tps']}, 13:09:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:09:22 INFO - 'tests': ['dromaeo_dom']}, 13:09:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:09:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:09:22 INFO - 'tests': ['basic_compositor_video']}, 13:09:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:09:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:09:22 INFO - 'tests': ['a11yr', 13:09:22 INFO - 'ts_paint', 13:09:22 INFO - 'tpaint', 13:09:22 INFO - 'sessionrestore', 13:09:22 INFO - 'sessionrestore_no_auto_restore', 13:09:22 INFO - 'tabpaint']}, 13:09:22 INFO - 'other-e10s': {'tests': ['a11yr', 13:09:22 INFO - 'ts_paint', 13:09:22 INFO - 'tpaint', 13:09:22 INFO - 'sessionrestore', 13:09:22 INFO - 'sessionrestore_no_auto_restore', 13:09:22 INFO - 'tabpaint']}, 13:09:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:09:22 INFO - 'ts_paint', 13:09:22 INFO - 'tpaint', 13:09:22 INFO - 'sessionrestore', 13:09:22 INFO - 'sessionrestore_no_auto_restore', 13:09:22 INFO - 'tabpaint']}, 13:09:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:09:22 INFO - 'ts_paint', 13:09:22 INFO - 'tpaint', 13:09:22 INFO - 'sessionrestore', 13:09:22 INFO - 'sessionrestore_no_auto_restore', 13:09:22 INFO - 'tabpaint']}, 13:09:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:09:22 INFO - 'tests': ['a11yr', 13:09:22 INFO - 'ts_paint', 13:09:22 INFO - 'tpaint', 13:09:22 INFO - 'sessionrestore', 13:09:22 INFO - 'sessionrestore_no_auto_restore', 13:09:22 INFO - 'tabpaint']}, 13:09:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:09:22 INFO - 'tests': ['a11yr', 13:09:22 INFO - 'ts_paint', 13:09:22 INFO - 'tpaint', 13:09:22 INFO - 'sessionrestore', 13:09:22 INFO - 'sessionrestore_no_auto_restore', 13:09:22 INFO - 'tabpaint']}, 13:09:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:09:22 INFO - 'tests': ['tsvgx', 13:09:22 INFO - 'tsvgr_opacity', 13:09:22 INFO - 'tart', 13:09:22 INFO - 'tscrollx', 13:09:22 INFO - 'cart']}, 13:09:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:09:22 INFO - 'tsvgr_opacity', 13:09:22 INFO - 'tart', 13:09:22 INFO - 'tscrollx', 13:09:22 INFO - 'cart']}, 13:09:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:22 INFO - 'talos_options': ['--disable-e10s'], 13:09:22 INFO - 'tests': ['tp5o']}, 13:09:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:22 INFO - 'tests': ['tp5o']}, 13:09:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:22 INFO - 'talos_options': ['--disable-e10s', 13:09:22 INFO - '--xperf_path', 13:09:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:09:22 INFO - 'tests': ['tp5n']}, 13:09:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:22 INFO - 'talos_options': ['--xperf_path', 13:09:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:09:22 INFO - 'tests': ['tp5n']}}, 13:09:22 INFO - 'talos.zip': {'path': '', 13:09:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:09:22 INFO - Running post-action listener: _resource_record_post_action 13:09:22 INFO - ##### 13:09:22 INFO - ##### Finished populate-webroot step (success) 13:09:22 INFO - ##### 13:09:22 INFO - ##### 13:09:22 INFO - ##### Running create-virtualenv step. 13:09:22 INFO - ##### 13:09:22 INFO - Running pre-action listener: _resource_record_pre_action 13:09:22 INFO - Running main action method: create_virtualenv 13:09:22 INFO - Creating virtualenv /builds/slave/test/build/venv 13:09:22 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 13:09:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:09:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:09:22 INFO - Using real prefix '/usr' 13:09:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:09:23 INFO - Installing distribute.............................................................................................................................................................................................done. 13:09:25 INFO - Installing pip.................done. 13:09:25 INFO - Return code: 0 13:09:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x183a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af93b0>, '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 0x1afa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afa740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848', '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 13:09:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:09:25 INFO - Using env: {'DISPLAY': ':0', 13:09:25 INFO - 'HOME': '/home/cltbld', 13:09:25 INFO - 'LANG': 'en_US.UTF-8', 13:09:25 INFO - 'LANGUAGE': 'en_US:en', 13:09:25 INFO - 'LOGNAME': 'cltbld', 13:09:25 INFO - 'MAIL': '/var/mail/cltbld', 13:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:25 INFO - 'MOZ_NO_REMOTE': '1', 13:09:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:25 INFO - 'NO_EM_RESTART': '1', 13:09:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:25 INFO - 'PWD': '/builds/slave/test', 13:09:25 INFO - 'SHELL': '/bin/bash', 13:09:25 INFO - 'SHLVL': '1', 13:09:25 INFO - 'TERM': 'linux', 13:09:25 INFO - 'TMOUT': '86400', 13:09:25 INFO - 'USER': 'cltbld', 13:09:25 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848', 13:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:25 INFO - '_': '/tools/buildbot/bin/python'} 13:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:25 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 13:09:25 INFO - Cleaning up... 13:09:25 INFO - Return code: 0 13:09:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x183a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af93b0>, '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 0x1afa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afa740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848', '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 13:09:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:09:25 INFO - Using env: {'DISPLAY': ':0', 13:09:25 INFO - 'HOME': '/home/cltbld', 13:09:25 INFO - 'LANG': 'en_US.UTF-8', 13:09:25 INFO - 'LANGUAGE': 'en_US:en', 13:09:25 INFO - 'LOGNAME': 'cltbld', 13:09:25 INFO - 'MAIL': '/var/mail/cltbld', 13:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:25 INFO - 'MOZ_NO_REMOTE': '1', 13:09:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:25 INFO - 'NO_EM_RESTART': '1', 13:09:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:25 INFO - 'PWD': '/builds/slave/test', 13:09:25 INFO - 'SHELL': '/bin/bash', 13:09:25 INFO - 'SHLVL': '1', 13:09:25 INFO - 'TERM': 'linux', 13:09:25 INFO - 'TMOUT': '86400', 13:09:25 INFO - 'USER': 'cltbld', 13:09:25 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848', 13:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:25 INFO - '_': '/tools/buildbot/bin/python'} 13:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:25 INFO - Downloading/unpacking psutil>=3.1.1 13:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:09:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:09:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:09:27 INFO - Installing collected packages: psutil 13:09:27 INFO - Running setup.py install for psutil 13:09:27 INFO - building 'psutil._psutil_linux' extension 13:09:27 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 13:09:27 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 13:09:27 INFO - building 'psutil._psutil_posix' extension 13:09:27 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 13:09:28 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 13:09:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:09:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:09:28 INFO - Successfully installed psutil 13:09:28 INFO - Cleaning up... 13:09:28 INFO - Return code: 0 13:09:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x183a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af93b0>, '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 0x1afa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afa740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848', '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 13:09:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:09:28 INFO - Using env: {'DISPLAY': ':0', 13:09:28 INFO - 'HOME': '/home/cltbld', 13:09:28 INFO - 'LANG': 'en_US.UTF-8', 13:09:28 INFO - 'LANGUAGE': 'en_US:en', 13:09:28 INFO - 'LOGNAME': 'cltbld', 13:09:28 INFO - 'MAIL': '/var/mail/cltbld', 13:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:28 INFO - 'MOZ_NO_REMOTE': '1', 13:09:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:28 INFO - 'NO_EM_RESTART': '1', 13:09:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:28 INFO - 'PWD': '/builds/slave/test', 13:09:28 INFO - 'SHELL': '/bin/bash', 13:09:28 INFO - 'SHLVL': '1', 13:09:28 INFO - 'TERM': 'linux', 13:09:28 INFO - 'TMOUT': '86400', 13:09:28 INFO - 'USER': 'cltbld', 13:09:28 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848', 13:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:28 INFO - '_': '/tools/buildbot/bin/python'} 13:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:09:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:09:30 INFO - Installing collected packages: mozsystemmonitor 13:09:30 INFO - Running setup.py install for mozsystemmonitor 13:09:30 INFO - Successfully installed mozsystemmonitor 13:09:30 INFO - Cleaning up... 13:09:30 INFO - Return code: 0 13:09:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:09: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')]} 13:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09: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')]} 13:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:30 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 0x183a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af93b0>, '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 0x1afa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afa740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848', '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 13:09:30 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 13:09:30 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 13:09:30 INFO - Using env: {'DISPLAY': ':0', 13:09:30 INFO - 'HOME': '/home/cltbld', 13:09:30 INFO - 'LANG': 'en_US.UTF-8', 13:09:30 INFO - 'LANGUAGE': 'en_US:en', 13:09:30 INFO - 'LOGNAME': 'cltbld', 13:09:30 INFO - 'MAIL': '/var/mail/cltbld', 13:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:30 INFO - 'MOZ_NO_REMOTE': '1', 13:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:30 INFO - 'NO_EM_RESTART': '1', 13:09:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:30 INFO - 'PWD': '/builds/slave/test', 13:09:30 INFO - 'SHELL': '/bin/bash', 13:09:30 INFO - 'SHLVL': '1', 13:09:30 INFO - 'TERM': 'linux', 13:09:30 INFO - 'TMOUT': '86400', 13:09:30 INFO - 'USER': 'cltbld', 13:09:30 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848', 13:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:30 INFO - '_': '/tools/buildbot/bin/python'} 13:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:30 INFO - Downloading/unpacking jsonschema==2.5.1 13:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:09:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:32 INFO - Downloading functools32-3.2.3-2.tar.gz 13:09:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:09:32 INFO - warning: no files found matching '*.txt' 13:09:32 INFO - no previously-included directories found matching 'build' 13:09:32 INFO - no previously-included directories found matching 'dist' 13:09:32 INFO - no previously-included directories found matching '.git*' 13:09:32 INFO - Installing collected packages: jsonschema, functools32 13:09:32 INFO - Running setup.py install for functools32 13:09:32 INFO - warning: no files found matching '*.txt' 13:09:32 INFO - no previously-included directories found matching 'build' 13:09:32 INFO - no previously-included directories found matching 'dist' 13:09:32 INFO - no previously-included directories found matching '.git*' 13:09:32 INFO - Successfully installed jsonschema functools32 13:09:32 INFO - Cleaning up... 13:09:33 INFO - Return code: 0 13:09:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:09: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')]} 13:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09: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')]} 13:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x183a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af93b0>, '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 0x1afa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afa740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848', '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 13:09:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:09:33 INFO - Using env: {'DISPLAY': ':0', 13:09:33 INFO - 'HOME': '/home/cltbld', 13:09:33 INFO - 'LANG': 'en_US.UTF-8', 13:09:33 INFO - 'LANGUAGE': 'en_US:en', 13:09:33 INFO - 'LOGNAME': 'cltbld', 13:09:33 INFO - 'MAIL': '/var/mail/cltbld', 13:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:33 INFO - 'MOZ_NO_REMOTE': '1', 13:09:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:33 INFO - 'NO_EM_RESTART': '1', 13:09:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:33 INFO - 'PWD': '/builds/slave/test', 13:09:33 INFO - 'SHELL': '/bin/bash', 13:09:33 INFO - 'SHLVL': '1', 13:09:33 INFO - 'TERM': 'linux', 13:09:33 INFO - 'TMOUT': '86400', 13:09:33 INFO - 'USER': 'cltbld', 13:09:33 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848', 13:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:33 INFO - '_': '/tools/buildbot/bin/python'} 13:09:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:33 INFO - Downloading/unpacking blobuploader==1.2.4 13:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:35 INFO - Downloading blobuploader-1.2.4.tar.gz 13:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:09:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:09: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 13:09: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 13:09: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 13:09: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 13:09: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 13:09: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 13:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:09:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:09: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 13:09: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 13:09: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 13:09: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 13:09: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 13:09: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 13:09:35 INFO - Downloading docopt-0.6.1.tar.gz 13:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:09:35 INFO - Installing collected packages: blobuploader, requests, docopt 13:09:35 INFO - Running setup.py install for blobuploader 13:09:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:09:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:09:35 INFO - Running setup.py install for requests 13:09:36 INFO - Running setup.py install for docopt 13:09:36 INFO - Successfully installed blobuploader requests docopt 13:09:36 INFO - Cleaning up... 13:09:36 INFO - Return code: 0 13:09:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:36 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 0x183a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af93b0>, '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 0x1afa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afa740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848', '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 13:09:36 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 13:09:36 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 13:09:36 INFO - Using env: {'DISPLAY': ':0', 13:09:36 INFO - 'HOME': '/home/cltbld', 13:09:36 INFO - 'LANG': 'en_US.UTF-8', 13:09:36 INFO - 'LANGUAGE': 'en_US:en', 13:09:36 INFO - 'LOGNAME': 'cltbld', 13:09:36 INFO - 'MAIL': '/var/mail/cltbld', 13:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:36 INFO - 'MOZ_NO_REMOTE': '1', 13:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:36 INFO - 'NO_EM_RESTART': '1', 13:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:36 INFO - 'PWD': '/builds/slave/test', 13:09:36 INFO - 'SHELL': '/bin/bash', 13:09:36 INFO - 'SHLVL': '1', 13:09:36 INFO - 'TERM': 'linux', 13:09:36 INFO - 'TMOUT': '86400', 13:09:36 INFO - 'USER': 'cltbld', 13:09:36 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848', 13:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:36 INFO - '_': '/tools/buildbot/bin/python'} 13:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:09:36 INFO - Running setup.py (path:/tmp/pip-4ZA7jp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:09:36 INFO - Running setup.py (path:/tmp/pip-mPXEya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:09:36 INFO - Running setup.py (path:/tmp/pip-zZK88m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:09:36 INFO - Running setup.py (path:/tmp/pip-50nKNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:09:36 INFO - Running setup.py (path:/tmp/pip-YOgEA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:09:37 INFO - Running setup.py (path:/tmp/pip-7PSrMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:09:37 INFO - Running setup.py (path:/tmp/pip-hsKLmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:09:37 INFO - Running setup.py (path:/tmp/pip-ETOybD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:09:37 INFO - Running setup.py (path:/tmp/pip-_RyWwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:09:37 INFO - Running setup.py (path:/tmp/pip-VqZxSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:09:37 INFO - Running setup.py (path:/tmp/pip-6xEh2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:09:37 INFO - Running setup.py (path:/tmp/pip-YBOOkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:09:37 INFO - Running setup.py (path:/tmp/pip-gv34Kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:09:37 INFO - Running setup.py (path:/tmp/pip-UK2LAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:37 INFO - Running setup.py (path:/tmp/pip-c4NAB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:09:37 INFO - Running setup.py (path:/tmp/pip-e_7BqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:09:37 INFO - Running setup.py (path:/tmp/pip-YLXdF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:09:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:09:37 INFO - Running setup.py install for manifestparser 13:09:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:09:38 INFO - Running setup.py install for mozcrash 13:09:38 INFO - Running setup.py install for mozdebug 13:09:38 INFO - Running setup.py install for mozdevice 13:09:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:09:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:09:38 INFO - Running setup.py install for mozfile 13:09:38 INFO - Running setup.py install for mozhttpd 13:09:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:09:38 INFO - Running setup.py install for mozinfo 13:09:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:09:38 INFO - Running setup.py install for mozInstall 13:09:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:09:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:09:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:09:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:09:38 INFO - Running setup.py install for mozleak 13:09:38 INFO - Running setup.py install for mozlog 13:09:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:09:38 INFO - Running setup.py install for moznetwork 13:09:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:09:39 INFO - Running setup.py install for mozprocess 13:09:39 INFO - Running setup.py install for mozprofile 13:09:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:09:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:09:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:09:39 INFO - Running setup.py install for mozrunner 13:09:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:09:39 INFO - Running setup.py install for mozscreenshot 13:09:39 INFO - Running setup.py install for moztest 13:09:39 INFO - Running setup.py install for mozversion 13:09:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:09:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:09:39 INFO - Cleaning up... 13:09:39 INFO - Return code: 0 13:09:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:39 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 0x183a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af93b0>, '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 0x1afa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afa740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848', '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 13:09:39 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 13:09:39 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 13:09:39 INFO - Using env: {'DISPLAY': ':0', 13:09:39 INFO - 'HOME': '/home/cltbld', 13:09:39 INFO - 'LANG': 'en_US.UTF-8', 13:09:39 INFO - 'LANGUAGE': 'en_US:en', 13:09:39 INFO - 'LOGNAME': 'cltbld', 13:09:39 INFO - 'MAIL': '/var/mail/cltbld', 13:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:39 INFO - 'MOZ_NO_REMOTE': '1', 13:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:39 INFO - 'NO_EM_RESTART': '1', 13:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:39 INFO - 'PWD': '/builds/slave/test', 13:09:39 INFO - 'SHELL': '/bin/bash', 13:09:39 INFO - 'SHLVL': '1', 13:09:39 INFO - 'TERM': 'linux', 13:09:39 INFO - 'TMOUT': '86400', 13:09:39 INFO - 'USER': 'cltbld', 13:09:39 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848', 13:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:39 INFO - '_': '/tools/buildbot/bin/python'} 13:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:09:39 INFO - Running setup.py (path:/tmp/pip-tkHmjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:09:39 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)) 13:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:09:39 INFO - Running setup.py (path:/tmp/pip-Nugpoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:09:40 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)) 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:09:40 INFO - Running setup.py (path:/tmp/pip-S1GY3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:09:40 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)) 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:09:40 INFO - Running setup.py (path:/tmp/pip-HKTHQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:09:40 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)) 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:09:40 INFO - Running setup.py (path:/tmp/pip-3VeP1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:09:40 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)) 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:09:40 INFO - Running setup.py (path:/tmp/pip-sAHKV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:09:40 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)) 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:09:40 INFO - Running setup.py (path:/tmp/pip-o94kbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:09:40 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)) 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:09:40 INFO - Running setup.py (path:/tmp/pip-zQRMKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:09:40 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)) 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:09:40 INFO - Running setup.py (path:/tmp/pip-0lQuOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:09:40 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)) 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:09:40 INFO - Running setup.py (path:/tmp/pip-SGfSk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:09:40 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)) 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:09:40 INFO - Running setup.py (path:/tmp/pip-ttyZlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:09:40 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)) 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:09:40 INFO - Running setup.py (path:/tmp/pip-b53j0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:09:40 INFO - Running setup.py (path:/tmp/pip-QofSrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:09:40 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)) 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:09:40 INFO - Running setup.py (path:/tmp/pip-8byVOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:40 INFO - Running setup.py (path:/tmp/pip-AhE3bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:41 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)) 13:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:09:41 INFO - Running setup.py (path:/tmp/pip-J7B7AN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:09:41 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)) 13:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:09:41 INFO - Running setup.py (path:/tmp/pip-pCtbZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:09:41 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)) 13:09:41 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)) 13:09:41 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)) 13:09:41 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)) 13:09:41 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)) 13:09:41 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)) 13:09:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:43 INFO - Downloading blessings-1.6.tar.gz 13:09:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:09:43 INFO - Installing collected packages: blessings 13:09:43 INFO - Running setup.py install for blessings 13:09:43 INFO - Successfully installed blessings 13:09:43 INFO - Cleaning up... 13:09:43 INFO - Return code: 0 13:09:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:09:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:09:43 INFO - Reading from file tmpfile_stdout 13:09:43 INFO - Current package versions: 13:09:43 INFO - argparse == 1.2.1 13:09:43 INFO - blessings == 1.6 13:09:43 INFO - blobuploader == 1.2.4 13:09:43 INFO - docopt == 0.6.1 13:09:43 INFO - functools32 == 3.2.3-2 13:09:43 INFO - jsonschema == 2.5.1 13:09:43 INFO - manifestparser == 1.1 13:09:43 INFO - mozInstall == 1.12 13:09:43 INFO - mozcrash == 0.17 13:09:43 INFO - mozdebug == 0.1 13:09:43 INFO - mozdevice == 0.48 13:09:43 INFO - mozfile == 1.2 13:09:43 INFO - mozhttpd == 0.7 13:09:43 INFO - mozinfo == 0.9 13:09:43 INFO - mozleak == 0.1 13:09:43 INFO - mozlog == 3.2 13:09:43 INFO - moznetwork == 0.27 13:09:43 INFO - mozprocess == 0.23 13:09:43 INFO - mozprofile == 0.28 13:09:43 INFO - mozrunner == 6.12 13:09:43 INFO - mozscreenshot == 0.1 13:09:43 INFO - mozsystemmonitor == 0.3 13:09:43 INFO - moztest == 0.7 13:09:43 INFO - mozversion == 1.4 13:09:43 INFO - psutil == 3.1.1 13:09:43 INFO - requests == 1.2.3 13:09:43 INFO - wsgiref == 0.1.2 13:09:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:43 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 0x183a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af93b0>, '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 0x1afa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afa740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848', '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 13:09:43 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 13:09:43 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 13:09:43 INFO - Using env: {'DISPLAY': ':0', 13:09:43 INFO - 'HOME': '/home/cltbld', 13:09:43 INFO - 'LANG': 'en_US.UTF-8', 13:09:43 INFO - 'LANGUAGE': 'en_US:en', 13:09:43 INFO - 'LOGNAME': 'cltbld', 13:09:43 INFO - 'MAIL': '/var/mail/cltbld', 13:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:43 INFO - 'MOZ_NO_REMOTE': '1', 13:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:43 INFO - 'NO_EM_RESTART': '1', 13:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:43 INFO - 'PWD': '/builds/slave/test', 13:09:43 INFO - 'SHELL': '/bin/bash', 13:09:43 INFO - 'SHLVL': '1', 13:09:43 INFO - 'TERM': 'linux', 13:09:43 INFO - 'TMOUT': '86400', 13:09:43 INFO - 'USER': 'cltbld', 13:09:43 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848', 13:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:43 INFO - '_': '/tools/buildbot/bin/python'} 13:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:43 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)) 13:09:43 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)) 13:09:43 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)) 13:09:43 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)) 13:09:43 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)) 13:09:43 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)) 13:09:43 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)) 13:09:43 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)) 13:09:43 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)) 13:09:43 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)) 13:09:43 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)) 13:09:43 INFO - Cleaning up... 13:09:43 INFO - Return code: 0 13:09:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:43 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 0x183a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af93b0>, '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 0x1afa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afa740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848', '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 13:09:43 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 13:09:43 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 13:09:43 INFO - Using env: {'DISPLAY': ':0', 13:09:43 INFO - 'HOME': '/home/cltbld', 13:09:43 INFO - 'LANG': 'en_US.UTF-8', 13:09:43 INFO - 'LANGUAGE': 'en_US:en', 13:09:43 INFO - 'LOGNAME': 'cltbld', 13:09:43 INFO - 'MAIL': '/var/mail/cltbld', 13:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:43 INFO - 'MOZ_NO_REMOTE': '1', 13:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:43 INFO - 'NO_EM_RESTART': '1', 13:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:43 INFO - 'PWD': '/builds/slave/test', 13:09:43 INFO - 'SHELL': '/bin/bash', 13:09:43 INFO - 'SHLVL': '1', 13:09:43 INFO - 'TERM': 'linux', 13:09:43 INFO - 'TMOUT': '86400', 13:09:43 INFO - 'USER': 'cltbld', 13:09:43 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848', 13:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:43 INFO - '_': '/tools/buildbot/bin/python'} 13:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:09:43 INFO - Cleaning up... 13:09:43 INFO - Return code: 0 13:09:43 INFO - Running post-action listener: _resource_record_post_action 13:09:43 INFO - Running post-action listener: _start_resource_monitoring 13:09:43 INFO - Starting resource monitoring. 13:09:43 INFO - ##### 13:09:43 INFO - ##### Finished create-virtualenv step (success) 13:09:43 INFO - ##### 13:09:43 INFO - ##### 13:09:43 INFO - ##### Running install step. 13:09:43 INFO - ##### 13:09:43 INFO - Running pre-action listener: _resource_record_pre_action 13:09:43 INFO - Running main action method: install 13:09:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:09:44 INFO - Reading from file tmpfile_stdout 13:09:44 INFO - Detecting whether we're running mozinstall >=1.0... 13:09:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:09:44 INFO - Reading from file tmpfile_stdout 13:09:44 INFO - Output received: 13:09:44 INFO - Usage: mozinstall [options] installer 13:09:44 INFO - Options: 13:09:44 INFO - -h, --help show this help message and exit 13:09:44 INFO - -d DEST, --destination=DEST 13:09:44 INFO - Directory to install application into. [default: 13:09:44 INFO - "/builds/slave/test"] 13:09:44 INFO - --app=APP Application being installed. [default: firefox] 13:09:44 INFO - mkdir: /builds/slave/test/build/application 13:09:44 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'] 13:09:44 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 13:10:01 INFO - Reading from file tmpfile_stdout 13:10:01 INFO - Output received: 13:10:01 INFO - /builds/slave/test/build/application/firefox/firefox 13:10:01 INFO - Running post-action listener: _resource_record_post_action 13:10:01 INFO - ##### 13:10:01 INFO - ##### Finished install step (success) 13:10:01 INFO - ##### 13:10:01 INFO - ##### 13:10:01 INFO - ##### Running run-tests step. 13:10:01 INFO - ##### 13:10:01 INFO - Running pre-action listener: _resource_record_pre_action 13:10:01 INFO - Running main action method: run_tests 13:10:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:10:01 INFO - Python 2.7.3 13:10:01 INFO - Return code: 0 13:10:01 INFO - grabbing minidump binary from tooltool 13:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:01 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 0x1af93b0>, '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 0x1afa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afa740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:10:01 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 13:10:01 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 13:10:01 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 13:10:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:10:01 INFO - Return code: 0 13:10:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:10:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:10:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:10:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:10:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:10:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:10:01 INFO - Using env: {'DISPLAY': ':0', 13:10:01 INFO - 'HOME': '/home/cltbld', 13:10:01 INFO - 'LANG': 'en_US.UTF-8', 13:10:01 INFO - 'LANGUAGE': 'en_US:en', 13:10:01 INFO - 'LOGNAME': 'cltbld', 13:10:01 INFO - 'MAIL': '/var/mail/cltbld', 13:10:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:10:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:01 INFO - 'MOZ_NO_REMOTE': '1', 13:10:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:10:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:01 INFO - 'NO_EM_RESTART': '1', 13:10:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:01 INFO - 'PWD': '/builds/slave/test', 13:10:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:10:01 INFO - 'SHELL': '/bin/bash', 13:10:01 INFO - 'SHLVL': '1', 13:10:01 INFO - 'TERM': 'linux', 13:10:01 INFO - 'TMOUT': '86400', 13:10:01 INFO - 'USER': 'cltbld', 13:10:01 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848', 13:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:01 INFO - '_': '/tools/buildbot/bin/python'} 13:10:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:10:01 INFO - mozversion application_buildid: 20160709103021 13:10:01 INFO - mozversion application_changeset: 679118259e91f40d4a8f968f03ec4cff066cdb5b 13:10:01 INFO - mozversion application_display_name: Nightly 13:10:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:10:01 INFO - mozversion application_name: Firefox 13:10:01 INFO - mozversion application_remotingname: firefox 13:10:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:10:01 INFO - mozversion application_vendor: Mozilla 13:10:01 INFO - mozversion application_version: 50.0a1 13:10:01 INFO - mozversion platform_buildid: 20160709103021 13:10:01 INFO - mozversion platform_changeset: 679118259e91f40d4a8f968f03ec4cff066cdb5b 13:10:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:10:01 INFO - mozversion platform_version: 50.0a1 13:10:01 INFO - using testdate: 1468095001 13:10:01 INFO - actual date: 1468095001 13:10:01 INFO - starting webserver on 'localhost:40727' 13:10:01 INFO - SUITE-START | Running 2 tests 13:10:01 INFO - TEST-START | dromaeo_css 13:10:01 INFO - operating with platform_type : linux_ 13:10:01 INFO - Initialising browser for dromaeo_css test... 13:10:01 INFO - TEST-INFO | started process 22268 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiQkz4z/profile http://localhost:40727/getInfo.html) 13:10:06 INFO - PROCESS | 22268 | __metrics Screen width/height:1600/1200 13:10:06 INFO - PROCESS | 22268 | colorDepth:24 13:10:06 INFO - PROCESS | 22268 | Browser inner width/height: 1024/697 13:10:06 INFO - PROCESS | 22268 | __metrics 13:10:06 ERROR - PROCESS | 22268 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 13:10:07 INFO - TEST-INFO | 22268: exit 0 13:10:07 INFO - Browser initialized. 13:10:07 INFO - Running cycle 1/1 for dromaeo_css test... 13:10:07 INFO - TEST-INFO | started process 22388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiQkz4z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:10:19 INFO - PROCESS | 22388 | RSS: Main: 167780352 13:10:19 INFO - PROCESS | 22388 | 13:11:09 INFO - PROCESS | 22388 | 1468095069135 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] 13:13:16 INFO - PROCESS | 22388 | Cycle 1(1): loaded http://localhost:40727/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40727/tests/dromaeo/cssquery-ext.html) 13:13:17 INFO - PROCESS | 22388 | RSS: Main: 171270144 13:13:17 INFO - PROCESS | 22388 | 13:16:19 INFO - PROCESS | 22388 | Cycle 1(1): loaded http://localhost:40727/tests/dromaeo/cssquery-ext.html (next: http://localhost:40727/tests/dromaeo/cssquery-jquery.html) 13:16:20 INFO - PROCESS | 22388 | RSS: Main: 168620032 13:16:20 INFO - PROCESS | 22388 | 13:19:21 INFO - PROCESS | 22388 | Cycle 1(1): loaded http://localhost:40727/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40727/tests/dromaeo/cssquery-mootools.html) 13:19:22 INFO - PROCESS | 22388 | RSS: Main: 170123264 13:19:22 INFO - PROCESS | 22388 | 13:22:24 INFO - PROCESS | 22388 | Cycle 1(1): loaded http://localhost:40727/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40727/tests/dromaeo/cssquery-prototype.html) 13:22:24 INFO - PROCESS | 22388 | RSS: Main: 166129664 13:22:24 INFO - PROCESS | 22388 | 13:25:27 INFO - PROCESS | 22388 | Cycle 1(1): loaded http://localhost:40727/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40727/tests/dromaeo/cssquery-yui.html) 13:25:28 INFO - PROCESS | 22388 | RSS: Main: 168779776 13:25:28 INFO - PROCESS | 22388 | 13:28:30 INFO - PROCESS | 22388 | Cycle 1(1): loaded http://localhost:40727/tests/dromaeo/cssquery-yui.html (next: http://localhost:40727/tests/dromaeo/cssquery-dojo.html) 13:28:30 INFO - PROCESS | 22388 | RSS: Main: 169164800 13:28:30 INFO - PROCESS | 22388 | 13:28:30 INFO - PROCESS | 22388 | __start_tp_report 13:28:30 INFO - PROCESS | 22388 | _x_x_mozilla_page_load 13:28:30 INFO - PROCESS | 22388 | _x_x_mozilla_page_load_details 13:28:30 INFO - PROCESS | 22388 | |i|pagename|runs| 13:28:30 INFO - PROCESS | 22388 | |0;dojo.html;3024.561438591404;3047.898396735606;3061.7397521210696;3079.076277116865;3089.752819774417;5308.416074231836;5342.385625653046;5367.973160134204;5394.1908713692965;5434.157705555635;5268.789248430058;5341.973290133554;5407.161889907061;5440.211169380437;5474.972625136868;4923.80304787808;4928.260760885869;5002.749862506878;5089.3638295213095;5091.338126043609;170.38581180333549;4969.4036715594;5005.0990821652085;5071.3407257056715;5120.385553733558;4770;4937.308776771255;4953.752312384385;4999.600031997432;5028.647994640377;4996.900061998776;5034.697918124924;5039.09296326661;5065.012322597095;5079.79680812767;4853.733044682541;4885.291632713237;4942.555170034678;5014.974925125388;5018.774155163026;5372.247885296062;5432.320959880015;5462.808801691922;5465.043617366945;5480.26016487777;5814.244148260699;5830.387809280007;5835.270591176103;5841.474267315962;5869.559783016291;5666.121751128581;5814.069748840166;5819.156222347779;5852.824415267549;5860.413958604148;5470.316210473691;5499.340079190482;5502.312210973629;5503.2020357048405;5508.03609368359;5691.203231547586;6008.279006519158;6012.428819262163;6014.18808460861;6018.037114061729;5662.85842853932;5731.512821410227;5741;5755.625884317506;5770.24986751728;5805.332386775491;5823.068309070529;5824.767009319579;5826.708664566755;5839.474447299764;5598.860028499239;5702.45826646468;5728.169415434739;5729.742161602738;5729.914051289234;5781.392953739881;5824.621399609012;5831.766729330864;5834.212381328552;5893.941060589425;4426.911461770811;4427.645788336926;4433.623142032963;4441.777911104432;4445.5776701213335;3838.136419305634;3912.921741565153;3934.8229329680235;3956.149427873021;4022.577629348876;5285.603579731535;5326.92009619856;5378.058839703036;5408.810691625774;5619.157126430986;5656.519195868315;5694.971525142348;5697.829065128053;5699.772009119672;5717.42825717425;5434.347878254634;5447.618666693373;5456.290682211287;5505.614606977553;5513.09034009392;4958.281049247911;5008.774605142778;5025.974870125626;5033.597312215014;5036.294918711384;5974.761009559656;5992.490638295793;5992.940070599326;5999.670018149044;6020.969895150496;5649.350324712711;5790.131480277992;5855.736491857791;5869.765209391577;5873.530117590497;5976.133460648269;5978.192943952511;5986.16193732869;6006.639601623917;6063.696815159313;5688.317401911797;5695.772169113189;5704.0588302929555;5711.029125048669;5719.170720245625;5550.8057217997175;5784.479396854304;5817.040188368872;5835.56233282514;5868.031774757117;5750.942490575041;5762.30852297727;5763.5965482417505;5765.164051212467;5792.21805056312;5651.519620832275;5689.630174038674;5697.4872261495;5697.914531281951;5713.428657134254;5494.835154945358;5537.446255374431;5606.607537472338;5625.774969001194;5687.20379146928;5657.660540367591;5673.234113394639;5683.60214784961;5714.571407144397;5723.399043100415;5579.553635709052;5587.972060139836;5590.049691552527;5590.748416321194;5598.188262701967 13:28:30 INFO - PROCESS | 22388 | |1;ext.html;558.2794579193242;579.8086631411634;588.926384201975;610.0178712273241;629.28261781569;39872.40191397128;44555.108897822065;44657.106857862906;44658.33012504811;44672.10655786882;44653.77673111638;45068.54931450685;45151.09697806042;45254.32118518225;45479;8987.640494380234;9066.18404343609;9090.409123406956;9126.406783559047;9130.04134565871;8975.865362019542;9023.413478123934;9095.181433670969;9122.315826313019;9124.133207345325;9072.455652660828;9146.634134634607;9148.725538233864;9173;9199;9094;9098.681546145886;9102.544872756402;9125.17873391398;9157.95421022894;9089.590968406437;9108.954455227748;9138.17756401927;9162.908370916339;9164.221041211506;34531.719486648726;43848;44255;44256;44272.77863610694;3293.489509126089;3312.138843900579;3608.675219230282;3613.403788374915;3616.222512159872;31682.841585792154;32436.18909527257;32470;32579.674203257902;32873.17817054593;4247.171801498709;4326.113146804897;4342.2401079811225;4457.175422546807;4461;335166;335848;337076;338221.3088934564;338597;33155.171120721694;37638.81180594079;38604;38604.80697596494;38630.80684596615;38136.618633813865;38182.42726359107;38236.617633823305;38254.61745382566;38281.425778613346;15629.3748250071;15735.213239337987;15754.291056902466;15781.605459863365;15791;13032;13056.673583160496;13160;13163.802542961863;13166.802497962539;8506.914930850737;8550.572471376407;8591.484510929364;8594.527300998505;8649.264812490883;3202.551642770014;3231.4991176367703;3241.1410976090883;3247.350529894031;3260.6087269527334;1011.312307630818;1119.652907598647;1134.3987686526154;1151.9596814111467;1152.6657269391783;35523;37209.44185837215;37633.435498467545;38049.61950380516;38101;1127.3067063755732;1129.0797999630274;1160.1414952934936;1202.326697049655;1219.3110892345796;17582.65929473396;18462.538436539195;18513.81486185148;18533.53666158357;18562.814371856108;543160;549849;552613;556765;556794;62805.37194627995;62908.37091629117;63251.36748632547;63487.365126348144;63638.0454293186;1348.6763176837685;1357.6537982814516;1384.6884450998446;1403.8245219347582;1404.0522647213295;33392.66607333896;34464.65535344614;34931.47602785909;35022.82488587541;35041;55561.722191388784;55943;56466.153007704095;56514;56579;391035;394148;394861;395763;396220;29634.851825740734;29705.85147074251;30203;30326.393472129992;30355.544666829574;52383;52707;52927.735361324485;53321.7333913328;53855.73072134614;44370.77814610906;44505.88735281644;44956;44986.10027799491;45411.545884540734;44098.33852492151;44430;44560.88597785081;45451.77274113608;45454.77272613748;44107;44332.33501497545;44476;44912.32631510595;46766.53233467758;37907.62092379041;39469.60530394659;39876.401853971634;40283;40741;29933.70066299309;30408;30619.2345191372;30678.079657610306;30732.84633576818 13:28:30 INFO - PROCESS | 22388 | |2;jquery.html;387.87781848717634;388.5512233370458;391.7531954868433;393.44720667462224;418.98114584843677;16786.748198776997;20221.494462638442;20557.280495182673;21358;21450.678239826415;19786.901065494687;19837.404877853653;20748.896255518703;20788;20905.581888362223;5013.097642424371;5265.157574788034;5274.4198138204765;5345.812896548621;5384.300040994684;5190.948090519084;5302.443243459439;5535.640183388087;5736.569757268201;5743.54051675865;5663.150527420899;5700.7719691212305;5704.629199102066;5723.2559767230205;5732.197492351053;5773.682447465388;5848.941510584882;5886.117082437647;5886.852828679274;5935.6141850779995;5167.741612919339;5225.268462415227;5249.711265880375;5250.7637156328055;5360.2227676987;13713.862861371359;13998.650033749238;14074.648133796736;14108.365123569463;26059.436433813844;2679.6516452861;2706.8375897446217;2868.18256796814;2896.2904088498453;3069.155982104917;15958.202089895574;16307.184640768033;16431.671366572722;16695.41566045195;16732.832671673248;2048.539078707294;2076.2940600195857;2083.479130217446;2128.648772952461;2138.689889965962;92220;102332.48833755858;103655.4817225909;104102;105487.47256263746;18193.7270940936;18725.625487490175;18963.241470341032;19107.331243406414;19109;11705.473253703603;12209.145359824905;12319.199252048587;34107;34222.315553688786;7902.7234046809235;7948.244916732901;8001.519908805491;8064.475809072392;8255.42212045151;8164.224398682116;8228.50628962264;8362.080171181165;8537.943678353411;8613.741587752378;4060.6548443382053;4100.872260128429;4172.165566886635;4204.852830150991;4242.342436922282;1911.4934542346289;1911.5985643014844;1927.5470264487835;1957.2758079510388;1958.1677786940493;981.5730157381562;1015.6546774096843;1022.867027286448;1031.8916513766096;1051.9211059170593;21038.263660771798;21212.893935530225;21230.36308910735;21329.360119196448;21383.46541336448;1007.1741172238841;1025.958961641541;1026.7330494071596;1030.299396410448;1085.6037546295545;11244.943775281072;11765.411729413496;11817.172797904235;11911.225770325074;11931.880681193077;487828;488077;498826;501593;506234;101655.49172254092;105353.47323263335;106332;107369;107964.46017769861;1006.8892421833592;1011.7420057885192;1020.5203554329453;1023.2632504596827;1028.5577201803296;18419.81580184181;18627.441176764718;18987.62024759525;19033.333833316323;19051;45947;46022.53977460317;46268;47123.764381179244;47518.52481475141;64923;65729;65885.67057164683;66368.33631663621;69444;8718.476891386537;9121.4666161305;9168.816623667622;9255.67605133844;9496.762580935532;13390.464381425023;13951.790723138958;14470.565883023526;14566.41734330615;14609.123452592878;13060.085793994329;13177.209367437985;13187.340632968506;13227.206367617973;13373.799393008918;12623.431945562288;13027.957763378718;13095.934520327337;13114.60656180316;13150.736985260433;12392.194507356993;12791.168574042658;13167.275799830719;13360.599182024165;13526;7876.448648594773;8226.42415030966;8992.640294388151;9118.361714679908;9137.680181193626;12836.358182090671;12939.223646581235;12997.610071697864;13070.411831467416;13176.868231317947 13:28:30 INFO - PROCESS | 22388 | |3;mootools.html;1497.44594500035;1515.6892836968423;1665.4837000529837;1767.3372485318005;1779.8042215356309;7740.845183096335;8388.412811103217;8493.065762766091;8924.28605711543;8952.060033696465;8599.957000215007;8824.91175088249;8850.291976641869;8878.689245876396;8919.286457083434;2342.816877476876;2355.693759811222;2363.1728894886824;2369.5379401016808;2373.2405630198346;2319.965200521985;2355.9411014724596;2359.304005318427;2362.14962613459;2369.4668699542635;2327.185485080225;2333.8249631277636;2337.100216416675;2381.3094202681286;2385.2009576791797;2284.6001949658744;2301.976980230201;2311.06401907227;2312.6415405612156;2322.1640209524558;2241.4172315198;2243.4615692233747;2254.842161048727;2258.9887050564807;2260.16373941641;8864.689735859278;8890.377673562853;8965.058668839809;8980.730578082668;8988.370814043019;5261.631685781997;5367.221752845854;5368.060589396879;5369.489898459679;5370.731463426813;3421.4183588789715;3477.3393055319407;3542.468629705539;3558.928821423583;3614.0242134623504;1184.4965889497016;1214.884585964332;1249.975000499994;1261.1361217565905;1268.131330038917;12176.817347739703;12318.50725970969;12336.321502317369;12337;12353.382330883509;4489.932651010237;4700.55344742249;4723.574878260973;4800.35195248644;4811.807527698853;10366.378017318984;10474.947625261977;10488;10498.212634052477;10532.736681583021;5331.040412725747;5355.357357117093;5368.624196306299;5368.892622147535;5372.973135134299;4340.60934515895;4775.570198682135;4912.214045752734;4944.357233559686;4947.554720075211;4001.8399264029695;4033.3748269018347;4060.4486376639447;4073.6944729145434;4121.732087414309;1309.7642424363705;1311.344327836082;1325.244610571984;1330.2018788726687;1340.0485655184928;908.3051465628799;1021.5147804792664;1032.55084038442;1038.5586125896464;1049.4437947887632;5757.107648314518;5844.12338149281;5945.554083443759;5965.343812180657;6014.51883849291;469.2234352147202;478.9664723469393;492.65267986069733;494.1549949586176;499.4306490600718;4385.627221686129;4397.428334316518;4401.977990110029;4420.403245561873;4421.314696222091;10532.947335263429;10969.725756856142;11035.227534072537;11041.06150977176;11062.612808551663;10136.695899123039;10590.841137382946;10975.121990240761;10991.340519568852;11012.39431831241;7672.42456815741;7844.607769611496;7846.058472983393;7903.644336004779;7914.604269786603;5956.642601443928;6247.156633854372;6283.937160628335;6305.274893387319;6311.24265088174;9767.9023209767;9792.902070979198;9804.264680148875;9858.85211721839;9913.405195688281;9774.560144793359;9896.356736812084;10044.899551004397;10136.594536218763;10173.796524069625;7613.505122167041;7883.7240696575345;7946.364290856602;7978.880316795136;8138.064122625974;8803.823923521366;8821.691240806798;8835.779105522413;8844.46933184011;8886.822263554823;7747.225277472207;7986.241307075818;8018.679252830055;8043.436959412785;8099.230573095547;7780.299773020455;7944.404169687412;7961.044674639081;8067.475614085066;8088.099296665397;7072.752453664097;7176.06711127571;7188.5327453715345;7271.381932535582;7281.890771638536;5247.265382846328;5252.947470525399;5512.3660779010925;5515.751791169327;5538.806141785019;5001.824936127364;5091.71995540234;5165.405978312542;5207.92188117171;5486.835394938158 13:28:30 INFO - PROCESS | 22388 | |4;prototype.html;329;329.3807641633728;331.3174859788835;334.81752444917515;338.2541496001317;5683.431656834315;5695.408589091963;5707.601637598784;5713.914291285629;5714.8857022859565;5631.436856314366;5636.4927156555905;5636.887262254752;5656.010198215306;5725.255716756816;4121.319982202933;4230.873073807776;4332.263515202423;4356.97821510892;4357.607815296623;4318.784060796963;4334.97832510837;4368.432103826498;4395.230834603947;4404.537523560028;4386.363977223301;4403.229434848905;4418.9394545309215;4425.8450954216605;4426.62373698236;4325.826966921335;4362.672799540047;4365.650747940157;4369.257226271541;4375.365571992043;3766.1714422826935;3777.660010599059;3800.220954704279;3809.7904615246152;3829.48301979232;5522.585806064561;5544.7227638618315;5587.441255874421;5619.887602247973;5619.915701264485;4904.411470623512;5047.974760126176;5051.646384753032;5079.4412614612365;5103.311053007871;5935.1987481690285;5956.702164891782;5959.374265702126;5963.582549221556;5988.371221021774;4259.190753756808;4271.765052922088;4301.505326887385;4305.677074219415;4310.073334233123;5996.8500787480225;6142.600730952474;6152.230971128653;6189.938100619026;6200.720967556471;4323;4326.935095973563;4351.042770590465;4366.825326986885;4369.43197384338;4425.336199570026;4425.933610995838;4430.335449682509;4433.623142032899;4441.955580444219;4904.754762261872;5002.499750024968;5021.171506701427;5027.044861476308;5029.5221953914315;5963.373845746134;5994.190784244159;6013.308469525973;6013.579049466583;6023.0965355196195;1434.2040167707023;1459.569427019032;1479.34169294665;1485.1089346392293;1489.4042383046651;966.40566051879;973.5181085362649;996.2080146283722;1026.6047571684805;1047.6699839550517;5683.715814209273;5737.684427356452;5755.59710820247;5758.596898217084;5774.653520788766;5959.880802383928;5992.880142397127;6015.218021657244;6034.530145166546;6083.239595050619;5623.6906970116215;5688.886222275614;5925.318588362307;5936.910946335808;5948.494377977834;3301.6203136639115;3305.272839975202;3313.718333941642;3315.8342082896243;3329.217633856042;6096.573239873255;6324;6345.1434056401795;6363.236411630634;6386.552941294158;6257.74969001244;6323.557350985387;6360.427561519486;6361.809145725636;6370.55406121567;6015.909761353583;6276.560640755195;6356.364363563606;6359.583358323807;6408.903866442007;6145.8156255312415;6211.2857021443115;6215.296346089465;6227.875442491216;6239.4696450800375;6131.325554188947;6142.754289828536;6152.78465253714;6155.415235552616;6160.443415982496;6240.753328801718;6282.497400207881;6293.276273228455;6310.716017779119;6345.17512723343;4283.436545660874;4291.82832686689;4296.742195468282;4313.051128751669;4319.006628475406;6029.246344206974;6198.72105755233;6258.405451482102;6259.906101408392;6268.996960486483;5960.122561393321;5969.940300596939;5973.940260597512;5998.7300571473515;6003.969980150246;5908.556858235564;5989.3112292085225;6004.819855404345;6011.789587364421;6092.258483682449;5829;5889.763149738603;6034.426729460694;6046.939530604814;6063.6664983426335;6105.084237364254;6120;6124.846878828065;6132.509399247961;6136.895358835274;5812.959650168886;5946.524278057832;5955.851103722442;5969.403059693996;5981.431763982415 13:28:30 INFO - PROCESS | 22388 | |5;yui.html;706.4101475268151;760.2397602397602;785.320697596579;789.2856964447174;881.8280435315114;15688.764668529968;16749.162541872887;17168.74246886296;17245.396411125614;17282.30870765168;16243.918780406082;17091.05999170045;17125.82874171258;17163.227654755534;17202.741958870625;673.5857447669697;815.2133191470215;825.3108654273689;825.6202147012382;826;809.1948511231303;821.8561751693429;822.8560001999626;825.5129473610568;828.0601517277903;851.6337974670889;855.6406309350057;856.618804631939;856.9742907712747;858.8754630578562;835.1815221083373;842.2419822160043;844.472204871955;846.8983721953343;849.0066622052213;620.2494981072907;620.7548018532655;621.1986537366837;622.5610944284268;623.2427600465456;16257.674846503121;16301.266443010092;16318;16318.102504362374;16319.755203671955;15408.980437467642;15474.68465180461;15596.766048509167;15634.843651563453;15716.29276682552;12096.092793040469;12150.635480935585;12279.324637144953;12382.380880955916;12493.312867792269;4009.719319647626;4092.0997380576227;4138.048248902769;4169.937450938239;4171.3325867860995;82213.17786822114;82428.64213826082;83621;86619.13380866173;87045;12107.697307567381;12204.816927746091;12260.816087758512;12294.75410491785;12330.691732706755;21040.684389734168;22349.329520114097;22447.102115915506;22482.55034899293;22550.436239093826;8983.46099234035;9181.311401644904;9266.44401335922;9424.623015079456;9601.279904007228;4910;4951.405831300267;4980.726060066731;5060.240963855377;5231.267622532772;3521.771084879526;3627.9455808162897;3632.7457078004286;3655.798931058764;3662.377395842713;620.4106099205773;624.5934929075327;635.0569404434411;636.5671343486474;636.6975686548852;720.5496564647095;743.0711610486892;760.3347071312602;776.3905334312537;804.2279411764655;10483.318584291997;10558.947205263925;10561.841572376421;10866.511007004545;11237.775244495064;686.5537400689592;733.7725305155419;776.3595034096779;793.7579038393345;805.64551597297;5097;5199.688018718889;5211.557017653542;5249.501297376743;5357.812476563302;75925.24074759292;107324.46337768261;128034;128715.35642321916;131207;67629;96939.51530242304;98278.5086074565;101240;104671.4766426163;59521.10718339142;59531.40468595345;65707.67146164239;92798.53600732089;93624.53187734153;9791.706248812547;9937.503124843584;9992.10071093605;10088.142507886618;10089.243306751876;56147;56386;56575;57785;57894.4210557889;77039.22960770321;78069.21930780847;82949.58525207336;83155;84544;11556.306621602731;11875.168738188244;12511.311877846805;12709;12940.935295323463;14272.21502817355;14406;14612.561623151323;15349.386024559339;15436.845631543541;13720.176789392668;13726.245056521988;13782.310884455937;13820.723585528032;13835.584932452042;12912.818829660824;13498.46006159782;13553.796693049415;13634.454621815017;13837.377318020512;13300.268485233406;13530.864691352961;13802.378892950042;13857;13932.442702292201;10006.149477294512;10093.343932644355;10206.92954826372;10258.487075646039;10704.30422022566;9812.65655702047;10333.84499232497;10796.622118225825;10796.946015269874;10901.945490272497 13:28:30 INFO - PROCESS | 22388 | __end_tp_report 13:28:30 INFO - PROCESS | 22388 | __start_cc_report 13:28:30 INFO - PROCESS | 22388 | _x_x_mozilla_cycle_collect,364 13:28:30 INFO - PROCESS | 22388 | __end_cc_report 13:28:30 INFO - PROCESS | 22388 | __startTimestamp1468096110875__endTimestamp 13:28:30 INFO - PROCESS | 22388 | 13:28:30 INFO - PROCESS | 22388 | ------- Summary: start ------- 13:28:30 INFO - PROCESS | 22388 | Number of tests: 6 13:28:30 INFO - PROCESS | 22388 | 13:28:30 INFO - PROCESS | 22388 | [#0] dojo.html Cycles:165 Average:5363.27 Median:5598.86 stddev:737.86 (13.2%) stddev-sans-first:716.95 13:28:30 INFO - PROCESS | 22388 | Values: 3024.6 3047.9 3061.7 3079.1 3089.8 5308.4 5342.4 5368.0 5394.2 5434.2 5268.8 5342.0 5407.2 5440.2 5475.0 4923.8 4928.3 5002.7 5089.4 5091.3 170.4 4969.4 5005.1 5071.3 5120.4 4770.0 4937.3 4953.8 4999.6 5028.6 4996.9 5034.7 5039.1 5065.0 5079.8 4853.7 4885.3 4942.6 5015.0 5018.8 5372.2 5432.3 5462.8 5465.0 5480.3 5814.2 5830.4 5835.3 5841.5 5869.6 5666.1 5814.1 5819.2 5852.8 5860.4 5470.3 5499.3 5502.3 5503.2 5508.0 5691.2 6008.3 6012.4 6014.2 6018.0 5662.9 5731.5 5741.0 5755.6 5770.2 5805.3 5823.1 5824.8 5826.7 5839.5 5598.9 5702.5 5728.2 5729.7 5729.9 5781.4 5824.6 5831.8 5834.2 5893.9 4426.9 4427.6 4433.6 4441.8 4445.6 3838.1 3912.9 3934.8 3956.1 4022.6 5285.6 5326.9 5378.1 5408.8 5619.2 5656.5 5695.0 5697.8 5699.8 5717.4 5434.3 5447.6 5456.3 5505.6 5513.1 4958.3 5008.8 5026.0 5033.6 5036.3 5974.8 5992.5 5992.9 5999.7 6021.0 5649.4 5790.1 5855.7 5869.8 5873.5 5976.1 5978.2 5986.2 6006.6 6063.7 5688.3 5695.8 5704.1 5711.0 5719.2 5550.8 5784.5 5817.0 5835.6 5868.0 5750.9 5762.3 5763.6 5765.2 5792.2 5651.5 5689.6 5697.5 5697.9 5713.4 5494.8 5537.4 5606.6 5625.8 5687.2 5657.7 5673.2 5683.6 5714.6 5723.4 5579.6 5588.0 5590.0 5590.7 5598.2 13:28:30 INFO - PROCESS | 22388 | 13:28:30 INFO - PROCESS | 22388 | [#1] ext.html Cycles:180 Average:58832.00 Median:40512.00 stddev:116034.26 (286.4%) stddev-sans-first:116277.28 13:28:30 INFO - PROCESS | 22388 | Values: 558.3 579.8 588.9 610.0 629.3 39872.4 44555.1 44657.1 44658.3 44672.1 44653.8 45068.5 45151.1 45254.3 45479.0 8987.6 9066.2 9090.4 9126.4 9130.0 8975.9 9023.4 9095.2 9122.3 9124.1 9072.5 9146.6 9148.7 9173.0 9199.0 9094.0 9098.7 9102.5 9125.2 9158.0 9089.6 9109.0 9138.2 9162.9 9164.2 34531.7 43848.0 44255.0 44256.0 44272.8 3293.5 3312.1 3608.7 3613.4 3616.2 31682.8 32436.2 32470.0 32579.7 32873.2 4247.2 4326.1 4342.2 4457.2 4461.0 335166.0 335848.0 337076.0 338221.3 338597.0 33155.2 37638.8 38604.0 38604.8 38630.8 38136.6 38182.4 38236.6 38254.6 38281.4 15629.4 15735.2 15754.3 15781.6 15791.0 13032.0 13056.7 13160.0 13163.8 13166.8 8506.9 8550.6 8591.5 8594.5 8649.3 3202.6 3231.5 3241.1 3247.4 3260.6 1011.3 1119.7 1134.4 1152.0 1152.7 35523.0 37209.4 37633.4 38049.6 38101.0 1127.3 1129.1 1160.1 1202.3 1219.3 17582.7 18462.5 18513.8 18533.5 18562.8 543160.0 549849.0 552613.0 556765.0 556794.0 62805.4 62908.4 63251.4 63487.4 63638.0 1348.7 1357.7 1384.7 1403.8 1404.1 33392.7 34464.7 34931.5 35022.8 35041.0 55561.7 55943.0 56466.2 56514.0 56579.0 391035.0 394148.0 394861.0 395763.0 396220.0 29634.9 29705.9 30203.0 30326.4 30355.5 52383.0 52707.0 52927.7 53321.7 53855.7 44370.8 44505.9 44956.0 44986.1 45411.5 44098.3 44430.0 44560.9 45451.8 45454.8 44107.0 44332.3 44476.0 44912.3 46766.5 37907.6 39469.6 39876.4 40283.0 40741.0 29933.7 30408.0 30619.2 30678.1 30732.8 13:28:30 INFO - PROCESS | 22388 | 13:28:30 INFO - PROCESS | 22388 | [#2] jquery.html Cycles:180 Average:31234.99 Median:20971.92 stddev:82586.19 (393.8%) stddev-sans-first:82785.39 13:28:30 INFO - PROCESS | 22388 | Values: 387.9 388.6 391.8 393.4 419.0 16786.7 20221.5 20557.3 21358.0 21450.7 19786.9 19837.4 20748.9 20788.0 20905.6 5013.1 5265.2 5274.4 5345.8 5384.3 5190.9 5302.4 5535.6 5736.6 5743.5 5663.2 5700.8 5704.6 5723.3 5732.2 5773.7 5848.9 5886.1 5886.9 5935.6 5167.7 5225.3 5249.7 5250.8 5360.2 13713.9 13998.7 14074.6 14108.4 26059.4 2679.7 2706.8 2868.2 2896.3 3069.2 15958.2 16307.2 16431.7 16695.4 16732.8 2048.5 2076.3 2083.5 2128.6 2138.7 92220.0 102332.5 103655.5 104102.0 105487.5 18193.7 18725.6 18963.2 19107.3 19109.0 11705.5 12209.1 12319.2 34107.0 34222.3 7902.7 7948.2 8001.5 8064.5 8255.4 8164.2 8228.5 8362.1 8537.9 8613.7 4060.7 4100.9 4172.2 4204.9 4242.3 1911.5 1911.6 1927.5 1957.3 1958.2 981.6 1015.7 1022.9 1031.9 1051.9 21038.3 21212.9 21230.4 21329.4 21383.5 1007.2 1026.0 1026.7 1030.3 1085.6 11244.9 11765.4 11817.2 11911.2 11931.9 487828.0 488077.0 498826.0 501593.0 506234.0 101655.5 105353.5 106332.0 107369.0 107964.5 1006.9 1011.7 1020.5 1023.3 1028.6 18419.8 18627.4 18987.6 19033.3 19051.0 45947.0 46022.5 46268.0 47123.8 47518.5 64923.0 65729.0 65885.7 66368.3 69444.0 8718.5 9121.5 9168.8 9255.7 9496.8 13390.5 13951.8 14470.6 14566.4 14609.1 13060.1 13177.2 13187.3 13227.2 13373.8 12623.4 13028.0 13095.9 13114.6 13150.7 12392.2 12791.2 13167.3 13360.6 13526.0 7876.4 8226.4 8992.6 9118.4 9137.7 12836.4 12939.2 12997.6 13070.4 13176.9 13:28:30 INFO - PROCESS | 22388 | 13:28:30 INFO - PROCESS | 22388 | [#3] mootools.html Cycles:180 Average:5847.30 Median:4862.01 stddev:3291.99 (67.7%) stddev-sans-first:3284.99 13:28:30 INFO - PROCESS | 22388 | Values: 1497.4 1515.7 1665.5 1767.3 1779.8 7740.8 8388.4 8493.1 8924.3 8952.1 8600.0 8824.9 8850.3 8878.7 8919.3 2342.8 2355.7 2363.2 2369.5 2373.2 2320.0 2355.9 2359.3 2362.1 2369.5 2327.2 2333.8 2337.1 2381.3 2385.2 2284.6 2302.0 2311.1 2312.6 2322.2 2241.4 2243.5 2254.8 2259.0 2260.2 8864.7 8890.4 8965.1 8980.7 8988.4 5261.6 5367.2 5368.1 5369.5 5370.7 3421.4 3477.3 3542.5 3558.9 3614.0 1184.5 1214.9 1250.0 1261.1 1268.1 12176.8 12318.5 12336.3 12337.0 12353.4 4489.9 4700.6 4723.6 4800.4 4811.8 10366.4 10474.9 10488.0 10498.2 10532.7 5331.0 5355.4 5368.6 5368.9 5373.0 4340.6 4775.6 4912.2 4944.4 4947.6 4001.8 4033.4 4060.4 4073.7 4121.7 1309.8 1311.3 1325.2 1330.2 1340.0 908.3 1021.5 1032.6 1038.6 1049.4 5757.1 5844.1 5945.6 5965.3 6014.5 469.2 479.0 492.7 494.2 499.4 4385.6 4397.4 4402.0 4420.4 4421.3 10532.9 10969.7 11035.2 11041.1 11062.6 10136.7 10590.8 10975.1 10991.3 11012.4 7672.4 7844.6 7846.1 7903.6 7914.6 5956.6 6247.2 6283.9 6305.3 6311.2 9767.9 9792.9 9804.3 9858.9 9913.4 9774.6 9896.4 10044.9 10136.6 10173.8 7613.5 7883.7 7946.4 7978.9 8138.1 8803.8 8821.7 8835.8 8844.5 8886.8 7747.2 7986.2 8018.7 8043.4 8099.2 7780.3 7944.4 7961.0 8067.5 8088.1 7072.8 7176.1 7188.5 7271.4 7281.9 5247.3 5252.9 5512.4 5515.8 5538.8 5001.8 5091.7 5165.4 5207.9 5486.8 13:28:30 INFO - PROCESS | 22388 | 13:28:30 INFO - PROCESS | 22388 | [#4] prototype.html Cycles:180 Average:5031.76 Median:5746.64 stddev:1502.71 (26.1%) stddev-sans-first:1464.88 13:28:30 INFO - PROCESS | 22388 | Values: 329.0 329.4 331.3 334.8 338.3 5683.4 5695.4 5707.6 5713.9 5714.9 5631.4 5636.5 5636.9 5656.0 5725.3 4121.3 4230.9 4332.3 4357.0 4357.6 4318.8 4335.0 4368.4 4395.2 4404.5 4386.4 4403.2 4418.9 4425.8 4426.6 4325.8 4362.7 4365.7 4369.3 4375.4 3766.2 3777.7 3800.2 3809.8 3829.5 5522.6 5544.7 5587.4 5619.9 5619.9 4904.4 5048.0 5051.6 5079.4 5103.3 5935.2 5956.7 5959.4 5963.6 5988.4 4259.2 4271.8 4301.5 4305.7 4310.1 5996.9 6142.6 6152.2 6189.9 6200.7 4323.0 4326.9 4351.0 4366.8 4369.4 4425.3 4425.9 4430.3 4433.6 4442.0 4904.8 5002.5 5021.2 5027.0 5029.5 5963.4 5994.2 6013.3 6013.6 6023.1 1434.2 1459.6 1479.3 1485.1 1489.4 966.4 973.5 996.2 1026.6 1047.7 5683.7 5737.7 5755.6 5758.6 5774.7 5959.9 5992.9 6015.2 6034.5 6083.2 5623.7 5688.9 5925.3 5936.9 5948.5 3301.6 3305.3 3313.7 3315.8 3329.2 6096.6 6324.0 6345.1 6363.2 6386.6 6257.7 6323.6 6360.4 6361.8 6370.6 6015.9 6276.6 6356.4 6359.6 6408.9 6145.8 6211.3 6215.3 6227.9 6239.5 6131.3 6142.8 6152.8 6155.4 6160.4 6240.8 6282.5 6293.3 6310.7 6345.2 4283.4 4291.8 4296.7 4313.1 4319.0 6029.2 6198.7 6258.4 6259.9 6269.0 5960.1 5969.9 5973.9 5998.7 6004.0 5908.6 5989.3 6004.8 6011.8 6092.3 5829.0 5889.8 6034.4 6046.9 6063.7 6105.1 6120.0 6124.8 6132.5 6136.9 5813.0 5946.5 5955.9 5969.4 5981.4 13:28:30 INFO - PROCESS | 22388 | 13:28:30 INFO - PROCESS | 22388 | [#5] yui.html Cycles:180 Average:21133.75 Median:4170.64 stddev:30134.40 (722.5%) stddev-sans-first:30179.90 13:28:30 INFO - PROCESS | 22388 | Values: 706.4 760.2 785.3 789.3 881.8 15688.8 16749.2 17168.7 17245.4 17282.3 16243.9 17091.1 17125.8 17163.2 17202.7 673.6 815.2 825.3 825.6 826.0 809.2 821.9 822.9 825.5 828.1 851.6 855.6 856.6 857.0 858.9 835.2 842.2 844.5 846.9 849.0 620.2 620.8 621.2 622.6 623.2 16257.7 16301.3 16318.0 16318.1 16319.8 15409.0 15474.7 15596.8 15634.8 15716.3 12096.1 12150.6 12279.3 12382.4 12493.3 4009.7 4092.1 4138.0 4169.9 4171.3 82213.2 82428.6 83621.0 86619.1 87045.0 12107.7 12204.8 12260.8 12294.8 12330.7 21040.7 22349.3 22447.1 22482.6 22550.4 8983.5 9181.3 9266.4 9424.6 9601.3 4910.0 4951.4 4980.7 5060.2 5231.3 3521.8 3627.9 3632.7 3655.8 3662.4 620.4 624.6 635.1 636.6 636.7 720.5 743.1 760.3 776.4 804.2 10483.3 10558.9 10561.8 10866.5 11237.8 686.6 733.8 776.4 793.8 805.6 5097.0 5199.7 5211.6 5249.5 5357.8 75925.2 107324.5 128034.0 128715.4 131207.0 67629.0 96939.5 98278.5 101240.0 104671.5 59521.1 59531.4 65707.7 92798.5 93624.5 9791.7 9937.5 9992.1 10088.1 10089.2 56147.0 56386.0 56575.0 57785.0 57894.4 77039.2 78069.2 82949.6 83155.0 84544.0 11556.3 11875.2 12511.3 12709.0 12940.9 14272.2 14406.0 14612.6 15349.4 15436.8 13720.2 13726.2 13782.3 13820.7 13835.6 12912.8 13498.5 13553.8 13634.5 13837.4 13300.3 13530.9 13802.4 13857.0 13932.4 10006.1 10093.3 10206.9 10258.5 10704.3 9812.7 10333.8 10796.6 10796.9 10901.9 13:28:30 INFO - PROCESS | 22388 | -------- Summary: end -------- 13:28:30 INFO - PROCESS | 22388 | 13:28:31 INFO - TEST-INFO | 22388: exit 0 13:28:31 INFO - TEST-OK | dromaeo_css | took 1109895ms 13:28:31 INFO - TEST-START | kraken 13:28:31 INFO - operating with platform_type : linux_ 13:28:31 INFO - Initialising browser for kraken test... 13:28:31 INFO - TEST-INFO | started process 22638 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6B_1e3/profile http://localhost:40727/getInfo.html) 13:28:36 INFO - PROCESS | 22638 | __metrics Screen width/height:1600/1200 13:28:36 INFO - PROCESS | 22638 | colorDepth:24 13:28:36 INFO - PROCESS | 22638 | Browser inner width/height: 1024/697 13:28:36 INFO - PROCESS | 22638 | __metrics 13:28:36 ERROR - PROCESS | 22638 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 13:28:37 INFO - TEST-INFO | 22638: exit 0 13:28:37 INFO - Browser initialized. 13:28:37 INFO - Running cycle 1/1 for kraken test... 13:28:37 INFO - TEST-INFO | started process 22759 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6B_1e3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:28:49 INFO - PROCESS | 22759 | RSS: Main: 167854080 13:28:49 INFO - PROCESS | 22759 | 13:28:51 INFO - PROCESS | 22759 | Cycle 1(1): loaded http://localhost:40727/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40727/tests/kraken/driver.html?testName=audio-beat-detection) 13:28:52 INFO - PROCESS | 22759 | RSS: Main: 173305856 13:28:52 INFO - PROCESS | 22759 | 13:28:55 INFO - PROCESS | 22759 | Cycle 1(1): loaded http://localhost:40727/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40727/tests/kraken/driver.html?testName=audio-dft) 13:28:55 INFO - PROCESS | 22759 | RSS: Main: 172544000 13:28:55 INFO - PROCESS | 22759 | 13:28:58 INFO - PROCESS | 22759 | Cycle 1(1): loaded http://localhost:40727/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40727/tests/kraken/driver.html?testName=audio-fft) 13:28:59 INFO - PROCESS | 22759 | RSS: Main: 167731200 13:28:59 INFO - PROCESS | 22759 | 13:29:01 INFO - PROCESS | 22759 | Cycle 1(1): loaded http://localhost:40727/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40727/tests/kraken/driver.html?testName=audio-oscillator) 13:29:02 INFO - PROCESS | 22759 | RSS: Main: 168173568 13:29:02 INFO - PROCESS | 22759 | 13:29:04 INFO - PROCESS | 22759 | Cycle 1(1): loaded http://localhost:40727/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40727/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:29:04 INFO - PROCESS | 22759 | RSS: Main: 168439808 13:29:04 INFO - PROCESS | 22759 | 13:29:08 INFO - PROCESS | 22759 | Cycle 1(1): loaded http://localhost:40727/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40727/tests/kraken/driver.html?testName=imaging-darkroom) 13:29:08 INFO - PROCESS | 22759 | RSS: Main: 169144320 13:29:08 INFO - PROCESS | 22759 | 13:29:12 INFO - PROCESS | 22759 | Cycle 1(1): loaded http://localhost:40727/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40727/tests/kraken/driver.html?testName=imaging-desaturate) 13:29:12 INFO - PROCESS | 22759 | RSS: Main: 166612992 13:29:12 INFO - PROCESS | 22759 | 13:29:15 INFO - PROCESS | 22759 | Cycle 1(1): loaded http://localhost:40727/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40727/tests/kraken/driver.html?testName=json-parse-financial) 13:29:16 INFO - PROCESS | 22759 | RSS: Main: 167256064 13:29:16 INFO - PROCESS | 22759 | 13:29:17 INFO - PROCESS | 22759 | Cycle 1(1): loaded http://localhost:40727/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40727/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:29:18 INFO - PROCESS | 22759 | RSS: Main: 167579648 13:29:18 INFO - PROCESS | 22759 | 13:29:20 INFO - PROCESS | 22759 | Cycle 1(1): loaded http://localhost:40727/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40727/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:29:20 INFO - PROCESS | 22759 | RSS: Main: 168112128 13:29:20 INFO - PROCESS | 22759 | 13:29:23 INFO - PROCESS | 22759 | Cycle 1(1): loaded http://localhost:40727/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40727/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:29:23 INFO - PROCESS | 22759 | RSS: Main: 168353792 13:29:23 INFO - PROCESS | 22759 | 13:29:26 INFO - PROCESS | 22759 | Cycle 1(1): loaded http://localhost:40727/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40727/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:29:26 INFO - PROCESS | 22759 | RSS: Main: 168599552 13:29:26 INFO - PROCESS | 22759 | 13:29:29 INFO - PROCESS | 22759 | Cycle 1(1): loaded http://localhost:40727/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40727/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:29:30 INFO - PROCESS | 22759 | RSS: Main: 168472576 13:29:30 INFO - PROCESS | 22759 | 13:29:32 INFO - PROCESS | 22759 | Cycle 1(1): loaded http://localhost:40727/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40727/tests/kraken/driver.html?testName=ai-astar) 13:29:32 INFO - PROCESS | 22759 | RSS: Main: 168845312 13:29:32 INFO - PROCESS | 22759 | 13:29:32 INFO - PROCESS | 22759 | __start_tp_report 13:29:32 INFO - PROCESS | 22759 | _x_x_mozilla_page_load 13:29:32 INFO - PROCESS | 22759 | _x_x_mozilla_page_load_details 13:29:32 INFO - PROCESS | 22759 | |i|pagename|runs| 13:29:32 INFO - PROCESS | 22759 | |0;ai-astar;101;111;106;111;114;113;114;111;113;110 13:29:32 INFO - PROCESS | 22759 | |1;audio-beat-detection;157;116;141;179;118;149;155;126;185;117 13:29:32 INFO - PROCESS | 22759 | |2;audio-dft;164;162;161;162;163;164;169;165;162;162 13:29:32 INFO - PROCESS | 22759 | |3;audio-fft;75;75;75;167;77;76;81;75;184;76 13:29:32 INFO - PROCESS | 22759 | |4;audio-oscillator;84;84;143;84;85;88;143;85;85;147 13:29:32 INFO - PROCESS | 22759 | |5;imaging-gaussian-blur;117;117;117;118;118;117;118;118;118;118 13:29:32 INFO - PROCESS | 22759 | |6;imaging-darkroom;148;147;148;147;148;148;147;148;148;147 13:29:32 INFO - PROCESS | 22759 | |7;imaging-desaturate;96;97;96;97;96;96;96;96;96;97 13:29:32 INFO - PROCESS | 22759 | |8;json-parse-financial;57;56;58;55;56;59;55;55;55;58 13:29:32 INFO - PROCESS | 22759 | |9;json-stringify-tinderbox;62;62;61;61;62;62;62;61;62;61 13:29:32 INFO - PROCESS | 22759 | |10;stanford-crypto-aes;76;82;76;82;75;74;75;74;80;75 13:29:32 INFO - PROCESS | 22759 | |11;stanford-crypto-ccm;137;130;122;125;123;128;137;140;159;127 13:29:32 INFO - PROCESS | 22759 | |12;stanford-crypto-pbkdf2;164;167;161;162;170;166;162;164;163;163 13:29:32 INFO - PROCESS | 22759 | |13;stanford-crypto-sha256-iterative;65;66;65;67;67;63;69;67;67;63 13:29:32 INFO - PROCESS | 22759 | __end_tp_report 13:29:32 INFO - PROCESS | 22759 | __start_cc_report 13:29:32 INFO - PROCESS | 22759 | _x_x_mozilla_cycle_collect,896 13:29:32 INFO - PROCESS | 22759 | __end_cc_report 13:29:32 INFO - PROCESS | 22759 | __startTimestamp1468096172337__endTimestamp 13:29:32 INFO - PROCESS | 22759 | 13:29:32 INFO - PROCESS | 22759 | ------- Summary: start ------- 13:29:32 INFO - PROCESS | 22759 | Number of tests: 14 13:29:32 INFO - PROCESS | 22759 | 13:29:32 INFO - PROCESS | 22759 | [#0] ai-astar Cycles:10 Average:110.40 Median:112.00 stddev:4.06 (3.6%) stddev-sans-first:2.51 13:29:32 INFO - PROCESS | 22759 | Values: 101.0 111.0 106.0 111.0 114.0 113.0 114.0 111.0 113.0 110.0 13:29:32 INFO - PROCESS | 22759 | 13:29:32 INFO - PROCESS | 22759 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:152.00 stddev:25.26 (16.6%) stddev-sans-first:26.37 13:29:32 INFO - PROCESS | 22759 | Values: 157.0 116.0 141.0 179.0 118.0 149.0 155.0 126.0 185.0 117.0 13:29:32 INFO - PROCESS | 22759 | 13:29:32 INFO - PROCESS | 22759 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:2.32 (1.4%) stddev-sans-first:2.45 13:29:32 INFO - PROCESS | 22759 | Values: 164.0 162.0 161.0 162.0 163.0 164.0 169.0 165.0 162.0 162.0 13:29:32 INFO - PROCESS | 22759 | 13:29:32 INFO - PROCESS | 22759 | [#3] audio-fft Cycles:10 Average:96.10 Median:75.50 stddev:42.08 (55.7%) stddev-sans-first:43.93 13:29:32 INFO - PROCESS | 22759 | Values: 75.0 75.0 75.0 167.0 77.0 76.0 81.0 75.0 184.0 76.0 13:29:32 INFO - PROCESS | 22759 | 13:29:32 INFO - PROCESS | 22759 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:84.50 stddev:28.70 (34.0%) stddev-sans-first:29.63 13:29:32 INFO - PROCESS | 22759 | Values: 84.0 84.0 143.0 84.0 85.0 88.0 143.0 85.0 85.0 147.0 13:29:32 INFO - PROCESS | 22759 | 13:29:32 INFO - PROCESS | 22759 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 13:29:32 INFO - PROCESS | 22759 | Values: 117.0 117.0 117.0 118.0 118.0 117.0 118.0 118.0 118.0 118.0 13:29:32 INFO - PROCESS | 22759 | 13:29:32 INFO - PROCESS | 22759 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 13:29:32 INFO - PROCESS | 22759 | Values: 148.0 147.0 148.0 147.0 148.0 148.0 147.0 148.0 148.0 147.0 13:29:32 INFO - PROCESS | 22759 | 13:29:32 INFO - PROCESS | 22759 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 13:29:32 INFO - PROCESS | 22759 | Values: 96.0 97.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 97.0 13:29:32 INFO - PROCESS | 22759 | 13:29:32 INFO - PROCESS | 22759 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.50 stddev:1.51 (2.7%) stddev-sans-first:1.58 13:29:32 INFO - PROCESS | 22759 | Values: 57.0 56.0 58.0 55.0 56.0 59.0 55.0 55.0 55.0 58.0 13:29:32 INFO - PROCESS | 22759 | 13:29:32 INFO - PROCESS | 22759 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 13:29:32 INFO - PROCESS | 22759 | Values: 62.0 62.0 61.0 61.0 62.0 62.0 62.0 61.0 62.0 61.0 13:29:32 INFO - PROCESS | 22759 | 13:29:32 INFO - PROCESS | 22759 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:76.00 stddev:3.18 (4.2%) stddev-sans-first:3.35 13:29:32 INFO - PROCESS | 22759 | Values: 76.0 82.0 76.0 82.0 75.0 74.0 75.0 74.0 80.0 75.0 13:29:32 INFO - PROCESS | 22759 | 13:29:32 INFO - PROCESS | 22759 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:133.50 stddev:11.11 (8.3%) stddev-sans-first:11.68 13:29:32 INFO - PROCESS | 22759 | Values: 137.0 130.0 122.0 125.0 123.0 128.0 137.0 140.0 159.0 127.0 13:29:32 INFO - PROCESS | 22759 | 13:29:32 INFO - PROCESS | 22759 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.20 Median:164.00 stddev:2.74 (1.7%) stddev-sans-first:2.91 13:29:32 INFO - PROCESS | 22759 | Values: 164.0 167.0 161.0 162.0 170.0 166.0 162.0 164.0 163.0 163.0 13:29:32 INFO - PROCESS | 22759 | 13:29:32 INFO - PROCESS | 22759 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:67.00 stddev:1.91 (2.9%) stddev-sans-first:2.00 13:29:32 INFO - PROCESS | 22759 | Values: 65.0 66.0 65.0 67.0 67.0 63.0 69.0 67.0 67.0 63.0 13:29:32 INFO - PROCESS | 22759 | -------- Summary: end -------- 13:29:32 INFO - PROCESS | 22759 | 13:29:33 INFO - TEST-INFO | 22759: exit 0 13:29:33 INFO - TEST-OK | kraken | took 61665ms 13:29:33 INFO - SUITE-END | took 1171s 13:29:33 INFO - Completed test suite (00:19:31) 13:29:33 INFO - javascript benchmark 13:29:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7429.105807665049, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3024.561438591404, 3047.898396735606, 3061.7397521210696, 3079.076277116865, 3089.752819774417, 5308.416074231836, 5342.385625653046, 5367.973160134204, 5394.1908713692965, 5434.157705555635, 5268.789248430058, 5341.973290133554, 5407.161889907061, 5440.211169380437, 5474.972625136868, 4923.80304787808, 4928.260760885869, 5002.749862506878, 5089.3638295213095, 5091.338126043609, 170.38581180333549, 4969.4036715594, 5005.0990821652085, 5071.3407257056715, 5120.385553733558, 4770.0, 4937.308776771255, 4953.752312384385, 4999.600031997432, 5028.647994640377, 4996.900061998776, 5034.697918124924, 5039.09296326661, 5065.012322597095, 5079.79680812767, 4853.733044682541, 4885.291632713237, 4942.555170034678, 5014.974925125388, 5018.774155163026, 5372.247885296062, 5432.320959880015, 5462.808801691922, 5465.043617366945, 5480.26016487777, 5814.244148260699, 5830.387809280007, 5835.270591176103, 5841.474267315962, 5869.559783016291, 5666.121751128581, 5814.069748840166, 5819.156222347779, 5852.824415267549, 5860.413958604148, 5470.316210473691, 5499.340079190482, 5502.312210973629, 5503.2020357048405, 5508.03609368359, 5691.203231547586, 6008.279006519158, 6012.428819262163, 6014.18808460861, 6018.037114061729, 5662.85842853932, 5731.512821410227, 5741.0, 5755.625884317506, 5770.24986751728, 5805.332386775491, 5823.068309070529, 5824.767009319579, 5826.708664566755, 5839.474447299764, 5598.860028499239, 5702.45826646468, 5728.169415434739, 5729.742161602738, 5729.914051289234, 5781.392953739881, 5824.621399609012, 5831.766729330864, 5834.212381328552, 5893.941060589425, 4426.911461770811, 4427.645788336926, 4433.623142032963, 4441.777911104432, 4445.5776701213335, 3838.136419305634, 3912.921741565153, 3934.8229329680235, 3956.149427873021, 4022.577629348876, 5285.603579731535, 5326.92009619856, 5378.058839703036, 5408.810691625774, 5619.157126430986, 5656.519195868315, 5694.971525142348, 5697.829065128053, 5699.772009119672, 5717.42825717425, 5434.347878254634, 5447.618666693373, 5456.290682211287, 5505.614606977553, 5513.09034009392, 4958.281049247911, 5008.774605142778, 5025.974870125626, 5033.597312215014, 5036.294918711384, 5974.761009559656, 5992.490638295793, 5992.940070599326, 5999.670018149044, 6020.969895150496, 5649.350324712711, 5790.131480277992, 5855.736491857791, 5869.765209391577, 5873.530117590497, 5976.133460648269, 5978.192943952511, 5986.16193732869, 6006.639601623917, 6063.696815159313, 5688.317401911797, 5695.772169113189, 5704.0588302929555, 5711.029125048669, 5719.170720245625, 5550.8057217997175, 5784.479396854304, 5817.040188368872, 5835.56233282514, 5868.031774757117, 5750.942490575041, 5762.30852297727, 5763.5965482417505, 5765.164051212467, 5792.21805056312, 5651.519620832275, 5689.630174038674, 5697.4872261495, 5697.914531281951, 5713.428657134254, 5494.835154945358, 5537.446255374431, 5606.607537472338, 5625.774969001194, 5687.20379146928, 5657.660540367591, 5673.234113394639, 5683.60214784961, 5714.571407144397, 5723.399043100415, 5579.553635709052, 5587.972060139836, 5590.049691552527, 5590.748416321194, 5598.188262701967], "value": 5315.525818315318, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.2794579193242, 579.8086631411634, 588.926384201975, 610.0178712273241, 629.28261781569, 39872.40191397128, 44555.108897822065, 44657.106857862906, 44658.33012504811, 44672.10655786882, 44653.77673111638, 45068.54931450685, 45151.09697806042, 45254.32118518225, 45479.0, 8987.640494380234, 9066.18404343609, 9090.409123406956, 9126.406783559047, 9130.04134565871, 8975.865362019542, 9023.413478123934, 9095.181433670969, 9122.315826313019, 9124.133207345325, 9072.455652660828, 9146.634134634607, 9148.725538233864, 9173.0, 9199.0, 9094.0, 9098.681546145886, 9102.544872756402, 9125.17873391398, 9157.95421022894, 9089.590968406437, 9108.954455227748, 9138.17756401927, 9162.908370916339, 9164.221041211506, 34531.719486648726, 43848.0, 44255.0, 44256.0, 44272.77863610694, 3293.489509126089, 3312.138843900579, 3608.675219230282, 3613.403788374915, 3616.222512159872, 31682.841585792154, 32436.18909527257, 32470.0, 32579.674203257902, 32873.17817054593, 4247.171801498709, 4326.113146804897, 4342.2401079811225, 4457.175422546807, 4461.0, 335166.0, 335848.0, 337076.0, 338221.3088934564, 338597.0, 33155.171120721694, 37638.81180594079, 38604.0, 38604.80697596494, 38630.80684596615, 38136.618633813865, 38182.42726359107, 38236.617633823305, 38254.61745382566, 38281.425778613346, 15629.3748250071, 15735.213239337987, 15754.291056902466, 15781.605459863365, 15791.0, 13032.0, 13056.673583160496, 13160.0, 13163.802542961863, 13166.802497962539, 8506.914930850737, 8550.572471376407, 8591.484510929364, 8594.527300998505, 8649.264812490883, 3202.551642770014, 3231.4991176367703, 3241.1410976090883, 3247.350529894031, 3260.6087269527334, 1011.312307630818, 1119.652907598647, 1134.3987686526154, 1151.9596814111467, 1152.6657269391783, 35523.0, 37209.44185837215, 37633.435498467545, 38049.61950380516, 38101.0, 1127.3067063755732, 1129.0797999630274, 1160.1414952934936, 1202.326697049655, 1219.3110892345796, 17582.65929473396, 18462.538436539195, 18513.81486185148, 18533.53666158357, 18562.814371856108, 543160.0, 549849.0, 552613.0, 556765.0, 556794.0, 62805.37194627995, 62908.37091629117, 63251.36748632547, 63487.365126348144, 63638.0454293186, 1348.6763176837685, 1357.6537982814516, 1384.6884450998446, 1403.8245219347582, 1404.0522647213295, 33392.66607333896, 34464.65535344614, 34931.47602785909, 35022.82488587541, 35041.0, 55561.722191388784, 55943.0, 56466.153007704095, 56514.0, 56579.0, 391035.0, 394148.0, 394861.0, 395763.0, 396220.0, 29634.851825740734, 29705.85147074251, 30203.0, 30326.393472129992, 30355.544666829574, 52383.0, 52707.0, 52927.735361324485, 53321.7333913328, 53855.73072134614, 44370.77814610906, 44505.88735281644, 44956.0, 44986.10027799491, 45411.545884540734, 44098.33852492151, 44430.0, 44560.88597785081, 45451.77274113608, 45454.77272613748, 44107.0, 44332.33501497545, 44476.0, 44912.32631510595, 46766.53233467758, 37907.62092379041, 39469.60530394659, 39876.401853971634, 40283.0, 40741.0, 29933.70066299309, 30408.0, 30619.2345191372, 30678.079657610306, 30732.84633576818], "value": 19426.977418663013, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.87781848717634, 388.5512233370458, 391.7531954868433, 393.44720667462224, 418.98114584843677, 16786.748198776997, 20221.494462638442, 20557.280495182673, 21358.0, 21450.678239826415, 19786.901065494687, 19837.404877853653, 20748.896255518703, 20788.0, 20905.581888362223, 5013.097642424371, 5265.157574788034, 5274.4198138204765, 5345.812896548621, 5384.300040994684, 5190.948090519084, 5302.443243459439, 5535.640183388087, 5736.569757268201, 5743.54051675865, 5663.150527420899, 5700.7719691212305, 5704.629199102066, 5723.2559767230205, 5732.197492351053, 5773.682447465388, 5848.941510584882, 5886.117082437647, 5886.852828679274, 5935.6141850779995, 5167.741612919339, 5225.268462415227, 5249.711265880375, 5250.7637156328055, 5360.2227676987, 13713.862861371359, 13998.650033749238, 14074.648133796736, 14108.365123569463, 26059.436433813844, 2679.6516452861, 2706.8375897446217, 2868.18256796814, 2896.2904088498453, 3069.155982104917, 15958.202089895574, 16307.184640768033, 16431.671366572722, 16695.41566045195, 16732.832671673248, 2048.539078707294, 2076.2940600195857, 2083.479130217446, 2128.648772952461, 2138.689889965962, 92220.0, 102332.48833755858, 103655.4817225909, 104102.0, 105487.47256263746, 18193.7270940936, 18725.625487490175, 18963.241470341032, 19107.331243406414, 19109.0, 11705.473253703603, 12209.145359824905, 12319.199252048587, 34107.0, 34222.315553688786, 7902.7234046809235, 7948.244916732901, 8001.519908805491, 8064.475809072392, 8255.42212045151, 8164.224398682116, 8228.50628962264, 8362.080171181165, 8537.943678353411, 8613.741587752378, 4060.6548443382053, 4100.872260128429, 4172.165566886635, 4204.852830150991, 4242.342436922282, 1911.4934542346289, 1911.5985643014844, 1927.5470264487835, 1957.2758079510388, 1958.1677786940493, 981.5730157381562, 1015.6546774096843, 1022.867027286448, 1031.8916513766096, 1051.9211059170593, 21038.263660771798, 21212.893935530225, 21230.36308910735, 21329.360119196448, 21383.46541336448, 1007.1741172238841, 1025.958961641541, 1026.7330494071596, 1030.299396410448, 1085.6037546295545, 11244.943775281072, 11765.411729413496, 11817.172797904235, 11911.225770325074, 11931.880681193077, 487828.0, 488077.0, 498826.0, 501593.0, 506234.0, 101655.49172254092, 105353.47323263335, 106332.0, 107369.0, 107964.46017769861, 1006.8892421833592, 1011.7420057885192, 1020.5203554329453, 1023.2632504596827, 1028.5577201803296, 18419.81580184181, 18627.441176764718, 18987.62024759525, 19033.333833316323, 19051.0, 45947.0, 46022.53977460317, 46268.0, 47123.764381179244, 47518.52481475141, 64923.0, 65729.0, 65885.67057164683, 66368.33631663621, 69444.0, 8718.476891386537, 9121.4666161305, 9168.816623667622, 9255.67605133844, 9496.762580935532, 13390.464381425023, 13951.790723138958, 14470.565883023526, 14566.41734330615, 14609.123452592878, 13060.085793994329, 13177.209367437985, 13187.340632968506, 13227.206367617973, 13373.799393008918, 12623.431945562288, 13027.957763378718, 13095.934520327337, 13114.60656180316, 13150.736985260433, 12392.194507356993, 12791.168574042658, 13167.275799830719, 13360.599182024165, 13526.0, 7876.448648594773, 8226.42415030966, 8992.640294388151, 9118.361714679908, 9137.680181193626, 12836.358182090671, 12939.223646581235, 12997.610071697864, 13070.411831467416, 13176.868231317947], "value": 9929.449183281227, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1497.44594500035, 1515.6892836968423, 1665.4837000529837, 1767.3372485318005, 1779.8042215356309, 7740.845183096335, 8388.412811103217, 8493.065762766091, 8924.28605711543, 8952.060033696465, 8599.957000215007, 8824.91175088249, 8850.291976641869, 8878.689245876396, 8919.286457083434, 2342.816877476876, 2355.693759811222, 2363.1728894886824, 2369.5379401016808, 2373.2405630198346, 2319.965200521985, 2355.9411014724596, 2359.304005318427, 2362.14962613459, 2369.4668699542635, 2327.185485080225, 2333.8249631277636, 2337.100216416675, 2381.3094202681286, 2385.2009576791797, 2284.6001949658744, 2301.976980230201, 2311.06401907227, 2312.6415405612156, 2322.1640209524558, 2241.4172315198, 2243.4615692233747, 2254.842161048727, 2258.9887050564807, 2260.16373941641, 8864.689735859278, 8890.377673562853, 8965.058668839809, 8980.730578082668, 8988.370814043019, 5261.631685781997, 5367.221752845854, 5368.060589396879, 5369.489898459679, 5370.731463426813, 3421.4183588789715, 3477.3393055319407, 3542.468629705539, 3558.928821423583, 3614.0242134623504, 1184.4965889497016, 1214.884585964332, 1249.975000499994, 1261.1361217565905, 1268.131330038917, 12176.817347739703, 12318.50725970969, 12336.321502317369, 12337.0, 12353.382330883509, 4489.932651010237, 4700.55344742249, 4723.574878260973, 4800.35195248644, 4811.807527698853, 10366.378017318984, 10474.947625261977, 10488.0, 10498.212634052477, 10532.736681583021, 5331.040412725747, 5355.357357117093, 5368.624196306299, 5368.892622147535, 5372.973135134299, 4340.60934515895, 4775.570198682135, 4912.214045752734, 4944.357233559686, 4947.554720075211, 4001.8399264029695, 4033.3748269018347, 4060.4486376639447, 4073.6944729145434, 4121.732087414309, 1309.7642424363705, 1311.344327836082, 1325.244610571984, 1330.2018788726687, 1340.0485655184928, 908.3051465628799, 1021.5147804792664, 1032.55084038442, 1038.5586125896464, 1049.4437947887632, 5757.107648314518, 5844.12338149281, 5945.554083443759, 5965.343812180657, 6014.51883849291, 469.2234352147202, 478.9664723469393, 492.65267986069733, 494.1549949586176, 499.4306490600718, 4385.627221686129, 4397.428334316518, 4401.977990110029, 4420.403245561873, 4421.314696222091, 10532.947335263429, 10969.725756856142, 11035.227534072537, 11041.06150977176, 11062.612808551663, 10136.695899123039, 10590.841137382946, 10975.121990240761, 10991.340519568852, 11012.39431831241, 7672.42456815741, 7844.607769611496, 7846.058472983393, 7903.644336004779, 7914.604269786603, 5956.642601443928, 6247.156633854372, 6283.937160628335, 6305.274893387319, 6311.24265088174, 9767.9023209767, 9792.902070979198, 9804.264680148875, 9858.85211721839, 9913.405195688281, 9774.560144793359, 9896.356736812084, 10044.899551004397, 10136.594536218763, 10173.796524069625, 7613.505122167041, 7883.7240696575345, 7946.364290856602, 7978.880316795136, 8138.064122625974, 8803.823923521366, 8821.691240806798, 8835.779105522413, 8844.46933184011, 8886.822263554823, 7747.225277472207, 7986.241307075818, 8018.679252830055, 8043.436959412785, 8099.230573095547, 7780.299773020455, 7944.404169687412, 7961.044674639081, 8067.475614085066, 8088.099296665397, 7072.752453664097, 7176.06711127571, 7188.5327453715345, 7271.381932535582, 7281.890771638536, 5247.265382846328, 5252.947470525399, 5512.3660779010925, 5515.751791169327, 5538.806141785019, 5001.824936127364, 5091.71995540234, 5165.405978312542, 5207.92188117171, 5486.835394938158], "value": 4634.207425037535, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.0, 329.3807641633728, 331.3174859788835, 334.81752444917515, 338.2541496001317, 5683.431656834315, 5695.408589091963, 5707.601637598784, 5713.914291285629, 5714.8857022859565, 5631.436856314366, 5636.4927156555905, 5636.887262254752, 5656.010198215306, 5725.255716756816, 4121.319982202933, 4230.873073807776, 4332.263515202423, 4356.97821510892, 4357.607815296623, 4318.784060796963, 4334.97832510837, 4368.432103826498, 4395.230834603947, 4404.537523560028, 4386.363977223301, 4403.229434848905, 4418.9394545309215, 4425.8450954216605, 4426.62373698236, 4325.826966921335, 4362.672799540047, 4365.650747940157, 4369.257226271541, 4375.365571992043, 3766.1714422826935, 3777.660010599059, 3800.220954704279, 3809.7904615246152, 3829.48301979232, 5522.585806064561, 5544.7227638618315, 5587.441255874421, 5619.887602247973, 5619.915701264485, 4904.411470623512, 5047.974760126176, 5051.646384753032, 5079.4412614612365, 5103.311053007871, 5935.1987481690285, 5956.702164891782, 5959.374265702126, 5963.582549221556, 5988.371221021774, 4259.190753756808, 4271.765052922088, 4301.505326887385, 4305.677074219415, 4310.073334233123, 5996.8500787480225, 6142.600730952474, 6152.230971128653, 6189.938100619026, 6200.720967556471, 4323.0, 4326.935095973563, 4351.042770590465, 4366.825326986885, 4369.43197384338, 4425.336199570026, 4425.933610995838, 4430.335449682509, 4433.623142032899, 4441.955580444219, 4904.754762261872, 5002.499750024968, 5021.171506701427, 5027.044861476308, 5029.5221953914315, 5963.373845746134, 5994.190784244159, 6013.308469525973, 6013.579049466583, 6023.0965355196195, 1434.2040167707023, 1459.569427019032, 1479.34169294665, 1485.1089346392293, 1489.4042383046651, 966.40566051879, 973.5181085362649, 996.2080146283722, 1026.6047571684805, 1047.6699839550517, 5683.715814209273, 5737.684427356452, 5755.59710820247, 5758.596898217084, 5774.653520788766, 5959.880802383928, 5992.880142397127, 6015.218021657244, 6034.530145166546, 6083.239595050619, 5623.6906970116215, 5688.886222275614, 5925.318588362307, 5936.910946335808, 5948.494377977834, 3301.6203136639115, 3305.272839975202, 3313.718333941642, 3315.8342082896243, 3329.217633856042, 6096.573239873255, 6324.0, 6345.1434056401795, 6363.236411630634, 6386.552941294158, 6257.74969001244, 6323.557350985387, 6360.427561519486, 6361.809145725636, 6370.55406121567, 6015.909761353583, 6276.560640755195, 6356.364363563606, 6359.583358323807, 6408.903866442007, 6145.8156255312415, 6211.2857021443115, 6215.296346089465, 6227.875442491216, 6239.4696450800375, 6131.325554188947, 6142.754289828536, 6152.78465253714, 6155.415235552616, 6160.443415982496, 6240.753328801718, 6282.497400207881, 6293.276273228455, 6310.716017779119, 6345.17512723343, 4283.436545660874, 4291.82832686689, 4296.742195468282, 4313.051128751669, 4319.006628475406, 6029.246344206974, 6198.72105755233, 6258.405451482102, 6259.906101408392, 6268.996960486483, 5960.122561393321, 5969.940300596939, 5973.940260597512, 5998.7300571473515, 6003.969980150246, 5908.556858235564, 5989.3112292085225, 6004.819855404345, 6011.789587364421, 6092.258483682449, 5829.0, 5889.763149738603, 6034.426729460694, 6046.939530604814, 6063.6664983426335, 6105.084237364254, 6120.0, 6124.846878828065, 6132.509399247961, 6136.895358835274, 5812.959650168886, 5946.524278057832, 5955.851103722442, 5969.403059693996, 5981.431763982415], "value": 4542.555981840659, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.4101475268151, 760.2397602397602, 785.320697596579, 789.2856964447174, 881.8280435315114, 15688.764668529968, 16749.162541872887, 17168.74246886296, 17245.396411125614, 17282.30870765168, 16243.918780406082, 17091.05999170045, 17125.82874171258, 17163.227654755534, 17202.741958870625, 673.5857447669697, 815.2133191470215, 825.3108654273689, 825.6202147012382, 826.0, 809.1948511231303, 821.8561751693429, 822.8560001999626, 825.5129473610568, 828.0601517277903, 851.6337974670889, 855.6406309350057, 856.618804631939, 856.9742907712747, 858.8754630578562, 835.1815221083373, 842.2419822160043, 844.472204871955, 846.8983721953343, 849.0066622052213, 620.2494981072907, 620.7548018532655, 621.1986537366837, 622.5610944284268, 623.2427600465456, 16257.674846503121, 16301.266443010092, 16318.0, 16318.102504362374, 16319.755203671955, 15408.980437467642, 15474.68465180461, 15596.766048509167, 15634.843651563453, 15716.29276682552, 12096.092793040469, 12150.635480935585, 12279.324637144953, 12382.380880955916, 12493.312867792269, 4009.719319647626, 4092.0997380576227, 4138.048248902769, 4169.937450938239, 4171.3325867860995, 82213.17786822114, 82428.64213826082, 83621.0, 86619.13380866173, 87045.0, 12107.697307567381, 12204.816927746091, 12260.816087758512, 12294.75410491785, 12330.691732706755, 21040.684389734168, 22349.329520114097, 22447.102115915506, 22482.55034899293, 22550.436239093826, 8983.46099234035, 9181.311401644904, 9266.44401335922, 9424.623015079456, 9601.279904007228, 4910.0, 4951.405831300267, 4980.726060066731, 5060.240963855377, 5231.267622532772, 3521.771084879526, 3627.9455808162897, 3632.7457078004286, 3655.798931058764, 3662.377395842713, 620.4106099205773, 624.5934929075327, 635.0569404434411, 636.5671343486474, 636.6975686548852, 720.5496564647095, 743.0711610486892, 760.3347071312602, 776.3905334312537, 804.2279411764655, 10483.318584291997, 10558.947205263925, 10561.841572376421, 10866.511007004545, 11237.775244495064, 686.5537400689592, 733.7725305155419, 776.3595034096779, 793.7579038393345, 805.64551597297, 5097.0, 5199.688018718889, 5211.557017653542, 5249.501297376743, 5357.812476563302, 75925.24074759292, 107324.46337768261, 128034.0, 128715.35642321916, 131207.0, 67629.0, 96939.51530242304, 98278.5086074565, 101240.0, 104671.4766426163, 59521.10718339142, 59531.40468595345, 65707.67146164239, 92798.53600732089, 93624.53187734153, 9791.706248812547, 9937.503124843584, 9992.10071093605, 10088.142507886618, 10089.243306751876, 56147.0, 56386.0, 56575.0, 57785.0, 57894.4210557889, 77039.22960770321, 78069.21930780847, 82949.58525207336, 83155.0, 84544.0, 11556.306621602731, 11875.168738188244, 12511.311877846805, 12709.0, 12940.935295323463, 14272.21502817355, 14406.0, 14612.561623151323, 15349.386024559339, 15436.845631543541, 13720.176789392668, 13726.245056521988, 13782.310884455937, 13820.723585528032, 13835.584932452042, 12912.818829660824, 13498.46006159782, 13553.796693049415, 13634.454621815017, 13837.377318020512, 13300.268485233406, 13530.864691352961, 13802.378892950042, 13857.0, 13932.442702292201, 10006.149477294512, 10093.343932644355, 10206.92954826372, 10258.487075646039, 10704.30422022566, 9812.65655702047, 10333.84499232497, 10796.622118225825, 10796.946015269874, 10901.945490272497], "value": 7787.978810871027, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 106.0, 111.0, 114.0, 113.0, 114.0, 111.0, 113.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 116.0, 141.0, 179.0, 118.0, 149.0, 155.0, 126.0, 185.0, 117.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 161.0, 162.0, 163.0, 164.0, 169.0, 165.0, 162.0, 162.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 167.0, 77.0, 76.0, 81.0, 75.0, 184.0, 76.0], "value": 96.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 143.0, 84.0, 85.0, 88.0, 143.0, 85.0, 85.0, 147.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 148.0, 148.0, 147.0, 148.0, 148.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 58.0, 55.0, 56.0, 59.0, 55.0, 55.0, 55.0, 58.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 62.0, 62.0, 62.0, 61.0, 62.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 82.0, 76.0, 82.0, 75.0, 74.0, 75.0, 74.0, 80.0, 75.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 130.0, 122.0, 125.0, 123.0, 128.0, 137.0, 140.0, 159.0, 127.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 161.0, 162.0, 170.0, 166.0, 162.0, 164.0, 163.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 67.0, 67.0, 63.0, 69.0, 67.0, 67.0, 63.0], "value": 65.9, "unit": "score"}]}]} 13:29:33 INFO - Return code: 0 13:29:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:29:33 ERROR - # TBPL SUCCESS # 13:29:33 INFO - Running post-action listener: _resource_record_post_action 13:29:33 INFO - ##### 13:29:33 INFO - ##### Finished run-tests step (success) 13:29:33 INFO - ##### 13:29:33 INFO - Running post-run listener: _resource_record_post_run 13:29:33 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 12288; Write bytes: 554524672; Read time: 332; Write time: 426480 13:29:33 INFO - TinderboxPrint: CPU usage
13.3% 13:29:33 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 332 13:29:33 INFO - TinderboxPrint: I/O write bytes / time
554,524,672 / 426,480 13:29:33 INFO - TinderboxPrint: CPU idle
8,223.8 (86.7%) 13:29:33 INFO - TinderboxPrint: CPU user
1,209.7 (12.8%) 13:29:33 INFO - TinderboxPrint: Swap in / out
0 / 0 13:29:33 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 256364544; Read time: 184; Write time: 250424 13:29:33 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 8192; Write bytes: 297914368; Read time: 148; Write time: 176032 13:29:34 INFO - Running post-run listener: _upload_blobber_files 13:29:34 INFO - Blob upload gear active. 13:29:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:29:34 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 13:29:34 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'] 13:29:34 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 13:29:34 INFO - (blobuploader) - INFO - Open directory for files ... 13:29:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:29:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:29:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:35 INFO - (blobuploader) - INFO - Done attempting. 13:29:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:29:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:29:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:38 INFO - (blobuploader) - INFO - Done attempting. 13:29:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:29:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:29:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:39 INFO - (blobuploader) - INFO - Done attempting. 13:29:39 INFO - (blobuploader) - INFO - Iteration through files over. 13:29:39 INFO - Return code: 0 13:29:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:29:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:29:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d9f46052d4d2ecf8d0aededb06477b5e5ec9e633cb8fcf7b1f35d30dbcbc16305d872064c5d25ca5d9cf9823510f8270a4c3cc6f38b85ab31272839b4433b9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f48ff32aeb2045586d36c437f8cb173605ae720fad80f1be08a4247b73d85994b38bddad2be662a8b47daa7fef339af3ddb7bac80f99cad6035cbf92407d68d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f133ec25eee30e3e1d713811941dcdd5eb25a85b4c67856bafea3ef9d8cc757101ea62c55f14b1dfa96dc8effecf9026a77d6d94ca69c7a9368de372525f06c"} 13:29:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:29:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:29:39 INFO - Contents: 13:29:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d9f46052d4d2ecf8d0aededb06477b5e5ec9e633cb8fcf7b1f35d30dbcbc16305d872064c5d25ca5d9cf9823510f8270a4c3cc6f38b85ab31272839b4433b9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f48ff32aeb2045586d36c437f8cb173605ae720fad80f1be08a4247b73d85994b38bddad2be662a8b47daa7fef339af3ddb7bac80f99cad6035cbf92407d68d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f133ec25eee30e3e1d713811941dcdd5eb25a85b4c67856bafea3ef9d8cc757101ea62c55f14b1dfa96dc8effecf9026a77d6d94ca69c7a9368de372525f06c"} 13:29:39 INFO - Running post-run listener: copy_logs_to_upload_dir 13:29:39 INFO - Copying logs to upload dir... 13:29:39 INFO - mkdir: /builds/slave/test/build/upload/logs 13:29:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.873535 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-09 13:29:39.269648) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 13:29:39.272935) ========= 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=bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d9f46052d4d2ecf8d0aededb06477b5e5ec9e633cb8fcf7b1f35d30dbcbc16305d872064c5d25ca5d9cf9823510f8270a4c3cc6f38b85ab31272839b4433b9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f48ff32aeb2045586d36c437f8cb173605ae720fad80f1be08a4247b73d85994b38bddad2be662a8b47daa7fef339af3ddb7bac80f99cad6035cbf92407d68d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f133ec25eee30e3e1d713811941dcdd5eb25a85b4c67856bafea3ef9d8cc757101ea62c55f14b1dfa96dc8effecf9026a77d6d94ca69c7a9368de372525f06c"} build_url:https://queue.taskcluster.net/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011253 build_url: 'https://queue.taskcluster.net/v1/task/ET1NA7H4S06ISmJ3Vmy0sQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d9f46052d4d2ecf8d0aededb06477b5e5ec9e633cb8fcf7b1f35d30dbcbc16305d872064c5d25ca5d9cf9823510f8270a4c3cc6f38b85ab31272839b4433b9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f48ff32aeb2045586d36c437f8cb173605ae720fad80f1be08a4247b73d85994b38bddad2be662a8b47daa7fef339af3ddb7bac80f99cad6035cbf92407d68d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f133ec25eee30e3e1d713811941dcdd5eb25a85b4c67856bafea3ef9d8cc757101ea62c55f14b1dfa96dc8effecf9026a77d6d94ca69c7a9368de372525f06c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 13:29:39.302181) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 13:29:39.302938) ========= 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=bb9b54edd4a927dc735d112f000001d9-1468086895.181571-763468848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004388 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 13:29:39.383296) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 13:29:39.384190) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 13:29:39.384998) ========= ========= Total master_lag: 0.17 =========