builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1468662597.08 results: success (0) buildid: 20160716011552 builduid: 23ee219f9775454aafcbb9d7d882df3c revision: de45aca6e7cfd90777cfcb1524443039e1d22374 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 02:49:57.078730) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 02:49:57.079166) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 02:49:57.079446) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 02:49:57.118109) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 02:49:57.118380) ========= 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-1468662424.245175-416113174 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-16 02:49:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 44.1M=0s 2016-07-16 02:49:57 (44.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158850 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 02:49:57.298884) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 02:49:57.299185) ========= 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-1468662424.245175-416113174 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.147251 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 02:49:57.458563) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 02:49:57.458881) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev de45aca6e7cfd90777cfcb1524443039e1d22374 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev de45aca6e7cfd90777cfcb1524443039e1d22374 --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-1468662424.245175-416113174 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-16 02:49:57,571 truncating revision to first 12 chars 2016-07-16 02:49:57,571 Setting DEBUG logging. 2016-07-16 02:49:57,571 attempt 1/10 2016-07-16 02:49:57,571 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/de45aca6e7cf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-16 02:49:57,875 unpacking tar archive at: autoland-de45aca6e7cf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656550 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 02:49:58.128928) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 02:49:58.129225) ========= script_repo_revision: de45aca6e7cfd90777cfcb1524443039e1d22374 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 02:49:58.129657) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 02:49:58.129930) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 02:49:58.139813) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-16 02:49:58.140109) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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-1468662424.245175-416113174 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:49:58 INFO - MultiFileLogger online at 20160716 02:49:58 in /builds/slave/test 02:49:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 02:49:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:49:58 INFO - {'append_to_log': False, 02:49:58 INFO - 'base_work_dir': '/builds/slave/test', 02:49:58 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 02:49:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:49:58 INFO - 'branch': 'Autoland-Non-PGO', 02:49:58 INFO - 'buildbot_json_path': 'buildprops.json', 02:49:58 INFO - 'config_files': ('talos/linux_config.py',), 02:49:58 INFO - 'default_actions': ('clobber', 02:49:58 INFO - 'read-buildbot-config', 02:49:58 INFO - 'download-and-extract', 02:49:58 INFO - 'populate-webroot', 02:49:58 INFO - 'create-virtualenv', 02:49:58 INFO - 'install', 02:49:58 INFO - 'run-tests'), 02:49:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:49:58 INFO - 'download_minidump_stackwalk': True, 02:49:58 INFO - 'download_symbols': 'ondemand', 02:49:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:49:58 INFO - 'tooltool.py': '/tools/tooltool.py', 02:49:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:49:58 INFO - '/tools/misc-python/virtualenv.py')}, 02:49:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:49:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:49:58 INFO - 'installer_path': 'installer.exe', 02:49:58 INFO - 'log_level': 'info', 02:49:58 INFO - 'log_name': 'talos', 02:49:58 INFO - 'log_to_console': True, 02:49:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:49:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:49:58 INFO - 'opt_config_files': (), 02:49:58 INFO - 'pip_index': False, 02:49:58 INFO - 'sps_profile': False, 02:49:58 INFO - 'sps_profile_interval': 0, 02:49:58 INFO - 'suite': 'dromaeojs', 02:49:58 INFO - 'system_bits': '32', 02:49:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:49:58 INFO - 'title': 'talos-linux64-ix-023', 02:49:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:49:58 INFO - 'use_talos_json': True, 02:49:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:49:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:49:58 INFO - 'work_dir': 'build'} 02:49:58 INFO - ##### 02:49:58 INFO - ##### Running clobber step. 02:49:58 INFO - ##### 02:49:58 INFO - Running pre-action listener: _resource_record_pre_action 02:49:58 INFO - Running main action method: clobber 02:49:58 INFO - rmtree: /builds/slave/test/build 02:49:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:50:00 INFO - Running post-action listener: _resource_record_post_action 02:50:00 INFO - ##### 02:50:00 INFO - ##### Finished clobber step (success) 02:50:00 INFO - ##### 02:50:00 INFO - ##### 02:50:00 INFO - ##### Running read-buildbot-config step. 02:50:00 INFO - ##### 02:50:00 INFO - Running pre-action listener: _resource_record_pre_action 02:50:00 INFO - Running main action method: read_buildbot_config 02:50:00 INFO - Using buildbot properties: 02:50:00 INFO - { 02:50:00 INFO - "project": "", 02:50:00 INFO - "product": "firefox", 02:50:00 INFO - "script_repo_revision": "production", 02:50:00 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 02:50:00 INFO - "repository": "", 02:50:00 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 02:50:00 INFO - "buildid": "20160716011552", 02:50:00 INFO - "pgo_build": "False", 02:50:00 INFO - "basedir": "/builds/slave/test", 02:50:00 INFO - "buildnumber": 63, 02:50:00 INFO - "slavename": "talos-linux64-ix-023", 02:50:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:50:00 INFO - "platform": "ubuntu64_hw", 02:50:00 INFO - "scheduler": "tests-autoland-linux64-talos", 02:50:00 INFO - "branch": "autoland", 02:50:00 INFO - "repo_path": "integration/autoland", 02:50:00 INFO - "revision": "de45aca6e7cfd90777cfcb1524443039e1d22374", 02:50:00 INFO - "stage_platform": "linux64", 02:50:00 INFO - "builduid": "23ee219f9775454aafcbb9d7d882df3c", 02:50:00 INFO - "slavebuilddir": "test" 02:50:00 INFO - } 02:50:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:50:00 INFO - Running post-action listener: _resource_record_post_action 02:50:00 INFO - ##### 02:50:00 INFO - ##### Finished read-buildbot-config step (success) 02:50:00 INFO - ##### 02:50:00 INFO - ##### 02:50:00 INFO - ##### Running download-and-extract step. 02:50:00 INFO - ##### 02:50:00 INFO - Running pre-action listener: _resource_record_pre_action 02:50:00 INFO - Running main action method: download_and_extract 02:50:00 INFO - mkdir: /builds/slave/test/build/tests 02:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:00 INFO - https://queue.taskcluster.net/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:50:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:50:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:50:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:50:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:50:05 INFO - Downloaded 1361 bytes. 02:50:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:50:05 INFO - Using the following test package requirements: 02:50:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:50:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:50:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:50:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:50:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:50:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:50:05 INFO - u'jsshell-linux-x86_64.zip'], 02:50:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:50:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:50:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:50:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:50:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:50:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:50:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:50:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:50:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:50:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:50:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:50:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:05 INFO - https://queue.taskcluster.net/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:50:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:50:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:50:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:50:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:50:07 INFO - Downloaded 22757712 bytes. 02:50:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:50:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:50:08 INFO - Return code: 0 02:50:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:08 INFO - https://queue.taskcluster.net/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:50:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:50:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:50:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:50:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:50:10 INFO - Downloaded 22757712 bytes. 02:50:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:50:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:50:11 INFO - Return code: 0 02:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:11 INFO - https://queue.taskcluster.net/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:50:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:50:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:50:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:50:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:50:13 INFO - Downloaded 14403317 bytes. 02:50:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:50:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:50:13 INFO - Return code: 0 02:50:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:13 INFO - https://queue.taskcluster.net/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:50:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:50:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:50:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:50:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:50:15 INFO - Downloaded 57058792 bytes. 02:50:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:50:15 INFO - mkdir: /builds/slave/test/properties 02:50:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:50:15 INFO - Writing to file /builds/slave/test/properties/build_url 02:50:15 INFO - Contents: 02:50:15 INFO - build_url:https://queue.taskcluster.net/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:50:15 INFO - Running post-action listener: _resource_record_post_action 02:50:15 INFO - Running post-action listener: set_extra_try_arguments 02:50:15 INFO - ##### 02:50:15 INFO - ##### Finished download-and-extract step (success) 02:50:15 INFO - ##### 02:50:15 INFO - ##### 02:50:15 INFO - ##### Running populate-webroot step. 02:50:15 INFO - ##### 02:50:15 INFO - Running pre-action listener: _resource_record_pre_action 02:50:15 INFO - Running main action method: populate_webroot 02:50:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:50:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:50:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:50:15 INFO - '--tppagecycles', 02:50:15 INFO - '7'], 02:50:15 INFO - 'tests': ['tsvgm']}}, 02:50:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:50:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:50:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:50:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:50:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:50:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:50:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:15 INFO - 'talos_options': ['--disable-e10s'], 02:50:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:50:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:50:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:15 INFO - 'talos_options': ['--disable-e10s'], 02:50:15 INFO - 'tests': ['damp', 'tps']}, 02:50:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:15 INFO - 'tests': ['damp', 'tps']}, 02:50:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:50:15 INFO - 'tests': ['dromaeo_dom']}, 02:50:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:50:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:50:15 INFO - 'tests': ['basic_compositor_video']}, 02:50:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:50:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:50:15 INFO - 'tests': ['a11yr', 02:50:15 INFO - 'ts_paint', 02:50:15 INFO - 'tpaint', 02:50:15 INFO - 'sessionrestore', 02:50:15 INFO - 'sessionrestore_no_auto_restore', 02:50:15 INFO - 'tabpaint']}, 02:50:15 INFO - 'other-e10s': {'tests': ['a11yr', 02:50:15 INFO - 'ts_paint', 02:50:15 INFO - 'tpaint', 02:50:15 INFO - 'sessionrestore', 02:50:15 INFO - 'sessionrestore_no_auto_restore', 02:50:15 INFO - 'tabpaint']}, 02:50:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:50:15 INFO - 'ts_paint', 02:50:15 INFO - 'tpaint', 02:50:15 INFO - 'sessionrestore', 02:50:15 INFO - 'sessionrestore_no_auto_restore', 02:50:15 INFO - 'tabpaint']}, 02:50:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:50:15 INFO - 'ts_paint', 02:50:15 INFO - 'tpaint', 02:50:15 INFO - 'sessionrestore', 02:50:15 INFO - 'sessionrestore_no_auto_restore', 02:50:15 INFO - 'tabpaint']}, 02:50:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:50:15 INFO - 'tests': ['a11yr', 02:50:15 INFO - 'ts_paint', 02:50:15 INFO - 'tpaint', 02:50:15 INFO - 'sessionrestore', 02:50:15 INFO - 'sessionrestore_no_auto_restore', 02:50:15 INFO - 'tabpaint']}, 02:50:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:50:15 INFO - 'tests': ['a11yr', 02:50:15 INFO - 'ts_paint', 02:50:15 INFO - 'tpaint', 02:50:15 INFO - 'sessionrestore', 02:50:15 INFO - 'sessionrestore_no_auto_restore', 02:50:15 INFO - 'tabpaint']}, 02:50:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:50:15 INFO - 'tests': ['tsvgx', 02:50:15 INFO - 'tsvgr_opacity', 02:50:15 INFO - 'tart', 02:50:15 INFO - 'tscrollx', 02:50:15 INFO - 'cart']}, 02:50:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:50:15 INFO - 'tsvgr_opacity', 02:50:15 INFO - 'tart', 02:50:15 INFO - 'tscrollx', 02:50:15 INFO - 'cart']}, 02:50:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:15 INFO - 'talos_options': ['--disable-e10s'], 02:50:15 INFO - 'tests': ['tp5o']}, 02:50:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:15 INFO - 'tests': ['tp5o']}, 02:50:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:15 INFO - 'talos_options': ['--disable-e10s', 02:50:15 INFO - '--xperf_path', 02:50:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:50:15 INFO - 'tests': ['tp5n']}, 02:50:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:15 INFO - 'talos_options': ['--xperf_path', 02:50:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:50:15 INFO - 'tests': ['tp5n']}}, 02:50:15 INFO - 'talos.zip': {'path': '', 02:50:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:50:15 INFO - Running post-action listener: _resource_record_post_action 02:50:15 INFO - ##### 02:50:15 INFO - ##### Finished populate-webroot step (success) 02:50:15 INFO - ##### 02:50:15 INFO - ##### 02:50:15 INFO - ##### Running create-virtualenv step. 02:50:15 INFO - ##### 02:50:15 INFO - Running pre-action listener: _resource_record_pre_action 02:50:15 INFO - Running main action method: create_virtualenv 02:50:15 INFO - Creating virtualenv /builds/slave/test/build/venv 02:50:15 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 02:50:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:50:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:50:15 INFO - Using real prefix '/usr' 02:50:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:50:16 INFO - Installing distribute.............................................................................................................................................................................................done. 02:50:19 INFO - Installing pip.................done. 02:50:19 INFO - Return code: 0 02:50:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:50:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e3b0>, '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 0x2d2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2f740>, '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-1468662424.245175-416113174', '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 02:50:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:50:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:50:19 INFO - Using env: {'DISPLAY': ':0', 02:50:19 INFO - 'HOME': '/home/cltbld', 02:50:19 INFO - 'LANG': 'en_US.UTF-8', 02:50:19 INFO - 'LANGUAGE': 'en_US:en', 02:50:19 INFO - 'LOGNAME': 'cltbld', 02:50:19 INFO - 'MAIL': '/var/mail/cltbld', 02:50:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:19 INFO - 'MOZ_NO_REMOTE': '1', 02:50:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:19 INFO - 'NO_EM_RESTART': '1', 02:50:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:19 INFO - 'PWD': '/builds/slave/test', 02:50:19 INFO - 'SHELL': '/bin/bash', 02:50:19 INFO - 'SHLVL': '1', 02:50:19 INFO - 'TERM': 'linux', 02:50:19 INFO - 'TMOUT': '86400', 02:50:19 INFO - 'USER': 'cltbld', 02:50:19 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1468662424.245175-416113174', 02:50:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:19 INFO - '_': '/tools/buildbot/bin/python'} 02:50:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:50:19 INFO - Cleaning up... 02:50:19 INFO - Return code: 0 02:50:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:50:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e3b0>, '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 0x2d2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2f740>, '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-1468662424.245175-416113174', '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 02:50:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:50:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:50:19 INFO - Using env: {'DISPLAY': ':0', 02:50:19 INFO - 'HOME': '/home/cltbld', 02:50:19 INFO - 'LANG': 'en_US.UTF-8', 02:50:19 INFO - 'LANGUAGE': 'en_US:en', 02:50:19 INFO - 'LOGNAME': 'cltbld', 02:50:19 INFO - 'MAIL': '/var/mail/cltbld', 02:50:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:19 INFO - 'MOZ_NO_REMOTE': '1', 02:50:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:19 INFO - 'NO_EM_RESTART': '1', 02:50:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:19 INFO - 'PWD': '/builds/slave/test', 02:50:19 INFO - 'SHELL': '/bin/bash', 02:50:19 INFO - 'SHLVL': '1', 02:50:19 INFO - 'TERM': 'linux', 02:50:19 INFO - 'TMOUT': '86400', 02:50:19 INFO - 'USER': 'cltbld', 02:50:19 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1468662424.245175-416113174', 02:50:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:19 INFO - '_': '/tools/buildbot/bin/python'} 02:50:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:19 INFO - Downloading/unpacking psutil>=3.1.1 02:50:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:50:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:50:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:50:21 INFO - Installing collected packages: psutil 02:50:21 INFO - Running setup.py install for psutil 02:50:22 INFO - building 'psutil._psutil_linux' extension 02:50:22 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 02:50:23 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 02:50:23 INFO - building 'psutil._psutil_posix' extension 02:50:23 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 02:50:23 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 02:50:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:50:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:50:23 INFO - Successfully installed psutil 02:50:23 INFO - Cleaning up... 02:50:23 INFO - Return code: 0 02:50:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:23 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 0x2a6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e3b0>, '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 0x2d2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2f740>, '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-1468662424.245175-416113174', '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 02:50:23 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 02:50:23 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 02:50:23 INFO - Using env: {'DISPLAY': ':0', 02:50:23 INFO - 'HOME': '/home/cltbld', 02:50:23 INFO - 'LANG': 'en_US.UTF-8', 02:50:23 INFO - 'LANGUAGE': 'en_US:en', 02:50:23 INFO - 'LOGNAME': 'cltbld', 02:50:23 INFO - 'MAIL': '/var/mail/cltbld', 02:50:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:23 INFO - 'MOZ_NO_REMOTE': '1', 02:50:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:23 INFO - 'NO_EM_RESTART': '1', 02:50:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:23 INFO - 'PWD': '/builds/slave/test', 02:50:23 INFO - 'SHELL': '/bin/bash', 02:50:23 INFO - 'SHLVL': '1', 02:50:23 INFO - 'TERM': 'linux', 02:50:23 INFO - 'TMOUT': '86400', 02:50:23 INFO - 'USER': 'cltbld', 02:50:23 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1468662424.245175-416113174', 02:50:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:23 INFO - '_': '/tools/buildbot/bin/python'} 02:50:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:50:23 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 02:50:23 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 02:50:23 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 02:50:23 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 02:50:23 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 02:50:23 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 02:50:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:50:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:50:25 INFO - Installing collected packages: mozsystemmonitor 02:50:25 INFO - Running setup.py install for mozsystemmonitor 02:50:25 INFO - Successfully installed mozsystemmonitor 02:50:25 INFO - Cleaning up... 02:50:25 INFO - Return code: 0 02:50:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:50:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2a6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e3b0>, '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 0x2d2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2f740>, '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-1468662424.245175-416113174', '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 02:50:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:50:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:50:25 INFO - Using env: {'DISPLAY': ':0', 02:50:25 INFO - 'HOME': '/home/cltbld', 02:50:25 INFO - 'LANG': 'en_US.UTF-8', 02:50:25 INFO - 'LANGUAGE': 'en_US:en', 02:50:25 INFO - 'LOGNAME': 'cltbld', 02:50:25 INFO - 'MAIL': '/var/mail/cltbld', 02:50:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:25 INFO - 'MOZ_NO_REMOTE': '1', 02:50:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:25 INFO - 'NO_EM_RESTART': '1', 02:50:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:25 INFO - 'PWD': '/builds/slave/test', 02:50:25 INFO - 'SHELL': '/bin/bash', 02:50:25 INFO - 'SHLVL': '1', 02:50:25 INFO - 'TERM': 'linux', 02:50:25 INFO - 'TMOUT': '86400', 02:50:25 INFO - 'USER': 'cltbld', 02:50:25 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1468662424.245175-416113174', 02:50:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:25 INFO - '_': '/tools/buildbot/bin/python'} 02:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:25 INFO - Downloading/unpacking jsonschema==2.5.1 02:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:50:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:28 INFO - Downloading functools32-3.2.3-2.tar.gz 02:50:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:50:28 INFO - warning: no files found matching '*.txt' 02:50:28 INFO - no previously-included directories found matching 'build' 02:50:28 INFO - no previously-included directories found matching 'dist' 02:50:28 INFO - no previously-included directories found matching '.git*' 02:50:28 INFO - Installing collected packages: jsonschema, functools32 02:50:28 INFO - Running setup.py install for functools32 02:50:28 INFO - warning: no files found matching '*.txt' 02:50:28 INFO - no previously-included directories found matching 'build' 02:50:28 INFO - no previously-included directories found matching 'dist' 02:50:28 INFO - no previously-included directories found matching '.git*' 02:50:28 INFO - Successfully installed jsonschema functools32 02:50:28 INFO - Cleaning up... 02:50:28 INFO - Return code: 0 02:50:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2a6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e3b0>, '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 0x2d2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2f740>, '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-1468662424.245175-416113174', '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 02:50:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:50:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:50:28 INFO - Using env: {'DISPLAY': ':0', 02:50:28 INFO - 'HOME': '/home/cltbld', 02:50:28 INFO - 'LANG': 'en_US.UTF-8', 02:50:28 INFO - 'LANGUAGE': 'en_US:en', 02:50:28 INFO - 'LOGNAME': 'cltbld', 02:50:28 INFO - 'MAIL': '/var/mail/cltbld', 02:50:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:28 INFO - 'MOZ_NO_REMOTE': '1', 02:50:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:28 INFO - 'NO_EM_RESTART': '1', 02:50:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:28 INFO - 'PWD': '/builds/slave/test', 02:50:28 INFO - 'SHELL': '/bin/bash', 02:50:28 INFO - 'SHLVL': '1', 02:50:28 INFO - 'TERM': 'linux', 02:50:28 INFO - 'TMOUT': '86400', 02:50:28 INFO - 'USER': 'cltbld', 02:50:28 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1468662424.245175-416113174', 02:50:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:28 INFO - '_': '/tools/buildbot/bin/python'} 02:50:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:28 INFO - Downloading/unpacking blobuploader==1.2.4 02:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:30 INFO - Downloading blobuploader-1.2.4.tar.gz 02:50:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:50:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:50:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:50:31 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 02:50:31 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 02:50:31 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 02:50:31 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 02:50:31 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 02:50:31 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 02:50:31 INFO - Downloading docopt-0.6.1.tar.gz 02:50:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:50:31 INFO - Installing collected packages: blobuploader, requests, docopt 02:50:31 INFO - Running setup.py install for blobuploader 02:50:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:50:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:50:31 INFO - Running setup.py install for requests 02:50:31 INFO - Running setup.py install for docopt 02:50:32 INFO - Successfully installed blobuploader requests docopt 02:50:32 INFO - Cleaning up... 02:50:32 INFO - Return code: 0 02:50:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:50:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:32 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 0x2a6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e3b0>, '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 0x2d2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2f740>, '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-1468662424.245175-416113174', '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 02:50:32 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 02:50:32 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 02:50:32 INFO - Using env: {'DISPLAY': ':0', 02:50:32 INFO - 'HOME': '/home/cltbld', 02:50:32 INFO - 'LANG': 'en_US.UTF-8', 02:50:32 INFO - 'LANGUAGE': 'en_US:en', 02:50:32 INFO - 'LOGNAME': 'cltbld', 02:50:32 INFO - 'MAIL': '/var/mail/cltbld', 02:50:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:32 INFO - 'MOZ_NO_REMOTE': '1', 02:50:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:32 INFO - 'NO_EM_RESTART': '1', 02:50:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:32 INFO - 'PWD': '/builds/slave/test', 02:50:32 INFO - 'SHELL': '/bin/bash', 02:50:32 INFO - 'SHLVL': '1', 02:50:32 INFO - 'TERM': 'linux', 02:50:32 INFO - 'TMOUT': '86400', 02:50:32 INFO - 'USER': 'cltbld', 02:50:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1468662424.245175-416113174', 02:50:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:32 INFO - '_': '/tools/buildbot/bin/python'} 02:50:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:50:32 INFO - Running setup.py (path:/tmp/pip-G4yPmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:50:32 INFO - Running setup.py (path:/tmp/pip-HAvjUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:50:32 INFO - Running setup.py (path:/tmp/pip-bM8rkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:50:32 INFO - Running setup.py (path:/tmp/pip-abU2xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:50:32 INFO - Running setup.py (path:/tmp/pip-pAdeSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:50:32 INFO - Running setup.py (path:/tmp/pip-V5Oa5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:50:32 INFO - Running setup.py (path:/tmp/pip-f5kH6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:50:32 INFO - Running setup.py (path:/tmp/pip-DUohgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:50:32 INFO - Running setup.py (path:/tmp/pip-wHWqDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:50:32 INFO - Running setup.py (path:/tmp/pip-crUtDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:50:33 INFO - Running setup.py (path:/tmp/pip-bKV8sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:50:33 INFO - Running setup.py (path:/tmp/pip-b_thYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:50:33 INFO - Running setup.py (path:/tmp/pip-MTcjs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:50:33 INFO - Running setup.py (path:/tmp/pip-LcS235-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:50:33 INFO - Running setup.py (path:/tmp/pip-WKkl98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:50:33 INFO - Running setup.py (path:/tmp/pip-8GEHRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:50:33 INFO - Running setup.py (path:/tmp/pip-TOTyrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:50:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:50:33 INFO - Running setup.py install for manifestparser 02:50:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:50:33 INFO - Running setup.py install for mozcrash 02:50:33 INFO - Running setup.py install for mozdebug 02:50:33 INFO - Running setup.py install for mozdevice 02:50:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:50:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:50:33 INFO - Running setup.py install for mozfile 02:50:34 INFO - Running setup.py install for mozhttpd 02:50:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:50:34 INFO - Running setup.py install for mozinfo 02:50:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:50:34 INFO - Running setup.py install for mozInstall 02:50:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:50:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:50:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:50:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:50:34 INFO - Running setup.py install for mozleak 02:50:34 INFO - Running setup.py install for mozlog 02:50:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:50:34 INFO - Running setup.py install for moznetwork 02:50:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:50:34 INFO - Running setup.py install for mozprocess 02:50:34 INFO - Running setup.py install for mozprofile 02:50:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:50:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:50:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:50:34 INFO - Running setup.py install for mozrunner 02:50:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:50:34 INFO - Running setup.py install for mozscreenshot 02:50:35 INFO - Running setup.py install for moztest 02:50:35 INFO - Running setup.py install for mozversion 02:50:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:50:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:50:35 INFO - Cleaning up... 02:50:35 INFO - Return code: 0 02:50:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:35 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 0x2a6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e3b0>, '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 0x2d2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2f740>, '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-1468662424.245175-416113174', '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 02:50:35 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 02:50:35 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 02:50:35 INFO - Using env: {'DISPLAY': ':0', 02:50:35 INFO - 'HOME': '/home/cltbld', 02:50:35 INFO - 'LANG': 'en_US.UTF-8', 02:50:35 INFO - 'LANGUAGE': 'en_US:en', 02:50:35 INFO - 'LOGNAME': 'cltbld', 02:50:35 INFO - 'MAIL': '/var/mail/cltbld', 02:50:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:35 INFO - 'MOZ_NO_REMOTE': '1', 02:50:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:35 INFO - 'NO_EM_RESTART': '1', 02:50:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:35 INFO - 'PWD': '/builds/slave/test', 02:50:35 INFO - 'SHELL': '/bin/bash', 02:50:35 INFO - 'SHLVL': '1', 02:50:35 INFO - 'TERM': 'linux', 02:50:35 INFO - 'TMOUT': '86400', 02:50:35 INFO - 'USER': 'cltbld', 02:50:35 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1468662424.245175-416113174', 02:50:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:35 INFO - '_': '/tools/buildbot/bin/python'} 02:50:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:50:35 INFO - Running setup.py (path:/tmp/pip-GeYMaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:50:35 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)) 02:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:50:35 INFO - Running setup.py (path:/tmp/pip-MqNMIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:50:35 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)) 02:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:50:35 INFO - Running setup.py (path:/tmp/pip-lpmS_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:50:35 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)) 02:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:50:35 INFO - Running setup.py (path:/tmp/pip-62keRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:50:35 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)) 02:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:50:35 INFO - Running setup.py (path:/tmp/pip-ohvZQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:50:35 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)) 02:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:50:35 INFO - Running setup.py (path:/tmp/pip-VRSjJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:50:35 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)) 02:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:50:35 INFO - Running setup.py (path:/tmp/pip-nPmEaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:50:36 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)) 02:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:50:36 INFO - Running setup.py (path:/tmp/pip-cuIgRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:50:36 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)) 02:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:50:36 INFO - Running setup.py (path:/tmp/pip-uKgFen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:50:36 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)) 02:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:50:36 INFO - Running setup.py (path:/tmp/pip-pOVLXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:50:36 INFO - Running setup.py (path:/tmp/pip-dxGHWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:50:36 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)) 02:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:50:36 INFO - Running setup.py (path:/tmp/pip-t8FULE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:50:36 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)) 02:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:50:36 INFO - Running setup.py (path:/tmp/pip-kXf_v0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:50:36 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)) 02:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:50:36 INFO - Running setup.py (path:/tmp/pip-xzMZ7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:50:36 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)) 02:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:50:36 INFO - Running setup.py (path:/tmp/pip-BAg8nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:50:36 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)) 02:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:50:36 INFO - Running setup.py (path:/tmp/pip-1rikaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:50:36 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)) 02:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:50:36 INFO - Running setup.py (path:/tmp/pip-jpuDeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:50:36 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)) 02:50:36 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)) 02:50:36 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)) 02:50:36 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)) 02:50:36 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)) 02:50:36 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)) 02:50:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:38 INFO - Downloading blessings-1.6.tar.gz 02:50:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:50:38 INFO - Installing collected packages: blessings 02:50:38 INFO - Running setup.py install for blessings 02:50:38 INFO - Successfully installed blessings 02:50:38 INFO - Cleaning up... 02:50:38 INFO - Return code: 0 02:50:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:50:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:50:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:50:39 INFO - Reading from file tmpfile_stdout 02:50:39 INFO - Current package versions: 02:50:39 INFO - argparse == 1.2.1 02:50:39 INFO - blessings == 1.6 02:50:39 INFO - blobuploader == 1.2.4 02:50:39 INFO - docopt == 0.6.1 02:50:39 INFO - functools32 == 3.2.3-2 02:50:39 INFO - jsonschema == 2.5.1 02:50:39 INFO - manifestparser == 1.1 02:50:39 INFO - mozInstall == 1.12 02:50:39 INFO - mozcrash == 0.17 02:50:39 INFO - mozdebug == 0.1 02:50:39 INFO - mozdevice == 0.48 02:50:39 INFO - mozfile == 1.2 02:50:39 INFO - mozhttpd == 0.7 02:50:39 INFO - mozinfo == 0.9 02:50:39 INFO - mozleak == 0.1 02:50:39 INFO - mozlog == 3.2 02:50:39 INFO - moznetwork == 0.27 02:50:39 INFO - mozprocess == 0.23 02:50:39 INFO - mozprofile == 0.28 02:50:39 INFO - mozrunner == 6.12 02:50:39 INFO - mozscreenshot == 0.1 02:50:39 INFO - mozsystemmonitor == 0.3 02:50:39 INFO - moztest == 0.7 02:50:39 INFO - mozversion == 1.4 02:50:39 INFO - psutil == 3.1.1 02:50:39 INFO - requests == 1.2.3 02:50:39 INFO - wsgiref == 0.1.2 02:50:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:39 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 0x2a6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e3b0>, '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 0x2d2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2f740>, '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-1468662424.245175-416113174', '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 02:50:39 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 02:50:39 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 02:50:39 INFO - Using env: {'DISPLAY': ':0', 02:50:39 INFO - 'HOME': '/home/cltbld', 02:50:39 INFO - 'LANG': 'en_US.UTF-8', 02:50:39 INFO - 'LANGUAGE': 'en_US:en', 02:50:39 INFO - 'LOGNAME': 'cltbld', 02:50:39 INFO - 'MAIL': '/var/mail/cltbld', 02:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:39 INFO - 'MOZ_NO_REMOTE': '1', 02:50:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:39 INFO - 'NO_EM_RESTART': '1', 02:50:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:39 INFO - 'PWD': '/builds/slave/test', 02:50:39 INFO - 'SHELL': '/bin/bash', 02:50:39 INFO - 'SHLVL': '1', 02:50:39 INFO - 'TERM': 'linux', 02:50:39 INFO - 'TMOUT': '86400', 02:50:39 INFO - 'USER': 'cltbld', 02:50:39 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1468662424.245175-416113174', 02:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:39 INFO - '_': '/tools/buildbot/bin/python'} 02:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:39 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)) 02:50:39 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)) 02:50:39 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)) 02:50:39 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)) 02:50:39 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)) 02:50:39 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)) 02:50:39 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)) 02:50:39 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)) 02:50:39 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)) 02:50:39 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)) 02:50:39 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)) 02:50:39 INFO - Cleaning up... 02:50:39 INFO - Return code: 0 02:50:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e3b0>, '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 0x2d2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2f740>, '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-1468662424.245175-416113174', '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 02:50:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:50:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:50:39 INFO - Using env: {'DISPLAY': ':0', 02:50:39 INFO - 'HOME': '/home/cltbld', 02:50:39 INFO - 'LANG': 'en_US.UTF-8', 02:50:39 INFO - 'LANGUAGE': 'en_US:en', 02:50:39 INFO - 'LOGNAME': 'cltbld', 02:50:39 INFO - 'MAIL': '/var/mail/cltbld', 02:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:39 INFO - 'MOZ_NO_REMOTE': '1', 02:50:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:39 INFO - 'NO_EM_RESTART': '1', 02:50:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:39 INFO - 'PWD': '/builds/slave/test', 02:50:39 INFO - 'SHELL': '/bin/bash', 02:50:39 INFO - 'SHLVL': '1', 02:50:39 INFO - 'TERM': 'linux', 02:50:39 INFO - 'TMOUT': '86400', 02:50:39 INFO - 'USER': 'cltbld', 02:50:39 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1468662424.245175-416113174', 02:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:39 INFO - '_': '/tools/buildbot/bin/python'} 02:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:50:39 INFO - Cleaning up... 02:50:39 INFO - Return code: 0 02:50:39 INFO - Running post-action listener: _resource_record_post_action 02:50:39 INFO - Running post-action listener: _start_resource_monitoring 02:50:39 INFO - Starting resource monitoring. 02:50:39 INFO - ##### 02:50:39 INFO - ##### Finished create-virtualenv step (success) 02:50:39 INFO - ##### 02:50:39 INFO - ##### 02:50:39 INFO - ##### Running install step. 02:50:39 INFO - ##### 02:50:39 INFO - Running pre-action listener: _resource_record_pre_action 02:50:39 INFO - Running main action method: install 02:50:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:50:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:50:39 INFO - Reading from file tmpfile_stdout 02:50:39 INFO - Detecting whether we're running mozinstall >=1.0... 02:50:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:50:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:50:39 INFO - Reading from file tmpfile_stdout 02:50:39 INFO - Output received: 02:50:39 INFO - Usage: mozinstall [options] installer 02:50:39 INFO - Options: 02:50:39 INFO - -h, --help show this help message and exit 02:50:39 INFO - -d DEST, --destination=DEST 02:50:39 INFO - Directory to install application into. [default: 02:50:39 INFO - "/builds/slave/test"] 02:50:39 INFO - --app=APP Application being installed. [default: firefox] 02:50:39 INFO - mkdir: /builds/slave/test/build/application 02:50:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:50:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:50:56 INFO - Reading from file tmpfile_stdout 02:50:56 INFO - Output received: 02:50:56 INFO - /builds/slave/test/build/application/firefox/firefox 02:50:56 INFO - Running post-action listener: _resource_record_post_action 02:50:56 INFO - ##### 02:50:56 INFO - ##### Finished install step (success) 02:50:56 INFO - ##### 02:50:56 INFO - ##### 02:50:56 INFO - ##### Running run-tests step. 02:50:56 INFO - ##### 02:50:56 INFO - Running pre-action listener: _resource_record_pre_action 02:50:56 INFO - Running main action method: run_tests 02:50:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:50:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:50:56 INFO - Python 2.7.3 02:50:56 INFO - Return code: 0 02:50:56 INFO - grabbing minidump binary from tooltool 02:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:56 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 0x2d2e3b0>, '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 0x2d2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2f740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:50:56 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 02:50:56 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 02:50:56 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 02:50:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:50:56 INFO - Return code: 0 02:50:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:50:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:50:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:50:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:50:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:50:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.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 02:50:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.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 02:50:56 INFO - Using env: {'DISPLAY': ':0', 02:50:56 INFO - 'HOME': '/home/cltbld', 02:50:56 INFO - 'LANG': 'en_US.UTF-8', 02:50:56 INFO - 'LANGUAGE': 'en_US:en', 02:50:56 INFO - 'LOGNAME': 'cltbld', 02:50:56 INFO - 'MAIL': '/var/mail/cltbld', 02:50:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:50:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:56 INFO - 'MOZ_NO_REMOTE': '1', 02:50:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:50:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:56 INFO - 'NO_EM_RESTART': '1', 02:50:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:56 INFO - 'PWD': '/builds/slave/test', 02:50:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:50:56 INFO - 'SHELL': '/bin/bash', 02:50:56 INFO - 'SHLVL': '1', 02:50:56 INFO - 'TERM': 'linux', 02:50:56 INFO - 'TMOUT': '86400', 02:50:56 INFO - 'USER': 'cltbld', 02:50:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1468662424.245175-416113174', 02:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:56 INFO - '_': '/tools/buildbot/bin/python'} 02:50:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.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 02:50:56 INFO - mozversion application_buildid: 20160716011552 02:50:56 INFO - mozversion application_changeset: de45aca6e7cfd90777cfcb1524443039e1d22374 02:50:56 INFO - mozversion application_display_name: Nightly 02:50:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:50:56 INFO - mozversion application_name: Firefox 02:50:56 INFO - mozversion application_remotingname: firefox 02:50:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 02:50:56 INFO - mozversion application_vendor: Mozilla 02:50:56 INFO - mozversion application_version: 50.0a1 02:50:56 INFO - mozversion platform_buildid: 20160716011552 02:50:56 INFO - mozversion platform_changeset: de45aca6e7cfd90777cfcb1524443039e1d22374 02:50:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 02:50:56 INFO - mozversion platform_version: 50.0a1 02:50:56 INFO - using testdate: 1468662656 02:50:56 INFO - actual date: 1468662656 02:50:56 INFO - starting webserver on 'localhost:51868' 02:50:56 INFO - SUITE-START | Running 2 tests 02:50:56 INFO - TEST-START | dromaeo_css 02:50:56 INFO - operating with platform_type : linux_ 02:50:56 INFO - Initialising browser for dromaeo_css test... 02:50:56 INFO - TEST-INFO | started process 3302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsf1rk7/profile http://localhost:51868/getInfo.html) 02:51:03 INFO - PROCESS | 3302 | __metrics Screen width/height:1600/1200 02:51:03 INFO - PROCESS | 3302 | colorDepth:24 02:51:03 INFO - PROCESS | 3302 | Browser inner width/height: 1024/697 02:51:03 INFO - PROCESS | 3302 | __metrics 02:51:04 INFO - PROCESS | 3302 | 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" 02:51:04 INFO - PROCESS | 3302 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:51:05 INFO - TEST-INFO | 3302: exit 0 02:51:05 INFO - Browser initialized. 02:51:05 INFO - Running cycle 1/1 for dromaeo_css test... 02:51:05 INFO - TEST-INFO | started process 3381 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsf1rk7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:51:16 INFO - PROCESS | 3381 | RSS: Main: 159019008 02:51:16 INFO - PROCESS | 3381 | 02:52:08 INFO - PROCESS | 3381 | 1468662728940 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] 02:54:20 INFO - PROCESS | 3381 | Cycle 1(1): loaded http://localhost:51868/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51868/tests/dromaeo/cssquery-ext.html) 02:54:21 INFO - PROCESS | 3381 | RSS: Main: 277520384 02:54:21 INFO - PROCESS | 3381 | 02:57:24 INFO - PROCESS | 3381 | Cycle 1(1): loaded http://localhost:51868/tests/dromaeo/cssquery-ext.html (next: http://localhost:51868/tests/dromaeo/cssquery-jquery.html) 02:57:25 INFO - PROCESS | 3381 | RSS: Main: 243720192 02:57:25 INFO - PROCESS | 3381 | 03:00:27 INFO - PROCESS | 3381 | Cycle 1(1): loaded http://localhost:51868/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51868/tests/dromaeo/cssquery-mootools.html) 03:00:28 INFO - PROCESS | 3381 | RSS: Main: 233320448 03:00:28 INFO - PROCESS | 3381 | 03:03:30 INFO - PROCESS | 3381 | Cycle 1(1): loaded http://localhost:51868/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51868/tests/dromaeo/cssquery-prototype.html) 03:03:31 INFO - PROCESS | 3381 | RSS: Main: 232579072 03:03:31 INFO - PROCESS | 3381 | 03:06:34 INFO - PROCESS | 3381 | Cycle 1(1): loaded http://localhost:51868/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51868/tests/dromaeo/cssquery-yui.html) 03:06:34 INFO - PROCESS | 3381 | RSS: Main: 200646656 03:06:34 INFO - PROCESS | 3381 | 03:09:37 INFO - PROCESS | 3381 | Cycle 1(1): loaded http://localhost:51868/tests/dromaeo/cssquery-yui.html (next: http://localhost:51868/tests/dromaeo/cssquery-dojo.html) 03:09:37 INFO - PROCESS | 3381 | RSS: Main: 288514048 03:09:37 INFO - PROCESS | 3381 | 03:09:37 INFO - PROCESS | 3381 | __start_tp_report 03:09:37 INFO - PROCESS | 3381 | _x_x_mozilla_page_load 03:09:37 INFO - PROCESS | 3381 | _x_x_mozilla_page_load_details 03:09:37 INFO - PROCESS | 3381 | |i|pagename|runs| 03:09:37 INFO - PROCESS | 3381 | |0;dojo.html;2628.6319915211866;2637.709851916288;2668.0795125681643;2669.7463740944618;2675.826071305365;4667.953320466794;4720.386349774529;4751.619870410359;4785.54537318955;4829.106615276176;4794.7842347094465;4813.638977076725;4815.518448155182;4828.661993660445;4895.877603059926;4353.978230108845;4399.208142534342;4444.555544445546;4501.392312037866;4618.584327410533;4525.909481810362;4561.0649816787645;4577.725336479805;4583.266677331628;4596.517365676606;4315.98574335031;4347.717398369127;4356.4336636237085;4412.602865742067;4485.215087359732;4329.9134017319475;4394.450693663292;4423.889402764925;4448.021435284232;4468.084042771224;4406.405135306724;4414;4431.601155895984;4453.866384008485;4465.263231566788;4644.233701439259;4758.310045043484;4778.928316075262;4859.07677541266;4907.337509436216;5157.381114266312;5183.403908550489;5186.533212010937;5235.0838603244665;5235.921461178085;5198.246254293106;5216.60875434344;5263.4473380295285;5267.841964741064;5268.025415298143;4660.7436590987145;4772.212584923518;4822.252550854623;4866.635002374872;4908.901821963541;5292.497212764782;5296.867578310496;5305.495977882095;5332.413434522199;5352.892942141136;5077.390713114376;5092.9745351273;5103.923441148386;5127.4872512748425;5141.511556402211;5078.365204349457;5144.074066668036;5148.382194136728;5186.948130518646;5247.16045432729;5148.716820574829;5163.7676304566385;5175.611829112831;5183.429822719498;5187.870303242449;5152.510511501401;5155.2782610433815;5166.3800343958965;5185.533302002837;5213.087709650796;4263.232618128704;4313.202057619351;4316.352547117957;4353.390525326457;4425.491068527096;3814.275287695329;3820.312343778091;3824.2160357126722;3858.884233473;3864.613538646169;4452.287633978548;4461.977690111528;4466.173757854807;4486.506484286726;4496.842610508616;5010.323606313174;5073.1122053640465;5175.353080864892;5202.08963431398;5237.423883372826;4498.482674492475;4514.25514790056;4516.6160876325885;4524.6380289576755;4559.38448309474;4705.364775755298;4710.788014539354;4720.645951553579;4721.480637129913;4724.291356296583;4722.220833562424;4794.544518270759;4819.518048195293;4871.756412179448;4925.1873440881855;5217.504337088122;5224.138017227115;5233.581313494835;5234.476552344735;5250.763715632729;4877.6829506081995;4878.292647566154;4884.92672609904;4892.461829198856;4922;5024.221245706921;5032.295478632921;5065.240213967934;5087.618428617942;5138.486151384832;5176.767045483038;5202.557782588371;5208.5051920067535;5210.765515551885;5243.108671525926;4948.851534453972;5039.773210205476;5057.949420505895;5061.291419201389;5063.924041139312;4995.400551933792;5005.299258103942;5053.646244762831;5069.5944324454695;5070.645054846125;4997.725125118008;4998.625103117353;5006.274090256965;5041.899162016813;5052.8989420210655;4978.8755281118265;5065.924011139909;5082.745862706776;5089.211172268304;5092.567131793691;4885.047415753894;4941.258811178352;4954.256861470808;4968.726720030433;4989.476105008922 03:09:37 INFO - PROCESS | 3381 | |1;ext.html;550.4180061272947;581.9621724587904;585.8447511409476;589.2016317889263;598.913157592149;40044;41839.372409413845;41860.790696046475;41895.16209675808;46135.30797038039;41800.58199418005;42042.57957420425;42401.787991060075;42470.57529424705;42517.574824251824;7395.186529481753;7638.197989211136;7654.043244594426;7851.607419629025;7988.920110798876;7634.045744281965;10105.898941010606;10379.792404151913;10387.896121038806;10790.73023174423;10531.526081326321;10579.153667706603;10583.10043646291;10589.417582032986;10601.363918164934;7574.810629734246;7750.612469376565;10333.431661258628;10390.42852643108;10398.168146548334;7698.692052317901;10060.144887684555;10433.32183408076;10459.529321180566;10825.458727063615;39360.60639393598;39558.406623900664;39644;39655.20689586221;39730.80134599337;2896.348321627638;2990.9700902990908;3097.1792474994145;3349.229677174239;3519.7712148710507;29309;29671;29709.257268568243;29722.85138574315;30106.84946575275;3323.850426730803;3374.3757404880175;3377.527146199534;3393.7963722176746;3403.0981789825714;249398;251656;252366;252550.73724631444;252861;52717;53168;53238.46761532335;53321;53431.46568534265;56186.43813561812;56198.43801562014;56465;56495.71752141213;56498.717506412206;15265.847341526665;15666.530004099895;15675.686486270211;15678.294476748573;15681.137537435323;9580.0898914603;11303.095752339794;11494.655160345203;11959.222650527689;12351.505939762488;16537.503874883772;16613.50159495217;16838.410655627238;16892.141864394907;16911.069891156105;6525.412712855771;6528.08606795049;6565.606063636197;6595.868082638321;6602.2407423146;834.6077343648476;870.8737233101165;883.4478450968145;920.8802855628726;948.4783369146942;28553;28569.857150714528;28712.282192944927;28888.566671499946;29323.266918327212;974.2790335151936;983.1937810994915;1002.6891663584312;1039.963601273967;1055.1611468882256;14665.266736663125;15018.69962600742;15201.163935983626;15439.073655580702;15537.45618903333;380681;386581;386742;387229;388559;50111.99776004459;50508;50635.746821266395;50925.236121458205;51018.74490627598;1078.946052697362;1168.9298642081333;1187.4834447015576;1205.5238180918313;1213.4054313386378;28857.567136493388;29907;30226;30478.542821857245;30717.23206919845;49016.2647560294;49182;49681.50318496914;49685.50314496809;49765.751171243915;277443;279043;279737;280037;280431;22847.543049139258;23550.882245588662;25988.8700556496;27294.181174564794;27331.59002615002;42125;42223;42608;42646;43025.139497210504;36177.819110904275;36460.635393646786;36475.45286820647;36735;36926.076848079014;35945.281094377446;36860.81569592135;36967.26065478729;37044.44433333556;37559.812200939916;36019.63980360268;36145.63854361528;36190.45714314235;36808.631913681595;36972.63027369799;31974.36051279008;32534.67465325411;32930;33378;33481.83259083689;24869.50260994806;25565.872170639028;25644.358891027874;25651.871740641178;25942.22173334803 03:09:37 INFO - PROCESS | 3381 | |2;jquery.html;352.41499111474957;374.8200863585479;380.98666546670887;385.3199103582178;395.7823197241518;13147.211167329955;16770;17023.914880425596;17107.91446042771;17699.407053365194;16830.410935617256;17068.743968840477;17983.73024404635;18065.909670451663;18069.09654517272;4856.951430485694;5081.771320290596;5112.821051263207;5136.64043516954;5149.40781810091;3756.417755247941;5113.105206588851;5646.943530564683;5968.582199246054;5983.820485385424;6014.969925150368;6017.405387572297;6028.879422411549;6033.366496517869;6041.093835924625;5119.104156772569;5421.132618780976;5426.810061647863;5492.340919089695;5499.065158922993;3402.8638854445794;5044.747762611854;5346.545543628797;5356.276902618136;5390.1914712793005;11989.340586267752;12054.819177712341;12244.632661020183;12281.447334869952;12420.503179872885;1789.7225929980873;1803.4860064881577;1870.2612468075033;1958.8139126782933;2072.3990042887544;9354.204892584139;9624.615015399375;9628.422294662343;9634.807303853884;9711.174550163245;1759.9912000439915;1775.698131317679;1782.393986044751;1786.437272259234;1836.5500452389117;66220.66889665568;68654.31345686529;69348;71557.64221178861;73620;8328.958355208186;9146.908530914605;9195.862062069074;9592.808143837085;10219.54730864602;13084.542041028519;13935.303234838217;13973.720525589431;14340.784888226684;14386;7593.544387336778;7734.265244801735;7800.609969501502;8015.078265999368;8056.073551541648;7066.646667666699;7076.25699301566;7559.848803023909;7624.5425274483705;7945.404094692921;4415.918100065504;4463.486699029589;4489.147062058199;4489.73061616304;4624;1795.7126859702385;1807.1235450806348;1852.1665250637268;1871.7192421136665;1875.3811242290012;821.0762891746784;874.2394117118021;897.555709923592;924.1313165624292;953.6852838563258;15874;16394.344226230816;17612.389460160637;17944.282228710705;18022.639547209244;751.7894989402976;796.8446153000225;805.9764099593483;870.4037734152126;925.6066171876926;9254.953725231466;9280.90719092814;9746.366486178376;9821.754456138653;9890.159336456338;404853;410028;414810;415179;415331;47476;51312.48687513077;76250.61874690591;81327.18672813315;81820;896.3053633434141;898.8067565473455;900.243795212025;904.7647611620895;911.9088091190828;12057.336846473529;15487.380504779683;15670.608234794221;16705;16955.23701433414;38139.80930095332;38286;38499.615003849605;39250.21499569935;39899.800500997306;50160;50611.24083138682;50796;50808.23787643114;51298.48701512937;7654.578998155155;7826.647800848861;7835.608219589112;7852.725154619561;7885;6766.594004359754;8976.730698079067;11112.722181945193;11602.88397116018;12172.4175857138;5101.107306221471;5201.401838788588;10790.838137427787;10901.182411319025;11094.22492401212;10309.07218350352;10503.422311772925;10516.211284153873;10759.89240107589;10844.457777110954;10180.490975451346;10304.484775761031;10699.304545204537;10849.186311026546;11072.280301780358;7639.197884222299;7681.15507294186;7813.3749300057;7946.404019698662;8133.105358410452;4989.451160372429;6405;7942.8085787132395;10477.9476102619;11244.26912250701 03:09:37 INFO - PROCESS | 3381 | |3;mootools.html;1408.1762169131057;1438.3024233246874;1515.9545213643587;1701.1919338314294;1718.1323431667006;7670.961645191774;8127.959360203191;8198.42611017229;8205.589720513964;8219.58902054897;6855.862882742342;7648.5028473149205;7895.210478952102;7944.205579442053;8049.758507244777;2226.065052677875;2256.7404748453973;2258.672492488588;2259.2092767531317;2259.7288325400973;1873.9906300468479;2213;2218.5673793610254;2289.1301305503885;2289.8053665438456;2131.6056529542007;2179.683945827854;2186.5408264264524;2195.3633446300632;2209.2598979341938;2186.355025267534;2198.4613769626385;2205.1730601024697;2217.434554188688;2221.300290408516;2167.468970102335;2168.0894024509744;2173.7174167358144;2180.8146307563875;2187.50781074257;8078.272955434039;8182.18178182183;8182.345412367056;8195.918040819635;8206.015278166658;4687.929681054787;4810.446798618169;4816.470188279286;4829.468758436569;4830.9275360869615;2893.6816950135467;2986.775991800602;3017.5063343644815;3031.060371284909;3058.1590062732703;904.398574947659;906.8503696890006;915.33638112368;936.0779632062413;936.8594710793367;11052.171087168495;11065.557377704883;11073.16951228653;11083.334999900031;11123.276986995901;4100.2414553307735;4193.832246710159;4340.60934515895;4346.500152482505;4390.560943905648;9460.006699296613;9498.145166934872;9513;9514.28642851789;9522;4703.294505824154;4707.2468405055715;4707.6233901287815;4707.85876423701;4711.717296962193;4222.451081359403;4318.5681431856565;4319.179355922428;4323.394724738476;4330.155619654201;3724.6275372462537;3727.254549090193;3785.7917814519915;3825.081980324702;3825.387937929918;1079.5897558927556;1184.1592469346688;1216.6532538226563;1222.419350808359;1238.993805030969;668.866226754651;682.1813823411926;693.5041445366587;695.2769120115124;704.7181127549021;4896.363472748591;4919.0899683558655;4980.77586508608;4984.451710311862;5033.144365457881;794.6702118620708;836.0427310729181;853.8505761491714;869.8564736818354;885.1193062902453;3243.2864769750618;3270.5257737627912;3290.621578518501;3295.3244584860045;3328.617209020945;9670.661526846667;9800.509974501247;10172.796544069077;10177.491125443697;10201.846972295421;10019.198464122852;10101.090901818872;10101.545430455648;10130.189584833195;10138;7159.642017899084;7461.776146715607;7556.773296801105;7599.810004749815;7626.809329766689;5148.2020286855595;5161.225816127611;5246.895062098813;5396.865078373072;5413.377461591967;9031.103468271736;9294.535273236446;9329.673461428818;9399.483028433502;9423.10480504351;8789.560521974003;8961.327900407365;8996.865047024168;9256.213221875947;9326.533673316442;7245.963770181115;7515.436342274461;7546.434017448603;7580.810479738051;7739.535627862347;7593.430492713179;7596.506227095221;7610.353119984863;7637.809054773675;7652.502587331805;6770.966145169243;7019.754308599175;7076.646167691698;7180.210176880643;7192.532485388433;6947.930520694728;7029.789106326818;7055.6824942876665;7108.147022357351;7140.214576396696;6177.660228687465;6333.778317759041;6379.3301703320485;6441.774537891151;6449.871002580016;4352.542982986741;4370.825166993284;4399.5820397062225;4403.625691816232;4476.171908196994;4526.502084770738;4574.268117101248;4583.312503124558;4611.2852507861335;4612.331211974312 03:09:37 INFO - PROCESS | 3381 | |4;prototype.html;298.6893630624151;308.48329048843186;312.4001916320664;313.9513375426807;317.73469153257037;4842.757862106894;4862.343583616215;4872.317875497424;4895.534924182201;4896.975515122428;4772.403449568804;4814.374131362927;4825.541573550516;4837.685550439219;4862.051899879525;3827.3302172119907;3846.4230365445196;3856.9228615427674;3858.82635281413;3898.727089103764;3759.5300587426573;3872.5159355080614;3885.57258701544;3888.5223615026252;3905.4922860028155;3810.7523011004337;3821.254855303217;3837.2901013312626;3845.5577608574954;3847.6921846252235;3811.5997820228895;3824.254270417284;3828.7511311764647;3850.5764365919727;3852.152526444178;3168.2712976015414;3259.148245285375;3271.2149084219855;3274.6397896231397;3290.572225610679;4398.538153493901;4710.175719249118;4722.409698787652;4735.526447355272;4760.238361862085;4413.227685155117;4417.889552761175;4424.247877860739;4428.512863585003;4449.599536041739;4840.467548569654;4911.557959783601;4973;5107.157319042353;5154.7680354383765;3572.678458938682;3573.7855728656104;3585.569731632195;3612.313660404541;3746.4754934309217;5356.1430171172815;5362.43694412085;5365.08793505105;5368.785248590052;5376.704281264529;3843.866654006997;3850.7100121459625;3864.613538646113;3872.3929569229017;3878.7284890057426;3626.7642603230706;3786.280606684721;3793.943090853639;3796.8671096512044;3799.0502374406396;4303.4190384298345;4304.397384366192;4312.310030395121;4316.2446571849805;4317.9921336578645;5075.593952483792;5083.288339632454;5089.643724939218;5099.770510327045;5102;1243.7450322683828;1291.838520184977;1312.6062181345749;1318.9142705724098;1319.5645437005765;821.4578378270313;833.9457935234311;845.7124577643631;853.7310747114639;854.974350769478;4011.7191796574543;4013;4014.558398576154;4027.476428064333;4054.6756259499757;4605.769711514411;4608.516105808909;4622.375979242826;4635.281531362644;4645.814167433265;4036.9596304037173;4040.4949381327333;4040.4949381327333;4043.534993475788;4050.0482386639114;2370.3837002379505;2466.703995520549;2486.95026099477;2489.593379740477;2500.7374225706403;4314.80583373749;4330.545292744217;4376.452943382077;4393.846215382447;4405.581469760367;4661.603763680125;4711.481737008926;4720.527947205252;4742.217534106902;4756.715686764554;4070.3487442009136;4345.848350187203;4347.847825326098;4376.715513491613;4379.715318504287;4629.537046295343;5016.297718319365;5165.354330708661;5168.715720635401;5168.90659282991;4989.854362623962;5061.266116413173;5079.64442489037;5126.487351264844;5127.2565478004735;4901.215805471107;4903.239997800347;4916.7541622919425;4928.236123400879;4938.9259161111895;3557.217412169319;3736.551613806361;3749.568799588082;3776.8300426480323;3783.6027217141805;5226.477352264743;5241.659292145999;5267.3152490176035;5282.049231138432;5283.445238250082;5072;5111.488851114858;5121.487851214849;5123.641345105807;5134.640575159703;4927.265367720949;5084.135696931605;5101.438841727481;5105.795768169231;5107.131787596192;4930.457649658606;4955.72743499111;5004.6246531511015;5024.246363045572;5027.824026159067;5091.821786237464;5096.439391666988;5101.107306221322;5116.948830511647;5142.485751424828;4771.1650461168465;5002.124628190125;5031.974840125776;5036.420811606566;5064.670796398223 03:09:37 INFO - PROCESS | 3381 | |5;yui.html;589.5124158634229;599.0624672387715;610.8381278961074;654.1986067067843;667.706209267922;12265.693357666063;13891.79162312566;14506;14578.271086445675;14588.41646334148;14458.710825783479;14679.192644404553;14698.853011469882;15088.622784430394;15130.924345378258;634.0615888485045;771.8764997600385;793.1473665809264;815.808285053012;818.6602559937619;791.2720297326445;802.6749166587541;803.0724513187278;803.7307501986842;804.0913767442781;840.6931470013432;845.1928408370022;846.6951897316992;847.0089994706209;847.1401527449643;654.5385503220218;804.782708668662;829.0134739659845;838.6310023589632;839.5550358310105;604.6341963112342;604.948579370754;606.5208485296611;607.2045620237459;607.2439812433548;13722.588322350346;13735.107218030797;13778.862211377958;13779.931100344535;13783;12564.308963007123;13004.674883127904;13009.219446833125;13104.934475327658;13402.664933376645;11749.94125029378;11983.880161198364;11985.700357491045;11987.820182697267;12055.939720301343;4186.867779972444;4204.600562946545;4276.850310239158;4285;4302.182585308781;58655;58852.70573647147;58972;59378;59526.40473595252;9472.95263523678;10304.587816487257;10598.041547732251;10842.891571084188;10908.890911090788;20340.779553226854;20724.58550828975;20755.58488830215;20759.377218683465;20761.065752041195;6719.428848547928;6749.190097188271;6787.151606049244;6888;6987.545809522365;3408.3183363327435;3547.255076433926;3554.626764189723;3556.6976806971697;3592.7305452091196;2836.305105249227;2940.2649337665584;2946.7937244393115;2947.793654444168;2950.8819647213872;473.6423999880137;482.97343646099097;484.5759960034969;487.1329034318918;491.54286513542746;449.86054323159925;465.1905684109625;503.7305041802618;566.2440641743319;573.3549756523911;7652.426068044919;7889.289963903161;7954.658744242636;8031.477953933093;8094.919050809534;554.2960440240871;555.7165845418784;562.9268195134606;577.2236342119842;586.196910232975;3499.230169362736;3699.8150092495266;3703.8703645372284;3754.7371683982406;3779.9433008504893;52555.73722131365;63500;93735.53132234295;95284;96028.55957160649;47934.76032619815;70581;75360;76008.23991760123;77202.6139869297;69562.65218673975;74775.62612187013;76198.61900690572;76252.61873690596;76448.61775691198;6950.165980082423;7093.290670932865;7166.570005799668;7251.23861994483;7369.152547457111;42395;42728;43942.560574395124;43966.56033439752;44428;61371;65288;65623.67188164029;65669;65738;9264.53677316145;9279;9348.25213982866;9398.906010939803;9417.246620270225;10692.62575809874;10703.678889633324;11043.116550675766;12836.935815320863;13222.140560863898;9244.352895297265;10951.636350919849;11623.76752464929;12190.390480476119;12360.938195308965;11882.643520694393;12196.57311994076;12382.133250672367;12471.5011399543;13339.933300333436;11353.318800871974;11759.88240117622;12010.219335743499;12036;12167.330796805907;9500.355716083983;9612.615495380387;9715.174210192214;9785.412875227508;10093.949530252301;9229.215516681157;9580.856287155559;9668.951655241679;9684.515774211402;9917.851232231378 03:09:37 INFO - PROCESS | 3381 | __end_tp_report 03:09:37 INFO - PROCESS | 3381 | __start_cc_report 03:09:37 INFO - PROCESS | 3381 | _x_x_mozilla_cycle_collect,1058 03:09:37 INFO - PROCESS | 3381 | __end_cc_report 03:09:37 INFO - PROCESS | 3381 | __startTimestamp1468663777665__endTimestamp 03:09:37 INFO - PROCESS | 3381 | 03:09:37 INFO - PROCESS | 3381 | ------- Summary: start ------- 03:09:37 INFO - PROCESS | 3381 | Number of tests: 6 03:09:37 INFO - PROCESS | 3381 | 03:09:37 INFO - PROCESS | 3381 | [#0] dojo.html Cycles:165 Average:4782.50 Median:4907.34 stddev:510.40 (10.4%) stddev-sans-first:483.19 03:09:37 INFO - PROCESS | 3381 | Values: 2628.6 2637.7 2668.1 2669.7 2675.8 4668.0 4720.4 4751.6 4785.5 4829.1 4794.8 4813.6 4815.5 4828.7 4895.9 4354.0 4399.2 4444.6 4501.4 4618.6 4525.9 4561.1 4577.7 4583.3 4596.5 4316.0 4347.7 4356.4 4412.6 4485.2 4329.9 4394.5 4423.9 4448.0 4468.1 4406.4 4414.0 4431.6 4453.9 4465.3 4644.2 4758.3 4778.9 4859.1 4907.3 5157.4 5183.4 5186.5 5235.1 5235.9 5198.2 5216.6 5263.4 5267.8 5268.0 4660.7 4772.2 4822.3 4866.6 4908.9 5292.5 5296.9 5305.5 5332.4 5352.9 5077.4 5093.0 5103.9 5127.5 5141.5 5078.4 5144.1 5148.4 5186.9 5247.2 5148.7 5163.8 5175.6 5183.4 5187.9 5152.5 5155.3 5166.4 5185.5 5213.1 4263.2 4313.2 4316.4 4353.4 4425.5 3814.3 3820.3 3824.2 3858.9 3864.6 4452.3 4462.0 4466.2 4486.5 4496.8 5010.3 5073.1 5175.4 5202.1 5237.4 4498.5 4514.3 4516.6 4524.6 4559.4 4705.4 4710.8 4720.6 4721.5 4724.3 4722.2 4794.5 4819.5 4871.8 4925.2 5217.5 5224.1 5233.6 5234.5 5250.8 4877.7 4878.3 4884.9 4892.5 4922.0 5024.2 5032.3 5065.2 5087.6 5138.5 5176.8 5202.6 5208.5 5210.8 5243.1 4948.9 5039.8 5057.9 5061.3 5063.9 4995.4 5005.3 5053.6 5069.6 5070.6 4997.7 4998.6 5006.3 5041.9 5052.9 4978.9 5065.9 5082.7 5089.2 5092.6 4885.0 4941.3 4954.3 4968.7 4989.5 03:09:37 INFO - PROCESS | 3381 | 03:09:37 INFO - PROCESS | 3381 | [#1] ext.html Cycles:180 Average:47183.00 Median:3398.45 stddev:81646.74 (2402.5%) stddev-sans-first:81800.71 03:09:37 INFO - PROCESS | 3381 | Values: 550.4 582.0 585.8 589.2 598.9 40044.0 41839.4 41860.8 41895.2 46135.3 41800.6 42042.6 42401.8 42470.6 42517.6 7395.2 7638.2 7654.0 7851.6 7988.9 7634.0 10105.9 10379.8 10387.9 10790.7 10531.5 10579.2 10583.1 10589.4 10601.4 7574.8 7750.6 10333.4 10390.4 10398.2 7698.7 10060.1 10433.3 10459.5 10825.5 39360.6 39558.4 39644.0 39655.2 39730.8 2896.3 2991.0 3097.2 3349.2 3519.8 29309.0 29671.0 29709.3 29722.9 30106.8 3323.9 3374.4 3377.5 3393.8 3403.1 249398.0 251656.0 252366.0 252550.7 252861.0 52717.0 53168.0 53238.5 53321.0 53431.5 56186.4 56198.4 56465.0 56495.7 56498.7 15265.8 15666.5 15675.7 15678.3 15681.1 9580.1 11303.1 11494.7 11959.2 12351.5 16537.5 16613.5 16838.4 16892.1 16911.1 6525.4 6528.1 6565.6 6595.9 6602.2 834.6 870.9 883.4 920.9 948.5 28553.0 28569.9 28712.3 28888.6 29323.3 974.3 983.2 1002.7 1040.0 1055.2 14665.3 15018.7 15201.2 15439.1 15537.5 380681.0 386581.0 386742.0 387229.0 388559.0 50112.0 50508.0 50635.7 50925.2 51018.7 1078.9 1168.9 1187.5 1205.5 1213.4 28857.6 29907.0 30226.0 30478.5 30717.2 49016.3 49182.0 49681.5 49685.5 49765.8 277443.0 279043.0 279737.0 280037.0 280431.0 22847.5 23550.9 25988.9 27294.2 27331.6 42125.0 42223.0 42608.0 42646.0 43025.1 36177.8 36460.6 36475.5 36735.0 36926.1 35945.3 36860.8 36967.3 37044.4 37559.8 36019.6 36145.6 36190.5 36808.6 36972.6 31974.4 32534.7 32930.0 33378.0 33481.8 24869.5 25565.9 25644.4 25651.9 25942.2 03:09:37 INFO - PROCESS | 3381 | 03:09:37 INFO - PROCESS | 3381 | [#2] jquery.html Cycles:180 Average:24418.40 Median:27827.99 stddev:67834.64 (243.8%) stddev-sans-first:68000.87 03:09:37 INFO - PROCESS | 3381 | Values: 352.4 374.8 381.0 385.3 395.8 13147.2 16770.0 17023.9 17107.9 17699.4 16830.4 17068.7 17983.7 18065.9 18069.1 4857.0 5081.8 5112.8 5136.6 5149.4 3756.4 5113.1 5646.9 5968.6 5983.8 6015.0 6017.4 6028.9 6033.4 6041.1 5119.1 5421.1 5426.8 5492.3 5499.1 3402.9 5044.7 5346.5 5356.3 5390.2 11989.3 12054.8 12244.6 12281.4 12420.5 1789.7 1803.5 1870.3 1958.8 2072.4 9354.2 9624.6 9628.4 9634.8 9711.2 1760.0 1775.7 1782.4 1786.4 1836.6 66220.7 68654.3 69348.0 71557.6 73620.0 8329.0 9146.9 9195.9 9592.8 10219.5 13084.5 13935.3 13973.7 14340.8 14386.0 7593.5 7734.3 7800.6 8015.1 8056.1 7066.6 7076.3 7559.8 7624.5 7945.4 4415.9 4463.5 4489.1 4489.7 4624.0 1795.7 1807.1 1852.2 1871.7 1875.4 821.1 874.2 897.6 924.1 953.7 15874.0 16394.3 17612.4 17944.3 18022.6 751.8 796.8 806.0 870.4 925.6 9255.0 9280.9 9746.4 9821.8 9890.2 404853.0 410028.0 414810.0 415179.0 415331.0 47476.0 51312.5 76250.6 81327.2 81820.0 896.3 898.8 900.2 904.8 911.9 12057.3 15487.4 15670.6 16705.0 16955.2 38139.8 38286.0 38499.6 39250.2 39899.8 50160.0 50611.2 50796.0 50808.2 51298.5 7654.6 7826.6 7835.6 7852.7 7885.0 6766.6 8976.7 11112.7 11602.9 12172.4 5101.1 5201.4 10790.8 10901.2 11094.2 10309.1 10503.4 10516.2 10759.9 10844.5 10180.5 10304.5 10699.3 10849.2 11072.3 7639.2 7681.2 7813.4 7946.4 8133.1 4989.5 6405.0 7942.8 10477.9 11244.3 03:09:37 INFO - PROCESS | 3381 | 03:09:37 INFO - PROCESS | 3381 | [#3] mootools.html Cycles:180 Average:5267.05 Median:4822.97 stddev:3017.15 (62.6%) stddev-sans-first:3011.68 03:09:37 INFO - PROCESS | 3381 | Values: 1408.2 1438.3 1516.0 1701.2 1718.1 7671.0 8128.0 8198.4 8205.6 8219.6 6855.9 7648.5 7895.2 7944.2 8049.8 2226.1 2256.7 2258.7 2259.2 2259.7 1874.0 2213.0 2218.6 2289.1 2289.8 2131.6 2179.7 2186.5 2195.4 2209.3 2186.4 2198.5 2205.2 2217.4 2221.3 2167.5 2168.1 2173.7 2180.8 2187.5 8078.3 8182.2 8182.3 8195.9 8206.0 4687.9 4810.4 4816.5 4829.5 4830.9 2893.7 2986.8 3017.5 3031.1 3058.2 904.4 906.9 915.3 936.1 936.9 11052.2 11065.6 11073.2 11083.3 11123.3 4100.2 4193.8 4340.6 4346.5 4390.6 9460.0 9498.1 9513.0 9514.3 9522.0 4703.3 4707.2 4707.6 4707.9 4711.7 4222.5 4318.6 4319.2 4323.4 4330.2 3724.6 3727.3 3785.8 3825.1 3825.4 1079.6 1184.2 1216.7 1222.4 1239.0 668.9 682.2 693.5 695.3 704.7 4896.4 4919.1 4980.8 4984.5 5033.1 794.7 836.0 853.9 869.9 885.1 3243.3 3270.5 3290.6 3295.3 3328.6 9670.7 9800.5 10172.8 10177.5 10201.8 10019.2 10101.1 10101.5 10130.2 10138.0 7159.6 7461.8 7556.8 7599.8 7626.8 5148.2 5161.2 5246.9 5396.9 5413.4 9031.1 9294.5 9329.7 9399.5 9423.1 8789.6 8961.3 8996.9 9256.2 9326.5 7246.0 7515.4 7546.4 7580.8 7739.5 7593.4 7596.5 7610.4 7637.8 7652.5 6771.0 7019.8 7076.6 7180.2 7192.5 6947.9 7029.8 7055.7 7108.1 7140.2 6177.7 6333.8 6379.3 6441.8 6449.9 4352.5 4370.8 4399.6 4403.6 4476.2 4526.5 4574.3 4583.3 4611.3 4612.3 03:09:37 INFO - PROCESS | 3381 | 03:09:37 INFO - PROCESS | 3381 | [#4] prototype.html Cycles:180 Average:4130.12 Median:4527.68 stddev:1196.79 (26.4%) stddev-sans-first:1165.08 03:09:37 INFO - PROCESS | 3381 | Values: 298.7 308.5 312.4 314.0 317.7 4842.8 4862.3 4872.3 4895.5 4897.0 4772.4 4814.4 4825.5 4837.7 4862.1 3827.3 3846.4 3856.9 3858.8 3898.7 3759.5 3872.5 3885.6 3888.5 3905.5 3810.8 3821.3 3837.3 3845.6 3847.7 3811.6 3824.3 3828.8 3850.6 3852.2 3168.3 3259.1 3271.2 3274.6 3290.6 4398.5 4710.2 4722.4 4735.5 4760.2 4413.2 4417.9 4424.2 4428.5 4449.6 4840.5 4911.6 4973.0 5107.2 5154.8 3572.7 3573.8 3585.6 3612.3 3746.5 5356.1 5362.4 5365.1 5368.8 5376.7 3843.9 3850.7 3864.6 3872.4 3878.7 3626.8 3786.3 3793.9 3796.9 3799.1 4303.4 4304.4 4312.3 4316.2 4318.0 5075.6 5083.3 5089.6 5099.8 5102.0 1243.7 1291.8 1312.6 1318.9 1319.6 821.5 833.9 845.7 853.7 855.0 4011.7 4013.0 4014.6 4027.5 4054.7 4605.8 4608.5 4622.4 4635.3 4645.8 4037.0 4040.5 4040.5 4043.5 4050.0 2370.4 2466.7 2487.0 2489.6 2500.7 4314.8 4330.5 4376.5 4393.8 4405.6 4661.6 4711.5 4720.5 4742.2 4756.7 4070.3 4345.8 4347.8 4376.7 4379.7 4629.5 5016.3 5165.4 5168.7 5168.9 4989.9 5061.3 5079.6 5126.5 5127.3 4901.2 4903.2 4916.8 4928.2 4938.9 3557.2 3736.6 3749.6 3776.8 3783.6 5226.5 5241.7 5267.3 5282.0 5283.4 5072.0 5111.5 5121.5 5123.6 5134.6 4927.3 5084.1 5101.4 5105.8 5107.1 4930.5 4955.7 5004.6 5024.2 5027.8 5091.8 5096.4 5101.1 5116.9 5142.5 4771.2 5002.1 5032.0 5036.4 5064.7 03:09:37 INFO - PROCESS | 3381 | 03:09:37 INFO - PROCESS | 3381 | [#5] yui.html Cycles:180 Average:16902.72 Median:559.32 stddev:23094.27 (4129.0%) stddev-sans-first:23126.57 03:09:37 INFO - PROCESS | 3381 | Values: 589.5 599.1 610.8 654.2 667.7 12265.7 13891.8 14506.0 14578.3 14588.4 14458.7 14679.2 14698.9 15088.6 15130.9 634.1 771.9 793.1 815.8 818.7 791.3 802.7 803.1 803.7 804.1 840.7 845.2 846.7 847.0 847.1 654.5 804.8 829.0 838.6 839.6 604.6 604.9 606.5 607.2 607.2 13722.6 13735.1 13778.9 13779.9 13783.0 12564.3 13004.7 13009.2 13104.9 13402.7 11749.9 11983.9 11985.7 11987.8 12055.9 4186.9 4204.6 4276.9 4285.0 4302.2 58655.0 58852.7 58972.0 59378.0 59526.4 9473.0 10304.6 10598.0 10842.9 10908.9 20340.8 20724.6 20755.6 20759.4 20761.1 6719.4 6749.2 6787.2 6888.0 6987.5 3408.3 3547.3 3554.6 3556.7 3592.7 2836.3 2940.3 2946.8 2947.8 2950.9 473.6 483.0 484.6 487.1 491.5 449.9 465.2 503.7 566.2 573.4 7652.4 7889.3 7954.7 8031.5 8094.9 554.3 555.7 562.9 577.2 586.2 3499.2 3699.8 3703.9 3754.7 3779.9 52555.7 63500.0 93735.5 95284.0 96028.6 47934.8 70581.0 75360.0 76008.2 77202.6 69562.7 74775.6 76198.6 76252.6 76448.6 6950.2 7093.3 7166.6 7251.2 7369.2 42395.0 42728.0 43942.6 43966.6 44428.0 61371.0 65288.0 65623.7 65669.0 65738.0 9264.5 9279.0 9348.3 9398.9 9417.2 10692.6 10703.7 11043.1 12836.9 13222.1 9244.4 10951.6 11623.8 12190.4 12360.9 11882.6 12196.6 12382.1 12471.5 13339.9 11353.3 11759.9 12010.2 12036.0 12167.3 9500.4 9612.6 9715.2 9785.4 10093.9 9229.2 9580.9 9669.0 9684.5 9917.9 03:09:37 INFO - PROCESS | 3381 | -------- Summary: end -------- 03:09:37 INFO - PROCESS | 3381 | 03:09:38 INFO - TEST-INFO | 3381: exit 0 03:09:38 INFO - TEST-OK | dromaeo_css | took 1121895ms 03:09:38 INFO - TEST-START | kraken 03:09:38 INFO - operating with platform_type : linux_ 03:09:38 INFO - Initialising browser for kraken test... 03:09:38 INFO - TEST-INFO | started process 3568 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3W1sDs/profile http://localhost:51868/getInfo.html) 03:09:42 INFO - PROCESS | 3568 | __metrics Screen width/height:1600/1200 03:09:42 INFO - PROCESS | 3568 | colorDepth:24 03:09:42 INFO - PROCESS | 3568 | Browser inner width/height: 1024/697 03:09:42 INFO - PROCESS | 3568 | __metrics 03:09:43 INFO - PROCESS | 3568 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:09:43 INFO - PROCESS | 3568 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:09:44 INFO - TEST-INFO | 3568: exit 0 03:09:44 INFO - Browser initialized. 03:09:44 INFO - Running cycle 1/1 for kraken test... 03:09:44 INFO - TEST-INFO | started process 3648 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3W1sDs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:09:56 INFO - PROCESS | 3648 | RSS: Main: 158502912 03:09:56 INFO - PROCESS | 3648 | 03:09:59 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51868/tests/kraken/driver.html?testName=audio-beat-detection) 03:10:00 INFO - PROCESS | 3648 | RSS: Main: 218619904 03:10:00 INFO - PROCESS | 3648 | 03:10:02 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51868/tests/kraken/driver.html?testName=audio-dft) 03:10:03 INFO - PROCESS | 3648 | RSS: Main: 205578240 03:10:03 INFO - PROCESS | 3648 | 03:10:06 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51868/tests/kraken/driver.html?testName=audio-fft) 03:10:07 INFO - PROCESS | 3648 | RSS: Main: 272273408 03:10:07 INFO - PROCESS | 3648 | 03:10:09 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51868/tests/kraken/driver.html?testName=audio-oscillator) 03:10:10 INFO - PROCESS | 3648 | RSS: Main: 182173696 03:10:10 INFO - PROCESS | 3648 | 03:10:12 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51868/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:10:12 INFO - PROCESS | 3648 | RSS: Main: 185618432 03:10:12 INFO - PROCESS | 3648 | 03:10:16 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51868/tests/kraken/driver.html?testName=imaging-darkroom) 03:10:16 INFO - PROCESS | 3648 | RSS: Main: 222326784 03:10:16 INFO - PROCESS | 3648 | 03:10:20 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51868/tests/kraken/driver.html?testName=imaging-desaturate) 03:10:20 INFO - PROCESS | 3648 | RSS: Main: 222449664 03:10:20 INFO - PROCESS | 3648 | 03:10:23 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51868/tests/kraken/driver.html?testName=json-parse-financial) 03:10:24 INFO - PROCESS | 3648 | RSS: Main: 222732288 03:10:24 INFO - PROCESS | 3648 | 03:10:26 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51868/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:10:26 INFO - PROCESS | 3648 | RSS: Main: 211410944 03:10:26 INFO - PROCESS | 3648 | 03:10:28 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51868/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:10:29 INFO - PROCESS | 3648 | RSS: Main: 215961600 03:10:29 INFO - PROCESS | 3648 | 03:10:31 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51868/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:10:32 INFO - PROCESS | 3648 | RSS: Main: 212234240 03:10:32 INFO - PROCESS | 3648 | 03:10:34 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51868/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:10:35 INFO - PROCESS | 3648 | RSS: Main: 226676736 03:10:35 INFO - PROCESS | 3648 | 03:10:38 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51868/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:10:38 INFO - PROCESS | 3648 | RSS: Main: 226938880 03:10:38 INFO - PROCESS | 3648 | 03:10:40 INFO - PROCESS | 3648 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51868/tests/kraken/driver.html?testName=ai-astar) 03:10:40 INFO - PROCESS | 3648 | RSS: Main: 269926400 03:10:40 INFO - PROCESS | 3648 | 03:10:40 INFO - PROCESS | 3648 | __start_tp_report 03:10:40 INFO - PROCESS | 3648 | _x_x_mozilla_page_load 03:10:40 INFO - PROCESS | 3648 | _x_x_mozilla_page_load_details 03:10:40 INFO - PROCESS | 3648 | |i|pagename|runs| 03:10:40 INFO - PROCESS | 3648 | |0;ai-astar;104;117;114;113;114;114;113;115;114;113 03:10:40 INFO - PROCESS | 3648 | |1;audio-beat-detection;156;126;125;167;123;126;146;127;157;123 03:10:40 INFO - PROCESS | 3648 | |2;audio-dft;161;161;162;160;160;162;163;161;160;161 03:10:40 INFO - PROCESS | 3648 | |3;audio-fft;75;75;75;111;75;76;75;74;100;76 03:10:40 INFO - PROCESS | 3648 | |4;audio-oscillator;84;84;114;84;85;84;126;83;85;134 03:10:40 INFO - PROCESS | 3648 | |5;imaging-gaussian-blur;119;117;116;116;117;117;117;116;116;117 03:10:40 INFO - PROCESS | 3648 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;146 03:10:40 INFO - PROCESS | 3648 | |7;imaging-desaturate;95;95;95;95;95;95;95;94;95;95 03:10:40 INFO - PROCESS | 3648 | |8;json-parse-financial;67;62;62;63;62;63;62;64;62;62 03:10:40 INFO - PROCESS | 3648 | |9;json-stringify-tinderbox;65;65;65;66;66;65;67;66;66;67 03:10:40 INFO - PROCESS | 3648 | |10;stanford-crypto-aes;86;77;79;78;78;77;78;83;84;80 03:10:40 INFO - PROCESS | 3648 | |11;stanford-crypto-ccm;138;130;137;132;131;137;127;129;165;140 03:10:40 INFO - PROCESS | 3648 | |12;stanford-crypto-pbkdf2;162;165;162;161;163;161;162;164;167;169 03:10:40 INFO - PROCESS | 3648 | |13;stanford-crypto-sha256-iterative;67;67;68;66;70;70;66;65;65;65 03:10:40 INFO - PROCESS | 3648 | __end_tp_report 03:10:40 INFO - PROCESS | 3648 | __start_cc_report 03:10:40 INFO - PROCESS | 3648 | _x_x_mozilla_cycle_collect,1958 03:10:40 INFO - PROCESS | 3648 | __end_cc_report 03:10:40 INFO - PROCESS | 3648 | __startTimestamp1468663840853__endTimestamp 03:10:40 INFO - PROCESS | 3648 | 03:10:40 INFO - PROCESS | 3648 | ------- Summary: start ------- 03:10:40 INFO - PROCESS | 3648 | Number of tests: 14 03:10:40 INFO - PROCESS | 3648 | 03:10:40 INFO - PROCESS | 3648 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:3.41 (3.0%) stddev-sans-first:1.27 03:10:40 INFO - PROCESS | 3648 | Values: 104.0 117.0 114.0 113.0 114.0 114.0 113.0 115.0 114.0 113.0 03:10:40 INFO - PROCESS | 3648 | 03:10:40 INFO - PROCESS | 3648 | [#1] audio-beat-detection Cycles:10 Average:137.60 Median:136.50 stddev:17.05 (12.5%) stddev-sans-first:16.73 03:10:40 INFO - PROCESS | 3648 | Values: 156.0 126.0 125.0 167.0 123.0 126.0 146.0 127.0 157.0 123.0 03:10:40 INFO - PROCESS | 3648 | 03:10:40 INFO - PROCESS | 3648 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 03:10:40 INFO - PROCESS | 3648 | Values: 161.0 161.0 162.0 160.0 160.0 162.0 163.0 161.0 160.0 161.0 03:10:40 INFO - PROCESS | 3648 | 03:10:40 INFO - PROCESS | 3648 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.00 stddev:13.08 (17.4%) stddev-sans-first:13.68 03:10:40 INFO - PROCESS | 3648 | Values: 75.0 75.0 75.0 111.0 75.0 76.0 75.0 74.0 100.0 76.0 03:10:40 INFO - PROCESS | 3648 | 03:10:40 INFO - PROCESS | 3648 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:84.00 stddev:20.15 (24.0%) stddev-sans-first:20.87 03:10:40 INFO - PROCESS | 3648 | Values: 84.0 84.0 114.0 84.0 85.0 84.0 126.0 83.0 85.0 134.0 03:10:40 INFO - PROCESS | 3648 | 03:10:40 INFO - PROCESS | 3648 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.92 (0.8%) stddev-sans-first:0.53 03:10:40 INFO - PROCESS | 3648 | Values: 119.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 03:10:40 INFO - PROCESS | 3648 | 03:10:40 INFO - PROCESS | 3648 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 03:10:40 INFO - PROCESS | 3648 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 03:10:40 INFO - PROCESS | 3648 | 03:10:40 INFO - PROCESS | 3648 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:10:40 INFO - PROCESS | 3648 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 03:10:40 INFO - PROCESS | 3648 | 03:10:40 INFO - PROCESS | 3648 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:62.50 stddev:1.60 (2.6%) stddev-sans-first:0.73 03:10:40 INFO - PROCESS | 3648 | Values: 67.0 62.0 62.0 63.0 62.0 63.0 62.0 64.0 62.0 62.0 03:10:40 INFO - PROCESS | 3648 | 03:10:40 INFO - PROCESS | 3648 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 03:10:40 INFO - PROCESS | 3648 | Values: 65.0 65.0 65.0 66.0 66.0 65.0 67.0 66.0 66.0 67.0 03:10:40 INFO - PROCESS | 3648 | 03:10:40 INFO - PROCESS | 3648 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:79.50 stddev:3.20 (4.0%) stddev-sans-first:2.55 03:10:40 INFO - PROCESS | 3648 | Values: 86.0 77.0 79.0 78.0 78.0 77.0 78.0 83.0 84.0 80.0 03:10:40 INFO - PROCESS | 3648 | 03:10:40 INFO - PROCESS | 3648 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:137.00 stddev:10.89 (7.9%) stddev-sans-first:11.53 03:10:40 INFO - PROCESS | 3648 | Values: 138.0 130.0 137.0 132.0 131.0 137.0 127.0 129.0 165.0 140.0 03:10:40 INFO - PROCESS | 3648 | 03:10:40 INFO - PROCESS | 3648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.60 Median:163.50 stddev:2.67 (1.6%) stddev-sans-first:2.77 03:10:40 INFO - PROCESS | 3648 | Values: 162.0 165.0 162.0 161.0 163.0 161.0 162.0 164.0 167.0 169.0 03:10:40 INFO - PROCESS | 3648 | 03:10:40 INFO - PROCESS | 3648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.91 (2.9%) stddev-sans-first:2.03 03:10:40 INFO - PROCESS | 3648 | Values: 67.0 67.0 68.0 66.0 70.0 70.0 66.0 65.0 65.0 65.0 03:10:40 INFO - PROCESS | 3648 | -------- Summary: end -------- 03:10:40 INFO - PROCESS | 3648 | 03:10:41 INFO - TEST-INFO | 3648: exit 0 03:10:42 INFO - TEST-OK | kraken | took 63510ms 03:10:42 INFO - SUITE-END | took 1185s 03:10:42 INFO - Completed test suite (00:19:45) 03:10:42 INFO - javascript benchmark 03:10:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2628.6319915211866, 2637.709851916288, 2668.0795125681643, 2669.7463740944618, 2675.826071305365, 4667.953320466794, 4720.386349774529, 4751.619870410359, 4785.54537318955, 4829.106615276176, 4794.7842347094465, 4813.638977076725, 4815.518448155182, 4828.661993660445, 4895.877603059926, 4353.978230108845, 4399.208142534342, 4444.555544445546, 4501.392312037866, 4618.584327410533, 4525.909481810362, 4561.0649816787645, 4577.725336479805, 4583.266677331628, 4596.517365676606, 4315.98574335031, 4347.717398369127, 4356.4336636237085, 4412.602865742067, 4485.215087359732, 4329.9134017319475, 4394.450693663292, 4423.889402764925, 4448.021435284232, 4468.084042771224, 4406.405135306724, 4414.0, 4431.601155895984, 4453.866384008485, 4465.263231566788, 4644.233701439259, 4758.310045043484, 4778.928316075262, 4859.07677541266, 4907.337509436216, 5157.381114266312, 5183.403908550489, 5186.533212010937, 5235.0838603244665, 5235.921461178085, 5198.246254293106, 5216.60875434344, 5263.4473380295285, 5267.841964741064, 5268.025415298143, 4660.7436590987145, 4772.212584923518, 4822.252550854623, 4866.635002374872, 4908.901821963541, 5292.497212764782, 5296.867578310496, 5305.495977882095, 5332.413434522199, 5352.892942141136, 5077.390713114376, 5092.9745351273, 5103.923441148386, 5127.4872512748425, 5141.511556402211, 5078.365204349457, 5144.074066668036, 5148.382194136728, 5186.948130518646, 5247.16045432729, 5148.716820574829, 5163.7676304566385, 5175.611829112831, 5183.429822719498, 5187.870303242449, 5152.510511501401, 5155.2782610433815, 5166.3800343958965, 5185.533302002837, 5213.087709650796, 4263.232618128704, 4313.202057619351, 4316.352547117957, 4353.390525326457, 4425.491068527096, 3814.275287695329, 3820.312343778091, 3824.2160357126722, 3858.884233473, 3864.613538646169, 4452.287633978548, 4461.977690111528, 4466.173757854807, 4486.506484286726, 4496.842610508616, 5010.323606313174, 5073.1122053640465, 5175.353080864892, 5202.08963431398, 5237.423883372826, 4498.482674492475, 4514.25514790056, 4516.6160876325885, 4524.6380289576755, 4559.38448309474, 4705.364775755298, 4710.788014539354, 4720.645951553579, 4721.480637129913, 4724.291356296583, 4722.220833562424, 4794.544518270759, 4819.518048195293, 4871.756412179448, 4925.1873440881855, 5217.504337088122, 5224.138017227115, 5233.581313494835, 5234.476552344735, 5250.763715632729, 4877.6829506081995, 4878.292647566154, 4884.92672609904, 4892.461829198856, 4922.0, 5024.221245706921, 5032.295478632921, 5065.240213967934, 5087.618428617942, 5138.486151384832, 5176.767045483038, 5202.557782588371, 5208.5051920067535, 5210.765515551885, 5243.108671525926, 4948.851534453972, 5039.773210205476, 5057.949420505895, 5061.291419201389, 5063.924041139312, 4995.400551933792, 5005.299258103942, 5053.646244762831, 5069.5944324454695, 5070.645054846125, 4997.725125118008, 4998.625103117353, 5006.274090256965, 5041.899162016813, 5052.8989420210655, 4978.8755281118265, 5065.924011139909, 5082.745862706776, 5089.211172268304, 5092.567131793691, 4885.047415753894, 4941.258811178352, 4954.256861470808, 4968.726720030433, 4989.476105008922], "value": 4749.053223684557, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.4180061272947, 581.9621724587904, 585.8447511409476, 589.2016317889263, 598.913157592149, 40044.0, 41839.372409413845, 41860.790696046475, 41895.16209675808, 46135.30797038039, 41800.58199418005, 42042.57957420425, 42401.787991060075, 42470.57529424705, 42517.574824251824, 7395.186529481753, 7638.197989211136, 7654.043244594426, 7851.607419629025, 7988.920110798876, 7634.045744281965, 10105.898941010606, 10379.792404151913, 10387.896121038806, 10790.73023174423, 10531.526081326321, 10579.153667706603, 10583.10043646291, 10589.417582032986, 10601.363918164934, 7574.810629734246, 7750.612469376565, 10333.431661258628, 10390.42852643108, 10398.168146548334, 7698.692052317901, 10060.144887684555, 10433.32183408076, 10459.529321180566, 10825.458727063615, 39360.60639393598, 39558.406623900664, 39644.0, 39655.20689586221, 39730.80134599337, 2896.348321627638, 2990.9700902990908, 3097.1792474994145, 3349.229677174239, 3519.7712148710507, 29309.0, 29671.0, 29709.257268568243, 29722.85138574315, 30106.84946575275, 3323.850426730803, 3374.3757404880175, 3377.527146199534, 3393.7963722176746, 3403.0981789825714, 249398.0, 251656.0, 252366.0, 252550.73724631444, 252861.0, 52717.0, 53168.0, 53238.46761532335, 53321.0, 53431.46568534265, 56186.43813561812, 56198.43801562014, 56465.0, 56495.71752141213, 56498.717506412206, 15265.847341526665, 15666.530004099895, 15675.686486270211, 15678.294476748573, 15681.137537435323, 9580.0898914603, 11303.095752339794, 11494.655160345203, 11959.222650527689, 12351.505939762488, 16537.503874883772, 16613.50159495217, 16838.410655627238, 16892.141864394907, 16911.069891156105, 6525.412712855771, 6528.08606795049, 6565.606063636197, 6595.868082638321, 6602.2407423146, 834.6077343648476, 870.8737233101165, 883.4478450968145, 920.8802855628726, 948.4783369146942, 28553.0, 28569.857150714528, 28712.282192944927, 28888.566671499946, 29323.266918327212, 974.2790335151936, 983.1937810994915, 1002.6891663584312, 1039.963601273967, 1055.1611468882256, 14665.266736663125, 15018.69962600742, 15201.163935983626, 15439.073655580702, 15537.45618903333, 380681.0, 386581.0, 386742.0, 387229.0, 388559.0, 50111.99776004459, 50508.0, 50635.746821266395, 50925.236121458205, 51018.74490627598, 1078.946052697362, 1168.9298642081333, 1187.4834447015576, 1205.5238180918313, 1213.4054313386378, 28857.567136493388, 29907.0, 30226.0, 30478.542821857245, 30717.23206919845, 49016.2647560294, 49182.0, 49681.50318496914, 49685.50314496809, 49765.751171243915, 277443.0, 279043.0, 279737.0, 280037.0, 280431.0, 22847.543049139258, 23550.882245588662, 25988.8700556496, 27294.181174564794, 27331.59002615002, 42125.0, 42223.0, 42608.0, 42646.0, 43025.139497210504, 36177.819110904275, 36460.635393646786, 36475.45286820647, 36735.0, 36926.076848079014, 35945.281094377446, 36860.81569592135, 36967.26065478729, 37044.44433333556, 37559.812200939916, 36019.63980360268, 36145.63854361528, 36190.45714314235, 36808.631913681595, 36972.63027369799, 31974.36051279008, 32534.67465325411, 32930.0, 33378.0, 33481.83259083689, 24869.50260994806, 25565.872170639028, 25644.358891027874, 25651.871740641178, 25942.22173334803], "value": 18215.142439353487, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.41499111474957, 374.8200863585479, 380.98666546670887, 385.3199103582178, 395.7823197241518, 13147.211167329955, 16770.0, 17023.914880425596, 17107.91446042771, 17699.407053365194, 16830.410935617256, 17068.743968840477, 17983.73024404635, 18065.909670451663, 18069.09654517272, 4856.951430485694, 5081.771320290596, 5112.821051263207, 5136.64043516954, 5149.40781810091, 3756.417755247941, 5113.105206588851, 5646.943530564683, 5968.582199246054, 5983.820485385424, 6014.969925150368, 6017.405387572297, 6028.879422411549, 6033.366496517869, 6041.093835924625, 5119.104156772569, 5421.132618780976, 5426.810061647863, 5492.340919089695, 5499.065158922993, 3402.8638854445794, 5044.747762611854, 5346.545543628797, 5356.276902618136, 5390.1914712793005, 11989.340586267752, 12054.819177712341, 12244.632661020183, 12281.447334869952, 12420.503179872885, 1789.7225929980873, 1803.4860064881577, 1870.2612468075033, 1958.8139126782933, 2072.3990042887544, 9354.204892584139, 9624.615015399375, 9628.422294662343, 9634.807303853884, 9711.174550163245, 1759.9912000439915, 1775.698131317679, 1782.393986044751, 1786.437272259234, 1836.5500452389117, 66220.66889665568, 68654.31345686529, 69348.0, 71557.64221178861, 73620.0, 8328.958355208186, 9146.908530914605, 9195.862062069074, 9592.808143837085, 10219.54730864602, 13084.542041028519, 13935.303234838217, 13973.720525589431, 14340.784888226684, 14386.0, 7593.544387336778, 7734.265244801735, 7800.609969501502, 8015.078265999368, 8056.073551541648, 7066.646667666699, 7076.25699301566, 7559.848803023909, 7624.5425274483705, 7945.404094692921, 4415.918100065504, 4463.486699029589, 4489.147062058199, 4489.73061616304, 4624.0, 1795.7126859702385, 1807.1235450806348, 1852.1665250637268, 1871.7192421136665, 1875.3811242290012, 821.0762891746784, 874.2394117118021, 897.555709923592, 924.1313165624292, 953.6852838563258, 15874.0, 16394.344226230816, 17612.389460160637, 17944.282228710705, 18022.639547209244, 751.7894989402976, 796.8446153000225, 805.9764099593483, 870.4037734152126, 925.6066171876926, 9254.953725231466, 9280.90719092814, 9746.366486178376, 9821.754456138653, 9890.159336456338, 404853.0, 410028.0, 414810.0, 415179.0, 415331.0, 47476.0, 51312.48687513077, 76250.61874690591, 81327.18672813315, 81820.0, 896.3053633434141, 898.8067565473455, 900.243795212025, 904.7647611620895, 911.9088091190828, 12057.336846473529, 15487.380504779683, 15670.608234794221, 16705.0, 16955.23701433414, 38139.80930095332, 38286.0, 38499.615003849605, 39250.21499569935, 39899.800500997306, 50160.0, 50611.24083138682, 50796.0, 50808.23787643114, 51298.48701512937, 7654.578998155155, 7826.647800848861, 7835.608219589112, 7852.725154619561, 7885.0, 6766.594004359754, 8976.730698079067, 11112.722181945193, 11602.88397116018, 12172.4175857138, 5101.107306221471, 5201.401838788588, 10790.838137427787, 10901.182411319025, 11094.22492401212, 10309.07218350352, 10503.422311772925, 10516.211284153873, 10759.89240107589, 10844.457777110954, 10180.490975451346, 10304.484775761031, 10699.304545204537, 10849.186311026546, 11072.280301780358, 7639.197884222299, 7681.15507294186, 7813.3749300057, 7946.404019698662, 8133.105358410452, 4989.451160372429, 6405.0, 7942.8085787132395, 10477.9476102619, 11244.26912250701], "value": 8032.015289467408, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.1762169131057, 1438.3024233246874, 1515.9545213643587, 1701.1919338314294, 1718.1323431667006, 7670.961645191774, 8127.959360203191, 8198.42611017229, 8205.589720513964, 8219.58902054897, 6855.862882742342, 7648.5028473149205, 7895.210478952102, 7944.205579442053, 8049.758507244777, 2226.065052677875, 2256.7404748453973, 2258.672492488588, 2259.2092767531317, 2259.7288325400973, 1873.9906300468479, 2213.0, 2218.5673793610254, 2289.1301305503885, 2289.8053665438456, 2131.6056529542007, 2179.683945827854, 2186.5408264264524, 2195.3633446300632, 2209.2598979341938, 2186.355025267534, 2198.4613769626385, 2205.1730601024697, 2217.434554188688, 2221.300290408516, 2167.468970102335, 2168.0894024509744, 2173.7174167358144, 2180.8146307563875, 2187.50781074257, 8078.272955434039, 8182.18178182183, 8182.345412367056, 8195.918040819635, 8206.015278166658, 4687.929681054787, 4810.446798618169, 4816.470188279286, 4829.468758436569, 4830.9275360869615, 2893.6816950135467, 2986.775991800602, 3017.5063343644815, 3031.060371284909, 3058.1590062732703, 904.398574947659, 906.8503696890006, 915.33638112368, 936.0779632062413, 936.8594710793367, 11052.171087168495, 11065.557377704883, 11073.16951228653, 11083.334999900031, 11123.276986995901, 4100.2414553307735, 4193.832246710159, 4340.60934515895, 4346.500152482505, 4390.560943905648, 9460.006699296613, 9498.145166934872, 9513.0, 9514.28642851789, 9522.0, 4703.294505824154, 4707.2468405055715, 4707.6233901287815, 4707.85876423701, 4711.717296962193, 4222.451081359403, 4318.5681431856565, 4319.179355922428, 4323.394724738476, 4330.155619654201, 3724.6275372462537, 3727.254549090193, 3785.7917814519915, 3825.081980324702, 3825.387937929918, 1079.5897558927556, 1184.1592469346688, 1216.6532538226563, 1222.419350808359, 1238.993805030969, 668.866226754651, 682.1813823411926, 693.5041445366587, 695.2769120115124, 704.7181127549021, 4896.363472748591, 4919.0899683558655, 4980.77586508608, 4984.451710311862, 5033.144365457881, 794.6702118620708, 836.0427310729181, 853.8505761491714, 869.8564736818354, 885.1193062902453, 3243.2864769750618, 3270.5257737627912, 3290.621578518501, 3295.3244584860045, 3328.617209020945, 9670.661526846667, 9800.509974501247, 10172.796544069077, 10177.491125443697, 10201.846972295421, 10019.198464122852, 10101.090901818872, 10101.545430455648, 10130.189584833195, 10138.0, 7159.642017899084, 7461.776146715607, 7556.773296801105, 7599.810004749815, 7626.809329766689, 5148.2020286855595, 5161.225816127611, 5246.895062098813, 5396.865078373072, 5413.377461591967, 9031.103468271736, 9294.535273236446, 9329.673461428818, 9399.483028433502, 9423.10480504351, 8789.560521974003, 8961.327900407365, 8996.865047024168, 9256.213221875947, 9326.533673316442, 7245.963770181115, 7515.436342274461, 7546.434017448603, 7580.810479738051, 7739.535627862347, 7593.430492713179, 7596.506227095221, 7610.353119984863, 7637.809054773675, 7652.502587331805, 6770.966145169243, 7019.754308599175, 7076.646167691698, 7180.210176880643, 7192.532485388433, 6947.930520694728, 7029.789106326818, 7055.6824942876665, 7108.147022357351, 7140.214576396696, 6177.660228687465, 6333.778317759041, 6379.3301703320485, 6441.774537891151, 6449.871002580016, 4352.542982986741, 4370.825166993284, 4399.5820397062225, 4403.625691816232, 4476.171908196994, 4526.502084770738, 4574.268117101248, 4583.312503124558, 4611.2852507861335, 4612.331211974312], "value": 4192.692313453862, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.6893630624151, 308.48329048843186, 312.4001916320664, 313.9513375426807, 317.73469153257037, 4842.757862106894, 4862.343583616215, 4872.317875497424, 4895.534924182201, 4896.975515122428, 4772.403449568804, 4814.374131362927, 4825.541573550516, 4837.685550439219, 4862.051899879525, 3827.3302172119907, 3846.4230365445196, 3856.9228615427674, 3858.82635281413, 3898.727089103764, 3759.5300587426573, 3872.5159355080614, 3885.57258701544, 3888.5223615026252, 3905.4922860028155, 3810.7523011004337, 3821.254855303217, 3837.2901013312626, 3845.5577608574954, 3847.6921846252235, 3811.5997820228895, 3824.254270417284, 3828.7511311764647, 3850.5764365919727, 3852.152526444178, 3168.2712976015414, 3259.148245285375, 3271.2149084219855, 3274.6397896231397, 3290.572225610679, 4398.538153493901, 4710.175719249118, 4722.409698787652, 4735.526447355272, 4760.238361862085, 4413.227685155117, 4417.889552761175, 4424.247877860739, 4428.512863585003, 4449.599536041739, 4840.467548569654, 4911.557959783601, 4973.0, 5107.157319042353, 5154.7680354383765, 3572.678458938682, 3573.7855728656104, 3585.569731632195, 3612.313660404541, 3746.4754934309217, 5356.1430171172815, 5362.43694412085, 5365.08793505105, 5368.785248590052, 5376.704281264529, 3843.866654006997, 3850.7100121459625, 3864.613538646113, 3872.3929569229017, 3878.7284890057426, 3626.7642603230706, 3786.280606684721, 3793.943090853639, 3796.8671096512044, 3799.0502374406396, 4303.4190384298345, 4304.397384366192, 4312.310030395121, 4316.2446571849805, 4317.9921336578645, 5075.593952483792, 5083.288339632454, 5089.643724939218, 5099.770510327045, 5102.0, 1243.7450322683828, 1291.838520184977, 1312.6062181345749, 1318.9142705724098, 1319.5645437005765, 821.4578378270313, 833.9457935234311, 845.7124577643631, 853.7310747114639, 854.974350769478, 4011.7191796574543, 4013.0, 4014.558398576154, 4027.476428064333, 4054.6756259499757, 4605.769711514411, 4608.516105808909, 4622.375979242826, 4635.281531362644, 4645.814167433265, 4036.9596304037173, 4040.4949381327333, 4040.4949381327333, 4043.534993475788, 4050.0482386639114, 2370.3837002379505, 2466.703995520549, 2486.95026099477, 2489.593379740477, 2500.7374225706403, 4314.80583373749, 4330.545292744217, 4376.452943382077, 4393.846215382447, 4405.581469760367, 4661.603763680125, 4711.481737008926, 4720.527947205252, 4742.217534106902, 4756.715686764554, 4070.3487442009136, 4345.848350187203, 4347.847825326098, 4376.715513491613, 4379.715318504287, 4629.537046295343, 5016.297718319365, 5165.354330708661, 5168.715720635401, 5168.90659282991, 4989.854362623962, 5061.266116413173, 5079.64442489037, 5126.487351264844, 5127.2565478004735, 4901.215805471107, 4903.239997800347, 4916.7541622919425, 4928.236123400879, 4938.9259161111895, 3557.217412169319, 3736.551613806361, 3749.568799588082, 3776.8300426480323, 3783.6027217141805, 5226.477352264743, 5241.659292145999, 5267.3152490176035, 5282.049231138432, 5283.445238250082, 5072.0, 5111.488851114858, 5121.487851214849, 5123.641345105807, 5134.640575159703, 4927.265367720949, 5084.135696931605, 5101.438841727481, 5105.795768169231, 5107.131787596192, 4930.457649658606, 4955.72743499111, 5004.6246531511015, 5024.246363045572, 5027.824026159067, 5091.821786237464, 5096.439391666988, 5101.107306221322, 5116.948830511647, 5142.485751424828, 4771.1650461168465, 5002.124628190125, 5031.974840125776, 5036.420811606566, 5064.670796398223], "value": 3754.3232178075523, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.5124158634229, 599.0624672387715, 610.8381278961074, 654.1986067067843, 667.706209267922, 12265.693357666063, 13891.79162312566, 14506.0, 14578.271086445675, 14588.41646334148, 14458.710825783479, 14679.192644404553, 14698.853011469882, 15088.622784430394, 15130.924345378258, 634.0615888485045, 771.8764997600385, 793.1473665809264, 815.808285053012, 818.6602559937619, 791.2720297326445, 802.6749166587541, 803.0724513187278, 803.7307501986842, 804.0913767442781, 840.6931470013432, 845.1928408370022, 846.6951897316992, 847.0089994706209, 847.1401527449643, 654.5385503220218, 804.782708668662, 829.0134739659845, 838.6310023589632, 839.5550358310105, 604.6341963112342, 604.948579370754, 606.5208485296611, 607.2045620237459, 607.2439812433548, 13722.588322350346, 13735.107218030797, 13778.862211377958, 13779.931100344535, 13783.0, 12564.308963007123, 13004.674883127904, 13009.219446833125, 13104.934475327658, 13402.664933376645, 11749.94125029378, 11983.880161198364, 11985.700357491045, 11987.820182697267, 12055.939720301343, 4186.867779972444, 4204.600562946545, 4276.850310239158, 4285.0, 4302.182585308781, 58655.0, 58852.70573647147, 58972.0, 59378.0, 59526.40473595252, 9472.95263523678, 10304.587816487257, 10598.041547732251, 10842.891571084188, 10908.890911090788, 20340.779553226854, 20724.58550828975, 20755.58488830215, 20759.377218683465, 20761.065752041195, 6719.428848547928, 6749.190097188271, 6787.151606049244, 6888.0, 6987.545809522365, 3408.3183363327435, 3547.255076433926, 3554.626764189723, 3556.6976806971697, 3592.7305452091196, 2836.305105249227, 2940.2649337665584, 2946.7937244393115, 2947.793654444168, 2950.8819647213872, 473.6423999880137, 482.97343646099097, 484.5759960034969, 487.1329034318918, 491.54286513542746, 449.86054323159925, 465.1905684109625, 503.7305041802618, 566.2440641743319, 573.3549756523911, 7652.426068044919, 7889.289963903161, 7954.658744242636, 8031.477953933093, 8094.919050809534, 554.2960440240871, 555.7165845418784, 562.9268195134606, 577.2236342119842, 586.196910232975, 3499.230169362736, 3699.8150092495266, 3703.8703645372284, 3754.7371683982406, 3779.9433008504893, 52555.73722131365, 63500.0, 93735.53132234295, 95284.0, 96028.55957160649, 47934.76032619815, 70581.0, 75360.0, 76008.23991760123, 77202.6139869297, 69562.65218673975, 74775.62612187013, 76198.61900690572, 76252.61873690596, 76448.61775691198, 6950.165980082423, 7093.290670932865, 7166.570005799668, 7251.23861994483, 7369.152547457111, 42395.0, 42728.0, 43942.560574395124, 43966.56033439752, 44428.0, 61371.0, 65288.0, 65623.67188164029, 65669.0, 65738.0, 9264.53677316145, 9279.0, 9348.25213982866, 9398.906010939803, 9417.246620270225, 10692.62575809874, 10703.678889633324, 11043.116550675766, 12836.935815320863, 13222.140560863898, 9244.352895297265, 10951.636350919849, 11623.76752464929, 12190.390480476119, 12360.938195308965, 11882.643520694393, 12196.57311994076, 12382.133250672367, 12471.5011399543, 13339.933300333436, 11353.318800871974, 11759.88240117622, 12010.219335743499, 12036.0, 12167.330796805907, 9500.355716083983, 9612.615495380387, 9715.174210192214, 9785.412875227508, 10093.949530252301, 9229.215516681157, 9580.856287155559, 9668.951655241679, 9684.515774211402, 9917.851232231378], "value": 6470.684141918218, "unit": "score"}], "name": "dromaeo_css", "value": 6431.5392811106085, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 117.0, 114.0, 113.0, 114.0, 114.0, 113.0, 115.0, 114.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 126.0, 125.0, 167.0, 123.0, 126.0, 146.0, 127.0, 157.0, 123.0], "value": 137.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 160.0, 160.0, 162.0, 163.0, 161.0, 160.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 111.0, 75.0, 76.0, 75.0, 74.0, 100.0, 76.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 114.0, 84.0, 85.0, 84.0, 126.0, 83.0, 85.0, 134.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 62.0, 62.0, 63.0, 62.0, 63.0, 62.0, 64.0, 62.0, 62.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 66.0, 65.0, 67.0, 66.0, 66.0, 67.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 77.0, 79.0, 78.0, 78.0, 77.0, 78.0, 83.0, 84.0, 80.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 130.0, 137.0, 132.0, 131.0, 137.0, 127.0, 129.0, 165.0, 140.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 162.0, 161.0, 163.0, 161.0, 162.0, 164.0, 167.0, 169.0], "value": 163.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 66.0, 70.0, 70.0, 66.0, 65.0, 65.0, 65.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1522.7999999999997, "alertThreshold": 2.0}]} 03:10:42 INFO - Return code: 0 03:10:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:10:42 INFO - # TBPL SUCCESS # 03:10:42 INFO - Running post-action listener: _resource_record_post_action 03:10:42 INFO - ##### 03:10:42 INFO - ##### Finished run-tests step (success) 03:10:42 INFO - ##### 03:10:42 INFO - Running post-run listener: _resource_record_post_run 03:10:42 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 7778304; Write bytes: 391811072; Read time: 1452; Write time: 428136 03:10:42 INFO - TinderboxPrint: CPU usage
13.0% 03:10:42 INFO - TinderboxPrint: I/O read bytes / time
7,778,304 / 1,452 03:10:42 INFO - TinderboxPrint: I/O write bytes / time
391,811,072 / 428,136 03:10:42 INFO - TinderboxPrint: CPU idle
8,345.0 (87.0%) 03:10:42 INFO - TinderboxPrint: CPU user
1,204.6 (12.6%) 03:10:42 INFO - TinderboxPrint: Swap in / out
0 / 0 03:10:42 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 81862656; Read time: 48; Write time: 84868 03:10:42 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 5619712; Write bytes: 309948416; Read time: 1296; Write time: 343268 03:10:43 INFO - Running post-run listener: _upload_blobber_files 03:10:43 INFO - Blob upload gear active. 03:10:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:10:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:10:43 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:10:43 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:10:43 INFO - (blobuploader) - INFO - Open directory for files ... 03:10:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:10:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:10:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:10:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:10:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:10:44 INFO - (blobuploader) - INFO - Done attempting. 03:10:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:10:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:10:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:10:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:10:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:10:45 INFO - (blobuploader) - INFO - Done attempting. 03:10:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:10:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:10:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:10:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:10:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:10:49 INFO - (blobuploader) - INFO - Done attempting. 03:10:49 INFO - (blobuploader) - INFO - Iteration through files over. 03:10:49 INFO - Return code: 0 03:10:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:10:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:10:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/29afc37657c6771f680f6ad1bad2a7385d0231e94ca904a10e6daf9eda4daac69698d84e3f07a3d14db7d206dda389baa10613cbf4c4696b9875b4b2e58a25dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/eae67c87f62acaa45f397532963eef41c8d6115a6964786d8a498470dc1ed11178eb7b8a16ca1ddc29aad5c0a78d39c7f03a5c8dc70e1ead838a43beedbf4ba5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a7c286fc5bc75e649606852816e3b25a75da4e3f4736207b22f20dc8fb2a2d1ff774b3bcd68f33393fb93382dd395c1c87342570d7448e23eb8f9aad22dacb12"} 03:10:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:10:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:10:49 INFO - Contents: 03:10:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/29afc37657c6771f680f6ad1bad2a7385d0231e94ca904a10e6daf9eda4daac69698d84e3f07a3d14db7d206dda389baa10613cbf4c4696b9875b4b2e58a25dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/eae67c87f62acaa45f397532963eef41c8d6115a6964786d8a498470dc1ed11178eb7b8a16ca1ddc29aad5c0a78d39c7f03a5c8dc70e1ead838a43beedbf4ba5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a7c286fc5bc75e649606852816e3b25a75da4e3f4736207b22f20dc8fb2a2d1ff774b3bcd68f33393fb93382dd395c1c87342570d7448e23eb8f9aad22dacb12"} 03:10:49 INFO - Running post-run listener: copy_logs_to_upload_dir 03:10:49 INFO - Copying logs to upload dir... 03:10:49 INFO - mkdir: /builds/slave/test/build/upload/logs 03:10:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.131466 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-16 03:10:49.390258) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 03:10:49.393834) ========= 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-1468662424.245175-416113174 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/29afc37657c6771f680f6ad1bad2a7385d0231e94ca904a10e6daf9eda4daac69698d84e3f07a3d14db7d206dda389baa10613cbf4c4696b9875b4b2e58a25dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/eae67c87f62acaa45f397532963eef41c8d6115a6964786d8a498470dc1ed11178eb7b8a16ca1ddc29aad5c0a78d39c7f03a5c8dc70e1ead838a43beedbf4ba5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a7c286fc5bc75e649606852816e3b25a75da4e3f4736207b22f20dc8fb2a2d1ff774b3bcd68f33393fb93382dd395c1c87342570d7448e23eb8f9aad22dacb12"} build_url:https://queue.taskcluster.net/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011336 build_url: 'https://queue.taskcluster.net/v1/task/MnOgP0YWQCuqDUjbX906wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/29afc37657c6771f680f6ad1bad2a7385d0231e94ca904a10e6daf9eda4daac69698d84e3f07a3d14db7d206dda389baa10613cbf4c4696b9875b4b2e58a25dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/eae67c87f62acaa45f397532963eef41c8d6115a6964786d8a498470dc1ed11178eb7b8a16ca1ddc29aad5c0a78d39c7f03a5c8dc70e1ead838a43beedbf4ba5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a7c286fc5bc75e649606852816e3b25a75da4e3f4736207b22f20dc8fb2a2d1ff774b3bcd68f33393fb93382dd395c1c87342570d7448e23eb8f9aad22dacb12"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 03:10:49.419425) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:10:49.419776) ========= 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-1468662424.245175-416113174 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004384 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:10:49.503263) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 03:10:49.503621) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 03:10:49.503935) ========= ========= Total master_lag: 0.26 =========