builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1471393303.08 results: success (0) buildid: 20160816163815 builduid: d4db7cea77864916975f0634444bd236 revision: 52be5024e34261bcd08d68fda65379ed0ffd363d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 17:21:43.080296) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 17:21:43.080678) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 17:21:43.080955) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 17:21:43.107650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:21:43.107907) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-16 17:21:43-- 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% 104M=0s 2016-08-16 17:21:43 (104 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160578 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:21:43.409305) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:21:43.409685) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019012 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:21:43.466793) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:21:43.467106) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 52be5024e34261bcd08d68fda65379ed0ffd363d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 52be5024e34261bcd08d68fda65379ed0ffd363d --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=6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-16 17:21:43,619 truncating revision to first 12 chars 2016-08-16 17:21:43,619 Setting DEBUG logging. 2016-08-16 17:21:43,619 attempt 1/10 2016-08-16 17:21:43,619 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/52be5024e342?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 17:21:43,957 unpacking tar archive at: mozilla-central-52be5024e342/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649474 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:21:44.134916) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 17:21:44.138210) ========= script_repo_revision: 52be5024e34261bcd08d68fda65379ed0ffd363d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 17:21:44.138592) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 17:21:44.138871) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 17:21:44.152402) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-16 17:21:44.153105) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:21:44 INFO - MultiFileLogger online at 20160816 17:21:44 in /builds/slave/test 17:21:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:21:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:21:44 INFO - {'append_to_log': False, 17:21:44 INFO - 'base_work_dir': '/builds/slave/test', 17:21:44 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:21:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:21:44 INFO - 'branch': 'Firefox-Non-PGO', 17:21:44 INFO - 'buildbot_json_path': 'buildprops.json', 17:21:44 INFO - 'config_files': ('talos/linux_config.py',), 17:21:44 INFO - 'default_actions': ('clobber', 17:21:44 INFO - 'read-buildbot-config', 17:21:44 INFO - 'download-and-extract', 17:21:44 INFO - 'populate-webroot', 17:21:44 INFO - 'create-virtualenv', 17:21:44 INFO - 'install', 17:21:44 INFO - 'run-tests'), 17:21:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:21:44 INFO - 'download_minidump_stackwalk': True, 17:21:44 INFO - 'download_symbols': 'ondemand', 17:21:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:21:44 INFO - 'tooltool.py': '/tools/tooltool.py', 17:21:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:21:44 INFO - '/tools/misc-python/virtualenv.py')}, 17:21:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:21:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:21:44 INFO - 'installer_path': 'installer.exe', 17:21:44 INFO - 'log_level': 'info', 17:21:44 INFO - 'log_name': 'talos', 17:21:44 INFO - 'log_to_console': True, 17:21:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:21:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:21:44 INFO - 'opt_config_files': (), 17:21:44 INFO - 'pip_index': False, 17:21:44 INFO - 'sps_profile': False, 17:21:44 INFO - 'sps_profile_interval': 0, 17:21:44 INFO - 'suite': 'dromaeojs', 17:21:44 INFO - 'system_bits': '32', 17:21:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:21:44 INFO - 'title': 'talos-linux64-ix-023', 17:21:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:21:44 INFO - 'use_talos_json': True, 17:21:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:21:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:21:44 INFO - 'work_dir': 'build'} 17:21:44 INFO - [mozharness: 2016-08-17 00:21:44.391719Z] Running clobber step. 17:21:44 INFO - Running pre-action listener: _resource_record_pre_action 17:21:44 INFO - Running main action method: clobber 17:21:44 INFO - rmtree: /builds/slave/test/build 17:21:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:21:44 INFO - Running post-action listener: _resource_record_post_action 17:21:44 INFO - [mozharness: 2016-08-17 00:21:44.852403Z] Finished clobber step (success) 17:21:44 INFO - [mozharness: 2016-08-17 00:21:44.852505Z] Running read-buildbot-config step. 17:21:44 INFO - Running pre-action listener: _resource_record_pre_action 17:21:44 INFO - Running main action method: read_buildbot_config 17:21:44 INFO - Using buildbot properties: 17:21:44 INFO - { 17:21:44 INFO - "project": "", 17:21:44 INFO - "product": "firefox", 17:21:44 INFO - "script_repo_revision": "production", 17:21:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:21:44 INFO - "repository": "", 17:21:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 17:21:44 INFO - "buildid": "20160816163815", 17:21:44 INFO - "pgo_build": "False", 17:21:44 INFO - "basedir": "/builds/slave/test", 17:21:44 INFO - "buildnumber": 594, 17:21:44 INFO - "slavename": "talos-linux64-ix-023", 17:21:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:21:44 INFO - "platform": "ubuntu64_hw", 17:21:44 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:21:44 INFO - "branch": "mozilla-central", 17:21:44 INFO - "repo_path": "mozilla-central", 17:21:44 INFO - "revision": "52be5024e34261bcd08d68fda65379ed0ffd363d", 17:21:44 INFO - "stage_platform": "linux64", 17:21:44 INFO - "builduid": "d4db7cea77864916975f0634444bd236", 17:21:44 INFO - "slavebuilddir": "test" 17:21:44 INFO - } 17:21:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/HCS9INJYQle-v-y70ha5ug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 17:21:44 INFO - Running post-action listener: _resource_record_post_action 17:21:44 INFO - [mozharness: 2016-08-17 00:21:44.854938Z] Finished read-buildbot-config step (success) 17:21:44 INFO - [mozharness: 2016-08-17 00:21:44.855026Z] Running download-and-extract step. 17:21:44 INFO - Running pre-action listener: _resource_record_pre_action 17:21:44 INFO - Running main action method: download_and_extract 17:21:44 INFO - mkdir: /builds/slave/test/build/tests 17:21: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:44 INFO - trying https://queue.taskcluster.net/v1/task/HCS9INJYQle-v-y70ha5ug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:21:44 INFO - Downloading https://queue.taskcluster.net/v1/task/HCS9INJYQle-v-y70ha5ug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:21:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HCS9INJYQle-v-y70ha5ug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:21:45 INFO - Downloaded 1361 bytes. 17:21:45 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:21:45 INFO - Using the following test package requirements: 17:21:45 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:21:45 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:45 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:21:45 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:45 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:21:45 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:45 INFO - u'jsshell-linux-x86_64.zip'], 17:21:45 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:45 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:21:45 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:21:45 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:45 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:21:45 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:45 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:21:45 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:45 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:21:45 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:45 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:21:45 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:45 INFO - trying https://queue.taskcluster.net/v1/task/HCS9INJYQle-v-y70ha5ug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:21:45 INFO - Downloading https://queue.taskcluster.net/v1/task/HCS9INJYQle-v-y70ha5ug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:21:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HCS9INJYQle-v-y70ha5ug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:21:46 INFO - Downloaded 20266372 bytes. 17:21:46 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 17:21:50 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:21: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:50 INFO - trying https://queue.taskcluster.net/v1/task/HCS9INJYQle-v-y70ha5ug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:21:50 INFO - Downloading https://queue.taskcluster.net/v1/task/HCS9INJYQle-v-y70ha5ug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:21:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HCS9INJYQle-v-y70ha5ug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:21:51 INFO - Downloaded 20266372 bytes. 17:21:51 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 17:21:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:55 INFO - trying https://queue.taskcluster.net/v1/task/HCS9INJYQle-v-y70ha5ug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:21:55 INFO - Downloading https://queue.taskcluster.net/v1/task/HCS9INJYQle-v-y70ha5ug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:21:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HCS9INJYQle-v-y70ha5ug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:21:57 INFO - Downloaded 14413719 bytes. 17:21:57 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 17:21:57 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:57 INFO - trying https://queue.taskcluster.net/v1/task/HCS9INJYQle-v-y70ha5ug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:21:57 INFO - Downloading https://queue.taskcluster.net/v1/task/HCS9INJYQle-v-y70ha5ug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:21:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HCS9INJYQle-v-y70ha5ug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:21:58 INFO - Downloaded 55633927 bytes. 17:21:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HCS9INJYQle-v-y70ha5ug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:21:58 INFO - mkdir: /builds/slave/test/properties 17:21:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:21:58 INFO - Writing to file /builds/slave/test/properties/build_url 17:21:58 INFO - Contents: 17:21:58 INFO - build_url:https://queue.taskcluster.net/v1/task/HCS9INJYQle-v-y70ha5ug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:21:59 INFO - Running post-action listener: _resource_record_post_action 17:21:59 INFO - Running post-action listener: set_extra_try_arguments 17:21:59 INFO - [mozharness: 2016-08-17 00:21:59.183111Z] Finished download-and-extract step (success) 17:21:59 INFO - [mozharness: 2016-08-17 00:21:59.183337Z] Running populate-webroot step. 17:21:59 INFO - Running pre-action listener: _resource_record_pre_action 17:21:59 INFO - Running main action method: populate_webroot 17:21:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:21:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:21:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:21:59 INFO - '--tppagecycles', 17:21:59 INFO - '7'], 17:21:59 INFO - 'tests': ['tsvgm']}}, 17:21:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:21:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:21:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:21:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:21:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:21:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:21:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:59 INFO - 'talos_options': ['--disable-e10s'], 17:21:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:21:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:21:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:59 INFO - 'talos_options': ['--disable-e10s'], 17:21:59 INFO - 'tests': ['damp', 'tps']}, 17:21:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:59 INFO - 'tests': ['damp', 'tps']}, 17:21:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:21:59 INFO - 'tests': ['dromaeo_dom']}, 17:21:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:21:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:21:59 INFO - 'tests': ['basic_compositor_video']}, 17:21:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:21:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:21:59 INFO - 'tests': ['a11yr', 17:21:59 INFO - 'ts_paint', 17:21:59 INFO - 'tpaint', 17:21:59 INFO - 'sessionrestore', 17:21:59 INFO - 'sessionrestore_no_auto_restore', 17:21:59 INFO - 'tabpaint']}, 17:21:59 INFO - 'other-e10s': {'tests': ['a11yr', 17:21:59 INFO - 'ts_paint', 17:21:59 INFO - 'tpaint', 17:21:59 INFO - 'sessionrestore', 17:21:59 INFO - 'sessionrestore_no_auto_restore', 17:21:59 INFO - 'tabpaint']}, 17:21:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:21:59 INFO - 'ts_paint', 17:21:59 INFO - 'tpaint', 17:21:59 INFO - 'sessionrestore', 17:21:59 INFO - 'sessionrestore_no_auto_restore', 17:21:59 INFO - 'tabpaint']}, 17:21:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:21:59 INFO - 'ts_paint', 17:21:59 INFO - 'tpaint', 17:21:59 INFO - 'sessionrestore', 17:21:59 INFO - 'sessionrestore_no_auto_restore', 17:21:59 INFO - 'tabpaint']}, 17:21:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:21:59 INFO - 'tests': ['a11yr', 17:21:59 INFO - 'ts_paint', 17:21:59 INFO - 'tpaint', 17:21:59 INFO - 'sessionrestore', 17:21:59 INFO - 'sessionrestore_no_auto_restore', 17:21:59 INFO - 'tabpaint']}, 17:21:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:21:59 INFO - 'tests': ['a11yr', 17:21:59 INFO - 'ts_paint', 17:21:59 INFO - 'tpaint', 17:21:59 INFO - 'sessionrestore', 17:21:59 INFO - 'sessionrestore_no_auto_restore', 17:21:59 INFO - 'tabpaint']}, 17:21:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:21:59 INFO - 'tests': ['tsvgx', 17:21:59 INFO - 'tsvgr_opacity', 17:21:59 INFO - 'tart', 17:21:59 INFO - 'tscrollx', 17:21:59 INFO - 'cart']}, 17:21:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:21:59 INFO - 'tsvgr_opacity', 17:21:59 INFO - 'tart', 17:21:59 INFO - 'tscrollx', 17:21:59 INFO - 'cart']}, 17:21:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:59 INFO - 'talos_options': ['--disable-e10s'], 17:21:59 INFO - 'tests': ['tp5o']}, 17:21:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:59 INFO - 'tests': ['tp5o']}, 17:21:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:59 INFO - 'talos_options': ['--disable-e10s', 17:21:59 INFO - '--xperf_path', 17:21:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:21:59 INFO - 'tests': ['tp5n']}, 17:21:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:59 INFO - 'talos_options': ['--xperf_path', 17:21:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:21:59 INFO - 'tests': ['tp5n']}}, 17:21:59 INFO - 'talos.zip': {'path': '', 17:21:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:21:59 INFO - Running post-action listener: _resource_record_post_action 17:21:59 INFO - [mozharness: 2016-08-17 00:21:59.205607Z] Finished populate-webroot step (success) 17:21:59 INFO - [mozharness: 2016-08-17 00:21:59.205696Z] Running create-virtualenv step. 17:21:59 INFO - Running pre-action listener: _resource_record_pre_action 17:21:59 INFO - Running main action method: create_virtualenv 17:21:59 INFO - Creating virtualenv /builds/slave/test/build/venv 17:21:59 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 17:21:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:21:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:21:59 INFO - Using real prefix '/usr' 17:21:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:21:59 INFO - Installing distribute.............................................................................................................................................................................................done. 17:22:01 INFO - Installing pip.................done. 17:22:01 INFO - Return code: 0 17:22:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:01 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 0x7effe1e54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2705230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ff090>, '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 0x27029b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2702e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697', '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 17:22:01 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 17:22:01 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 17:22:01 INFO - Using env: {'DISPLAY': ':0', 17:22:01 INFO - 'HOME': '/home/cltbld', 17:22:01 INFO - 'LANG': 'en_US.UTF-8', 17:22:01 INFO - 'LANGUAGE': 'en_US:en', 17:22:01 INFO - 'LOGNAME': 'cltbld', 17:22:01 INFO - 'MAIL': '/var/mail/cltbld', 17:22:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:01 INFO - 'MOZ_NO_REMOTE': '1', 17:22:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:01 INFO - 'NO_EM_RESTART': '1', 17:22:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:01 INFO - 'PWD': '/builds/slave/test', 17:22:01 INFO - 'SHELL': '/bin/bash', 17:22:01 INFO - 'SHLVL': '1', 17:22:01 INFO - 'TERM': 'linux', 17:22:01 INFO - 'TMOUT': '86400', 17:22:01 INFO - 'USER': 'cltbld', 17:22:01 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697', 17:22:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:01 INFO - '_': '/tools/buildbot/bin/python'} 17:22:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:01 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 17:22:01 INFO - Cleaning up... 17:22:01 INFO - Return code: 0 17:22:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:02 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 0x7effe1e54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2705230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ff090>, '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 0x27029b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2702e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697', '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 17:22:02 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 17:22:02 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 17:22:02 INFO - Using env: {'DISPLAY': ':0', 17:22:02 INFO - 'HOME': '/home/cltbld', 17:22:02 INFO - 'LANG': 'en_US.UTF-8', 17:22:02 INFO - 'LANGUAGE': 'en_US:en', 17:22:02 INFO - 'LOGNAME': 'cltbld', 17:22:02 INFO - 'MAIL': '/var/mail/cltbld', 17:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:02 INFO - 'MOZ_NO_REMOTE': '1', 17:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:02 INFO - 'NO_EM_RESTART': '1', 17:22:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:02 INFO - 'PWD': '/builds/slave/test', 17:22:02 INFO - 'SHELL': '/bin/bash', 17:22:02 INFO - 'SHLVL': '1', 17:22:02 INFO - 'TERM': 'linux', 17:22:02 INFO - 'TMOUT': '86400', 17:22:02 INFO - 'USER': 'cltbld', 17:22:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697', 17:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:02 INFO - '_': '/tools/buildbot/bin/python'} 17:22:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:02 INFO - Downloading/unpacking psutil>=3.1.1 17:22:02 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 17:22:02 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 17:22:02 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 17:22:02 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 17:22:02 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 17:22:02 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 17:22:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:22:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:22:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:22:04 INFO - Installing collected packages: psutil 17:22:04 INFO - Running setup.py install for psutil 17:22:04 INFO - building 'psutil._psutil_linux' extension 17:22:04 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 17:22:04 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 17:22:04 INFO - building 'psutil._psutil_posix' extension 17:22:04 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 17:22:04 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 17:22:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:22:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:22:04 INFO - Successfully installed psutil 17:22:04 INFO - Cleaning up... 17:22:04 INFO - Return code: 0 17:22:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:22:04 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:04 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:04 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 0x7effe1e54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2705230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ff090>, '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 0x27029b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2702e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697', '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 17:22:04 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 17:22:04 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 17:22:04 INFO - Using env: {'DISPLAY': ':0', 17:22:04 INFO - 'HOME': '/home/cltbld', 17:22:04 INFO - 'LANG': 'en_US.UTF-8', 17:22:04 INFO - 'LANGUAGE': 'en_US:en', 17:22:04 INFO - 'LOGNAME': 'cltbld', 17:22:04 INFO - 'MAIL': '/var/mail/cltbld', 17:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:04 INFO - 'MOZ_NO_REMOTE': '1', 17:22:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:04 INFO - 'NO_EM_RESTART': '1', 17:22:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:04 INFO - 'PWD': '/builds/slave/test', 17:22:04 INFO - 'SHELL': '/bin/bash', 17:22:04 INFO - 'SHLVL': '1', 17:22:04 INFO - 'TERM': 'linux', 17:22:04 INFO - 'TMOUT': '86400', 17:22:04 INFO - 'USER': 'cltbld', 17:22:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697', 17:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:04 INFO - '_': '/tools/buildbot/bin/python'} 17:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:22:04 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 17:22:04 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 17:22:04 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 17:22:04 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 17:22:04 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 17:22:04 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 17:22:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:22:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:22:06 INFO - Installing collected packages: mozsystemmonitor 17:22:06 INFO - Running setup.py install for mozsystemmonitor 17:22:07 INFO - Successfully installed mozsystemmonitor 17:22:07 INFO - Cleaning up... 17:22:07 INFO - Return code: 0 17:22:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:07 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 0x7effe1e54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2705230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ff090>, '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 0x27029b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2702e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697', '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 17:22:07 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 17:22:07 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 17:22:07 INFO - Using env: {'DISPLAY': ':0', 17:22:07 INFO - 'HOME': '/home/cltbld', 17:22:07 INFO - 'LANG': 'en_US.UTF-8', 17:22:07 INFO - 'LANGUAGE': 'en_US:en', 17:22:07 INFO - 'LOGNAME': 'cltbld', 17:22:07 INFO - 'MAIL': '/var/mail/cltbld', 17:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:07 INFO - 'MOZ_NO_REMOTE': '1', 17:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:07 INFO - 'NO_EM_RESTART': '1', 17:22:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:07 INFO - 'PWD': '/builds/slave/test', 17:22:07 INFO - 'SHELL': '/bin/bash', 17:22:07 INFO - 'SHLVL': '1', 17:22:07 INFO - 'TERM': 'linux', 17:22:07 INFO - 'TMOUT': '86400', 17:22:07 INFO - 'USER': 'cltbld', 17:22:07 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697', 17:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:07 INFO - '_': '/tools/buildbot/bin/python'} 17:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:07 INFO - Downloading/unpacking jsonschema==2.5.1 17:22:07 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 17:22:07 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 17:22:07 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 17:22:07 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 17:22:07 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 17:22:07 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 17:22:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:22:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:22:09 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 17:22:09 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 17:22:09 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 17:22:09 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 17:22:09 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 17:22:09 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 17:22:09 INFO - Downloading functools32-3.2.3-2.tar.gz 17:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:22:09 INFO - warning: no files found matching '*.txt' 17:22:09 INFO - no previously-included directories found matching 'build' 17:22:09 INFO - no previously-included directories found matching 'dist' 17:22:09 INFO - no previously-included directories found matching '.git*' 17:22:09 INFO - Installing collected packages: jsonschema, functools32 17:22:09 INFO - Running setup.py install for functools32 17:22:09 INFO - warning: no files found matching '*.txt' 17:22:09 INFO - no previously-included directories found matching 'build' 17:22:09 INFO - no previously-included directories found matching 'dist' 17:22:09 INFO - no previously-included directories found matching '.git*' 17:22:09 INFO - Successfully installed jsonschema functools32 17:22:09 INFO - Cleaning up... 17:22:09 INFO - Return code: 0 17:22:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:22:09 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:09 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:09 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7effe1e54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2705230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ff090>, '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 0x27029b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2702e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697', '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 17:22:09 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:22:09 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 functools32==3.2.3-2 17:22:09 INFO - Using env: {'DISPLAY': ':0', 17:22:09 INFO - 'HOME': '/home/cltbld', 17:22:09 INFO - 'LANG': 'en_US.UTF-8', 17:22:09 INFO - 'LANGUAGE': 'en_US:en', 17:22:09 INFO - 'LOGNAME': 'cltbld', 17:22:09 INFO - 'MAIL': '/var/mail/cltbld', 17:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:09 INFO - 'MOZ_NO_REMOTE': '1', 17:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:09 INFO - 'NO_EM_RESTART': '1', 17:22:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:09 INFO - 'PWD': '/builds/slave/test', 17:22:09 INFO - 'SHELL': '/bin/bash', 17:22:09 INFO - 'SHLVL': '1', 17:22:09 INFO - 'TERM': 'linux', 17:22:09 INFO - 'TMOUT': '86400', 17:22:09 INFO - 'USER': 'cltbld', 17:22:09 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697', 17:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:09 INFO - '_': '/tools/buildbot/bin/python'} 17:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:22:09 INFO - Cleaning up... 17:22:09 INFO - Return code: 0 17:22:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:22:09 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:09 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:09 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 0x7effe1e54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2705230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ff090>, '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 0x27029b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2702e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697', '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 17:22:09 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 17:22:09 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 17:22:09 INFO - Using env: {'DISPLAY': ':0', 17:22:09 INFO - 'HOME': '/home/cltbld', 17:22:09 INFO - 'LANG': 'en_US.UTF-8', 17:22:09 INFO - 'LANGUAGE': 'en_US:en', 17:22:09 INFO - 'LOGNAME': 'cltbld', 17:22:09 INFO - 'MAIL': '/var/mail/cltbld', 17:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:09 INFO - 'MOZ_NO_REMOTE': '1', 17:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:09 INFO - 'NO_EM_RESTART': '1', 17:22:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:09 INFO - 'PWD': '/builds/slave/test', 17:22:09 INFO - 'SHELL': '/bin/bash', 17:22:09 INFO - 'SHLVL': '1', 17:22:09 INFO - 'TERM': 'linux', 17:22:09 INFO - 'TMOUT': '86400', 17:22:09 INFO - 'USER': 'cltbld', 17:22:09 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697', 17:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:09 INFO - '_': '/tools/buildbot/bin/python'} 17:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:10 INFO - Downloading/unpacking blobuploader==1.2.4 17:22:10 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 17:22:10 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 17:22:10 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 17:22:10 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 17:22:10 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 17:22:10 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 17:22:11 INFO - Downloading blobuploader-1.2.4.tar.gz 17:22:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:22:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:22:12 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 17:22:12 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 17:22:12 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 17:22:12 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 17:22:12 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 17:22:12 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 17:22:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:22:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:22:12 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 17:22:12 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 17:22:12 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 17:22:12 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 17:22:12 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 17:22:12 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 17:22:12 INFO - Downloading docopt-0.6.1.tar.gz 17:22:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:22:12 INFO - Installing collected packages: blobuploader, requests, docopt 17:22:12 INFO - Running setup.py install for blobuploader 17:22:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:22:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:22:12 INFO - Running setup.py install for requests 17:22:13 INFO - Running setup.py install for docopt 17:22:13 INFO - Successfully installed blobuploader requests docopt 17:22:13 INFO - Cleaning up... 17:22:13 INFO - Return code: 0 17:22:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:13 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 0x7effe1e54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2705230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ff090>, '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 0x27029b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2702e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697', '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 17:22:13 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 17:22:13 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 17:22:13 INFO - Using env: {'DISPLAY': ':0', 17:22:13 INFO - 'HOME': '/home/cltbld', 17:22:13 INFO - 'LANG': 'en_US.UTF-8', 17:22:13 INFO - 'LANGUAGE': 'en_US:en', 17:22:13 INFO - 'LOGNAME': 'cltbld', 17:22:13 INFO - 'MAIL': '/var/mail/cltbld', 17:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:13 INFO - 'MOZ_NO_REMOTE': '1', 17:22:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:13 INFO - 'NO_EM_RESTART': '1', 17:22:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:13 INFO - 'PWD': '/builds/slave/test', 17:22:13 INFO - 'SHELL': '/bin/bash', 17:22:13 INFO - 'SHLVL': '1', 17:22:13 INFO - 'TERM': 'linux', 17:22:13 INFO - 'TMOUT': '86400', 17:22:13 INFO - 'USER': 'cltbld', 17:22:13 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697', 17:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:13 INFO - '_': '/tools/buildbot/bin/python'} 17:22:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:22:13 INFO - Running setup.py (path:/tmp/pip-iF3wJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:22:13 INFO - Running setup.py (path:/tmp/pip-0KZHqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:22:13 INFO - Running setup.py (path:/tmp/pip-0rdRjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:22:13 INFO - Running setup.py (path:/tmp/pip-QyKMvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:22:13 INFO - Running setup.py (path:/tmp/pip-Gzld4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:22:13 INFO - Running setup.py (path:/tmp/pip-BSLwoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:22:13 INFO - Running setup.py (path:/tmp/pip-xZHvQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:22:14 INFO - Running setup.py (path:/tmp/pip-GA15ye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:22:14 INFO - Running setup.py (path:/tmp/pip-Ynw_2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:22:14 INFO - Running setup.py (path:/tmp/pip-IEbkxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:22:14 INFO - Running setup.py (path:/tmp/pip-8QqYwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:22:14 INFO - Running setup.py (path:/tmp/pip-lzFbBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:22:14 INFO - Running setup.py (path:/tmp/pip-L1r3N6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:22:14 INFO - Running setup.py (path:/tmp/pip-sKkfPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:22:14 INFO - Running setup.py (path:/tmp/pip-z7VmRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:22:14 INFO - Running setup.py (path:/tmp/pip-n53dn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:22:14 INFO - Running setup.py (path:/tmp/pip-lAOCsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:22:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:22:14 INFO - Running setup.py install for manifestparser 17:22:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:22:14 INFO - Running setup.py install for mozcrash 17:22:14 INFO - Running setup.py install for mozdebug 17:22:15 INFO - Running setup.py install for mozdevice 17:22:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:22:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:22:15 INFO - Running setup.py install for mozfile 17:22:15 INFO - Running setup.py install for mozhttpd 17:22:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:22:15 INFO - Running setup.py install for mozinfo 17:22:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:22:15 INFO - Running setup.py install for mozInstall 17:22:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:22:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:22:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:22:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:22:15 INFO - Running setup.py install for mozleak 17:22:15 INFO - Running setup.py install for mozlog 17:22:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:22:15 INFO - Running setup.py install for moznetwork 17:22:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:22:15 INFO - Running setup.py install for mozprocess 17:22:16 INFO - Running setup.py install for mozprofile 17:22:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:22:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:22:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:22:16 INFO - Running setup.py install for mozrunner 17:22:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:22:16 INFO - Running setup.py install for mozscreenshot 17:22:16 INFO - Running setup.py install for moztest 17:22:16 INFO - Running setup.py install for mozversion 17:22:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:22:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:22:16 INFO - Cleaning up... 17:22:16 INFO - Return code: 0 17:22:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:16 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 0x7effe1e54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2705230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ff090>, '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 0x27029b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2702e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697', '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 17:22:16 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 17:22:16 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 17:22:16 INFO - Using env: {'DISPLAY': ':0', 17:22:16 INFO - 'HOME': '/home/cltbld', 17:22:16 INFO - 'LANG': 'en_US.UTF-8', 17:22:16 INFO - 'LANGUAGE': 'en_US:en', 17:22:16 INFO - 'LOGNAME': 'cltbld', 17:22:16 INFO - 'MAIL': '/var/mail/cltbld', 17:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:16 INFO - 'MOZ_NO_REMOTE': '1', 17:22:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:16 INFO - 'NO_EM_RESTART': '1', 17:22:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:16 INFO - 'PWD': '/builds/slave/test', 17:22:16 INFO - 'SHELL': '/bin/bash', 17:22:16 INFO - 'SHLVL': '1', 17:22:16 INFO - 'TERM': 'linux', 17:22:16 INFO - 'TMOUT': '86400', 17:22:16 INFO - 'USER': 'cltbld', 17:22:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697', 17:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:16 INFO - '_': '/tools/buildbot/bin/python'} 17:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:22:16 INFO - Running setup.py (path:/tmp/pip-wE1sdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:22:16 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)) 17:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:22:16 INFO - Running setup.py (path:/tmp/pip-UpuGYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:22:16 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)) 17:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:22:16 INFO - Running setup.py (path:/tmp/pip-XY5eeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:22:16 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)) 17:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:22:16 INFO - Running setup.py (path:/tmp/pip-sYyLCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:22:17 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)) 17:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:22:17 INFO - Running setup.py (path:/tmp/pip-eSQGbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:22:17 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)) 17:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:22:17 INFO - Running setup.py (path:/tmp/pip-kOxNf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:22:17 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)) 17:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:22:17 INFO - Running setup.py (path:/tmp/pip-r34173-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:22:17 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)) 17:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:22:17 INFO - Running setup.py (path:/tmp/pip-1zFEmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:22:17 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)) 17:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:22:17 INFO - Running setup.py (path:/tmp/pip-6HGz1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:22:17 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)) 17:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:22:17 INFO - Running setup.py (path:/tmp/pip-RPl2Af-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:22:17 INFO - Running setup.py (path:/tmp/pip-BEnc_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:22:17 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)) 17:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:22:17 INFO - Running setup.py (path:/tmp/pip-2RNmmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:22:17 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)) 17:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:22:17 INFO - Running setup.py (path:/tmp/pip-n8L89l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:22:17 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)) 17:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:22:17 INFO - Running setup.py (path:/tmp/pip-gMs3qA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:22:17 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)) 17:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:22:17 INFO - Running setup.py (path:/tmp/pip-xgBYMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:22:17 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)) 17:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:22:17 INFO - Running setup.py (path:/tmp/pip-7bglzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:22:17 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)) 17:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:22:17 INFO - Running setup.py (path:/tmp/pip-ioQB5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:22:18 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)) 17:22:18 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)) 17:22:18 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)) 17:22:18 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)) 17:22:18 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)) 17:22:18 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)) 17:22:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:19 INFO - Downloading blessings-1.6.tar.gz 17:22:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:22:19 INFO - Installing collected packages: blessings 17:22:19 INFO - Running setup.py install for blessings 17:22:20 INFO - Successfully installed blessings 17:22:20 INFO - Cleaning up... 17:22:20 INFO - Return code: 0 17:22:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:22:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:22:20 INFO - Reading from file tmpfile_stdout 17:22:20 INFO - Current package versions: 17:22:20 INFO - argparse == 1.2.1 17:22:20 INFO - blessings == 1.6 17:22:20 INFO - blobuploader == 1.2.4 17:22:20 INFO - docopt == 0.6.1 17:22:20 INFO - functools32 == 3.2.3-2 17:22:20 INFO - jsonschema == 2.5.1 17:22:20 INFO - manifestparser == 1.1 17:22:20 INFO - mozInstall == 1.12 17:22:20 INFO - mozcrash == 0.17 17:22:20 INFO - mozdebug == 0.1 17:22:20 INFO - mozdevice == 0.48 17:22:20 INFO - mozfile == 1.2 17:22:20 INFO - mozhttpd == 0.7 17:22:20 INFO - mozinfo == 0.9 17:22:20 INFO - mozleak == 0.1 17:22:20 INFO - mozlog == 3.3 17:22:20 INFO - moznetwork == 0.27 17:22:20 INFO - mozprocess == 0.23 17:22:20 INFO - mozprofile == 0.28 17:22:20 INFO - mozrunner == 6.12 17:22:20 INFO - mozscreenshot == 0.1 17:22:20 INFO - mozsystemmonitor == 0.3 17:22:20 INFO - moztest == 0.7 17:22:20 INFO - mozversion == 1.4 17:22:20 INFO - psutil == 3.1.1 17:22:20 INFO - requests == 1.2.3 17:22:20 INFO - wsgiref == 0.1.2 17:22:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:20 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 0x7effe1e54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2705230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ff090>, '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 0x27029b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2702e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697', '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 17:22:20 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 17:22:20 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 17:22:20 INFO - Using env: {'DISPLAY': ':0', 17:22:20 INFO - 'HOME': '/home/cltbld', 17:22:20 INFO - 'LANG': 'en_US.UTF-8', 17:22:20 INFO - 'LANGUAGE': 'en_US:en', 17:22:20 INFO - 'LOGNAME': 'cltbld', 17:22:20 INFO - 'MAIL': '/var/mail/cltbld', 17:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:20 INFO - 'MOZ_NO_REMOTE': '1', 17:22:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:20 INFO - 'NO_EM_RESTART': '1', 17:22:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:20 INFO - 'PWD': '/builds/slave/test', 17:22:20 INFO - 'SHELL': '/bin/bash', 17:22:20 INFO - 'SHLVL': '1', 17:22:20 INFO - 'TERM': 'linux', 17:22:20 INFO - 'TMOUT': '86400', 17:22:20 INFO - 'USER': 'cltbld', 17:22:20 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697', 17:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:20 INFO - '_': '/tools/buildbot/bin/python'} 17:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:20 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)) 17:22:20 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)) 17:22:20 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)) 17:22:20 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)) 17:22:20 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)) 17:22:20 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)) 17:22:20 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)) 17:22:20 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)) 17:22:20 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)) 17:22:20 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)) 17:22:20 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)) 17:22:20 INFO - Cleaning up... 17:22:20 INFO - Return code: 0 17:22:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:20 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 0x7effe1e54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2705230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ff090>, '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 0x27029b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2702e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697', '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 17:22:20 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 17:22:20 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 17:22:20 INFO - Using env: {'DISPLAY': ':0', 17:22:20 INFO - 'HOME': '/home/cltbld', 17:22:20 INFO - 'LANG': 'en_US.UTF-8', 17:22:20 INFO - 'LANGUAGE': 'en_US:en', 17:22:20 INFO - 'LOGNAME': 'cltbld', 17:22:20 INFO - 'MAIL': '/var/mail/cltbld', 17:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:20 INFO - 'MOZ_NO_REMOTE': '1', 17:22:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:20 INFO - 'NO_EM_RESTART': '1', 17:22:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:20 INFO - 'PWD': '/builds/slave/test', 17:22:20 INFO - 'SHELL': '/bin/bash', 17:22:20 INFO - 'SHLVL': '1', 17:22:20 INFO - 'TERM': 'linux', 17:22:20 INFO - 'TMOUT': '86400', 17:22:20 INFO - 'USER': 'cltbld', 17:22:20 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697', 17:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:20 INFO - '_': '/tools/buildbot/bin/python'} 17:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:22:20 INFO - Cleaning up... 17:22:20 INFO - Return code: 0 17:22:20 INFO - Running post-action listener: _resource_record_post_action 17:22:20 INFO - Running post-action listener: _start_resource_monitoring 17:22:20 INFO - Starting resource monitoring. 17:22:20 INFO - [mozharness: 2016-08-17 00:22:20.865049Z] Finished create-virtualenv step (success) 17:22:20 INFO - [mozharness: 2016-08-17 00:22:20.865684Z] Running install step. 17:22:20 INFO - Running pre-action listener: _resource_record_pre_action 17:22:20 INFO - Running main action method: install 17:22:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:22:21 INFO - Reading from file tmpfile_stdout 17:22:21 INFO - Detecting whether we're running mozinstall >=1.0... 17:22:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:22:21 INFO - Reading from file tmpfile_stdout 17:22:21 INFO - Output received: 17:22:21 INFO - Usage: mozinstall [options] installer 17:22:21 INFO - Options: 17:22:21 INFO - -h, --help show this help message and exit 17:22:21 INFO - -d DEST, --destination=DEST 17:22:21 INFO - Directory to install application into. [default: 17:22:21 INFO - "/builds/slave/test"] 17:22:21 INFO - --app=APP Application being installed. [default: firefox] 17:22:21 INFO - mkdir: /builds/slave/test/build/application 17:22:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:22:37 INFO - Reading from file tmpfile_stdout 17:22:37 INFO - Output received: 17:22:37 INFO - /builds/slave/test/build/application/firefox/firefox 17:22:37 INFO - Running post-action listener: _resource_record_post_action 17:22:37 INFO - [mozharness: 2016-08-17 00:22:37.177316Z] Finished install step (success) 17:22:37 INFO - [mozharness: 2016-08-17 00:22:37.177633Z] Running run-tests step. 17:22:37 INFO - Running pre-action listener: _resource_record_pre_action 17:22:37 INFO - Running main action method: run_tests 17:22:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:22:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:22:37 INFO - Python 2.7.3 17:22:37 INFO - Return code: 0 17:22:37 INFO - grabbing minidump binary from tooltool 17:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:37 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 0x26ff090>, '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 0x27029b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2702e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:22:37 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 17:22:37 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 17:22:37 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 17:22:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:22:37 INFO - Return code: 0 17:22:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:22:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:22:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:22:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:22:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:22:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HCS9INJYQle-v-y70ha5ug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 17:22:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HCS9INJYQle-v-y70ha5ug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 17:22:37 INFO - Using env: {'DISPLAY': ':0', 17:22:37 INFO - 'HOME': '/home/cltbld', 17:22:37 INFO - 'LANG': 'en_US.UTF-8', 17:22:37 INFO - 'LANGUAGE': 'en_US:en', 17:22:37 INFO - 'LOGNAME': 'cltbld', 17:22:37 INFO - 'MAIL': '/var/mail/cltbld', 17:22:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:22:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:22:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:37 INFO - 'MOZ_NO_REMOTE': '1', 17:22:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:22:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:37 INFO - 'NO_EM_RESTART': '1', 17:22:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:37 INFO - 'PWD': '/builds/slave/test', 17:22:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:22:37 INFO - 'SHELL': '/bin/bash', 17:22:37 INFO - 'SHLVL': '1', 17:22:37 INFO - 'TERM': 'linux', 17:22:37 INFO - 'TMOUT': '86400', 17:22:37 INFO - 'USER': 'cltbld', 17:22:37 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697', 17:22:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:37 INFO - '_': '/tools/buildbot/bin/python'} 17:22:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HCS9INJYQle-v-y70ha5ug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 17:22:37 INFO - mozversion application_buildid: 20160816163815 17:22:37 INFO - mozversion application_changeset: 52be5024e34261bcd08d68fda65379ed0ffd363d 17:22:37 INFO - mozversion application_display_name: Nightly 17:22:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:22:37 INFO - mozversion application_name: Firefox 17:22:37 INFO - mozversion application_remotingname: firefox 17:22:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:22:37 INFO - mozversion application_vendor: Mozilla 17:22:37 INFO - mozversion application_version: 51.0a1 17:22:37 INFO - mozversion platform_buildid: 20160816163815 17:22:37 INFO - mozversion platform_changeset: 52be5024e34261bcd08d68fda65379ed0ffd363d 17:22:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:22:37 INFO - mozversion platform_version: 51.0a1 17:22:37 INFO - using testdate: 1471393357 17:22:37 INFO - actual date: 1471393357 17:22:37 INFO - starting webserver on 'localhost:40576' 17:22:37 INFO - SUITE-START | Running 2 tests 17:22:37 INFO - TEST-START | dromaeo_css 17:22:37 INFO - operating with platform_type : linux_ 17:22:37 INFO - Initialising browser for dromaeo_css test... 17:22:37 INFO - TEST-INFO | started process 29230 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx302UX/profile http://localhost:40576/getInfo.html) 17:22:41 INFO - PROCESS | 29230 | __metrics Screen width/height:1600/1200 17:22:41 INFO - PROCESS | 29230 | colorDepth:24 17:22:41 INFO - PROCESS | 29230 | Browser inner width/height: 1024/697 17:22:41 INFO - PROCESS | 29230 | __metrics 17:22:42 INFO - PROCESS | 29230 | 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" 17:22:42 INFO - PROCESS | 29230 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:22:42 INFO - PROCESS | 29230 | console.error: PushService: 17:22:42 INFO - PROCESS | 29230 | stateChangeProcessEnqueue: Error transitioning state 17:22:42 INFO - PROCESS | 29230 | UnknownError 17:22:43 INFO - TEST-INFO | 29230: exit 0 17:22:43 INFO - Browser initialized. 17:22:43 INFO - Running cycle 1/1 for dromaeo_css test... 17:22:43 INFO - TEST-INFO | started process 29311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx302UX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:22:55 INFO - PROCESS | 29311 | RSS: Main: 156942336 17:22:55 INFO - PROCESS | 29311 | 17:23:46 INFO - PROCESS | 29311 | 1471393426164 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] 17:25:59 INFO - PROCESS | 29311 | Cycle 1(1): loaded http://localhost:40576/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40576/tests/dromaeo/cssquery-ext.html) 17:26:00 INFO - PROCESS | 29311 | RSS: Main: 236933120 17:26:00 INFO - PROCESS | 29311 | 17:29:03 INFO - PROCESS | 29311 | Cycle 1(1): loaded http://localhost:40576/tests/dromaeo/cssquery-ext.html (next: http://localhost:40576/tests/dromaeo/cssquery-jquery.html) 17:29:03 INFO - PROCESS | 29311 | RSS: Main: 240939008 17:29:03 INFO - PROCESS | 29311 | 17:32:06 INFO - PROCESS | 29311 | Cycle 1(1): loaded http://localhost:40576/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40576/tests/dromaeo/cssquery-mootools.html) 17:32:06 INFO - PROCESS | 29311 | RSS: Main: 227287040 17:32:06 INFO - PROCESS | 29311 | 17:35:08 INFO - PROCESS | 29311 | Cycle 1(1): loaded http://localhost:40576/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40576/tests/dromaeo/cssquery-prototype.html) 17:35:09 INFO - PROCESS | 29311 | RSS: Main: 189693952 17:35:09 INFO - PROCESS | 29311 | 17:38:12 INFO - PROCESS | 29311 | Cycle 1(1): loaded http://localhost:40576/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40576/tests/dromaeo/cssquery-yui.html) 17:38:13 INFO - PROCESS | 29311 | RSS: Main: 188866560 17:38:13 INFO - PROCESS | 29311 | 17:41:16 INFO - PROCESS | 29311 | Cycle 1(1): loaded http://localhost:40576/tests/dromaeo/cssquery-yui.html (next: http://localhost:40576/tests/dromaeo/cssquery-dojo.html) 17:41:16 INFO - PROCESS | 29311 | RSS: Main: 281968640 17:41:16 INFO - PROCESS | 29311 | 17:41:16 INFO - PROCESS | 29311 | __start_tp_report 17:41:16 INFO - PROCESS | 29311 | _x_x_mozilla_page_load 17:41:16 INFO - PROCESS | 29311 | _x_x_mozilla_page_load_details 17:41:16 INFO - PROCESS | 29311 | |i|pagename|runs| 17:41:16 INFO - PROCESS | 29311 | |0;dojo.html;2651.072124756335;2666.1601595497427;2687.717789632089;2712.4168303814677;2714.090779588839;4611.515790841963;4728.645351598627;4825.734584597846;4834.34736310598;4845.685030473017;4752.548507891754;4762.285657151429;4765.90468190636;4798.880027999302;4815;4340.891477713051;4369.694121411502;4384.693071484981;4445.599896009358;4451.844185453509;4401.05377343871;4420.535843736409;4434.06884554244;4440.356148358486;4465.910681786362;4321.654267658611;4378.036831896978;4394.4946331172005;4397.31841564558;4486.596206341429;4327.502337231227;4395.714278571914;4409.228385032607;4413.117376524708;4455.086707225011;4379.211741886459;4394.494633117169;4394.956050439487;4419;4436.223660859337;4628.629709623222;4717.2452407614965;4791.041791641651;4792.209285467894;4816;5048.368953880765;5152.175651895716;5162;5230.110881150214;5235.842924712265;5209.6874187548865;5248.580113590903;5266.631335806495;5272.683638981635;5274.498922602346;4733.100710864925;4903.362562866804;4904.0191961607825;4912.508749125059;4918.9508104919205;5236.39781425141;5290.761915713802;5304.018756530054;5378.139497680352;5380.569554435636;5092.388913330424;5098.4646612105935;5127.948720512822;5145.922811157836;5146.30524879144;5043.167877300278;5199.194124910569;5205.115130427836;5225.869353266199;5232.2413250078525;4911.582515486224;5012.398512178562;5081.4918508148885;5112.207607820794;5160.819371321985;5069.315642388304;5081;5082.161443361878;5082.33929589151;5127.1540195867265;4228.851990180329;4270.957290427056;4291.334843099325;4307.913841723211;4354.912901741947;3730.6642402183934;3760.041189496661;3780.8865734028022;3794.2601192767147;3809.980950095232;4492.213862574036;4496.100779844044;4498.865034048984;4505.45934487857;4535.478419981744;5168;5188.766505507261;5198.740062996835;5208.244804503326;5240.449752775904;4363.52001279859;4438.1567502174485;4457.821687132543;4480.305552639346;4493.483249426293;4641.443026836801;4643.791029403685;4644.442666879929;4678.2982552616695;4698.248280275139;4936.358273424504;4936.7284799336385;4942.975285123552;4944.035912996931;4972.925406118911;5039.395272567315;5097.209932460474;5098.158803797481;5199.532042116228;5237.16205407133;4860.586850117638;4863.610911127172;4864.683795553277;4885.047415754036;4902.166631672696;4987.276844857548;5014.34813474246;5017.974910125426;5023.974880125576;5051.646384753032;4985.376827896513;5064.316317297265;5096.286519887293;5127.2309153625765;5161.251618515219;4991.575716064175;4993.725345105909;4995.300657907823;4997.3253610762085;5021.297018417497;4990.80036798524;4995.150824359795;4999.175136102503;5008.223725322581;5051.318072060371;4819.7108173509705;4884.462709102067;4912.95087049125;4917.28699338601;4977.178765503651;5006;5049.2426136079885;5052.292679025013;5080.212567052113;5082.4917508250355;4904.681195722266;4920.975395123001;4936.259561065725;4938.75306234694;4977.228529577921 17:41:16 INFO - PROCESS | 29311 | |1;ext.html;565.9915101273481;567.3730527766818;570.9971450142749;579.7478097027796;581.4360070731391;28393.716062839365;31301.686983130192;31353.216169595773;37754.244915101684;38894;40841;41116.17767644645;41234;41250.381244281285;41251.58748412515;7457.5152615080115;7593.544387336749;7594.354479869217;7595.696172153107;7599.202083781206;7659.540427574336;7770.261825126604;7775.222477752236;7775.650095745705;7775.922240777576;7747.922520774805;7786.416018798613;7805.765827025199;7812.101608315032;7816.570088645122;7735.30382265596;7754.030746156731;7771.067471903351;7771.494852834548;7774.222577742237;7639.541627502367;7676.46264761467;7702.961485192594;7707.845843083107;7714.845703085963;38207.426888596696;38589.807050964846;38612.80693596542;38634.61365386338;38700.80649596762;2977.672456029835;3126.187191330248;3158.3051728619666;3334.1997920498907;3731.8320675569666;28679.42641147186;28749.56875646867;28749.712502874914;28894.71105288941;30333.848330758425;3488.0930957950864;3513.9648603513892;3524.9118772030647;3535.6287589803214;3649.543807024122;182900;184204;184339;184375;185069.0746546272;32553.51169732456;49524.25713614299;49952;50073;50125.73428321387;32889.83555082209;32891.50662740013;32902.177445563575;32933.83533082319;33032.3393532128;11652.883471165349;11746.236494627821;11762.5883094093;11763.294202347886;11765.647030588925;9423.717288481357;9505.382150160218;9517.048295170427;9544.0455954404;9546.665866694771;7720.343770779435;7749.41879359039;7786.26030527099;7812.92187078122;7826.7651970440975;3006.9849650751607;3078.707522785332;3088.1162490880547;3123.048094940662;3131.2171957010746;806.6974884418344;820.5733018830175;918.9816203675889;966.5119114846957;1032.3599368391494;27280.181594552196;27393.45213095727;27882.581761273595;28199.295017624314;28664.426711466072;974.1184228273424;1010.888802231754;1021.4126877045728;1062.16089289462;1067.7170549804307;14236;14767.409303627735;14947.912540600328;15000.699986000438;15111.4710985115;407910;410686;411020.9448952736;411220;412088;47784;48393;48573.5142648569;48581;48651;1052.4737631184407;1101;1128.1426116151947;1161.2742036227357;1204.072863894796;25633.10284140046;28651.561812582622;29206.41587168287;29489.85255073711;29791.255218619706;37042.629573704995;37324;37341.2531749358;37370.626293737805;37373;309729;311354;312211;312687;313429;21968.231111911005;22138.55722885501;22561.21035763806;22576.435589110402;24968.625470618317;36538.63461365352;36799.44800827936;40003.39943909222;40936.38595421011;42568.78715606402;35050.29899401947;35158.29683406266;35217;35323.82338088293;35867.46198806968;34672.82663586666;35503.82248088743;35730.464043039894;35976.64023359837;36055.81972090123;34542.65457345395;34622.65377346295;35601.82199088988;35661.821690892415;35952;29984.85007574948;32268.83865580751;32451;32812;33112.33775324432;24194.41194550785;24294.651406232366;24673.50652986966;24682.876585616956;24910.87544562338 17:41:16 INFO - PROCESS | 29311 | |2;jquery.html;343.9656034396559;345.7234212629897;354.1306093540358;354.7623092528005;379.66968737198624;13235;15825.446109386174;16029.91985040076;17071.743923841153;17928.37250696226;15675.921620391911;16059.759103613425;16105;16129.274182661778;16218.918905405457;4978.054169707753;5169.948300516984;5194.37667479901;5402.243685883979;5430.158325459541;3509.263054758491;5243.816466423676;5370.301860758096;5395.757190926398;5412.810551630694;5608.747606357723;5621.943780562204;5632.887342253173;5633.943660563383;5639.238702775114;5596.048671725796;5598.4961353478175;5761.769529218826;6175.258968923713;6204.689765511706;5460.6177567570285;5499.257600223958;5503.9174412383445;5504.64219825714;5507.779688812443;13394.464221431132;20564.38306850797;20618.278360257318;20766;20766.792332076788;1813.8186181381889;1817.082373401437;1864.2170288478735;2235.7205349331334;2284.7486776454575;8544.700935467292;8938.284937205008;9267.907320926772;9273.536323183882;9388.62445502179;1705.7697210876497;1755.1312100510202;1777.919993600278;1794.9282028718967;1825.7809062912536;67302.32697673059;68330.65834670844;68776.96834547535;69200.6539967302;69422.3057769426;10009.549570269355;10200;10228.07947284748;10306.381617102848;10363.585456581803;13934.790978135336;13989.440422383193;14005.229712365917;14033.438662453591;14042.578722638336;6665.800025999228;6748.257691653914;6863.794086177422;6941.409980151642;6944.062551555577;6142.57002009855;6160.199174107337;6372;6380.042993551005;6385.48916086712;3946.230485055444;4010.498687664042;4074.490688663917;4280.186764514732;4533.5013148553635;1756.604763928106;1789.3111152206234;1816.9909150454164;1839.172372432384;1839.8344149026652;843.3759018326517;871.1854416120947;895.3866601378077;903.5617725403174;916.093067862811;16579.751303730452;16751.581210469834;17473.56316092108;17577.824221757874;17667.469975900745;820.6500306995079;861.3798065392907;883.2360008592522;929.4051806843626;936.1247233836385;9672.95163524192;9725.4650994196;9754.122129008423;9798.902010979942;9835.557399917021;354243;365227;365337;366806;367404;72964;77569.22430775732;78252;78567;79313.60343198247;869.3705095504132;879.366855863777;896.050186801979;897;899.3434792601438;14990.025648332823;15146.545603631908;15558.9222053889;15950.760738588699;16048.1173535452;36616.81691591525;36633.26733465369;38034.23931521299;38583;38769.224615508094;50785.492145078075;51103.48896511136;51268.23097653613;51442.74278628583;52063.97136386539;5420.319700892735;6467.838304042437;7514.849703006019;7635.3583979442465;7674.961625191839;9527.523623818919;11332.433378330885;11502.82745758831;11543.942280288546;11951.581694640647;9760.951195243979;10207.132393746615;10303.278770486293;10522.263441559018;10760.89239107599;10349.430781307101;10394.844077338998;10397.428141452292;10399.740006499898;10440.895591044296;10319.896801031893;10459.738506537398;10673.199510036624;10779.191560632828;11060.612878549213;6492.28584855656;7531.171571127062;7699.730509432367;7732.652030658522;7955.602219889098;8519.95740021296;10379.896201037893;10466.947665261625;10520.210984176065;10619.469026548488 17:41:16 INFO - PROCESS | 29311 | |3;mootools.html;1225.9877401225986;1328.1632571479965;1371.3691701817163;1417.893657975652;1651.0918994553;6669.833254168642;7303.671334789934;7643.388528917687;7669.923300766984;7881.645325960331;7690.077190737105;7750.302472777449;7750.341220996208;7753.418493612988;7756.418268629861;2176.542925985541;2205.0959106766227;2211.1487077475126;2212.048819007826;2213.9225127120553;2140.454184183031;2190.561887622474;2197.8351623628214;2207.8454508184354;2209.7679743626927;2143.839212059094;2162.4053385319007;2175.9347219583437;2177.314146043999;2179.215482426333;2096.5597224582857;2108.441263065289;2110.4090854560673;2111.092230340953;2112.2501511963337;2067.6071546406133;2111.9366419007456;2114.7356580427445;2116.947076323089;2118.364490652798;7561.810954726121;7695.576318381118;7707.075150981918;7739.922600774033;7785.805354866117;4412.691111622188;4530.569595888385;4544.750038747868;4554.703944243647;4558.202314594932;2867.971320286791;2961.6149900512796;2989.8505074746395;3006.9548956765666;3013.3370658455106;963.1428029054148;966.8453047512364;967.1730670276883;981.190517822799;999.8000399920045;10348;10441.895581044168;10450.268481206318;10458.215633827493;10565.788684226349;4040.1111755413763;4064.837406503707;4068.0846809468226;4083.0813067059676;4163.063310755117;8241.093479717227;8248.13394593559;8258.463199892109;8259.545724985064;8262.380321475914;4341.544137865541;4344.674149438804;4347.891302717458;4349.499807522176;4350.434443522322;3612.9638703612627;3682.765304474233;3740.831662575191;4017.6183262590007;4019.9397009044887;3360.6975372216616;3389.881354152593;3499.2651543175707;3500.3524347995194;3508.2281897982402;1048.6487026846091;1050.24907191357;1054.514923135351;1056.7410984308895;1062;736.7973807202955;743.3644234179807;748.0649188514357;761.6610608279374;850.8978922529336;4873.780679869344;5008.824691135793;5009.148444764399;5015.974920125449;5271.156614941591;405.08652987513557;415.3326130269711;420.66346922461906;423.3036654702996;427.164892634898;3486.633903440153;3492.9126771830906;3537.1510837398837;3538.168530395355;3634.0914771307175;9213.63145474187;9625.855612165824;9632.32573719847;9635.759106022266;9657.22742180624;9586.66446674363;9610.95194524023;9621.615135394506;9623.470709111067;9670.951645241728;7115.75094871677;7197.856042879113;7234.385077268491;7254.600996945113;7264.782056538313;5055.266986286894;5138.486151384981;5238.397584277857;5267.209918512254;5304.496072873071;8503.362247831561;8742.781430464289;8758.518281494578;8767.824643507221;8814.2948564116;8796.384253102477;8805.735827925173;8859.424137431304;8905.688300909436;9025.684101056431;6384.3934826191435;6444.291127976013;6446.161998940295;6457.354264573505;6461.386168314003;6998.860022799618;7260.201377848327;7394.408447324094;7429.294217049372;7438.702451901863;6585.539012269095;6629.337066293525;6631.270560238273;6841.965790171017;6995.195552511526;6298.401651843067;6370.522210834113;6418.743250269937;6472.029195620695;6547.148870646785;6080.847978800565;6085.269767627913;6087.786927457518;6098.908516372169;6103.3591472894705;4225.683073769418;4290.957090429056;4326.329418940069;4359.149965756774;4377.934330985101;4639.35049093134;4658.86023419298;4707.4821769606;4807.4471435785335;4829.661923665451 17:41:16 INFO - PROCESS | 29311 | |4;prototype.html;291.81907217525134;295.5655186875294;299.6194832562646;304.394255431691;305.1486353074921;4847.975760121199;4864.878378040551;4869.7565121743855;4869.951300486999;4879.658423910323;4804.807807687697;4826.179549476588;4826.613870890329;4826.7586620669;4830.4686484486765;3593.5687717473875;3694.4643026761105;3701.463892484629;3705.2589482103554;3726.5528136623507;3627.6916462100753;3721.3301605710963;3746.1945681678435;3770.3213421584105;3809.2381523695235;3739.9065023374496;3745.550533935918;3749.2817707162226;3760.2291530236234;3762.3039737648487;3538.221591249921;3702.333579955607;3744.138848064933;3745.1573395985956;3749.5500539935247;3277.4100661880852;3277.72139368154;3280.507369147056;3280.523764306048;3289.687479689426;4689.264971960397;4694.24892017279;4706.788194531255;4707.929381059287;4708.623310135181;4253.319468884994;4265.573442655709;4277.182197566053;4279.443672322609;4286.957130428687;4908.312836202935;4919.975400122977;4966.255061740768;4982.010793523857;5033;3564.821758912044;3564.8574057037686;3581.1047238190454;3594.6944509716704;3597.9100522486888;5215;5239.790408383698;5249.370075590953;5263.605229607795;5265.2628631991165;3559.928801423957;3642.745007849478;3650.1969566695284;3665.9266814663556;3669.2661467706566;3701.148735790783;3706.814659267026;3708.9985703859807;3722.813859307024;3726.627337266306;4207.137536804948;4223.260929337353;4227.323628219531;4229.302165142779;4232.280512312914;4882.877928051827;5004.424491183488;5009.221726287188;5012.949870501321;5027.245913113063;1260.2564486952558;1271.9809202861964;1282.1409655530817;1286.6397408725572;1289.071868254855;789.1989630525022;813.9186081391813;825.9215374539409;826.6817275348914;830.2237408023517;4304.80628371724;4354.216241076637;4457.194836091323;4459.799309031101;4461.553844615577;5153.613478989091;5178.792848286102;5206.583473322201;5231.450697676765;5238.895222095613;4502.4371953505815;4503.144402563503;4517.661175411858;4518.480374756945;4532.841350552715;2629.5924131759607;2758.586212068206;2762.682291536499;2765.14280573023;2770.5844123381653;4928.531789479994;4931.3589233399425;4956.5786908112495;4956.925646115311;4965.4041515018425;5071;5324.547413469821;5327.600429967768;5331.81338653153;5332.200169974535;4919.508049195123;4927.359443272423;4943.382077240345;4956.330895329229;4958.652894297365;5155.587552995827;5156.9742151289;5209.166533354645;5217.8173763918085;5235.345581802275;4882.511748825089;5094.847154585368;5099.949000509948;5117.411497677815;5123.462036486264;4830.927536086891;4870.756462176948;4882.5605695487575;4905.754712264301;4929.728864912321;3632.1464455853384;3650.762700424464;3651.3245049664833;3654.3787556114994;3659.5608526976935;4994.425641051325;5192.870178245574;5200.829813291979;5225.16397376418;5225.947740522698;5038.84883453497;5053.418856831511;5060.316857224375;5060.367454068241;5072.873178170427;5045;5049.6465247432325;5049.8737531562;5059.468755780737;5070.8225212117395;4749.4063242094735;4989.476105009067;4990.476000019946;5003.474635163256;5014.674046186986;4916;4990.6007519397635;5076.898462030665;5092.2361645753435;5101.20931255656;4990.50094990498;4994.925076123788;4995.925875936691;4997.201007637175;5000.624953128603 17:41:16 INFO - PROCESS | 29311 | |5;yui.html;615.9784407545735;693.7017082654463;693.8300116471469;726.386203657909;727.8980942668024;12290.877091229086;13439.798403023962;13446.663833404169;13465.7306853863;13479.460821567138;12583.622491325252;12716.491340346374;12718.872811271884;12719.618411447671;12720.93639531801;615.6860001399297;727.5198369076411;742.6101296819172;753.1226121568367;761.261576271019;762.5996351915234;772.9265719756614;773.0259872560558;774.0324594257179;774.1059076766344;811.6753298680516;812.8536863364592;813.1380736419385;813.2883726739103;813.5281536708725;645.5481163185742;776.4021703288493;797.4656979823532;806.395203597302;806.4314658165979;596.6777939912442;598.7156100852104;598.7305712429425;599.307799491588;599.9790007349766;12747.04397170216;12750.489980400773;12778;12843.87156128436;12845.67885802853;12278.324692141929;12615.621531354074;12938.935305323508;13117.621775072175;13456.461741530327;11349.943250283779;11703.18077734559;11844.40777961107;12192.695182620417;12477.438515266835;4102.835886564564;4119.361498967635;4137.689673274486;4302.118065796504;4312.482502099737;65258;65481.345186548475;65568.01647975332;65619.34380656228;66265.3373466264;10152.137068349273;10314.48427578618;10471.267011309288;10660.09389201911;11112.722181945515;19853;19880.50298742543;19889.204431822563;19896.204151833765;20010.399688009384;6658.641819361644;6750.527463077636;6757.966210169016;6769.898451523231;6950.652467376611;3710.703143748494;3730.4590834329415;3759.398496240643;3791.7156213284115;3864.091938394475;2782.373965857666;2893.8119022263486;2898.4927637663322;2902.216401571606;2904.361040571071;508.7430847422028;509.95665368443355;519.1952473665802;519.9584033277329;524.0776233828414;468.32093464476645;540.2787278982523;576.705880001194;590.893639144958;594.1118028547263;7352.852942941218;7500.174980752113;7818.804529886798;7923.6830526778285;7965.65350447153;488.27003629574017;543.4891202269854;555.0037682360173;571.3401021819805;582.286698793974;3730.347189241872;3925.1953349563273;4109.075458021921;4218.978905105516;4348.7390756554705;101652.49173754084;104125;105425;105575.4721226389;108133;85228.57385713032;86240.56879715562;89228;89886;90409;56282.718586407624;69379.30620693728;77524.22475775283;78668.60665696635;80910.19089809144;8330.916690833013;8410.369222308474;8534.487930724177;8636.136386361564;8649.221570058726;42620.78689606532;43864.561354386045;44677.55322446864;45039.324410134526;45318.18727250873;60474.69762651159;61555.15226053518;62829.37170628418;63013;65714.67142664256;10950.178736594627;11096.88903110991;11250.156238282325;11488.253263537843;11973.940130299292;12897.871021289668;13072.281024543741;13506.122102063335;14049.623857738861;14191.574252772434;11378.21233797725;11519.596814111466;11707.063434925356;11721.531138754695;12059.336736479227;11579.247348922294;11829.881701183222;12054.337011464102;12674.239545627292;12689.175203611736;11133.665990020312;11459.255148415326;11935.164538482222;11937.28376297425;11941.16411851162;9592.472414017297;10333.121684656888;10498.160147188359;10750.784984300426;11381.317120972768;9190.310726695658;10169.288149829441;10327.741806454898;10443.164546836082;10468.110210632181 17:41:16 INFO - PROCESS | 29311 | __end_tp_report 17:41:16 INFO - PROCESS | 29311 | __start_cc_report 17:41:16 INFO - PROCESS | 29311 | _x_x_mozilla_cycle_collect,904 17:41:16 INFO - PROCESS | 29311 | __end_cc_report 17:41:16 INFO - PROCESS | 29311 | __startTimestamp1471394476576__endTimestamp 17:41:16 INFO - PROCESS | 29311 | 17:41:16 INFO - PROCESS | 29311 | ------- Summary: start ------- 17:41:16 INFO - PROCESS | 29311 | Number of tests: 6 17:41:16 INFO - PROCESS | 29311 | 17:41:16 INFO - PROCESS | 29311 | [#0] dojo.html Cycles:165 Average:4755.09 Median:4912.51 stddev:506.30 (10.3%) stddev-sans-first:480.20 17:41:16 INFO - PROCESS | 29311 | Values: 2651.1 2666.2 2687.7 2712.4 2714.1 4611.5 4728.6 4825.7 4834.3 4845.7 4752.5 4762.3 4765.9 4798.9 4815.0 4340.9 4369.7 4384.7 4445.6 4451.8 4401.1 4420.5 4434.1 4440.4 4465.9 4321.7 4378.0 4394.5 4397.3 4486.6 4327.5 4395.7 4409.2 4413.1 4455.1 4379.2 4394.5 4395.0 4419.0 4436.2 4628.6 4717.2 4791.0 4792.2 4816.0 5048.4 5152.2 5162.0 5230.1 5235.8 5209.7 5248.6 5266.6 5272.7 5274.5 4733.1 4903.4 4904.0 4912.5 4919.0 5236.4 5290.8 5304.0 5378.1 5380.6 5092.4 5098.5 5127.9 5145.9 5146.3 5043.2 5199.2 5205.1 5225.9 5232.2 4911.6 5012.4 5081.5 5112.2 5160.8 5069.3 5081.0 5082.2 5082.3 5127.2 4228.9 4271.0 4291.3 4307.9 4354.9 3730.7 3760.0 3780.9 3794.3 3810.0 4492.2 4496.1 4498.9 4505.5 4535.5 5168.0 5188.8 5198.7 5208.2 5240.4 4363.5 4438.2 4457.8 4480.3 4493.5 4641.4 4643.8 4644.4 4678.3 4698.2 4936.4 4936.7 4943.0 4944.0 4972.9 5039.4 5097.2 5098.2 5199.5 5237.2 4860.6 4863.6 4864.7 4885.0 4902.2 4987.3 5014.3 5018.0 5024.0 5051.6 4985.4 5064.3 5096.3 5127.2 5161.3 4991.6 4993.7 4995.3 4997.3 5021.3 4990.8 4995.2 4999.2 5008.2 5051.3 4819.7 4884.5 4913.0 4917.3 4977.2 5006.0 5049.2 5052.3 5080.2 5082.5 4904.7 4921.0 4936.3 4938.8 4977.2 17:41:16 INFO - PROCESS | 29311 | 17:41:16 INFO - PROCESS | 29311 | [#1] ext.html Cycles:180 Average:44207.30 Median:35631.82 stddev:83819.72 (235.2%) stddev-sans-first:83990.81 17:41:16 INFO - PROCESS | 29311 | Values: 566.0 567.4 571.0 579.7 581.4 28393.7 31301.7 31353.2 37754.2 38894.0 40841.0 41116.2 41234.0 41250.4 41251.6 7457.5 7593.5 7594.4 7595.7 7599.2 7659.5 7770.3 7775.2 7775.7 7775.9 7747.9 7786.4 7805.8 7812.1 7816.6 7735.3 7754.0 7771.1 7771.5 7774.2 7639.5 7676.5 7703.0 7707.8 7714.8 38207.4 38589.8 38612.8 38634.6 38700.8 2977.7 3126.2 3158.3 3334.2 3731.8 28679.4 28749.6 28749.7 28894.7 30333.8 3488.1 3514.0 3524.9 3535.6 3649.5 182900.0 184204.0 184339.0 184375.0 185069.1 32553.5 49524.3 49952.0 50073.0 50125.7 32889.8 32891.5 32902.2 32933.8 33032.3 11652.9 11746.2 11762.6 11763.3 11765.6 9423.7 9505.4 9517.0 9544.0 9546.7 7720.3 7749.4 7786.3 7812.9 7826.8 3007.0 3078.7 3088.1 3123.0 3131.2 806.7 820.6 919.0 966.5 1032.4 27280.2 27393.5 27882.6 28199.3 28664.4 974.1 1010.9 1021.4 1062.2 1067.7 14236.0 14767.4 14947.9 15000.7 15111.5 407910.0 410686.0 411020.9 411220.0 412088.0 47784.0 48393.0 48573.5 48581.0 48651.0 1052.5 1101.0 1128.1 1161.3 1204.1 25633.1 28651.6 29206.4 29489.9 29791.3 37042.6 37324.0 37341.3 37370.6 37373.0 309729.0 311354.0 312211.0 312687.0 313429.0 21968.2 22138.6 22561.2 22576.4 24968.6 36538.6 36799.4 40003.4 40936.4 42568.8 35050.3 35158.3 35217.0 35323.8 35867.5 34672.8 35503.8 35730.5 35976.6 36055.8 34542.7 34622.7 35601.8 35661.8 35952.0 29984.9 32268.8 32451.0 32812.0 33112.3 24194.4 24294.7 24673.5 24682.9 24910.9 17:41:16 INFO - PROCESS | 29311 | 17:41:16 INFO - PROCESS | 29311 | [#2] jquery.html Cycles:180 Average:23501.58 Median:4177.34 stddev:60279.45 (1443.0%) stddev-sans-first:60423.47 17:41:16 INFO - PROCESS | 29311 | Values: 344.0 345.7 354.1 354.8 379.7 13235.0 15825.4 16029.9 17071.7 17928.4 15675.9 16059.8 16105.0 16129.3 16218.9 4978.1 5169.9 5194.4 5402.2 5430.2 3509.3 5243.8 5370.3 5395.8 5412.8 5608.7 5621.9 5632.9 5633.9 5639.2 5596.0 5598.5 5761.8 6175.3 6204.7 5460.6 5499.3 5503.9 5504.6 5507.8 13394.5 20564.4 20618.3 20766.0 20766.8 1813.8 1817.1 1864.2 2235.7 2284.7 8544.7 8938.3 9267.9 9273.5 9388.6 1705.8 1755.1 1777.9 1794.9 1825.8 67302.3 68330.7 68777.0 69200.7 69422.3 10009.5 10200.0 10228.1 10306.4 10363.6 13934.8 13989.4 14005.2 14033.4 14042.6 6665.8 6748.3 6863.8 6941.4 6944.1 6142.6 6160.2 6372.0 6380.0 6385.5 3946.2 4010.5 4074.5 4280.2 4533.5 1756.6 1789.3 1817.0 1839.2 1839.8 843.4 871.2 895.4 903.6 916.1 16579.8 16751.6 17473.6 17577.8 17667.5 820.7 861.4 883.2 929.4 936.1 9673.0 9725.5 9754.1 9798.9 9835.6 354243.0 365227.0 365337.0 366806.0 367404.0 72964.0 77569.2 78252.0 78567.0 79313.6 869.4 879.4 896.1 897.0 899.3 14990.0 15146.5 15558.9 15950.8 16048.1 36616.8 36633.3 38034.2 38583.0 38769.2 50785.5 51103.5 51268.2 51442.7 52064.0 5420.3 6467.8 7514.8 7635.4 7675.0 9527.5 11332.4 11502.8 11543.9 11951.6 9761.0 10207.1 10303.3 10522.3 10760.9 10349.4 10394.8 10397.4 10399.7 10440.9 10319.9 10459.7 10673.2 10779.2 11060.6 6492.3 7531.2 7699.7 7732.7 7955.6 8520.0 10379.9 10466.9 10520.2 10619.5 17:41:16 INFO - PROCESS | 29311 | 17:41:16 INFO - PROCESS | 29311 | [#3] mootools.html Cycles:180 Average:4998.61 Median:4941.30 stddev:2832.20 (57.3%) stddev-sans-first:2825.95 17:41:16 INFO - PROCESS | 29311 | Values: 1226.0 1328.2 1371.4 1417.9 1651.1 6669.8 7303.7 7643.4 7669.9 7881.6 7690.1 7750.3 7750.3 7753.4 7756.4 2176.5 2205.1 2211.1 2212.0 2213.9 2140.5 2190.6 2197.8 2207.8 2209.8 2143.8 2162.4 2175.9 2177.3 2179.2 2096.6 2108.4 2110.4 2111.1 2112.3 2067.6 2111.9 2114.7 2116.9 2118.4 7561.8 7695.6 7707.1 7739.9 7785.8 4412.7 4530.6 4544.8 4554.7 4558.2 2868.0 2961.6 2989.9 3007.0 3013.3 963.1 966.8 967.2 981.2 999.8 10348.0 10441.9 10450.3 10458.2 10565.8 4040.1 4064.8 4068.1 4083.1 4163.1 8241.1 8248.1 8258.5 8259.5 8262.4 4341.5 4344.7 4347.9 4349.5 4350.4 3613.0 3682.8 3740.8 4017.6 4019.9 3360.7 3389.9 3499.3 3500.4 3508.2 1048.6 1050.2 1054.5 1056.7 1062.0 736.8 743.4 748.1 761.7 850.9 4873.8 5008.8 5009.1 5016.0 5271.2 405.1 415.3 420.7 423.3 427.2 3486.6 3492.9 3537.2 3538.2 3634.1 9213.6 9625.9 9632.3 9635.8 9657.2 9586.7 9611.0 9621.6 9623.5 9671.0 7115.8 7197.9 7234.4 7254.6 7264.8 5055.3 5138.5 5238.4 5267.2 5304.5 8503.4 8742.8 8758.5 8767.8 8814.3 8796.4 8805.7 8859.4 8905.7 9025.7 6384.4 6444.3 6446.2 6457.4 6461.4 6998.9 7260.2 7394.4 7429.3 7438.7 6585.5 6629.3 6631.3 6842.0 6995.2 6298.4 6370.5 6418.7 6472.0 6547.1 6080.8 6085.3 6087.8 6098.9 6103.4 4225.7 4291.0 4326.3 4359.1 4377.9 4639.4 4658.9 4707.5 4807.4 4829.7 17:41:16 INFO - PROCESS | 29311 | 17:41:16 INFO - PROCESS | 29311 | [#4] prototype.html Cycles:180 Average:4184.38 Median:4830.70 stddev:1224.99 (25.4%) stddev-sans-first:1193.08 17:41:16 INFO - PROCESS | 29311 | Values: 291.8 295.6 299.6 304.4 305.1 4848.0 4864.9 4869.8 4870.0 4879.7 4804.8 4826.2 4826.6 4826.8 4830.5 3593.6 3694.5 3701.5 3705.3 3726.6 3627.7 3721.3 3746.2 3770.3 3809.2 3739.9 3745.6 3749.3 3760.2 3762.3 3538.2 3702.3 3744.1 3745.2 3749.6 3277.4 3277.7 3280.5 3280.5 3289.7 4689.3 4694.2 4706.8 4707.9 4708.6 4253.3 4265.6 4277.2 4279.4 4287.0 4908.3 4920.0 4966.3 4982.0 5033.0 3564.8 3564.9 3581.1 3594.7 3597.9 5215.0 5239.8 5249.4 5263.6 5265.3 3559.9 3642.7 3650.2 3665.9 3669.3 3701.1 3706.8 3709.0 3722.8 3726.6 4207.1 4223.3 4227.3 4229.3 4232.3 4882.9 5004.4 5009.2 5012.9 5027.2 1260.3 1272.0 1282.1 1286.6 1289.1 789.2 813.9 825.9 826.7 830.2 4304.8 4354.2 4457.2 4459.8 4461.6 5153.6 5178.8 5206.6 5231.5 5238.9 4502.4 4503.1 4517.7 4518.5 4532.8 2629.6 2758.6 2762.7 2765.1 2770.6 4928.5 4931.4 4956.6 4956.9 4965.4 5071.0 5324.5 5327.6 5331.8 5332.2 4919.5 4927.4 4943.4 4956.3 4958.7 5155.6 5157.0 5209.2 5217.8 5235.3 4882.5 5094.8 5099.9 5117.4 5123.5 4830.9 4870.8 4882.6 4905.8 4929.7 3632.1 3650.8 3651.3 3654.4 3659.6 4994.4 5192.9 5200.8 5225.2 5225.9 5038.8 5053.4 5060.3 5060.4 5072.9 5045.0 5049.6 5049.9 5059.5 5070.8 4749.4 4989.5 4990.5 5003.5 5014.7 4916.0 4990.6 5076.9 5092.2 5101.2 4990.5 4994.9 4995.9 4997.2 5000.6 17:41:16 INFO - PROCESS | 29311 | 17:41:16 INFO - PROCESS | 29311 | [#5] yui.html Cycles:180 Average:18257.95 Median:23461.45 stddev:26353.85 (112.3%) stddev-sans-first:26394.48 17:41:16 INFO - PROCESS | 29311 | Values: 616.0 693.7 693.8 726.4 727.9 12290.9 13439.8 13446.7 13465.7 13479.5 12583.6 12716.5 12718.9 12719.6 12720.9 615.7 727.5 742.6 753.1 761.3 762.6 772.9 773.0 774.0 774.1 811.7 812.9 813.1 813.3 813.5 645.5 776.4 797.5 806.4 806.4 596.7 598.7 598.7 599.3 600.0 12747.0 12750.5 12778.0 12843.9 12845.7 12278.3 12615.6 12938.9 13117.6 13456.5 11349.9 11703.2 11844.4 12192.7 12477.4 4102.8 4119.4 4137.7 4302.1 4312.5 65258.0 65481.3 65568.0 65619.3 66265.3 10152.1 10314.5 10471.3 10660.1 11112.7 19853.0 19880.5 19889.2 19896.2 20010.4 6658.6 6750.5 6758.0 6769.9 6950.7 3710.7 3730.5 3759.4 3791.7 3864.1 2782.4 2893.8 2898.5 2902.2 2904.4 508.7 510.0 519.2 520.0 524.1 468.3 540.3 576.7 590.9 594.1 7352.9 7500.2 7818.8 7923.7 7965.7 488.3 543.5 555.0 571.3 582.3 3730.3 3925.2 4109.1 4219.0 4348.7 101652.5 104125.0 105425.0 105575.5 108133.0 85228.6 86240.6 89228.0 89886.0 90409.0 56282.7 69379.3 77524.2 78668.6 80910.2 8330.9 8410.4 8534.5 8636.1 8649.2 42620.8 43864.6 44677.6 45039.3 45318.2 60474.7 61555.2 62829.4 63013.0 65714.7 10950.2 11096.9 11250.2 11488.3 11973.9 12897.9 13072.3 13506.1 14049.6 14191.6 11378.2 11519.6 11707.1 11721.5 12059.3 11579.2 11829.9 12054.3 12674.2 12689.2 11133.7 11459.3 11935.2 11937.3 11941.2 9592.5 10333.1 10498.2 10750.8 11381.3 9190.3 10169.3 10327.7 10443.2 10468.1 17:41:16 INFO - PROCESS | 29311 | -------- Summary: end -------- 17:41:16 INFO - PROCESS | 29311 | 17:41:17 INFO - TEST-INFO | 29311: exit 0 17:41:17 INFO - TEST-OK | dromaeo_css | took 1120006ms 17:41:17 INFO - TEST-START | kraken 17:41:17 INFO - operating with platform_type : linux_ 17:41:17 INFO - Initialising browser for kraken test... 17:41:17 INFO - TEST-INFO | started process 29614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRbEy8i/profile http://localhost:40576/getInfo.html) 17:41:21 INFO - PROCESS | 29614 | __metrics Screen width/height:1600/1200 17:41:21 INFO - PROCESS | 29614 | colorDepth:24 17:41:21 INFO - PROCESS | 29614 | Browser inner width/height: 1024/697 17:41:21 INFO - PROCESS | 29614 | __metrics 17:41:22 INFO - PROCESS | 29614 | 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" 17:41:22 INFO - PROCESS | 29614 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:41:23 INFO - TEST-INFO | 29614: exit 0 17:41:23 INFO - Browser initialized. 17:41:23 INFO - Running cycle 1/1 for kraken test... 17:41:23 INFO - TEST-INFO | started process 29698 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRbEy8i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:41:35 INFO - PROCESS | 29698 | RSS: Main: 157114368 17:41:35 INFO - PROCESS | 29698 | 17:41:37 INFO - PROCESS | 29698 | Cycle 1(1): loaded http://localhost:40576/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40576/tests/kraken/driver.html?testName=audio-beat-detection) 17:41:38 INFO - PROCESS | 29698 | RSS: Main: 204931072 17:41:38 INFO - PROCESS | 29698 | 17:41:41 INFO - PROCESS | 29698 | Cycle 1(1): loaded http://localhost:40576/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40576/tests/kraken/driver.html?testName=audio-dft) 17:41:42 INFO - PROCESS | 29698 | RSS: Main: 195796992 17:41:42 INFO - PROCESS | 29698 | 17:41:45 INFO - PROCESS | 29698 | Cycle 1(1): loaded http://localhost:40576/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40576/tests/kraken/driver.html?testName=audio-fft) 17:41:46 INFO - PROCESS | 29698 | RSS: Main: 277946368 17:41:46 INFO - PROCESS | 29698 | 17:41:48 INFO - PROCESS | 29698 | Cycle 1(1): loaded http://localhost:40576/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40576/tests/kraken/driver.html?testName=audio-oscillator) 17:41:48 INFO - PROCESS | 29698 | RSS: Main: 187478016 17:41:48 INFO - PROCESS | 29698 | 17:41:51 INFO - PROCESS | 29698 | Cycle 1(1): loaded http://localhost:40576/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40576/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:41:51 INFO - PROCESS | 29698 | RSS: Main: 191643648 17:41:51 INFO - PROCESS | 29698 | 17:41:54 INFO - PROCESS | 29698 | Cycle 1(1): loaded http://localhost:40576/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40576/tests/kraken/driver.html?testName=imaging-darkroom) 17:41:55 INFO - PROCESS | 29698 | RSS: Main: 228864000 17:41:55 INFO - PROCESS | 29698 | 17:41:59 INFO - PROCESS | 29698 | Cycle 1(1): loaded http://localhost:40576/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40576/tests/kraken/driver.html?testName=imaging-desaturate) 17:41:59 INFO - PROCESS | 29698 | RSS: Main: 222461952 17:41:59 INFO - PROCESS | 29698 | 17:42:02 INFO - PROCESS | 29698 | Cycle 1(1): loaded http://localhost:40576/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40576/tests/kraken/driver.html?testName=json-parse-financial) 17:42:03 INFO - PROCESS | 29698 | RSS: Main: 226033664 17:42:03 INFO - PROCESS | 29698 | 17:42:04 INFO - PROCESS | 29698 | Cycle 1(1): loaded http://localhost:40576/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40576/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:42:05 INFO - PROCESS | 29698 | RSS: Main: 189591552 17:42:05 INFO - PROCESS | 29698 | 17:42:07 INFO - PROCESS | 29698 | Cycle 1(1): loaded http://localhost:40576/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40576/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:42:07 INFO - PROCESS | 29698 | RSS: Main: 197197824 17:42:07 INFO - PROCESS | 29698 | 17:42:10 INFO - PROCESS | 29698 | Cycle 1(1): loaded http://localhost:40576/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40576/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:42:10 INFO - PROCESS | 29698 | RSS: Main: 194347008 17:42:10 INFO - PROCESS | 29698 | 17:42:13 INFO - PROCESS | 29698 | Cycle 1(1): loaded http://localhost:40576/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40576/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:42:14 INFO - PROCESS | 29698 | RSS: Main: 189448192 17:42:14 INFO - PROCESS | 29698 | 17:42:17 INFO - PROCESS | 29698 | Cycle 1(1): loaded http://localhost:40576/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40576/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:42:17 INFO - PROCESS | 29698 | RSS: Main: 192847872 17:42:17 INFO - PROCESS | 29698 | 17:42:19 INFO - PROCESS | 29698 | Cycle 1(1): loaded http://localhost:40576/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40576/tests/kraken/driver.html?testName=ai-astar) 17:42:19 INFO - PROCESS | 29698 | RSS: Main: 243101696 17:42:19 INFO - PROCESS | 29698 | 17:42:19 INFO - PROCESS | 29698 | __start_tp_report 17:42:19 INFO - PROCESS | 29698 | _x_x_mozilla_page_load 17:42:19 INFO - PROCESS | 29698 | _x_x_mozilla_page_load_details 17:42:19 INFO - PROCESS | 29698 | |i|pagename|runs| 17:42:19 INFO - PROCESS | 29698 | |0;ai-astar;105;114;114;113;109;113;114;112;113;114 17:42:19 INFO - PROCESS | 29698 | |1;audio-beat-detection;148;122;123;177;129;150;147;127;177;128 17:42:19 INFO - PROCESS | 29698 | |2;audio-dft;160;161;161;162;160;161;162;161;161;163 17:42:19 INFO - PROCESS | 29698 | |3;audio-fft;76;77;75;107;76;76;75;77;104;76 17:42:19 INFO - PROCESS | 29698 | |4;audio-oscillator;85;86;129;85;85;85;124;84;86;136 17:42:19 INFO - PROCESS | 29698 | |5;imaging-gaussian-blur;117;118;118;116;117;117;117;116;116;117 17:42:19 INFO - PROCESS | 29698 | |6;imaging-darkroom;146;147;145;146;147;147;146;146;146;146 17:42:19 INFO - PROCESS | 29698 | |7;imaging-desaturate;96;95;95;95;95;95;95;96;95;95 17:42:19 INFO - PROCESS | 29698 | |8;json-parse-financial;69;66;69;67;66;68;66;67;67;66 17:42:19 INFO - PROCESS | 29698 | |9;json-stringify-tinderbox;66;66;66;65;67;65;67;66;65;65 17:42:19 INFO - PROCESS | 29698 | |10;stanford-crypto-aes;84;91;83;84;83;92;86;83;92;86 17:42:19 INFO - PROCESS | 29698 | |11;stanford-crypto-ccm;135;132;133;129;139;131;128;144;155;143 17:42:19 INFO - PROCESS | 29698 | |12;stanford-crypto-pbkdf2;172;171;169;171;174;172;170;173;171;169 17:42:19 INFO - PROCESS | 29698 | |13;stanford-crypto-sha256-iterative;70;68;71;69;70;71;70;66;69;67 17:42:19 INFO - PROCESS | 29698 | __end_tp_report 17:42:19 INFO - PROCESS | 29698 | __start_cc_report 17:42:19 INFO - PROCESS | 29698 | _x_x_mozilla_cycle_collect,1952 17:42:19 INFO - PROCESS | 29698 | __end_cc_report 17:42:19 INFO - PROCESS | 29698 | __startTimestamp1471394539809__endTimestamp 17:42:19 INFO - PROCESS | 29698 | 17:42:19 INFO - PROCESS | 29698 | ------- Summary: start ------- 17:42:19 INFO - PROCESS | 29698 | Number of tests: 14 17:42:19 INFO - PROCESS | 29698 | 17:42:19 INFO - PROCESS | 29698 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.50 stddev:2.92 (2.6%) stddev-sans-first:1.62 17:42:19 INFO - PROCESS | 29698 | Values: 105.0 114.0 114.0 113.0 109.0 113.0 114.0 112.0 113.0 114.0 17:42:19 INFO - PROCESS | 29698 | 17:42:19 INFO - PROCESS | 29698 | [#1] audio-beat-detection Cycles:10 Average:142.80 Median:147.50 stddev:20.87 (14.1%) stddev-sans-first:22.05 17:42:19 INFO - PROCESS | 29698 | Values: 148.0 122.0 123.0 177.0 129.0 150.0 147.0 127.0 177.0 128.0 17:42:19 INFO - PROCESS | 29698 | 17:42:19 INFO - PROCESS | 29698 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 17:42:19 INFO - PROCESS | 29698 | Values: 160.0 161.0 161.0 162.0 160.0 161.0 162.0 161.0 161.0 163.0 17:42:19 INFO - PROCESS | 29698 | 17:42:19 INFO - PROCESS | 29698 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:12.48 (16.4%) stddev-sans-first:13.05 17:42:19 INFO - PROCESS | 29698 | Values: 76.0 77.0 75.0 107.0 76.0 76.0 75.0 77.0 104.0 76.0 17:42:19 INFO - PROCESS | 29698 | 17:42:19 INFO - PROCESS | 29698 | [#4] audio-oscillator Cycles:10 Average:98.50 Median:85.00 stddev:21.70 (25.5%) stddev-sans-first:22.46 17:42:19 INFO - PROCESS | 29698 | Values: 85.0 86.0 129.0 85.0 85.0 85.0 124.0 84.0 86.0 136.0 17:42:19 INFO - PROCESS | 29698 | 17:42:19 INFO - PROCESS | 29698 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 17:42:19 INFO - PROCESS | 29698 | Values: 117.0 118.0 118.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 17:42:19 INFO - PROCESS | 29698 | 17:42:19 INFO - PROCESS | 29698 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 17:42:19 INFO - PROCESS | 29698 | Values: 146.0 147.0 145.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 17:42:19 INFO - PROCESS | 29698 | 17:42:19 INFO - PROCESS | 29698 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 17:42:19 INFO - PROCESS | 29698 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 17:42:19 INFO - PROCESS | 29698 | 17:42:19 INFO - PROCESS | 29698 | [#8] json-parse-financial Cycles:10 Average:67.10 Median:67.00 stddev:1.20 (1.8%) stddev-sans-first:1.05 17:42:19 INFO - PROCESS | 29698 | Values: 69.0 66.0 69.0 67.0 66.0 68.0 66.0 67.0 67.0 66.0 17:42:19 INFO - PROCESS | 29698 | 17:42:19 INFO - PROCESS | 29698 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 17:42:19 INFO - PROCESS | 29698 | Values: 66.0 66.0 66.0 65.0 67.0 65.0 67.0 66.0 65.0 65.0 17:42:19 INFO - PROCESS | 29698 | 17:42:19 INFO - PROCESS | 29698 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:86.00 stddev:3.81 (4.4%) stddev-sans-first:3.94 17:42:19 INFO - PROCESS | 29698 | Values: 84.0 91.0 83.0 84.0 83.0 92.0 86.0 83.0 92.0 86.0 17:42:19 INFO - PROCESS | 29698 | 17:42:19 INFO - PROCESS | 29698 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:137.00 stddev:8.43 (6.1%) stddev-sans-first:8.91 17:42:19 INFO - PROCESS | 29698 | Values: 135.0 132.0 133.0 129.0 139.0 131.0 128.0 144.0 155.0 143.0 17:42:19 INFO - PROCESS | 29698 | 17:42:19 INFO - PROCESS | 29698 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.20 Median:171.50 stddev:1.62 (0.9%) stddev-sans-first:1.69 17:42:19 INFO - PROCESS | 29698 | Values: 172.0 171.0 169.0 171.0 174.0 172.0 170.0 173.0 171.0 169.0 17:42:19 INFO - PROCESS | 29698 | 17:42:19 INFO - PROCESS | 29698 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:70.00 stddev:1.66 (2.4%) stddev-sans-first:1.73 17:42:19 INFO - PROCESS | 29698 | Values: 70.0 68.0 71.0 69.0 70.0 71.0 70.0 66.0 69.0 67.0 17:42:19 INFO - PROCESS | 29698 | -------- Summary: end -------- 17:42:19 INFO - PROCESS | 29698 | 17:42:20 INFO - TEST-INFO | 29698: exit 0 17:42:20 INFO - TEST-OK | kraken | took 63436ms 17:42:20 INFO - SUITE-END | took 1183s 17:42:20 INFO - Completed test suite (00:19:43) 17:42:20 INFO - javascript benchmark 17:42:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2651.072124756335, 2666.1601595497427, 2687.717789632089, 2712.4168303814677, 2714.090779588839, 4611.515790841963, 4728.645351598627, 4825.734584597846, 4834.34736310598, 4845.685030473017, 4752.548507891754, 4762.285657151429, 4765.90468190636, 4798.880027999302, 4815.0, 4340.891477713051, 4369.694121411502, 4384.693071484981, 4445.599896009358, 4451.844185453509, 4401.05377343871, 4420.535843736409, 4434.06884554244, 4440.356148358486, 4465.910681786362, 4321.654267658611, 4378.036831896978, 4394.4946331172005, 4397.31841564558, 4486.596206341429, 4327.502337231227, 4395.714278571914, 4409.228385032607, 4413.117376524708, 4455.086707225011, 4379.211741886459, 4394.494633117169, 4394.956050439487, 4419.0, 4436.223660859337, 4628.629709623222, 4717.2452407614965, 4791.041791641651, 4792.209285467894, 4816.0, 5048.368953880765, 5152.175651895716, 5162.0, 5230.110881150214, 5235.842924712265, 5209.6874187548865, 5248.580113590903, 5266.631335806495, 5272.683638981635, 5274.498922602346, 4733.100710864925, 4903.362562866804, 4904.0191961607825, 4912.508749125059, 4918.9508104919205, 5236.39781425141, 5290.761915713802, 5304.018756530054, 5378.139497680352, 5380.569554435636, 5092.388913330424, 5098.4646612105935, 5127.948720512822, 5145.922811157836, 5146.30524879144, 5043.167877300278, 5199.194124910569, 5205.115130427836, 5225.869353266199, 5232.2413250078525, 4911.582515486224, 5012.398512178562, 5081.4918508148885, 5112.207607820794, 5160.819371321985, 5069.315642388304, 5081.0, 5082.161443361878, 5082.33929589151, 5127.1540195867265, 4228.851990180329, 4270.957290427056, 4291.334843099325, 4307.913841723211, 4354.912901741947, 3730.6642402183934, 3760.041189496661, 3780.8865734028022, 3794.2601192767147, 3809.980950095232, 4492.213862574036, 4496.100779844044, 4498.865034048984, 4505.45934487857, 4535.478419981744, 5168.0, 5188.766505507261, 5198.740062996835, 5208.244804503326, 5240.449752775904, 4363.52001279859, 4438.1567502174485, 4457.821687132543, 4480.305552639346, 4493.483249426293, 4641.443026836801, 4643.791029403685, 4644.442666879929, 4678.2982552616695, 4698.248280275139, 4936.358273424504, 4936.7284799336385, 4942.975285123552, 4944.035912996931, 4972.925406118911, 5039.395272567315, 5097.209932460474, 5098.158803797481, 5199.532042116228, 5237.16205407133, 4860.586850117638, 4863.610911127172, 4864.683795553277, 4885.047415754036, 4902.166631672696, 4987.276844857548, 5014.34813474246, 5017.974910125426, 5023.974880125576, 5051.646384753032, 4985.376827896513, 5064.316317297265, 5096.286519887293, 5127.2309153625765, 5161.251618515219, 4991.575716064175, 4993.725345105909, 4995.300657907823, 4997.3253610762085, 5021.297018417497, 4990.80036798524, 4995.150824359795, 4999.175136102503, 5008.223725322581, 5051.318072060371, 4819.7108173509705, 4884.462709102067, 4912.95087049125, 4917.28699338601, 4977.178765503651, 5006.0, 5049.2426136079885, 5052.292679025013, 5080.212567052113, 5082.4917508250355, 4904.681195722266, 4920.975395123001, 4936.259561065725, 4938.75306234694, 4977.228529577921], "value": 4722.360525438306, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.9915101273481, 567.3730527766818, 570.9971450142749, 579.7478097027796, 581.4360070731391, 28393.716062839365, 31301.686983130192, 31353.216169595773, 37754.244915101684, 38894.0, 40841.0, 41116.17767644645, 41234.0, 41250.381244281285, 41251.58748412515, 7457.5152615080115, 7593.544387336749, 7594.354479869217, 7595.696172153107, 7599.202083781206, 7659.540427574336, 7770.261825126604, 7775.222477752236, 7775.650095745705, 7775.922240777576, 7747.922520774805, 7786.416018798613, 7805.765827025199, 7812.101608315032, 7816.570088645122, 7735.30382265596, 7754.030746156731, 7771.067471903351, 7771.494852834548, 7774.222577742237, 7639.541627502367, 7676.46264761467, 7702.961485192594, 7707.845843083107, 7714.845703085963, 38207.426888596696, 38589.807050964846, 38612.80693596542, 38634.61365386338, 38700.80649596762, 2977.672456029835, 3126.187191330248, 3158.3051728619666, 3334.1997920498907, 3731.8320675569666, 28679.42641147186, 28749.56875646867, 28749.712502874914, 28894.71105288941, 30333.848330758425, 3488.0930957950864, 3513.9648603513892, 3524.9118772030647, 3535.6287589803214, 3649.543807024122, 182900.0, 184204.0, 184339.0, 184375.0, 185069.0746546272, 32553.51169732456, 49524.25713614299, 49952.0, 50073.0, 50125.73428321387, 32889.83555082209, 32891.50662740013, 32902.177445563575, 32933.83533082319, 33032.3393532128, 11652.883471165349, 11746.236494627821, 11762.5883094093, 11763.294202347886, 11765.647030588925, 9423.717288481357, 9505.382150160218, 9517.048295170427, 9544.0455954404, 9546.665866694771, 7720.343770779435, 7749.41879359039, 7786.26030527099, 7812.92187078122, 7826.7651970440975, 3006.9849650751607, 3078.707522785332, 3088.1162490880547, 3123.048094940662, 3131.2171957010746, 806.6974884418344, 820.5733018830175, 918.9816203675889, 966.5119114846957, 1032.3599368391494, 27280.181594552196, 27393.45213095727, 27882.581761273595, 28199.295017624314, 28664.426711466072, 974.1184228273424, 1010.888802231754, 1021.4126877045728, 1062.16089289462, 1067.7170549804307, 14236.0, 14767.409303627735, 14947.912540600328, 15000.699986000438, 15111.4710985115, 407910.0, 410686.0, 411020.9448952736, 411220.0, 412088.0, 47784.0, 48393.0, 48573.5142648569, 48581.0, 48651.0, 1052.4737631184407, 1101.0, 1128.1426116151947, 1161.2742036227357, 1204.072863894796, 25633.10284140046, 28651.561812582622, 29206.41587168287, 29489.85255073711, 29791.255218619706, 37042.629573704995, 37324.0, 37341.2531749358, 37370.626293737805, 37373.0, 309729.0, 311354.0, 312211.0, 312687.0, 313429.0, 21968.231111911005, 22138.55722885501, 22561.21035763806, 22576.435589110402, 24968.625470618317, 36538.63461365352, 36799.44800827936, 40003.39943909222, 40936.38595421011, 42568.78715606402, 35050.29899401947, 35158.29683406266, 35217.0, 35323.82338088293, 35867.46198806968, 34672.82663586666, 35503.82248088743, 35730.464043039894, 35976.64023359837, 36055.81972090123, 34542.65457345395, 34622.65377346295, 35601.82199088988, 35661.821690892415, 35952.0, 29984.85007574948, 32268.83865580751, 32451.0, 32812.0, 33112.33775324432, 24194.41194550785, 24294.651406232366, 24673.50652986966, 24682.876585616956, 24910.87544562338], "value": 15933.185581033793, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.9656034396559, 345.7234212629897, 354.1306093540358, 354.7623092528005, 379.66968737198624, 13235.0, 15825.446109386174, 16029.91985040076, 17071.743923841153, 17928.37250696226, 15675.921620391911, 16059.759103613425, 16105.0, 16129.274182661778, 16218.918905405457, 4978.054169707753, 5169.948300516984, 5194.37667479901, 5402.243685883979, 5430.158325459541, 3509.263054758491, 5243.816466423676, 5370.301860758096, 5395.757190926398, 5412.810551630694, 5608.747606357723, 5621.943780562204, 5632.887342253173, 5633.943660563383, 5639.238702775114, 5596.048671725796, 5598.4961353478175, 5761.769529218826, 6175.258968923713, 6204.689765511706, 5460.6177567570285, 5499.257600223958, 5503.9174412383445, 5504.64219825714, 5507.779688812443, 13394.464221431132, 20564.38306850797, 20618.278360257318, 20766.0, 20766.792332076788, 1813.8186181381889, 1817.082373401437, 1864.2170288478735, 2235.7205349331334, 2284.7486776454575, 8544.700935467292, 8938.284937205008, 9267.907320926772, 9273.536323183882, 9388.62445502179, 1705.7697210876497, 1755.1312100510202, 1777.919993600278, 1794.9282028718967, 1825.7809062912536, 67302.32697673059, 68330.65834670844, 68776.96834547535, 69200.6539967302, 69422.3057769426, 10009.549570269355, 10200.0, 10228.07947284748, 10306.381617102848, 10363.585456581803, 13934.790978135336, 13989.440422383193, 14005.229712365917, 14033.438662453591, 14042.578722638336, 6665.800025999228, 6748.257691653914, 6863.794086177422, 6941.409980151642, 6944.062551555577, 6142.57002009855, 6160.199174107337, 6372.0, 6380.042993551005, 6385.48916086712, 3946.230485055444, 4010.498687664042, 4074.490688663917, 4280.186764514732, 4533.5013148553635, 1756.604763928106, 1789.3111152206234, 1816.9909150454164, 1839.172372432384, 1839.8344149026652, 843.3759018326517, 871.1854416120947, 895.3866601378077, 903.5617725403174, 916.093067862811, 16579.751303730452, 16751.581210469834, 17473.56316092108, 17577.824221757874, 17667.469975900745, 820.6500306995079, 861.3798065392907, 883.2360008592522, 929.4051806843626, 936.1247233836385, 9672.95163524192, 9725.4650994196, 9754.122129008423, 9798.902010979942, 9835.557399917021, 354243.0, 365227.0, 365337.0, 366806.0, 367404.0, 72964.0, 77569.22430775732, 78252.0, 78567.0, 79313.60343198247, 869.3705095504132, 879.366855863777, 896.050186801979, 897.0, 899.3434792601438, 14990.025648332823, 15146.545603631908, 15558.9222053889, 15950.760738588699, 16048.1173535452, 36616.81691591525, 36633.26733465369, 38034.23931521299, 38583.0, 38769.224615508094, 50785.492145078075, 51103.48896511136, 51268.23097653613, 51442.74278628583, 52063.97136386539, 5420.319700892735, 6467.838304042437, 7514.849703006019, 7635.3583979442465, 7674.961625191839, 9527.523623818919, 11332.433378330885, 11502.82745758831, 11543.942280288546, 11951.581694640647, 9760.951195243979, 10207.132393746615, 10303.278770486293, 10522.263441559018, 10760.89239107599, 10349.430781307101, 10394.844077338998, 10397.428141452292, 10399.740006499898, 10440.895591044296, 10319.896801031893, 10459.738506537398, 10673.199510036624, 10779.191560632828, 11060.612878549213, 6492.28584855656, 7531.171571127062, 7699.730509432367, 7732.652030658522, 7955.602219889098, 8519.95740021296, 10379.896201037893, 10466.947665261625, 10520.210984176065, 10619.469026548488], "value": 8126.107694647252, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1225.9877401225986, 1328.1632571479965, 1371.3691701817163, 1417.893657975652, 1651.0918994553, 6669.833254168642, 7303.671334789934, 7643.388528917687, 7669.923300766984, 7881.645325960331, 7690.077190737105, 7750.302472777449, 7750.341220996208, 7753.418493612988, 7756.418268629861, 2176.542925985541, 2205.0959106766227, 2211.1487077475126, 2212.048819007826, 2213.9225127120553, 2140.454184183031, 2190.561887622474, 2197.8351623628214, 2207.8454508184354, 2209.7679743626927, 2143.839212059094, 2162.4053385319007, 2175.9347219583437, 2177.314146043999, 2179.215482426333, 2096.5597224582857, 2108.441263065289, 2110.4090854560673, 2111.092230340953, 2112.2501511963337, 2067.6071546406133, 2111.9366419007456, 2114.7356580427445, 2116.947076323089, 2118.364490652798, 7561.810954726121, 7695.576318381118, 7707.075150981918, 7739.922600774033, 7785.805354866117, 4412.691111622188, 4530.569595888385, 4544.750038747868, 4554.703944243647, 4558.202314594932, 2867.971320286791, 2961.6149900512796, 2989.8505074746395, 3006.9548956765666, 3013.3370658455106, 963.1428029054148, 966.8453047512364, 967.1730670276883, 981.190517822799, 999.8000399920045, 10348.0, 10441.895581044168, 10450.268481206318, 10458.215633827493, 10565.788684226349, 4040.1111755413763, 4064.837406503707, 4068.0846809468226, 4083.0813067059676, 4163.063310755117, 8241.093479717227, 8248.13394593559, 8258.463199892109, 8259.545724985064, 8262.380321475914, 4341.544137865541, 4344.674149438804, 4347.891302717458, 4349.499807522176, 4350.434443522322, 3612.9638703612627, 3682.765304474233, 3740.831662575191, 4017.6183262590007, 4019.9397009044887, 3360.6975372216616, 3389.881354152593, 3499.2651543175707, 3500.3524347995194, 3508.2281897982402, 1048.6487026846091, 1050.24907191357, 1054.514923135351, 1056.7410984308895, 1062.0, 736.7973807202955, 743.3644234179807, 748.0649188514357, 761.6610608279374, 850.8978922529336, 4873.780679869344, 5008.824691135793, 5009.148444764399, 5015.974920125449, 5271.156614941591, 405.08652987513557, 415.3326130269711, 420.66346922461906, 423.3036654702996, 427.164892634898, 3486.633903440153, 3492.9126771830906, 3537.1510837398837, 3538.168530395355, 3634.0914771307175, 9213.63145474187, 9625.855612165824, 9632.32573719847, 9635.759106022266, 9657.22742180624, 9586.66446674363, 9610.95194524023, 9621.615135394506, 9623.470709111067, 9670.951645241728, 7115.75094871677, 7197.856042879113, 7234.385077268491, 7254.600996945113, 7264.782056538313, 5055.266986286894, 5138.486151384981, 5238.397584277857, 5267.209918512254, 5304.496072873071, 8503.362247831561, 8742.781430464289, 8758.518281494578, 8767.824643507221, 8814.2948564116, 8796.384253102477, 8805.735827925173, 8859.424137431304, 8905.688300909436, 9025.684101056431, 6384.3934826191435, 6444.291127976013, 6446.161998940295, 6457.354264573505, 6461.386168314003, 6998.860022799618, 7260.201377848327, 7394.408447324094, 7429.294217049372, 7438.702451901863, 6585.539012269095, 6629.337066293525, 6631.270560238273, 6841.965790171017, 6995.195552511526, 6298.401651843067, 6370.522210834113, 6418.743250269937, 6472.029195620695, 6547.148870646785, 6080.847978800565, 6085.269767627913, 6087.786927457518, 6098.908516372169, 6103.3591472894705, 4225.683073769418, 4290.957090429056, 4326.329418940069, 4359.149965756774, 4377.934330985101, 4639.35049093134, 4658.86023419298, 4707.4821769606, 4807.4471435785335, 4829.661923665451], "value": 3953.7521593621377, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.81907217525134, 295.5655186875294, 299.6194832562646, 304.394255431691, 305.1486353074921, 4847.975760121199, 4864.878378040551, 4869.7565121743855, 4869.951300486999, 4879.658423910323, 4804.807807687697, 4826.179549476588, 4826.613870890329, 4826.7586620669, 4830.4686484486765, 3593.5687717473875, 3694.4643026761105, 3701.463892484629, 3705.2589482103554, 3726.5528136623507, 3627.6916462100753, 3721.3301605710963, 3746.1945681678435, 3770.3213421584105, 3809.2381523695235, 3739.9065023374496, 3745.550533935918, 3749.2817707162226, 3760.2291530236234, 3762.3039737648487, 3538.221591249921, 3702.333579955607, 3744.138848064933, 3745.1573395985956, 3749.5500539935247, 3277.4100661880852, 3277.72139368154, 3280.507369147056, 3280.523764306048, 3289.687479689426, 4689.264971960397, 4694.24892017279, 4706.788194531255, 4707.929381059287, 4708.623310135181, 4253.319468884994, 4265.573442655709, 4277.182197566053, 4279.443672322609, 4286.957130428687, 4908.312836202935, 4919.975400122977, 4966.255061740768, 4982.010793523857, 5033.0, 3564.821758912044, 3564.8574057037686, 3581.1047238190454, 3594.6944509716704, 3597.9100522486888, 5215.0, 5239.790408383698, 5249.370075590953, 5263.605229607795, 5265.2628631991165, 3559.928801423957, 3642.745007849478, 3650.1969566695284, 3665.9266814663556, 3669.2661467706566, 3701.148735790783, 3706.814659267026, 3708.9985703859807, 3722.813859307024, 3726.627337266306, 4207.137536804948, 4223.260929337353, 4227.323628219531, 4229.302165142779, 4232.280512312914, 4882.877928051827, 5004.424491183488, 5009.221726287188, 5012.949870501321, 5027.245913113063, 1260.2564486952558, 1271.9809202861964, 1282.1409655530817, 1286.6397408725572, 1289.071868254855, 789.1989630525022, 813.9186081391813, 825.9215374539409, 826.6817275348914, 830.2237408023517, 4304.80628371724, 4354.216241076637, 4457.194836091323, 4459.799309031101, 4461.553844615577, 5153.613478989091, 5178.792848286102, 5206.583473322201, 5231.450697676765, 5238.895222095613, 4502.4371953505815, 4503.144402563503, 4517.661175411858, 4518.480374756945, 4532.841350552715, 2629.5924131759607, 2758.586212068206, 2762.682291536499, 2765.14280573023, 2770.5844123381653, 4928.531789479994, 4931.3589233399425, 4956.5786908112495, 4956.925646115311, 4965.4041515018425, 5071.0, 5324.547413469821, 5327.600429967768, 5331.81338653153, 5332.200169974535, 4919.508049195123, 4927.359443272423, 4943.382077240345, 4956.330895329229, 4958.652894297365, 5155.587552995827, 5156.9742151289, 5209.166533354645, 5217.8173763918085, 5235.345581802275, 4882.511748825089, 5094.847154585368, 5099.949000509948, 5117.411497677815, 5123.462036486264, 4830.927536086891, 4870.756462176948, 4882.5605695487575, 4905.754712264301, 4929.728864912321, 3632.1464455853384, 3650.762700424464, 3651.3245049664833, 3654.3787556114994, 3659.5608526976935, 4994.425641051325, 5192.870178245574, 5200.829813291979, 5225.16397376418, 5225.947740522698, 5038.84883453497, 5053.418856831511, 5060.316857224375, 5060.367454068241, 5072.873178170427, 5045.0, 5049.6465247432325, 5049.8737531562, 5059.468755780737, 5070.8225212117395, 4749.4063242094735, 4989.476105009067, 4990.476000019946, 5003.474635163256, 5014.674046186986, 4916.0, 4990.6007519397635, 5076.898462030665, 5092.2361645753435, 5101.20931255656, 4990.50094990498, 4994.925076123788, 4995.925875936691, 4997.201007637175, 5000.624953128603], "value": 3792.251777838304, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.9784407545735, 693.7017082654463, 693.8300116471469, 726.386203657909, 727.8980942668024, 12290.877091229086, 13439.798403023962, 13446.663833404169, 13465.7306853863, 13479.460821567138, 12583.622491325252, 12716.491340346374, 12718.872811271884, 12719.618411447671, 12720.93639531801, 615.6860001399297, 727.5198369076411, 742.6101296819172, 753.1226121568367, 761.261576271019, 762.5996351915234, 772.9265719756614, 773.0259872560558, 774.0324594257179, 774.1059076766344, 811.6753298680516, 812.8536863364592, 813.1380736419385, 813.2883726739103, 813.5281536708725, 645.5481163185742, 776.4021703288493, 797.4656979823532, 806.395203597302, 806.4314658165979, 596.6777939912442, 598.7156100852104, 598.7305712429425, 599.307799491588, 599.9790007349766, 12747.04397170216, 12750.489980400773, 12778.0, 12843.87156128436, 12845.67885802853, 12278.324692141929, 12615.621531354074, 12938.935305323508, 13117.621775072175, 13456.461741530327, 11349.943250283779, 11703.18077734559, 11844.40777961107, 12192.695182620417, 12477.438515266835, 4102.835886564564, 4119.361498967635, 4137.689673274486, 4302.118065796504, 4312.482502099737, 65258.0, 65481.345186548475, 65568.01647975332, 65619.34380656228, 66265.3373466264, 10152.137068349273, 10314.48427578618, 10471.267011309288, 10660.09389201911, 11112.722181945515, 19853.0, 19880.50298742543, 19889.204431822563, 19896.204151833765, 20010.399688009384, 6658.641819361644, 6750.527463077636, 6757.966210169016, 6769.898451523231, 6950.652467376611, 3710.703143748494, 3730.4590834329415, 3759.398496240643, 3791.7156213284115, 3864.091938394475, 2782.373965857666, 2893.8119022263486, 2898.4927637663322, 2902.216401571606, 2904.361040571071, 508.7430847422028, 509.95665368443355, 519.1952473665802, 519.9584033277329, 524.0776233828414, 468.32093464476645, 540.2787278982523, 576.705880001194, 590.893639144958, 594.1118028547263, 7352.852942941218, 7500.174980752113, 7818.804529886798, 7923.6830526778285, 7965.65350447153, 488.27003629574017, 543.4891202269854, 555.0037682360173, 571.3401021819805, 582.286698793974, 3730.347189241872, 3925.1953349563273, 4109.075458021921, 4218.978905105516, 4348.7390756554705, 101652.49173754084, 104125.0, 105425.0, 105575.4721226389, 108133.0, 85228.57385713032, 86240.56879715562, 89228.0, 89886.0, 90409.0, 56282.718586407624, 69379.30620693728, 77524.22475775283, 78668.60665696635, 80910.19089809144, 8330.916690833013, 8410.369222308474, 8534.487930724177, 8636.136386361564, 8649.221570058726, 42620.78689606532, 43864.561354386045, 44677.55322446864, 45039.324410134526, 45318.18727250873, 60474.69762651159, 61555.15226053518, 62829.37170628418, 63013.0, 65714.67142664256, 10950.178736594627, 11096.88903110991, 11250.156238282325, 11488.253263537843, 11973.940130299292, 12897.871021289668, 13072.281024543741, 13506.122102063335, 14049.623857738861, 14191.574252772434, 11378.21233797725, 11519.596814111466, 11707.063434925356, 11721.531138754695, 12059.336736479227, 11579.247348922294, 11829.881701183222, 12054.337011464102, 12674.239545627292, 12689.175203611736, 11133.665990020312, 11459.255148415326, 11935.164538482222, 11937.28376297425, 11941.16411851162, 9592.472414017297, 10333.121684656888, 10498.160147188359, 10750.784984300426, 11381.317120972768, 9190.310726695658, 10169.288149829441, 10327.741806454898, 10443.164546836082, 10468.110210632181], "value": 6655.082824876296, "unit": "score"}], "name": "dromaeo_css", "value": 6274.443735668253, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 114.0, 113.0, 109.0, 113.0, 114.0, 112.0, 113.0, 114.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 123.0, 177.0, 129.0, 150.0, 147.0, 127.0, 177.0, 128.0], "value": 142.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 162.0, 160.0, 161.0, 162.0, 161.0, 161.0, 163.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 107.0, 76.0, 76.0, 75.0, 77.0, 104.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 129.0, 85.0, 85.0, 85.0, 124.0, 84.0, 86.0, 136.0], "value": 98.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 69.0, 67.0, 66.0, 68.0, 66.0, 67.0, 67.0, 66.0], "value": 67.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 67.0, 65.0, 67.0, 66.0, 65.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 91.0, 83.0, 84.0, 83.0, 92.0, 86.0, 83.0, 92.0, 86.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 133.0, 129.0, 139.0, 131.0, 128.0, 144.0, 155.0, 143.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 169.0, 171.0, 174.0, 172.0, 170.0, 173.0, 171.0, 169.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 71.0, 69.0, 70.0, 71.0, 70.0, 66.0, 69.0, 67.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1551.3000000000002, "alertThreshold": 2.0}]} 17:42:21 INFO - Return code: 0 17:42:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:42:21 INFO - # TBPL SUCCESS # 17:42:21 INFO - Running post-action listener: _resource_record_post_action 17:42:21 INFO - [mozharness: 2016-08-17 00:42:21.115575Z] Finished run-tests step (success) 17:42:21 INFO - Running post-run listener: _resource_record_post_run 17:42:21 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407154688; Read time: 16; Write time: 346640 17:42:21 INFO - TinderboxPrint: CPU usage
13.0% 17:42:21 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 17:42:21 INFO - TinderboxPrint: I/O write bytes / time
407,154,688 / 346,640 17:42:21 INFO - TinderboxPrint: CPU idle
8,334.7 (87.0%) 17:42:21 INFO - TinderboxPrint: CPU user
1,199.5 (12.5%) 17:42:21 INFO - TinderboxPrint: Swap in / out
0 / 0 17:42:21 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124751872; Read time: 0; Write time: 101652 17:42:21 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 282402816; Read time: 0; Write time: 244988 17:42:21 INFO - Running post-run listener: _upload_blobber_files 17:42:21 INFO - Blob upload gear active. 17:42:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:42:21 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 17:42:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:42:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:42:22 INFO - (blobuploader) - INFO - Open directory for files ... 17:42:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:42:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:42:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:42:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:42:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:42:23 INFO - (blobuploader) - INFO - Done attempting. 17:42:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:42:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:42:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:42:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:42:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:42:23 INFO - (blobuploader) - INFO - Done attempting. 17:42:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:42:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:42:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:42:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:42:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:42:28 INFO - (blobuploader) - INFO - Done attempting. 17:42:28 INFO - (blobuploader) - INFO - Iteration through files over. 17:42:28 INFO - Return code: 0 17:42:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:42:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:42:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5dc1322760949cc1c9dbfa8441a0244b5c82a9f9fac12131e88f207a36e90993c7207129b2e17fae1ae470768b80f67de8128ac58f476d0b3475466647ca475", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d89ca8f3a1db86ae125c7728e8edabfcde5bf04d3a705dde4d67d64135484caf7902ea0544f8491bb3d2fada9a3c8ee392fc29250d516b7f8ec324d227be5b39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d7a192c5ca4020523684f24bb954d9b59e744fad4e00a4a2312337a163471051a445200743a9a433fd987787e6a37a95acfe1c30f3a0a156e75e703ee1d2c18"} 17:42:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:42:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:42:28 INFO - Contents: 17:42:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5dc1322760949cc1c9dbfa8441a0244b5c82a9f9fac12131e88f207a36e90993c7207129b2e17fae1ae470768b80f67de8128ac58f476d0b3475466647ca475", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d89ca8f3a1db86ae125c7728e8edabfcde5bf04d3a705dde4d67d64135484caf7902ea0544f8491bb3d2fada9a3c8ee392fc29250d516b7f8ec324d227be5b39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d7a192c5ca4020523684f24bb954d9b59e744fad4e00a4a2312337a163471051a445200743a9a433fd987787e6a37a95acfe1c30f3a0a156e75e703ee1d2c18"} 17:42:28 INFO - Running post-run listener: copy_logs_to_upload_dir 17:42:28 INFO - Copying logs to upload dir... 17:42:28 INFO - mkdir: /builds/slave/test/build/upload/logs 17:42:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.062080 ========= master_lag: 1.28 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-16 17:42:29.493702) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 17:42:29.501552) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5dc1322760949cc1c9dbfa8441a0244b5c82a9f9fac12131e88f207a36e90993c7207129b2e17fae1ae470768b80f67de8128ac58f476d0b3475466647ca475", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d89ca8f3a1db86ae125c7728e8edabfcde5bf04d3a705dde4d67d64135484caf7902ea0544f8491bb3d2fada9a3c8ee392fc29250d516b7f8ec324d227be5b39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d7a192c5ca4020523684f24bb954d9b59e744fad4e00a4a2312337a163471051a445200743a9a433fd987787e6a37a95acfe1c30f3a0a156e75e703ee1d2c18"} build_url:https://queue.taskcluster.net/v1/task/HCS9INJYQle-v-y70ha5ug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011258 build_url: 'https://queue.taskcluster.net/v1/task/HCS9INJYQle-v-y70ha5ug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5dc1322760949cc1c9dbfa8441a0244b5c82a9f9fac12131e88f207a36e90993c7207129b2e17fae1ae470768b80f67de8128ac58f476d0b3475466647ca475", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d89ca8f3a1db86ae125c7728e8edabfcde5bf04d3a705dde4d67d64135484caf7902ea0544f8491bb3d2fada9a3c8ee392fc29250d516b7f8ec324d227be5b39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d7a192c5ca4020523684f24bb954d9b59e744fad4e00a4a2312337a163471051a445200743a9a433fd987787e6a37a95acfe1c30f3a0a156e75e703ee1d2c18"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 17:42:29.526111) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:42:29.529442) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471392389.353557-842113697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:42:29.578838) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 17:42:29.579163) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 17:42:29.579449) ========= ========= Total master_lag: 1.53 =========