builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1468257802.27 results: success (0) buildid: 20160711073136 builduid: 5ff2b1cde5bc48e0a8f3024d32e31355 revision: 2de28b975423d18acbc965d6f29ae396c2f1bef3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 10:23:22.267041) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 10:23:22.267991) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 10:23:22.268642) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 10:23:22.308760) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 10:23:22.309021) ========= 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=14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 10:23:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 29.3M=0s 2016-07-11 10:23:22 (29.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081598 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 10:23:22.407232) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 10:23:22.407961) ========= 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=14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015747 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 10:23:22.460719) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 10:23:22.461378) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 2de28b975423d18acbc965d6f29ae396c2f1bef3 --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 2de28b975423d18acbc965d6f29ae396c2f1bef3 --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=14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 10:23:22,932 truncating revision to first 12 chars 2016-07-11 10:23:22,932 Setting DEBUG logging. 2016-07-11 10:23:22,932 attempt 1/10 2016-07-11 10:23:22,932 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/2de28b975423?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 10:23:23,250 unpacking tar archive at: mozilla-inbound-2de28b975423/testing/mozharness/ program finished with exit code 0 elapsedTime=0.657220 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 10:23:23.133688) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 10:23:23.134175) ========= script_repo_revision: 2de28b975423d18acbc965d6f29ae396c2f1bef3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 10:23:23.134654) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 10:23:23.135006) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 10:23:23.152218) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-11 10:23:23.152537) ========= /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=14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:23:23 INFO - MultiFileLogger online at 20160711 10:23:23 in /builds/slave/test 10:23:23 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 10:23:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:23:23 INFO - {'append_to_log': False, 10:23:23 INFO - 'base_work_dir': '/builds/slave/test', 10:23:23 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:23:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:23:23 INFO - 'branch': 'Mozilla-Inbound', 10:23:23 INFO - 'buildbot_json_path': 'buildprops.json', 10:23:23 INFO - 'config_files': ('talos/linux_config.py',), 10:23:23 INFO - 'default_actions': ('clobber', 10:23:23 INFO - 'read-buildbot-config', 10:23:23 INFO - 'download-and-extract', 10:23:23 INFO - 'populate-webroot', 10:23:23 INFO - 'create-virtualenv', 10:23:23 INFO - 'install', 10:23:23 INFO - 'run-tests'), 10:23:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:23:23 INFO - 'download_minidump_stackwalk': True, 10:23:23 INFO - 'download_symbols': 'ondemand', 10:23:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:23:23 INFO - 'tooltool.py': '/tools/tooltool.py', 10:23:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:23:23 INFO - '/tools/misc-python/virtualenv.py')}, 10:23:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:23:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:23:23 INFO - 'installer_path': 'installer.exe', 10:23:23 INFO - 'log_level': 'info', 10:23:23 INFO - 'log_name': 'talos', 10:23:23 INFO - 'log_to_console': True, 10:23:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:23:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:23:23 INFO - 'opt_config_files': (), 10:23:23 INFO - 'pip_index': False, 10:23:23 INFO - 'sps_profile': False, 10:23:23 INFO - 'sps_profile_interval': 0, 10:23:23 INFO - 'suite': 'dromaeojs', 10:23:23 INFO - 'system_bits': '32', 10:23:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:23:23 INFO - 'title': 'talos-linux64-ix-036', 10:23:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:23:23 INFO - 'use_talos_json': True, 10:23:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:23:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:23:23 INFO - 'work_dir': 'build'} 10:23:23 INFO - ##### 10:23:23 INFO - ##### Running clobber step. 10:23:23 INFO - ##### 10:23:23 INFO - Running pre-action listener: _resource_record_pre_action 10:23:23 INFO - Running main action method: clobber 10:23:23 INFO - rmtree: /builds/slave/test/build 10:23:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:23:24 INFO - Running post-action listener: _resource_record_post_action 10:23:24 INFO - ##### 10:23:24 INFO - ##### Finished clobber step (success) 10:23:24 INFO - ##### 10:23:24 INFO - ##### 10:23:24 INFO - ##### Running read-buildbot-config step. 10:23:24 INFO - ##### 10:23:24 INFO - Running pre-action listener: _resource_record_pre_action 10:23:24 INFO - Running main action method: read_buildbot_config 10:23:24 INFO - Using buildbot properties: 10:23:24 INFO - { 10:23:24 INFO - "project": "", 10:23:24 INFO - "product": "firefox", 10:23:24 INFO - "script_repo_revision": "production", 10:23:24 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 10:23:24 INFO - "repository": "", 10:23:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 10:23:24 INFO - "buildid": "20160711073136", 10:23:24 INFO - "pgo_build": "True", 10:23:24 INFO - "basedir": "/builds/slave/test", 10:23:24 INFO - "buildnumber": 1229, 10:23:24 INFO - "slavename": "talos-linux64-ix-036", 10:23:24 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:23:24 INFO - "platform": "ubuntu64_hw", 10:23:24 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:23:24 INFO - "branch": "mozilla-inbound", 10:23:24 INFO - "repo_path": "integration/mozilla-inbound", 10:23:24 INFO - "revision": "2de28b975423d18acbc965d6f29ae396c2f1bef3", 10:23:24 INFO - "stage_platform": "linux64-pgo", 10:23:24 INFO - "builduid": "5ff2b1cde5bc48e0a8f3024d32e31355", 10:23:24 INFO - "slavebuilddir": "test" 10:23:24 INFO - } 10:23:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/HImbvD2lRZegHAAjc8G1PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:23:24 INFO - Running post-action listener: _resource_record_post_action 10:23:24 INFO - ##### 10:23:24 INFO - ##### Finished read-buildbot-config step (success) 10:23:24 INFO - ##### 10:23:24 INFO - ##### 10:23:24 INFO - ##### Running download-and-extract step. 10:23:24 INFO - ##### 10:23:24 INFO - Running pre-action listener: _resource_record_pre_action 10:23:24 INFO - Running main action method: download_and_extract 10:23:24 INFO - mkdir: /builds/slave/test/build/tests 10:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:24 INFO - https://queue.taskcluster.net/v1/task/HImbvD2lRZegHAAjc8G1PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:23:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HImbvD2lRZegHAAjc8G1PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:23:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HImbvD2lRZegHAAjc8G1PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:23:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HImbvD2lRZegHAAjc8G1PQ/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 10:23:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HImbvD2lRZegHAAjc8G1PQ/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 10:23:24 INFO - Downloaded 1361 bytes. 10:23:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:23:24 INFO - Using the following test package requirements: 10:23:24 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:23:24 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:23:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:23:24 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:23:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:23:24 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:23:24 INFO - u'jsshell-linux-x86_64.zip'], 10:23:24 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:23:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:23:24 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:23:24 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:23:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:23:24 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:23:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:23:24 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:23:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:23:24 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:23:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:23:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:24 INFO - https://queue.taskcluster.net/v1/task/HImbvD2lRZegHAAjc8G1PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:23:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HImbvD2lRZegHAAjc8G1PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:23:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HImbvD2lRZegHAAjc8G1PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:23:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HImbvD2lRZegHAAjc8G1PQ/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 10:23:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HImbvD2lRZegHAAjc8G1PQ/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 10:23:25 INFO - Downloaded 24307417 bytes. 10:23:25 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'] 10:23:25 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 10:23:27 INFO - Return code: 0 10:23:27 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 10:23: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')]} 10:23:27 INFO - https://queue.taskcluster.net/v1/task/HImbvD2lRZegHAAjc8G1PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:23:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HImbvD2lRZegHAAjc8G1PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:23:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HImbvD2lRZegHAAjc8G1PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:23:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HImbvD2lRZegHAAjc8G1PQ/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 10:23:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HImbvD2lRZegHAAjc8G1PQ/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 10:23:28 INFO - Downloaded 24307417 bytes. 10:23:28 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'] 10:23:28 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 10:23:30 INFO - Return code: 0 10:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:30 INFO - https://queue.taskcluster.net/v1/task/HImbvD2lRZegHAAjc8G1PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:23:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HImbvD2lRZegHAAjc8G1PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:23:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HImbvD2lRZegHAAjc8G1PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:23:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HImbvD2lRZegHAAjc8G1PQ/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 10:23:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HImbvD2lRZegHAAjc8G1PQ/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 10:23:31 INFO - Downloaded 14403333 bytes. 10:23:31 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'] 10:23:31 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 10:23:31 INFO - Return code: 0 10:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:31 INFO - https://queue.taskcluster.net/v1/task/HImbvD2lRZegHAAjc8G1PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:23:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HImbvD2lRZegHAAjc8G1PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:23:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HImbvD2lRZegHAAjc8G1PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:23:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HImbvD2lRZegHAAjc8G1PQ/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 10:23:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HImbvD2lRZegHAAjc8G1PQ/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 10:23:32 INFO - Downloaded 60488286 bytes. 10:23:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HImbvD2lRZegHAAjc8G1PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:23:32 INFO - mkdir: /builds/slave/test/properties 10:23:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:23:32 INFO - Writing to file /builds/slave/test/properties/build_url 10:23:32 INFO - Contents: 10:23:32 INFO - build_url:https://queue.taskcluster.net/v1/task/HImbvD2lRZegHAAjc8G1PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:23:33 INFO - Running post-action listener: _resource_record_post_action 10:23:33 INFO - Running post-action listener: set_extra_try_arguments 10:23:33 INFO - ##### 10:23:33 INFO - ##### Finished download-and-extract step (success) 10:23:33 INFO - ##### 10:23:33 INFO - ##### 10:23:33 INFO - ##### Running populate-webroot step. 10:23:33 INFO - ##### 10:23:33 INFO - Running pre-action listener: _resource_record_pre_action 10:23:33 INFO - Running main action method: populate_webroot 10:23:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:23:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:23:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:23:33 INFO - '--tppagecycles', 10:23:33 INFO - '7'], 10:23:33 INFO - 'tests': ['tsvgm']}}, 10:23:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:23:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:23:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:23:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:23:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:23:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:23:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:33 INFO - 'talos_options': ['--disable-e10s'], 10:23:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:23:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:23:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:33 INFO - 'talos_options': ['--disable-e10s'], 10:23:33 INFO - 'tests': ['damp', 'tps']}, 10:23:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:33 INFO - 'tests': ['damp', 'tps']}, 10:23:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:23:33 INFO - 'tests': ['dromaeo_dom']}, 10:23:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:23:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:23:33 INFO - 'tests': ['basic_compositor_video']}, 10:23:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:23:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:23:33 INFO - 'tests': ['a11yr', 10:23:33 INFO - 'ts_paint', 10:23:33 INFO - 'tpaint', 10:23:33 INFO - 'sessionrestore', 10:23:33 INFO - 'sessionrestore_no_auto_restore', 10:23:33 INFO - 'tabpaint']}, 10:23:33 INFO - 'other-e10s': {'tests': ['a11yr', 10:23:33 INFO - 'ts_paint', 10:23:33 INFO - 'tpaint', 10:23:33 INFO - 'sessionrestore', 10:23:33 INFO - 'sessionrestore_no_auto_restore', 10:23:33 INFO - 'tabpaint']}, 10:23:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:23:33 INFO - 'ts_paint', 10:23:33 INFO - 'tpaint', 10:23:33 INFO - 'sessionrestore', 10:23:33 INFO - 'sessionrestore_no_auto_restore', 10:23:33 INFO - 'tabpaint']}, 10:23:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:23:33 INFO - 'ts_paint', 10:23:33 INFO - 'tpaint', 10:23:33 INFO - 'sessionrestore', 10:23:33 INFO - 'sessionrestore_no_auto_restore', 10:23:33 INFO - 'tabpaint']}, 10:23:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:23:33 INFO - 'tests': ['a11yr', 10:23:33 INFO - 'ts_paint', 10:23:33 INFO - 'tpaint', 10:23:33 INFO - 'sessionrestore', 10:23:33 INFO - 'sessionrestore_no_auto_restore', 10:23:33 INFO - 'tabpaint']}, 10:23:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:23:33 INFO - 'tests': ['a11yr', 10:23:33 INFO - 'ts_paint', 10:23:33 INFO - 'tpaint', 10:23:33 INFO - 'sessionrestore', 10:23:33 INFO - 'sessionrestore_no_auto_restore', 10:23:33 INFO - 'tabpaint']}, 10:23:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:23:33 INFO - 'tests': ['tsvgx', 10:23:33 INFO - 'tsvgr_opacity', 10:23:33 INFO - 'tart', 10:23:33 INFO - 'tscrollx', 10:23:33 INFO - 'cart']}, 10:23:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:23:33 INFO - 'tsvgr_opacity', 10:23:33 INFO - 'tart', 10:23:33 INFO - 'tscrollx', 10:23:33 INFO - 'cart']}, 10:23:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:33 INFO - 'talos_options': ['--disable-e10s'], 10:23:33 INFO - 'tests': ['tp5o']}, 10:23:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:33 INFO - 'tests': ['tp5o']}, 10:23:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:33 INFO - 'talos_options': ['--disable-e10s', 10:23:33 INFO - '--xperf_path', 10:23:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:23:33 INFO - 'tests': ['tp5n']}, 10:23:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:33 INFO - 'talos_options': ['--xperf_path', 10:23:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:23:33 INFO - 'tests': ['tp5n']}}, 10:23:33 INFO - 'talos.zip': {'path': '', 10:23:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:23:33 INFO - Running post-action listener: _resource_record_post_action 10:23:33 INFO - ##### 10:23:33 INFO - ##### Finished populate-webroot step (success) 10:23:33 INFO - ##### 10:23:33 INFO - ##### 10:23:33 INFO - ##### Running create-virtualenv step. 10:23:33 INFO - ##### 10:23:33 INFO - Running pre-action listener: _resource_record_pre_action 10:23:33 INFO - Running main action method: create_virtualenv 10:23:33 INFO - Creating virtualenv /builds/slave/test/build/venv 10:23:33 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 10:23:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:23:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:23:33 INFO - Using real prefix '/usr' 10:23:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:23:34 INFO - Installing distribute.............................................................................................................................................................................................done. 10:23:36 INFO - Installing pip.................done. 10:23:36 INFO - Return code: 0 10:23:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:36 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 0x1cb0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f71180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f3b0>, '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 0x1f702b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f70740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189', '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 10:23:36 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 10:23:36 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 10:23:36 INFO - Using env: {'DISPLAY': ':0', 10:23:36 INFO - 'HOME': '/home/cltbld', 10:23:36 INFO - 'LANG': 'en_US.UTF-8', 10:23:36 INFO - 'LANGUAGE': 'en_US:en', 10:23:36 INFO - 'LOGNAME': 'cltbld', 10:23:36 INFO - 'MAIL': '/var/mail/cltbld', 10:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:36 INFO - 'MOZ_NO_REMOTE': '1', 10:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:23:36 INFO - 'NO_EM_RESTART': '1', 10:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:36 INFO - 'PWD': '/builds/slave/test', 10:23:36 INFO - 'SHELL': '/bin/bash', 10:23:36 INFO - 'SHLVL': '1', 10:23:36 INFO - 'TERM': 'linux', 10:23:36 INFO - 'TMOUT': '86400', 10:23:36 INFO - 'USER': 'cltbld', 10:23:36 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189', 10:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:36 INFO - '_': '/tools/buildbot/bin/python'} 10:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:36 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 10:23:36 INFO - Cleaning up... 10:23:36 INFO - Return code: 0 10:23:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:36 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 0x1cb0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f71180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f3b0>, '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 0x1f702b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f70740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189', '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 10:23:36 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 10:23:36 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 10:23:36 INFO - Using env: {'DISPLAY': ':0', 10:23:36 INFO - 'HOME': '/home/cltbld', 10:23:36 INFO - 'LANG': 'en_US.UTF-8', 10:23:36 INFO - 'LANGUAGE': 'en_US:en', 10:23:36 INFO - 'LOGNAME': 'cltbld', 10:23:36 INFO - 'MAIL': '/var/mail/cltbld', 10:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:36 INFO - 'MOZ_NO_REMOTE': '1', 10:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:23:36 INFO - 'NO_EM_RESTART': '1', 10:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:36 INFO - 'PWD': '/builds/slave/test', 10:23:36 INFO - 'SHELL': '/bin/bash', 10:23:36 INFO - 'SHLVL': '1', 10:23:36 INFO - 'TERM': 'linux', 10:23:36 INFO - 'TMOUT': '86400', 10:23:36 INFO - 'USER': 'cltbld', 10:23:36 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189', 10:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:36 INFO - '_': '/tools/buildbot/bin/python'} 10:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:36 INFO - Downloading/unpacking psutil>=3.1.1 10:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:23:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:23:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:23:38 INFO - Installing collected packages: psutil 10:23:38 INFO - Running setup.py install for psutil 10:23:38 INFO - building 'psutil._psutil_linux' extension 10:23:38 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 10:23:38 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 10:23:38 INFO - building 'psutil._psutil_posix' extension 10:23:38 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 10:23:38 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 10:23:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:23:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:23:39 INFO - Successfully installed psutil 10:23:39 INFO - Cleaning up... 10:23:39 INFO - Return code: 0 10:23:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:23: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')]} 10:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23: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')]} 10:23:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f71180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f3b0>, '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 0x1f702b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f70740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189', '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 10:23: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:23: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 mozsystemmonitor==0.3 10:23:39 INFO - Using env: {'DISPLAY': ':0', 10:23:39 INFO - 'HOME': '/home/cltbld', 10:23:39 INFO - 'LANG': 'en_US.UTF-8', 10:23:39 INFO - 'LANGUAGE': 'en_US:en', 10:23:39 INFO - 'LOGNAME': 'cltbld', 10:23:39 INFO - 'MAIL': '/var/mail/cltbld', 10:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:39 INFO - 'MOZ_NO_REMOTE': '1', 10:23:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:23:39 INFO - 'NO_EM_RESTART': '1', 10:23:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:39 INFO - 'PWD': '/builds/slave/test', 10:23:39 INFO - 'SHELL': '/bin/bash', 10:23:39 INFO - 'SHLVL': '1', 10:23:39 INFO - 'TERM': 'linux', 10:23:39 INFO - 'TMOUT': '86400', 10:23:39 INFO - 'USER': 'cltbld', 10:23:39 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189', 10:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:39 INFO - '_': '/tools/buildbot/bin/python'} 10:23:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:23: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 10:23: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 10:23: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 10:23: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 10:23: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 10:23: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 10:23:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:23:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:23:41 INFO - Installing collected packages: mozsystemmonitor 10:23:41 INFO - Running setup.py install for mozsystemmonitor 10:23:41 INFO - Successfully installed mozsystemmonitor 10:23:41 INFO - Cleaning up... 10:23:41 INFO - Return code: 0 10:23:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:23:41 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')]} 10:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:41 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')]} 10:23:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:41 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 0x1cb0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f71180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f3b0>, '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 0x1f702b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f70740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189', '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 10:23:41 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 10:23:41 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 10:23:41 INFO - Using env: {'DISPLAY': ':0', 10:23:41 INFO - 'HOME': '/home/cltbld', 10:23:41 INFO - 'LANG': 'en_US.UTF-8', 10:23:41 INFO - 'LANGUAGE': 'en_US:en', 10:23:41 INFO - 'LOGNAME': 'cltbld', 10:23:41 INFO - 'MAIL': '/var/mail/cltbld', 10:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:41 INFO - 'MOZ_NO_REMOTE': '1', 10:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:23:41 INFO - 'NO_EM_RESTART': '1', 10:23:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:41 INFO - 'PWD': '/builds/slave/test', 10:23:41 INFO - 'SHELL': '/bin/bash', 10:23:41 INFO - 'SHLVL': '1', 10:23:41 INFO - 'TERM': 'linux', 10:23:41 INFO - 'TMOUT': '86400', 10:23:41 INFO - 'USER': 'cltbld', 10:23:41 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189', 10:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:41 INFO - '_': '/tools/buildbot/bin/python'} 10:23:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:41 INFO - Downloading/unpacking jsonschema==2.5.1 10:23: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 10:23: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 10:23: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 10:23: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 10:23: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 10:23: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 10:23:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:23:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:23:43 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 10:23:43 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 10:23:43 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 10:23:43 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 10:23:43 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 10:23:43 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 10:23:43 INFO - Downloading functools32-3.2.3-2.tar.gz 10:23:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:23:43 INFO - warning: no files found matching '*.txt' 10:23:43 INFO - no previously-included directories found matching 'build' 10:23:43 INFO - no previously-included directories found matching 'dist' 10:23:43 INFO - no previously-included directories found matching '.git*' 10:23:43 INFO - Installing collected packages: jsonschema, functools32 10:23:43 INFO - Running setup.py install for functools32 10:23:43 INFO - warning: no files found matching '*.txt' 10:23:43 INFO - no previously-included directories found matching 'build' 10:23:43 INFO - no previously-included directories found matching 'dist' 10:23:43 INFO - no previously-included directories found matching '.git*' 10:23:43 INFO - Successfully installed jsonschema functools32 10:23:43 INFO - Cleaning up... 10:23:44 INFO - Return code: 0 10:23:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:44 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 0x1cb0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f71180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f3b0>, '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 0x1f702b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f70740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189', '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 10:23:44 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 10:23:44 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 10:23:44 INFO - Using env: {'DISPLAY': ':0', 10:23:44 INFO - 'HOME': '/home/cltbld', 10:23:44 INFO - 'LANG': 'en_US.UTF-8', 10:23:44 INFO - 'LANGUAGE': 'en_US:en', 10:23:44 INFO - 'LOGNAME': 'cltbld', 10:23:44 INFO - 'MAIL': '/var/mail/cltbld', 10:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:44 INFO - 'MOZ_NO_REMOTE': '1', 10:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:23:44 INFO - 'NO_EM_RESTART': '1', 10:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:44 INFO - 'PWD': '/builds/slave/test', 10:23:44 INFO - 'SHELL': '/bin/bash', 10:23:44 INFO - 'SHLVL': '1', 10:23:44 INFO - 'TERM': 'linux', 10:23:44 INFO - 'TMOUT': '86400', 10:23:44 INFO - 'USER': 'cltbld', 10:23:44 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189', 10:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:44 INFO - '_': '/tools/buildbot/bin/python'} 10:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:44 INFO - Downloading/unpacking blobuploader==1.2.4 10:23: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 10:23: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 10:23: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 10:23: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 10:23: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 10:23: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 10:23:46 INFO - Downloading blobuploader-1.2.4.tar.gz 10:23:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:23:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:23:46 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 10:23:46 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 10:23:46 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 10:23:46 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 10:23:46 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 10:23:46 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 10:23:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:23:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:23:46 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 10:23:46 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 10:23:46 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 10:23:46 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 10:23:46 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 10:23:46 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 10:23:46 INFO - Downloading docopt-0.6.1.tar.gz 10:23:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:23:46 INFO - Installing collected packages: blobuploader, requests, docopt 10:23:46 INFO - Running setup.py install for blobuploader 10:23:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:23:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:23:47 INFO - Running setup.py install for requests 10:23:47 INFO - Running setup.py install for docopt 10:23:47 INFO - Successfully installed blobuploader requests docopt 10:23:47 INFO - Cleaning up... 10:23:47 INFO - Return code: 0 10:23:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:23:47 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')]} 10:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:47 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')]} 10:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:47 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 0x1cb0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f71180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f3b0>, '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 0x1f702b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f70740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189', '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 10:23:47 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 10:23:47 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 10:23:47 INFO - Using env: {'DISPLAY': ':0', 10:23:47 INFO - 'HOME': '/home/cltbld', 10:23:47 INFO - 'LANG': 'en_US.UTF-8', 10:23:47 INFO - 'LANGUAGE': 'en_US:en', 10:23:47 INFO - 'LOGNAME': 'cltbld', 10:23:47 INFO - 'MAIL': '/var/mail/cltbld', 10:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:47 INFO - 'MOZ_NO_REMOTE': '1', 10:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:23:47 INFO - 'NO_EM_RESTART': '1', 10:23:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:47 INFO - 'PWD': '/builds/slave/test', 10:23:47 INFO - 'SHELL': '/bin/bash', 10:23:47 INFO - 'SHLVL': '1', 10:23:47 INFO - 'TERM': 'linux', 10:23:47 INFO - 'TMOUT': '86400', 10:23:47 INFO - 'USER': 'cltbld', 10:23:47 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189', 10:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:47 INFO - '_': '/tools/buildbot/bin/python'} 10:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:23:47 INFO - Running setup.py (path:/tmp/pip-TUW23T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:23:47 INFO - Running setup.py (path:/tmp/pip-r_jlMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:23:47 INFO - Running setup.py (path:/tmp/pip-ApYRkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:23:47 INFO - Running setup.py (path:/tmp/pip-XZIl9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:23:48 INFO - Running setup.py (path:/tmp/pip-4qi2fV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:23:48 INFO - Running setup.py (path:/tmp/pip-oV6SUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:23:48 INFO - Running setup.py (path:/tmp/pip-7V1a5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:23:48 INFO - Running setup.py (path:/tmp/pip-reJThA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:23:48 INFO - Running setup.py (path:/tmp/pip-odKWUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:23:48 INFO - Running setup.py (path:/tmp/pip-mjwAIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:23:48 INFO - Running setup.py (path:/tmp/pip-I8F2Iq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:23:48 INFO - Running setup.py (path:/tmp/pip-NFSeVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:23:48 INFO - Running setup.py (path:/tmp/pip-dfvYx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:23:48 INFO - Running setup.py (path:/tmp/pip-qAdJfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:23:48 INFO - Running setup.py (path:/tmp/pip-CHT3Dw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:23:48 INFO - Running setup.py (path:/tmp/pip-qs3UHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:23:48 INFO - Running setup.py (path:/tmp/pip-9Mtbis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:23:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:23:48 INFO - Running setup.py install for manifestparser 10:23:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:23:49 INFO - Running setup.py install for mozcrash 10:23:49 INFO - Running setup.py install for mozdebug 10:23:49 INFO - Running setup.py install for mozdevice 10:23:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:23:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:23:49 INFO - Running setup.py install for mozfile 10:23:49 INFO - Running setup.py install for mozhttpd 10:23:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:23:49 INFO - Running setup.py install for mozinfo 10:23:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:23:49 INFO - Running setup.py install for mozInstall 10:23:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:23:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:23:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:23:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:23:49 INFO - Running setup.py install for mozleak 10:23:49 INFO - Running setup.py install for mozlog 10:23:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:23:50 INFO - Running setup.py install for moznetwork 10:23:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:23:50 INFO - Running setup.py install for mozprocess 10:23:50 INFO - Running setup.py install for mozprofile 10:23:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:23:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:23:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:23:50 INFO - Running setup.py install for mozrunner 10:23:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:23:50 INFO - Running setup.py install for mozscreenshot 10:23:50 INFO - Running setup.py install for moztest 10:23:50 INFO - Running setup.py install for mozversion 10:23:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:23:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:23:50 INFO - Cleaning up... 10:23:50 INFO - Return code: 0 10:23:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:23:50 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')]} 10:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:50 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')]} 10:23:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:50 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 0x1cb0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f71180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f3b0>, '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 0x1f702b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f70740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189', '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 10:23:50 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 10:23:50 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 10:23:50 INFO - Using env: {'DISPLAY': ':0', 10:23:50 INFO - 'HOME': '/home/cltbld', 10:23:50 INFO - 'LANG': 'en_US.UTF-8', 10:23:50 INFO - 'LANGUAGE': 'en_US:en', 10:23:50 INFO - 'LOGNAME': 'cltbld', 10:23:50 INFO - 'MAIL': '/var/mail/cltbld', 10:23:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:50 INFO - 'MOZ_NO_REMOTE': '1', 10:23:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:23:50 INFO - 'NO_EM_RESTART': '1', 10:23:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:23:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:50 INFO - 'PWD': '/builds/slave/test', 10:23:50 INFO - 'SHELL': '/bin/bash', 10:23:50 INFO - 'SHLVL': '1', 10:23:50 INFO - 'TERM': 'linux', 10:23:50 INFO - 'TMOUT': '86400', 10:23:50 INFO - 'USER': 'cltbld', 10:23:50 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189', 10:23:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:50 INFO - '_': '/tools/buildbot/bin/python'} 10:23:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:23:51 INFO - Running setup.py (path:/tmp/pip-AWws25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:23:51 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)) 10:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:23:51 INFO - Running setup.py (path:/tmp/pip-AH4l3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:23:51 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)) 10:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:23:51 INFO - Running setup.py (path:/tmp/pip-_F2wha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:23:51 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)) 10:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:23:51 INFO - Running setup.py (path:/tmp/pip-P_pz2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:23:51 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)) 10:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:23:51 INFO - Running setup.py (path:/tmp/pip-5fxIxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:23:51 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)) 10:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:23:51 INFO - Running setup.py (path:/tmp/pip-8o80O5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:23:51 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)) 10:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:23:51 INFO - Running setup.py (path:/tmp/pip-PKBW5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:23:51 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)) 10:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:23:51 INFO - Running setup.py (path:/tmp/pip-lak8VR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:23:51 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)) 10:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:23:51 INFO - Running setup.py (path:/tmp/pip-UwH6RK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:23:51 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)) 10:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:23:51 INFO - Running setup.py (path:/tmp/pip-y1fazG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:23:51 INFO - Running setup.py (path:/tmp/pip-tEvwlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:23:51 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)) 10:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:23:51 INFO - Running setup.py (path:/tmp/pip-4v5GA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:23:51 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)) 10:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:23:51 INFO - Running setup.py (path:/tmp/pip-calFsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:23:51 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)) 10:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:23:51 INFO - Running setup.py (path:/tmp/pip-WOC3Z2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:23:52 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)) 10:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:23:52 INFO - Running setup.py (path:/tmp/pip-MtfpJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:23:52 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)) 10:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:23:52 INFO - Running setup.py (path:/tmp/pip-SvYlSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:23:52 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)) 10:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:23:52 INFO - Running setup.py (path:/tmp/pip-5uzbW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:23:52 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)) 10:23:52 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)) 10:23:52 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)) 10:23:52 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)) 10:23:52 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)) 10:23:52 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)) 10:23:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:23:52 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 10:23:52 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 10:23:52 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 10:23:52 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 10:23:52 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 10:23:52 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 10:23:54 INFO - Downloading blessings-1.6.tar.gz 10:23:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:23:54 INFO - Installing collected packages: blessings 10:23:54 INFO - Running setup.py install for blessings 10:23:54 INFO - Successfully installed blessings 10:23:54 INFO - Cleaning up... 10:23:54 INFO - Return code: 0 10:23:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:23:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:23:54 INFO - Reading from file tmpfile_stdout 10:23:54 INFO - Current package versions: 10:23:54 INFO - argparse == 1.2.1 10:23:54 INFO - blessings == 1.6 10:23:54 INFO - blobuploader == 1.2.4 10:23:54 INFO - docopt == 0.6.1 10:23:54 INFO - functools32 == 3.2.3-2 10:23:54 INFO - jsonschema == 2.5.1 10:23:54 INFO - manifestparser == 1.1 10:23:54 INFO - mozInstall == 1.12 10:23:54 INFO - mozcrash == 0.17 10:23:54 INFO - mozdebug == 0.1 10:23:54 INFO - mozdevice == 0.48 10:23:54 INFO - mozfile == 1.2 10:23:54 INFO - mozhttpd == 0.7 10:23:54 INFO - mozinfo == 0.9 10:23:54 INFO - mozleak == 0.1 10:23:54 INFO - mozlog == 3.2 10:23:54 INFO - moznetwork == 0.27 10:23:54 INFO - mozprocess == 0.23 10:23:54 INFO - mozprofile == 0.28 10:23:54 INFO - mozrunner == 6.12 10:23:54 INFO - mozscreenshot == 0.1 10:23:54 INFO - mozsystemmonitor == 0.3 10:23:54 INFO - moztest == 0.7 10:23:54 INFO - mozversion == 1.4 10:23:54 INFO - psutil == 3.1.1 10:23:54 INFO - requests == 1.2.3 10:23:54 INFO - wsgiref == 0.1.2 10:23:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:23:54 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')]} 10:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:54 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')]} 10:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:54 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 0x1cb0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f71180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f3b0>, '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 0x1f702b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f70740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189', '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 10:23:54 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 10:23:54 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 10:23:54 INFO - Using env: {'DISPLAY': ':0', 10:23:54 INFO - 'HOME': '/home/cltbld', 10:23:54 INFO - 'LANG': 'en_US.UTF-8', 10:23:54 INFO - 'LANGUAGE': 'en_US:en', 10:23:54 INFO - 'LOGNAME': 'cltbld', 10:23:54 INFO - 'MAIL': '/var/mail/cltbld', 10:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:54 INFO - 'MOZ_NO_REMOTE': '1', 10:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:23:54 INFO - 'NO_EM_RESTART': '1', 10:23:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:54 INFO - 'PWD': '/builds/slave/test', 10:23:54 INFO - 'SHELL': '/bin/bash', 10:23:54 INFO - 'SHLVL': '1', 10:23:54 INFO - 'TERM': 'linux', 10:23:54 INFO - 'TMOUT': '86400', 10:23:54 INFO - 'USER': 'cltbld', 10:23:54 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189', 10:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:54 INFO - '_': '/tools/buildbot/bin/python'} 10:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:54 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)) 10:23:54 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)) 10:23:54 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)) 10:23:54 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)) 10:23:54 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)) 10:23:54 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)) 10:23:54 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)) 10:23:54 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)) 10:23:54 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)) 10:23:54 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)) 10:23:54 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)) 10:23:54 INFO - Cleaning up... 10:23:54 INFO - Return code: 0 10:23:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:23:54 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')]} 10:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:54 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')]} 10:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:54 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 0x1cb0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f71180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f3b0>, '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 0x1f702b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f70740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189', '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 10:23:54 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 10:23:54 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 10:23:54 INFO - Using env: {'DISPLAY': ':0', 10:23:54 INFO - 'HOME': '/home/cltbld', 10:23:54 INFO - 'LANG': 'en_US.UTF-8', 10:23:54 INFO - 'LANGUAGE': 'en_US:en', 10:23:54 INFO - 'LOGNAME': 'cltbld', 10:23:54 INFO - 'MAIL': '/var/mail/cltbld', 10:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:54 INFO - 'MOZ_NO_REMOTE': '1', 10:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:23:54 INFO - 'NO_EM_RESTART': '1', 10:23:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:54 INFO - 'PWD': '/builds/slave/test', 10:23:54 INFO - 'SHELL': '/bin/bash', 10:23:54 INFO - 'SHLVL': '1', 10:23:54 INFO - 'TERM': 'linux', 10:23:54 INFO - 'TMOUT': '86400', 10:23:54 INFO - 'USER': 'cltbld', 10:23:54 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189', 10:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:54 INFO - '_': '/tools/buildbot/bin/python'} 10:23:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:23:55 INFO - Cleaning up... 10:23:55 INFO - Return code: 0 10:23:55 INFO - Running post-action listener: _resource_record_post_action 10:23:55 INFO - Running post-action listener: _start_resource_monitoring 10:23:55 INFO - Starting resource monitoring. 10:23:55 INFO - ##### 10:23:55 INFO - ##### Finished create-virtualenv step (success) 10:23:55 INFO - ##### 10:23:55 INFO - ##### 10:23:55 INFO - ##### Running install step. 10:23:55 INFO - ##### 10:23:55 INFO - Running pre-action listener: _resource_record_pre_action 10:23:55 INFO - Running main action method: install 10:23:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:23:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:23:55 INFO - Reading from file tmpfile_stdout 10:23:55 INFO - Detecting whether we're running mozinstall >=1.0... 10:23:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:23:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:23:55 INFO - Reading from file tmpfile_stdout 10:23:55 INFO - Output received: 10:23:55 INFO - Usage: mozinstall [options] installer 10:23:55 INFO - Options: 10:23:55 INFO - -h, --help show this help message and exit 10:23:55 INFO - -d DEST, --destination=DEST 10:23:55 INFO - Directory to install application into. [default: 10:23:55 INFO - "/builds/slave/test"] 10:23:55 INFO - --app=APP Application being installed. [default: firefox] 10:23:55 INFO - mkdir: /builds/slave/test/build/application 10:23:55 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'] 10:23:55 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 10:24:12 INFO - Reading from file tmpfile_stdout 10:24:12 INFO - Output received: 10:24:12 INFO - /builds/slave/test/build/application/firefox/firefox 10:24:12 INFO - Running post-action listener: _resource_record_post_action 10:24:12 INFO - ##### 10:24:12 INFO - ##### Finished install step (success) 10:24:12 INFO - ##### 10:24:12 INFO - ##### 10:24:12 INFO - ##### Running run-tests step. 10:24:12 INFO - ##### 10:24:12 INFO - Running pre-action listener: _resource_record_pre_action 10:24:12 INFO - Running main action method: run_tests 10:24:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:24:12 INFO - Python 2.7.3 10:24:12 INFO - Return code: 0 10:24:12 INFO - grabbing minidump binary from tooltool 10:24:12 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')]} 10:24:12 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 0x1f6f3b0>, '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 0x1f702b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f70740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:24:12 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 10:24:12 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 10:24:12 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 10:24:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:24:12 INFO - Return code: 0 10:24:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:24:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:24:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:24:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:24:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:24:12 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/HImbvD2lRZegHAAjc8G1PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 10:24:12 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/HImbvD2lRZegHAAjc8G1PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 10:24:12 INFO - Using env: {'DISPLAY': ':0', 10:24:12 INFO - 'HOME': '/home/cltbld', 10:24:12 INFO - 'LANG': 'en_US.UTF-8', 10:24:12 INFO - 'LANGUAGE': 'en_US:en', 10:24:12 INFO - 'LOGNAME': 'cltbld', 10:24:12 INFO - 'MAIL': '/var/mail/cltbld', 10:24:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:24:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:12 INFO - 'MOZ_NO_REMOTE': '1', 10:24:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:24:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:24:12 INFO - 'NO_EM_RESTART': '1', 10:24:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:12 INFO - 'PWD': '/builds/slave/test', 10:24:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:24:12 INFO - 'SHELL': '/bin/bash', 10:24:12 INFO - 'SHLVL': '1', 10:24:12 INFO - 'TERM': 'linux', 10:24:12 INFO - 'TMOUT': '86400', 10:24:12 INFO - 'USER': 'cltbld', 10:24:12 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189', 10:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:12 INFO - '_': '/tools/buildbot/bin/python'} 10:24:12 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/HImbvD2lRZegHAAjc8G1PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 10:24:12 INFO - mozversion application_buildid: 20160711073136 10:24:12 INFO - mozversion application_changeset: 2de28b975423d18acbc965d6f29ae396c2f1bef3 10:24:12 INFO - mozversion application_display_name: Nightly 10:24:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:24:12 INFO - mozversion application_name: Firefox 10:24:12 INFO - mozversion application_remotingname: firefox 10:24:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:24:12 INFO - mozversion application_vendor: Mozilla 10:24:12 INFO - mozversion application_version: 50.0a1 10:24:12 INFO - mozversion platform_buildid: 20160711073136 10:24:12 INFO - mozversion platform_changeset: 2de28b975423d18acbc965d6f29ae396c2f1bef3 10:24:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:24:12 INFO - mozversion platform_version: 50.0a1 10:24:12 INFO - using testdate: 1468257852 10:24:12 INFO - actual date: 1468257852 10:24:12 INFO - starting webserver on 'localhost:58060' 10:24:12 INFO - SUITE-START | Running 2 tests 10:24:12 INFO - TEST-START | dromaeo_css 10:24:12 INFO - operating with platform_type : linux_ 10:24:12 INFO - Initialising browser for dromaeo_css test... 10:24:12 INFO - TEST-INFO | started process 898 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfi7QyY/profile http://localhost:58060/getInfo.html) 10:24:16 INFO - PROCESS | 898 | __metrics Screen width/height:1600/1200 10:24:16 INFO - PROCESS | 898 | colorDepth:24 10:24:16 INFO - PROCESS | 898 | Browser inner width/height: 1024/697 10:24:16 INFO - PROCESS | 898 | __metrics 10:24:17 INFO - PROCESS | 898 | 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" 10:24:17 INFO - PROCESS | 898 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:24:18 INFO - TEST-INFO | 898: exit 0 10:24:18 INFO - Browser initialized. 10:24:18 INFO - Running cycle 1/1 for dromaeo_css test... 10:24:18 INFO - TEST-INFO | started process 982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfi7QyY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:24:30 INFO - PROCESS | 982 | RSS: Main: 158081024 10:24:30 INFO - PROCESS | 982 | 10:25:21 INFO - PROCESS | 982 | 1468257921902 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] 10:27:29 INFO - PROCESS | 982 | Cycle 1(1): loaded http://localhost:58060/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58060/tests/dromaeo/cssquery-ext.html) 10:27:30 INFO - PROCESS | 982 | RSS: Main: 248238080 10:27:30 INFO - PROCESS | 982 | 10:30:33 INFO - PROCESS | 982 | Cycle 1(1): loaded http://localhost:58060/tests/dromaeo/cssquery-ext.html (next: http://localhost:58060/tests/dromaeo/cssquery-jquery.html) 10:30:33 INFO - PROCESS | 982 | RSS: Main: 251297792 10:30:33 INFO - PROCESS | 982 | 10:33:35 INFO - PROCESS | 982 | Cycle 1(1): loaded http://localhost:58060/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58060/tests/dromaeo/cssquery-mootools.html) 10:33:36 INFO - PROCESS | 982 | RSS: Main: 248868864 10:33:36 INFO - PROCESS | 982 | 10:36:38 INFO - PROCESS | 982 | Cycle 1(1): loaded http://localhost:58060/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58060/tests/dromaeo/cssquery-prototype.html) 10:36:38 INFO - PROCESS | 982 | RSS: Main: 241987584 10:36:38 INFO - PROCESS | 982 | 10:39:41 INFO - PROCESS | 982 | Cycle 1(1): loaded http://localhost:58060/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58060/tests/dromaeo/cssquery-yui.html) 10:39:41 INFO - PROCESS | 982 | RSS: Main: 228556800 10:39:41 INFO - PROCESS | 982 | 10:42:44 INFO - PROCESS | 982 | Cycle 1(1): loaded http://localhost:58060/tests/dromaeo/cssquery-yui.html (next: http://localhost:58060/tests/dromaeo/cssquery-dojo.html) 10:42:45 INFO - PROCESS | 982 | RSS: Main: 289644544 10:42:45 INFO - PROCESS | 982 | 10:42:45 INFO - PROCESS | 982 | __start_tp_report 10:42:45 INFO - PROCESS | 982 | _x_x_mozilla_page_load 10:42:45 INFO - PROCESS | 982 | _x_x_mozilla_page_load_details 10:42:45 INFO - PROCESS | 982 | |i|pagename|runs| 10:42:45 INFO - PROCESS | 982 | |0;dojo.html;3028.7576993840494;3069.1866655336353;3089.057837359605;3091.6290045194564;3105.4875945469;5261.973690131554;5355.116405793045;5388.110961691316;5451.345838499381;5467.316585426826;5359.169328754049;5369.275147855038;5395.514403703666;5419.83740487786;5426.240326354314;4838.661293709451;4931.211006239003;4931.482194369593;4945.62907781916;5070.062038522867;4972.428170760372;4980.4272508661425;5007.549320561149;5027.49725027498;5029;4745.122152401799;4796.25658023007;4803.279508073782;4852.733099679516;4865.805367785284;4860.538248866387;4869.196582563873;4872.3909511311085;4931.038447502739;4983.053219888246;4902.8774280643265;4905.754712264373;4912.877178070541;4915.188993816016;4925.2858335541505;5267;5343.679379237258;5439.4832490913695;5494.917576236359;5516.668999859981;5857;5880.176775251468;5881.500072493843;5891.970540147315;5916.26046744157;5633.63381380209;5779.046457334534;5936.7922122725495;5967.9701601491715;5972.134040564138;5419.972900135514;5495.890082198333;5529.751161197756;5547.916781248285;5556.777728890839;6050.630771296217;6065.568859285597;6070.539005679006;6097.054956481752;6111.022236442148;5489.011977844027;5763.221965034751;5775.653460792366;5796.710164491758;5800.477956983892;5791.88416231673;5832.533397328203;5841.211436456109;5890.440408161217;5896.6756828374855;5789.247397838254;5794.768209271582;5798.449147330997;5804.245448091806;5806.912896306559;5603.131514615241;5726.570507211975;5775.8556036099435;5816.5055970243;5823.242978412779;4424.247877860771;4440.578145076212;4451.376807246988;4468.352088947149;4489.573490518395;3910.765354078764;3925.862594809168;3930.8820735377985;3944.36890097583;3970.1861118470642;5259;5324.9733751331;5384.811531596453;5498.505134537831;5549.528290095387;5833.941660583425;5855.707214639251;5883.61756485827;5897.321807992136;5935;5499.092649712753;5499.285092937973;5501.724913754297;5502.8349149525575;5505.256790333254;4913.975430122827;4932.827351042696;4959.107360675041;5060.898782024413;5107.770150343244;5925.496332811673;5936.7031648417405;5936.851578710481;5966.880662386815;6000.369961154103;5807.912881306868;5814.592978491634;5816.5055970243;5823.301203855564;5828.417158284137;5802.709864506842;5908.970455147697;5928.851778705567;5961.642301461926;5962;5676.7161641918565;5719.942800572107;5722.914156287576;5733.254676891977;5733.827985160452;5811.244538210006;5850.473457388855;5870.207521984477;5891.05743081105;5891.1752354669525;5515.972420137874;5615.887682246251;5669.518090962314;5716.085426331767;5758.481736643722;5679.574031947703;5680.289963754531;5680.318361796446;5681.971590142023;5688.54491640676;5444.537214336826;5625.662460252398;5631.324241091095;5646.802361917313;5648.745806438638;5622.662640241599;5664.320281566238;5682.261306030189;5711.314642242957;5782.479576838105;5598.300212473441;5599.80400685974;5602.1036634138345;5613.747381367766;5622.8313150605545 10:42:45 INFO - PROCESS | 982 | |1;ext.html;622.6202016769771;637.6301744987906;647.4043879630742;647.7635662983013;649.2598437780928;30596.847015764917;42485.78757106214;43444.348334774964;43475.34786978198;47078.52921470793;44759.10481790362;45031.549684503145;45125;45135.09729805402;45147.54852451474;8844.380893337453;8975.955120224422;8990.865137022916;8995.28037756978;9000;8897.822043559125;8959.820803583925;8985.730428087169;8988.370814043019;8990.056044115372;8995.550222488882;9020.639174433014;9034.503102329369;9042.86435703465;9044.321675874302;8970.910290897105;8990.685326013558;8999.145081217306;9013.954930225373;9030.27757779376;8785.64857405703;8837.072107428692;8855.468671879644;8870.73387798367;8873.068327825615;42450.78774606138;42754.78622606867;42771.57228427707;42792.14415711699;42838;3490.703290220334;3567.8037707926055;3655.1958569114754;3686.207465394926;4004.899877503057;31912.680873191202;32661;32909;33319;34476.65523344759;3885.2812229737588;3961.4057891316534;3971.384435412516;4013.9965008747813;4064.0855807443386;357147;357717;359154;360111.1938843363;360866;48648.51351486511;56704.14943775847;57173.42826571681;57258.713706431205;57290.42709572934;48577.514224857296;52414.47585524172;52433.7378313106;57859.421405785404;59329.40670593325;15991.040537567784;16091.356345746273;16107.516774496784;16127.596810079607;16235.431759888348;13270.933645331712;13336.5332213374;13399.866001340057;13425.932870335586;13444.260565668983;14099.577012689431;15427.382904683687;15664;15682.529524114294;15688.76466852998;5952.523798096142;6254.6872656366995;6299;6339.619622822645;6340.985442329205;977.4672803322206;1010.8129995950626;1028.4265074436125;1062.3997441445558;1127.0589058136384;33653.663463365054;34011.31977360439;34613.82693086519;35985.46021809675;36114.638853611126;1102.7022703869911;1155.7110722319421;1186.662747657314;1188.9881101188878;1190.5892467098838;16049.839501605067;16474.83525164733;16684.49946501607;16742.832571674127;17012.48962531126;554960;557949;558079;559481;560415;55783.48974296166;57258.141127883115;57365.42634573684;57378;57608.71195643995;1368.2201145347256;1388.6944872128115;1397.2594524901817;1406.5358431717304;1409.9506517271845;29776.885586449378;30681.693183068775;31137.221569460038;31222;31239.84380078085;50366;50730.74634626803;50770.74614626903;50806.74596626993;50906.745466272434;526002;526038;529419;530978;531132;24493.75506244915;27024.86487567628;27083;27426.5886011706;27539.862300688368;46634;46682.53317466917;47031.294530581385;47621.52378476309;47862.76068619634;38841.417378739905;40418.1916361677;40998.385024224066;41107.383389249786;41851.58148418598;39578;40256.59743402646;40326.1934761309;40376.78869633916;40458.1908361837;39085.218295633356;39535.20929581335;39682.80158599189;40122.79938600288;40554.1889162221;34194.65805342014;35683.46474802932;36414.63304885174;36659.266814663024;36712.26575468529;26878.462430751668;27250.727492724818;27432.862835685693;27538.17385478439;27599.724002759714 10:42:45 INFO - PROCESS | 982 | |2;jquery.html;379.90462810898526;382.50465646987146;390.95894931032234;396.77582166076166;415.0640306109722;14597.197154156516;17845.7323140153;18940.81059189408;20453.693194602092;20454.488637784045;19820.405387838353;20232.29186978456;20474.48813779656;20596.588068238627;20624.793752062476;5753.482186603205;5950.672713000783;5958.255218097738;5981.910271345933;5999.730012149464;4187.246295666779;5815.447532484428;5932.228810254661;6350.872982540346;6717.09319241901;6698.363655452748;6736.865262694743;6759.628220447873;6760.797176084725;6774.8306292342595;6391.808245752635;6534.640594767286;6548.1814773153355;6554.082428460043;6556.475481961432;5107.642465027449;5436.456354364572;5666.631668941505;5668.68822214778;5672.461116193955;14064.859351406458;14258.358373873201;14406.855931440656;14515;24239.272821815375;2165.436986383552;2279.350385140244;2298.2071185441164;2358.068562917638;2793.553031514968;9998.600055997751;10021.148202402805;10477.790444191074;10481.318714283547;10603.257771955967;1930.6621341265222;1943.885379510983;1958.8530860185542;1996.2613832881782;2080.6878968154747;78607;85216.57391713063;86213.56893215494;86347.56826215892;90146.54926725324;11108.16688748347;11174;11276.54893804255;11282.887171128348;11352.943235283936;15264.23678816077;15299.46451874179;15339.846601534065;15372.615684607974;15411.768823467657;8056.637451314705;8278.420510564203;8348.165183481724;8457.830843383097;8495.36284778644;8257.133001034805;8257.42198046131;8271.875921861178;8434.409591328671;8461.915380846112;4460.219461594208;4460.643148548108;4546.477155127137;4557.134144512598;4586.908261834745;1967.8228959393723;1993.8504612153856;1999.4001799460104;2006.6889632107047;2012.5874195789827;883.3595643158659;952.9904700952902;955.4219697083304;1038.2213339995003;1043.994780026095;19205.519862003563;19626.607467850565;19783.40649780509;20027.59944801096;20250.392488225378;986.2603047714215;999.6001599360169;1003.7289931718395;1011.3274672342957;1042.1089968077335;10498.842517362245;10945.671629851116;10963.83554246687;11044.33733975964;11069.335839849473;472754;479591;481265;495490;497123;53227.467725323026;91912.54043729873;98012;102598.48700756449;103927;922.276013329533;939.178219058324;971.0968799016982;975.068809287129;1009.1119814563137;17992.37026704059;18125;18477.16852741603;18518.684760437212;18639.254429822657;45290.64128076163;45949.54050459452;46229.76885115553;47573;47618;59662.70168649129;61333.69333153305;64350.67824660847;64951;65454;8556.529390883561;8562.657493700182;8610.225079742853;8766;8834.867476987722;9536.809263814546;13711.657208569866;14619;14669.633259168606;14797.704045919236;11822.408879555816;12200.755984880076;12290.631281061582;12345.38273086324;12453;7755.875398067135;7918.564478953713;12368.814467782811;12577.93711031439;12585;12283.631491055283;12323.383830808245;12381.319027453577;12657.746845063231;12782.68043298925;8390.580470976549;8646.265067469336;8765.430247033923;8823.426477278956;8952.23905968;11463.254888432226;12049.578264760692;12054.638360849189;12071.456784444897;12286 10:42:45 INFO - PROCESS | 982 | |3;mootools.html;1474.7419201639714;1507.977380339295;1602.3430393538645;1757.8593712503;1784.4735802938148;7800.258975397328;8278.710245141407;8499.447535910169;8977.461352318856;8984.19142277194;8397.412181147321;8556.786080347994;8864.512451815148;8881.333899957497;8920.330975176872;2346.5893468643003;2412.975870241293;2416.2871952773976;2418.117387153685;2421.2131057406327;2010.3667344786345;2301.3671240408853;2304.700388949434;2336.439254578906;2372.7627237276306;2312.976870231293;2335.8364914455997;2339.4385347516645;2340.8829558522093;2341.1103780563362;2219.367480268124;2233.8212942964687;2250.4936389312275;2251.470904337479;2253.177590179581;2236.384994126628;2236.7651396603287;2245.012194634372;2247.415671925311;2247.6965609642652;8852.424592401474;8926.821463570757;8927.196552310323;8935.419197752126;8947.239484643747;5257.08001099806;5367.221752845854;5379.704116273603;5421.1326187810155;5435.646682965595;3238.8138006845284;3264.347130573895;3350.5644266245477;3352.899413017589;3368.0569440556683;1085.104788549442;1101.7465982823915;1135.9034482069035;1146.8623765148152;1147.552454542729;12415;12573.497060117494;12653;12699;12712;4653.23221668421;4712.198926182557;4843.491433399442;4858.17411040124;4898.975505122452;10669.253152279265;10702.518386672462;10711.83932241017;10753.51609177589;10800.405977671304;5404.91892621611;5409.56723462122;5419.918701219485;5422.837314880481;5442.510174084351;4847.781849816767;4863.902721945541;4923.803047878117;4926.5073492650445;4969.304297398367;3916.4516967624554;3954.367301231789;4010.598940105966;4054.493188351456;4096.713230073926;1179.6755892129734;1268.7969924811987;1278.0733967873218;1326.5357125006365;1327.8008298755071;979.7354714227118;982.9262805289632;991.6876184002016;997.8913605179486;1007.8337074382645;6097.725602347905;6201.658908760061;6273.749050037947;6286.214223222098;6402.743890244431;975.0980343182528;975.8487434447673;1014.5130337438071;1021.2085633633844;1024.4109636958779;4256.34026725858;4378.2119218540965;4438.467383913887;4468.486124095771;4478.611630394588;10885.782284354427;11162.66512004625;11236.381998989971;11267;11286.322820630625;10809.83785243222;10954.3427394355;11090.611828586123;11132;11236.606718764804;8392.328613710888;8401.11788262248;8407.201315874981;8451.661933522713;8487.193716596914;5869.119632055226;6082.2701275847185;6188;6318.589291696025;6357.241925896609;10226.897731022595;10352.120069793851;10364.326318789555;10397.16822654201;10579.947100264757;10467.062527398068;10521.368717876952;10749.677509674722;10753.677389678322;10841.241113122005;8162.0613629431;8216.876746848682;8294.54380009081;8299.294559962229;8305.169483051646;8247.917520824714;8510.234078932926;8599.484030958163;8691.521966291662;8794.252488538546;7787.571683557232;7812.492188007761;7850.33272171849;7926.128125906031;7927.088384835818;7892.881606776018;7936.444448888522;7943.364530837403;7978.401619878417;8133.34933205354;6692.933070669231;6947.65261736901;6957.304269573002;7113.679884405111;7120.537165084253;5300.416954135119;5422.051141050221;5430.104032834538;5443.156310771837;5499.642523235977;5456.099743542271;5475.370332411664;5508.641938274;5508.80719174843;5559.805406810742 10:42:45 INFO - PROCESS | 982 | |4;prototype.html;332.9711192415436;334.62689101651665;340.59639327397036;340.9284050349427;343.91745980964544;5366.248725178473;5389.434109418514;5391.191321301807;5399.811006614769;5400.9189862152;5268.47315268473;5343.412224655285;5354.330708661418;5363.8122665706705;5364.517193452589;3980.761154330735;4019.919601607966;4156.231097247019;4167.52073511547;4222.366645003243;4149.751014939098;4166.958330416687;4188.958110418887;4190.601892820177;4213.9367909481225;3976.403539469088;4144.8549300774475;4148.108156746299;4152.397902304164;4163.167366526692;4032.9395059074136;4056.336901870219;4072.2059198456163;4144.730592511477;4157.5864206169745;3680.3191409589313;3691.778493290384;3692.7415080944343;3705.8517659293598;3716.2939041582013;5164.6642968207325;5172.491341699273;5186.455422180655;5191.195364718475;5206.765695543671;4512.661550383735;4778.5699287064335;4788.928166077511;4802.711837289774;4806.663533552653;5431.728413579305;5497.587680923907;5516.365617953947;5522.530584900248;5524.309461317335;3967.7420967637013;3996.4205190247253;4000.4599379083743;4008.8997775055564;4017.417474466186;5565.30433695788;5772.538196944192;5773.220615216934;5773.422657734235;5777.248957635523;3991.84032638697;4025.879223623296;4027.5903433797935;4027.9124636348024;4031.496062992126;4077.7757223353;4079.530853951774;4103.194594378464;4110.856120035784;4112.198121366365;4596.7931443085145;4636.884077898012;4662.743549104832;4701.5533524315815;4710.081534100886;5475.808346707846;5523.558115350762;5538.919910617391;5544.251526044013;5553.305836770403;1401.4254155796075;1402.7895815627737;1410.5697762182429;1413.9010269281052;1420.936057877398;903.7514683461969;906.8367693815045;917.9173874351341;932.6802574357345;933.6312156698066;4738.431388233434;4744.430668319824;4752.263399173134;4757.690750101302;4770.856874293777;5003.974980125149;5066.138756411419;5069.845315740796;5096.337476128154;5164.147915593885;4471.8658440246845;4765.690230135099;4766.904661906812;4845.9030819383415;4846.418429788448;2682.637843891089;2692.3000019994943;2700.2979225401145;2703.8643769616806;2710.186943916817;5170.482951704875;5185.922211166836;5209.348831396075;5209.426963034063;5229.6727956059185;4819.240977043424;5004.524570165829;5046.990601879639;5131.56381707559;5228.9738551307;5183.755898584388;5183.766730497136;5208.739563021833;5222.4255331913455;5272.6836389816735;5034.521720436553;5051.722155281494;5063.088644044107;5098.5411312982005;5105.948940510547;4829.517048295143;4986.351774269322;4986.80052797884;4996.425411077627;5015.22264049073;5198.948010519997;5199.324087868553;5206.583473322201;5216.582673386044;5240.34495688039;3760.2855457462992;3773.603771603942;3788.1855401088897;3789.6020917804335;3807.857642707121;5116.692998420107;5122.282880396673;5300.416954134965;5456.181572763959;5720.199172115824;5435.456454354533;5612.522935550524;5638.689872057076;5638.85902852432;5640.182173584889;5574.944250557604;5603.915941260802;5604;5612.775488980558;5634.183043458757;5258.710770907637;5526.397344770133;5535.280413546213;5538.750756215899;5545.889082218252;5591.27313449249;5603.131514615241;5605.915911261252;5614.354349249726;5663.292088488939;5484.862878428071;5510.201020852034;5543.8891222176135;5565.666060036411;5579.69311687861 10:42:45 INFO - PROCESS | 982 | |5;yui.html;730.7186733107756;759.7075126076459;790.4901338636575;806.3025482957241;846.7883029242689;14648.633784155389;15748.685026299467;15750.448734294288;16048;16319.265633046512;13188.208707477534;13334.199948003126;14645.780313295309;14901.105933643988;15072.47246346378;666.1140682891743;798.1180795221284;802.0736049862404;821.1214001018913;823.2878560045548;803.441608082383;804.6781287484994;805.9597020148998;806.2300503019602;806.4999700185894;854;856.3662889461816;856.4775486952954;857.0486759696763;857.1514200941086;696.2967402923034;710.3287393413226;820.4543978254453;845.8392905347964;848.5799529233008;616.5868867858545;617.4103730936945;617.629422346593;617.7652492053036;618.2766163588612;14119;14189.290535473288;14295.428182872673;14322;14371.568852934428;13702.588922332347;13858.099223550436;13958.93020534901;13963.860361396357;14277.071990320595;12429.987181980925;12500.937495312557;12626.936865315707;12753.362331883462;13119.47522099115;4358.65130789536;4425.579569940851;4428.180786554465;4431.645468362523;4634.814607415699;81267;81336.90395457843;81839.59080204621;82105;82351.17648823436;11153.665390038312;11302.491387887565;11343;11408.144389170679;11459.140564457699;19857.205711771658;19939.003049847448;21271;21342.253021144184;21364.78635213659;7664.770056898302;7785.416093792988;7951.522908625501;8203.343732501386;8682.088380720059;4601.493835678073;4783.617310615143;4837.7097374157665;4854.077725232265;4965.230389289666;3333.5999680038067;3453.637368076366;3475.7914525128067;3479.6520347965;3479.739019573542;526.8208809004957;653.8300041989118;655.5869802024694;700.1423256510734;703.9260877607777;706.1843570675775;713.3722324354535;717.3651318583092;730.8867125595541;746.1233051164968;9899.861193733974;10016.972013597508;10065.194784417228;10232.334898231591;10247.795044099077;594.5124997502007;677.5223467455432;695.6347917343435;719.5610677486729;722.1154086244309;4666.696664716783;4804.471508134103;5156.484351564814;5221.895562088813;5388.7305634718105;100156.49921750344;101604.49197753964;124006;124293.37853310857;126592;99860;100686.49656751669;101290;102125;102500;87575;87630.56184719036;88160.11839881519;91143;91256;10064.899351006396;10320.881226053736;10414.687559373231;10511.474426278808;10515.316504427188;52656.736716316176;53722;54155;54353.72823135859;56292.718536407054;71131.64434177797;79657.60171199107;80247;81127.59436202781;81338.59330703308;12644.557440489538;12842.293673848028;13228.404721787736;13610.659733506742;13647.795283070564;9128.680496182868;14714.264286785832;14791.112533248039;14923.626909327353;15774.684506310039;12942.417591208607;13203.735925281248;13389.330533473481;13719.588412347646;13730.794038089236;13842.930785346009;14144;14152;14321.14073155614;14480.420783168976;13909.58271251864;14176.574702758933;14260.572182834532;14385.712285754436;14624.780628290371;11546.42267886619;11557.479913404086;11580;11661.06711463098;12141.575044873387;10864.402457864893;10991.698821462176;11533;11575.826362604399;11881.82177267359 10:42:45 INFO - PROCESS | 982 | __end_tp_report 10:42:45 INFO - PROCESS | 982 | __start_cc_report 10:42:45 INFO - PROCESS | 982 | _x_x_mozilla_cycle_collect,784 10:42:45 INFO - PROCESS | 982 | __end_cc_report 10:42:45 INFO - PROCESS | 982 | __startTimestamp1468258965125__endTimestamp 10:42:45 INFO - PROCESS | 982 | 10:42:45 INFO - PROCESS | 982 | ------- Summary: start ------- 10:42:45 INFO - PROCESS | 982 | Number of tests: 6 10:42:45 INFO - PROCESS | 982 | 10:42:45 INFO - PROCESS | 982 | [#0] dojo.html Cycles:165 Average:5393.09 Median:5613.75 stddev:630.10 (11.2%) stddev-sans-first:604.12 10:42:45 INFO - PROCESS | 982 | Values: 3028.8 3069.2 3089.1 3091.6 3105.5 5262.0 5355.1 5388.1 5451.3 5467.3 5359.2 5369.3 5395.5 5419.8 5426.2 4838.7 4931.2 4931.5 4945.6 5070.1 4972.4 4980.4 5007.5 5027.5 5029.0 4745.1 4796.3 4803.3 4852.7 4865.8 4860.5 4869.2 4872.4 4931.0 4983.1 4902.9 4905.8 4912.9 4915.2 4925.3 5267.0 5343.7 5439.5 5494.9 5516.7 5857.0 5880.2 5881.5 5892.0 5916.3 5633.6 5779.0 5936.8 5968.0 5972.1 5420.0 5495.9 5529.8 5547.9 5556.8 6050.6 6065.6 6070.5 6097.1 6111.0 5489.0 5763.2 5775.7 5796.7 5800.5 5791.9 5832.5 5841.2 5890.4 5896.7 5789.2 5794.8 5798.4 5804.2 5806.9 5603.1 5726.6 5775.9 5816.5 5823.2 4424.2 4440.6 4451.4 4468.4 4489.6 3910.8 3925.9 3930.9 3944.4 3970.2 5259.0 5325.0 5384.8 5498.5 5549.5 5833.9 5855.7 5883.6 5897.3 5935.0 5499.1 5499.3 5501.7 5502.8 5505.3 4914.0 4932.8 4959.1 5060.9 5107.8 5925.5 5936.7 5936.9 5966.9 6000.4 5807.9 5814.6 5816.5 5823.3 5828.4 5802.7 5909.0 5928.9 5961.6 5962.0 5676.7 5719.9 5722.9 5733.3 5733.8 5811.2 5850.5 5870.2 5891.1 5891.2 5516.0 5615.9 5669.5 5716.1 5758.5 5679.6 5680.3 5680.3 5682.0 5688.5 5444.5 5625.7 5631.3 5646.8 5648.7 5622.7 5664.3 5682.3 5711.3 5782.5 5598.3 5599.8 5602.1 5613.7 5622.8 10:42:45 INFO - PROCESS | 982 | 10:42:45 INFO - PROCESS | 982 | [#1] ext.html Cycles:180 Average:63146.20 Median:22309.14 stddev:130364.46 (584.4%) stddev-sans-first:130645.64 10:42:45 INFO - PROCESS | 982 | Values: 622.6 637.6 647.4 647.8 649.3 30596.8 42485.8 43444.3 43475.3 47078.5 44759.1 45031.5 45125.0 45135.1 45147.5 8844.4 8976.0 8990.9 8995.3 9000.0 8897.8 8959.8 8985.7 8988.4 8990.1 8995.6 9020.6 9034.5 9042.9 9044.3 8970.9 8990.7 8999.1 9014.0 9030.3 8785.6 8837.1 8855.5 8870.7 8873.1 42450.8 42754.8 42771.6 42792.1 42838.0 3490.7 3567.8 3655.2 3686.2 4004.9 31912.7 32661.0 32909.0 33319.0 34476.7 3885.3 3961.4 3971.4 4014.0 4064.1 357147.0 357717.0 359154.0 360111.2 360866.0 48648.5 56704.1 57173.4 57258.7 57290.4 48577.5 52414.5 52433.7 57859.4 59329.4 15991.0 16091.4 16107.5 16127.6 16235.4 13270.9 13336.5 13399.9 13425.9 13444.3 14099.6 15427.4 15664.0 15682.5 15688.8 5952.5 6254.7 6299.0 6339.6 6341.0 977.5 1010.8 1028.4 1062.4 1127.1 33653.7 34011.3 34613.8 35985.5 36114.6 1102.7 1155.7 1186.7 1189.0 1190.6 16049.8 16474.8 16684.5 16742.8 17012.5 554960.0 557949.0 558079.0 559481.0 560415.0 55783.5 57258.1 57365.4 57378.0 57608.7 1368.2 1388.7 1397.3 1406.5 1410.0 29776.9 30681.7 31137.2 31222.0 31239.8 50366.0 50730.7 50770.7 50806.7 50906.7 526002.0 526038.0 529419.0 530978.0 531132.0 24493.8 27024.9 27083.0 27426.6 27539.9 46634.0 46682.5 47031.3 47621.5 47862.8 38841.4 40418.2 40998.4 41107.4 41851.6 39578.0 40256.6 40326.2 40376.8 40458.2 39085.2 39535.2 39682.8 40122.8 40554.2 34194.7 35683.5 36414.6 36659.3 36712.3 26878.5 27250.7 27432.9 27538.2 27599.7 10:42:45 INFO - PROCESS | 982 | 10:42:45 INFO - PROCESS | 982 | [#2] jquery.html Cycles:180 Average:29188.04 Median:386.73 stddev:80223.12 (20743.9%) stddev-sans-first:80419.01 10:42:45 INFO - PROCESS | 982 | Values: 379.9 382.5 391.0 396.8 415.1 14597.2 17845.7 18940.8 20453.7 20454.5 19820.4 20232.3 20474.5 20596.6 20624.8 5753.5 5950.7 5958.3 5981.9 5999.7 4187.2 5815.4 5932.2 6350.9 6717.1 6698.4 6736.9 6759.6 6760.8 6774.8 6391.8 6534.6 6548.2 6554.1 6556.5 5107.6 5436.5 5666.6 5668.7 5672.5 14064.9 14258.4 14406.9 14515.0 24239.3 2165.4 2279.4 2298.2 2358.1 2793.6 9998.6 10021.1 10477.8 10481.3 10603.3 1930.7 1943.9 1958.9 1996.3 2080.7 78607.0 85216.6 86213.6 86347.6 90146.5 11108.2 11174.0 11276.5 11282.9 11352.9 15264.2 15299.5 15339.8 15372.6 15411.8 8056.6 8278.4 8348.2 8457.8 8495.4 8257.1 8257.4 8271.9 8434.4 8461.9 4460.2 4460.6 4546.5 4557.1 4586.9 1967.8 1993.9 1999.4 2006.7 2012.6 883.4 953.0 955.4 1038.2 1044.0 19205.5 19626.6 19783.4 20027.6 20250.4 986.3 999.6 1003.7 1011.3 1042.1 10498.8 10945.7 10963.8 11044.3 11069.3 472754.0 479591.0 481265.0 495490.0 497123.0 53227.5 91912.5 98012.0 102598.5 103927.0 922.3 939.2 971.1 975.1 1009.1 17992.4 18125.0 18477.2 18518.7 18639.3 45290.6 45949.5 46229.8 47573.0 47618.0 59662.7 61333.7 64350.7 64951.0 65454.0 8556.5 8562.7 8610.2 8766.0 8834.9 9536.8 13711.7 14619.0 14669.6 14797.7 11822.4 12200.8 12290.6 12345.4 12453.0 7755.9 7918.6 12368.8 12577.9 12585.0 12283.6 12323.4 12381.3 12657.7 12782.7 8390.6 8646.3 8765.4 8823.4 8952.2 11463.3 12049.6 12054.6 12071.5 12286.0 10:42:45 INFO - PROCESS | 982 | 10:42:45 INFO - PROCESS | 982 | [#3] mootools.html Cycles:180 Average:5940.73 Median:4777.85 stddev:3381.49 (70.8%) stddev-sans-first:3374.32 10:42:45 INFO - PROCESS | 982 | Values: 1474.7 1508.0 1602.3 1757.9 1784.5 7800.3 8278.7 8499.4 8977.5 8984.2 8397.4 8556.8 8864.5 8881.3 8920.3 2346.6 2413.0 2416.3 2418.1 2421.2 2010.4 2301.4 2304.7 2336.4 2372.8 2313.0 2335.8 2339.4 2340.9 2341.1 2219.4 2233.8 2250.5 2251.5 2253.2 2236.4 2236.8 2245.0 2247.4 2247.7 8852.4 8926.8 8927.2 8935.4 8947.2 5257.1 5367.2 5379.7 5421.1 5435.6 3238.8 3264.3 3350.6 3352.9 3368.1 1085.1 1101.7 1135.9 1146.9 1147.6 12415.0 12573.5 12653.0 12699.0 12712.0 4653.2 4712.2 4843.5 4858.2 4899.0 10669.3 10702.5 10711.8 10753.5 10800.4 5404.9 5409.6 5419.9 5422.8 5442.5 4847.8 4863.9 4923.8 4926.5 4969.3 3916.5 3954.4 4010.6 4054.5 4096.7 1179.7 1268.8 1278.1 1326.5 1327.8 979.7 982.9 991.7 997.9 1007.8 6097.7 6201.7 6273.7 6286.2 6402.7 975.1 975.8 1014.5 1021.2 1024.4 4256.3 4378.2 4438.5 4468.5 4478.6 10885.8 11162.7 11236.4 11267.0 11286.3 10809.8 10954.3 11090.6 11132.0 11236.6 8392.3 8401.1 8407.2 8451.7 8487.2 5869.1 6082.3 6188.0 6318.6 6357.2 10226.9 10352.1 10364.3 10397.2 10579.9 10467.1 10521.4 10749.7 10753.7 10841.2 8162.1 8216.9 8294.5 8299.3 8305.2 8247.9 8510.2 8599.5 8691.5 8794.3 7787.6 7812.5 7850.3 7926.1 7927.1 7892.9 7936.4 7943.4 7978.4 8133.3 6692.9 6947.7 6957.3 7113.7 7120.5 5300.4 5422.1 5430.1 5443.2 5499.6 5456.1 5475.4 5508.6 5508.8 5559.8 10:42:45 INFO - PROCESS | 982 | 10:42:45 INFO - PROCESS | 982 | [#4] prototype.html Cycles:180 Average:4499.70 Median:5057.41 stddev:1297.83 (25.7%) stddev-sans-first:1263.23 10:42:45 INFO - PROCESS | 982 | Values: 333.0 334.6 340.6 340.9 343.9 5366.2 5389.4 5391.2 5399.8 5400.9 5268.5 5343.4 5354.3 5363.8 5364.5 3980.8 4019.9 4156.2 4167.5 4222.4 4149.8 4167.0 4189.0 4190.6 4213.9 3976.4 4144.9 4148.1 4152.4 4163.2 4032.9 4056.3 4072.2 4144.7 4157.6 3680.3 3691.8 3692.7 3705.9 3716.3 5164.7 5172.5 5186.5 5191.2 5206.8 4512.7 4778.6 4788.9 4802.7 4806.7 5431.7 5497.6 5516.4 5522.5 5524.3 3967.7 3996.4 4000.5 4008.9 4017.4 5565.3 5772.5 5773.2 5773.4 5777.2 3991.8 4025.9 4027.6 4027.9 4031.5 4077.8 4079.5 4103.2 4110.9 4112.2 4596.8 4636.9 4662.7 4701.6 4710.1 5475.8 5523.6 5538.9 5544.3 5553.3 1401.4 1402.8 1410.6 1413.9 1420.9 903.8 906.8 917.9 932.7 933.6 4738.4 4744.4 4752.3 4757.7 4770.9 5004.0 5066.1 5069.8 5096.3 5164.1 4471.9 4765.7 4766.9 4845.9 4846.4 2682.6 2692.3 2700.3 2703.9 2710.2 5170.5 5185.9 5209.3 5209.4 5229.7 4819.2 5004.5 5047.0 5131.6 5229.0 5183.8 5183.8 5208.7 5222.4 5272.7 5034.5 5051.7 5063.1 5098.5 5105.9 4829.5 4986.4 4986.8 4996.4 5015.2 5198.9 5199.3 5206.6 5216.6 5240.3 3760.3 3773.6 3788.2 3789.6 3807.9 5116.7 5122.3 5300.4 5456.2 5720.2 5435.5 5612.5 5638.7 5638.9 5640.2 5574.9 5603.9 5604.0 5612.8 5634.2 5258.7 5526.4 5535.3 5538.8 5545.9 5591.3 5603.1 5605.9 5614.4 5663.3 5484.9 5510.2 5543.9 5565.7 5579.7 10:42:45 INFO - PROCESS | 982 | 10:42:45 INFO - PROCESS | 982 | [#5] yui.html Cycles:180 Average:21343.07 Median:3479.70 stddev:30928.76 (888.8%) stddev-sans-first:30976.80 10:42:45 INFO - PROCESS | 982 | Values: 730.7 759.7 790.5 806.3 846.8 14648.6 15748.7 15750.4 16048.0 16319.3 13188.2 13334.2 14645.8 14901.1 15072.5 666.1 798.1 802.1 821.1 823.3 803.4 804.7 806.0 806.2 806.5 854.0 856.4 856.5 857.0 857.2 696.3 710.3 820.5 845.8 848.6 616.6 617.4 617.6 617.8 618.3 14119.0 14189.3 14295.4 14322.0 14371.6 13702.6 13858.1 13958.9 13963.9 14277.1 12430.0 12500.9 12626.9 12753.4 13119.5 4358.7 4425.6 4428.2 4431.6 4634.8 81267.0 81336.9 81839.6 82105.0 82351.2 11153.7 11302.5 11343.0 11408.1 11459.1 19857.2 19939.0 21271.0 21342.3 21364.8 7664.8 7785.4 7951.5 8203.3 8682.1 4601.5 4783.6 4837.7 4854.1 4965.2 3333.6 3453.6 3475.8 3479.7 3479.7 526.8 653.8 655.6 700.1 703.9 706.2 713.4 717.4 730.9 746.1 9899.9 10017.0 10065.2 10232.3 10247.8 594.5 677.5 695.6 719.6 722.1 4666.7 4804.5 5156.5 5221.9 5388.7 100156.5 101604.5 124006.0 124293.4 126592.0 99860.0 100686.5 101290.0 102125.0 102500.0 87575.0 87630.6 88160.1 91143.0 91256.0 10064.9 10320.9 10414.7 10511.5 10515.3 52656.7 53722.0 54155.0 54353.7 56292.7 71131.6 79657.6 80247.0 81127.6 81338.6 12644.6 12842.3 13228.4 13610.7 13647.8 9128.7 14714.3 14791.1 14923.6 15774.7 12942.4 13203.7 13389.3 13719.6 13730.8 13842.9 14144.0 14152.0 14321.1 14480.4 13909.6 14176.6 14260.6 14385.7 14624.8 11546.4 11557.5 11580.0 11661.1 12141.6 10864.4 10991.7 11533.0 11575.8 11881.8 10:42:45 INFO - PROCESS | 982 | -------- Summary: end -------- 10:42:45 INFO - PROCESS | 982 | 10:42:45 INFO - TEST-INFO | 982: exit 0 10:42:45 INFO - TEST-OK | dromaeo_css | took 1113085ms 10:42:45 INFO - TEST-START | kraken 10:42:45 INFO - operating with platform_type : linux_ 10:42:45 INFO - Initialising browser for kraken test... 10:42:45 INFO - TEST-INFO | started process 1255 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxCwysS/profile http://localhost:58060/getInfo.html) 10:42:49 INFO - PROCESS | 1255 | __metrics Screen width/height:1600/1200 10:42:49 INFO - PROCESS | 1255 | colorDepth:24 10:42:49 INFO - PROCESS | 1255 | Browser inner width/height: 1024/697 10:42:49 INFO - PROCESS | 1255 | __metrics 10:42:50 INFO - PROCESS | 1255 | 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" 10:42:50 INFO - PROCESS | 1255 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:42:51 INFO - PROCESS | 1255 | console.error: PushService: 10:42:51 INFO - PROCESS | 1255 | stateChangeProcessEnqueue: Error transitioning state 10:42:51 INFO - PROCESS | 1255 | UnknownError 10:42:51 INFO - TEST-INFO | 1255: exit 0 10:42:51 INFO - Browser initialized. 10:42:51 INFO - Running cycle 1/1 for kraken test... 10:42:51 INFO - TEST-INFO | started process 1338 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxCwysS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:43:03 INFO - PROCESS | 1338 | RSS: Main: 157167616 10:43:03 INFO - PROCESS | 1338 | 10:43:05 INFO - PROCESS | 1338 | Cycle 1(1): loaded http://localhost:58060/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58060/tests/kraken/driver.html?testName=audio-beat-detection) 10:43:06 INFO - PROCESS | 1338 | RSS: Main: 215650304 10:43:06 INFO - PROCESS | 1338 | 10:43:09 INFO - PROCESS | 1338 | Cycle 1(1): loaded http://localhost:58060/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58060/tests/kraken/driver.html?testName=audio-dft) 10:43:09 INFO - PROCESS | 1338 | RSS: Main: 203157504 10:43:09 INFO - PROCESS | 1338 | 10:43:13 INFO - PROCESS | 1338 | Cycle 1(1): loaded http://localhost:58060/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58060/tests/kraken/driver.html?testName=audio-fft) 10:43:13 INFO - PROCESS | 1338 | RSS: Main: 269246464 10:43:13 INFO - PROCESS | 1338 | 10:43:15 INFO - PROCESS | 1338 | Cycle 1(1): loaded http://localhost:58060/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58060/tests/kraken/driver.html?testName=audio-oscillator) 10:43:16 INFO - PROCESS | 1338 | RSS: Main: 180400128 10:43:16 INFO - PROCESS | 1338 | 10:43:18 INFO - PROCESS | 1338 | Cycle 1(1): loaded http://localhost:58060/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58060/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:43:19 INFO - PROCESS | 1338 | RSS: Main: 185454592 10:43:19 INFO - PROCESS | 1338 | 10:43:22 INFO - PROCESS | 1338 | Cycle 1(1): loaded http://localhost:58060/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58060/tests/kraken/driver.html?testName=imaging-darkroom) 10:43:22 INFO - PROCESS | 1338 | RSS: Main: 218882048 10:43:22 INFO - PROCESS | 1338 | 10:43:26 INFO - PROCESS | 1338 | Cycle 1(1): loaded http://localhost:58060/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58060/tests/kraken/driver.html?testName=imaging-desaturate) 10:43:26 INFO - PROCESS | 1338 | RSS: Main: 221061120 10:43:26 INFO - PROCESS | 1338 | 10:43:29 INFO - PROCESS | 1338 | Cycle 1(1): loaded http://localhost:58060/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58060/tests/kraken/driver.html?testName=json-parse-financial) 10:43:30 INFO - PROCESS | 1338 | RSS: Main: 221540352 10:43:30 INFO - PROCESS | 1338 | 10:43:31 INFO - PROCESS | 1338 | Cycle 1(1): loaded http://localhost:58060/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58060/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:43:32 INFO - PROCESS | 1338 | RSS: Main: 206868480 10:43:32 INFO - PROCESS | 1338 | 10:43:34 INFO - PROCESS | 1338 | Cycle 1(1): loaded http://localhost:58060/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58060/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:43:34 INFO - PROCESS | 1338 | RSS: Main: 210739200 10:43:34 INFO - PROCESS | 1338 | 10:43:36 INFO - PROCESS | 1338 | Cycle 1(1): loaded http://localhost:58060/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58060/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:43:37 INFO - PROCESS | 1338 | RSS: Main: 208687104 10:43:37 INFO - PROCESS | 1338 | 10:43:39 INFO - PROCESS | 1338 | Cycle 1(1): loaded http://localhost:58060/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58060/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:43:40 INFO - PROCESS | 1338 | RSS: Main: 222138368 10:43:40 INFO - PROCESS | 1338 | 10:43:43 INFO - PROCESS | 1338 | Cycle 1(1): loaded http://localhost:58060/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58060/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:43:43 INFO - PROCESS | 1338 | RSS: Main: 222605312 10:43:43 INFO - PROCESS | 1338 | 10:43:45 INFO - PROCESS | 1338 | Cycle 1(1): loaded http://localhost:58060/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58060/tests/kraken/driver.html?testName=ai-astar) 10:43:45 INFO - PROCESS | 1338 | RSS: Main: 265211904 10:43:45 INFO - PROCESS | 1338 | 10:43:45 INFO - PROCESS | 1338 | __start_tp_report 10:43:45 INFO - PROCESS | 1338 | _x_x_mozilla_page_load 10:43:45 INFO - PROCESS | 1338 | _x_x_mozilla_page_load_details 10:43:45 INFO - PROCESS | 1338 | |i|pagename|runs| 10:43:45 INFO - PROCESS | 1338 | |0;ai-astar;102;111;109;111;110;112;111;110;111;109 10:43:45 INFO - PROCESS | 1338 | |1;audio-beat-detection;164;116;120;194;119;120;145;117;172;122 10:43:45 INFO - PROCESS | 1338 | |2;audio-dft;161;161;161;161;160;161;161;162;162;161 10:43:45 INFO - PROCESS | 1338 | |3;audio-fft;74;82;75;130;75;76;76;76;104;74 10:43:45 INFO - PROCESS | 1338 | |4;audio-oscillator;84;85;109;84;84;85;118;85;85;122 10:43:45 INFO - PROCESS | 1338 | |5;imaging-gaussian-blur;117;117;117;118;118;118;117;117;118;118 10:43:45 INFO - PROCESS | 1338 | |6;imaging-darkroom;146;146;146;145;146;146;146;146;145;146 10:43:45 INFO - PROCESS | 1338 | |7;imaging-desaturate;95;95;95;95;95;95;96;96;95;95 10:43:45 INFO - PROCESS | 1338 | |8;json-parse-financial;54;52;56;52;52;53;54;53;53;53 10:43:45 INFO - PROCESS | 1338 | |9;json-stringify-tinderbox;63;63;63;63;63;62;62;62;62;63 10:43:45 INFO - PROCESS | 1338 | |10;stanford-crypto-aes;76;75;80;77;75;75;78;76;80;84 10:43:45 INFO - PROCESS | 1338 | |11;stanford-crypto-ccm;118;121;118;129;117;119;132;130;173;121 10:43:45 INFO - PROCESS | 1338 | |12;stanford-crypto-pbkdf2;161;158;157;156;156;166;162;157;159;156 10:43:45 INFO - PROCESS | 1338 | |13;stanford-crypto-sha256-iterative;66;63;67;63;66;64;65;62;62;66 10:43:45 INFO - PROCESS | 1338 | __end_tp_report 10:43:45 INFO - PROCESS | 1338 | __start_cc_report 10:43:45 INFO - PROCESS | 1338 | _x_x_mozilla_cycle_collect,1688 10:43:45 INFO - PROCESS | 1338 | __end_cc_report 10:43:45 INFO - PROCESS | 1338 | __startTimestamp1468259025745__endTimestamp 10:43:45 INFO - PROCESS | 1338 | 10:43:45 INFO - PROCESS | 1338 | ------- Summary: start ------- 10:43:45 INFO - PROCESS | 1338 | Number of tests: 14 10:43:45 INFO - PROCESS | 1338 | 10:43:45 INFO - PROCESS | 1338 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:2.84 (2.6%) stddev-sans-first:1.01 10:43:45 INFO - PROCESS | 1338 | Values: 102.0 111.0 109.0 111.0 110.0 112.0 111.0 110.0 111.0 109.0 10:43:45 INFO - PROCESS | 1338 | 10:43:45 INFO - PROCESS | 1338 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:133.50 stddev:28.28 (21.2%) stddev-sans-first:28.50 10:43:45 INFO - PROCESS | 1338 | Values: 164.0 116.0 120.0 194.0 119.0 120.0 145.0 117.0 172.0 122.0 10:43:45 INFO - PROCESS | 1338 | 10:43:45 INFO - PROCESS | 1338 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 10:43:45 INFO - PROCESS | 1338 | Values: 161.0 161.0 161.0 161.0 160.0 161.0 161.0 162.0 162.0 161.0 10:43:45 INFO - PROCESS | 1338 | 10:43:45 INFO - PROCESS | 1338 | [#3] audio-fft Cycles:10 Average:84.20 Median:75.50 stddev:18.48 (24.5%) stddev-sans-first:19.23 10:43:45 INFO - PROCESS | 1338 | Values: 74.0 82.0 75.0 130.0 75.0 76.0 76.0 76.0 104.0 74.0 10:43:45 INFO - PROCESS | 1338 | 10:43:45 INFO - PROCESS | 1338 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:84.50 stddev:15.67 (18.5%) stddev-sans-first:16.18 10:43:45 INFO - PROCESS | 1338 | Values: 84.0 85.0 109.0 84.0 84.0 85.0 118.0 85.0 85.0 122.0 10:43:45 INFO - PROCESS | 1338 | 10:43:45 INFO - PROCESS | 1338 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 10:43:45 INFO - PROCESS | 1338 | Values: 117.0 117.0 117.0 118.0 118.0 118.0 117.0 117.0 118.0 118.0 10:43:45 INFO - PROCESS | 1338 | 10:43:45 INFO - PROCESS | 1338 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 10:43:45 INFO - PROCESS | 1338 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 10:43:45 INFO - PROCESS | 1338 | 10:43:45 INFO - PROCESS | 1338 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:43:45 INFO - PROCESS | 1338 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 10:43:45 INFO - PROCESS | 1338 | 10:43:45 INFO - PROCESS | 1338 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.00 stddev:1.23 (2.3%) stddev-sans-first:1.27 10:43:45 INFO - PROCESS | 1338 | Values: 54.0 52.0 56.0 52.0 52.0 53.0 54.0 53.0 53.0 53.0 10:43:45 INFO - PROCESS | 1338 | 10:43:45 INFO - PROCESS | 1338 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:63.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 10:43:45 INFO - PROCESS | 1338 | Values: 63.0 63.0 63.0 63.0 63.0 62.0 62.0 62.0 62.0 63.0 10:43:45 INFO - PROCESS | 1338 | 10:43:45 INFO - PROCESS | 1338 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:77.50 stddev:2.95 (3.8%) stddev-sans-first:3.07 10:43:45 INFO - PROCESS | 1338 | Values: 76.0 75.0 80.0 77.0 75.0 75.0 78.0 76.0 80.0 84.0 10:43:45 INFO - PROCESS | 1338 | 10:43:45 INFO - PROCESS | 1338 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:125.00 stddev:16.82 (13.5%) stddev-sans-first:17.46 10:43:45 INFO - PROCESS | 1338 | Values: 118.0 121.0 118.0 129.0 117.0 119.0 132.0 130.0 173.0 121.0 10:43:45 INFO - PROCESS | 1338 | 10:43:45 INFO - PROCESS | 1338 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.80 Median:158.50 stddev:3.29 (2.1%) stddev-sans-first:3.40 10:43:45 INFO - PROCESS | 1338 | Values: 161.0 158.0 157.0 156.0 156.0 166.0 162.0 157.0 159.0 156.0 10:43:45 INFO - PROCESS | 1338 | 10:43:45 INFO - PROCESS | 1338 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:65.50 stddev:1.84 (2.8%) stddev-sans-first:1.86 10:43:45 INFO - PROCESS | 1338 | Values: 66.0 63.0 67.0 63.0 66.0 64.0 65.0 62.0 62.0 66.0 10:43:45 INFO - PROCESS | 1338 | -------- Summary: end -------- 10:43:45 INFO - PROCESS | 1338 | 10:43:46 INFO - TEST-INFO | 1338: exit 0 10:43:46 INFO - TEST-OK | kraken | took 60925ms 10:43:46 INFO - SUITE-END | took 1174s 10:43:46 INFO - Completed test suite (00:19:34) 10:43:46 INFO - javascript benchmark 10:43:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3028.7576993840494, 3069.1866655336353, 3089.057837359605, 3091.6290045194564, 3105.4875945469, 5261.973690131554, 5355.116405793045, 5388.110961691316, 5451.345838499381, 5467.316585426826, 5359.169328754049, 5369.275147855038, 5395.514403703666, 5419.83740487786, 5426.240326354314, 4838.661293709451, 4931.211006239003, 4931.482194369593, 4945.62907781916, 5070.062038522867, 4972.428170760372, 4980.4272508661425, 5007.549320561149, 5027.49725027498, 5029.0, 4745.122152401799, 4796.25658023007, 4803.279508073782, 4852.733099679516, 4865.805367785284, 4860.538248866387, 4869.196582563873, 4872.3909511311085, 4931.038447502739, 4983.053219888246, 4902.8774280643265, 4905.754712264373, 4912.877178070541, 4915.188993816016, 4925.2858335541505, 5267.0, 5343.679379237258, 5439.4832490913695, 5494.917576236359, 5516.668999859981, 5857.0, 5880.176775251468, 5881.500072493843, 5891.970540147315, 5916.26046744157, 5633.63381380209, 5779.046457334534, 5936.7922122725495, 5967.9701601491715, 5972.134040564138, 5419.972900135514, 5495.890082198333, 5529.751161197756, 5547.916781248285, 5556.777728890839, 6050.630771296217, 6065.568859285597, 6070.539005679006, 6097.054956481752, 6111.022236442148, 5489.011977844027, 5763.221965034751, 5775.653460792366, 5796.710164491758, 5800.477956983892, 5791.88416231673, 5832.533397328203, 5841.211436456109, 5890.440408161217, 5896.6756828374855, 5789.247397838254, 5794.768209271582, 5798.449147330997, 5804.245448091806, 5806.912896306559, 5603.131514615241, 5726.570507211975, 5775.8556036099435, 5816.5055970243, 5823.242978412779, 4424.247877860771, 4440.578145076212, 4451.376807246988, 4468.352088947149, 4489.573490518395, 3910.765354078764, 3925.862594809168, 3930.8820735377985, 3944.36890097583, 3970.1861118470642, 5259.0, 5324.9733751331, 5384.811531596453, 5498.505134537831, 5549.528290095387, 5833.941660583425, 5855.707214639251, 5883.61756485827, 5897.321807992136, 5935.0, 5499.092649712753, 5499.285092937973, 5501.724913754297, 5502.8349149525575, 5505.256790333254, 4913.975430122827, 4932.827351042696, 4959.107360675041, 5060.898782024413, 5107.770150343244, 5925.496332811673, 5936.7031648417405, 5936.851578710481, 5966.880662386815, 6000.369961154103, 5807.912881306868, 5814.592978491634, 5816.5055970243, 5823.301203855564, 5828.417158284137, 5802.709864506842, 5908.970455147697, 5928.851778705567, 5961.642301461926, 5962.0, 5676.7161641918565, 5719.942800572107, 5722.914156287576, 5733.254676891977, 5733.827985160452, 5811.244538210006, 5850.473457388855, 5870.207521984477, 5891.05743081105, 5891.1752354669525, 5515.972420137874, 5615.887682246251, 5669.518090962314, 5716.085426331767, 5758.481736643722, 5679.574031947703, 5680.289963754531, 5680.318361796446, 5681.971590142023, 5688.54491640676, 5444.537214336826, 5625.662460252398, 5631.324241091095, 5646.802361917313, 5648.745806438638, 5622.662640241599, 5664.320281566238, 5682.261306030189, 5711.314642242957, 5782.479576838105, 5598.300212473441, 5599.80400685974, 5602.1036634138345, 5613.747381367766, 5622.8313150605545], "value": 5349.126367539302, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.6202016769771, 637.6301744987906, 647.4043879630742, 647.7635662983013, 649.2598437780928, 30596.847015764917, 42485.78757106214, 43444.348334774964, 43475.34786978198, 47078.52921470793, 44759.10481790362, 45031.549684503145, 45125.0, 45135.09729805402, 45147.54852451474, 8844.380893337453, 8975.955120224422, 8990.865137022916, 8995.28037756978, 9000.0, 8897.822043559125, 8959.820803583925, 8985.730428087169, 8988.370814043019, 8990.056044115372, 8995.550222488882, 9020.639174433014, 9034.503102329369, 9042.86435703465, 9044.321675874302, 8970.910290897105, 8990.685326013558, 8999.145081217306, 9013.954930225373, 9030.27757779376, 8785.64857405703, 8837.072107428692, 8855.468671879644, 8870.73387798367, 8873.068327825615, 42450.78774606138, 42754.78622606867, 42771.57228427707, 42792.14415711699, 42838.0, 3490.703290220334, 3567.8037707926055, 3655.1958569114754, 3686.207465394926, 4004.899877503057, 31912.680873191202, 32661.0, 32909.0, 33319.0, 34476.65523344759, 3885.2812229737588, 3961.4057891316534, 3971.384435412516, 4013.9965008747813, 4064.0855807443386, 357147.0, 357717.0, 359154.0, 360111.1938843363, 360866.0, 48648.51351486511, 56704.14943775847, 57173.42826571681, 57258.713706431205, 57290.42709572934, 48577.514224857296, 52414.47585524172, 52433.7378313106, 57859.421405785404, 59329.40670593325, 15991.040537567784, 16091.356345746273, 16107.516774496784, 16127.596810079607, 16235.431759888348, 13270.933645331712, 13336.5332213374, 13399.866001340057, 13425.932870335586, 13444.260565668983, 14099.577012689431, 15427.382904683687, 15664.0, 15682.529524114294, 15688.76466852998, 5952.523798096142, 6254.6872656366995, 6299.0, 6339.619622822645, 6340.985442329205, 977.4672803322206, 1010.8129995950626, 1028.4265074436125, 1062.3997441445558, 1127.0589058136384, 33653.663463365054, 34011.31977360439, 34613.82693086519, 35985.46021809675, 36114.638853611126, 1102.7022703869911, 1155.7110722319421, 1186.662747657314, 1188.9881101188878, 1190.5892467098838, 16049.839501605067, 16474.83525164733, 16684.49946501607, 16742.832571674127, 17012.48962531126, 554960.0, 557949.0, 558079.0, 559481.0, 560415.0, 55783.48974296166, 57258.141127883115, 57365.42634573684, 57378.0, 57608.71195643995, 1368.2201145347256, 1388.6944872128115, 1397.2594524901817, 1406.5358431717304, 1409.9506517271845, 29776.885586449378, 30681.693183068775, 31137.221569460038, 31222.0, 31239.84380078085, 50366.0, 50730.74634626803, 50770.74614626903, 50806.74596626993, 50906.745466272434, 526002.0, 526038.0, 529419.0, 530978.0, 531132.0, 24493.75506244915, 27024.86487567628, 27083.0, 27426.5886011706, 27539.862300688368, 46634.0, 46682.53317466917, 47031.294530581385, 47621.52378476309, 47862.76068619634, 38841.417378739905, 40418.1916361677, 40998.385024224066, 41107.383389249786, 41851.58148418598, 39578.0, 40256.59743402646, 40326.1934761309, 40376.78869633916, 40458.1908361837, 39085.218295633356, 39535.20929581335, 39682.80158599189, 40122.79938600288, 40554.1889162221, 34194.65805342014, 35683.46474802932, 36414.63304885174, 36659.266814663024, 36712.26575468529, 26878.462430751668, 27250.727492724818, 27432.862835685693, 27538.17385478439, 27599.724002759714], "value": 19976.48678390286, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.90462810898526, 382.50465646987146, 390.95894931032234, 396.77582166076166, 415.0640306109722, 14597.197154156516, 17845.7323140153, 18940.81059189408, 20453.693194602092, 20454.488637784045, 19820.405387838353, 20232.29186978456, 20474.48813779656, 20596.588068238627, 20624.793752062476, 5753.482186603205, 5950.672713000783, 5958.255218097738, 5981.910271345933, 5999.730012149464, 4187.246295666779, 5815.447532484428, 5932.228810254661, 6350.872982540346, 6717.09319241901, 6698.363655452748, 6736.865262694743, 6759.628220447873, 6760.797176084725, 6774.8306292342595, 6391.808245752635, 6534.640594767286, 6548.1814773153355, 6554.082428460043, 6556.475481961432, 5107.642465027449, 5436.456354364572, 5666.631668941505, 5668.68822214778, 5672.461116193955, 14064.859351406458, 14258.358373873201, 14406.855931440656, 14515.0, 24239.272821815375, 2165.436986383552, 2279.350385140244, 2298.2071185441164, 2358.068562917638, 2793.553031514968, 9998.600055997751, 10021.148202402805, 10477.790444191074, 10481.318714283547, 10603.257771955967, 1930.6621341265222, 1943.885379510983, 1958.8530860185542, 1996.2613832881782, 2080.6878968154747, 78607.0, 85216.57391713063, 86213.56893215494, 86347.56826215892, 90146.54926725324, 11108.16688748347, 11174.0, 11276.54893804255, 11282.887171128348, 11352.943235283936, 15264.23678816077, 15299.46451874179, 15339.846601534065, 15372.615684607974, 15411.768823467657, 8056.637451314705, 8278.420510564203, 8348.165183481724, 8457.830843383097, 8495.36284778644, 8257.133001034805, 8257.42198046131, 8271.875921861178, 8434.409591328671, 8461.915380846112, 4460.219461594208, 4460.643148548108, 4546.477155127137, 4557.134144512598, 4586.908261834745, 1967.8228959393723, 1993.8504612153856, 1999.4001799460104, 2006.6889632107047, 2012.5874195789827, 883.3595643158659, 952.9904700952902, 955.4219697083304, 1038.2213339995003, 1043.994780026095, 19205.519862003563, 19626.607467850565, 19783.40649780509, 20027.59944801096, 20250.392488225378, 986.2603047714215, 999.6001599360169, 1003.7289931718395, 1011.3274672342957, 1042.1089968077335, 10498.842517362245, 10945.671629851116, 10963.83554246687, 11044.33733975964, 11069.335839849473, 472754.0, 479591.0, 481265.0, 495490.0, 497123.0, 53227.467725323026, 91912.54043729873, 98012.0, 102598.48700756449, 103927.0, 922.276013329533, 939.178219058324, 971.0968799016982, 975.068809287129, 1009.1119814563137, 17992.37026704059, 18125.0, 18477.16852741603, 18518.684760437212, 18639.254429822657, 45290.64128076163, 45949.54050459452, 46229.76885115553, 47573.0, 47618.0, 59662.70168649129, 61333.69333153305, 64350.67824660847, 64951.0, 65454.0, 8556.529390883561, 8562.657493700182, 8610.225079742853, 8766.0, 8834.867476987722, 9536.809263814546, 13711.657208569866, 14619.0, 14669.633259168606, 14797.704045919236, 11822.408879555816, 12200.755984880076, 12290.631281061582, 12345.38273086324, 12453.0, 7755.875398067135, 7918.564478953713, 12368.814467782811, 12577.93711031439, 12585.0, 12283.631491055283, 12323.383830808245, 12381.319027453577, 12657.746845063231, 12782.68043298925, 8390.580470976549, 8646.265067469336, 8765.430247033923, 8823.426477278956, 8952.23905968, 11463.254888432226, 12049.578264760692, 12054.638360849189, 12071.456784444897, 12286.0], "value": 9341.210712178314, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1474.7419201639714, 1507.977380339295, 1602.3430393538645, 1757.8593712503, 1784.4735802938148, 7800.258975397328, 8278.710245141407, 8499.447535910169, 8977.461352318856, 8984.19142277194, 8397.412181147321, 8556.786080347994, 8864.512451815148, 8881.333899957497, 8920.330975176872, 2346.5893468643003, 2412.975870241293, 2416.2871952773976, 2418.117387153685, 2421.2131057406327, 2010.3667344786345, 2301.3671240408853, 2304.700388949434, 2336.439254578906, 2372.7627237276306, 2312.976870231293, 2335.8364914455997, 2339.4385347516645, 2340.8829558522093, 2341.1103780563362, 2219.367480268124, 2233.8212942964687, 2250.4936389312275, 2251.470904337479, 2253.177590179581, 2236.384994126628, 2236.7651396603287, 2245.012194634372, 2247.415671925311, 2247.6965609642652, 8852.424592401474, 8926.821463570757, 8927.196552310323, 8935.419197752126, 8947.239484643747, 5257.08001099806, 5367.221752845854, 5379.704116273603, 5421.1326187810155, 5435.646682965595, 3238.8138006845284, 3264.347130573895, 3350.5644266245477, 3352.899413017589, 3368.0569440556683, 1085.104788549442, 1101.7465982823915, 1135.9034482069035, 1146.8623765148152, 1147.552454542729, 12415.0, 12573.497060117494, 12653.0, 12699.0, 12712.0, 4653.23221668421, 4712.198926182557, 4843.491433399442, 4858.17411040124, 4898.975505122452, 10669.253152279265, 10702.518386672462, 10711.83932241017, 10753.51609177589, 10800.405977671304, 5404.91892621611, 5409.56723462122, 5419.918701219485, 5422.837314880481, 5442.510174084351, 4847.781849816767, 4863.902721945541, 4923.803047878117, 4926.5073492650445, 4969.304297398367, 3916.4516967624554, 3954.367301231789, 4010.598940105966, 4054.493188351456, 4096.713230073926, 1179.6755892129734, 1268.7969924811987, 1278.0733967873218, 1326.5357125006365, 1327.8008298755071, 979.7354714227118, 982.9262805289632, 991.6876184002016, 997.8913605179486, 1007.8337074382645, 6097.725602347905, 6201.658908760061, 6273.749050037947, 6286.214223222098, 6402.743890244431, 975.0980343182528, 975.8487434447673, 1014.5130337438071, 1021.2085633633844, 1024.4109636958779, 4256.34026725858, 4378.2119218540965, 4438.467383913887, 4468.486124095771, 4478.611630394588, 10885.782284354427, 11162.66512004625, 11236.381998989971, 11267.0, 11286.322820630625, 10809.83785243222, 10954.3427394355, 11090.611828586123, 11132.0, 11236.606718764804, 8392.328613710888, 8401.11788262248, 8407.201315874981, 8451.661933522713, 8487.193716596914, 5869.119632055226, 6082.2701275847185, 6188.0, 6318.589291696025, 6357.241925896609, 10226.897731022595, 10352.120069793851, 10364.326318789555, 10397.16822654201, 10579.947100264757, 10467.062527398068, 10521.368717876952, 10749.677509674722, 10753.677389678322, 10841.241113122005, 8162.0613629431, 8216.876746848682, 8294.54380009081, 8299.294559962229, 8305.169483051646, 8247.917520824714, 8510.234078932926, 8599.484030958163, 8691.521966291662, 8794.252488538546, 7787.571683557232, 7812.492188007761, 7850.33272171849, 7926.128125906031, 7927.088384835818, 7892.881606776018, 7936.444448888522, 7943.364530837403, 7978.401619878417, 8133.34933205354, 6692.933070669231, 6947.65261736901, 6957.304269573002, 7113.679884405111, 7120.537165084253, 5300.416954135119, 5422.051141050221, 5430.104032834538, 5443.156310771837, 5499.642523235977, 5456.099743542271, 5475.370332411664, 5508.641938274, 5508.80719174843, 5559.805406810742], "value": 4742.885477821826, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.9711192415436, 334.62689101651665, 340.59639327397036, 340.9284050349427, 343.91745980964544, 5366.248725178473, 5389.434109418514, 5391.191321301807, 5399.811006614769, 5400.9189862152, 5268.47315268473, 5343.412224655285, 5354.330708661418, 5363.8122665706705, 5364.517193452589, 3980.761154330735, 4019.919601607966, 4156.231097247019, 4167.52073511547, 4222.366645003243, 4149.751014939098, 4166.958330416687, 4188.958110418887, 4190.601892820177, 4213.9367909481225, 3976.403539469088, 4144.8549300774475, 4148.108156746299, 4152.397902304164, 4163.167366526692, 4032.9395059074136, 4056.336901870219, 4072.2059198456163, 4144.730592511477, 4157.5864206169745, 3680.3191409589313, 3691.778493290384, 3692.7415080944343, 3705.8517659293598, 3716.2939041582013, 5164.6642968207325, 5172.491341699273, 5186.455422180655, 5191.195364718475, 5206.765695543671, 4512.661550383735, 4778.5699287064335, 4788.928166077511, 4802.711837289774, 4806.663533552653, 5431.728413579305, 5497.587680923907, 5516.365617953947, 5522.530584900248, 5524.309461317335, 3967.7420967637013, 3996.4205190247253, 4000.4599379083743, 4008.8997775055564, 4017.417474466186, 5565.30433695788, 5772.538196944192, 5773.220615216934, 5773.422657734235, 5777.248957635523, 3991.84032638697, 4025.879223623296, 4027.5903433797935, 4027.9124636348024, 4031.496062992126, 4077.7757223353, 4079.530853951774, 4103.194594378464, 4110.856120035784, 4112.198121366365, 4596.7931443085145, 4636.884077898012, 4662.743549104832, 4701.5533524315815, 4710.081534100886, 5475.808346707846, 5523.558115350762, 5538.919910617391, 5544.251526044013, 5553.305836770403, 1401.4254155796075, 1402.7895815627737, 1410.5697762182429, 1413.9010269281052, 1420.936057877398, 903.7514683461969, 906.8367693815045, 917.9173874351341, 932.6802574357345, 933.6312156698066, 4738.431388233434, 4744.430668319824, 4752.263399173134, 4757.690750101302, 4770.856874293777, 5003.974980125149, 5066.138756411419, 5069.845315740796, 5096.337476128154, 5164.147915593885, 4471.8658440246845, 4765.690230135099, 4766.904661906812, 4845.9030819383415, 4846.418429788448, 2682.637843891089, 2692.3000019994943, 2700.2979225401145, 2703.8643769616806, 2710.186943916817, 5170.482951704875, 5185.922211166836, 5209.348831396075, 5209.426963034063, 5229.6727956059185, 4819.240977043424, 5004.524570165829, 5046.990601879639, 5131.56381707559, 5228.9738551307, 5183.755898584388, 5183.766730497136, 5208.739563021833, 5222.4255331913455, 5272.6836389816735, 5034.521720436553, 5051.722155281494, 5063.088644044107, 5098.5411312982005, 5105.948940510547, 4829.517048295143, 4986.351774269322, 4986.80052797884, 4996.425411077627, 5015.22264049073, 5198.948010519997, 5199.324087868553, 5206.583473322201, 5216.582673386044, 5240.34495688039, 3760.2855457462992, 3773.603771603942, 3788.1855401088897, 3789.6020917804335, 3807.857642707121, 5116.692998420107, 5122.282880396673, 5300.416954134965, 5456.181572763959, 5720.199172115824, 5435.456454354533, 5612.522935550524, 5638.689872057076, 5638.85902852432, 5640.182173584889, 5574.944250557604, 5603.915941260802, 5604.0, 5612.775488980558, 5634.183043458757, 5258.710770907637, 5526.397344770133, 5535.280413546213, 5538.750756215899, 5545.889082218252, 5591.27313449249, 5603.131514615241, 5605.915911261252, 5614.354349249726, 5663.292088488939, 5484.862878428071, 5510.201020852034, 5543.8891222176135, 5565.666060036411, 5579.69311687861], "value": 4091.523898322069, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.7186733107756, 759.7075126076459, 790.4901338636575, 806.3025482957241, 846.7883029242689, 14648.633784155389, 15748.685026299467, 15750.448734294288, 16048.0, 16319.265633046512, 13188.208707477534, 13334.199948003126, 14645.780313295309, 14901.105933643988, 15072.47246346378, 666.1140682891743, 798.1180795221284, 802.0736049862404, 821.1214001018913, 823.2878560045548, 803.441608082383, 804.6781287484994, 805.9597020148998, 806.2300503019602, 806.4999700185894, 854.0, 856.3662889461816, 856.4775486952954, 857.0486759696763, 857.1514200941086, 696.2967402923034, 710.3287393413226, 820.4543978254453, 845.8392905347964, 848.5799529233008, 616.5868867858545, 617.4103730936945, 617.629422346593, 617.7652492053036, 618.2766163588612, 14119.0, 14189.290535473288, 14295.428182872673, 14322.0, 14371.568852934428, 13702.588922332347, 13858.099223550436, 13958.93020534901, 13963.860361396357, 14277.071990320595, 12429.987181980925, 12500.937495312557, 12626.936865315707, 12753.362331883462, 13119.47522099115, 4358.65130789536, 4425.579569940851, 4428.180786554465, 4431.645468362523, 4634.814607415699, 81267.0, 81336.90395457843, 81839.59080204621, 82105.0, 82351.17648823436, 11153.665390038312, 11302.491387887565, 11343.0, 11408.144389170679, 11459.140564457699, 19857.205711771658, 19939.003049847448, 21271.0, 21342.253021144184, 21364.78635213659, 7664.770056898302, 7785.416093792988, 7951.522908625501, 8203.343732501386, 8682.088380720059, 4601.493835678073, 4783.617310615143, 4837.7097374157665, 4854.077725232265, 4965.230389289666, 3333.5999680038067, 3453.637368076366, 3475.7914525128067, 3479.6520347965, 3479.739019573542, 526.8208809004957, 653.8300041989118, 655.5869802024694, 700.1423256510734, 703.9260877607777, 706.1843570675775, 713.3722324354535, 717.3651318583092, 730.8867125595541, 746.1233051164968, 9899.861193733974, 10016.972013597508, 10065.194784417228, 10232.334898231591, 10247.795044099077, 594.5124997502007, 677.5223467455432, 695.6347917343435, 719.5610677486729, 722.1154086244309, 4666.696664716783, 4804.471508134103, 5156.484351564814, 5221.895562088813, 5388.7305634718105, 100156.49921750344, 101604.49197753964, 124006.0, 124293.37853310857, 126592.0, 99860.0, 100686.49656751669, 101290.0, 102125.0, 102500.0, 87575.0, 87630.56184719036, 88160.11839881519, 91143.0, 91256.0, 10064.899351006396, 10320.881226053736, 10414.687559373231, 10511.474426278808, 10515.316504427188, 52656.736716316176, 53722.0, 54155.0, 54353.72823135859, 56292.718536407054, 71131.64434177797, 79657.60171199107, 80247.0, 81127.59436202781, 81338.59330703308, 12644.557440489538, 12842.293673848028, 13228.404721787736, 13610.659733506742, 13647.795283070564, 9128.680496182868, 14714.264286785832, 14791.112533248039, 14923.626909327353, 15774.684506310039, 12942.417591208607, 13203.735925281248, 13389.330533473481, 13719.588412347646, 13730.794038089236, 13842.930785346009, 14144.0, 14152.0, 14321.14073155614, 14480.420783168976, 13909.58271251864, 14176.574702758933, 14260.572182834532, 14385.712285754436, 14624.780628290371, 11546.42267886619, 11557.479913404086, 11580.0, 11661.06711463098, 12141.575044873387, 10864.402457864893, 10991.698821462176, 11533.0, 11575.826362604399, 11881.82177267359], "value": 7654.619196965067, "unit": "score"}], "name": "dromaeo_css", "value": 7275.290824153371, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 109.0, 111.0, 110.0, 112.0, 111.0, 110.0, 111.0, 109.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 116.0, 120.0, 194.0, 119.0, 120.0, 145.0, 117.0, 172.0, 122.0], "value": 138.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 160.0, 161.0, 161.0, 162.0, 162.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 82.0, 75.0, 130.0, 75.0, 76.0, 76.0, 76.0, 104.0, 74.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 109.0, 84.0, 84.0, 85.0, 118.0, 85.0, 85.0, 122.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.8, "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, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 56.0, 52.0, 52.0, 53.0, 54.0, 53.0, 53.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 63.0, 62.0, 62.0, 62.0, 62.0, 63.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 80.0, 77.0, 75.0, 75.0, 78.0, 76.0, 80.0, 84.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 121.0, 118.0, 129.0, 117.0, 119.0, 132.0, 130.0, 173.0, 121.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 158.0, 157.0, 156.0, 156.0, 166.0, 162.0, 157.0, 159.0, 156.0], "value": 158.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 67.0, 63.0, 66.0, 64.0, 65.0, 62.0, 62.0, 66.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1490.8, "alertThreshold": 2.0}]} 10:43:46 INFO - Return code: 0 10:43:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:43:47 INFO - # TBPL SUCCESS # 10:43:47 INFO - Running post-action listener: _resource_record_post_action 10:43:47 INFO - ##### 10:43:47 INFO - ##### Finished run-tests step (success) 10:43:47 INFO - ##### 10:43:47 INFO - Running post-run listener: _resource_record_post_run 10:43:47 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 561418240; Read time: 16; Write time: 559756 10:43:47 INFO - TinderboxPrint: CPU usage
13.1% 10:43:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:43:47 INFO - TinderboxPrint: I/O write bytes / time
561,418,240 / 559,756 10:43:47 INFO - TinderboxPrint: CPU idle
8,260.2 (86.9%) 10:43:47 INFO - TinderboxPrint: CPU user
1,202.1 (12.6%) 10:43:47 INFO - TinderboxPrint: Swap in / out
0 / 0 10:43:47 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 266702848; Read time: 0; Write time: 266080 10:43:47 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 294715392; Read time: 0; Write time: 293676 10:43:47 INFO - Running post-run listener: _upload_blobber_files 10:43:47 INFO - Blob upload gear active. 10:43:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:43:47 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 10:43:47 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'] 10:43:47 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 10:43:48 INFO - (blobuploader) - INFO - Open directory for files ... 10:43:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:43:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:43:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:43:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:43:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:43:49 INFO - (blobuploader) - INFO - Done attempting. 10:43:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:43:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:43:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:43:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:43:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:43:49 INFO - (blobuploader) - INFO - Done attempting. 10:43:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:43:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:43:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:43:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:43:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:43:53 INFO - (blobuploader) - INFO - Done attempting. 10:43:53 INFO - (blobuploader) - INFO - Iteration through files over. 10:43:53 INFO - Return code: 0 10:43:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:43:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:43:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/71168ada11d1dfd51b2928ce5fd46ebbbe633fabe6d6d4cc7f25487cbb4a858c4328499c57d4c9ef928d5b6d211d36781f57c76875ded3d5399ba45097fa24d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c69fa2d0f7dc4da7d92ceda0bb0c3895ef8c8fd15dcd947a34ba0717f74ee87237add3defaa69f4949f3123d5ca04012bf15d51148e0035c944a71b966fbb86e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cd2b985b0d5be4550c09a509394f12e15bdbbd4df6c43256760b260b5f4760c9a00ec3eeef1251dc41f46b4bf15d75fa71466d6622e77064d3513042eb484a30"} 10:43:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:43:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:43:53 INFO - Contents: 10:43:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/71168ada11d1dfd51b2928ce5fd46ebbbe633fabe6d6d4cc7f25487cbb4a858c4328499c57d4c9ef928d5b6d211d36781f57c76875ded3d5399ba45097fa24d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c69fa2d0f7dc4da7d92ceda0bb0c3895ef8c8fd15dcd947a34ba0717f74ee87237add3defaa69f4949f3123d5ca04012bf15d51148e0035c944a71b966fbb86e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cd2b985b0d5be4550c09a509394f12e15bdbbd4df6c43256760b260b5f4760c9a00ec3eeef1251dc41f46b4bf15d75fa71466d6622e77064d3513042eb484a30"} 10:43:53 INFO - Running post-run listener: copy_logs_to_upload_dir 10:43:53 INFO - Copying logs to upload dir... 10:43:53 INFO - mkdir: /builds/slave/test/build/upload/logs 10:43:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.712797 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-11 10:43:52.889138) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 10:43:52.893128) ========= 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=14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189 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/71168ada11d1dfd51b2928ce5fd46ebbbe633fabe6d6d4cc7f25487cbb4a858c4328499c57d4c9ef928d5b6d211d36781f57c76875ded3d5399ba45097fa24d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c69fa2d0f7dc4da7d92ceda0bb0c3895ef8c8fd15dcd947a34ba0717f74ee87237add3defaa69f4949f3123d5ca04012bf15d51148e0035c944a71b966fbb86e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cd2b985b0d5be4550c09a509394f12e15bdbbd4df6c43256760b260b5f4760c9a00ec3eeef1251dc41f46b4bf15d75fa71466d6622e77064d3513042eb484a30"} build_url:https://queue.taskcluster.net/v1/task/HImbvD2lRZegHAAjc8G1PQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/HImbvD2lRZegHAAjc8G1PQ/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/71168ada11d1dfd51b2928ce5fd46ebbbe633fabe6d6d4cc7f25487cbb4a858c4328499c57d4c9ef928d5b6d211d36781f57c76875ded3d5399ba45097fa24d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c69fa2d0f7dc4da7d92ceda0bb0c3895ef8c8fd15dcd947a34ba0717f74ee87237add3defaa69f4949f3123d5ca04012bf15d51148e0035c944a71b966fbb86e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cd2b985b0d5be4550c09a509394f12e15bdbbd4df6c43256760b260b5f4760c9a00ec3eeef1251dc41f46b4bf15d75fa71466d6622e77064d3513042eb484a30"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 10:43:52.920128) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 10:43:52.920581) ========= 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=14ef55db36f7623abb31b9cf000001d5-1468257768.803001-765017189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004399 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 10:43:53.003849) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 10:43:53.004332) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 10:43:53.004818) ========= ========= Total master_lag: 0.19 =========