builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-034 starttime: 1472737730.98 results: success (0) buildid: 20160901053021 builduid: ab67ba61512640dfa6b79a98abc11679 revision: 7db02dab044ea63188daa8a1f04ab29647e3b139 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 06:48:50.976602) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 06:48:50.977082) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 06:48:50.977357) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 06:48:51.004967) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:48:51.005234) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-01 06:48:51-- 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% 56.6M=0s 2016-09-01 06:48:51 (56.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130401 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:48:51.149200) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:48:51.149482) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015933 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:48:51.198337) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 06:48:51.198633) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 7db02dab044ea63188daa8a1f04ab29647e3b139 --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 7db02dab044ea63188daa8a1f04ab29647e3b139 --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=d6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-01 06:48:52,004 truncating revision to first 12 chars 2016-09-01 06:48:52,004 Setting DEBUG logging. 2016-09-01 06:48:52,004 attempt 1/10 2016-09-01 06:48:52,004 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/7db02dab044e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 06:48:53,022 unpacking tar archive at: autoland-7db02dab044e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.426014 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 06:48:52.638021) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 06:48:52.638348) ========= script_repo_revision: 7db02dab044ea63188daa8a1f04ab29647e3b139 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 06:48:52.638736) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 06:48:52.639012) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 06:48:52.648676) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-01 06:48:52.648962) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:48:53 INFO - MultiFileLogger online at 20160901 06:48:53 in /builds/slave/test 06:48:53 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 06:48:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:48:53 INFO - {'append_to_log': False, 06:48:53 INFO - 'base_work_dir': '/builds/slave/test', 06:48:53 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 06:48:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:48:53 INFO - 'branch': 'Autoland-Non-PGO', 06:48:53 INFO - 'buildbot_json_path': 'buildprops.json', 06:48:53 INFO - 'config_files': ('talos/linux_config.py',), 06:48:53 INFO - 'default_actions': ('clobber', 06:48:53 INFO - 'read-buildbot-config', 06:48:53 INFO - 'download-and-extract', 06:48:53 INFO - 'populate-webroot', 06:48:53 INFO - 'create-virtualenv', 06:48:53 INFO - 'install', 06:48:53 INFO - 'run-tests'), 06:48:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:48:53 INFO - 'download_minidump_stackwalk': True, 06:48:53 INFO - 'download_symbols': 'ondemand', 06:48:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:48:53 INFO - 'tooltool.py': '/tools/tooltool.py', 06:48:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:48:53 INFO - '/tools/misc-python/virtualenv.py')}, 06:48:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:48:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:48:53 INFO - 'installer_path': 'installer.exe', 06:48:53 INFO - 'log_level': 'info', 06:48:53 INFO - 'log_name': 'talos', 06:48:53 INFO - 'log_to_console': True, 06:48:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:48:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:48:53 INFO - 'opt_config_files': (), 06:48:53 INFO - 'pip_index': False, 06:48:53 INFO - 'sps_profile': False, 06:48:53 INFO - 'sps_profile_interval': 0, 06:48:53 INFO - 'suite': 'dromaeojs', 06:48:53 INFO - 'system_bits': '32', 06:48:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:48:53 INFO - 'title': 'talos-linux64-ix-034', 06:48:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:48:53 INFO - 'use_talos_json': True, 06:48:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:48:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:48:53 INFO - 'work_dir': 'build'} 06:48:53 INFO - [mozharness: 2016-09-01 13:48:53.546209Z] Running clobber step. 06:48:53 INFO - Running pre-action listener: _resource_record_pre_action 06:48:53 INFO - Running main action method: clobber 06:48:53 INFO - rmtree: /builds/slave/test/build 06:48:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:48:53 INFO - Running post-action listener: _resource_record_post_action 06:48:53 INFO - [mozharness: 2016-09-01 13:48:53.550000Z] Finished clobber step (success) 06:48:53 INFO - [mozharness: 2016-09-01 13:48:53.550098Z] Running read-buildbot-config step. 06:48:53 INFO - Running pre-action listener: _resource_record_pre_action 06:48:53 INFO - Running main action method: read_buildbot_config 06:48:53 INFO - Using buildbot properties: 06:48:53 INFO - { 06:48:53 INFO - "project": "", 06:48:53 INFO - "product": "firefox", 06:48:53 INFO - "script_repo_revision": "production", 06:48:53 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 06:48:53 INFO - "repository": "", 06:48:53 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 06:48:53 INFO - "buildid": "20160901053021", 06:48:53 INFO - "pgo_build": "False", 06:48:53 INFO - "basedir": "/builds/slave/test", 06:48:53 INFO - "buildnumber": 588, 06:48:53 INFO - "slavename": "talos-linux64-ix-034", 06:48:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:48:53 INFO - "platform": "ubuntu64_hw", 06:48:53 INFO - "scheduler": "tests-autoland-linux64-talos", 06:48:53 INFO - "branch": "autoland", 06:48:53 INFO - "repo_path": "integration/autoland", 06:48:53 INFO - "revision": "7db02dab044ea63188daa8a1f04ab29647e3b139", 06:48:53 INFO - "stage_platform": "linux64", 06:48:53 INFO - "builduid": "ab67ba61512640dfa6b79a98abc11679", 06:48:53 INFO - "slavebuilddir": "test" 06:48:53 INFO - } 06:48:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/K6YjdrIvSa-p3Jp4BWfgWQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 06:48:53 INFO - Running post-action listener: _resource_record_post_action 06:48:53 INFO - [mozharness: 2016-09-01 13:48:53.552507Z] Finished read-buildbot-config step (success) 06:48:53 INFO - [mozharness: 2016-09-01 13:48:53.552598Z] Running download-and-extract step. 06:48:53 INFO - Running pre-action listener: _resource_record_pre_action 06:48:53 INFO - Running main action method: download_and_extract 06:48:53 INFO - mkdir: /builds/slave/test/build/tests 06:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:48:53 INFO - trying https://queue.taskcluster.net/v1/task/K6YjdrIvSa-p3Jp4BWfgWQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:48:53 INFO - Downloading https://queue.taskcluster.net/v1/task/K6YjdrIvSa-p3Jp4BWfgWQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:48:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K6YjdrIvSa-p3Jp4BWfgWQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:48:54 INFO - Downloaded 1361 bytes. 06:48:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:48:54 INFO - Using the following test package requirements: 06:48:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 06:48:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:48:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:48:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:48:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:48:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:48:54 INFO - u'jsshell-linux-x86_64.zip'], 06:48:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:48:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:48:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 06:48:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:48:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:48:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:48:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:48:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:48:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:48:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:48:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:48:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:48:54 INFO - trying https://queue.taskcluster.net/v1/task/K6YjdrIvSa-p3Jp4BWfgWQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:48:54 INFO - Downloading https://queue.taskcluster.net/v1/task/K6YjdrIvSa-p3Jp4BWfgWQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:48:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K6YjdrIvSa-p3Jp4BWfgWQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:48:55 INFO - Downloaded 20333746 bytes. 06:48:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 06:49:00 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:49: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:00 INFO - trying https://queue.taskcluster.net/v1/task/K6YjdrIvSa-p3Jp4BWfgWQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:49:00 INFO - Downloading https://queue.taskcluster.net/v1/task/K6YjdrIvSa-p3Jp4BWfgWQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:49:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K6YjdrIvSa-p3Jp4BWfgWQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:49:00 INFO - Downloaded 20333746 bytes. 06:49:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 06:49: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:05 INFO - trying https://queue.taskcluster.net/v1/task/K6YjdrIvSa-p3Jp4BWfgWQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 06:49:05 INFO - Downloading https://queue.taskcluster.net/v1/task/K6YjdrIvSa-p3Jp4BWfgWQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 06:49:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K6YjdrIvSa-p3Jp4BWfgWQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:49:07 INFO - Downloaded 14413998 bytes. 06:49:07 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 06:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:07 INFO - trying https://queue.taskcluster.net/v1/task/K6YjdrIvSa-p3Jp4BWfgWQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:49:07 INFO - Downloading https://queue.taskcluster.net/v1/task/K6YjdrIvSa-p3Jp4BWfgWQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:49:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K6YjdrIvSa-p3Jp4BWfgWQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:49:09 INFO - Downloaded 55868910 bytes. 06:49:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K6YjdrIvSa-p3Jp4BWfgWQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:49:09 INFO - mkdir: /builds/slave/test/properties 06:49:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:49:09 INFO - Writing to file /builds/slave/test/properties/build_url 06:49:09 INFO - Contents: 06:49:09 INFO - build_url:https://queue.taskcluster.net/v1/task/K6YjdrIvSa-p3Jp4BWfgWQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:49:10 INFO - Running post-action listener: _resource_record_post_action 06:49:10 INFO - Running post-action listener: set_extra_try_arguments 06:49:10 INFO - [mozharness: 2016-09-01 13:49:10.231101Z] Finished download-and-extract step (success) 06:49:10 INFO - [mozharness: 2016-09-01 13:49:10.231331Z] Running populate-webroot step. 06:49:10 INFO - Running pre-action listener: _resource_record_pre_action 06:49:10 INFO - Running main action method: populate_webroot 06:49:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:49:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:49:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:49:10 INFO - '--tppagecycles', 06:49:10 INFO - '7'], 06:49:10 INFO - 'tests': ['tsvgm']}}, 06:49:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:49:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:49:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:49:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:49:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:49:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:49:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:10 INFO - 'talos_options': ['--disable-e10s'], 06:49:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:49:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:49:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:10 INFO - 'talos_options': ['--disable-e10s'], 06:49:10 INFO - 'tests': ['damp', 'tps']}, 06:49:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:10 INFO - 'tests': ['damp', 'tps']}, 06:49:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:49:10 INFO - 'tests': ['dromaeo_dom']}, 06:49:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:49:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:49:10 INFO - 'tests': ['basic_compositor_video']}, 06:49:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:49:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:49:10 INFO - 'tests': ['a11yr', 06:49:10 INFO - 'ts_paint', 06:49:10 INFO - 'tpaint', 06:49:10 INFO - 'sessionrestore', 06:49:10 INFO - 'sessionrestore_no_auto_restore', 06:49:10 INFO - 'tabpaint']}, 06:49:10 INFO - 'other-e10s': {'tests': ['a11yr', 06:49:10 INFO - 'ts_paint', 06:49:10 INFO - 'tpaint', 06:49:10 INFO - 'sessionrestore', 06:49:10 INFO - 'sessionrestore_no_auto_restore', 06:49:10 INFO - 'tabpaint']}, 06:49:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:49:10 INFO - 'ts_paint', 06:49:10 INFO - 'tpaint', 06:49:10 INFO - 'sessionrestore', 06:49:10 INFO - 'sessionrestore_no_auto_restore', 06:49:10 INFO - 'tabpaint']}, 06:49:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:49:10 INFO - 'ts_paint', 06:49:10 INFO - 'tpaint', 06:49:10 INFO - 'sessionrestore', 06:49:10 INFO - 'sessionrestore_no_auto_restore', 06:49:10 INFO - 'tabpaint']}, 06:49:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:49:10 INFO - 'tests': ['a11yr', 06:49:10 INFO - 'ts_paint', 06:49:10 INFO - 'tpaint', 06:49:10 INFO - 'sessionrestore', 06:49:10 INFO - 'sessionrestore_no_auto_restore', 06:49:10 INFO - 'tabpaint']}, 06:49:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:49:10 INFO - 'tests': ['a11yr', 06:49:10 INFO - 'ts_paint', 06:49:10 INFO - 'tpaint', 06:49:10 INFO - 'sessionrestore', 06:49:10 INFO - 'sessionrestore_no_auto_restore', 06:49:10 INFO - 'tabpaint']}, 06:49:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:49:10 INFO - 'tests': ['tsvgx', 06:49:10 INFO - 'tsvgr_opacity', 06:49:10 INFO - 'tart', 06:49:10 INFO - 'tscrollx', 06:49:10 INFO - 'cart']}, 06:49:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:49:10 INFO - 'tsvgr_opacity', 06:49:10 INFO - 'tart', 06:49:10 INFO - 'tscrollx', 06:49:10 INFO - 'cart']}, 06:49:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:10 INFO - 'talos_options': ['--disable-e10s'], 06:49:10 INFO - 'tests': ['tp5o']}, 06:49:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:10 INFO - 'tests': ['tp5o']}, 06:49:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:10 INFO - 'talos_options': ['--disable-e10s', 06:49:10 INFO - '--xperf_path', 06:49:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:49:10 INFO - 'tests': ['tp5n']}, 06:49:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:10 INFO - 'talos_options': ['--xperf_path', 06:49:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:49:10 INFO - 'tests': ['tp5n']}}, 06:49:10 INFO - 'talos.zip': {'path': '', 06:49:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:49:10 INFO - Running post-action listener: _resource_record_post_action 06:49:10 INFO - [mozharness: 2016-09-01 13:49:10.248157Z] Finished populate-webroot step (success) 06:49:10 INFO - [mozharness: 2016-09-01 13:49:10.248248Z] Running create-virtualenv step. 06:49:10 INFO - Running pre-action listener: _resource_record_pre_action 06:49:10 INFO - Running main action method: create_virtualenv 06:49:10 INFO - Creating virtualenv /builds/slave/test/build/venv 06:49:10 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 06:49:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:49:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:49:10 INFO - Using real prefix '/usr' 06:49:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:49:10 INFO - Installing distribute.............................................................................................................................................................................................done. 06:49:12 INFO - Installing pip.................done. 06:49:12 INFO - Return code: 0 06:49:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:12 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 0x7f62e6becf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9090>, '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 0x1bcc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcce40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713', '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 06:49:12 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 06:49:12 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 06:49:12 INFO - Using env: {'DISPLAY': ':0', 06:49:12 INFO - 'HOME': '/home/cltbld', 06:49:12 INFO - 'LANG': 'en_US.UTF-8', 06:49:12 INFO - 'LANGUAGE': 'en_US:en', 06:49:12 INFO - 'LOGNAME': 'cltbld', 06:49:12 INFO - 'MAIL': '/var/mail/cltbld', 06:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:12 INFO - 'MOZ_NO_REMOTE': '1', 06:49:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:12 INFO - 'NO_EM_RESTART': '1', 06:49:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:12 INFO - 'PWD': '/builds/slave/test', 06:49:12 INFO - 'SHELL': '/bin/bash', 06:49:12 INFO - 'SHLVL': '1', 06:49:12 INFO - 'TERM': 'linux', 06:49:12 INFO - 'TMOUT': '86400', 06:49:12 INFO - 'USER': 'cltbld', 06:49:12 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713', 06:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:12 INFO - '_': '/tools/buildbot/bin/python'} 06:49:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:13 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 06:49:13 INFO - Cleaning up... 06:49:13 INFO - Return code: 0 06:49:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:13 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 0x7f62e6becf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9090>, '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 0x1bcc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcce40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713', '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 06:49:13 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 06:49:13 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 06:49:13 INFO - Using env: {'DISPLAY': ':0', 06:49:13 INFO - 'HOME': '/home/cltbld', 06:49:13 INFO - 'LANG': 'en_US.UTF-8', 06:49:13 INFO - 'LANGUAGE': 'en_US:en', 06:49:13 INFO - 'LOGNAME': 'cltbld', 06:49:13 INFO - 'MAIL': '/var/mail/cltbld', 06:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:13 INFO - 'MOZ_NO_REMOTE': '1', 06:49:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:13 INFO - 'NO_EM_RESTART': '1', 06:49:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:13 INFO - 'PWD': '/builds/slave/test', 06:49:13 INFO - 'SHELL': '/bin/bash', 06:49:13 INFO - 'SHLVL': '1', 06:49:13 INFO - 'TERM': 'linux', 06:49:13 INFO - 'TMOUT': '86400', 06:49:13 INFO - 'USER': 'cltbld', 06:49:13 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713', 06:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:13 INFO - '_': '/tools/buildbot/bin/python'} 06:49:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:13 INFO - Downloading/unpacking psutil>=3.1.1 06:49:13 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 06:49:13 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 06:49:13 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 06:49:13 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 06:49:13 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 06:49:13 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 06:49:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:49:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:49:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:49:15 INFO - Installing collected packages: psutil 06:49:15 INFO - Running setup.py install for psutil 06:49:15 INFO - building 'psutil._psutil_linux' extension 06:49:15 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 06:49:15 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 06:49:15 INFO - building 'psutil._psutil_posix' extension 06:49:15 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 06:49:15 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 06:49:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:49:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:49:15 INFO - Successfully installed psutil 06:49:15 INFO - Cleaning up... 06:49:15 INFO - Return code: 0 06:49:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:15 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 0x7f62e6becf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9090>, '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 0x1bcc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcce40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713', '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 06:49:15 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 06:49:15 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 06:49:15 INFO - Using env: {'DISPLAY': ':0', 06:49:15 INFO - 'HOME': '/home/cltbld', 06:49:15 INFO - 'LANG': 'en_US.UTF-8', 06:49:15 INFO - 'LANGUAGE': 'en_US:en', 06:49:15 INFO - 'LOGNAME': 'cltbld', 06:49:15 INFO - 'MAIL': '/var/mail/cltbld', 06:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:15 INFO - 'MOZ_NO_REMOTE': '1', 06:49:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:15 INFO - 'NO_EM_RESTART': '1', 06:49:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:15 INFO - 'PWD': '/builds/slave/test', 06:49:15 INFO - 'SHELL': '/bin/bash', 06:49:15 INFO - 'SHLVL': '1', 06:49:15 INFO - 'TERM': 'linux', 06:49:15 INFO - 'TMOUT': '86400', 06:49:15 INFO - 'USER': 'cltbld', 06:49:15 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713', 06:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:15 INFO - '_': '/tools/buildbot/bin/python'} 06:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:49:16 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 06:49:16 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 06:49:16 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 06:49:16 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 06:49:16 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 06:49:16 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 06:49:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:49:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:49:17 INFO - Installing collected packages: mozsystemmonitor 06:49:17 INFO - Running setup.py install for mozsystemmonitor 06:49:18 INFO - Successfully installed mozsystemmonitor 06:49:18 INFO - Cleaning up... 06:49:18 INFO - Return code: 0 06:49:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:18 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 0x7f62e6becf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9090>, '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 0x1bcc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcce40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713', '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 06:49:18 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 06:49:18 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 06:49:18 INFO - Using env: {'DISPLAY': ':0', 06:49:18 INFO - 'HOME': '/home/cltbld', 06:49:18 INFO - 'LANG': 'en_US.UTF-8', 06:49:18 INFO - 'LANGUAGE': 'en_US:en', 06:49:18 INFO - 'LOGNAME': 'cltbld', 06:49:18 INFO - 'MAIL': '/var/mail/cltbld', 06:49:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:18 INFO - 'MOZ_NO_REMOTE': '1', 06:49:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:18 INFO - 'NO_EM_RESTART': '1', 06:49:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:18 INFO - 'PWD': '/builds/slave/test', 06:49:18 INFO - 'SHELL': '/bin/bash', 06:49:18 INFO - 'SHLVL': '1', 06:49:18 INFO - 'TERM': 'linux', 06:49:18 INFO - 'TMOUT': '86400', 06:49:18 INFO - 'USER': 'cltbld', 06:49:18 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713', 06:49:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:18 INFO - '_': '/tools/buildbot/bin/python'} 06:49:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:18 INFO - Downloading/unpacking jsonschema==2.5.1 06:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:49:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:49:20 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 06:49:20 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 06:49:20 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 06:49:20 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 06:49:20 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 06:49:20 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 06:49:20 INFO - Downloading functools32-3.2.3-2.tar.gz 06:49:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:49:20 INFO - warning: no files found matching '*.txt' 06:49:20 INFO - no previously-included directories found matching 'build' 06:49:20 INFO - no previously-included directories found matching 'dist' 06:49:20 INFO - no previously-included directories found matching '.git*' 06:49:20 INFO - Installing collected packages: jsonschema, functools32 06:49:20 INFO - Running setup.py install for functools32 06:49:20 INFO - warning: no files found matching '*.txt' 06:49:20 INFO - no previously-included directories found matching 'build' 06:49:20 INFO - no previously-included directories found matching 'dist' 06:49:20 INFO - no previously-included directories found matching '.git*' 06:49:20 INFO - Successfully installed jsonschema functools32 06:49:20 INFO - Cleaning up... 06:49:20 INFO - Return code: 0 06:49:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f62e6becf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9090>, '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 0x1bcc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcce40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713', '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 06:49:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:49:20 INFO - Using env: {'DISPLAY': ':0', 06:49:20 INFO - 'HOME': '/home/cltbld', 06:49:20 INFO - 'LANG': 'en_US.UTF-8', 06:49:20 INFO - 'LANGUAGE': 'en_US:en', 06:49:20 INFO - 'LOGNAME': 'cltbld', 06:49:20 INFO - 'MAIL': '/var/mail/cltbld', 06:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:20 INFO - 'MOZ_NO_REMOTE': '1', 06:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:20 INFO - 'NO_EM_RESTART': '1', 06:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:20 INFO - 'PWD': '/builds/slave/test', 06:49:20 INFO - 'SHELL': '/bin/bash', 06:49:20 INFO - 'SHLVL': '1', 06:49:20 INFO - 'TERM': 'linux', 06:49:20 INFO - 'TMOUT': '86400', 06:49:20 INFO - 'USER': 'cltbld', 06:49:20 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713', 06:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:20 INFO - '_': '/tools/buildbot/bin/python'} 06:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:49:20 INFO - Cleaning up... 06:49:20 INFO - Return code: 0 06:49:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f62e6becf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9090>, '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 0x1bcc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcce40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713', '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 06:49:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:49:20 INFO - Using env: {'DISPLAY': ':0', 06:49:20 INFO - 'HOME': '/home/cltbld', 06:49:20 INFO - 'LANG': 'en_US.UTF-8', 06:49:20 INFO - 'LANGUAGE': 'en_US:en', 06:49:20 INFO - 'LOGNAME': 'cltbld', 06:49:20 INFO - 'MAIL': '/var/mail/cltbld', 06:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:20 INFO - 'MOZ_NO_REMOTE': '1', 06:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:20 INFO - 'NO_EM_RESTART': '1', 06:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:20 INFO - 'PWD': '/builds/slave/test', 06:49:20 INFO - 'SHELL': '/bin/bash', 06:49:20 INFO - 'SHLVL': '1', 06:49:20 INFO - 'TERM': 'linux', 06:49:20 INFO - 'TMOUT': '86400', 06:49:20 INFO - 'USER': 'cltbld', 06:49:20 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713', 06:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:20 INFO - '_': '/tools/buildbot/bin/python'} 06:49:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:21 INFO - Downloading/unpacking blobuploader==1.2.4 06:49:21 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 06:49:21 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 06:49:21 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 06:49:21 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 06:49:21 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 06:49:21 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 06:49:22 INFO - Downloading blobuploader-1.2.4.tar.gz 06:49:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:49:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:49: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 06:49: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 06:49: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 06:49: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 06:49: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 06:49: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 06:49:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:49:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:49: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 06:49: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 06:49: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 06:49: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 06:49: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 06:49: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 06:49:23 INFO - Downloading docopt-0.6.1.tar.gz 06:49:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:49:23 INFO - Installing collected packages: blobuploader, requests, docopt 06:49:23 INFO - Running setup.py install for blobuploader 06:49:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:49:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:49:23 INFO - Running setup.py install for requests 06:49:24 INFO - Running setup.py install for docopt 06:49:24 INFO - Successfully installed blobuploader requests docopt 06:49:24 INFO - Cleaning up... 06:49:24 INFO - Return code: 0 06:49:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:49:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:24 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 0x7f62e6becf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9090>, '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 0x1bcc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcce40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713', '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 06:49:24 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 06:49:24 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 06:49:24 INFO - Using env: {'DISPLAY': ':0', 06:49:24 INFO - 'HOME': '/home/cltbld', 06:49:24 INFO - 'LANG': 'en_US.UTF-8', 06:49:24 INFO - 'LANGUAGE': 'en_US:en', 06:49:24 INFO - 'LOGNAME': 'cltbld', 06:49:24 INFO - 'MAIL': '/var/mail/cltbld', 06:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:24 INFO - 'MOZ_NO_REMOTE': '1', 06:49:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:24 INFO - 'NO_EM_RESTART': '1', 06:49:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:24 INFO - 'PWD': '/builds/slave/test', 06:49:24 INFO - 'SHELL': '/bin/bash', 06:49:24 INFO - 'SHLVL': '1', 06:49:24 INFO - 'TERM': 'linux', 06:49:24 INFO - 'TMOUT': '86400', 06:49:24 INFO - 'USER': 'cltbld', 06:49:24 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713', 06:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:24 INFO - '_': '/tools/buildbot/bin/python'} 06:49:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:49:24 INFO - Running setup.py (path:/tmp/pip-SxlVWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:49:24 INFO - Running setup.py (path:/tmp/pip-2xXtKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:49:24 INFO - Running setup.py (path:/tmp/pip-VU8sOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:49:24 INFO - Running setup.py (path:/tmp/pip-sjbirS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:49:24 INFO - Running setup.py (path:/tmp/pip-PnwwLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:49:25 INFO - Running setup.py (path:/tmp/pip-TOe4xH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:49:25 INFO - Running setup.py (path:/tmp/pip-4dnl9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:49:25 INFO - Running setup.py (path:/tmp/pip-K52zNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:49:25 INFO - Running setup.py (path:/tmp/pip-nS8pNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:49:25 INFO - Running setup.py (path:/tmp/pip-FwGyUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:49:25 INFO - Running setup.py (path:/tmp/pip-GIbMtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:49:25 INFO - Running setup.py (path:/tmp/pip-54dtt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:49:25 INFO - Running setup.py (path:/tmp/pip-rgfxdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:49:25 INFO - Running setup.py (path:/tmp/pip-2p61sY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:49:25 INFO - Running setup.py (path:/tmp/pip-wJwJJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:49:25 INFO - Running setup.py (path:/tmp/pip-FPbOkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:49:25 INFO - Running setup.py (path:/tmp/pip-8K0czl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:49:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:49:25 INFO - Running setup.py install for manifestparser 06:49:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:49:25 INFO - Running setup.py install for mozcrash 06:49:26 INFO - Running setup.py install for mozdebug 06:49:26 INFO - Running setup.py install for mozdevice 06:49:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:49:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:49:26 INFO - Running setup.py install for mozfile 06:49:26 INFO - Running setup.py install for mozhttpd 06:49:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:49:26 INFO - Running setup.py install for mozinfo 06:49:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:49:26 INFO - Running setup.py install for mozInstall 06:49:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:49:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:49:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:49:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:49:26 INFO - Running setup.py install for mozleak 06:49:26 INFO - Running setup.py install for mozlog 06:49:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:49:26 INFO - Running setup.py install for moznetwork 06:49:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:49:27 INFO - Running setup.py install for mozprocess 06:49:27 INFO - Running setup.py install for mozprofile 06:49:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:49:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:49:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:49:27 INFO - Running setup.py install for mozrunner 06:49:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:49:27 INFO - Running setup.py install for mozscreenshot 06:49:27 INFO - Running setup.py install for moztest 06:49:27 INFO - Running setup.py install for mozversion 06:49:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:49:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:49:27 INFO - Cleaning up... 06:49:27 INFO - Return code: 0 06:49:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:27 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 0x7f62e6becf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9090>, '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 0x1bcc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcce40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713', '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 06:49:27 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 06:49:27 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 06:49:27 INFO - Using env: {'DISPLAY': ':0', 06:49:27 INFO - 'HOME': '/home/cltbld', 06:49:27 INFO - 'LANG': 'en_US.UTF-8', 06:49:27 INFO - 'LANGUAGE': 'en_US:en', 06:49:27 INFO - 'LOGNAME': 'cltbld', 06:49:27 INFO - 'MAIL': '/var/mail/cltbld', 06:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:27 INFO - 'MOZ_NO_REMOTE': '1', 06:49:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:27 INFO - 'NO_EM_RESTART': '1', 06:49:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:27 INFO - 'PWD': '/builds/slave/test', 06:49:27 INFO - 'SHELL': '/bin/bash', 06:49:27 INFO - 'SHLVL': '1', 06:49:27 INFO - 'TERM': 'linux', 06:49:27 INFO - 'TMOUT': '86400', 06:49:27 INFO - 'USER': 'cltbld', 06:49:27 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713', 06:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:27 INFO - '_': '/tools/buildbot/bin/python'} 06:49:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:49:27 INFO - Running setup.py (path:/tmp/pip-oK2XGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:49:27 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)) 06:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:49:27 INFO - Running setup.py (path:/tmp/pip-BLzw5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:49:28 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)) 06:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:49:28 INFO - Running setup.py (path:/tmp/pip-uDZhiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:49:28 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)) 06:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:49:28 INFO - Running setup.py (path:/tmp/pip-Jsh0h_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:49:28 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)) 06:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:49:28 INFO - Running setup.py (path:/tmp/pip-38e_BT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:49:28 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)) 06:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:49:28 INFO - Running setup.py (path:/tmp/pip-pFDUpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:49:28 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)) 06:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:49:28 INFO - Running setup.py (path:/tmp/pip-oshhVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:49:28 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)) 06:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:49:28 INFO - Running setup.py (path:/tmp/pip-uYqS2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:49:28 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)) 06:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:49:28 INFO - Running setup.py (path:/tmp/pip-JkFIh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:49:28 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)) 06:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:49:28 INFO - Running setup.py (path:/tmp/pip-xAqQ51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:49:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:49:28 INFO - Running setup.py (path:/tmp/pip-KqAz4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:49:28 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)) 06:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:49:28 INFO - Running setup.py (path:/tmp/pip-96wqRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:49:28 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)) 06:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:49:28 INFO - Running setup.py (path:/tmp/pip-Phi0MJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:49:28 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)) 06:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:49:28 INFO - Running setup.py (path:/tmp/pip-YMAbot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:49:28 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)) 06:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:49:28 INFO - Running setup.py (path:/tmp/pip-YpyrIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:49:28 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)) 06:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:49:28 INFO - Running setup.py (path:/tmp/pip-ZddmOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:49:29 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)) 06:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:49:29 INFO - Running setup.py (path:/tmp/pip-UscskK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:49:29 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)) 06:49:29 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)) 06:49:29 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)) 06:49:29 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)) 06:49:29 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)) 06:49:29 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)) 06:49:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:49:29 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 06:49:29 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 06:49:29 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 06:49:29 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 06:49:29 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 06:49:29 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 06:49:30 INFO - Downloading blessings-1.6.tar.gz 06:49:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:49:31 INFO - Installing collected packages: blessings 06:49:31 INFO - Running setup.py install for blessings 06:49:31 INFO - Successfully installed blessings 06:49:31 INFO - Cleaning up... 06:49:31 INFO - Return code: 0 06:49:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:49:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:49:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:49:31 INFO - Reading from file tmpfile_stdout 06:49:31 INFO - Current package versions: 06:49:31 INFO - argparse == 1.2.1 06:49:31 INFO - blessings == 1.6 06:49:31 INFO - blobuploader == 1.2.4 06:49:31 INFO - docopt == 0.6.1 06:49:31 INFO - functools32 == 3.2.3-2 06:49:31 INFO - jsonschema == 2.5.1 06:49:31 INFO - manifestparser == 1.1 06:49:31 INFO - mozInstall == 1.12 06:49:31 INFO - mozcrash == 0.17 06:49:31 INFO - mozdebug == 0.1 06:49:31 INFO - mozdevice == 0.48 06:49:31 INFO - mozfile == 1.2 06:49:31 INFO - mozhttpd == 0.7 06:49:31 INFO - mozinfo == 0.9 06:49:31 INFO - mozleak == 0.1 06:49:31 INFO - mozlog == 3.3 06:49:31 INFO - moznetwork == 0.27 06:49:31 INFO - mozprocess == 0.23 06:49:31 INFO - mozprofile == 0.28 06:49:31 INFO - mozrunner == 6.12 06:49:31 INFO - mozscreenshot == 0.1 06:49:31 INFO - mozsystemmonitor == 0.3 06:49:31 INFO - moztest == 0.7 06:49:31 INFO - mozversion == 1.4 06:49:31 INFO - psutil == 3.1.1 06:49:31 INFO - requests == 1.2.3 06:49:31 INFO - wsgiref == 0.1.2 06:49:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:31 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 0x7f62e6becf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9090>, '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 0x1bcc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcce40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713', '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 06:49:31 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 06:49:31 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 06:49:31 INFO - Using env: {'DISPLAY': ':0', 06:49:31 INFO - 'HOME': '/home/cltbld', 06:49:31 INFO - 'LANG': 'en_US.UTF-8', 06:49:31 INFO - 'LANGUAGE': 'en_US:en', 06:49:31 INFO - 'LOGNAME': 'cltbld', 06:49:31 INFO - 'MAIL': '/var/mail/cltbld', 06:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:31 INFO - 'MOZ_NO_REMOTE': '1', 06:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:31 INFO - 'NO_EM_RESTART': '1', 06:49:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:31 INFO - 'PWD': '/builds/slave/test', 06:49:31 INFO - 'SHELL': '/bin/bash', 06:49:31 INFO - 'SHLVL': '1', 06:49:31 INFO - 'TERM': 'linux', 06:49:31 INFO - 'TMOUT': '86400', 06:49:31 INFO - 'USER': 'cltbld', 06:49:31 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713', 06:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:31 INFO - '_': '/tools/buildbot/bin/python'} 06:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:31 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)) 06:49:31 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)) 06:49:31 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)) 06:49:31 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)) 06:49:31 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)) 06:49:31 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)) 06:49:31 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)) 06:49:31 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)) 06:49:31 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)) 06:49:31 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)) 06:49:31 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)) 06:49:31 INFO - Cleaning up... 06:49:31 INFO - Return code: 0 06:49:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:31 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 0x7f62e6becf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bcf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9090>, '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 0x1bcc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcce40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713', '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 06:49:31 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 06:49:31 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 06:49:31 INFO - Using env: {'DISPLAY': ':0', 06:49:31 INFO - 'HOME': '/home/cltbld', 06:49:31 INFO - 'LANG': 'en_US.UTF-8', 06:49:31 INFO - 'LANGUAGE': 'en_US:en', 06:49:31 INFO - 'LOGNAME': 'cltbld', 06:49:31 INFO - 'MAIL': '/var/mail/cltbld', 06:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:31 INFO - 'MOZ_NO_REMOTE': '1', 06:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:31 INFO - 'NO_EM_RESTART': '1', 06:49:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:31 INFO - 'PWD': '/builds/slave/test', 06:49:31 INFO - 'SHELL': '/bin/bash', 06:49:31 INFO - 'SHLVL': '1', 06:49:31 INFO - 'TERM': 'linux', 06:49:31 INFO - 'TMOUT': '86400', 06:49:31 INFO - 'USER': 'cltbld', 06:49:31 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713', 06:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:31 INFO - '_': '/tools/buildbot/bin/python'} 06:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:49:31 INFO - Cleaning up... 06:49:31 INFO - Return code: 0 06:49:31 INFO - Running post-action listener: _resource_record_post_action 06:49:31 INFO - Running post-action listener: _start_resource_monitoring 06:49:31 INFO - Starting resource monitoring. 06:49:31 INFO - [mozharness: 2016-09-01 13:49:31.913566Z] Finished create-virtualenv step (success) 06:49:31 INFO - [mozharness: 2016-09-01 13:49:31.914072Z] Running install step. 06:49:31 INFO - Running pre-action listener: _resource_record_pre_action 06:49:31 INFO - Running main action method: install 06:49:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:49:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:49:32 INFO - Reading from file tmpfile_stdout 06:49:32 INFO - Detecting whether we're running mozinstall >=1.0... 06:49:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:49:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:49:32 INFO - Reading from file tmpfile_stdout 06:49:32 INFO - Output received: 06:49:32 INFO - Usage: mozinstall [options] installer 06:49:32 INFO - Options: 06:49:32 INFO - -h, --help show this help message and exit 06:49:32 INFO - -d DEST, --destination=DEST 06:49:32 INFO - Directory to install application into. [default: 06:49:32 INFO - "/builds/slave/test"] 06:49:32 INFO - --app=APP Application being installed. [default: firefox] 06:49:32 INFO - mkdir: /builds/slave/test/build/application 06:49:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:49:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:49:48 INFO - Reading from file tmpfile_stdout 06:49:48 INFO - Output received: 06:49:48 INFO - /builds/slave/test/build/application/firefox/firefox 06:49:48 INFO - Running post-action listener: _resource_record_post_action 06:49:48 INFO - [mozharness: 2016-09-01 13:49:48.333440Z] Finished install step (success) 06:49:48 INFO - [mozharness: 2016-09-01 13:49:48.333721Z] Running run-tests step. 06:49:48 INFO - Running pre-action listener: _resource_record_pre_action 06:49:48 INFO - Running main action method: run_tests 06:49:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:49:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:49:48 INFO - Python 2.7.3 06:49:48 INFO - Return code: 0 06:49:48 INFO - grabbing minidump binary from tooltool 06:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:48 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 0x1bc9090>, '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 0x1bcc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bcce40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:49:48 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 06:49:48 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 06:49:48 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 06:49:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:49:48 INFO - Return code: 0 06:49:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:49:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:49:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:49:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:49:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:49:48 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/K6YjdrIvSa-p3Jp4BWfgWQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 06:49:48 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/K6YjdrIvSa-p3Jp4BWfgWQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 06:49:48 INFO - Using env: {'DISPLAY': ':0', 06:49:48 INFO - 'HOME': '/home/cltbld', 06:49:48 INFO - 'LANG': 'en_US.UTF-8', 06:49:48 INFO - 'LANGUAGE': 'en_US:en', 06:49:48 INFO - 'LOGNAME': 'cltbld', 06:49:48 INFO - 'MAIL': '/var/mail/cltbld', 06:49:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:49:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:48 INFO - 'MOZ_NO_REMOTE': '1', 06:49:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:49:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:48 INFO - 'NO_EM_RESTART': '1', 06:49:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:48 INFO - 'PWD': '/builds/slave/test', 06:49:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:49:48 INFO - 'SHELL': '/bin/bash', 06:49:48 INFO - 'SHLVL': '1', 06:49:48 INFO - 'TERM': 'linux', 06:49:48 INFO - 'TMOUT': '86400', 06:49:48 INFO - 'USER': 'cltbld', 06:49:48 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713', 06:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:48 INFO - '_': '/tools/buildbot/bin/python'} 06:49:48 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/K6YjdrIvSa-p3Jp4BWfgWQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 06:49:48 INFO - mozversion application_buildid: 20160901053021 06:49:48 INFO - mozversion application_changeset: 7db02dab044ea63188daa8a1f04ab29647e3b139 06:49:48 INFO - mozversion application_display_name: Nightly 06:49:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:49:48 INFO - mozversion application_name: Firefox 06:49:48 INFO - mozversion application_remotingname: firefox 06:49:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 06:49:48 INFO - mozversion application_vendor: Mozilla 06:49:48 INFO - mozversion application_version: 51.0a1 06:49:48 INFO - mozversion platform_buildid: 20160901053021 06:49:48 INFO - mozversion platform_changeset: 7db02dab044ea63188daa8a1f04ab29647e3b139 06:49:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 06:49:48 INFO - mozversion platform_version: 51.0a1 06:49:48 INFO - using testdate: 1472737788 06:49:48 INFO - actual date: 1472737788 06:49:48 INFO - starting webserver on 'localhost:35369' 06:49:48 INFO - SUITE-START | Running 2 tests 06:49:48 INFO - TEST-START | dromaeo_css 06:49:48 INFO - operating with platform_type : linux_ 06:49:48 INFO - Initialising browser for dromaeo_css test... 06:49:48 INFO - TEST-INFO | started process 12526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpib0f_N/profile http://localhost:35369/getInfo.html) 06:49:53 INFO - PROCESS | 12526 | __metrics Screen width/height:1600/1200 06:49:53 INFO - PROCESS | 12526 | colorDepth:24 06:49:53 INFO - PROCESS | 12526 | Browser inner width/height: 1024/697 06:49:53 INFO - PROCESS | 12526 | __metrics 06:49:53 INFO - PROCESS | 12526 | 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" 06:49:53 INFO - PROCESS | 12526 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:49:54 INFO - PROCESS | 12526 | console.error: PushService: 06:49:54 INFO - PROCESS | 12526 | stateChangeProcessEnqueue: Error transitioning state 06:49:54 INFO - PROCESS | 12526 | UnknownError 06:49:54 INFO - TEST-INFO | 12526: exit 0 06:49:54 INFO - Browser initialized. 06:49:54 INFO - Running cycle 1/1 for dromaeo_css test... 06:49:54 INFO - TEST-INFO | started process 12605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpib0f_N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:50:07 INFO - PROCESS | 12605 | RSS: Main: 182558720 06:50:07 INFO - PROCESS | 12605 | 06:50:58 INFO - PROCESS | 12605 | 1472737858947 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] 06:53:11 INFO - PROCESS | 12605 | Cycle 1(1): loaded http://localhost:35369/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35369/tests/dromaeo/cssquery-ext.html) 06:53:12 INFO - PROCESS | 12605 | RSS: Main: 322183168 06:53:12 INFO - PROCESS | 12605 | 06:56:15 INFO - PROCESS | 12605 | Cycle 1(1): loaded http://localhost:35369/tests/dromaeo/cssquery-ext.html (next: http://localhost:35369/tests/dromaeo/cssquery-jquery.html) 06:56:16 INFO - PROCESS | 12605 | RSS: Main: 271695872 06:56:16 INFO - PROCESS | 12605 | 06:59:18 INFO - PROCESS | 12605 | Cycle 1(1): loaded http://localhost:35369/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35369/tests/dromaeo/cssquery-mootools.html) 06:59:19 INFO - PROCESS | 12605 | RSS: Main: 220405760 06:59:19 INFO - PROCESS | 12605 | 07:02:21 INFO - PROCESS | 12605 | Cycle 1(1): loaded http://localhost:35369/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35369/tests/dromaeo/cssquery-prototype.html) 07:02:21 INFO - PROCESS | 12605 | RSS: Main: 229482496 07:02:21 INFO - PROCESS | 12605 | 07:05:25 INFO - PROCESS | 12605 | Cycle 1(1): loaded http://localhost:35369/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35369/tests/dromaeo/cssquery-yui.html) 07:05:25 INFO - PROCESS | 12605 | RSS: Main: 220635136 07:05:25 INFO - PROCESS | 12605 | 07:08:28 INFO - PROCESS | 12605 | Cycle 1(1): loaded http://localhost:35369/tests/dromaeo/cssquery-yui.html (next: http://localhost:35369/tests/dromaeo/cssquery-dojo.html) 07:08:29 INFO - PROCESS | 12605 | RSS: Main: 312090624 07:08:29 INFO - PROCESS | 12605 | 07:08:29 INFO - PROCESS | 12605 | __start_tp_report 07:08:29 INFO - PROCESS | 12605 | _x_x_mozilla_page_load 07:08:29 INFO - PROCESS | 12605 | _x_x_mozilla_page_load_details 07:08:29 INFO - PROCESS | 12605 | |i|pagename|runs| 07:08:29 INFO - PROCESS | 12605 | |0;dojo.html;2566.1531694540804;2580.778872155221;2585.1210588399945;2607.1657069737694;2650.522905876943;4600.976995115024;4631.953680463194;4657.883552911179;4700.012997270573;4759.119562880869;4630.652701047418;4650.744299039257;4673.439187297529;4679.110968915904;4711.151992641332;4263.3178691409385;4286.828526858922;4345.087531618364;4412.735235885841;4424.159409712144;4320.503142138663;4353.521112677603;4368.322909948963;4385.627221686144;4413.514513403523;4207.200631879933;4231.91536169278;4240.597143271415;4277.572242775728;4311.547287534827;4293.957060429419;4331.3936048952855;4374.081442896995;4389.495208051083;4435.955640443586;4258.297380932143;4276.422682937795;4279.550647182032;4364.10535840152;4415.712978656377;4683.578477936968;4748.762561871893;4750.5249475052215;4808.687435316729;4810.567048965575;4875.268709693539;5006.649534532584;5035.0685123252315;5041.697498150123;5055.317532133152;5097.515736005111;5106.9489305106845;5109.514596113363;5110.207917772751;5169.56058735008;4727.290906364073;4753.904921901542;4766.475687674353;4769;4823.517648235148;5033.320501732219;5079.568236699848;5134.794608215704;5142.382914050338;5210.817621383233;4927;4945.67853089548;4948.950510494849;4950.059488697136;5001.524855138756;5022.6233032522705;5025.170846810309;5025.271335656309;5036.974815125901;5084.872878178076;4775.71345719258;4938.481459446706;4967.3542439482635;4977.203647416396;4979.278004689372;4936.086823937583;4937.382827146606;4943.629227807857;4955.975220123948;5001;4290.678199135077;4292.3561465780385;4295.613394794421;4335.981044454551;4354.4992325882295;3706.4069748840056;3711.7030637548933;3712.777233366007;3721.0883333582906;3798.6011468795377;4352.325389564622;4365.323374876899;4373.956260437419;4406.052698669801;4423.579759922803;5040.49595040493;5070.518300761421;5073;5075.949240507622;5128.666636668605;4306.009617787926;4329.545397733255;4369.60673539383;4374.58441448062;4422.75674837887;4523.909521809611;4539.773011349419;4556.863294101182;4614.676972611952;4619.769011549409;4779.187538118528;4780.760961951819;4781.091592597395;4784.162771514902;4843.951560484491;4891.095147397743;5062.063518249136;5070.4929507049;5075.949240507695;5079.390473143247;4826.034793041476;4829.517048295143;4830.879228019187;4901.803927842846;4906.754662266943;5020.146575082318;5023.4725353838785;5024.547790698854;5031;5097.260897169964;4880.463149053672;4924.655274130777;5107.284980102863;5117.5394214520875;5180.922286165635;4846.781894814812;4871.074495845778;4887.951120488749;4934.457209707001;4960.355153829979;4968.329275547755;4972.229304457815;4977.751112444435;4983.775730092082;5029.094762942559;4861.732604706775;4868.026394720999;4873.342098816756;4877.975610121926;4921.064997650435;4784.6889952153;4898.21628539432;4943.110240156806;4952.232403977389;5033.697978121324;4839.5402436769855;4859.149648811514;4859.586935110555;4909.3372394727685;4915.655904086822 07:08:29 INFO - PROCESS | 12605 | |1;ext.html;570.5350139636196;574.3251679276849;575.2895174459542;575.602834044509;581.453433772254;26366.604500932477;29277;29293.560596591014;29315.560266595992;29319.267018324525;30386.544201836936;38480.230395392144;39785.801070994676;39895;43915.78042109793;7701.075870895486;7833.099193592724;7836.2947334739865;7841.098273698541;7841.725539606115;7668.156502784689;7763.767086987399;7765.339946104588;7771.727989520368;7776.339011184056;7234;7401.962990185041;7404.2595740425795;7535.095788505359;7619;9654.806903861918;9929.65246216379;9943.105120539114;10373.84439233412;10383.065524102867;9806.90193098067;9887.703368898945;9888.555015024342;9894.851577226347;9902.950485247527;36872.63127368745;37205.81397092997;37222.62777372219;37253.44119838205;37261.44107838385;3002.384511175204;3009.5034319337283;3013.547967804825;3079.7690173237097;3263.282077942849;27533.449331013468;28344.574831377548;28707;28722.281942951384;28729;3314.4034073866696;3337.132345590164;3348.3972884880714;3513.1919658478437;3521.366154092262;258488;261081;261128.6943565289;261178;261602;30384.69615303863;52259.47740522622;52548;52706.682332941986;52720;30760.53859192114;33299.66700333014;33318.666813331554;33362.332753344795;33368.3326333472;13761.931190343985;14033.508827191203;14043.648908777363;14049.157050576998;14055.43778248879;11496.137789665641;11744.530218791153;11757.000654944255;11759.353235572125;11765.294082355085;7714.652840622185;7763.340116090083;7765.983953754876;7831.216878312237;7850.960745196352;2818.1404671574956;2953.1140657802575;2991.446582382266;3007.9248018799703;3012.2619958109967;770.5915864591664;885.93798434109;899.1817446123996;912.9543522823965;922.1516205091198;25871.741282586932;27993.58009629857;28756.137315880558;28800;28815.135545933656;901.2024358442694;946.9005754395827;956.8950098372339;958.91849192818;1020.6325722739808;14645.414183432544;14958.925205373904;15012.871460348491;15023.323950422257;15130.924345378422;372159;375388;376431;376565;377484;48861.75569122132;49331.75334123378;49551.256731149064;49588.25617615739;49591.50408495941;1062.9255952083436;1130.2257953302014;1171.7597892432032;1174.365842445087;1176.153169717836;27101;28373.858130709214;29340.70659293465;29507.114786556438;29557.704422956354;40809.79595102005;49000;49877.50122498729;50025;56302.43697562972;259921;262020;262740;371891;372075;37186;38379.616203837606;38923.22153556856;41688.58311416847;41949.370759438025;42242.57757422386;42485.78757106195;42489.575104248564;42620.360694588984;42651;35685.28629427449;35967.64032359643;36014.8199259002;36274.27451450904;36486.087847802955;35474;35902;36075.819620901726;36195.63804361923;36476.27047459089;35561;35613.465798012534;35683.643163568035;35942.8202858984;35995.82002089973;31413.371732564763;32520.67479325271;32530.698772048854;32916.50625240576;33214.335713286084;25276.368090797878;25400.237992860242;25479.23562293134;25550.616740748534;25605 07:08:29 INFO - PROCESS | 12605 | |2;jquery.html;331.163811376275;358.6646485536024;360.1410635634012;363.8053641301903;381.69464428457246;12524.686882827933;15847.128407937573;15901.920490397546;16629.66740665186;17754.46736597901;16603.750943735853;16631.251593678284;16677.66644667106;16798.916005419986;16984.4055458059;4980.800767969277;5150.845474635767;5220.608454365938;5430.321209848769;5470.5350045246205;3470.7743996640265;3634.890953271406;5476;5513.338399392079;5515.420880807517;3681.6134305897895;3687.465317528957;4955.909699866023;6910.861782764342;6913.619750913697;6793.320667933217;6901.137357830271;6969;6970.013546139377;6973.093497845273;6771.4582833373215;6806.693698783567;6812.386885180357;6814.1482314710665;6814.863702725967;20986.16055357784;22498;22665.546689066126;23380.532389352287;23490.060397584075;1964.6365422396902;1990.3133418970576;2010.6883433067899;2086.3636590839787;2165.588538177757;13459.86540134596;14394.136351818925;14573.271336433136;15182.45840268305;15285.082895026222;1836.9540761481069;1851.2965073272205;1872.17624245333;1901.5056085417752;1911.3214808742835;51503.74248128735;74562.25437745608;76547.6172619139;78098.60950695266;78939;14410.81210764124;15732.764008539882;16449.177541122895;16786.32854685799;16792.83207167937;27820.30449238785;27838.860805696248;27850.303742406602;27903.023394181106;28002.5799613006;9091.636334546676;9144.725658230263;9335.953320233355;9510.619575217052;9536.046395360547;7631.732889348847;7688.654010569538;7746.728864489716;7883.6058197089915;7997.5601341925585;8091.1504292048485;8272.958635206905;8363.540005299767;8401;8460.703875364332;3104.7516198704047;3172.809631422076;3209.935801283961;3216.7426605871474;3335.1495368681317;769.8037000564821;806.3106044332129;815.2214635023657;822.8765685147156;832.9791755206047;15692.607684807972;16153.676926461405;16835.494935151964;16976.32094716222;17626.647467050843;829.9460535065201;837.1126605797874;837.9455335403179;882.1839798186652;904.9818953677113;9170;9499.525023748924;9734.97782732817;9809.411435313761;9951.104400603981;392715.1456970902;398061;410708;411426;413955;77472.2252777465;81611.18388816036;84103.38449232542;84502.57748711217;84634;416.94162817205614;905.1355955062899;921.2583869984593;925.4493576322078;931.3108299858192;9585.36402489321;9672.177864881563;10081.14310283634;10222.948885255526;10462.006109419593;34848.82575587106;37113.814430927676;37998.810005949796;38410.231795363376;38960.220795583366;50905.49094509156;51209.48790512047;51348.22977655263;51838.77934647867;52407;7567.659455324413;7758.495697779626;7786.221377862168;7905;8212.096669366485;11769.705757356134;12100.515979360727;12113.212641178296;12290.877091228973;12338.50645974187;9797.608095676092;9817.85273220888;9823.21414286841;9865.210783137476;10915;9903.950480247553;10308.845367319645;10481.790364192826;10672;10727.678169654922;10538.156947444339;10555;10600.787984240118;10807.891921080689;10870.510827012962;7605.88591171144;7657.4256930731535;7853.725119620786;7906.841863162819;8163.265306122477;8953.865692014755;10335.431551264752;10435.530401131815;10500.26498145153;10838.729031773953 07:08:29 INFO - PROCESS | 12605 | |3;mootools.html;1214.3503225774214;1300.2523548959348;1361.863813618638;1371.7667996440605;1605.831387704291;7090.078289822322;7443.776686699394;7477.775666729994;7479.738209162673;7622.199669034755;7303.415726741861;7476.588787616679;7658.808529786758;7660.042494688164;7663.386929045677;2128.9574208515783;2163.56728654269;2164.77269886662;2168.4253672776726;2183.879886606236;2117.216629846951;2158.104386679526;2171.5005548723802;2175.445261458326;2179.6294629912954;2103.842211834111;2122.0556852200775;2123.4160605833363;2128.829693624514;2129.307974908161;2097.8216851567636;2104.2635077722825;2104.305579158874;2105.842061845368;2107.146605624709;2044.9182032718672;2096.172012055245;2096.4549217203635;2097.6958341040618;2103.1272022110957;7334.3032411920785;7591.316781489637;7633;7676.539407635504;7691.192424795372;4400.933985990213;4591.724496530219;4606.216943119678;4610.700304480198;4612.630989520831;2815.7043510431313;2988.7310142087317;2995.4757917364373;3012.834294113823;3023.4557779599663;956.5217391304348;961.1445813226235;978.1636700621009;991.6975322526627;995.3082607587729;10075.294729368947;10266.281360304782;10309.020643038899;10312.793744125076;10320;4092.9795351023054;4231.301835197158;4254.808533615995;4261.573842615714;4300.591443812833;8795.51624660637;8836.867446988172;8840.381173317806;8847.911520884709;8848.20366167048;4539.477960034638;4539.500654927955;4540.364348991144;4543.000539881221;4544.636429085665;3509.6139424663265;3692.2615476904725;4138.751674899516;4151.813168407429;4153.460050193516;3598.47822065799;3660.359437098497;3726.1802403471193;3729.328720830222;3738.1962877981364;1170.5142365918218;1182.6806762174165;1191.2078467818803;1194.808830587102;1209.838554987222;724.4457989637931;757.6969212315008;764.5107131435885;776.7630872583916;803.3171803966699;4798.49615790344;4862.416510018749;4902.852914412573;4994.425641051325;5166.044281807803;408.12864534219653;417.0595307581445;419.0383070852401;420.2225882118118;423.5425740200576;3197.2486465680545;3311.65227651098;3313.4532802087388;3366.360391525602;3382.8308584570673;9123.863142052875;9171.40385874916;9439.669611563562;9542.809143817223;9556;9422.717318480456;9425.62297508092;9428.340016198801;9431.434113953184;9439.197668198143;6637.137172167684;6850.280720524373;6906.447484201352;7061.435085193172;7145.214026457085;5035.773390197523;5189.273501709688;5222.712750798591;5265.578753699619;5319.893602128013;8354.58227088631;8522.10517895612;8677.305815534615;8739.519326437106;8796.780080498038;8577.485350878967;8704.042555318783;8825.293976481738;8840.336974726793;8949.239314658067;6468.741250349934;6578.5395022347975;6603.867922641616;6652;6656.36764507371;7144.892826607501;7173.1392232932385;7236.493445458767;7240.203577606564;7268.563886166847;6341.270753863365;6360.522960778053;6369.20384951881;6413.005984072476;6591.868162636816;6418.679066046772;6466.741330346734;6472.579282346821;6475.352464753487;6514.315996820455;6030.7286172121485;6143.293521245114;6146.877062458815;6148.077788331786;6149.7847575334645;4081.8979525510913;4144.772037537964;4263.637590804692;4271.423357846776;4373.781310934377;4082.326416141422;4146.253674338648;4165.354370072643;4236.872893813191;4401.735895846259 07:08:29 INFO - PROCESS | 12605 | |4;prototype.html;282.83595514601546;298.1368936927595;299.86056483735075;303.7038887085092;303.9817610943342;4562.863114106573;4671.976640116799;4711.764411779414;4761.405034256334;4778.808847646094;4520.412346394973;4616.515265897083;4645.210314246586;4654.674172807905;4684.929726054112;3749.343864823659;3751.0997360633387;3754.755940863835;3757.6993840492833;3765.171662234311;3582.3730847101783;3614.548181477315;3758.3422900992355;3769.9623003769884;3775.7168212384045;3680.5215322008103;3681.4293784463316;3702.3520883845354;3731.8134093295225;3740.8129593520353;3694.3165514379657;3705.6294370562728;3708.1841994761107;3712.888613341577;3727.832247548853;3273.8035717857006;3281.8851340202978;3284.8193349365774;3289.588801399825;3291.3175761754333;4489.483709373431;4544.954550454486;4564.954350456519;4575.679702420832;4601.148787474328;4238.114039252534;4242.893927651802;4243.787810609457;4256.404103425523;4281.807318670667;4926.96533727914;4933.407991041098;4953.331300274489;4962.255661650745;4981.526754958273;3550.6449355064547;3649.580298265707;3660.597334293252;3678;3679.9448008279896;5112.134071064072;5134.358205224347;5135.6148288878485;5144.871378215537;5170.819021334273;3718.3492888744363;3720.776753394805;3727.2545490901384;3734.477173195755;3736.813963831189;3780.3006443807985;3780.6030366811638;3781.8087302499625;3801.030737162061;3817.8091095445116;4154.709170358046;4215.367694845798;4216.810243539048;4267.487901451846;4294.74231546102;4887.169181239198;4889.608831293488;4908.288298196741;4922;4930.506949305112;1237.3256575166556;1271.1483306184878;1291.1284882704324;1302.8306320178317;1312.7266551445082;896.1083721696954;905.1039470923738;920.9815803684023;926.6988228825659;928.2898582584328;4366.825326986948;4375.47494300686;4379.868603941887;4382.167388196232;4385.846495372711;5021.6735912165595;5028.5977121830165;5038.899222015539;5064.848054558369;5065.175792276881;4335.921495738061;4348.391225228471;4350.2387082260475;4382.6055654991205;4384.4519435070615;2238.4851484158735;2349.729781075164;2359.5162991586685;2379.2862141357523;2392.8205384596226;4278.775036980815;4289.613934745826;4293.97853010733;4299.269124248885;4300.8709738707885;4548.727076375428;4563.748993805306;4571.3600095986585;4575.611073058827;4589.269384716089;4129.793510324532;4182.414461975326;4239.38528913312;4276.40130381753;4295.926018495376;4407.7796110195;4423.8497990522055;4426.3803067569925;4450.6439484841785;4457.554244575516;4338.58783415575;4350.58669426404;4354.390385345991;4365.956340436682;4384.364267181177;4211.894702632336;4258.446401967724;4264.251656820688;4540.545945405565;4876.951230487792;3625.4380571011534;3628.6008539060153;3641.16253261746;3645.54430696163;3654.6528079832374;4865.756712164307;5088.262201980618;5122.846314610568;5131.255967884561;5143.2285157225215;4781.258904869751;4935.111679897653;4954.851354459372;4977.576905963034;4986.576141027908;4946.950530494793;4947.727874966911;4977.805326721488;4981.875453113701;4985.9087365831965;4747.667663263538;4792.013311148004;4869.780859861244;4888.413390393033;4889.657723959289;4972.179590367549;4984.875378115431;4999.750012499288;5005.974970125126;5016.272640467038;4865.83220027198;4885.364902562644;4891.584215341736;4894.657373983787;4899.975500122477 07:08:29 INFO - PROCESS | 12605 | |5;yui.html;590.2209084009107;628.230417738271;666.733306677329;678.8574399376131;689.3347919257915;11500.884991150086;11861.110416718748;11866.82199767002;11881.584144554943;11900.40497975101;13022.739545209113;13382.197068175916;13400.061995660308;13891.305434728274;13974.650633734162;726.789231122975;747.7980945144808;752.732779863149;753.1113286322137;753.2091304130641;595.315387304601;720.6901032555999;747.2602123897357;750.7672621487357;754.9622518874035;779.8947142135825;780.1145699630931;781.2617076862367;782.1083964280724;782.2685788787473;777.2732495117084;777.4518964130275;777.5801067423585;777.871651177555;778.2567647896245;459.94710608280144;541.5992165797281;555.0176188146958;558.2101326622824;568.9203511508392;11422.25755325901;11453.141014423869;11463.140264480115;11463.885361146366;11469.827952580717;11032.834507482394;11436.656900293005;11691.76616467666;11798.587049453314;12325.445354959049;11218.551257949672;11302.208845380826;11348.829767553494;11536.711582210428;11578.247413918069;3948.170884114311;3986.621270979252;3996.620321069494;4007.97996010021;4018.0557568971267;63154.0526892097;63612.68193659048;64446;64488;67486.32513674899;9423.811523769486;9501.762455938519;9767.218622510181;9925.057119573628;9972.850407243897;17752.91123544374;17871.910640446713;18005.099745012696;18058.187381567863;18088.819111808978;6438.77464288757;6518.902216466757;6523;6545.672716364163;6622.536422450478;3595.9280814383565;3624.800635965047;3628.818559072036;3630.09247688078;3641.7450778445254;2774.2232174991036;2841.0624493916957;2868.3976364963173;2870.2106920596584;2871.956920646192;475.11628371229483;476.7258826174894;485.61393692014934;486.45031114840003;490.7521701540699;494.0834751535849;506.4960364437408;516.5635038392552;522.1280461629088;545.3319683387818;6773.491988100814;6840.144981877265;7025.086738723933;7071.151461824614;7099.787006389816;432.68846430569937;452.8482958208971;474.7294042395801;532.5074306266688;570.3042288408218;3204.9359012819614;3287.4411350070545;3295.719863811603;3352.5138854866395;3416.777909435879;99046.50476747715;105432;106437;108502;108702;50012.499875001515;50315;85347.57326213454;87998;88419.55790221007;76396.61801690956;78266;79044;79460;81809.59095204486;6596.30738772422;6688.933110668831;6733.562318449285;6788.660566971533;6817.795466136024;38505;46810.29784553302;47506.52493475021;47609;50670.74664626801;39541.80229098836;51485;57535.1369729446;59439.70280148571;62012.37987620066;11077.612283570037;11142.27575207609;11326.093912487146;11698.181127321006;12048.879511205127;12278.263304201419;12547.623571292876;12568.748625027265;13449.394777235244;13562.660933476742;10375.94812025935;11701.473433695333;12372;12686.429110689856;12751.553695620609;11258.718532036764;11419.429028548706;11790.705232369259;12063.577774777841;12075;11325;11554.191206615793;11937.16439849237;12566.371681416076;12571.245725256515;9140.725778226664;9180.954095229481;9506.667266645634;9786.60853565878;9811.411315321104;8245.876311855447;8523.318134549098;8969.551522423983;9163.587638556415;9787.951060244653 07:08:29 INFO - PROCESS | 12605 | __end_tp_report 07:08:29 INFO - PROCESS | 12605 | __start_cc_report 07:08:29 INFO - PROCESS | 12605 | _x_x_mozilla_cycle_collect,1305 07:08:29 INFO - PROCESS | 12605 | __end_cc_report 07:08:29 INFO - PROCESS | 12605 | __startTimestamp1472738909111__endTimestamp 07:08:29 INFO - PROCESS | 12605 | 07:08:29 INFO - PROCESS | 12605 | ------- Summary: start ------- 07:08:29 INFO - PROCESS | 12605 | Number of tests: 6 07:08:29 INFO - PROCESS | 12605 | 07:08:29 INFO - PROCESS | 12605 | [#0] dojo.html Cycles:165 Average:4666.93 Median:4829.52 stddev:493.19 (10.2%) stddev-sans-first:466.36 07:08:29 INFO - PROCESS | 12605 | Values: 2566.2 2580.8 2585.1 2607.2 2650.5 4601.0 4632.0 4657.9 4700.0 4759.1 4630.7 4650.7 4673.4 4679.1 4711.2 4263.3 4286.8 4345.1 4412.7 4424.2 4320.5 4353.5 4368.3 4385.6 4413.5 4207.2 4231.9 4240.6 4277.6 4311.5 4294.0 4331.4 4374.1 4389.5 4436.0 4258.3 4276.4 4279.6 4364.1 4415.7 4683.6 4748.8 4750.5 4808.7 4810.6 4875.3 5006.6 5035.1 5041.7 5055.3 5097.5 5106.9 5109.5 5110.2 5169.6 4727.3 4753.9 4766.5 4769.0 4823.5 5033.3 5079.6 5134.8 5142.4 5210.8 4927.0 4945.7 4949.0 4950.1 5001.5 5022.6 5025.2 5025.3 5037.0 5084.9 4775.7 4938.5 4967.4 4977.2 4979.3 4936.1 4937.4 4943.6 4956.0 5001.0 4290.7 4292.4 4295.6 4336.0 4354.5 3706.4 3711.7 3712.8 3721.1 3798.6 4352.3 4365.3 4374.0 4406.1 4423.6 5040.5 5070.5 5073.0 5075.9 5128.7 4306.0 4329.5 4369.6 4374.6 4422.8 4523.9 4539.8 4556.9 4614.7 4619.8 4779.2 4780.8 4781.1 4784.2 4844.0 4891.1 5062.1 5070.5 5075.9 5079.4 4826.0 4829.5 4830.9 4901.8 4906.8 5020.1 5023.5 5024.5 5031.0 5097.3 4880.5 4924.7 5107.3 5117.5 5180.9 4846.8 4871.1 4888.0 4934.5 4960.4 4968.3 4972.2 4977.8 4983.8 5029.1 4861.7 4868.0 4873.3 4878.0 4921.1 4784.7 4898.2 4943.1 4952.2 5033.7 4839.5 4859.1 4859.6 4909.3 4915.7 07:08:29 INFO - PROCESS | 12605 | 07:08:29 INFO - PROCESS | 12605 | [#1] ext.html Cycles:180 Average:46208.18 Median:35981.73 stddev:84075.12 (233.7%) stddev-sans-first:84241.15 07:08:29 INFO - PROCESS | 12605 | Values: 570.5 574.3 575.3 575.6 581.5 26366.6 29277.0 29293.6 29315.6 29319.3 30386.5 38480.2 39785.8 39895.0 43915.8 7701.1 7833.1 7836.3 7841.1 7841.7 7668.2 7763.8 7765.3 7771.7 7776.3 7234.0 7402.0 7404.3 7535.1 7619.0 9654.8 9929.7 9943.1 10373.8 10383.1 9806.9 9887.7 9888.6 9894.9 9903.0 36872.6 37205.8 37222.6 37253.4 37261.4 3002.4 3009.5 3013.5 3079.8 3263.3 27533.4 28344.6 28707.0 28722.3 28729.0 3314.4 3337.1 3348.4 3513.2 3521.4 258488.0 261081.0 261128.7 261178.0 261602.0 30384.7 52259.5 52548.0 52706.7 52720.0 30760.5 33299.7 33318.7 33362.3 33368.3 13761.9 14033.5 14043.6 14049.2 14055.4 11496.1 11744.5 11757.0 11759.4 11765.3 7714.7 7763.3 7766.0 7831.2 7851.0 2818.1 2953.1 2991.4 3007.9 3012.3 770.6 885.9 899.2 913.0 922.2 25871.7 27993.6 28756.1 28800.0 28815.1 901.2 946.9 956.9 958.9 1020.6 14645.4 14958.9 15012.9 15023.3 15130.9 372159.0 375388.0 376431.0 376565.0 377484.0 48861.8 49331.8 49551.3 49588.3 49591.5 1062.9 1130.2 1171.8 1174.4 1176.2 27101.0 28373.9 29340.7 29507.1 29557.7 40809.8 49000.0 49877.5 50025.0 56302.4 259921.0 262020.0 262740.0 371891.0 372075.0 37186.0 38379.6 38923.2 41688.6 41949.4 42242.6 42485.8 42489.6 42620.4 42651.0 35685.3 35967.6 36014.8 36274.3 36486.1 35474.0 35902.0 36075.8 36195.6 36476.3 35561.0 35613.5 35683.6 35942.8 35995.8 31413.4 32520.7 32530.7 32916.5 33214.3 25276.4 25400.2 25479.2 25550.6 25605.0 07:08:29 INFO - PROCESS | 12605 | 07:08:29 INFO - PROCESS | 12605 | [#2] jquery.html Cycles:180 Average:25892.50 Median:207185.97 stddev:66912.24 (32.3%) stddev-sans-first:67072.42 07:08:29 INFO - PROCESS | 12605 | Values: 331.2 358.7 360.1 363.8 381.7 12524.7 15847.1 15901.9 16629.7 17754.5 16603.8 16631.3 16677.7 16798.9 16984.4 4980.8 5150.8 5220.6 5430.3 5470.5 3470.8 3634.9 5476.0 5513.3 5515.4 3681.6 3687.5 4955.9 6910.9 6913.6 6793.3 6901.1 6969.0 6970.0 6973.1 6771.5 6806.7 6812.4 6814.1 6814.9 20986.2 22498.0 22665.5 23380.5 23490.1 1964.6 1990.3 2010.7 2086.4 2165.6 13459.9 14394.1 14573.3 15182.5 15285.1 1837.0 1851.3 1872.2 1901.5 1911.3 51503.7 74562.3 76547.6 78098.6 78939.0 14410.8 15732.8 16449.2 16786.3 16792.8 27820.3 27838.9 27850.3 27903.0 28002.6 9091.6 9144.7 9336.0 9510.6 9536.0 7631.7 7688.7 7746.7 7883.6 7997.6 8091.2 8273.0 8363.5 8401.0 8460.7 3104.8 3172.8 3209.9 3216.7 3335.1 769.8 806.3 815.2 822.9 833.0 15692.6 16153.7 16835.5 16976.3 17626.6 829.9 837.1 837.9 882.2 905.0 9170.0 9499.5 9735.0 9809.4 9951.1 392715.1 398061.0 410708.0 411426.0 413955.0 77472.2 81611.2 84103.4 84502.6 84634.0 416.9 905.1 921.3 925.4 931.3 9585.4 9672.2 10081.1 10222.9 10462.0 34848.8 37113.8 37998.8 38410.2 38960.2 50905.5 51209.5 51348.2 51838.8 52407.0 7567.7 7758.5 7786.2 7905.0 8212.1 11769.7 12100.5 12113.2 12290.9 12338.5 9797.6 9817.9 9823.2 9865.2 10915.0 9904.0 10308.8 10481.8 10672.0 10727.7 10538.2 10555.0 10600.8 10807.9 10870.5 7605.9 7657.4 7853.7 7906.8 8163.3 8953.9 10335.4 10435.5 10500.3 10838.7 07:08:29 INFO - PROCESS | 12605 | 07:08:29 INFO - PROCESS | 12605 | [#3] mootools.html Cycles:180 Average:4965.37 Median:4830.46 stddev:2799.21 (57.9%) stddev-sans-first:2792.87 07:08:29 INFO - PROCESS | 12605 | Values: 1214.4 1300.3 1361.9 1371.8 1605.8 7090.1 7443.8 7477.8 7479.7 7622.2 7303.4 7476.6 7658.8 7660.0 7663.4 2129.0 2163.6 2164.8 2168.4 2183.9 2117.2 2158.1 2171.5 2175.4 2179.6 2103.8 2122.1 2123.4 2128.8 2129.3 2097.8 2104.3 2104.3 2105.8 2107.1 2044.9 2096.2 2096.5 2097.7 2103.1 7334.3 7591.3 7633.0 7676.5 7691.2 4400.9 4591.7 4606.2 4610.7 4612.6 2815.7 2988.7 2995.5 3012.8 3023.5 956.5 961.1 978.2 991.7 995.3 10075.3 10266.3 10309.0 10312.8 10320.0 4093.0 4231.3 4254.8 4261.6 4300.6 8795.5 8836.9 8840.4 8847.9 8848.2 4539.5 4539.5 4540.4 4543.0 4544.6 3509.6 3692.3 4138.8 4151.8 4153.5 3598.5 3660.4 3726.2 3729.3 3738.2 1170.5 1182.7 1191.2 1194.8 1209.8 724.4 757.7 764.5 776.8 803.3 4798.5 4862.4 4902.9 4994.4 5166.0 408.1 417.1 419.0 420.2 423.5 3197.2 3311.7 3313.5 3366.4 3382.8 9123.9 9171.4 9439.7 9542.8 9556.0 9422.7 9425.6 9428.3 9431.4 9439.2 6637.1 6850.3 6906.4 7061.4 7145.2 5035.8 5189.3 5222.7 5265.6 5319.9 8354.6 8522.1 8677.3 8739.5 8796.8 8577.5 8704.0 8825.3 8840.3 8949.2 6468.7 6578.5 6603.9 6652.0 6656.4 7144.9 7173.1 7236.5 7240.2 7268.6 6341.3 6360.5 6369.2 6413.0 6591.9 6418.7 6466.7 6472.6 6475.4 6514.3 6030.7 6143.3 6146.9 6148.1 6149.8 4081.9 4144.8 4263.6 4271.4 4373.8 4082.3 4146.3 4165.4 4236.9 4401.7 07:08:29 INFO - PROCESS | 12605 | 07:08:29 INFO - PROCESS | 12605 | [#4] prototype.html Cycles:180 Average:4026.00 Median:4371.15 stddev:1142.40 (26.1%) stddev-sans-first:1110.52 07:08:29 INFO - PROCESS | 12605 | Values: 282.8 298.1 299.9 303.7 304.0 4562.9 4672.0 4711.8 4761.4 4778.8 4520.4 4616.5 4645.2 4654.7 4684.9 3749.3 3751.1 3754.8 3757.7 3765.2 3582.4 3614.5 3758.3 3770.0 3775.7 3680.5 3681.4 3702.4 3731.8 3740.8 3694.3 3705.6 3708.2 3712.9 3727.8 3273.8 3281.9 3284.8 3289.6 3291.3 4489.5 4545.0 4565.0 4575.7 4601.1 4238.1 4242.9 4243.8 4256.4 4281.8 4927.0 4933.4 4953.3 4962.3 4981.5 3550.6 3649.6 3660.6 3678.0 3679.9 5112.1 5134.4 5135.6 5144.9 5170.8 3718.3 3720.8 3727.3 3734.5 3736.8 3780.3 3780.6 3781.8 3801.0 3817.8 4154.7 4215.4 4216.8 4267.5 4294.7 4887.2 4889.6 4908.3 4922.0 4930.5 1237.3 1271.1 1291.1 1302.8 1312.7 896.1 905.1 921.0 926.7 928.3 4366.8 4375.5 4379.9 4382.2 4385.8 5021.7 5028.6 5038.9 5064.8 5065.2 4335.9 4348.4 4350.2 4382.6 4384.5 2238.5 2349.7 2359.5 2379.3 2392.8 4278.8 4289.6 4294.0 4299.3 4300.9 4548.7 4563.7 4571.4 4575.6 4589.3 4129.8 4182.4 4239.4 4276.4 4295.9 4407.8 4423.8 4426.4 4450.6 4457.6 4338.6 4350.6 4354.4 4366.0 4384.4 4211.9 4258.4 4264.3 4540.5 4877.0 3625.4 3628.6 3641.2 3645.5 3654.7 4865.8 5088.3 5122.8 5131.3 5143.2 4781.3 4935.1 4954.9 4977.6 4986.6 4947.0 4947.7 4977.8 4981.9 4985.9 4747.7 4792.0 4869.8 4888.4 4889.7 4972.2 4984.9 4999.8 5006.0 5016.3 4865.8 4885.4 4891.6 4894.7 4900.0 07:08:29 INFO - PROCESS | 12605 | 07:08:29 INFO - PROCESS | 12605 | [#5] yui.html Cycles:180 Average:17432.16 Median:486.03 stddev:25664.68 (5280.5%) stddev-sans-first:25705.52 07:08:29 INFO - PROCESS | 12605 | Values: 590.2 628.2 666.7 678.9 689.3 11500.9 11861.1 11866.8 11881.6 11900.4 13022.7 13382.2 13400.1 13891.3 13974.7 726.8 747.8 752.7 753.1 753.2 595.3 720.7 747.3 750.8 755.0 779.9 780.1 781.3 782.1 782.3 777.3 777.5 777.6 777.9 778.3 459.9 541.6 555.0 558.2 568.9 11422.3 11453.1 11463.1 11463.9 11469.8 11032.8 11436.7 11691.8 11798.6 12325.4 11218.6 11302.2 11348.8 11536.7 11578.2 3948.2 3986.6 3996.6 4008.0 4018.1 63154.1 63612.7 64446.0 64488.0 67486.3 9423.8 9501.8 9767.2 9925.1 9972.9 17752.9 17871.9 18005.1 18058.2 18088.8 6438.8 6518.9 6523.0 6545.7 6622.5 3595.9 3624.8 3628.8 3630.1 3641.7 2774.2 2841.1 2868.4 2870.2 2872.0 475.1 476.7 485.6 486.5 490.8 494.1 506.5 516.6 522.1 545.3 6773.5 6840.1 7025.1 7071.2 7099.8 432.7 452.8 474.7 532.5 570.3 3204.9 3287.4 3295.7 3352.5 3416.8 99046.5 105432.0 106437.0 108502.0 108702.0 50012.5 50315.0 85347.6 87998.0 88419.6 76396.6 78266.0 79044.0 79460.0 81809.6 6596.3 6688.9 6733.6 6788.7 6817.8 38505.0 46810.3 47506.5 47609.0 50670.7 39541.8 51485.0 57535.1 59439.7 62012.4 11077.6 11142.3 11326.1 11698.2 12048.9 12278.3 12547.6 12568.7 13449.4 13562.7 10375.9 11701.5 12372.0 12686.4 12751.6 11258.7 11419.4 11790.7 12063.6 12075.0 11325.0 11554.2 11937.2 12566.4 12571.2 9140.7 9181.0 9506.7 9786.6 9811.4 8245.9 8523.3 8969.6 9163.6 9788.0 07:08:29 INFO - PROCESS | 12605 | -------- Summary: end -------- 07:08:29 INFO - PROCESS | 12605 | 07:08:30 INFO - TEST-INFO | 12605: exit 0 07:08:30 INFO - TEST-OK | dromaeo_css | took 1121488ms 07:08:30 INFO - TEST-START | kraken 07:08:30 INFO - operating with platform_type : linux_ 07:08:30 INFO - Initialising browser for kraken test... 07:08:30 INFO - TEST-INFO | started process 12915 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkrDMqR/profile http://localhost:35369/getInfo.html) 07:08:34 INFO - PROCESS | 12915 | __metrics Screen width/height:1600/1200 07:08:34 INFO - PROCESS | 12915 | colorDepth:24 07:08:34 INFO - PROCESS | 12915 | Browser inner width/height: 1024/697 07:08:34 INFO - PROCESS | 12915 | __metrics 07:08:35 INFO - PROCESS | 12915 | 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" 07:08:35 INFO - PROCESS | 12915 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:08:35 INFO - PROCESS | 12915 | console.error: PushService: 07:08:35 INFO - PROCESS | 12915 | stateChangeProcessEnqueue: Error transitioning state 07:08:35 INFO - PROCESS | 12915 | UnknownError 07:08:36 INFO - TEST-INFO | 12915: exit 0 07:08:36 INFO - Browser initialized. 07:08:36 INFO - Running cycle 1/1 for kraken test... 07:08:36 INFO - TEST-INFO | started process 12995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkrDMqR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:08:48 INFO - PROCESS | 12995 | RSS: Main: 182562816 07:08:48 INFO - PROCESS | 12995 | 07:08:51 INFO - PROCESS | 12995 | Cycle 1(1): loaded http://localhost:35369/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35369/tests/kraken/driver.html?testName=audio-beat-detection) 07:08:52 INFO - PROCESS | 12995 | RSS: Main: 235110400 07:08:52 INFO - PROCESS | 12995 | 07:08:54 INFO - PROCESS | 12995 | Cycle 1(1): loaded http://localhost:35369/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35369/tests/kraken/driver.html?testName=audio-dft) 07:08:55 INFO - PROCESS | 12995 | RSS: Main: 224542720 07:08:55 INFO - PROCESS | 12995 | 07:08:58 INFO - PROCESS | 12995 | Cycle 1(1): loaded http://localhost:35369/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35369/tests/kraken/driver.html?testName=audio-fft) 07:08:59 INFO - PROCESS | 12995 | RSS: Main: 302604288 07:08:59 INFO - PROCESS | 12995 | 07:09:01 INFO - PROCESS | 12995 | Cycle 1(1): loaded http://localhost:35369/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35369/tests/kraken/driver.html?testName=audio-oscillator) 07:09:02 INFO - PROCESS | 12995 | RSS: Main: 213155840 07:09:02 INFO - PROCESS | 12995 | 07:09:04 INFO - PROCESS | 12995 | Cycle 1(1): loaded http://localhost:35369/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35369/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:09:05 INFO - PROCESS | 12995 | RSS: Main: 215695360 07:09:05 INFO - PROCESS | 12995 | 07:09:08 INFO - PROCESS | 12995 | Cycle 1(1): loaded http://localhost:35369/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35369/tests/kraken/driver.html?testName=imaging-darkroom) 07:09:08 INFO - PROCESS | 12995 | RSS: Main: 253755392 07:09:08 INFO - PROCESS | 12995 | 07:09:12 INFO - PROCESS | 12995 | Cycle 1(1): loaded http://localhost:35369/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35369/tests/kraken/driver.html?testName=imaging-desaturate) 07:09:12 INFO - PROCESS | 12995 | RSS: Main: 248389632 07:09:12 INFO - PROCESS | 12995 | 07:09:15 INFO - PROCESS | 12995 | Cycle 1(1): loaded http://localhost:35369/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35369/tests/kraken/driver.html?testName=json-parse-financial) 07:09:16 INFO - PROCESS | 12995 | RSS: Main: 250826752 07:09:16 INFO - PROCESS | 12995 | 07:09:18 INFO - PROCESS | 12995 | Cycle 1(1): loaded http://localhost:35369/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35369/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:09:18 INFO - PROCESS | 12995 | RSS: Main: 214913024 07:09:18 INFO - PROCESS | 12995 | 07:09:20 INFO - PROCESS | 12995 | Cycle 1(1): loaded http://localhost:35369/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35369/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:09:21 INFO - PROCESS | 12995 | RSS: Main: 222937088 07:09:21 INFO - PROCESS | 12995 | 07:09:23 INFO - PROCESS | 12995 | Cycle 1(1): loaded http://localhost:35369/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35369/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:09:24 INFO - PROCESS | 12995 | RSS: Main: 222908416 07:09:24 INFO - PROCESS | 12995 | 07:09:27 INFO - PROCESS | 12995 | Cycle 1(1): loaded http://localhost:35369/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:09:27 INFO - PROCESS | 12995 | RSS: Main: 224608256 07:09:27 INFO - PROCESS | 12995 | 07:09:30 INFO - PROCESS | 12995 | Cycle 1(1): loaded http://localhost:35369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:09:31 INFO - PROCESS | 12995 | RSS: Main: 222142464 07:09:31 INFO - PROCESS | 12995 | 07:09:33 INFO - PROCESS | 12995 | Cycle 1(1): loaded http://localhost:35369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35369/tests/kraken/driver.html?testName=ai-astar) 07:09:33 INFO - PROCESS | 12995 | RSS: Main: 272965632 07:09:33 INFO - PROCESS | 12995 | 07:09:33 INFO - PROCESS | 12995 | __start_tp_report 07:09:33 INFO - PROCESS | 12995 | _x_x_mozilla_page_load 07:09:33 INFO - PROCESS | 12995 | _x_x_mozilla_page_load_details 07:09:33 INFO - PROCESS | 12995 | |i|pagename|runs| 07:09:33 INFO - PROCESS | 12995 | |0;ai-astar;115;114;133;114;114;115;115;115;115;114 07:09:33 INFO - PROCESS | 12995 | |1;audio-beat-detection;154;126;149;191;127;155;150;126;187;126 07:09:33 INFO - PROCESS | 12995 | |2;audio-dft;161;162;162;162;162;163;162;162;163;161 07:09:33 INFO - PROCESS | 12995 | |3;audio-fft;77;76;76;168;78;75;76;78;159;76 07:09:33 INFO - PROCESS | 12995 | |4;audio-oscillator;84;85;154;83;84;83;142;84;83;141 07:09:33 INFO - PROCESS | 12995 | |5;imaging-gaussian-blur;117;117;117;117;116;116;118;117;118;117 07:09:33 INFO - PROCESS | 12995 | |6;imaging-darkroom;147;146;146;146;147;146;147;147;147;147 07:09:33 INFO - PROCESS | 12995 | |7;imaging-desaturate;95;94;95;94;95;95;95;95;95;95 07:09:33 INFO - PROCESS | 12995 | |8;json-parse-financial;64;64;65;66;65;66;65;65;65;65 07:09:33 INFO - PROCESS | 12995 | |9;json-stringify-tinderbox;65;65;66;66;67;65;66;65;66;66 07:09:33 INFO - PROCESS | 12995 | |10;stanford-crypto-aes;82;91;83;85;82;82;81;91;86;81 07:09:33 INFO - PROCESS | 12995 | |11;stanford-crypto-ccm;136;133;134;134;132;133;132;132;174;135 07:09:33 INFO - PROCESS | 12995 | |12;stanford-crypto-pbkdf2;172;173;173;172;172;171;171;171;176;174 07:09:33 INFO - PROCESS | 12995 | |13;stanford-crypto-sha256-iterative;69;69;69;68;70;69;72;70;67;67 07:09:33 INFO - PROCESS | 12995 | __end_tp_report 07:09:33 INFO - PROCESS | 12995 | __start_cc_report 07:09:33 INFO - PROCESS | 12995 | _x_x_mozilla_cycle_collect,2022 07:09:33 INFO - PROCESS | 12995 | __end_cc_report 07:09:33 INFO - PROCESS | 12995 | __startTimestamp1472738973298__endTimestamp 07:09:33 INFO - PROCESS | 12995 | 07:09:33 INFO - PROCESS | 12995 | ------- Summary: start ------- 07:09:33 INFO - PROCESS | 12995 | Number of tests: 14 07:09:33 INFO - PROCESS | 12995 | 07:09:33 INFO - PROCESS | 12995 | [#0] ai-astar Cycles:10 Average:116.40 Median:115.00 stddev:5.85 (5.1%) stddev-sans-first:6.19 07:09:33 INFO - PROCESS | 12995 | Values: 115.0 114.0 133.0 114.0 114.0 115.0 115.0 115.0 115.0 114.0 07:09:33 INFO - PROCESS | 12995 | 07:09:33 INFO - PROCESS | 12995 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:152.00 stddev:24.36 (16.0%) stddev-sans-first:25.77 07:09:33 INFO - PROCESS | 12995 | Values: 154.0 126.0 149.0 191.0 127.0 155.0 150.0 126.0 187.0 126.0 07:09:33 INFO - PROCESS | 12995 | 07:09:33 INFO - PROCESS | 12995 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 07:09:33 INFO - PROCESS | 12995 | Values: 161.0 162.0 162.0 162.0 162.0 163.0 162.0 162.0 163.0 161.0 07:09:33 INFO - PROCESS | 12995 | 07:09:33 INFO - PROCESS | 12995 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:36.76 (48.4%) stddev-sans-first:38.47 07:09:33 INFO - PROCESS | 12995 | Values: 77.0 76.0 76.0 168.0 78.0 75.0 76.0 78.0 159.0 76.0 07:09:33 INFO - PROCESS | 12995 | 07:09:33 INFO - PROCESS | 12995 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:83.50 stddev:30.13 (36.1%) stddev-sans-first:31.22 07:09:33 INFO - PROCESS | 12995 | Values: 84.0 85.0 154.0 83.0 84.0 83.0 142.0 84.0 83.0 141.0 07:09:33 INFO - PROCESS | 12995 | 07:09:33 INFO - PROCESS | 12995 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 07:09:33 INFO - PROCESS | 12995 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 118.0 117.0 118.0 117.0 07:09:33 INFO - PROCESS | 12995 | 07:09:33 INFO - PROCESS | 12995 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:09:33 INFO - PROCESS | 12995 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 147.0 147.0 147.0 147.0 07:09:33 INFO - PROCESS | 12995 | 07:09:33 INFO - PROCESS | 12995 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:09:33 INFO - PROCESS | 12995 | Values: 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 07:09:33 INFO - PROCESS | 12995 | 07:09:33 INFO - PROCESS | 12995 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 07:09:33 INFO - PROCESS | 12995 | Values: 64.0 64.0 65.0 66.0 65.0 66.0 65.0 65.0 65.0 65.0 07:09:33 INFO - PROCESS | 12995 | 07:09:33 INFO - PROCESS | 12995 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 07:09:33 INFO - PROCESS | 12995 | Values: 65.0 65.0 66.0 66.0 67.0 65.0 66.0 65.0 66.0 66.0 07:09:33 INFO - PROCESS | 12995 | 07:09:33 INFO - PROCESS | 12995 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:3.84 (4.6%) stddev-sans-first:3.97 07:09:33 INFO - PROCESS | 12995 | Values: 82.0 91.0 83.0 85.0 82.0 82.0 81.0 91.0 86.0 81.0 07:09:33 INFO - PROCESS | 12995 | 07:09:33 INFO - PROCESS | 12995 | [#11] stanford-crypto-ccm Cycles:10 Average:137.50 Median:134.00 stddev:12.89 (9.6%) stddev-sans-first:13.67 07:09:33 INFO - PROCESS | 12995 | Values: 136.0 133.0 134.0 134.0 132.0 133.0 132.0 132.0 174.0 135.0 07:09:33 INFO - PROCESS | 12995 | 07:09:33 INFO - PROCESS | 12995 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:172.50 stddev:1.58 (0.9%) stddev-sans-first:1.67 07:09:33 INFO - PROCESS | 12995 | Values: 172.0 173.0 173.0 172.0 172.0 171.0 171.0 171.0 176.0 174.0 07:09:33 INFO - PROCESS | 12995 | 07:09:33 INFO - PROCESS | 12995 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.49 (2.2%) stddev-sans-first:1.58 07:09:33 INFO - PROCESS | 12995 | Values: 69.0 69.0 69.0 68.0 70.0 69.0 72.0 70.0 67.0 67.0 07:09:33 INFO - PROCESS | 12995 | -------- Summary: end -------- 07:09:33 INFO - PROCESS | 12995 | 07:09:34 INFO - TEST-INFO | 12995: exit 0 07:09:34 INFO - TEST-OK | kraken | took 64520ms 07:09:34 INFO - SUITE-END | took 1186s 07:09:34 INFO - Completed test suite (00:19:46) 07:09:34 INFO - javascript benchmark 07:09:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2566.1531694540804, 2580.778872155221, 2585.1210588399945, 2607.1657069737694, 2650.522905876943, 4600.976995115024, 4631.953680463194, 4657.883552911179, 4700.012997270573, 4759.119562880869, 4630.652701047418, 4650.744299039257, 4673.439187297529, 4679.110968915904, 4711.151992641332, 4263.3178691409385, 4286.828526858922, 4345.087531618364, 4412.735235885841, 4424.159409712144, 4320.503142138663, 4353.521112677603, 4368.322909948963, 4385.627221686144, 4413.514513403523, 4207.200631879933, 4231.91536169278, 4240.597143271415, 4277.572242775728, 4311.547287534827, 4293.957060429419, 4331.3936048952855, 4374.081442896995, 4389.495208051083, 4435.955640443586, 4258.297380932143, 4276.422682937795, 4279.550647182032, 4364.10535840152, 4415.712978656377, 4683.578477936968, 4748.762561871893, 4750.5249475052215, 4808.687435316729, 4810.567048965575, 4875.268709693539, 5006.649534532584, 5035.0685123252315, 5041.697498150123, 5055.317532133152, 5097.515736005111, 5106.9489305106845, 5109.514596113363, 5110.207917772751, 5169.56058735008, 4727.290906364073, 4753.904921901542, 4766.475687674353, 4769.0, 4823.517648235148, 5033.320501732219, 5079.568236699848, 5134.794608215704, 5142.382914050338, 5210.817621383233, 4927.0, 4945.67853089548, 4948.950510494849, 4950.059488697136, 5001.524855138756, 5022.6233032522705, 5025.170846810309, 5025.271335656309, 5036.974815125901, 5084.872878178076, 4775.71345719258, 4938.481459446706, 4967.3542439482635, 4977.203647416396, 4979.278004689372, 4936.086823937583, 4937.382827146606, 4943.629227807857, 4955.975220123948, 5001.0, 4290.678199135077, 4292.3561465780385, 4295.613394794421, 4335.981044454551, 4354.4992325882295, 3706.4069748840056, 3711.7030637548933, 3712.777233366007, 3721.0883333582906, 3798.6011468795377, 4352.325389564622, 4365.323374876899, 4373.956260437419, 4406.052698669801, 4423.579759922803, 5040.49595040493, 5070.518300761421, 5073.0, 5075.949240507622, 5128.666636668605, 4306.009617787926, 4329.545397733255, 4369.60673539383, 4374.58441448062, 4422.75674837887, 4523.909521809611, 4539.773011349419, 4556.863294101182, 4614.676972611952, 4619.769011549409, 4779.187538118528, 4780.760961951819, 4781.091592597395, 4784.162771514902, 4843.951560484491, 4891.095147397743, 5062.063518249136, 5070.4929507049, 5075.949240507695, 5079.390473143247, 4826.034793041476, 4829.517048295143, 4830.879228019187, 4901.803927842846, 4906.754662266943, 5020.146575082318, 5023.4725353838785, 5024.547790698854, 5031.0, 5097.260897169964, 4880.463149053672, 4924.655274130777, 5107.284980102863, 5117.5394214520875, 5180.922286165635, 4846.781894814812, 4871.074495845778, 4887.951120488749, 4934.457209707001, 4960.355153829979, 4968.329275547755, 4972.229304457815, 4977.751112444435, 4983.775730092082, 5029.094762942559, 4861.732604706775, 4868.026394720999, 4873.342098816756, 4877.975610121926, 4921.064997650435, 4784.6889952153, 4898.21628539432, 4943.110240156806, 4952.232403977389, 5033.697978121324, 4839.5402436769855, 4859.149648811514, 4859.586935110555, 4909.3372394727685, 4915.655904086822], "value": 4634.840296040164, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.5350139636196, 574.3251679276849, 575.2895174459542, 575.602834044509, 581.453433772254, 26366.604500932477, 29277.0, 29293.560596591014, 29315.560266595992, 29319.267018324525, 30386.544201836936, 38480.230395392144, 39785.801070994676, 39895.0, 43915.78042109793, 7701.075870895486, 7833.099193592724, 7836.2947334739865, 7841.098273698541, 7841.725539606115, 7668.156502784689, 7763.767086987399, 7765.339946104588, 7771.727989520368, 7776.339011184056, 7234.0, 7401.962990185041, 7404.2595740425795, 7535.095788505359, 7619.0, 9654.806903861918, 9929.65246216379, 9943.105120539114, 10373.84439233412, 10383.065524102867, 9806.90193098067, 9887.703368898945, 9888.555015024342, 9894.851577226347, 9902.950485247527, 36872.63127368745, 37205.81397092997, 37222.62777372219, 37253.44119838205, 37261.44107838385, 3002.384511175204, 3009.5034319337283, 3013.547967804825, 3079.7690173237097, 3263.282077942849, 27533.449331013468, 28344.574831377548, 28707.0, 28722.281942951384, 28729.0, 3314.4034073866696, 3337.132345590164, 3348.3972884880714, 3513.1919658478437, 3521.366154092262, 258488.0, 261081.0, 261128.6943565289, 261178.0, 261602.0, 30384.69615303863, 52259.47740522622, 52548.0, 52706.682332941986, 52720.0, 30760.53859192114, 33299.66700333014, 33318.666813331554, 33362.332753344795, 33368.3326333472, 13761.931190343985, 14033.508827191203, 14043.648908777363, 14049.157050576998, 14055.43778248879, 11496.137789665641, 11744.530218791153, 11757.000654944255, 11759.353235572125, 11765.294082355085, 7714.652840622185, 7763.340116090083, 7765.983953754876, 7831.216878312237, 7850.960745196352, 2818.1404671574956, 2953.1140657802575, 2991.446582382266, 3007.9248018799703, 3012.2619958109967, 770.5915864591664, 885.93798434109, 899.1817446123996, 912.9543522823965, 922.1516205091198, 25871.741282586932, 27993.58009629857, 28756.137315880558, 28800.0, 28815.135545933656, 901.2024358442694, 946.9005754395827, 956.8950098372339, 958.91849192818, 1020.6325722739808, 14645.414183432544, 14958.925205373904, 15012.871460348491, 15023.323950422257, 15130.924345378422, 372159.0, 375388.0, 376431.0, 376565.0, 377484.0, 48861.75569122132, 49331.75334123378, 49551.256731149064, 49588.25617615739, 49591.50408495941, 1062.9255952083436, 1130.2257953302014, 1171.7597892432032, 1174.365842445087, 1176.153169717836, 27101.0, 28373.858130709214, 29340.70659293465, 29507.114786556438, 29557.704422956354, 40809.79595102005, 49000.0, 49877.50122498729, 50025.0, 56302.43697562972, 259921.0, 262020.0, 262740.0, 371891.0, 372075.0, 37186.0, 38379.616203837606, 38923.22153556856, 41688.58311416847, 41949.370759438025, 42242.57757422386, 42485.78757106195, 42489.575104248564, 42620.360694588984, 42651.0, 35685.28629427449, 35967.64032359643, 36014.8199259002, 36274.27451450904, 36486.087847802955, 35474.0, 35902.0, 36075.819620901726, 36195.63804361923, 36476.27047459089, 35561.0, 35613.465798012534, 35683.643163568035, 35942.8202858984, 35995.82002089973, 31413.371732564763, 32520.67479325271, 32530.698772048854, 32916.50625240576, 33214.335713286084, 25276.368090797878, 25400.237992860242, 25479.23562293134, 25550.616740748534, 25605.0], "value": 16693.96590349916, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.163811376275, 358.6646485536024, 360.1410635634012, 363.8053641301903, 381.69464428457246, 12524.686882827933, 15847.128407937573, 15901.920490397546, 16629.66740665186, 17754.46736597901, 16603.750943735853, 16631.251593678284, 16677.66644667106, 16798.916005419986, 16984.4055458059, 4980.800767969277, 5150.845474635767, 5220.608454365938, 5430.321209848769, 5470.5350045246205, 3470.7743996640265, 3634.890953271406, 5476.0, 5513.338399392079, 5515.420880807517, 3681.6134305897895, 3687.465317528957, 4955.909699866023, 6910.861782764342, 6913.619750913697, 6793.320667933217, 6901.137357830271, 6969.0, 6970.013546139377, 6973.093497845273, 6771.4582833373215, 6806.693698783567, 6812.386885180357, 6814.1482314710665, 6814.863702725967, 20986.16055357784, 22498.0, 22665.546689066126, 23380.532389352287, 23490.060397584075, 1964.6365422396902, 1990.3133418970576, 2010.6883433067899, 2086.3636590839787, 2165.588538177757, 13459.86540134596, 14394.136351818925, 14573.271336433136, 15182.45840268305, 15285.082895026222, 1836.9540761481069, 1851.2965073272205, 1872.17624245333, 1901.5056085417752, 1911.3214808742835, 51503.74248128735, 74562.25437745608, 76547.6172619139, 78098.60950695266, 78939.0, 14410.81210764124, 15732.764008539882, 16449.177541122895, 16786.32854685799, 16792.83207167937, 27820.30449238785, 27838.860805696248, 27850.303742406602, 27903.023394181106, 28002.5799613006, 9091.636334546676, 9144.725658230263, 9335.953320233355, 9510.619575217052, 9536.046395360547, 7631.732889348847, 7688.654010569538, 7746.728864489716, 7883.6058197089915, 7997.5601341925585, 8091.1504292048485, 8272.958635206905, 8363.540005299767, 8401.0, 8460.703875364332, 3104.7516198704047, 3172.809631422076, 3209.935801283961, 3216.7426605871474, 3335.1495368681317, 769.8037000564821, 806.3106044332129, 815.2214635023657, 822.8765685147156, 832.9791755206047, 15692.607684807972, 16153.676926461405, 16835.494935151964, 16976.32094716222, 17626.647467050843, 829.9460535065201, 837.1126605797874, 837.9455335403179, 882.1839798186652, 904.9818953677113, 9170.0, 9499.525023748924, 9734.97782732817, 9809.411435313761, 9951.104400603981, 392715.1456970902, 398061.0, 410708.0, 411426.0, 413955.0, 77472.2252777465, 81611.18388816036, 84103.38449232542, 84502.57748711217, 84634.0, 416.94162817205614, 905.1355955062899, 921.2583869984593, 925.4493576322078, 931.3108299858192, 9585.36402489321, 9672.177864881563, 10081.14310283634, 10222.948885255526, 10462.006109419593, 34848.82575587106, 37113.814430927676, 37998.810005949796, 38410.231795363376, 38960.220795583366, 50905.49094509156, 51209.48790512047, 51348.22977655263, 51838.77934647867, 52407.0, 7567.659455324413, 7758.495697779626, 7786.221377862168, 7905.0, 8212.096669366485, 11769.705757356134, 12100.515979360727, 12113.212641178296, 12290.877091228973, 12338.50645974187, 9797.608095676092, 9817.85273220888, 9823.21414286841, 9865.210783137476, 10915.0, 9903.950480247553, 10308.845367319645, 10481.790364192826, 10672.0, 10727.678169654922, 10538.156947444339, 10555.0, 10600.787984240118, 10807.891921080689, 10870.510827012962, 7605.88591171144, 7657.4256930731535, 7853.725119620786, 7906.841863162819, 8163.265306122477, 8953.865692014755, 10335.431551264752, 10435.530401131815, 10500.26498145153, 10838.729031773953], "value": 9004.728299754714, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1214.3503225774214, 1300.2523548959348, 1361.863813618638, 1371.7667996440605, 1605.831387704291, 7090.078289822322, 7443.776686699394, 7477.775666729994, 7479.738209162673, 7622.199669034755, 7303.415726741861, 7476.588787616679, 7658.808529786758, 7660.042494688164, 7663.386929045677, 2128.9574208515783, 2163.56728654269, 2164.77269886662, 2168.4253672776726, 2183.879886606236, 2117.216629846951, 2158.104386679526, 2171.5005548723802, 2175.445261458326, 2179.6294629912954, 2103.842211834111, 2122.0556852200775, 2123.4160605833363, 2128.829693624514, 2129.307974908161, 2097.8216851567636, 2104.2635077722825, 2104.305579158874, 2105.842061845368, 2107.146605624709, 2044.9182032718672, 2096.172012055245, 2096.4549217203635, 2097.6958341040618, 2103.1272022110957, 7334.3032411920785, 7591.316781489637, 7633.0, 7676.539407635504, 7691.192424795372, 4400.933985990213, 4591.724496530219, 4606.216943119678, 4610.700304480198, 4612.630989520831, 2815.7043510431313, 2988.7310142087317, 2995.4757917364373, 3012.834294113823, 3023.4557779599663, 956.5217391304348, 961.1445813226235, 978.1636700621009, 991.6975322526627, 995.3082607587729, 10075.294729368947, 10266.281360304782, 10309.020643038899, 10312.793744125076, 10320.0, 4092.9795351023054, 4231.301835197158, 4254.808533615995, 4261.573842615714, 4300.591443812833, 8795.51624660637, 8836.867446988172, 8840.381173317806, 8847.911520884709, 8848.20366167048, 4539.477960034638, 4539.500654927955, 4540.364348991144, 4543.000539881221, 4544.636429085665, 3509.6139424663265, 3692.2615476904725, 4138.751674899516, 4151.813168407429, 4153.460050193516, 3598.47822065799, 3660.359437098497, 3726.1802403471193, 3729.328720830222, 3738.1962877981364, 1170.5142365918218, 1182.6806762174165, 1191.2078467818803, 1194.808830587102, 1209.838554987222, 724.4457989637931, 757.6969212315008, 764.5107131435885, 776.7630872583916, 803.3171803966699, 4798.49615790344, 4862.416510018749, 4902.852914412573, 4994.425641051325, 5166.044281807803, 408.12864534219653, 417.0595307581445, 419.0383070852401, 420.2225882118118, 423.5425740200576, 3197.2486465680545, 3311.65227651098, 3313.4532802087388, 3366.360391525602, 3382.8308584570673, 9123.863142052875, 9171.40385874916, 9439.669611563562, 9542.809143817223, 9556.0, 9422.717318480456, 9425.62297508092, 9428.340016198801, 9431.434113953184, 9439.197668198143, 6637.137172167684, 6850.280720524373, 6906.447484201352, 7061.435085193172, 7145.214026457085, 5035.773390197523, 5189.273501709688, 5222.712750798591, 5265.578753699619, 5319.893602128013, 8354.58227088631, 8522.10517895612, 8677.305815534615, 8739.519326437106, 8796.780080498038, 8577.485350878967, 8704.042555318783, 8825.293976481738, 8840.336974726793, 8949.239314658067, 6468.741250349934, 6578.5395022347975, 6603.867922641616, 6652.0, 6656.36764507371, 7144.892826607501, 7173.1392232932385, 7236.493445458767, 7240.203577606564, 7268.563886166847, 6341.270753863365, 6360.522960778053, 6369.20384951881, 6413.005984072476, 6591.868162636816, 6418.679066046772, 6466.741330346734, 6472.579282346821, 6475.352464753487, 6514.315996820455, 6030.7286172121485, 6143.293521245114, 6146.877062458815, 6148.077788331786, 6149.7847575334645, 4081.8979525510913, 4144.772037537964, 4263.637590804692, 4271.423357846776, 4373.781310934377, 4082.326416141422, 4146.253674338648, 4165.354370072643, 4236.872893813191, 4401.735895846259], "value": 3940.000253521274, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.83595514601546, 298.1368936927595, 299.86056483735075, 303.7038887085092, 303.9817610943342, 4562.863114106573, 4671.976640116799, 4711.764411779414, 4761.405034256334, 4778.808847646094, 4520.412346394973, 4616.515265897083, 4645.210314246586, 4654.674172807905, 4684.929726054112, 3749.343864823659, 3751.0997360633387, 3754.755940863835, 3757.6993840492833, 3765.171662234311, 3582.3730847101783, 3614.548181477315, 3758.3422900992355, 3769.9623003769884, 3775.7168212384045, 3680.5215322008103, 3681.4293784463316, 3702.3520883845354, 3731.8134093295225, 3740.8129593520353, 3694.3165514379657, 3705.6294370562728, 3708.1841994761107, 3712.888613341577, 3727.832247548853, 3273.8035717857006, 3281.8851340202978, 3284.8193349365774, 3289.588801399825, 3291.3175761754333, 4489.483709373431, 4544.954550454486, 4564.954350456519, 4575.679702420832, 4601.148787474328, 4238.114039252534, 4242.893927651802, 4243.787810609457, 4256.404103425523, 4281.807318670667, 4926.96533727914, 4933.407991041098, 4953.331300274489, 4962.255661650745, 4981.526754958273, 3550.6449355064547, 3649.580298265707, 3660.597334293252, 3678.0, 3679.9448008279896, 5112.134071064072, 5134.358205224347, 5135.6148288878485, 5144.871378215537, 5170.819021334273, 3718.3492888744363, 3720.776753394805, 3727.2545490901384, 3734.477173195755, 3736.813963831189, 3780.3006443807985, 3780.6030366811638, 3781.8087302499625, 3801.030737162061, 3817.8091095445116, 4154.709170358046, 4215.367694845798, 4216.810243539048, 4267.487901451846, 4294.74231546102, 4887.169181239198, 4889.608831293488, 4908.288298196741, 4922.0, 4930.506949305112, 1237.3256575166556, 1271.1483306184878, 1291.1284882704324, 1302.8306320178317, 1312.7266551445082, 896.1083721696954, 905.1039470923738, 920.9815803684023, 926.6988228825659, 928.2898582584328, 4366.825326986948, 4375.47494300686, 4379.868603941887, 4382.167388196232, 4385.846495372711, 5021.6735912165595, 5028.5977121830165, 5038.899222015539, 5064.848054558369, 5065.175792276881, 4335.921495738061, 4348.391225228471, 4350.2387082260475, 4382.6055654991205, 4384.4519435070615, 2238.4851484158735, 2349.729781075164, 2359.5162991586685, 2379.2862141357523, 2392.8205384596226, 4278.775036980815, 4289.613934745826, 4293.97853010733, 4299.269124248885, 4300.8709738707885, 4548.727076375428, 4563.748993805306, 4571.3600095986585, 4575.611073058827, 4589.269384716089, 4129.793510324532, 4182.414461975326, 4239.38528913312, 4276.40130381753, 4295.926018495376, 4407.7796110195, 4423.8497990522055, 4426.3803067569925, 4450.6439484841785, 4457.554244575516, 4338.58783415575, 4350.58669426404, 4354.390385345991, 4365.956340436682, 4384.364267181177, 4211.894702632336, 4258.446401967724, 4264.251656820688, 4540.545945405565, 4876.951230487792, 3625.4380571011534, 3628.6008539060153, 3641.16253261746, 3645.54430696163, 3654.6528079832374, 4865.756712164307, 5088.262201980618, 5122.846314610568, 5131.255967884561, 5143.2285157225215, 4781.258904869751, 4935.111679897653, 4954.851354459372, 4977.576905963034, 4986.576141027908, 4946.950530494793, 4947.727874966911, 4977.805326721488, 4981.875453113701, 4985.9087365831965, 4747.667663263538, 4792.013311148004, 4869.780859861244, 4888.413390393033, 4889.657723959289, 4972.179590367549, 4984.875378115431, 4999.750012499288, 5005.974970125126, 5016.272640467038, 4865.83220027198, 4885.364902562644, 4891.584215341736, 4894.657373983787, 4899.975500122477], "value": 3671.2211070143344, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.2209084009107, 628.230417738271, 666.733306677329, 678.8574399376131, 689.3347919257915, 11500.884991150086, 11861.110416718748, 11866.82199767002, 11881.584144554943, 11900.40497975101, 13022.739545209113, 13382.197068175916, 13400.061995660308, 13891.305434728274, 13974.650633734162, 726.789231122975, 747.7980945144808, 752.732779863149, 753.1113286322137, 753.2091304130641, 595.315387304601, 720.6901032555999, 747.2602123897357, 750.7672621487357, 754.9622518874035, 779.8947142135825, 780.1145699630931, 781.2617076862367, 782.1083964280724, 782.2685788787473, 777.2732495117084, 777.4518964130275, 777.5801067423585, 777.871651177555, 778.2567647896245, 459.94710608280144, 541.5992165797281, 555.0176188146958, 558.2101326622824, 568.9203511508392, 11422.25755325901, 11453.141014423869, 11463.140264480115, 11463.885361146366, 11469.827952580717, 11032.834507482394, 11436.656900293005, 11691.76616467666, 11798.587049453314, 12325.445354959049, 11218.551257949672, 11302.208845380826, 11348.829767553494, 11536.711582210428, 11578.247413918069, 3948.170884114311, 3986.621270979252, 3996.620321069494, 4007.97996010021, 4018.0557568971267, 63154.0526892097, 63612.68193659048, 64446.0, 64488.0, 67486.32513674899, 9423.811523769486, 9501.762455938519, 9767.218622510181, 9925.057119573628, 9972.850407243897, 17752.91123544374, 17871.910640446713, 18005.099745012696, 18058.187381567863, 18088.819111808978, 6438.77464288757, 6518.902216466757, 6523.0, 6545.672716364163, 6622.536422450478, 3595.9280814383565, 3624.800635965047, 3628.818559072036, 3630.09247688078, 3641.7450778445254, 2774.2232174991036, 2841.0624493916957, 2868.3976364963173, 2870.2106920596584, 2871.956920646192, 475.11628371229483, 476.7258826174894, 485.61393692014934, 486.45031114840003, 490.7521701540699, 494.0834751535849, 506.4960364437408, 516.5635038392552, 522.1280461629088, 545.3319683387818, 6773.491988100814, 6840.144981877265, 7025.086738723933, 7071.151461824614, 7099.787006389816, 432.68846430569937, 452.8482958208971, 474.7294042395801, 532.5074306266688, 570.3042288408218, 3204.9359012819614, 3287.4411350070545, 3295.719863811603, 3352.5138854866395, 3416.777909435879, 99046.50476747715, 105432.0, 106437.0, 108502.0, 108702.0, 50012.499875001515, 50315.0, 85347.57326213454, 87998.0, 88419.55790221007, 76396.61801690956, 78266.0, 79044.0, 79460.0, 81809.59095204486, 6596.30738772422, 6688.933110668831, 6733.562318449285, 6788.660566971533, 6817.795466136024, 38505.0, 46810.29784553302, 47506.52493475021, 47609.0, 50670.74664626801, 39541.80229098836, 51485.0, 57535.1369729446, 59439.70280148571, 62012.37987620066, 11077.612283570037, 11142.27575207609, 11326.093912487146, 11698.181127321006, 12048.879511205127, 12278.263304201419, 12547.623571292876, 12568.748625027265, 13449.394777235244, 13562.660933476742, 10375.94812025935, 11701.473433695333, 12372.0, 12686.429110689856, 12751.553695620609, 11258.718532036764, 11419.429028548706, 11790.705232369259, 12063.577774777841, 12075.0, 11325.0, 11554.191206615793, 11937.16439849237, 12566.371681416076, 12571.245725256515, 9140.725778226664, 9180.954095229481, 9506.667266645634, 9786.60853565878, 9811.411315321104, 8245.876311855447, 8523.318134549098, 8969.551522423983, 9163.587638556415, 9787.951060244653], "value": 6272.654059865229, "unit": "score"}], "name": "dromaeo_css", "value": 6311.694648615158, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 133.0, 114.0, 114.0, 115.0, 115.0, 115.0, 115.0, 114.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 149.0, 191.0, 127.0, 155.0, 150.0, 126.0, 187.0, 126.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 162.0, 162.0, 163.0, 162.0, 162.0, 163.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 168.0, 78.0, 75.0, 76.0, 78.0, 159.0, 76.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 154.0, 83.0, 84.0, 83.0, 142.0, 84.0, 83.0, 141.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 118.0, 117.0, 118.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 67.0, 65.0, 66.0, 65.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 91.0, 83.0, 85.0, 82.0, 82.0, 81.0, 91.0, 86.0, 81.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 133.0, 134.0, 134.0, 132.0, 133.0, 132.0, 132.0, 174.0, 135.0], "value": 137.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 173.0, 172.0, 172.0, 171.0, 171.0, 171.0, 176.0, 174.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 68.0, 70.0, 69.0, 72.0, 70.0, 67.0, 67.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1576.2, "alertThreshold": 2.0}]} 07:09:35 INFO - Return code: 0 07:09:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:09:35 INFO - # TBPL SUCCESS # 07:09:35 INFO - Running post-action listener: _resource_record_post_action 07:09:35 INFO - [mozharness: 2016-09-01 14:09:35.132352Z] Finished run-tests step (success) 07:09:35 INFO - Running post-run listener: _resource_record_post_run 07:09:35 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 406884352; Read time: 16; Write time: 343140 07:09:35 INFO - TinderboxPrint: CPU usage
13.1% 07:09:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 07:09:35 INFO - TinderboxPrint: I/O write bytes / time
406,884,352 / 343,140 07:09:35 INFO - TinderboxPrint: CPU idle
8,341.6 (86.9%) 07:09:35 INFO - TinderboxPrint: CPU user
1,205.6 (12.6%) 07:09:35 INFO - TinderboxPrint: Swap in / out
0 / 0 07:09:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114515968; Read time: 0; Write time: 126840 07:09:35 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 292368384; Read time: 0; Write time: 216300 07:09:35 INFO - Running post-run listener: _upload_blobber_files 07:09:35 INFO - Blob upload gear active. 07:09:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:09:35 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 07:09:35 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'] 07:09:35 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 07:09:36 INFO - (blobuploader) - INFO - Open directory for files ... 07:09:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:09:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:09:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:09:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:09:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:09:36 INFO - (blobuploader) - INFO - Done attempting. 07:09:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:09:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:09:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:09:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:09:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:09:37 INFO - (blobuploader) - INFO - Done attempting. 07:09:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:09:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:09:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:09:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:09:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:09:42 INFO - (blobuploader) - INFO - Done attempting. 07:09:42 INFO - (blobuploader) - INFO - Iteration through files over. 07:09:42 INFO - Return code: 0 07:09:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:09:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:09:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c9c23e4be962de23d4659f7a0c5c5b24a0633c417442173ce9d7c629feca25b234b4e07ecb1882413fec8fd90363b8ad20d5f2aa248cb7415c0bc6ac6a1aeefa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/79905869ee3fba2cca6f3bfbbd228440dee1558e595a823ecd42601b5ff002d61823e1302a9809bb5c7bc8622206d62c9776095f7ed2e307b8d94786b51b237d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a66e270fee537fd5a19027bed22aca5f9231e77175372a6e61e8be88052fc51afb8d12bcc4032b3a74029c5ead734812ddc76a3f3d72b73521be825c372adcfe"} 07:09:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:09:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:09:42 INFO - Contents: 07:09:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c9c23e4be962de23d4659f7a0c5c5b24a0633c417442173ce9d7c629feca25b234b4e07ecb1882413fec8fd90363b8ad20d5f2aa248cb7415c0bc6ac6a1aeefa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/79905869ee3fba2cca6f3bfbbd228440dee1558e595a823ecd42601b5ff002d61823e1302a9809bb5c7bc8622206d62c9776095f7ed2e307b8d94786b51b237d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a66e270fee537fd5a19027bed22aca5f9231e77175372a6e61e8be88052fc51afb8d12bcc4032b3a74029c5ead734812ddc76a3f3d72b73521be825c372adcfe"} 07:09:42 INFO - Running post-run listener: copy_logs_to_upload_dir 07:09:42 INFO - Copying logs to upload dir... 07:09:42 INFO - mkdir: /builds/slave/test/build/upload/logs 07:09:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.096246 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-01 07:09:41.756563) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 07:09:41.760458) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713 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/c9c23e4be962de23d4659f7a0c5c5b24a0633c417442173ce9d7c629feca25b234b4e07ecb1882413fec8fd90363b8ad20d5f2aa248cb7415c0bc6ac6a1aeefa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/79905869ee3fba2cca6f3bfbbd228440dee1558e595a823ecd42601b5ff002d61823e1302a9809bb5c7bc8622206d62c9776095f7ed2e307b8d94786b51b237d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a66e270fee537fd5a19027bed22aca5f9231e77175372a6e61e8be88052fc51afb8d12bcc4032b3a74029c5ead734812ddc76a3f3d72b73521be825c372adcfe"} build_url:https://queue.taskcluster.net/v1/task/K6YjdrIvSa-p3Jp4BWfgWQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011419 build_url: 'https://queue.taskcluster.net/v1/task/K6YjdrIvSa-p3Jp4BWfgWQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c9c23e4be962de23d4659f7a0c5c5b24a0633c417442173ce9d7c629feca25b234b4e07ecb1882413fec8fd90363b8ad20d5f2aa248cb7415c0bc6ac6a1aeefa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/79905869ee3fba2cca6f3bfbbd228440dee1558e595a823ecd42601b5ff002d61823e1302a9809bb5c7bc8622206d62c9776095f7ed2e307b8d94786b51b237d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a66e270fee537fd5a19027bed22aca5f9231e77175372a6e61e8be88052fc51afb8d12bcc4032b3a74029c5ead734812ddc76a3f3d72b73521be825c372adcfe"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 07:09:41.786045) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 07:09:41.786382) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1472737014.553499-2032488713 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 07:09:41.868991) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 07:09:41.869309) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 07:09:41.869605) ========= ========= Total master_lag: 0.16 =========