builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1469528359.51 results: success (0) buildid: 20160726002841 builduid: f509fe4255714734ae53a9fdec164b99 revision: d7988da78c417062fd44170fe8881308b9803dbc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 03:19:19.507377) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 03:19:19.507796) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 03:19:19.508064) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 03:19:19.522494) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 03:19:19.522776) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-26 03:19:20-- 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% 114M=0s 2016-07-26 03:19:20 (114 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118778 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 03:19:19.655823) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 03:19:19.656088) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018814 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 03:19:19.706549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 03:19:19.706842) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d7988da78c417062fd44170fe8881308b9803dbc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d7988da78c417062fd44170fe8881308b9803dbc --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=9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-26 03:19:20,255 truncating revision to first 12 chars 2016-07-26 03:19:20,255 Setting DEBUG logging. 2016-07-26 03:19:20,256 attempt 1/10 2016-07-26 03:19:20,256 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d7988da78c41?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-26 03:19:20,891 unpacking tar archive at: mozilla-inbound-d7988da78c41/testing/mozharness/ program finished with exit code 0 elapsedTime=0.972033 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 03:19:20.692657) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 03:19:20.692997) ========= script_repo_revision: d7988da78c417062fd44170fe8881308b9803dbc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 03:19:20.693444) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 03:19:20.693742) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 03:19:20.704172) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-26 03:19:20.704491) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:19:21 INFO - MultiFileLogger online at 20160726 03:19:21 in /builds/slave/test 03:19:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 03:19:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:19:21 INFO - {'append_to_log': False, 03:19:21 INFO - 'base_work_dir': '/builds/slave/test', 03:19:21 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 03:19:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:19:21 INFO - 'branch': 'Mozilla-Inbound', 03:19:21 INFO - 'buildbot_json_path': 'buildprops.json', 03:19:21 INFO - 'config_files': ('talos/linux_config.py',), 03:19:21 INFO - 'default_actions': ('clobber', 03:19:21 INFO - 'read-buildbot-config', 03:19:21 INFO - 'download-and-extract', 03:19:21 INFO - 'populate-webroot', 03:19:21 INFO - 'create-virtualenv', 03:19:21 INFO - 'install', 03:19:21 INFO - 'run-tests'), 03:19:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:19:21 INFO - 'download_minidump_stackwalk': True, 03:19:21 INFO - 'download_symbols': 'ondemand', 03:19:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:19:21 INFO - 'tooltool.py': '/tools/tooltool.py', 03:19:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:19:21 INFO - '/tools/misc-python/virtualenv.py')}, 03:19:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:19:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:19:21 INFO - 'installer_path': 'installer.exe', 03:19:21 INFO - 'log_level': 'info', 03:19:21 INFO - 'log_name': 'talos', 03:19:21 INFO - 'log_to_console': True, 03:19:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:19:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:19:21 INFO - 'opt_config_files': (), 03:19:21 INFO - 'pip_index': False, 03:19:21 INFO - 'sps_profile': False, 03:19:21 INFO - 'sps_profile_interval': 0, 03:19:21 INFO - 'suite': 'dromaeojs', 03:19:21 INFO - 'system_bits': '32', 03:19:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:19:21 INFO - 'title': 'talos-linux64-ix-013', 03:19:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:19:21 INFO - 'use_talos_json': True, 03:19:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:19:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:19:21 INFO - 'work_dir': 'build'} 03:19:21 INFO - [mozharness: 2016-07-26 10:19:21.348431Z] Running clobber step. 03:19:21 INFO - Running pre-action listener: _resource_record_pre_action 03:19:21 INFO - Running main action method: clobber 03:19:21 INFO - rmtree: /builds/slave/test/build 03:19:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:19:22 INFO - Running post-action listener: _resource_record_post_action 03:19:22 INFO - [mozharness: 2016-07-26 10:19:22.337165Z] Finished clobber step (success) 03:19:22 INFO - [mozharness: 2016-07-26 10:19:22.337273Z] Running read-buildbot-config step. 03:19:22 INFO - Running pre-action listener: _resource_record_pre_action 03:19:22 INFO - Running main action method: read_buildbot_config 03:19:22 INFO - Using buildbot properties: 03:19:22 INFO - { 03:19:22 INFO - "project": "", 03:19:22 INFO - "product": "firefox", 03:19:22 INFO - "script_repo_revision": "production", 03:19:22 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 03:19:22 INFO - "repository": "", 03:19:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 03:19:22 INFO - "buildid": "20160726002841", 03:19:22 INFO - "pgo_build": "True", 03:19:22 INFO - "basedir": "/builds/slave/test", 03:19:22 INFO - "buildnumber": 1291, 03:19:22 INFO - "slavename": "talos-linux64-ix-013", 03:19:22 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:19:22 INFO - "platform": "ubuntu64_hw", 03:19:22 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 03:19:22 INFO - "branch": "mozilla-inbound", 03:19:22 INFO - "repo_path": "integration/mozilla-inbound", 03:19:22 INFO - "revision": "d7988da78c417062fd44170fe8881308b9803dbc", 03:19:22 INFO - "stage_platform": "linux64-pgo", 03:19:22 INFO - "builduid": "f509fe4255714734ae53a9fdec164b99", 03:19:22 INFO - "slavebuilddir": "test" 03:19:22 INFO - } 03:19:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:19:22 INFO - Running post-action listener: _resource_record_post_action 03:19:22 INFO - [mozharness: 2016-07-26 10:19:22.340055Z] Finished read-buildbot-config step (success) 03:19:22 INFO - [mozharness: 2016-07-26 10:19:22.340146Z] Running download-and-extract step. 03:19:22 INFO - Running pre-action listener: _resource_record_pre_action 03:19:22 INFO - Running main action method: download_and_extract 03:19:22 INFO - mkdir: /builds/slave/test/build/tests 03:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:22 INFO - https://queue.taskcluster.net/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:19:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:19:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:19:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/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 03:19:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/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 03:19:23 INFO - Downloaded 1361 bytes. 03:19:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:19:23 INFO - Using the following test package requirements: 03:19:23 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:19:23 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:19:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:19:23 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:19:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:19:23 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:19:23 INFO - u'jsshell-linux-x86_64.zip'], 03:19:23 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:19:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:19:23 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:19:23 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:19:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:19:23 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:19:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:19:23 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:19:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:19:23 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:19:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:19:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:19:23 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')]} 03:19:23 INFO - https://queue.taskcluster.net/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:19:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:19:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:19:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/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 03:19:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/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 03:19:24 INFO - Downloaded 24349044 bytes. 03:19:24 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'] 03:19:24 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 03:19:25 INFO - Return code: 0 03:19:25 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 03:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:25 INFO - https://queue.taskcluster.net/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:19:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:19:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:19:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/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 03:19:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/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 03:19:26 INFO - Downloaded 24349044 bytes. 03:19:26 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'] 03:19:26 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 03:19:27 INFO - Return code: 0 03:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:27 INFO - https://queue.taskcluster.net/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:19:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:19:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:19:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/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 03:19:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/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 03:19:29 INFO - Downloaded 14403317 bytes. 03:19:29 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'] 03:19:29 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 03:19:29 INFO - Return code: 0 03:19:29 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')]} 03:19:29 INFO - https://queue.taskcluster.net/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:19:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:19:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:19:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/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 03:19:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/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 03:19:30 INFO - Downloaded 60890670 bytes. 03:19:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:19:30 INFO - mkdir: /builds/slave/test/properties 03:19:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:19:30 INFO - Writing to file /builds/slave/test/properties/build_url 03:19:30 INFO - Contents: 03:19:30 INFO - build_url:https://queue.taskcluster.net/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:19:31 INFO - Running post-action listener: _resource_record_post_action 03:19:31 INFO - Running post-action listener: set_extra_try_arguments 03:19:31 INFO - [mozharness: 2016-07-26 10:19:31.581981Z] Finished download-and-extract step (success) 03:19:31 INFO - [mozharness: 2016-07-26 10:19:31.582215Z] Running populate-webroot step. 03:19:31 INFO - Running pre-action listener: _resource_record_pre_action 03:19:31 INFO - Running main action method: populate_webroot 03:19:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:19:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:19:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:19:31 INFO - '--tppagecycles', 03:19:31 INFO - '7'], 03:19:31 INFO - 'tests': ['tsvgm']}}, 03:19:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:19:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:19:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:19:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:19:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:19:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:19:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:31 INFO - 'talos_options': ['--disable-e10s'], 03:19:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:19:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:19:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:31 INFO - 'talos_options': ['--disable-e10s'], 03:19:31 INFO - 'tests': ['damp', 'tps']}, 03:19:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:31 INFO - 'tests': ['damp', 'tps']}, 03:19:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:19:31 INFO - 'tests': ['dromaeo_dom']}, 03:19:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:19:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:19:31 INFO - 'tests': ['basic_compositor_video']}, 03:19:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:19:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:19:31 INFO - 'tests': ['a11yr', 03:19:31 INFO - 'ts_paint', 03:19:31 INFO - 'tpaint', 03:19:31 INFO - 'sessionrestore', 03:19:31 INFO - 'sessionrestore_no_auto_restore', 03:19:31 INFO - 'tabpaint']}, 03:19:31 INFO - 'other-e10s': {'tests': ['a11yr', 03:19:31 INFO - 'ts_paint', 03:19:31 INFO - 'tpaint', 03:19:31 INFO - 'sessionrestore', 03:19:31 INFO - 'sessionrestore_no_auto_restore', 03:19:31 INFO - 'tabpaint']}, 03:19:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:19:31 INFO - 'ts_paint', 03:19:31 INFO - 'tpaint', 03:19:31 INFO - 'sessionrestore', 03:19:31 INFO - 'sessionrestore_no_auto_restore', 03:19:31 INFO - 'tabpaint']}, 03:19:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:19:31 INFO - 'ts_paint', 03:19:31 INFO - 'tpaint', 03:19:31 INFO - 'sessionrestore', 03:19:31 INFO - 'sessionrestore_no_auto_restore', 03:19:31 INFO - 'tabpaint']}, 03:19:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:19:31 INFO - 'tests': ['a11yr', 03:19:31 INFO - 'ts_paint', 03:19:31 INFO - 'tpaint', 03:19:31 INFO - 'sessionrestore', 03:19:31 INFO - 'sessionrestore_no_auto_restore', 03:19:31 INFO - 'tabpaint']}, 03:19:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:19:31 INFO - 'tests': ['a11yr', 03:19:31 INFO - 'ts_paint', 03:19:31 INFO - 'tpaint', 03:19:31 INFO - 'sessionrestore', 03:19:31 INFO - 'sessionrestore_no_auto_restore', 03:19:31 INFO - 'tabpaint']}, 03:19:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:19:31 INFO - 'tests': ['tsvgx', 03:19:31 INFO - 'tsvgr_opacity', 03:19:31 INFO - 'tart', 03:19:31 INFO - 'tscrollx', 03:19:31 INFO - 'cart']}, 03:19:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:19:31 INFO - 'tsvgr_opacity', 03:19:31 INFO - 'tart', 03:19:31 INFO - 'tscrollx', 03:19:31 INFO - 'cart']}, 03:19:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:31 INFO - 'talos_options': ['--disable-e10s'], 03:19:31 INFO - 'tests': ['tp5o']}, 03:19:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:31 INFO - 'tests': ['tp5o']}, 03:19:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:31 INFO - 'talos_options': ['--disable-e10s', 03:19:31 INFO - '--xperf_path', 03:19:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:19:31 INFO - 'tests': ['tp5n']}, 03:19:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:31 INFO - 'talos_options': ['--xperf_path', 03:19:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:19:31 INFO - 'tests': ['tp5n']}}, 03:19:31 INFO - 'talos.zip': {'path': '', 03:19:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:19:31 INFO - Running post-action listener: _resource_record_post_action 03:19:31 INFO - [mozharness: 2016-07-26 10:19:31.604097Z] Finished populate-webroot step (success) 03:19:31 INFO - [mozharness: 2016-07-26 10:19:31.604187Z] Running create-virtualenv step. 03:19:31 INFO - Running pre-action listener: _resource_record_pre_action 03:19:31 INFO - Running main action method: create_virtualenv 03:19:31 INFO - Creating virtualenv /builds/slave/test/build/venv 03:19:31 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 03:19:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:19:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:19:31 INFO - Using real prefix '/usr' 03:19:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:19:32 INFO - Installing distribute.............................................................................................................................................................................................done. 03:19:34 INFO - Installing pip.................done. 03:19:34 INFO - Return code: 0 03:19:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:34 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 0x241a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26db180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d93b0>, '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 0x26da2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26da740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163', '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 03:19:34 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 03:19:34 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 03:19:34 INFO - Using env: {'DISPLAY': ':0', 03:19:34 INFO - 'HOME': '/home/cltbld', 03:19:34 INFO - 'LANG': 'en_US.UTF-8', 03:19:34 INFO - 'LANGUAGE': 'en_US:en', 03:19:34 INFO - 'LOGNAME': 'cltbld', 03:19:34 INFO - 'MAIL': '/var/mail/cltbld', 03:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:34 INFO - 'MOZ_NO_REMOTE': '1', 03:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:34 INFO - 'NO_EM_RESTART': '1', 03:19:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:34 INFO - 'PWD': '/builds/slave/test', 03:19:34 INFO - 'SHELL': '/bin/bash', 03:19:34 INFO - 'SHLVL': '1', 03:19:34 INFO - 'TERM': 'linux', 03:19:34 INFO - 'TMOUT': '86400', 03:19:34 INFO - 'USER': 'cltbld', 03:19:34 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163', 03:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:34 INFO - '_': '/tools/buildbot/bin/python'} 03:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:34 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 03:19:34 INFO - Cleaning up... 03:19:34 INFO - Return code: 0 03:19:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:34 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 0x241a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26db180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d93b0>, '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 0x26da2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26da740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163', '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 03:19:34 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 03:19:34 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 03:19:34 INFO - Using env: {'DISPLAY': ':0', 03:19:34 INFO - 'HOME': '/home/cltbld', 03:19:34 INFO - 'LANG': 'en_US.UTF-8', 03:19:34 INFO - 'LANGUAGE': 'en_US:en', 03:19:34 INFO - 'LOGNAME': 'cltbld', 03:19:34 INFO - 'MAIL': '/var/mail/cltbld', 03:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:34 INFO - 'MOZ_NO_REMOTE': '1', 03:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:34 INFO - 'NO_EM_RESTART': '1', 03:19:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:34 INFO - 'PWD': '/builds/slave/test', 03:19:34 INFO - 'SHELL': '/bin/bash', 03:19:34 INFO - 'SHLVL': '1', 03:19:34 INFO - 'TERM': 'linux', 03:19:34 INFO - 'TMOUT': '86400', 03:19:34 INFO - 'USER': 'cltbld', 03:19:34 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163', 03:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:34 INFO - '_': '/tools/buildbot/bin/python'} 03:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:34 INFO - Downloading/unpacking psutil>=3.1.1 03:19:34 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 03:19:34 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 03:19:34 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 03:19:34 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 03:19:34 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 03:19:34 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 03:19:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:19:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:19:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:19:36 INFO - Installing collected packages: psutil 03:19:36 INFO - Running setup.py install for psutil 03:19:36 INFO - building 'psutil._psutil_linux' extension 03:19:36 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 03:19:36 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 03:19:36 INFO - building 'psutil._psutil_posix' extension 03:19:36 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 03:19:37 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 03:19:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:19:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:19:37 INFO - Successfully installed psutil 03:19:37 INFO - Cleaning up... 03:19:37 INFO - Return code: 0 03:19:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26db180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d93b0>, '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 0x26da2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26da740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163', '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 03:19:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:19:37 INFO - Using env: {'DISPLAY': ':0', 03:19:37 INFO - 'HOME': '/home/cltbld', 03:19:37 INFO - 'LANG': 'en_US.UTF-8', 03:19:37 INFO - 'LANGUAGE': 'en_US:en', 03:19:37 INFO - 'LOGNAME': 'cltbld', 03:19:37 INFO - 'MAIL': '/var/mail/cltbld', 03:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:37 INFO - 'MOZ_NO_REMOTE': '1', 03:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:37 INFO - 'NO_EM_RESTART': '1', 03:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:37 INFO - 'PWD': '/builds/slave/test', 03:19:37 INFO - 'SHELL': '/bin/bash', 03:19:37 INFO - 'SHLVL': '1', 03:19:37 INFO - 'TERM': 'linux', 03:19:37 INFO - 'TMOUT': '86400', 03:19:37 INFO - 'USER': 'cltbld', 03:19:37 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163', 03:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:37 INFO - '_': '/tools/buildbot/bin/python'} 03:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:19:37 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 03:19:37 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 03:19:37 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 03:19:37 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 03:19:37 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 03:19:37 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 03:19:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:19:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:19:39 INFO - Installing collected packages: mozsystemmonitor 03:19:39 INFO - Running setup.py install for mozsystemmonitor 03:19:39 INFO - Successfully installed mozsystemmonitor 03:19:39 INFO - Cleaning up... 03:19:39 INFO - Return code: 0 03:19:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:19: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')]} 03:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19: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')]} 03:19:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:39 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 0x241a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26db180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d93b0>, '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 0x26da2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26da740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163', '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 03:19:39 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 03:19:39 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 03:19:39 INFO - Using env: {'DISPLAY': ':0', 03:19:39 INFO - 'HOME': '/home/cltbld', 03:19:39 INFO - 'LANG': 'en_US.UTF-8', 03:19:39 INFO - 'LANGUAGE': 'en_US:en', 03:19:39 INFO - 'LOGNAME': 'cltbld', 03:19:39 INFO - 'MAIL': '/var/mail/cltbld', 03:19:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:39 INFO - 'MOZ_NO_REMOTE': '1', 03:19:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:39 INFO - 'NO_EM_RESTART': '1', 03:19:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:39 INFO - 'PWD': '/builds/slave/test', 03:19:39 INFO - 'SHELL': '/bin/bash', 03:19:39 INFO - 'SHLVL': '1', 03:19:39 INFO - 'TERM': 'linux', 03:19:39 INFO - 'TMOUT': '86400', 03:19:39 INFO - 'USER': 'cltbld', 03:19:39 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163', 03:19:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:39 INFO - '_': '/tools/buildbot/bin/python'} 03:19:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:39 INFO - Downloading/unpacking jsonschema==2.5.1 03:19:39 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 03:19:39 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 03:19:39 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 03:19:39 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 03:19:39 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 03:19:39 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 03:19:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:19:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:19: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 03:19: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 03:19: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 03:19: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 03:19: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 03:19: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 03:19:41 INFO - Downloading functools32-3.2.3-2.tar.gz 03:19:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:19:41 INFO - warning: no files found matching '*.txt' 03:19:41 INFO - no previously-included directories found matching 'build' 03:19:41 INFO - no previously-included directories found matching 'dist' 03:19:41 INFO - no previously-included directories found matching '.git*' 03:19:41 INFO - Installing collected packages: jsonschema, functools32 03:19:41 INFO - Running setup.py install for functools32 03:19:42 INFO - warning: no files found matching '*.txt' 03:19:42 INFO - no previously-included directories found matching 'build' 03:19:42 INFO - no previously-included directories found matching 'dist' 03:19:42 INFO - no previously-included directories found matching '.git*' 03:19:42 INFO - Successfully installed jsonschema functools32 03:19:42 INFO - Cleaning up... 03:19:42 INFO - Return code: 0 03:19:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:19:42 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')]} 03:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:42 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')]} 03:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:42 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 0x241a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26db180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d93b0>, '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 0x26da2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26da740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163', '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 03:19:42 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 03:19:42 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 03:19:42 INFO - Using env: {'DISPLAY': ':0', 03:19:42 INFO - 'HOME': '/home/cltbld', 03:19:42 INFO - 'LANG': 'en_US.UTF-8', 03:19:42 INFO - 'LANGUAGE': 'en_US:en', 03:19:42 INFO - 'LOGNAME': 'cltbld', 03:19:42 INFO - 'MAIL': '/var/mail/cltbld', 03:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:42 INFO - 'MOZ_NO_REMOTE': '1', 03:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:42 INFO - 'NO_EM_RESTART': '1', 03:19:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:42 INFO - 'PWD': '/builds/slave/test', 03:19:42 INFO - 'SHELL': '/bin/bash', 03:19:42 INFO - 'SHLVL': '1', 03:19:42 INFO - 'TERM': 'linux', 03:19:42 INFO - 'TMOUT': '86400', 03:19:42 INFO - 'USER': 'cltbld', 03:19:42 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163', 03:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:42 INFO - '_': '/tools/buildbot/bin/python'} 03:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:42 INFO - Downloading/unpacking blobuploader==1.2.4 03:19:42 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 03:19:42 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 03:19:42 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 03:19:42 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 03:19:42 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 03:19:42 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 03:19:44 INFO - Downloading blobuploader-1.2.4.tar.gz 03:19:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:19:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:19:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:44 INFO - Downloading docopt-0.6.1.tar.gz 03:19:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:19:44 INFO - Installing collected packages: blobuploader, requests, docopt 03:19:44 INFO - Running setup.py install for blobuploader 03:19:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:19:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:19:45 INFO - Running setup.py install for requests 03:19:45 INFO - Running setup.py install for docopt 03:19:45 INFO - Successfully installed blobuploader requests docopt 03:19:45 INFO - Cleaning up... 03:19:45 INFO - Return code: 0 03:19:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19:45 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')]} 03:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:45 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')]} 03:19:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:45 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 0x241a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26db180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d93b0>, '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 0x26da2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26da740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163', '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 03:19:45 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 03:19:45 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 03:19:45 INFO - Using env: {'DISPLAY': ':0', 03:19:45 INFO - 'HOME': '/home/cltbld', 03:19:45 INFO - 'LANG': 'en_US.UTF-8', 03:19:45 INFO - 'LANGUAGE': 'en_US:en', 03:19:45 INFO - 'LOGNAME': 'cltbld', 03:19:45 INFO - 'MAIL': '/var/mail/cltbld', 03:19:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:45 INFO - 'MOZ_NO_REMOTE': '1', 03:19:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:45 INFO - 'NO_EM_RESTART': '1', 03:19:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:45 INFO - 'PWD': '/builds/slave/test', 03:19:45 INFO - 'SHELL': '/bin/bash', 03:19:45 INFO - 'SHLVL': '1', 03:19:45 INFO - 'TERM': 'linux', 03:19:45 INFO - 'TMOUT': '86400', 03:19:45 INFO - 'USER': 'cltbld', 03:19:45 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163', 03:19:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:45 INFO - '_': '/tools/buildbot/bin/python'} 03:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:19:45 INFO - Running setup.py (path:/tmp/pip-n9lRUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:19:45 INFO - Running setup.py (path:/tmp/pip-48L1Jh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:19:45 INFO - Running setup.py (path:/tmp/pip-0XDfrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:19:46 INFO - Running setup.py (path:/tmp/pip-RS41Sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:19:46 INFO - Running setup.py (path:/tmp/pip-BKdKMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:19:46 INFO - Running setup.py (path:/tmp/pip-R3Wfgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:19:46 INFO - Running setup.py (path:/tmp/pip-oyaKMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:19:46 INFO - Running setup.py (path:/tmp/pip-BSZBME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:19:46 INFO - Running setup.py (path:/tmp/pip-LMlzgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:19:46 INFO - Running setup.py (path:/tmp/pip-eyBJwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:19:46 INFO - Running setup.py (path:/tmp/pip-p7pfkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:19:46 INFO - Running setup.py (path:/tmp/pip-LUTm2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:19:46 INFO - Running setup.py (path:/tmp/pip-Vi3LEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:19:46 INFO - Running setup.py (path:/tmp/pip-mlYO1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:46 INFO - Running setup.py (path:/tmp/pip-q5GJn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:19:46 INFO - Running setup.py (path:/tmp/pip-uZZ4hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:19:46 INFO - Running setup.py (path:/tmp/pip-zJmDp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:19:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:19:46 INFO - Running setup.py install for manifestparser 03:19:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:19:47 INFO - Running setup.py install for mozcrash 03:19:47 INFO - Running setup.py install for mozdebug 03:19:47 INFO - Running setup.py install for mozdevice 03:19:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:19:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:19:47 INFO - Running setup.py install for mozfile 03:19:47 INFO - Running setup.py install for mozhttpd 03:19:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:19:47 INFO - Running setup.py install for mozinfo 03:19:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:19:47 INFO - Running setup.py install for mozInstall 03:19:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:19:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:19:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:19:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:19:47 INFO - Running setup.py install for mozleak 03:19:47 INFO - Running setup.py install for mozlog 03:19:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:19:48 INFO - Running setup.py install for moznetwork 03:19:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:19:48 INFO - Running setup.py install for mozprocess 03:19:48 INFO - Running setup.py install for mozprofile 03:19:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:19:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:19:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:19:48 INFO - Running setup.py install for mozrunner 03:19:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:19:48 INFO - Running setup.py install for mozscreenshot 03:19:48 INFO - Running setup.py install for moztest 03:19:48 INFO - Running setup.py install for mozversion 03:19:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:19:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:19:48 INFO - Cleaning up... 03:19:48 INFO - Return code: 0 03:19:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19:48 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')]} 03:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:48 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')]} 03:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:48 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 0x241a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26db180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d93b0>, '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 0x26da2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26da740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163', '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 03:19:48 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 03:19:48 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 03:19:48 INFO - Using env: {'DISPLAY': ':0', 03:19:48 INFO - 'HOME': '/home/cltbld', 03:19:48 INFO - 'LANG': 'en_US.UTF-8', 03:19:48 INFO - 'LANGUAGE': 'en_US:en', 03:19:48 INFO - 'LOGNAME': 'cltbld', 03:19:48 INFO - 'MAIL': '/var/mail/cltbld', 03:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:48 INFO - 'MOZ_NO_REMOTE': '1', 03:19:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:48 INFO - 'NO_EM_RESTART': '1', 03:19:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:48 INFO - 'PWD': '/builds/slave/test', 03:19:48 INFO - 'SHELL': '/bin/bash', 03:19:48 INFO - 'SHLVL': '1', 03:19:48 INFO - 'TERM': 'linux', 03:19:48 INFO - 'TMOUT': '86400', 03:19:48 INFO - 'USER': 'cltbld', 03:19:48 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163', 03:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:48 INFO - '_': '/tools/buildbot/bin/python'} 03:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:19:49 INFO - Running setup.py (path:/tmp/pip-VrPeJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:19:49 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)) 03:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:19:49 INFO - Running setup.py (path:/tmp/pip-1_Yn5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:19:49 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)) 03:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:19:49 INFO - Running setup.py (path:/tmp/pip-1koJPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:19:49 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)) 03:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:19:49 INFO - Running setup.py (path:/tmp/pip-xR11rT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:19:49 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)) 03:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:19:49 INFO - Running setup.py (path:/tmp/pip-BbzW05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:19:49 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)) 03:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:19:49 INFO - Running setup.py (path:/tmp/pip-HfLZzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:19:49 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)) 03:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:19:49 INFO - Running setup.py (path:/tmp/pip-FFQroY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:19:49 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)) 03:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:19:49 INFO - Running setup.py (path:/tmp/pip-o9QI3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:19:49 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)) 03:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:19:49 INFO - Running setup.py (path:/tmp/pip-Vyw65A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:19:49 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)) 03:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:19:49 INFO - Running setup.py (path:/tmp/pip-iMNqLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:19:49 INFO - Running setup.py (path:/tmp/pip-pX9IgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:19:49 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)) 03:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:19:49 INFO - Running setup.py (path:/tmp/pip-b8m9Ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:19:49 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)) 03:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:19:49 INFO - Running setup.py (path:/tmp/pip-SWowak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:19:49 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)) 03:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:19:49 INFO - Running setup.py (path:/tmp/pip-1XP1NP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:19:50 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)) 03:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:50 INFO - Running setup.py (path:/tmp/pip-IpNWEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:50 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)) 03:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:19:50 INFO - Running setup.py (path:/tmp/pip-Uf9D5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:19:50 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)) 03:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:19:50 INFO - Running setup.py (path:/tmp/pip-kNdaCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:19:50 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)) 03:19:50 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)) 03:19:50 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)) 03:19:50 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)) 03:19:50 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)) 03:19:50 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)) 03:19:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:19:50 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 03:19:50 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 03:19:50 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 03:19:50 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 03:19:50 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 03:19:50 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 03:19:52 INFO - Downloading blessings-1.6.tar.gz 03:19:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:19:52 INFO - Installing collected packages: blessings 03:19:52 INFO - Running setup.py install for blessings 03:19:52 INFO - Successfully installed blessings 03:19:52 INFO - Cleaning up... 03:19:52 INFO - Return code: 0 03:19:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:19:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:19:52 INFO - Reading from file tmpfile_stdout 03:19:52 INFO - Current package versions: 03:19:52 INFO - argparse == 1.2.1 03:19:52 INFO - blessings == 1.6 03:19:52 INFO - blobuploader == 1.2.4 03:19:52 INFO - docopt == 0.6.1 03:19:52 INFO - functools32 == 3.2.3-2 03:19:52 INFO - jsonschema == 2.5.1 03:19:52 INFO - manifestparser == 1.1 03:19:52 INFO - mozInstall == 1.12 03:19:52 INFO - mozcrash == 0.17 03:19:52 INFO - mozdebug == 0.1 03:19:52 INFO - mozdevice == 0.48 03:19:52 INFO - mozfile == 1.2 03:19:52 INFO - mozhttpd == 0.7 03:19:52 INFO - mozinfo == 0.9 03:19:52 INFO - mozleak == 0.1 03:19:52 INFO - mozlog == 3.3 03:19:52 INFO - moznetwork == 0.27 03:19:52 INFO - mozprocess == 0.23 03:19:52 INFO - mozprofile == 0.28 03:19:52 INFO - mozrunner == 6.12 03:19:52 INFO - mozscreenshot == 0.1 03:19:52 INFO - mozsystemmonitor == 0.3 03:19:52 INFO - moztest == 0.7 03:19:52 INFO - mozversion == 1.4 03:19:52 INFO - psutil == 3.1.1 03:19:52 INFO - requests == 1.2.3 03:19:52 INFO - wsgiref == 0.1.2 03:19:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19:52 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')]} 03:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:52 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')]} 03:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:52 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 0x241a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26db180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d93b0>, '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 0x26da2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26da740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163', '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 03:19:52 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 03:19:52 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 03:19:52 INFO - Using env: {'DISPLAY': ':0', 03:19:52 INFO - 'HOME': '/home/cltbld', 03:19:52 INFO - 'LANG': 'en_US.UTF-8', 03:19:52 INFO - 'LANGUAGE': 'en_US:en', 03:19:52 INFO - 'LOGNAME': 'cltbld', 03:19:52 INFO - 'MAIL': '/var/mail/cltbld', 03:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:52 INFO - 'MOZ_NO_REMOTE': '1', 03:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:52 INFO - 'NO_EM_RESTART': '1', 03:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:52 INFO - 'PWD': '/builds/slave/test', 03:19:52 INFO - 'SHELL': '/bin/bash', 03:19:52 INFO - 'SHLVL': '1', 03:19:52 INFO - 'TERM': 'linux', 03:19:52 INFO - 'TMOUT': '86400', 03:19:52 INFO - 'USER': 'cltbld', 03:19:52 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163', 03:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:52 INFO - '_': '/tools/buildbot/bin/python'} 03:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:52 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)) 03:19:52 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)) 03:19:52 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)) 03:19:52 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)) 03:19:52 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)) 03:19:52 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)) 03:19:52 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)) 03:19:52 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)) 03:19:52 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)) 03:19:52 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)) 03:19:52 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)) 03:19:52 INFO - Cleaning up... 03:19:52 INFO - Return code: 0 03:19:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:19:52 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')]} 03:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:52 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')]} 03:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:52 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 0x241a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26db180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d93b0>, '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 0x26da2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26da740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163', '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 03:19:52 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 03:19:52 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 03:19:52 INFO - Using env: {'DISPLAY': ':0', 03:19:52 INFO - 'HOME': '/home/cltbld', 03:19:52 INFO - 'LANG': 'en_US.UTF-8', 03:19:52 INFO - 'LANGUAGE': 'en_US:en', 03:19:52 INFO - 'LOGNAME': 'cltbld', 03:19:52 INFO - 'MAIL': '/var/mail/cltbld', 03:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:52 INFO - 'MOZ_NO_REMOTE': '1', 03:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:52 INFO - 'NO_EM_RESTART': '1', 03:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:52 INFO - 'PWD': '/builds/slave/test', 03:19:52 INFO - 'SHELL': '/bin/bash', 03:19:52 INFO - 'SHLVL': '1', 03:19:52 INFO - 'TERM': 'linux', 03:19:52 INFO - 'TMOUT': '86400', 03:19:52 INFO - 'USER': 'cltbld', 03:19:52 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163', 03:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:52 INFO - '_': '/tools/buildbot/bin/python'} 03:19:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:19:53 INFO - Cleaning up... 03:19:53 INFO - Return code: 0 03:19:53 INFO - Running post-action listener: _resource_record_post_action 03:19:53 INFO - Running post-action listener: _start_resource_monitoring 03:19:53 INFO - Starting resource monitoring. 03:19:53 INFO - [mozharness: 2016-07-26 10:19:53.079828Z] Finished create-virtualenv step (success) 03:19:53 INFO - [mozharness: 2016-07-26 10:19:53.080315Z] Running install step. 03:19:53 INFO - Running pre-action listener: _resource_record_pre_action 03:19:53 INFO - Running main action method: install 03:19:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:19:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:19:53 INFO - Reading from file tmpfile_stdout 03:19:53 INFO - Detecting whether we're running mozinstall >=1.0... 03:19:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:19:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:19:53 INFO - Reading from file tmpfile_stdout 03:19:53 INFO - Output received: 03:19:53 INFO - Usage: mozinstall [options] installer 03:19:53 INFO - Options: 03:19:53 INFO - -h, --help show this help message and exit 03:19:53 INFO - -d DEST, --destination=DEST 03:19:53 INFO - Directory to install application into. [default: 03:19:53 INFO - "/builds/slave/test"] 03:19:53 INFO - --app=APP Application being installed. [default: firefox] 03:19:53 INFO - mkdir: /builds/slave/test/build/application 03:19:53 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'] 03:19:53 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 03:20:10 INFO - Reading from file tmpfile_stdout 03:20:10 INFO - Output received: 03:20:10 INFO - /builds/slave/test/build/application/firefox/firefox 03:20:10 INFO - Running post-action listener: _resource_record_post_action 03:20:10 INFO - [mozharness: 2016-07-26 10:20:10.700142Z] Finished install step (success) 03:20:10 INFO - [mozharness: 2016-07-26 10:20:10.700422Z] Running run-tests step. 03:20:10 INFO - Running pre-action listener: _resource_record_pre_action 03:20:10 INFO - Running main action method: run_tests 03:20:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:20:10 INFO - Python 2.7.3 03:20:10 INFO - Return code: 0 03:20:10 INFO - grabbing minidump binary from tooltool 03:20:10 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')]} 03:20:10 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 0x26d93b0>, '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 0x26da2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26da740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:20:10 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 03:20:10 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 03:20:10 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 03:20:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:20:10 INFO - Return code: 0 03:20:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:20:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:20:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:20:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:20:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:20:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:20:10 INFO - Using env: {'DISPLAY': ':0', 03:20:10 INFO - 'HOME': '/home/cltbld', 03:20:10 INFO - 'LANG': 'en_US.UTF-8', 03:20:10 INFO - 'LANGUAGE': 'en_US:en', 03:20:10 INFO - 'LOGNAME': 'cltbld', 03:20:10 INFO - 'MAIL': '/var/mail/cltbld', 03:20:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:20:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:20:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:10 INFO - 'MOZ_NO_REMOTE': '1', 03:20:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:20:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:10 INFO - 'NO_EM_RESTART': '1', 03:20:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:10 INFO - 'PWD': '/builds/slave/test', 03:20:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:20:10 INFO - 'SHELL': '/bin/bash', 03:20:10 INFO - 'SHLVL': '1', 03:20:10 INFO - 'TERM': 'linux', 03:20:10 INFO - 'TMOUT': '86400', 03:20:10 INFO - 'USER': 'cltbld', 03:20:10 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163', 03:20:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:10 INFO - '_': '/tools/buildbot/bin/python'} 03:20:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:20:10 INFO - mozversion application_buildid: 20160726002841 03:20:10 INFO - mozversion application_changeset: d7988da78c417062fd44170fe8881308b9803dbc 03:20:10 INFO - mozversion application_display_name: Nightly 03:20:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:20:10 INFO - mozversion application_name: Firefox 03:20:10 INFO - mozversion application_remotingname: firefox 03:20:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:20:10 INFO - mozversion application_vendor: Mozilla 03:20:10 INFO - mozversion application_version: 50.0a1 03:20:10 INFO - mozversion platform_buildid: 20160726002841 03:20:10 INFO - mozversion platform_changeset: d7988da78c417062fd44170fe8881308b9803dbc 03:20:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:20:10 INFO - mozversion platform_version: 50.0a1 03:20:10 INFO - using testdate: 1469528410 03:20:10 INFO - actual date: 1469528410 03:20:10 INFO - starting webserver on 'localhost:42778' 03:20:10 INFO - SUITE-START | Running 2 tests 03:20:10 INFO - TEST-START | dromaeo_css 03:20:10 INFO - operating with platform_type : linux_ 03:20:10 INFO - Initialising browser for dromaeo_css test... 03:20:10 INFO - TEST-INFO | started process 4148 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp39Js0k/profile http://localhost:42778/getInfo.html) 03:20:14 INFO - PROCESS | 4148 | JavaScript error: , line 0: uncaught exception: undefined 03:20:15 INFO - PROCESS | 4148 | __metrics Screen width/height:1600/1200 03:20:15 INFO - PROCESS | 4148 | colorDepth:24 03:20:15 INFO - PROCESS | 4148 | Browser inner width/height: 1024/697 03:20:15 INFO - PROCESS | 4148 | __metrics 03:20:15 INFO - PROCESS | 4148 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:20:15 INFO - PROCESS | 4148 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:20:16 INFO - TEST-INFO | 4148: exit 0 03:20:16 INFO - Browser initialized. 03:20:16 INFO - Running cycle 1/1 for dromaeo_css test... 03:20:16 INFO - TEST-INFO | started process 4229 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp39Js0k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:20:28 INFO - PROCESS | 4229 | RSS: Main: 157507584 03:20:28 INFO - PROCESS | 4229 | 03:21:20 INFO - PROCESS | 4229 | 1469528480161 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] 03:23:27 INFO - PROCESS | 4229 | Cycle 1(1): loaded http://localhost:42778/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42778/tests/dromaeo/cssquery-ext.html) 03:23:29 INFO - PROCESS | 4229 | RSS: Main: 270012416 03:23:29 INFO - PROCESS | 4229 | 03:26:31 INFO - PROCESS | 4229 | Cycle 1(1): loaded http://localhost:42778/tests/dromaeo/cssquery-ext.html (next: http://localhost:42778/tests/dromaeo/cssquery-jquery.html) 03:26:32 INFO - PROCESS | 4229 | RSS: Main: 247402496 03:26:32 INFO - PROCESS | 4229 | 03:29:33 INFO - PROCESS | 4229 | Cycle 1(1): loaded http://localhost:42778/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42778/tests/dromaeo/cssquery-mootools.html) 03:29:34 INFO - PROCESS | 4229 | RSS: Main: 186261504 03:29:34 INFO - PROCESS | 4229 | 03:32:36 INFO - PROCESS | 4229 | Cycle 1(1): loaded http://localhost:42778/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42778/tests/dromaeo/cssquery-prototype.html) 03:32:37 INFO - PROCESS | 4229 | RSS: Main: 232968192 03:32:37 INFO - PROCESS | 4229 | 03:35:39 INFO - PROCESS | 4229 | Cycle 1(1): loaded http://localhost:42778/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42778/tests/dromaeo/cssquery-yui.html) 03:35:40 INFO - PROCESS | 4229 | RSS: Main: 186146816 03:35:40 INFO - PROCESS | 4229 | 03:38:43 INFO - PROCESS | 4229 | Cycle 1(1): loaded http://localhost:42778/tests/dromaeo/cssquery-yui.html (next: http://localhost:42778/tests/dromaeo/cssquery-dojo.html) 03:38:43 INFO - PROCESS | 4229 | RSS: Main: 273387520 03:38:43 INFO - PROCESS | 4229 | 03:38:43 INFO - PROCESS | 4229 | __start_tp_report 03:38:43 INFO - PROCESS | 4229 | _x_x_mozilla_page_load 03:38:43 INFO - PROCESS | 4229 | _x_x_mozilla_page_load_details 03:38:43 INFO - PROCESS | 4229 | |i|pagename|runs| 03:38:43 INFO - PROCESS | 4229 | |0;dojo.html;3079.522673985532;3079.9230019249517;3101.751859851212;3101.8914337998176;3134.73354764845;5255.684658920458;5271.367435907697;5398.298221231239;5469.398366179722;5512.366077901042;5309.442508536606;5376.596755243353;5380.354357477108;5422.810201642943;5433.538149257318;4817.975910120454;4851.27230915362;4890.877728056791;4900.264960255954;5066.214736715815;4968.3292755477905;4999.32509111269;5018.673786203904;5027.49725027498;5034.874128146807;4747.90504189916;4850.102730994759;4868.878278043042;4887;4959.528844759742;4800.879978000543;4812.085703716282;4824.059308434857;4843.443004054544;4958.801647934079;4798.160321943646;4842.58837998767;4844.394450693663;4869;4881.926771098437;5218.76515556797;5333.2000199969925;5358.785648574052;5362.329708786402;5429.185622156669;5793.507551858097;5847.9415205848245;5853.385394533598;5853.473187413153;5863.8534036649;5839.240898683186;5880.7353669085;5881.67650779207;5887.4406931341455;5894.58737888348;5230.633855630107;5360.142377219665;5416.8104116355735;5420.403755586922;5484.61607687462;5952.404759524013;6004.849878752979;6004.939950600438;6009.759609615654;6014.278286605548;5707.828765137053;5715.457031581993;5716.942830571724;5727.742251598688;5754.510866576388;5597.3003374578175;5695.629784064023;5745.798897038583;5757.913631295534;5838.824835254949;5730.713464326767;5736.856578585485;5737.483626473638;5744.138379243147;5782.971085144547;5704.11586204139;5729.512991395778;5732.484076433141;5751.539876809845;5759.65442073477;4299.9570004300185;4309.762963037063;4359.585839345257;4381.364702118175;4415.27148020573;3934.390169523728;3937.4684417603257;3964.226975739703;3966.6628336591134;3993.5008123984503;5515.227868098469;5520.144377621395;5527.032769265363;5528.087865502147;5528.778848846001;5625.240592519957;5772.5670574707065;5822.737976791054;5858.150568167677;5918.556108291896;5535.501804837584;5539.446055394509;5539.695316757617;5549.084401073777;5587.469190426903;5017.974910125426;5038.647294689336;5040.042391945592;5045;5085.3134826797905;5741.368449470555;5868.67722275279;5955.523558115254;5970.373110823388;5980.372060933626;5777.2200752897825;5795.884082318415;5797.710114494174;5825.213596164633;5849.239598852122;5961.552883533665;5970.76116955317;5971.701414929323;5972.193753843176;5974.970125149346;5517.420670829505;5620.887582248414;5635.042042852643;5640.464155905182;5698.6580805151825;5776.653400795965;5807.535397168132;5815.069588865761;5846.35690074083;5862.413758624274;5637.098064309691;5654.349749778664;5657.2928383952;5687.971560142173;5690.4878560928055;5453.291072160594;5559.499645031967;5587.1339942309005;5652.971735141298;5667.461591148999;5566.610337276352;5575.386707462257;5575.498205161555;5610.438956104357;5626.634268772516;5665.065264231355;5675.7445914933105;5719.399463056486;5725.312962444534;5725.599208055396;5426.294581704353;5450.727463626882;5521.668699878021;5536.197251398606;5546.334439867242 03:38:43 INFO - PROCESS | 4229 | |1;ext.html;576.7952376906195;579.7391173971711;600.3966014155778;611.0620197996076;619.9752009919602;31864.203394915137;45035.32447013293;45876.311855322194;45901.770491147494;45955.77022114893;46661.533384666225;47226.291605625855;47393;47461;47478.52521474784;9145.999999999984;9286.907130928706;9295.44227346358;9298.628054877796;9298.907010929872;9009.099090091004;9083.95458022709;9091.681791137311;9094.77263068422;9103.681371152012;9128.406653567497;9153.771155721093;9166.312526560501;9176.265898728087;9186.081391860827;9052.4568525888;9069.863952040725;9089.545522723838;9099.63601455941;9119.452832830018;9058.094190580956;9129.771755706093;9143.405678630868;9148.268138548967;9151.039140890243;43839.56160438387;44304.113917721785;44387.778061109486;44412.3338149928;44488.3326750099;3707.1844194277214;3749.1189570450924;3880.611938806125;4330.870073897788;4374.321980093091;33237.833810831034;33594.83202583996;33979.830100849336;35786.24377504271;36949.63050369489;4085.2442298174933;4203.600657937491;4214.473190851144;4225.894352641178;4243.893902652428;382642;386388;386476;386688;387705;61959.69020154871;62342.376576234565;62390.68804655947;62417;62421;58502;65543.67228163924;66580.66709666421;67087;72481.63759181276;17670.293188272324;17748.3788067417;17752.3786667466;17767.289308427517;17785.7332140018;12103;13504.05471616997;13529.120607160503;13571.321433928264;13663.18020918748;19361.709574356395;19542.797869581787;20215.595688086156;20216.29242976518;20483.8975805123;7154.49104189771;7327.230640782747;7425.554466732014;7456.888146677804;7561.281678240558;984.0405604535521;1017.760826205841;1021.2442792333768;1073.6456969200144;1147.770445910821;33551.49672754911;33942.32115357679;33986.49020264698;34118.261648299514;34319.14202144966;1149.1553708024596;1150.654803558929;1168.293182624517;1250.1998720818683;1268.2327192048863;17575.20911558983;17789.604293423752;17877.553061173574;17898.5525361867;17910.462686119437;646270;649466;650403;650504;651531;59797.40202597919;60434.697826510586;60440.395596044356;60497;60568;1238.238483332762;1324.8079028540808;1353.3406855528933;1380.2270728392132;1398.2030242761732;30929.536056958714;34322.82838585791;34441.655583444845;34775.478367824;34899;50913.23630145477;51411;51416;51423.22865156951;51471;426540;427516;428155;428247.58762062393;429068;25249.11628093008;25975.09087182015;27549.862250688617;28884.42231155323;29405.411891761618;46422.767886160356;48792.268115979;49513.75243123761;50157.49842501674;50475;41340.586594133674;42976;43601.345979809696;43610;44454.77772611116;42498;42957;43155.568444315155;43983.340249896915;44802;41621.37567936423;42410.57589424066;42412.15175696407;42538.57461425346;42803.785981069894;34789.65210347965;36530.391563575424;37732.81133594424;38020;38718.225635487695;28364.290892727848;28386.432271354046;28668.42663146684;29004.27489312784;29041.273968150967 03:38:43 INFO - PROCESS | 4229 | |2;jquery.html;393.6319541228953;395.6300858697118;400.55738409057983;402.24177425552836;417.67421411299176;14527.854721452783;17403.43369096781;18327;19844.30544930926;19855.900720496415;19215.32746353878;19222.423327300203;19570.412887613358;20542.281020164297;20543.794562054412;5847.8538036549;6028.3067447243475;6038.426349496791;6045.697715114226;6063.939360606381;4346.8913277168;5891.263592050994;5981.6411015339;6384.170057892491;6698.363655452724;6677.265500794909;6727.260001399842;6733.158355205599;6736.090627765238;6736.5958042517605;6393.680315984206;6560.868782624345;6590;6596.241432235306;6600.3729645683825;5741.942580574183;5745.310562732457;5813.273340832396;5832.066869300934;5849.883002339972;23915;23943.88028059866;24269.271921842374;24327.148549800673;24493;2296.7358753743365;2320.7911287983993;2355.9646605300936;2403.6034054381007;2937.0454602254354;14749.631259218499;14776.556703298918;15208.771868421982;15446.922765386213;15803.841961580352;1948.0649288341676;1950.2199120351972;1971.5071232191951;1972.6547854125615;1983.2860170338668;80769.59615201886;81834.9999999994;82787.58606206991;83209;86102.13897861003;10353.63762268317;10368.429736364422;10406.427646479366;10996.395198264172;11195.216334856645;13673;13713.45146194161;13718.93140534291;13727.656808579866;13745.450181992608;8173.632186551619;8332.125126861592;8342.207490288412;8366.874496882552;8518.659253629909;8202;8314.41799074071;8447.873281900776;8483.151684831468;8547.572621368907;6355.713992870332;6385.106085148083;6388.329225431263;6487.07531943177;6515.771947981798;1867.9906600466911;1927.8554108441922;1930.5366711989022;1962;1978.960420791576;918.4213945214606;990.9405435673883;1004.5630150884389;1005.2058873490007;1039.9480025998669;20091.296804611768;20376.592468150553;20437;20462.488437788877;20788.376348709564;980.1032055668983;1009.9899001010043;1024.9955044056867;1030.3560274828233;1030.3766221435924;10921;11881.5841445549;11929.164958452999;11964.700882477833;11985.460654270404;529076;541880;543061;555276;555730;82766.58616706877;83578.58210708908;84755.57622211972;84769.57615212008;85405;937.7374335186158;967.849983252597;993.64228877604;994.9651762188289;997.3447315588433;17162;17564.473065808048;17909.820901790816;17937.282508699507;17955;40784;42052.57947420487;42528;42742.358864616435;42997.57002430061;51668.74165629148;59863.70068149632;61154;61296;62763;8384.371172161991;8623.310135189295;8741.125887411208;8792.47245165292;8981.416207946462;11473.254238474472;13649.317534123056;13660.248686321951;14000.579982600539;14080.929595351958;11185.944070279596;11713.41432928333;11717.238379505305;11889.405529723652;11971.844988367982;5282.577393808409;8081.757547273592;11384.203105782515;11836.810190114857;12182;11600;11843.644690659294;12244;12245.265284082983;12370.690732731753;8364.163583641588;8527.74416767498;8861.778455538662;8969.14793094655;9000.774980625536;9594.712158635251;11417.429128543707;11434.085273178292;11462.369569673749;12006.519739210684 03:38:43 INFO - PROCESS | 4229 | |3;mootools.html;1328.1433475408355;1489.501017159252;1551.6896620675864;1647.192875491009;1764.0738612228579;8584.356173287006;9043;9046.819063618732;9275.953620231889;9287.767805804859;9150.542472876363;9245;9251.583678734456;9252.814943701122;9253.676121335739;2409.2892596683932;2431.051889762994;2432.063655492639;2434.5982912819363;2435.5494233566847;2394.7126344838643;2431.7081950166007;2439.6828412306463;2448.6939132608422;2452.877356132195;2356.587597170497;2382.0709923129994;2392.676988606533;2394.8084153267696;2405.7353691093967;2328.3247858121126;2357.434215788207;2360.929172124839;2370.9051637934463;2372.2645979746335;2298.5747636687265;2317.826163037762;2321.373229228099;2324.9186278480174;2325.383773300077;8981.640734370618;9097.727068187965;9111.681091161778;9170.174684278447;9197.954010229972;5313.3092697949405;5526.861828454281;5528.170774383874;5534.1145416733125;5536;3387.322535492887;3397.405454045557;3432.048438343023;3440.2603440260214;3510.052285882823;1072.6674730833388;1086.8043752124615;1110.2006555280186;1132.049078773834;1137.914656400765;12853.35733213345;12905.483780648763;12917.22496650204;12981.286029268387;13000.349982500837;4550.544945505423;4683.391159149289;4757.14371413142;4843.4430040545085;4861.416630004422;10195.898041019494;10197.286189966631;10219.591216351411;10221.131203847608;10234.078932896075;5419.430959749248;5462.0987537056735;5482.671039737628;5485.232067510552;5488.368837583729;4501.504834468205;4944.060628480577;5068.82259120929;5122.436531981479;5128.974355128275;3887.5334959805004;3935.2719746846924;4016.9196616067516;4035.636792688672;4056.290149223933;1183.8461000070108;1203.8976686981705;1219.2136072233359;1232.963011109668;1237.3627581795383;993.60752502761;996.9252306076928;999.9750006249902;1009.535613617744;1015.7206768138673;6080.422359875804;6211.875762484725;6247.875042499216;6255.499560035186;6578.079068930354;444.65983522605234;455.61500532050366;457.75967617000674;461.8037334133047;1049.0977759127145;4040.939385909214;4242.342436922282;4253.659707223414;4282.421873047161;4298.806553705091;11401.258918170292;11717.355545444912;11741.647750567497;11768.764624707457;11790.469428875722;11641.41792910351;11645.243059201124;11649.417529123679;11659.650210493699;11710.238834475731;8551.957240213884;8650.43772154808;8707.259882909897;8771.956140219385;8788.945326560854;6101.9389806103145;6303.590266632654;6332.651704156316;6344.873102537831;6395.392437718409;10619.097376723064;10891.727706807393;10904.61833835812;10918.399488028235;10930;10790.946045269724;10827;10829.837552436562;10933.453327333442;10933.507992140532;7149.356557909813;7607.88588171189;7791.259830316111;7807.297343239135;7964.880526792219;9125.31560133006;9177.449353038839;9190.172884440433;9197.540122993958;9198.724038278862;8059.758207253792;8075.232852878967;8087.878681819895;8231.42380033392;8287.709930152416;7761.534307941542;7821.92178078212;7896.486728362638;7927.960360198162;8178.754637360888;7125.1093613298335;7234.421246300178;7302.890456643261;7305.41556675454;7309.378702810108;5497.560195184456;5538.169274608841;5558.166275058612;5574.275344205227;5631.943680563142;5444.292242008513;5485.149801780731;5509.256250406143;5558.694271815089;5671.574631902541 03:38:43 INFO - PROCESS | 4229 | |4;prototype.html;325.88612413739594;339.39248744746897;342.2760860779452;345.9965400345996;347.7739469344925;5301.973490132554;5307.70807605582;5316.893662126755;5336.6531175473565;5363.042489491327;5244.632875698702;5272.156454967197;5283.471652834714;5287.0437937962915;5294.100002999489;4162.0635357044575;4165.104502531955;4168.4581004469455;4185.058361868586;4232.132412855357;3763.604821493745;3976.622220889011;4121.4848143982;4150.564190759957;4188.74867507949;4115.753054816706;4128.009277773343;4129.194807012634;4131.091159944807;4148.896277593054;4135.359019352005;4141.233871733723;4150.5641907599875;4161.52142503613;4169.770662613555;3547.7161827053774;3587.515685382492;3673.779573225588;3680.9509289852263;3691.9446208306895;5136.614753893436;5175.948240517584;5176.301199338079;5187.584993200535;5188.533032027098;4735.928961065587;4754.381930349033;4771.427428708577;4773.854274974016;4774.904501909942;5376.010875975875;5381.354237491487;5426.782928682848;5431.728413579344;5432.592555558349;4043.2317859606583;4044.110295734963;4046.959530404717;4054.918901621951;4081.8163182656854;5435.891282174334;5437.184422336642;5702.8289151325525;5748.511376533;5760.36635970043;4111.1366613011005;4119.196756632487;4124.9587504125175;4129.731567448106;4139.19285739278;4155.8753237402925;4192.979035104805;4208.38978348144;4213.91572168561;4217.135487225111;4558.723557403932;4734.1241870253425;4750.429948406213;4751.976240118846;4759.428868535798;5464.688474766028;5472.7263636818;5476.2333273341765;5513.2005859151;5528.723563821793;1426.172819764534;1439.942402303917;1446.8987170898147;1450.390835848946;1450.8259008918997;895.2345744388584;940.9670661526814;947.2469386837481;951.900050494702;962.7256231973854;4712.293156026555;4754.500777418321;4757.26262429324;4766.142094422968;4798.928016079762;4938.678985865908;4939.481354457802;4962.578180854595;4978.875528111754;4997.650164488524;4653.9301910470695;4686.437627484655;4697.31888876111;4721.5278472153195;4982.800687972441;2955.3202763364116;2988.5666578346018;3010.1421094987822;3012.6744232538053;3023.56158357037;5846.327672317738;5853.151293062482;5860.3260625027815;5865.765369385262;5881.794137205177;5557.166425036196;5733.197352370671;5763.567732420085;5766.826995190151;5791.652500849962;5805.622634528742;5820.88358232833;5824.242848429677;5832.766689332549;5849.3858144894175;5386.784528618811;5656.60403771732;5686.947914635805;5691.971540142273;5693.231413759089;5602.439756024528;5605.523530499953;5616.831495055155;5630.352509461464;5633.436656334334;5557.805476808292;5732.828015159552;5817.185594016756;5839.299284085937;5868.647881127146;4033.213523362916;4053.91892162161;4067.186562687415;4077.1234184650443;4079.714419990691;5700.543956483389;5705.914411283751;5705.942940570541;5712;5746.080627099644;5341;5574.721263936706;5586.888262234814;5599.60802743804;5604.495595396434;5566.304211973504;5572.916406253828;5586.972065139648;5589.217509548585;5594.216809646571;5252.579793616578;5549.195366671891;5574.721263936868;5593.916091258716;5637;5507.8984203158725;5553.555715542666;5565.693886836101;5577.972110139423;5580.748866300945;5439.374471935778;5458.1266997280245;5543.778248870161;5580;5587.385387607279 03:38:43 INFO - PROCESS | 4229 | |5;yui.html;697.5500801982721;717.4260591526777;758.8861670749387;766.6933226709316;860.5267103093302;15541.378344866205;16675.749863752055;16697.332106715716;16697.499075027754;16775.41286054985;13938.790918136236;13991.30043497826;14003.649908752286;14018.439262429516;14030.228337441436;659.294554826336;790.5691398187972;795.4829360915394;814.3851392198882;818.9959050204741;810.8094597769519;822.4777266435826;823.1480417767582;823.2631794543879;823.8105235795771;846.1707526623912;847.1697736218509;847.8092429203441;847.8812966184739;848.088305072047;691.5366704308101;832.4256263178448;838.0906716212917;838.8532006898769;851.2508992086986;628.4595248086688;628.8050704281687;628.8616504369078;629.0375725140542;629.2291942370605;14883.925580372137;14969.775453368207;15006.549803505912;15029.699406011818;15058.171800550965;14163.079399838978;14436.133831970115;14482.275886205753;14607.415703371853;14685.926570367186;11896.167268291223;12113.576024839176;13097.607071787861;13290.136141150795;13317.467301307935;4466.955330446686;4543.0459603483305;4559.430071241095;4627.375304333906;4647.581717645395;82229.58885205595;83379;84048.15951840465;84250;84329.57835210847;11570.132240082028;11611.361375124281;11655.184137110491;11795.233309835005;11965.40172991347;20554.58890822205;20763.896180519;20796.688049679266;20880;21156.78843211548;8532.146785321418;8592.269657079094;8616.353773467015;8626.137386261324;8731.956340218385;4826.227803551415;4834.250691142808;4909.73085091109;4921.384826896638;5054.595632349403;3538.5399898013607;3615.060084378081;3620.511230983836;3628;3628.7097032237357;642.0722056628221;643.5398689936718;647.3591144766647;661.9768308109193;668.8528523724773;599.8320470268332;645.3159650770199;706.5478094019832;716.2193209401777;722.3390597603134;9371.718848434557;9558.330916835894;9951.55218015191;10010.199184065257;10029.598816047277;564.2692712936757;667.219353356574;668.4485299627827;679.8674258519541;760.091690429942;4661.883452913637;4699.929501057487;4717.150912835654;4776;4852;110426.44786776176;110889.44555277172;114094;116012.41993789977;116308;97507;98766.07403555665;100267.49866250622;101543;102102.48948755208;81095.59452202701;81836.59081704554;87713.56143219244;88048;94636.52681736548;8485;8601.612927418157;8715;8967.461952282883;8967.641294348414;51184;51404.74297628488;51765.48234517607;53152.73423633012;53894.46105538894;53153.202701960276;66696.6665166671;66997;67203;72077.63961180371;13882.444702212202;13940.372683229076;14100.153990760587;14205.502807401692;14849.183294918452;15041.623959401102;15283.15942623122;15331.233438328261;15414.152221627917;15704.685906281582;14608.269586520419;14788;14851.1831849245;15008.249587520799;15274.312655930733;13540.93229533846;13740.503649089356;14115.576532704035;14884.181370024753;15004.474843380429;13266.800997984845;13453.394597243343;14042.859571404564;14074.507392241223;14117.2941352934;11775.352355620524;12256.75486490283;12259.877401226231;12461.501539938301;13001.414936328078;11082.944585277022;11281.379524125923;11426.885731142582;11548.769024619292;11618.6514404568 03:38:43 INFO - PROCESS | 4229 | __end_tp_report 03:38:43 INFO - PROCESS | 4229 | __start_cc_report 03:38:43 INFO - PROCESS | 4229 | _x_x_mozilla_cycle_collect,992 03:38:43 INFO - PROCESS | 4229 | __end_cc_report 03:38:43 INFO - PROCESS | 4229 | __startTimestamp1469529523525__endTimestamp 03:38:43 INFO - PROCESS | 4229 | 03:38:43 INFO - PROCESS | 4229 | ------- Summary: start ------- 03:38:43 INFO - PROCESS | 4229 | Number of tests: 6 03:38:43 INFO - PROCESS | 4229 | 03:38:43 INFO - PROCESS | 4229 | [#0] dojo.html Cycles:165 Average:5366.91 Median:5566.61 stddev:619.23 (11.1%) stddev-sans-first:594.56 03:38:43 INFO - PROCESS | 4229 | Values: 3079.5 3079.9 3101.8 3101.9 3134.7 5255.7 5271.4 5398.3 5469.4 5512.4 5309.4 5376.6 5380.4 5422.8 5433.5 4818.0 4851.3 4890.9 4900.3 5066.2 4968.3 4999.3 5018.7 5027.5 5034.9 4747.9 4850.1 4868.9 4887.0 4959.5 4800.9 4812.1 4824.1 4843.4 4958.8 4798.2 4842.6 4844.4 4869.0 4881.9 5218.8 5333.2 5358.8 5362.3 5429.2 5793.5 5847.9 5853.4 5853.5 5863.9 5839.2 5880.7 5881.7 5887.4 5894.6 5230.6 5360.1 5416.8 5420.4 5484.6 5952.4 6004.8 6004.9 6009.8 6014.3 5707.8 5715.5 5716.9 5727.7 5754.5 5597.3 5695.6 5745.8 5757.9 5838.8 5730.7 5736.9 5737.5 5744.1 5783.0 5704.1 5729.5 5732.5 5751.5 5759.7 4300.0 4309.8 4359.6 4381.4 4415.3 3934.4 3937.5 3964.2 3966.7 3993.5 5515.2 5520.1 5527.0 5528.1 5528.8 5625.2 5772.6 5822.7 5858.2 5918.6 5535.5 5539.4 5539.7 5549.1 5587.5 5018.0 5038.6 5040.0 5045.0 5085.3 5741.4 5868.7 5955.5 5970.4 5980.4 5777.2 5795.9 5797.7 5825.2 5849.2 5961.6 5970.8 5971.7 5972.2 5975.0 5517.4 5620.9 5635.0 5640.5 5698.7 5776.7 5807.5 5815.1 5846.4 5862.4 5637.1 5654.3 5657.3 5688.0 5690.5 5453.3 5559.5 5587.1 5653.0 5667.5 5566.6 5575.4 5575.5 5610.4 5626.6 5665.1 5675.7 5719.4 5725.3 5725.6 5426.3 5450.7 5521.7 5536.2 5546.3 03:38:43 INFO - PROCESS | 4229 | 03:38:43 INFO - PROCESS | 4229 | [#1] ext.html Cycles:180 Average:65172.59 Median:42966.50 stddev:133492.60 (310.7%) stddev-sans-first:133778.98 03:38:43 INFO - PROCESS | 4229 | Values: 576.8 579.7 600.4 611.1 620.0 31864.2 45035.3 45876.3 45901.8 45955.8 46661.5 47226.3 47393.0 47461.0 47478.5 9146.0 9286.9 9295.4 9298.6 9298.9 9009.1 9084.0 9091.7 9094.8 9103.7 9128.4 9153.8 9166.3 9176.3 9186.1 9052.5 9069.9 9089.5 9099.6 9119.5 9058.1 9129.8 9143.4 9148.3 9151.0 43839.6 44304.1 44387.8 44412.3 44488.3 3707.2 3749.1 3880.6 4330.9 4374.3 33237.8 33594.8 33979.8 35786.2 36949.6 4085.2 4203.6 4214.5 4225.9 4243.9 382642.0 386388.0 386476.0 386688.0 387705.0 61959.7 62342.4 62390.7 62417.0 62421.0 58502.0 65543.7 66580.7 67087.0 72481.6 17670.3 17748.4 17752.4 17767.3 17785.7 12103.0 13504.1 13529.1 13571.3 13663.2 19361.7 19542.8 20215.6 20216.3 20483.9 7154.5 7327.2 7425.6 7456.9 7561.3 984.0 1017.8 1021.2 1073.6 1147.8 33551.5 33942.3 33986.5 34118.3 34319.1 1149.2 1150.7 1168.3 1250.2 1268.2 17575.2 17789.6 17877.6 17898.6 17910.5 646270.0 649466.0 650403.0 650504.0 651531.0 59797.4 60434.7 60440.4 60497.0 60568.0 1238.2 1324.8 1353.3 1380.2 1398.2 30929.5 34322.8 34441.7 34775.5 34899.0 50913.2 51411.0 51416.0 51423.2 51471.0 426540.0 427516.0 428155.0 428247.6 429068.0 25249.1 25975.1 27549.9 28884.4 29405.4 46422.8 48792.3 49513.8 50157.5 50475.0 41340.6 42976.0 43601.3 43610.0 44454.8 42498.0 42957.0 43155.6 43983.3 44802.0 41621.4 42410.6 42412.2 42538.6 42803.8 34789.7 36530.4 37732.8 38020.0 38718.2 28364.3 28386.4 28668.4 29004.3 29041.3 03:38:43 INFO - PROCESS | 4229 | 03:38:43 INFO - PROCESS | 4229 | [#2] jquery.html Cycles:180 Average:30683.01 Median:398.09 stddev:89455.28 (22470.9%) stddev-sans-first:89677.31 03:38:43 INFO - PROCESS | 4229 | Values: 393.6 395.6 400.6 402.2 417.7 14527.9 17403.4 18327.0 19844.3 19855.9 19215.3 19222.4 19570.4 20542.3 20543.8 5847.9 6028.3 6038.4 6045.7 6063.9 4346.9 5891.3 5981.6 6384.2 6698.4 6677.3 6727.3 6733.2 6736.1 6736.6 6393.7 6560.9 6590.0 6596.2 6600.4 5741.9 5745.3 5813.3 5832.1 5849.9 23915.0 23943.9 24269.3 24327.1 24493.0 2296.7 2320.8 2356.0 2403.6 2937.0 14749.6 14776.6 15208.8 15446.9 15803.8 1948.1 1950.2 1971.5 1972.7 1983.3 80769.6 81835.0 82787.6 83209.0 86102.1 10353.6 10368.4 10406.4 10996.4 11195.2 13673.0 13713.5 13718.9 13727.7 13745.5 8173.6 8332.1 8342.2 8366.9 8518.7 8202.0 8314.4 8447.9 8483.2 8547.6 6355.7 6385.1 6388.3 6487.1 6515.8 1868.0 1927.9 1930.5 1962.0 1979.0 918.4 990.9 1004.6 1005.2 1039.9 20091.3 20376.6 20437.0 20462.5 20788.4 980.1 1010.0 1025.0 1030.4 1030.4 10921.0 11881.6 11929.2 11964.7 11985.5 529076.0 541880.0 543061.0 555276.0 555730.0 82766.6 83578.6 84755.6 84769.6 85405.0 937.7 967.8 993.6 995.0 997.3 17162.0 17564.5 17909.8 17937.3 17955.0 40784.0 42052.6 42528.0 42742.4 42997.6 51668.7 59863.7 61154.0 61296.0 62763.0 8384.4 8623.3 8741.1 8792.5 8981.4 11473.3 13649.3 13660.2 14000.6 14080.9 11185.9 11713.4 11717.2 11889.4 11971.8 5282.6 8081.8 11384.2 11836.8 12182.0 11600.0 11843.6 12244.0 12245.3 12370.7 8364.2 8527.7 8861.8 8969.1 9000.8 9594.7 11417.4 11434.1 11462.4 12006.5 03:38:43 INFO - PROCESS | 4229 | 03:38:43 INFO - PROCESS | 4229 | [#3] mootools.html Cycles:180 Average:6049.70 Median:2503.08 stddev:3510.02 (140.2%) stddev-sans-first:3501.93 03:38:43 INFO - PROCESS | 4229 | Values: 1328.1 1489.5 1551.7 1647.2 1764.1 8584.4 9043.0 9046.8 9276.0 9287.8 9150.5 9245.0 9251.6 9252.8 9253.7 2409.3 2431.1 2432.1 2434.6 2435.5 2394.7 2431.7 2439.7 2448.7 2452.9 2356.6 2382.1 2392.7 2394.8 2405.7 2328.3 2357.4 2360.9 2370.9 2372.3 2298.6 2317.8 2321.4 2324.9 2325.4 8981.6 9097.7 9111.7 9170.2 9198.0 5313.3 5526.9 5528.2 5534.1 5536.0 3387.3 3397.4 3432.0 3440.3 3510.1 1072.7 1086.8 1110.2 1132.0 1137.9 12853.4 12905.5 12917.2 12981.3 13000.3 4550.5 4683.4 4757.1 4843.4 4861.4 10195.9 10197.3 10219.6 10221.1 10234.1 5419.4 5462.1 5482.7 5485.2 5488.4 4501.5 4944.1 5068.8 5122.4 5129.0 3887.5 3935.3 4016.9 4035.6 4056.3 1183.8 1203.9 1219.2 1233.0 1237.4 993.6 996.9 1000.0 1009.5 1015.7 6080.4 6211.9 6247.9 6255.5 6578.1 444.7 455.6 457.8 461.8 1049.1 4040.9 4242.3 4253.7 4282.4 4298.8 11401.3 11717.4 11741.6 11768.8 11790.5 11641.4 11645.2 11649.4 11659.7 11710.2 8552.0 8650.4 8707.3 8772.0 8788.9 6101.9 6303.6 6332.7 6344.9 6395.4 10619.1 10891.7 10904.6 10918.4 10930.0 10790.9 10827.0 10829.8 10933.5 10933.5 7149.4 7607.9 7791.3 7807.3 7964.9 9125.3 9177.4 9190.2 9197.5 9198.7 8059.8 8075.2 8087.9 8231.4 8287.7 7761.5 7821.9 7896.5 7928.0 8178.8 7125.1 7234.4 7302.9 7305.4 7309.4 5497.6 5538.2 5558.2 5574.3 5631.9 5444.3 5485.1 5509.3 5558.7 5671.6 03:38:43 INFO - PROCESS | 4229 | 03:38:43 INFO - PROCESS | 4229 | [#4] prototype.html Cycles:180 Average:4621.90 Median:5248.61 stddev:1342.56 (25.6%) stddev-sans-first:1307.04 03:38:43 INFO - PROCESS | 4229 | Values: 325.9 339.4 342.3 346.0 347.8 5302.0 5307.7 5316.9 5336.7 5363.0 5244.6 5272.2 5283.5 5287.0 5294.1 4162.1 4165.1 4168.5 4185.1 4232.1 3763.6 3976.6 4121.5 4150.6 4188.7 4115.8 4128.0 4129.2 4131.1 4148.9 4135.4 4141.2 4150.6 4161.5 4169.8 3547.7 3587.5 3673.8 3681.0 3691.9 5136.6 5175.9 5176.3 5187.6 5188.5 4735.9 4754.4 4771.4 4773.9 4774.9 5376.0 5381.4 5426.8 5431.7 5432.6 4043.2 4044.1 4047.0 4054.9 4081.8 5435.9 5437.2 5702.8 5748.5 5760.4 4111.1 4119.2 4125.0 4129.7 4139.2 4155.9 4193.0 4208.4 4213.9 4217.1 4558.7 4734.1 4750.4 4752.0 4759.4 5464.7 5472.7 5476.2 5513.2 5528.7 1426.2 1439.9 1446.9 1450.4 1450.8 895.2 941.0 947.2 951.9 962.7 4712.3 4754.5 4757.3 4766.1 4798.9 4938.7 4939.5 4962.6 4978.9 4997.7 4653.9 4686.4 4697.3 4721.5 4982.8 2955.3 2988.6 3010.1 3012.7 3023.6 5846.3 5853.2 5860.3 5865.8 5881.8 5557.2 5733.2 5763.6 5766.8 5791.7 5805.6 5820.9 5824.2 5832.8 5849.4 5386.8 5656.6 5686.9 5692.0 5693.2 5602.4 5605.5 5616.8 5630.4 5633.4 5557.8 5732.8 5817.2 5839.3 5868.6 4033.2 4053.9 4067.2 4077.1 4079.7 5700.5 5705.9 5705.9 5712.0 5746.1 5341.0 5574.7 5586.9 5599.6 5604.5 5566.3 5572.9 5587.0 5589.2 5594.2 5252.6 5549.2 5574.7 5593.9 5637.0 5507.9 5553.6 5565.7 5578.0 5580.7 5439.4 5458.1 5543.8 5580.0 5587.4 03:38:43 INFO - PROCESS | 4229 | 03:38:43 INFO - PROCESS | 4229 | [#5] yui.html Cycles:180 Average:20958.34 Median:4680.91 stddev:29879.70 (638.3%) stddev-sans-first:29924.79 03:38:43 INFO - PROCESS | 4229 | Values: 697.6 717.4 758.9 766.7 860.5 15541.4 16675.7 16697.3 16697.5 16775.4 13938.8 13991.3 14003.6 14018.4 14030.2 659.3 790.6 795.5 814.4 819.0 810.8 822.5 823.1 823.3 823.8 846.2 847.2 847.8 847.9 848.1 691.5 832.4 838.1 838.9 851.3 628.5 628.8 628.9 629.0 629.2 14883.9 14969.8 15006.5 15029.7 15058.2 14163.1 14436.1 14482.3 14607.4 14685.9 11896.2 12113.6 13097.6 13290.1 13317.5 4467.0 4543.0 4559.4 4627.4 4647.6 82229.6 83379.0 84048.2 84250.0 84329.6 11570.1 11611.4 11655.2 11795.2 11965.4 20554.6 20763.9 20796.7 20880.0 21156.8 8532.1 8592.3 8616.4 8626.1 8732.0 4826.2 4834.3 4909.7 4921.4 5054.6 3538.5 3615.1 3620.5 3628.0 3628.7 642.1 643.5 647.4 662.0 668.9 599.8 645.3 706.5 716.2 722.3 9371.7 9558.3 9951.6 10010.2 10029.6 564.3 667.2 668.4 679.9 760.1 4661.9 4699.9 4717.2 4776.0 4852.0 110426.4 110889.4 114094.0 116012.4 116308.0 97507.0 98766.1 100267.5 101543.0 102102.5 81095.6 81836.6 87713.6 88048.0 94636.5 8485.0 8601.6 8715.0 8967.5 8967.6 51184.0 51404.7 51765.5 53152.7 53894.5 53153.2 66696.7 66997.0 67203.0 72077.6 13882.4 13940.4 14100.2 14205.5 14849.2 15041.6 15283.2 15331.2 15414.2 15704.7 14608.3 14788.0 14851.2 15008.2 15274.3 13540.9 13740.5 14115.6 14884.2 15004.5 13266.8 13453.4 14042.9 14074.5 14117.3 11775.4 12256.8 12259.9 12461.5 13001.4 11082.9 11281.4 11426.9 11548.8 11618.7 03:38:43 INFO - PROCESS | 4229 | -------- Summary: end -------- 03:38:43 INFO - PROCESS | 4229 | 03:38:44 INFO - TEST-INFO | 4229: exit 0 03:38:44 INFO - TEST-OK | dromaeo_css | took 1113344ms 03:38:44 INFO - TEST-START | kraken 03:38:44 INFO - operating with platform_type : linux_ 03:38:44 INFO - Initialising browser for kraken test... 03:38:44 INFO - TEST-INFO | started process 4413 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGDN23W/profile http://localhost:42778/getInfo.html) 03:38:47 INFO - PROCESS | 4413 | JavaScript error: , line 0: uncaught exception: undefined 03:38:48 INFO - PROCESS | 4413 | __metrics Screen width/height:1600/1200 03:38:48 INFO - PROCESS | 4413 | colorDepth:24 03:38:48 INFO - PROCESS | 4413 | Browser inner width/height: 1024/697 03:38:48 INFO - PROCESS | 4413 | __metrics 03:38:49 INFO - PROCESS | 4413 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:38:49 INFO - PROCESS | 4413 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:38:50 INFO - TEST-INFO | 4413: exit 0 03:38:50 INFO - Browser initialized. 03:38:50 INFO - Running cycle 1/1 for kraken test... 03:38:50 INFO - TEST-INFO | started process 4495 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGDN23W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:39:02 INFO - PROCESS | 4495 | RSS: Main: 157876224 03:39:02 INFO - PROCESS | 4495 | 03:39:04 INFO - PROCESS | 4495 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42778/tests/kraken/driver.html?testName=audio-beat-detection) 03:39:05 INFO - PROCESS | 4495 | RSS: Main: 213905408 03:39:05 INFO - PROCESS | 4495 | 03:39:07 INFO - PROCESS | 4495 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42778/tests/kraken/driver.html?testName=audio-dft) 03:39:08 INFO - PROCESS | 4495 | RSS: Main: 193339392 03:39:08 INFO - PROCESS | 4495 | 03:39:11 INFO - PROCESS | 4495 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42778/tests/kraken/driver.html?testName=audio-fft) 03:39:12 INFO - PROCESS | 4495 | RSS: Main: 270143488 03:39:12 INFO - PROCESS | 4495 | 03:39:14 INFO - PROCESS | 4495 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42778/tests/kraken/driver.html?testName=audio-oscillator) 03:39:14 INFO - PROCESS | 4495 | RSS: Main: 181424128 03:39:14 INFO - PROCESS | 4495 | 03:39:16 INFO - PROCESS | 4495 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42778/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:39:17 INFO - PROCESS | 4495 | RSS: Main: 185397248 03:39:17 INFO - PROCESS | 4495 | 03:39:20 INFO - PROCESS | 4495 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42778/tests/kraken/driver.html?testName=imaging-darkroom) 03:39:21 INFO - PROCESS | 4495 | RSS: Main: 222126080 03:39:21 INFO - PROCESS | 4495 | 03:39:24 INFO - PROCESS | 4495 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42778/tests/kraken/driver.html?testName=imaging-desaturate) 03:39:25 INFO - PROCESS | 4495 | RSS: Main: 221347840 03:39:25 INFO - PROCESS | 4495 | 03:39:27 INFO - PROCESS | 4495 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42778/tests/kraken/driver.html?testName=json-parse-financial) 03:39:28 INFO - PROCESS | 4495 | RSS: Main: 221339648 03:39:28 INFO - PROCESS | 4495 | 03:39:30 INFO - PROCESS | 4495 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42778/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:39:30 INFO - PROCESS | 4495 | RSS: Main: 185806848 03:39:30 INFO - PROCESS | 4495 | 03:39:32 INFO - PROCESS | 4495 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42778/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:39:33 INFO - PROCESS | 4495 | RSS: Main: 191340544 03:39:33 INFO - PROCESS | 4495 | 03:39:34 INFO - PROCESS | 4495 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42778/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:39:35 INFO - PROCESS | 4495 | RSS: Main: 195702784 03:39:35 INFO - PROCESS | 4495 | 03:39:38 INFO - PROCESS | 4495 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42778/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:39:38 INFO - PROCESS | 4495 | RSS: Main: 189042688 03:39:38 INFO - PROCESS | 4495 | 03:39:41 INFO - PROCESS | 4495 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42778/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:39:42 INFO - PROCESS | 4495 | RSS: Main: 194002944 03:39:42 INFO - PROCESS | 4495 | 03:39:43 INFO - PROCESS | 4495 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42778/tests/kraken/driver.html?testName=ai-astar) 03:39:43 INFO - PROCESS | 4495 | RSS: Main: 244609024 03:39:43 INFO - PROCESS | 4495 | 03:39:43 INFO - PROCESS | 4495 | __start_tp_report 03:39:43 INFO - PROCESS | 4495 | _x_x_mozilla_page_load 03:39:43 INFO - PROCESS | 4495 | _x_x_mozilla_page_load_details 03:39:43 INFO - PROCESS | 4495 | |i|pagename|runs| 03:39:43 INFO - PROCESS | 4495 | |0;ai-astar;102;111;111;111;111;111;112;110;110;110 03:39:43 INFO - PROCESS | 4495 | |1;audio-beat-detection;141;118;120;185;120;125;144;118;148;118 03:39:43 INFO - PROCESS | 4495 | |2;audio-dft;162;161;159;163;163;161;160;161;163;163 03:39:43 INFO - PROCESS | 4495 | |3;audio-fft;75;76;75;124;74;75;75;74;116;75 03:39:43 INFO - PROCESS | 4495 | |4;audio-oscillator;84;83;107;84;84;85;120;85;84;127 03:39:43 INFO - PROCESS | 4495 | |5;imaging-gaussian-blur;116;116;117;116;116;116;117;116;116;117 03:39:43 INFO - PROCESS | 4495 | |6;imaging-darkroom;146;147;146;146;147;146;146;146;146;146 03:39:43 INFO - PROCESS | 4495 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 03:39:43 INFO - PROCESS | 4495 | |8;json-parse-financial;52;61;50;51;51;52;51;51;52;50 03:39:43 INFO - PROCESS | 4495 | |9;json-stringify-tinderbox;62;63;62;62;63;65;62;64;63;62 03:39:43 INFO - PROCESS | 4495 | |10;stanford-crypto-aes;76;76;75;76;76;75;76;84;81;80 03:39:43 INFO - PROCESS | 4495 | |11;stanford-crypto-ccm;123;129;134;122;129;137;118;120;169;124 03:39:43 INFO - PROCESS | 4495 | |12;stanford-crypto-pbkdf2;153;156;157;155;156;154;151;151;152;156 03:39:43 INFO - PROCESS | 4495 | |13;stanford-crypto-sha256-iterative;62;62;65;61;62;64;64;66;61;61 03:39:43 INFO - PROCESS | 4495 | __end_tp_report 03:39:43 INFO - PROCESS | 4495 | __start_cc_report 03:39:43 INFO - PROCESS | 4495 | _x_x_mozilla_cycle_collect,1640 03:39:43 INFO - PROCESS | 4495 | __end_cc_report 03:39:43 INFO - PROCESS | 4495 | __startTimestamp1469529583969__endTimestamp 03:39:43 INFO - PROCESS | 4495 | 03:39:43 INFO - PROCESS | 4495 | ------- Summary: start ------- 03:39:43 INFO - PROCESS | 4495 | Number of tests: 14 03:39:43 INFO - PROCESS | 4495 | 03:39:43 INFO - PROCESS | 4495 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:2.85 (2.6%) stddev-sans-first:0.67 03:39:43 INFO - PROCESS | 4495 | Values: 102.0 111.0 111.0 111.0 111.0 111.0 112.0 110.0 110.0 110.0 03:39:43 INFO - PROCESS | 4495 | 03:39:43 INFO - PROCESS | 4495 | [#1] audio-beat-detection Cycles:10 Average:133.70 Median:133.00 stddev:21.57 (16.2%) stddev-sans-first:22.71 03:39:43 INFO - PROCESS | 4495 | Values: 141.0 118.0 120.0 185.0 120.0 125.0 144.0 118.0 148.0 118.0 03:39:43 INFO - PROCESS | 4495 | 03:39:43 INFO - PROCESS | 4495 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.50 stddev:1.43 (0.9%) stddev-sans-first:1.51 03:39:43 INFO - PROCESS | 4495 | Values: 162.0 161.0 159.0 163.0 163.0 161.0 160.0 161.0 163.0 163.0 03:39:43 INFO - PROCESS | 4495 | 03:39:43 INFO - PROCESS | 4495 | [#3] audio-fft Cycles:10 Average:83.90 Median:75.00 stddev:19.13 (25.5%) stddev-sans-first:20.02 03:39:43 INFO - PROCESS | 4495 | Values: 75.0 76.0 75.0 124.0 74.0 75.0 75.0 74.0 116.0 75.0 03:39:43 INFO - PROCESS | 4495 | 03:39:43 INFO - PROCESS | 4495 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:84.00 stddev:17.05 (20.3%) stddev-sans-first:17.67 03:39:43 INFO - PROCESS | 4495 | Values: 84.0 83.0 107.0 84.0 84.0 85.0 120.0 85.0 84.0 127.0 03:39:43 INFO - PROCESS | 4495 | 03:39:43 INFO - PROCESS | 4495 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:39:43 INFO - PROCESS | 4495 | Values: 116.0 116.0 117.0 116.0 116.0 116.0 117.0 116.0 116.0 117.0 03:39:43 INFO - PROCESS | 4495 | 03:39:43 INFO - PROCESS | 4495 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 03:39:43 INFO - PROCESS | 4495 | Values: 146.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 03:39:43 INFO - PROCESS | 4495 | 03:39:43 INFO - PROCESS | 4495 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:39:43 INFO - PROCESS | 4495 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 03:39:43 INFO - PROCESS | 4495 | 03:39:43 INFO - PROCESS | 4495 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:51.50 stddev:3.21 (6.2%) stddev-sans-first:3.41 03:39:43 INFO - PROCESS | 4495 | Values: 52.0 61.0 50.0 51.0 51.0 52.0 51.0 51.0 52.0 50.0 03:39:43 INFO - PROCESS | 4495 | 03:39:43 INFO - PROCESS | 4495 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:1.03 (1.6%) stddev-sans-first:1.05 03:39:43 INFO - PROCESS | 4495 | Values: 62.0 63.0 62.0 62.0 63.0 65.0 62.0 64.0 63.0 62.0 03:39:43 INFO - PROCESS | 4495 | 03:39:43 INFO - PROCESS | 4495 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:76.00 stddev:3.06 (4.0%) stddev-sans-first:3.20 03:39:43 INFO - PROCESS | 4495 | Values: 76.0 76.0 75.0 76.0 76.0 75.0 76.0 84.0 81.0 80.0 03:39:43 INFO - PROCESS | 4495 | 03:39:43 INFO - PROCESS | 4495 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:129.00 stddev:14.83 (11.5%) stddev-sans-first:15.48 03:39:43 INFO - PROCESS | 4495 | Values: 123.0 129.0 134.0 122.0 129.0 137.0 118.0 120.0 169.0 124.0 03:39:43 INFO - PROCESS | 4495 | 03:39:43 INFO - PROCESS | 4495 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.10 Median:155.50 stddev:2.23 (1.4%) stddev-sans-first:2.33 03:39:43 INFO - PROCESS | 4495 | Values: 153.0 156.0 157.0 155.0 156.0 154.0 151.0 151.0 152.0 156.0 03:39:43 INFO - PROCESS | 4495 | 03:39:43 INFO - PROCESS | 4495 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.81 (2.9%) stddev-sans-first:1.90 03:39:43 INFO - PROCESS | 4495 | Values: 62.0 62.0 65.0 61.0 62.0 64.0 64.0 66.0 61.0 61.0 03:39:43 INFO - PROCESS | 4495 | -------- Summary: end -------- 03:39:43 INFO - PROCESS | 4495 | 03:39:44 INFO - TEST-INFO | 4495: exit 0 03:39:45 INFO - TEST-OK | kraken | took 60694ms 03:39:45 INFO - SUITE-END | took 1174s 03:39:45 INFO - Completed test suite (00:19:34) 03:39:45 INFO - javascript benchmark 03:39:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3079.522673985532, 3079.9230019249517, 3101.751859851212, 3101.8914337998176, 3134.73354764845, 5255.684658920458, 5271.367435907697, 5398.298221231239, 5469.398366179722, 5512.366077901042, 5309.442508536606, 5376.596755243353, 5380.354357477108, 5422.810201642943, 5433.538149257318, 4817.975910120454, 4851.27230915362, 4890.877728056791, 4900.264960255954, 5066.214736715815, 4968.3292755477905, 4999.32509111269, 5018.673786203904, 5027.49725027498, 5034.874128146807, 4747.90504189916, 4850.102730994759, 4868.878278043042, 4887.0, 4959.528844759742, 4800.879978000543, 4812.085703716282, 4824.059308434857, 4843.443004054544, 4958.801647934079, 4798.160321943646, 4842.58837998767, 4844.394450693663, 4869.0, 4881.926771098437, 5218.76515556797, 5333.2000199969925, 5358.785648574052, 5362.329708786402, 5429.185622156669, 5793.507551858097, 5847.9415205848245, 5853.385394533598, 5853.473187413153, 5863.8534036649, 5839.240898683186, 5880.7353669085, 5881.67650779207, 5887.4406931341455, 5894.58737888348, 5230.633855630107, 5360.142377219665, 5416.8104116355735, 5420.403755586922, 5484.61607687462, 5952.404759524013, 6004.849878752979, 6004.939950600438, 6009.759609615654, 6014.278286605548, 5707.828765137053, 5715.457031581993, 5716.942830571724, 5727.742251598688, 5754.510866576388, 5597.3003374578175, 5695.629784064023, 5745.798897038583, 5757.913631295534, 5838.824835254949, 5730.713464326767, 5736.856578585485, 5737.483626473638, 5744.138379243147, 5782.971085144547, 5704.11586204139, 5729.512991395778, 5732.484076433141, 5751.539876809845, 5759.65442073477, 4299.9570004300185, 4309.762963037063, 4359.585839345257, 4381.364702118175, 4415.27148020573, 3934.390169523728, 3937.4684417603257, 3964.226975739703, 3966.6628336591134, 3993.5008123984503, 5515.227868098469, 5520.144377621395, 5527.032769265363, 5528.087865502147, 5528.778848846001, 5625.240592519957, 5772.5670574707065, 5822.737976791054, 5858.150568167677, 5918.556108291896, 5535.501804837584, 5539.446055394509, 5539.695316757617, 5549.084401073777, 5587.469190426903, 5017.974910125426, 5038.647294689336, 5040.042391945592, 5045.0, 5085.3134826797905, 5741.368449470555, 5868.67722275279, 5955.523558115254, 5970.373110823388, 5980.372060933626, 5777.2200752897825, 5795.884082318415, 5797.710114494174, 5825.213596164633, 5849.239598852122, 5961.552883533665, 5970.76116955317, 5971.701414929323, 5972.193753843176, 5974.970125149346, 5517.420670829505, 5620.887582248414, 5635.042042852643, 5640.464155905182, 5698.6580805151825, 5776.653400795965, 5807.535397168132, 5815.069588865761, 5846.35690074083, 5862.413758624274, 5637.098064309691, 5654.349749778664, 5657.2928383952, 5687.971560142173, 5690.4878560928055, 5453.291072160594, 5559.499645031967, 5587.1339942309005, 5652.971735141298, 5667.461591148999, 5566.610337276352, 5575.386707462257, 5575.498205161555, 5610.438956104357, 5626.634268772516, 5665.065264231355, 5675.7445914933105, 5719.399463056486, 5725.312962444534, 5725.599208055396, 5426.294581704353, 5450.727463626882, 5521.668699878021, 5536.197251398606, 5546.334439867242], "value": 5324.370487397872, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.7952376906195, 579.7391173971711, 600.3966014155778, 611.0620197996076, 619.9752009919602, 31864.203394915137, 45035.32447013293, 45876.311855322194, 45901.770491147494, 45955.77022114893, 46661.533384666225, 47226.291605625855, 47393.0, 47461.0, 47478.52521474784, 9145.999999999984, 9286.907130928706, 9295.44227346358, 9298.628054877796, 9298.907010929872, 9009.099090091004, 9083.95458022709, 9091.681791137311, 9094.77263068422, 9103.681371152012, 9128.406653567497, 9153.771155721093, 9166.312526560501, 9176.265898728087, 9186.081391860827, 9052.4568525888, 9069.863952040725, 9089.545522723838, 9099.63601455941, 9119.452832830018, 9058.094190580956, 9129.771755706093, 9143.405678630868, 9148.268138548967, 9151.039140890243, 43839.56160438387, 44304.113917721785, 44387.778061109486, 44412.3338149928, 44488.3326750099, 3707.1844194277214, 3749.1189570450924, 3880.611938806125, 4330.870073897788, 4374.321980093091, 33237.833810831034, 33594.83202583996, 33979.830100849336, 35786.24377504271, 36949.63050369489, 4085.2442298174933, 4203.600657937491, 4214.473190851144, 4225.894352641178, 4243.893902652428, 382642.0, 386388.0, 386476.0, 386688.0, 387705.0, 61959.69020154871, 62342.376576234565, 62390.68804655947, 62417.0, 62421.0, 58502.0, 65543.67228163924, 66580.66709666421, 67087.0, 72481.63759181276, 17670.293188272324, 17748.3788067417, 17752.3786667466, 17767.289308427517, 17785.7332140018, 12103.0, 13504.05471616997, 13529.120607160503, 13571.321433928264, 13663.18020918748, 19361.709574356395, 19542.797869581787, 20215.595688086156, 20216.29242976518, 20483.8975805123, 7154.49104189771, 7327.230640782747, 7425.554466732014, 7456.888146677804, 7561.281678240558, 984.0405604535521, 1017.760826205841, 1021.2442792333768, 1073.6456969200144, 1147.770445910821, 33551.49672754911, 33942.32115357679, 33986.49020264698, 34118.261648299514, 34319.14202144966, 1149.1553708024596, 1150.654803558929, 1168.293182624517, 1250.1998720818683, 1268.2327192048863, 17575.20911558983, 17789.604293423752, 17877.553061173574, 17898.5525361867, 17910.462686119437, 646270.0, 649466.0, 650403.0, 650504.0, 651531.0, 59797.40202597919, 60434.697826510586, 60440.395596044356, 60497.0, 60568.0, 1238.238483332762, 1324.8079028540808, 1353.3406855528933, 1380.2270728392132, 1398.2030242761732, 30929.536056958714, 34322.82838585791, 34441.655583444845, 34775.478367824, 34899.0, 50913.23630145477, 51411.0, 51416.0, 51423.22865156951, 51471.0, 426540.0, 427516.0, 428155.0, 428247.58762062393, 429068.0, 25249.11628093008, 25975.09087182015, 27549.862250688617, 28884.42231155323, 29405.411891761618, 46422.767886160356, 48792.268115979, 49513.75243123761, 50157.49842501674, 50475.0, 41340.586594133674, 42976.0, 43601.345979809696, 43610.0, 44454.77772611116, 42498.0, 42957.0, 43155.568444315155, 43983.340249896915, 44802.0, 41621.37567936423, 42410.57589424066, 42412.15175696407, 42538.57461425346, 42803.785981069894, 34789.65210347965, 36530.391563575424, 37732.81133594424, 38020.0, 38718.225635487695, 28364.290892727848, 28386.432271354046, 28668.42663146684, 29004.27489312784, 29041.273968150967], "value": 20966.012745123684, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.6319541228953, 395.6300858697118, 400.55738409057983, 402.24177425552836, 417.67421411299176, 14527.854721452783, 17403.43369096781, 18327.0, 19844.30544930926, 19855.900720496415, 19215.32746353878, 19222.423327300203, 19570.412887613358, 20542.281020164297, 20543.794562054412, 5847.8538036549, 6028.3067447243475, 6038.426349496791, 6045.697715114226, 6063.939360606381, 4346.8913277168, 5891.263592050994, 5981.6411015339, 6384.170057892491, 6698.363655452724, 6677.265500794909, 6727.260001399842, 6733.158355205599, 6736.090627765238, 6736.5958042517605, 6393.680315984206, 6560.868782624345, 6590.0, 6596.241432235306, 6600.3729645683825, 5741.942580574183, 5745.310562732457, 5813.273340832396, 5832.066869300934, 5849.883002339972, 23915.0, 23943.88028059866, 24269.271921842374, 24327.148549800673, 24493.0, 2296.7358753743365, 2320.7911287983993, 2355.9646605300936, 2403.6034054381007, 2937.0454602254354, 14749.631259218499, 14776.556703298918, 15208.771868421982, 15446.922765386213, 15803.841961580352, 1948.0649288341676, 1950.2199120351972, 1971.5071232191951, 1972.6547854125615, 1983.2860170338668, 80769.59615201886, 81834.9999999994, 82787.58606206991, 83209.0, 86102.13897861003, 10353.63762268317, 10368.429736364422, 10406.427646479366, 10996.395198264172, 11195.216334856645, 13673.0, 13713.45146194161, 13718.93140534291, 13727.656808579866, 13745.450181992608, 8173.632186551619, 8332.125126861592, 8342.207490288412, 8366.874496882552, 8518.659253629909, 8202.0, 8314.41799074071, 8447.873281900776, 8483.151684831468, 8547.572621368907, 6355.713992870332, 6385.106085148083, 6388.329225431263, 6487.07531943177, 6515.771947981798, 1867.9906600466911, 1927.8554108441922, 1930.5366711989022, 1962.0, 1978.960420791576, 918.4213945214606, 990.9405435673883, 1004.5630150884389, 1005.2058873490007, 1039.9480025998669, 20091.296804611768, 20376.592468150553, 20437.0, 20462.488437788877, 20788.376348709564, 980.1032055668983, 1009.9899001010043, 1024.9955044056867, 1030.3560274828233, 1030.3766221435924, 10921.0, 11881.5841445549, 11929.164958452999, 11964.700882477833, 11985.460654270404, 529076.0, 541880.0, 543061.0, 555276.0, 555730.0, 82766.58616706877, 83578.58210708908, 84755.57622211972, 84769.57615212008, 85405.0, 937.7374335186158, 967.849983252597, 993.64228877604, 994.9651762188289, 997.3447315588433, 17162.0, 17564.473065808048, 17909.820901790816, 17937.282508699507, 17955.0, 40784.0, 42052.57947420487, 42528.0, 42742.358864616435, 42997.57002430061, 51668.74165629148, 59863.70068149632, 61154.0, 61296.0, 62763.0, 8384.371172161991, 8623.310135189295, 8741.125887411208, 8792.47245165292, 8981.416207946462, 11473.254238474472, 13649.317534123056, 13660.248686321951, 14000.579982600539, 14080.929595351958, 11185.944070279596, 11713.41432928333, 11717.238379505305, 11889.405529723652, 11971.844988367982, 5282.577393808409, 8081.757547273592, 11384.203105782515, 11836.810190114857, 12182.0, 11600.0, 11843.644690659294, 12244.0, 12245.265284082983, 12370.690732731753, 8364.163583641588, 8527.74416767498, 8861.778455538662, 8969.14793094655, 9000.774980625536, 9594.712158635251, 11417.429128543707, 11434.085273178292, 11462.369569673749, 12006.519739210684], "value": 9539.749552691466, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.1433475408355, 1489.501017159252, 1551.6896620675864, 1647.192875491009, 1764.0738612228579, 8584.356173287006, 9043.0, 9046.819063618732, 9275.953620231889, 9287.767805804859, 9150.542472876363, 9245.0, 9251.583678734456, 9252.814943701122, 9253.676121335739, 2409.2892596683932, 2431.051889762994, 2432.063655492639, 2434.5982912819363, 2435.5494233566847, 2394.7126344838643, 2431.7081950166007, 2439.6828412306463, 2448.6939132608422, 2452.877356132195, 2356.587597170497, 2382.0709923129994, 2392.676988606533, 2394.8084153267696, 2405.7353691093967, 2328.3247858121126, 2357.434215788207, 2360.929172124839, 2370.9051637934463, 2372.2645979746335, 2298.5747636687265, 2317.826163037762, 2321.373229228099, 2324.9186278480174, 2325.383773300077, 8981.640734370618, 9097.727068187965, 9111.681091161778, 9170.174684278447, 9197.954010229972, 5313.3092697949405, 5526.861828454281, 5528.170774383874, 5534.1145416733125, 5536.0, 3387.322535492887, 3397.405454045557, 3432.048438343023, 3440.2603440260214, 3510.052285882823, 1072.6674730833388, 1086.8043752124615, 1110.2006555280186, 1132.049078773834, 1137.914656400765, 12853.35733213345, 12905.483780648763, 12917.22496650204, 12981.286029268387, 13000.349982500837, 4550.544945505423, 4683.391159149289, 4757.14371413142, 4843.4430040545085, 4861.416630004422, 10195.898041019494, 10197.286189966631, 10219.591216351411, 10221.131203847608, 10234.078932896075, 5419.430959749248, 5462.0987537056735, 5482.671039737628, 5485.232067510552, 5488.368837583729, 4501.504834468205, 4944.060628480577, 5068.82259120929, 5122.436531981479, 5128.974355128275, 3887.5334959805004, 3935.2719746846924, 4016.9196616067516, 4035.636792688672, 4056.290149223933, 1183.8461000070108, 1203.8976686981705, 1219.2136072233359, 1232.963011109668, 1237.3627581795383, 993.60752502761, 996.9252306076928, 999.9750006249902, 1009.535613617744, 1015.7206768138673, 6080.422359875804, 6211.875762484725, 6247.875042499216, 6255.499560035186, 6578.079068930354, 444.65983522605234, 455.61500532050366, 457.75967617000674, 461.8037334133047, 1049.0977759127145, 4040.939385909214, 4242.342436922282, 4253.659707223414, 4282.421873047161, 4298.806553705091, 11401.258918170292, 11717.355545444912, 11741.647750567497, 11768.764624707457, 11790.469428875722, 11641.41792910351, 11645.243059201124, 11649.417529123679, 11659.650210493699, 11710.238834475731, 8551.957240213884, 8650.43772154808, 8707.259882909897, 8771.956140219385, 8788.945326560854, 6101.9389806103145, 6303.590266632654, 6332.651704156316, 6344.873102537831, 6395.392437718409, 10619.097376723064, 10891.727706807393, 10904.61833835812, 10918.399488028235, 10930.0, 10790.946045269724, 10827.0, 10829.837552436562, 10933.453327333442, 10933.507992140532, 7149.356557909813, 7607.88588171189, 7791.259830316111, 7807.297343239135, 7964.880526792219, 9125.31560133006, 9177.449353038839, 9190.172884440433, 9197.540122993958, 9198.724038278862, 8059.758207253792, 8075.232852878967, 8087.878681819895, 8231.42380033392, 8287.709930152416, 7761.534307941542, 7821.92178078212, 7896.486728362638, 7927.960360198162, 8178.754637360888, 7125.1093613298335, 7234.421246300178, 7302.890456643261, 7305.41556675454, 7309.378702810108, 5497.560195184456, 5538.169274608841, 5558.166275058612, 5574.275344205227, 5631.943680563142, 5444.292242008513, 5485.149801780731, 5509.256250406143, 5558.694271815089, 5671.574631902541], "value": 4740.316726365735, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.88612413739594, 339.39248744746897, 342.2760860779452, 345.9965400345996, 347.7739469344925, 5301.973490132554, 5307.70807605582, 5316.893662126755, 5336.6531175473565, 5363.042489491327, 5244.632875698702, 5272.156454967197, 5283.471652834714, 5287.0437937962915, 5294.100002999489, 4162.0635357044575, 4165.104502531955, 4168.4581004469455, 4185.058361868586, 4232.132412855357, 3763.604821493745, 3976.622220889011, 4121.4848143982, 4150.564190759957, 4188.74867507949, 4115.753054816706, 4128.009277773343, 4129.194807012634, 4131.091159944807, 4148.896277593054, 4135.359019352005, 4141.233871733723, 4150.5641907599875, 4161.52142503613, 4169.770662613555, 3547.7161827053774, 3587.515685382492, 3673.779573225588, 3680.9509289852263, 3691.9446208306895, 5136.614753893436, 5175.948240517584, 5176.301199338079, 5187.584993200535, 5188.533032027098, 4735.928961065587, 4754.381930349033, 4771.427428708577, 4773.854274974016, 4774.904501909942, 5376.010875975875, 5381.354237491487, 5426.782928682848, 5431.728413579344, 5432.592555558349, 4043.2317859606583, 4044.110295734963, 4046.959530404717, 4054.918901621951, 4081.8163182656854, 5435.891282174334, 5437.184422336642, 5702.8289151325525, 5748.511376533, 5760.36635970043, 4111.1366613011005, 4119.196756632487, 4124.9587504125175, 4129.731567448106, 4139.19285739278, 4155.8753237402925, 4192.979035104805, 4208.38978348144, 4213.91572168561, 4217.135487225111, 4558.723557403932, 4734.1241870253425, 4750.429948406213, 4751.976240118846, 4759.428868535798, 5464.688474766028, 5472.7263636818, 5476.2333273341765, 5513.2005859151, 5528.723563821793, 1426.172819764534, 1439.942402303917, 1446.8987170898147, 1450.390835848946, 1450.8259008918997, 895.2345744388584, 940.9670661526814, 947.2469386837481, 951.900050494702, 962.7256231973854, 4712.293156026555, 4754.500777418321, 4757.26262429324, 4766.142094422968, 4798.928016079762, 4938.678985865908, 4939.481354457802, 4962.578180854595, 4978.875528111754, 4997.650164488524, 4653.9301910470695, 4686.437627484655, 4697.31888876111, 4721.5278472153195, 4982.800687972441, 2955.3202763364116, 2988.5666578346018, 3010.1421094987822, 3012.6744232538053, 3023.56158357037, 5846.327672317738, 5853.151293062482, 5860.3260625027815, 5865.765369385262, 5881.794137205177, 5557.166425036196, 5733.197352370671, 5763.567732420085, 5766.826995190151, 5791.652500849962, 5805.622634528742, 5820.88358232833, 5824.242848429677, 5832.766689332549, 5849.3858144894175, 5386.784528618811, 5656.60403771732, 5686.947914635805, 5691.971540142273, 5693.231413759089, 5602.439756024528, 5605.523530499953, 5616.831495055155, 5630.352509461464, 5633.436656334334, 5557.805476808292, 5732.828015159552, 5817.185594016756, 5839.299284085937, 5868.647881127146, 4033.213523362916, 4053.91892162161, 4067.186562687415, 4077.1234184650443, 4079.714419990691, 5700.543956483389, 5705.914411283751, 5705.942940570541, 5712.0, 5746.080627099644, 5341.0, 5574.721263936706, 5586.888262234814, 5599.60802743804, 5604.495595396434, 5566.304211973504, 5572.916406253828, 5586.972065139648, 5589.217509548585, 5594.216809646571, 5252.579793616578, 5549.195366671891, 5574.721263936868, 5593.916091258716, 5637.0, 5507.8984203158725, 5553.555715542666, 5565.693886836101, 5577.972110139423, 5580.748866300945, 5439.374471935778, 5458.1266997280245, 5543.778248870161, 5580.0, 5587.385387607279], "value": 4198.897459916507, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.5500801982721, 717.4260591526777, 758.8861670749387, 766.6933226709316, 860.5267103093302, 15541.378344866205, 16675.749863752055, 16697.332106715716, 16697.499075027754, 16775.41286054985, 13938.790918136236, 13991.30043497826, 14003.649908752286, 14018.439262429516, 14030.228337441436, 659.294554826336, 790.5691398187972, 795.4829360915394, 814.3851392198882, 818.9959050204741, 810.8094597769519, 822.4777266435826, 823.1480417767582, 823.2631794543879, 823.8105235795771, 846.1707526623912, 847.1697736218509, 847.8092429203441, 847.8812966184739, 848.088305072047, 691.5366704308101, 832.4256263178448, 838.0906716212917, 838.8532006898769, 851.2508992086986, 628.4595248086688, 628.8050704281687, 628.8616504369078, 629.0375725140542, 629.2291942370605, 14883.925580372137, 14969.775453368207, 15006.549803505912, 15029.699406011818, 15058.171800550965, 14163.079399838978, 14436.133831970115, 14482.275886205753, 14607.415703371853, 14685.926570367186, 11896.167268291223, 12113.576024839176, 13097.607071787861, 13290.136141150795, 13317.467301307935, 4466.955330446686, 4543.0459603483305, 4559.430071241095, 4627.375304333906, 4647.581717645395, 82229.58885205595, 83379.0, 84048.15951840465, 84250.0, 84329.57835210847, 11570.132240082028, 11611.361375124281, 11655.184137110491, 11795.233309835005, 11965.40172991347, 20554.58890822205, 20763.896180519, 20796.688049679266, 20880.0, 21156.78843211548, 8532.146785321418, 8592.269657079094, 8616.353773467015, 8626.137386261324, 8731.956340218385, 4826.227803551415, 4834.250691142808, 4909.73085091109, 4921.384826896638, 5054.595632349403, 3538.5399898013607, 3615.060084378081, 3620.511230983836, 3628.0, 3628.7097032237357, 642.0722056628221, 643.5398689936718, 647.3591144766647, 661.9768308109193, 668.8528523724773, 599.8320470268332, 645.3159650770199, 706.5478094019832, 716.2193209401777, 722.3390597603134, 9371.718848434557, 9558.330916835894, 9951.55218015191, 10010.199184065257, 10029.598816047277, 564.2692712936757, 667.219353356574, 668.4485299627827, 679.8674258519541, 760.091690429942, 4661.883452913637, 4699.929501057487, 4717.150912835654, 4776.0, 4852.0, 110426.44786776176, 110889.44555277172, 114094.0, 116012.41993789977, 116308.0, 97507.0, 98766.07403555665, 100267.49866250622, 101543.0, 102102.48948755208, 81095.59452202701, 81836.59081704554, 87713.56143219244, 88048.0, 94636.52681736548, 8485.0, 8601.612927418157, 8715.0, 8967.461952282883, 8967.641294348414, 51184.0, 51404.74297628488, 51765.48234517607, 53152.73423633012, 53894.46105538894, 53153.202701960276, 66696.6665166671, 66997.0, 67203.0, 72077.63961180371, 13882.444702212202, 13940.372683229076, 14100.153990760587, 14205.502807401692, 14849.183294918452, 15041.623959401102, 15283.15942623122, 15331.233438328261, 15414.152221627917, 15704.685906281582, 14608.269586520419, 14788.0, 14851.1831849245, 15008.249587520799, 15274.312655930733, 13540.93229533846, 13740.503649089356, 14115.576532704035, 14884.181370024753, 15004.474843380429, 13266.800997984845, 13453.394597243343, 14042.859571404564, 14074.507392241223, 14117.2941352934, 11775.352355620524, 12256.75486490283, 12259.877401226231, 12461.501539938301, 13001.414936328078, 11082.944585277022, 11281.379524125923, 11426.885731142582, 11548.769024619292, 11618.6514404568], "value": 7664.42319869536, "unit": "score"}], "name": "dromaeo_css", "value": 7386.947131586322, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 111.0, 111.0, 111.0, 112.0, 110.0, 110.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 118.0, 120.0, 185.0, 120.0, 125.0, 144.0, 118.0, 148.0, 118.0], "value": 133.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 159.0, 163.0, 163.0, 161.0, 160.0, 161.0, 163.0, 163.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 124.0, 74.0, 75.0, 75.0, 74.0, 116.0, 75.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 107.0, 84.0, 84.0, 85.0, 120.0, 85.0, 84.0, 127.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 61.0, 50.0, 51.0, 51.0, 52.0, 51.0, 51.0, 52.0, 50.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 63.0, 65.0, 62.0, 64.0, 63.0, 62.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 76.0, 76.0, 75.0, 76.0, 84.0, 81.0, 80.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 129.0, 134.0, 122.0, 129.0, 137.0, 118.0, 120.0, 169.0, 124.0], "value": 130.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 156.0, 157.0, 155.0, 156.0, 154.0, 151.0, 151.0, 152.0, 156.0], "value": 154.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 65.0, 61.0, 62.0, 64.0, 64.0, 66.0, 61.0, 61.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1480.7999999999997, "alertThreshold": 2.0}]} 03:39:45 INFO - Return code: 0 03:39:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:39:45 INFO - # TBPL SUCCESS # 03:39:45 INFO - Running post-action listener: _resource_record_post_action 03:39:45 INFO - [mozharness: 2016-07-26 10:39:45.275801Z] Finished run-tests step (success) 03:39:45 INFO - Running post-run listener: _resource_record_post_run 03:39:45 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 564903936; Read time: 76; Write time: 617332 03:39:45 INFO - TinderboxPrint: CPU usage
13.0% 03:39:45 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 76 03:39:45 INFO - TinderboxPrint: I/O write bytes / time
564,903,936 / 617,332 03:39:45 INFO - TinderboxPrint: CPU idle
8,277.1 (87.0%) 03:39:45 INFO - TinderboxPrint: CPU user
1,190.8 (12.5%) 03:39:45 INFO - TinderboxPrint: Swap in / out
0 / 0 03:39:45 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 270503936; Read time: 0; Write time: 321532 03:39:45 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294400000; Read time: 64; Write time: 295800 03:39:45 INFO - Running post-run listener: _upload_blobber_files 03:39:45 INFO - Blob upload gear active. 03:39:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:39:45 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 03:39:45 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:39:45 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:39:46 INFO - (blobuploader) - INFO - Open directory for files ... 03:39:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:39:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:39:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:47 INFO - (blobuploader) - INFO - Done attempting. 03:39:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:39:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:40:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:06 INFO - (blobuploader) - INFO - Done attempting. 03:40:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:40:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:40:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:07 INFO - (blobuploader) - INFO - Done attempting. 03:40:07 INFO - (blobuploader) - INFO - Iteration through files over. 03:40:07 INFO - Return code: 0 03:40:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:40:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:40:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/294f1437193e86a657a3a638ed2e346a121fc5f02aa6ade8576acf50cb5771f0b183bf2d18f5ff1e3a585e983321f0fc44b2ecb4c178295a18a83dd97a16b618", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/94d162f31c80900f98215c2acc52906bc552ac6576767626d9c19e59acaab1ce5b636aa74a36b246b68f51cb260e56731e5f50c3be897750348057acced9d786", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f71e273b7e16fa4113fc9556dc99fab5ba432d1da252907c040e9735c05fc8bc0318050cc5f184ab07577ac70e77e58b1dd2f34f67bc2aefb053a37d20fd2a06"} 03:40:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:40:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:40:07 INFO - Contents: 03:40:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/294f1437193e86a657a3a638ed2e346a121fc5f02aa6ade8576acf50cb5771f0b183bf2d18f5ff1e3a585e983321f0fc44b2ecb4c178295a18a83dd97a16b618", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/94d162f31c80900f98215c2acc52906bc552ac6576767626d9c19e59acaab1ce5b636aa74a36b246b68f51cb260e56731e5f50c3be897750348057acced9d786", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f71e273b7e16fa4113fc9556dc99fab5ba432d1da252907c040e9735c05fc8bc0318050cc5f184ab07577ac70e77e58b1dd2f34f67bc2aefb053a37d20fd2a06"} 03:40:07 INFO - Running post-run listener: copy_logs_to_upload_dir 03:40:07 INFO - Copying logs to upload dir... 03:40:07 INFO - mkdir: /builds/slave/test/build/upload/logs 03:40:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.986452 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-26 03:40:06.710968) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 03:40:06.714651) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/294f1437193e86a657a3a638ed2e346a121fc5f02aa6ade8576acf50cb5771f0b183bf2d18f5ff1e3a585e983321f0fc44b2ecb4c178295a18a83dd97a16b618", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/94d162f31c80900f98215c2acc52906bc552ac6576767626d9c19e59acaab1ce5b636aa74a36b246b68f51cb260e56731e5f50c3be897750348057acced9d786", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f71e273b7e16fa4113fc9556dc99fab5ba432d1da252907c040e9735c05fc8bc0318050cc5f184ab07577ac70e77e58b1dd2f34f67bc2aefb053a37d20fd2a06"} build_url:https://queue.taskcluster.net/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://queue.taskcluster.net/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/294f1437193e86a657a3a638ed2e346a121fc5f02aa6ade8576acf50cb5771f0b183bf2d18f5ff1e3a585e983321f0fc44b2ecb4c178295a18a83dd97a16b618", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/94d162f31c80900f98215c2acc52906bc552ac6576767626d9c19e59acaab1ce5b636aa74a36b246b68f51cb260e56731e5f50c3be897750348057acced9d786", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f71e273b7e16fa4113fc9556dc99fab5ba432d1da252907c040e9735c05fc8bc0318050cc5f184ab07577ac70e77e58b1dd2f34f67bc2aefb053a37d20fd2a06"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 03:40:06.740068) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 03:40:06.740415) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1469528357.558026-1434056163 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-26 03:40:06.825041) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 03:40:06.825370) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 03:40:06.825676) ========= ========= Total master_lag: 0.17 =========