builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1472528333.88 results: success (0) buildid: 20160829191121 builduid: f264de251d1c4f47be8c8240b7ba39f3 revision: 08e4eadbb77d5789e41559ced20dc3fef8b93002 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 20:38:53.881158) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 20:38:53.882289) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 20:38:53.882928) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 20:38:53.895648) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 20:38:53.895942) ========= 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=ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-29 20:38:54-- 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% 46.3M=0s 2016-08-29 20:38:54 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111656 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 20:38:54.021858) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 20:38:54.022285) ========= 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=ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016036 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 20:38:54.071792) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 20:38:54.072195) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 08e4eadbb77d5789e41559ced20dc3fef8b93002 --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 08e4eadbb77d5789e41559ced20dc3fef8b93002 --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=ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-29 20:38:54,244 truncating revision to first 12 chars 2016-08-29 20:38:54,244 Setting DEBUG logging. 2016-08-29 20:38:54,244 attempt 1/10 2016-08-29 20:38:54,244 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/08e4eadbb77d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-29 20:38:54,507 unpacking tar archive at: autoland-08e4eadbb77d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.612068 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 20:38:54.698675) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 20:38:54.699073) ========= script_repo_revision: 08e4eadbb77d5789e41559ced20dc3fef8b93002 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 20:38:54.699509) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 20:38:54.700000) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 20:38:54.710594) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-29 20:38:54.710935) ========= /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=ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:38:54 INFO - MultiFileLogger online at 20160829 20:38:54 in /builds/slave/test 20:38:54 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 20:38:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:38:54 INFO - {'append_to_log': False, 20:38:54 INFO - 'base_work_dir': '/builds/slave/test', 20:38:54 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 20:38:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:38:54 INFO - 'branch': 'Autoland-Non-PGO', 20:38:54 INFO - 'buildbot_json_path': 'buildprops.json', 20:38:54 INFO - 'config_files': ('talos/linux_config.py',), 20:38:54 INFO - 'default_actions': ('clobber', 20:38:54 INFO - 'read-buildbot-config', 20:38:54 INFO - 'download-and-extract', 20:38:54 INFO - 'populate-webroot', 20:38:54 INFO - 'create-virtualenv', 20:38:54 INFO - 'install', 20:38:54 INFO - 'run-tests'), 20:38:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:38:54 INFO - 'download_minidump_stackwalk': True, 20:38:54 INFO - 'download_symbols': 'ondemand', 20:38:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:38:54 INFO - 'tooltool.py': '/tools/tooltool.py', 20:38:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:38:54 INFO - '/tools/misc-python/virtualenv.py')}, 20:38:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:38:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:38:54 INFO - 'installer_path': 'installer.exe', 20:38:54 INFO - 'log_level': 'info', 20:38:54 INFO - 'log_name': 'talos', 20:38:54 INFO - 'log_to_console': True, 20:38:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:38:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:38:54 INFO - 'opt_config_files': (), 20:38:54 INFO - 'pip_index': False, 20:38:54 INFO - 'sps_profile': False, 20:38:54 INFO - 'sps_profile_interval': 0, 20:38:54 INFO - 'suite': 'dromaeojs', 20:38:54 INFO - 'system_bits': '32', 20:38:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:38:54 INFO - 'title': 'talos-linux64-ix-035', 20:38:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:38:54 INFO - 'use_talos_json': True, 20:38:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:38:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:38:54 INFO - 'work_dir': 'build'} 20:38:54 INFO - [mozharness: 2016-08-30 03:38:54.979872Z] Running clobber step. 20:38:54 INFO - Running pre-action listener: _resource_record_pre_action 20:38:54 INFO - Running main action method: clobber 20:38:54 INFO - rmtree: /builds/slave/test/build 20:38:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:38:55 INFO - Running post-action listener: _resource_record_post_action 20:38:55 INFO - [mozharness: 2016-08-30 03:38:55.469345Z] Finished clobber step (success) 20:38:55 INFO - [mozharness: 2016-08-30 03:38:55.469446Z] Running read-buildbot-config step. 20:38:55 INFO - Running pre-action listener: _resource_record_pre_action 20:38:55 INFO - Running main action method: read_buildbot_config 20:38:55 INFO - Using buildbot properties: 20:38:55 INFO - { 20:38:55 INFO - "project": "", 20:38:55 INFO - "product": "firefox", 20:38:55 INFO - "script_repo_revision": "production", 20:38:55 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 20:38:55 INFO - "repository": "", 20:38:55 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 20:38:55 INFO - "buildid": "20160829191121", 20:38:55 INFO - "pgo_build": "False", 20:38:55 INFO - "basedir": "/builds/slave/test", 20:38:55 INFO - "buildnumber": 381, 20:38:55 INFO - "slavename": "talos-linux64-ix-035", 20:38:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:38:55 INFO - "platform": "ubuntu64_hw", 20:38:55 INFO - "scheduler": "tests-autoland-linux64-talos", 20:38:55 INFO - "branch": "autoland", 20:38:55 INFO - "repo_path": "integration/autoland", 20:38:55 INFO - "revision": "08e4eadbb77d5789e41559ced20dc3fef8b93002", 20:38:55 INFO - "stage_platform": "linux64", 20:38:55 INFO - "builduid": "f264de251d1c4f47be8c8240b7ba39f3", 20:38:55 INFO - "slavebuilddir": "test" 20:38:55 INFO - } 20:38:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/GN1EdAu3Rxiw8l_SPc4WwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 20:38:55 INFO - Running post-action listener: _resource_record_post_action 20:38:55 INFO - [mozharness: 2016-08-30 03:38:55.471894Z] Finished read-buildbot-config step (success) 20:38:55 INFO - [mozharness: 2016-08-30 03:38:55.471982Z] Running download-and-extract step. 20:38:55 INFO - Running pre-action listener: _resource_record_pre_action 20:38:55 INFO - Running main action method: download_and_extract 20:38:55 INFO - mkdir: /builds/slave/test/build/tests 20:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:38:55 INFO - trying https://queue.taskcluster.net/v1/task/GN1EdAu3Rxiw8l_SPc4WwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:38:55 INFO - Downloading https://queue.taskcluster.net/v1/task/GN1EdAu3Rxiw8l_SPc4WwA/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 20:38:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GN1EdAu3Rxiw8l_SPc4WwA/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 20:38:56 INFO - Downloaded 1361 bytes. 20:38:56 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:38:56 INFO - Using the following test package requirements: 20:38:56 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:38:56 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:38:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:38:56 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:38:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:38:56 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:38:56 INFO - u'jsshell-linux-x86_64.zip'], 20:38:56 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:38:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:38:56 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:38:56 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:38:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:38:56 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:38:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:38:56 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:38:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:38:56 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:38:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:38:56 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:38:56 INFO - trying https://queue.taskcluster.net/v1/task/GN1EdAu3Rxiw8l_SPc4WwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:38:56 INFO - Downloading https://queue.taskcluster.net/v1/task/GN1EdAu3Rxiw8l_SPc4WwA/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 20:38:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GN1EdAu3Rxiw8l_SPc4WwA/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 20:38:56 INFO - Downloaded 20316003 bytes. 20:38:56 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 20:39:01 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 20:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:39:01 INFO - trying https://queue.taskcluster.net/v1/task/GN1EdAu3Rxiw8l_SPc4WwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:39:01 INFO - Downloading https://queue.taskcluster.net/v1/task/GN1EdAu3Rxiw8l_SPc4WwA/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 20:39:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GN1EdAu3Rxiw8l_SPc4WwA/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 20:39:02 INFO - Downloaded 20316003 bytes. 20:39:02 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 20:39:06 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')]} 20:39:06 INFO - trying https://queue.taskcluster.net/v1/task/GN1EdAu3Rxiw8l_SPc4WwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:39:06 INFO - Downloading https://queue.taskcluster.net/v1/task/GN1EdAu3Rxiw8l_SPc4WwA/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 20:39:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GN1EdAu3Rxiw8l_SPc4WwA/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 20:39:07 INFO - Downloaded 14413998 bytes. 20:39: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 20:39: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')]} 20:39:07 INFO - trying https://queue.taskcluster.net/v1/task/GN1EdAu3Rxiw8l_SPc4WwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:39:07 INFO - Downloading https://queue.taskcluster.net/v1/task/GN1EdAu3Rxiw8l_SPc4WwA/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 20:39:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GN1EdAu3Rxiw8l_SPc4WwA/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 20:39:08 INFO - Downloaded 55854374 bytes. 20:39:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GN1EdAu3Rxiw8l_SPc4WwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:39:08 INFO - mkdir: /builds/slave/test/properties 20:39:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:39:08 INFO - Writing to file /builds/slave/test/properties/build_url 20:39:08 INFO - Contents: 20:39:08 INFO - build_url:https://queue.taskcluster.net/v1/task/GN1EdAu3Rxiw8l_SPc4WwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:39:09 INFO - Running post-action listener: _resource_record_post_action 20:39:09 INFO - Running post-action listener: set_extra_try_arguments 20:39:09 INFO - [mozharness: 2016-08-30 03:39:09.411004Z] Finished download-and-extract step (success) 20:39:09 INFO - [mozharness: 2016-08-30 03:39:09.411231Z] Running populate-webroot step. 20:39:09 INFO - Running pre-action listener: _resource_record_pre_action 20:39:09 INFO - Running main action method: populate_webroot 20:39:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:39:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:39:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:39:09 INFO - '--tppagecycles', 20:39:09 INFO - '7'], 20:39:09 INFO - 'tests': ['tsvgm']}}, 20:39:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:39:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:39:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:39:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:39:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:39:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:39:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:39:09 INFO - 'talos_options': ['--disable-e10s'], 20:39:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:39:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:39:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:39:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:39:09 INFO - 'talos_options': ['--disable-e10s'], 20:39:09 INFO - 'tests': ['damp', 'tps']}, 20:39:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:39:09 INFO - 'tests': ['damp', 'tps']}, 20:39:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:39:09 INFO - 'tests': ['dromaeo_dom']}, 20:39:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:39:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:39:09 INFO - 'tests': ['basic_compositor_video']}, 20:39:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:39:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:39:09 INFO - 'tests': ['a11yr', 20:39:09 INFO - 'ts_paint', 20:39:09 INFO - 'tpaint', 20:39:09 INFO - 'sessionrestore', 20:39:09 INFO - 'sessionrestore_no_auto_restore', 20:39:09 INFO - 'tabpaint']}, 20:39:09 INFO - 'other-e10s': {'tests': ['a11yr', 20:39:09 INFO - 'ts_paint', 20:39:09 INFO - 'tpaint', 20:39:09 INFO - 'sessionrestore', 20:39:09 INFO - 'sessionrestore_no_auto_restore', 20:39:09 INFO - 'tabpaint']}, 20:39:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:39:09 INFO - 'ts_paint', 20:39:09 INFO - 'tpaint', 20:39:09 INFO - 'sessionrestore', 20:39:09 INFO - 'sessionrestore_no_auto_restore', 20:39:09 INFO - 'tabpaint']}, 20:39:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:39:09 INFO - 'ts_paint', 20:39:09 INFO - 'tpaint', 20:39:09 INFO - 'sessionrestore', 20:39:09 INFO - 'sessionrestore_no_auto_restore', 20:39:09 INFO - 'tabpaint']}, 20:39:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:39:09 INFO - 'tests': ['a11yr', 20:39:09 INFO - 'ts_paint', 20:39:09 INFO - 'tpaint', 20:39:09 INFO - 'sessionrestore', 20:39:09 INFO - 'sessionrestore_no_auto_restore', 20:39:09 INFO - 'tabpaint']}, 20:39:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:39:09 INFO - 'tests': ['a11yr', 20:39:09 INFO - 'ts_paint', 20:39:09 INFO - 'tpaint', 20:39:09 INFO - 'sessionrestore', 20:39:09 INFO - 'sessionrestore_no_auto_restore', 20:39:09 INFO - 'tabpaint']}, 20:39:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:39:09 INFO - 'tests': ['tsvgx', 20:39:09 INFO - 'tsvgr_opacity', 20:39:09 INFO - 'tart', 20:39:09 INFO - 'tscrollx', 20:39:09 INFO - 'cart']}, 20:39:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:39:09 INFO - 'tsvgr_opacity', 20:39:09 INFO - 'tart', 20:39:09 INFO - 'tscrollx', 20:39:09 INFO - 'cart']}, 20:39:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:39:09 INFO - 'talos_options': ['--disable-e10s'], 20:39:09 INFO - 'tests': ['tp5o']}, 20:39:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:39:09 INFO - 'tests': ['tp5o']}, 20:39:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:39:09 INFO - 'talos_options': ['--disable-e10s', 20:39:09 INFO - '--xperf_path', 20:39:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:39:09 INFO - 'tests': ['tp5n']}, 20:39:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:39:09 INFO - 'talos_options': ['--xperf_path', 20:39:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:39:09 INFO - 'tests': ['tp5n']}}, 20:39:09 INFO - 'talos.zip': {'path': '', 20:39:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:39:09 INFO - Running post-action listener: _resource_record_post_action 20:39:09 INFO - [mozharness: 2016-08-30 03:39:09.427564Z] Finished populate-webroot step (success) 20:39:09 INFO - [mozharness: 2016-08-30 03:39:09.427655Z] Running create-virtualenv step. 20:39:09 INFO - Running pre-action listener: _resource_record_pre_action 20:39:09 INFO - Running main action method: create_virtualenv 20:39:09 INFO - Creating virtualenv /builds/slave/test/build/venv 20:39:09 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 20:39:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:39:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:39:09 INFO - Using real prefix '/usr' 20:39:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:39:10 INFO - Installing distribute.............................................................................................................................................................................................done. 20:39:12 INFO - Installing pip.................done. 20:39:12 INFO - Return code: 0 20:39:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:39: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')]} 20:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39: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')]} 20:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39: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 0x7f5e16a59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2197090>, '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 0x219a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219ae40>, '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': 'ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119', '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 20:39: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 20:39: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 20:39:12 INFO - Using env: {'DISPLAY': ':0', 20:39:12 INFO - 'HOME': '/home/cltbld', 20:39:12 INFO - 'LANG': 'en_US.UTF-8', 20:39:12 INFO - 'LANGUAGE': 'en_US:en', 20:39:12 INFO - 'LOGNAME': 'cltbld', 20:39:12 INFO - 'MAIL': '/var/mail/cltbld', 20:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:12 INFO - 'MOZ_NO_REMOTE': '1', 20:39:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:12 INFO - 'NO_EM_RESTART': '1', 20:39:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:12 INFO - 'PWD': '/builds/slave/test', 20:39:12 INFO - 'SHELL': '/bin/bash', 20:39:12 INFO - 'SHLVL': '1', 20:39:12 INFO - 'TERM': 'linux', 20:39:12 INFO - 'TMOUT': '86400', 20:39:12 INFO - 'USER': 'cltbld', 20:39:12 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119', 20:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:12 INFO - '_': '/tools/buildbot/bin/python'} 20:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:12 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 20:39:12 INFO - Cleaning up... 20:39:12 INFO - Return code: 0 20:39:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:39: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')]} 20:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39: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')]} 20:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39: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', '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 0x7f5e16a59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2197090>, '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 0x219a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219ae40>, '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': 'ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119', '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 20:39: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', 'psutil>=3.1.1'] in /builds/slave/test/build 20:39: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 psutil>=3.1.1 20:39:12 INFO - Using env: {'DISPLAY': ':0', 20:39:12 INFO - 'HOME': '/home/cltbld', 20:39:12 INFO - 'LANG': 'en_US.UTF-8', 20:39:12 INFO - 'LANGUAGE': 'en_US:en', 20:39:12 INFO - 'LOGNAME': 'cltbld', 20:39:12 INFO - 'MAIL': '/var/mail/cltbld', 20:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:12 INFO - 'MOZ_NO_REMOTE': '1', 20:39:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:12 INFO - 'NO_EM_RESTART': '1', 20:39:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:12 INFO - 'PWD': '/builds/slave/test', 20:39:12 INFO - 'SHELL': '/bin/bash', 20:39:12 INFO - 'SHLVL': '1', 20:39:12 INFO - 'TERM': 'linux', 20:39:12 INFO - 'TMOUT': '86400', 20:39:12 INFO - 'USER': 'cltbld', 20:39:12 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119', 20:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:12 INFO - '_': '/tools/buildbot/bin/python'} 20:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:12 INFO - Downloading/unpacking psutil>=3.1.1 20:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:39:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:39:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:39:14 INFO - Installing collected packages: psutil 20:39:14 INFO - Running setup.py install for psutil 20:39:14 INFO - building 'psutil._psutil_linux' extension 20:39:14 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 20:39:14 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 20:39:14 INFO - building 'psutil._psutil_posix' extension 20:39:14 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 20:39:14 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 20:39:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:39:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:39:14 INFO - Successfully installed psutil 20:39:14 INFO - Cleaning up... 20:39:14 INFO - Return code: 0 20:39:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:39:14 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')]} 20:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:14 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')]} 20:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:14 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 0x7f5e16a59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2197090>, '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 0x219a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219ae40>, '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': 'ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119', '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 20:39:14 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 20:39:14 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 20:39:14 INFO - Using env: {'DISPLAY': ':0', 20:39:14 INFO - 'HOME': '/home/cltbld', 20:39:14 INFO - 'LANG': 'en_US.UTF-8', 20:39:14 INFO - 'LANGUAGE': 'en_US:en', 20:39:14 INFO - 'LOGNAME': 'cltbld', 20:39:14 INFO - 'MAIL': '/var/mail/cltbld', 20:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:14 INFO - 'MOZ_NO_REMOTE': '1', 20:39:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:14 INFO - 'NO_EM_RESTART': '1', 20:39:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:14 INFO - 'PWD': '/builds/slave/test', 20:39:14 INFO - 'SHELL': '/bin/bash', 20:39:14 INFO - 'SHLVL': '1', 20:39:14 INFO - 'TERM': 'linux', 20:39:14 INFO - 'TMOUT': '86400', 20:39:14 INFO - 'USER': 'cltbld', 20:39:14 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119', 20:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:14 INFO - '_': '/tools/buildbot/bin/python'} 20:39:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:39:15 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 20:39:15 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 20:39:15 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 20:39:15 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 20:39:15 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 20:39:15 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 20:39:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:39:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:39:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:39:17 INFO - Installing collected packages: mozsystemmonitor 20:39:17 INFO - Running setup.py install for mozsystemmonitor 20:39:17 INFO - Successfully installed mozsystemmonitor 20:39:17 INFO - Cleaning up... 20:39:17 INFO - Return code: 0 20:39:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:39:17 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')]} 20:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:17 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')]} 20:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:17 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 0x7f5e16a59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2197090>, '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 0x219a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219ae40>, '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': 'ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119', '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 20:39:17 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 20:39:17 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 20:39:17 INFO - Using env: {'DISPLAY': ':0', 20:39:17 INFO - 'HOME': '/home/cltbld', 20:39:17 INFO - 'LANG': 'en_US.UTF-8', 20:39:17 INFO - 'LANGUAGE': 'en_US:en', 20:39:17 INFO - 'LOGNAME': 'cltbld', 20:39:17 INFO - 'MAIL': '/var/mail/cltbld', 20:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:17 INFO - 'MOZ_NO_REMOTE': '1', 20:39:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:17 INFO - 'NO_EM_RESTART': '1', 20:39:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:17 INFO - 'PWD': '/builds/slave/test', 20:39:17 INFO - 'SHELL': '/bin/bash', 20:39:17 INFO - 'SHLVL': '1', 20:39:17 INFO - 'TERM': 'linux', 20:39:17 INFO - 'TMOUT': '86400', 20:39:17 INFO - 'USER': 'cltbld', 20:39:17 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119', 20:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:17 INFO - '_': '/tools/buildbot/bin/python'} 20:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:17 INFO - Downloading/unpacking jsonschema==2.5.1 20:39:17 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 20:39:17 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 20:39:17 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 20:39:17 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 20:39:17 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 20:39:17 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 20:39:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:39:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:19 INFO - Downloading functools32-3.2.3-2.tar.gz 20:39:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:39:19 INFO - warning: no files found matching '*.txt' 20:39:19 INFO - no previously-included directories found matching 'build' 20:39:19 INFO - no previously-included directories found matching 'dist' 20:39:19 INFO - no previously-included directories found matching '.git*' 20:39:19 INFO - Installing collected packages: jsonschema, functools32 20:39:19 INFO - Running setup.py install for functools32 20:39:19 INFO - warning: no files found matching '*.txt' 20:39:19 INFO - no previously-included directories found matching 'build' 20:39:19 INFO - no previously-included directories found matching 'dist' 20:39:19 INFO - no previously-included directories found matching '.git*' 20:39:19 INFO - Successfully installed jsonschema functools32 20:39:19 INFO - Cleaning up... 20:39:19 INFO - Return code: 0 20:39:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:39:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5e16a59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2197090>, '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 0x219a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219ae40>, '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': 'ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119', '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 20:39:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:39:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:39:19 INFO - Using env: {'DISPLAY': ':0', 20:39:19 INFO - 'HOME': '/home/cltbld', 20:39:19 INFO - 'LANG': 'en_US.UTF-8', 20:39:19 INFO - 'LANGUAGE': 'en_US:en', 20:39:19 INFO - 'LOGNAME': 'cltbld', 20:39:19 INFO - 'MAIL': '/var/mail/cltbld', 20:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:19 INFO - 'MOZ_NO_REMOTE': '1', 20:39:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:19 INFO - 'NO_EM_RESTART': '1', 20:39:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:19 INFO - 'PWD': '/builds/slave/test', 20:39:19 INFO - 'SHELL': '/bin/bash', 20:39:19 INFO - 'SHLVL': '1', 20:39:19 INFO - 'TERM': 'linux', 20:39:19 INFO - 'TMOUT': '86400', 20:39:19 INFO - 'USER': 'cltbld', 20:39:19 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119', 20:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:19 INFO - '_': '/tools/buildbot/bin/python'} 20:39:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:39:20 INFO - Cleaning up... 20:39:20 INFO - Return code: 0 20:39:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:39: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')]} 20:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39: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')]} 20:39:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39: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 0x7f5e16a59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2197090>, '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 0x219a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219ae40>, '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': 'ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119', '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 20:39: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 20:39: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 20:39:20 INFO - Using env: {'DISPLAY': ':0', 20:39:20 INFO - 'HOME': '/home/cltbld', 20:39:20 INFO - 'LANG': 'en_US.UTF-8', 20:39:20 INFO - 'LANGUAGE': 'en_US:en', 20:39:20 INFO - 'LOGNAME': 'cltbld', 20:39:20 INFO - 'MAIL': '/var/mail/cltbld', 20:39:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:20 INFO - 'MOZ_NO_REMOTE': '1', 20:39:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:20 INFO - 'NO_EM_RESTART': '1', 20:39:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:20 INFO - 'PWD': '/builds/slave/test', 20:39:20 INFO - 'SHELL': '/bin/bash', 20:39:20 INFO - 'SHLVL': '1', 20:39:20 INFO - 'TERM': 'linux', 20:39:20 INFO - 'TMOUT': '86400', 20:39:20 INFO - 'USER': 'cltbld', 20:39:20 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119', 20:39:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:20 INFO - '_': '/tools/buildbot/bin/python'} 20:39:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:20 INFO - Downloading/unpacking blobuploader==1.2.4 20:39: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 20:39: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 20:39: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 20:39: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 20:39: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 20:39: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 20:39:22 INFO - Downloading blobuploader-1.2.4.tar.gz 20:39:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:39:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:39:22 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 20:39:22 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 20:39:22 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 20:39:22 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 20:39:22 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 20:39:22 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 20:39:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:39:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:39:22 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 20:39:22 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 20:39:22 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 20:39:22 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 20:39:22 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 20:39:22 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 20:39:22 INFO - Downloading docopt-0.6.1.tar.gz 20:39:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:39:22 INFO - Installing collected packages: blobuploader, requests, docopt 20:39:22 INFO - Running setup.py install for blobuploader 20:39:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:39:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:39:22 INFO - Running setup.py install for requests 20:39:23 INFO - Running setup.py install for docopt 20:39:23 INFO - Successfully installed blobuploader requests docopt 20:39:23 INFO - Cleaning up... 20:39:23 INFO - Return code: 0 20:39:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:39:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:23 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 0x7f5e16a59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2197090>, '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 0x219a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219ae40>, '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': 'ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119', '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 20:39:23 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 20:39:23 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 20:39:23 INFO - Using env: {'DISPLAY': ':0', 20:39:23 INFO - 'HOME': '/home/cltbld', 20:39:23 INFO - 'LANG': 'en_US.UTF-8', 20:39:23 INFO - 'LANGUAGE': 'en_US:en', 20:39:23 INFO - 'LOGNAME': 'cltbld', 20:39:23 INFO - 'MAIL': '/var/mail/cltbld', 20:39:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:23 INFO - 'MOZ_NO_REMOTE': '1', 20:39:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:23 INFO - 'NO_EM_RESTART': '1', 20:39:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:23 INFO - 'PWD': '/builds/slave/test', 20:39:23 INFO - 'SHELL': '/bin/bash', 20:39:23 INFO - 'SHLVL': '1', 20:39:23 INFO - 'TERM': 'linux', 20:39:23 INFO - 'TMOUT': '86400', 20:39:23 INFO - 'USER': 'cltbld', 20:39:23 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119', 20:39:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:23 INFO - '_': '/tools/buildbot/bin/python'} 20:39:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:39:23 INFO - Running setup.py (path:/tmp/pip-CHpIzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:39:23 INFO - Running setup.py (path:/tmp/pip-byubgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:39:23 INFO - Running setup.py (path:/tmp/pip-9UY6cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:39:23 INFO - Running setup.py (path:/tmp/pip-msiZP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:39:24 INFO - Running setup.py (path:/tmp/pip-hxMNkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:39:24 INFO - Running setup.py (path:/tmp/pip-E3txRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:39:24 INFO - Running setup.py (path:/tmp/pip-e2nbKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:39:24 INFO - Running setup.py (path:/tmp/pip-qvxSUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:39:24 INFO - Running setup.py (path:/tmp/pip-DtyWFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:39:24 INFO - Running setup.py (path:/tmp/pip-UKorY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:39:24 INFO - Running setup.py (path:/tmp/pip-AEyvWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:39:24 INFO - Running setup.py (path:/tmp/pip-0dSHPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:39:24 INFO - Running setup.py (path:/tmp/pip-dsj_Ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:39:24 INFO - Running setup.py (path:/tmp/pip-afehlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:39:24 INFO - Running setup.py (path:/tmp/pip-nMeIu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:39:24 INFO - Running setup.py (path:/tmp/pip-s1o9YH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:39:24 INFO - Running setup.py (path:/tmp/pip-nqDKao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:39:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:39:24 INFO - Running setup.py install for manifestparser 20:39:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:39:25 INFO - Running setup.py install for mozcrash 20:39:25 INFO - Running setup.py install for mozdebug 20:39:25 INFO - Running setup.py install for mozdevice 20:39:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:39:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:39:25 INFO - Running setup.py install for mozfile 20:39:25 INFO - Running setup.py install for mozhttpd 20:39:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:39:25 INFO - Running setup.py install for mozinfo 20:39:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:39:25 INFO - Running setup.py install for mozInstall 20:39:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:39:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:39:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:39:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:39:25 INFO - Running setup.py install for mozleak 20:39:25 INFO - Running setup.py install for mozlog 20:39:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:39:25 INFO - Running setup.py install for moznetwork 20:39:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:39:26 INFO - Running setup.py install for mozprocess 20:39:26 INFO - Running setup.py install for mozprofile 20:39:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:39:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:39:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:39:26 INFO - Running setup.py install for mozrunner 20:39:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:39:26 INFO - Running setup.py install for mozscreenshot 20:39:26 INFO - Running setup.py install for moztest 20:39:26 INFO - Running setup.py install for mozversion 20:39:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:39:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:39:26 INFO - Cleaning up... 20:39:26 INFO - Return code: 0 20:39:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:39:26 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')]} 20:39:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:26 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')]} 20:39:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:26 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 0x7f5e16a59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2197090>, '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 0x219a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219ae40>, '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': 'ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119', '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 20:39:26 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 20:39:26 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 20:39:26 INFO - Using env: {'DISPLAY': ':0', 20:39:26 INFO - 'HOME': '/home/cltbld', 20:39:26 INFO - 'LANG': 'en_US.UTF-8', 20:39:26 INFO - 'LANGUAGE': 'en_US:en', 20:39:26 INFO - 'LOGNAME': 'cltbld', 20:39:26 INFO - 'MAIL': '/var/mail/cltbld', 20:39:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:26 INFO - 'MOZ_NO_REMOTE': '1', 20:39:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:26 INFO - 'NO_EM_RESTART': '1', 20:39:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:26 INFO - 'PWD': '/builds/slave/test', 20:39:26 INFO - 'SHELL': '/bin/bash', 20:39:26 INFO - 'SHLVL': '1', 20:39:26 INFO - 'TERM': 'linux', 20:39:26 INFO - 'TMOUT': '86400', 20:39:26 INFO - 'USER': 'cltbld', 20:39:26 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119', 20:39:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:26 INFO - '_': '/tools/buildbot/bin/python'} 20:39:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:39:26 INFO - Running setup.py (path:/tmp/pip-9uYBfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:39: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)) 20:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:39:27 INFO - Running setup.py (path:/tmp/pip-5TDQmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:39:27 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)) 20:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:39:27 INFO - Running setup.py (path:/tmp/pip-IR09B0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:39:27 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)) 20:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:39:27 INFO - Running setup.py (path:/tmp/pip-fkGJ6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:39:27 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)) 20:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:39:27 INFO - Running setup.py (path:/tmp/pip-hqF182-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:39:27 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)) 20:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:39:27 INFO - Running setup.py (path:/tmp/pip-F4cWuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:39:27 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)) 20:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:39:27 INFO - Running setup.py (path:/tmp/pip-RHQ_33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:39:27 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)) 20:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:39:27 INFO - Running setup.py (path:/tmp/pip-Q2gk8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:39:27 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)) 20:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:39:27 INFO - Running setup.py (path:/tmp/pip-A04xth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:39:27 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)) 20:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:39:27 INFO - Running setup.py (path:/tmp/pip-TzgGsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:39:27 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)) 20:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:39:27 INFO - Running setup.py (path:/tmp/pip-rPDdEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:39:27 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)) 20:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:39:27 INFO - Running setup.py (path:/tmp/pip-sA1NFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:39:27 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)) 20:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:39:27 INFO - Running setup.py (path:/tmp/pip-XCkG8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:39:27 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)) 20:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:39:27 INFO - Running setup.py (path:/tmp/pip-nct0jU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:39:27 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)) 20:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:39:27 INFO - Running setup.py (path:/tmp/pip-LxauoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:39: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)) 20:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:39:28 INFO - Running setup.py (path:/tmp/pip-RP_9dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:39:28 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)) 20:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:39:28 INFO - Running setup.py (path:/tmp/pip-brarnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:39:28 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)) 20:39:28 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)) 20:39:28 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)) 20:39:28 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)) 20:39:28 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)) 20:39:28 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)) 20:39:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:30 INFO - Downloading blessings-1.6.tar.gz 20:39:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:39:30 INFO - Installing collected packages: blessings 20:39:30 INFO - Running setup.py install for blessings 20:39:30 INFO - Successfully installed blessings 20:39:30 INFO - Cleaning up... 20:39:30 INFO - Return code: 0 20:39:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:39:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:39:30 INFO - Reading from file tmpfile_stdout 20:39:30 INFO - Current package versions: 20:39:30 INFO - argparse == 1.2.1 20:39:30 INFO - blessings == 1.6 20:39:30 INFO - blobuploader == 1.2.4 20:39:30 INFO - docopt == 0.6.1 20:39:30 INFO - functools32 == 3.2.3-2 20:39:30 INFO - jsonschema == 2.5.1 20:39:30 INFO - manifestparser == 1.1 20:39:30 INFO - mozInstall == 1.12 20:39:30 INFO - mozcrash == 0.17 20:39:30 INFO - mozdebug == 0.1 20:39:30 INFO - mozdevice == 0.48 20:39:30 INFO - mozfile == 1.2 20:39:30 INFO - mozhttpd == 0.7 20:39:30 INFO - mozinfo == 0.9 20:39:30 INFO - mozleak == 0.1 20:39:30 INFO - mozlog == 3.3 20:39:30 INFO - moznetwork == 0.27 20:39:30 INFO - mozprocess == 0.23 20:39:30 INFO - mozprofile == 0.28 20:39:30 INFO - mozrunner == 6.12 20:39:30 INFO - mozscreenshot == 0.1 20:39:30 INFO - mozsystemmonitor == 0.3 20:39:30 INFO - moztest == 0.7 20:39:30 INFO - mozversion == 1.4 20:39:30 INFO - psutil == 3.1.1 20:39:30 INFO - requests == 1.2.3 20:39:30 INFO - wsgiref == 0.1.2 20:39:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:30 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 0x7f5e16a59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2197090>, '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 0x219a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219ae40>, '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': 'ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119', '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 20:39:30 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 20:39:30 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 20:39:30 INFO - Using env: {'DISPLAY': ':0', 20:39:30 INFO - 'HOME': '/home/cltbld', 20:39:30 INFO - 'LANG': 'en_US.UTF-8', 20:39:30 INFO - 'LANGUAGE': 'en_US:en', 20:39:30 INFO - 'LOGNAME': 'cltbld', 20:39:30 INFO - 'MAIL': '/var/mail/cltbld', 20:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:30 INFO - 'MOZ_NO_REMOTE': '1', 20:39:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:30 INFO - 'NO_EM_RESTART': '1', 20:39:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:30 INFO - 'PWD': '/builds/slave/test', 20:39:30 INFO - 'SHELL': '/bin/bash', 20:39:30 INFO - 'SHLVL': '1', 20:39:30 INFO - 'TERM': 'linux', 20:39:30 INFO - 'TMOUT': '86400', 20:39:30 INFO - 'USER': 'cltbld', 20:39:30 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119', 20:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:30 INFO - '_': '/tools/buildbot/bin/python'} 20:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:30 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)) 20:39:30 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)) 20:39:30 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)) 20:39:30 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)) 20:39:30 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)) 20:39:30 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)) 20:39:30 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)) 20:39:30 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)) 20:39:30 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)) 20:39:30 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)) 20:39:30 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)) 20:39:30 INFO - Cleaning up... 20:39:30 INFO - Return code: 0 20:39:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:30 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 0x7f5e16a59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2197090>, '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 0x219a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219ae40>, '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': 'ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119', '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 20:39:30 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 20:39:30 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 20:39:30 INFO - Using env: {'DISPLAY': ':0', 20:39:30 INFO - 'HOME': '/home/cltbld', 20:39:30 INFO - 'LANG': 'en_US.UTF-8', 20:39:30 INFO - 'LANGUAGE': 'en_US:en', 20:39:30 INFO - 'LOGNAME': 'cltbld', 20:39:30 INFO - 'MAIL': '/var/mail/cltbld', 20:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:30 INFO - 'MOZ_NO_REMOTE': '1', 20:39:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:30 INFO - 'NO_EM_RESTART': '1', 20:39:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:30 INFO - 'PWD': '/builds/slave/test', 20:39:30 INFO - 'SHELL': '/bin/bash', 20:39:30 INFO - 'SHLVL': '1', 20:39:30 INFO - 'TERM': 'linux', 20:39:30 INFO - 'TMOUT': '86400', 20:39:30 INFO - 'USER': 'cltbld', 20:39:30 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119', 20:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:30 INFO - '_': '/tools/buildbot/bin/python'} 20:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:39:30 INFO - Cleaning up... 20:39:30 INFO - Return code: 0 20:39:30 INFO - Running post-action listener: _resource_record_post_action 20:39:30 INFO - Running post-action listener: _start_resource_monitoring 20:39:30 INFO - Starting resource monitoring. 20:39:30 INFO - [mozharness: 2016-08-30 03:39:30.983938Z] Finished create-virtualenv step (success) 20:39:30 INFO - [mozharness: 2016-08-30 03:39:30.984395Z] Running install step. 20:39:30 INFO - Running pre-action listener: _resource_record_pre_action 20:39:30 INFO - Running main action method: install 20:39:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:39:31 INFO - Reading from file tmpfile_stdout 20:39:31 INFO - Detecting whether we're running mozinstall >=1.0... 20:39:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:39:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:39:31 INFO - Reading from file tmpfile_stdout 20:39:31 INFO - Output received: 20:39:31 INFO - Usage: mozinstall [options] installer 20:39:31 INFO - Options: 20:39:31 INFO - -h, --help show this help message and exit 20:39:31 INFO - -d DEST, --destination=DEST 20:39:31 INFO - Directory to install application into. [default: 20:39:31 INFO - "/builds/slave/test"] 20:39:31 INFO - --app=APP Application being installed. [default: firefox] 20:39:31 INFO - mkdir: /builds/slave/test/build/application 20:39:31 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'] 20:39:31 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 20:39:47 INFO - Reading from file tmpfile_stdout 20:39:47 INFO - Output received: 20:39:47 INFO - /builds/slave/test/build/application/firefox/firefox 20:39:47 INFO - Running post-action listener: _resource_record_post_action 20:39:47 INFO - [mozharness: 2016-08-30 03:39:47.414129Z] Finished install step (success) 20:39:47 INFO - [mozharness: 2016-08-30 03:39:47.414470Z] Running run-tests step. 20:39:47 INFO - Running pre-action listener: _resource_record_pre_action 20:39:47 INFO - Running main action method: run_tests 20:39:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:39:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:39:47 INFO - Python 2.7.3 20:39:47 INFO - Return code: 0 20:39:47 INFO - grabbing minidump binary from tooltool 20:39:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:39:47 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 0x2197090>, '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 0x219a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219ae40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:39:47 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 20:39:47 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 20:39:47 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 20:39:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:39:47 INFO - Return code: 0 20:39:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:39:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:39:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:39:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:39:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:39:47 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/GN1EdAu3Rxiw8l_SPc4WwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 20:39:47 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/GN1EdAu3Rxiw8l_SPc4WwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 20:39:47 INFO - Using env: {'DISPLAY': ':0', 20:39:47 INFO - 'HOME': '/home/cltbld', 20:39:47 INFO - 'LANG': 'en_US.UTF-8', 20:39:47 INFO - 'LANGUAGE': 'en_US:en', 20:39:47 INFO - 'LOGNAME': 'cltbld', 20:39:47 INFO - 'MAIL': '/var/mail/cltbld', 20:39:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:39:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:39:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:47 INFO - 'MOZ_NO_REMOTE': '1', 20:39:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:39:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:47 INFO - 'NO_EM_RESTART': '1', 20:39:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:47 INFO - 'PWD': '/builds/slave/test', 20:39:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:39:47 INFO - 'SHELL': '/bin/bash', 20:39:47 INFO - 'SHLVL': '1', 20:39:47 INFO - 'TERM': 'linux', 20:39:47 INFO - 'TMOUT': '86400', 20:39:47 INFO - 'USER': 'cltbld', 20:39:47 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119', 20:39:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:47 INFO - '_': '/tools/buildbot/bin/python'} 20:39:47 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/GN1EdAu3Rxiw8l_SPc4WwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 20:39:47 INFO - mozversion application_buildid: 20160829191121 20:39:47 INFO - mozversion application_changeset: 08e4eadbb77d5789e41559ced20dc3fef8b93002 20:39:47 INFO - mozversion application_display_name: Nightly 20:39:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:39:47 INFO - mozversion application_name: Firefox 20:39:47 INFO - mozversion application_remotingname: firefox 20:39:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:39:47 INFO - mozversion application_vendor: Mozilla 20:39:47 INFO - mozversion application_version: 51.0a1 20:39:47 INFO - mozversion platform_buildid: 20160829191121 20:39:47 INFO - mozversion platform_changeset: 08e4eadbb77d5789e41559ced20dc3fef8b93002 20:39:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:39:47 INFO - mozversion platform_version: 51.0a1 20:39:47 INFO - using testdate: 1472528387 20:39:47 INFO - actual date: 1472528387 20:39:47 INFO - starting webserver on 'localhost:44137' 20:39:47 INFO - SUITE-START | Running 2 tests 20:39:47 INFO - TEST-START | dromaeo_css 20:39:47 INFO - operating with platform_type : linux_ 20:39:47 INFO - Initialising browser for dromaeo_css test... 20:39:47 INFO - TEST-INFO | started process 7080 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIuzwgH/profile http://localhost:44137/getInfo.html) 20:39:52 INFO - PROCESS | 7080 | __metrics Screen width/height:1600/1200 20:39:52 INFO - PROCESS | 7080 | colorDepth:24 20:39:52 INFO - PROCESS | 7080 | Browser inner width/height: 1024/697 20:39:52 INFO - PROCESS | 7080 | __metrics 20:39:52 INFO - PROCESS | 7080 | 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" 20:39:52 INFO - PROCESS | 7080 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:39:53 INFO - PROCESS | 7080 | console.error: PushService: 20:39:53 INFO - PROCESS | 7080 | stateChangeProcessEnqueue: Error transitioning state 20:39:53 INFO - PROCESS | 7080 | UnknownError 20:39:53 INFO - TEST-INFO | 7080: exit 0 20:39:53 INFO - Browser initialized. 20:39:53 INFO - Running cycle 1/1 for dromaeo_css test... 20:39:53 INFO - TEST-INFO | started process 7160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIuzwgH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:40:05 INFO - PROCESS | 7160 | RSS: Main: 181932032 20:40:05 INFO - PROCESS | 7160 | 20:40:56 INFO - PROCESS | 7160 | 1472528456850 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] 20:43:09 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:44137/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44137/tests/dromaeo/cssquery-ext.html) 20:43:11 INFO - PROCESS | 7160 | RSS: Main: 358604800 20:43:11 INFO - PROCESS | 7160 | 20:46:14 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:44137/tests/dromaeo/cssquery-ext.html (next: http://localhost:44137/tests/dromaeo/cssquery-jquery.html) 20:46:15 INFO - PROCESS | 7160 | RSS: Main: 271802368 20:46:15 INFO - PROCESS | 7160 | 20:49:17 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:44137/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44137/tests/dromaeo/cssquery-mootools.html) 20:49:17 INFO - PROCESS | 7160 | RSS: Main: 218447872 20:49:17 INFO - PROCESS | 7160 | 20:52:20 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:44137/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44137/tests/dromaeo/cssquery-prototype.html) 20:52:20 INFO - PROCESS | 7160 | RSS: Main: 218148864 20:52:20 INFO - PROCESS | 7160 | 20:55:23 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:44137/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44137/tests/dromaeo/cssquery-yui.html) 20:55:24 INFO - PROCESS | 7160 | RSS: Main: 218845184 20:55:24 INFO - PROCESS | 7160 | 20:58:27 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:44137/tests/dromaeo/cssquery-yui.html (next: http://localhost:44137/tests/dromaeo/cssquery-dojo.html) 20:58:27 INFO - PROCESS | 7160 | RSS: Main: 310149120 20:58:27 INFO - PROCESS | 7160 | 20:58:27 INFO - PROCESS | 7160 | __start_tp_report 20:58:27 INFO - PROCESS | 7160 | _x_x_mozilla_page_load 20:58:27 INFO - PROCESS | 7160 | _x_x_mozilla_page_load_details 20:58:27 INFO - PROCESS | 7160 | |i|pagename|runs| 20:58:27 INFO - PROCESS | 7160 | |0;dojo.html;2573.446708957574;2588.314096764359;2603.6615240018796;2613.725558816325;2625.4749050189967;4523.909521809562;4640.651951103664;4641.350210970467;4706.717596944181;4779.569838714515;4670.556297151774;4672.5327467253255;4681.110588988098;4686.156491831469;4742.976285118578;4318.07161460286;4365.978170109145;4386.868393948187;4398.626116780078;4398.868033958986;4351.19502891966;4356.346548017791;4375.409319741826;4389.648828093745;4443.622292105175;4391.824327026915;4437.534058923815;4462;4462.709923854939;4463.73217606943;4211.578842115795;4284.850030248957;4351.0862718829085;4390.1878152541885;4409.316555933835;4206.6003729645945;4223.66210703146;4242.512111107231;4298.720583162084;4308.987387963826;4586.151561961048;4661.743604101773;4663.720176789404;4670.626349892001;4675.345451636774;4798.328234047236;4963.726995015273;5008.649394542384;5010.123228435009;5027.0448614763445;5005.624578156653;5047.47001564834;5118.513741194618;5122.718250496221;5124.769385377667;4726.692764970266;4765.261384485445;4765.356676848651;4766.189747742892;4821.710697358169;5081.593472522263;5083.262926875583;5227.921581176285;5229.973850130801;5240.502152295526;4928.950710492849;4936.086823937583;4944.826931057396;5011.448740638527;5012.7994880205115;5020.046191223656;5020.49795020495;5027.396712394463;5030.195168772979;5095.108356037753;4877.048975449753;4937.530934561211;4979.875503112378;4991.825286115041;4993.251012348104;4921.926171107436;4942.752862356868;4954.777035033432;5053.620978426633;5059.8988020239385;4329.28566786483;4332.891677708019;4373.2565463871215;4381.6494680425485;4384.079343337935;3750.4186851038135;3772.962270377261;3782.5650050244026;3822.3310920588788;3843.8270277837564;4217.367394890791;4240.6395456385935;4271.145770845781;4301.204277208663;4313.202057619351;5016.372953380827;5025.7989680412375;5052.949470505321;5075.568576671024;5108.055009823194;4227.32362821947;4258.808353624095;4263.253930562139;4290.635295999812;4311.784410779448;4434.2240107981615;4495.348174514677;4501.48232953208;4510.2783554631105;4532.66005049616;4689.249720044776;4701.717896926264;4724.905501889874;4745.193317136026;4751.596114330182;5025.673331233458;5041.0422019816115;5048.268001139888;5053.472094947029;5109.642325037212;4545.9090818182785;4681.742504162167;4685.969086800898;4700.905981880412;4751.40607424072;4875.731834749123;4950.084234416644;4953.479884612064;4969.801207951641;5015.322931404214;5018.899622007466;5033.446320904624;5033.471485494117;5041.319421878;5078.060558796635;4808.495108013748;4873.439554451284;4900.191468407673;4904.607631389409;4971.552560269593;4858.368412106403;4908.190148625436;4931.827386041471;4932.580730637936;4935.309056732132;4841.612670986383;4857.222844344888;4873.878153046202;4875.902481950412;4891.33966914462;4894.535019173173;4959.677620954626;4962.33008543842;4963.057019166346;4976.825811096594;4839.975800120977;4844.806207751651;4848.175810112219;4881.048195601824;4895.828645997373 20:58:27 INFO - PROCESS | 7160 | |1;ext.html;562.5274769193877;572.8940146072977;573.0802062689384;575.0884847516686;581.935987041425;28037.859810700942;39254.411183832264;40477.39283910744;40515;44080;40474.7976260119;40700.389494157615;40791;40901.7954910225;40955;7697.384209263273;7804.687812487494;7842.411819113589;7887.8422431551335;7894;7349.926500734978;9835.065668761456;10081.143102836268;10091.394516329006;10373.948130259376;10154.746131346701;10239.539220735047;10246.487675616227;10263.640772572962;10270.589176432934;10062.74843128924;10087.798244035152;10118.241131915061;10132.797344053151;10136.13842823361;10045.447500387476;10108.595656173744;10119.089281964585;10121.898781012169;10127.189824814071;37225.25549489022;37480.43779343312;37481.25037499262;37534.81232593847;37640.24719505622;2794.986025069882;2802.355458244595;2900.260433589442;2944.3522425066453;3117.719405253538;28589;28629;28724.8563757182;29289.85355073232;31153.376932461222;3327.168207948013;3385.2890892912274;3387.1532116970757;3400.336934297813;3405.591329040531;261041;261791;262296;262354;263881;31836;32827.50758738621;53500.73249633727;53843;53873;33346.833265834;33446.832765836014;33666;33681.326373472395;33729.15677108043;13143.277119758313;13298.468061277634;13302.600921972356;13308.467661293633;13310.334483275798;10053.195744340435;10280.742981425374;10329.276950613385;10383.480825958823;10385.584576616851;7311.378532824663;7360.926390736024;7474.439417043744;7768.378529717609;7821.530708157528;3046.491986466713;3048.192229059301;3060.372623612199;3064.3718037802196;3115.454795410794;841.4236248170023;931.4132096778986;972.8783902012249;1002.3284399452384;1018.8828284747201;26500.292337752733;27298.45403091927;27710.33615151832;27778.72221277802;27786;893.6425429828121;914.8627705844043;937.723371605378;948.0945696859483;992.692265397729;14330.57008289753;14675.19286439256;14918.850811491964;14972.700545989019;14993.925030374778;397765;399611;400119;400341;401186;48281.75859120752;48612.513874861506;48704.512954870705;48791.5120848787;48801.75599121982;1053.578568572577;1135.0579019413701;1178.8172833210865;1180.262336039975;1189.6014835030362;27172.864135679196;28358.291042724097;28979.420411592073;29589.85205073961;30115.54826677558;47887.521124788305;49805.75097124491;49838.50161498338;53896.73051634717;53965.460345396044;372496;375450;375547;376035;376398;24279.635805463284;25270.49459010846;25301.493970120126;26256.60615090737;26417.471650567266;41617;42914.57085429106;43072.35391469193;46599.30101048419;47987.5201247997;35786;35882.34415380742;36007.63992360043;36179.45730813987;36767.44848827216;36679;36882.8155859219;37034.44448333331;37448;37652.435213471275;35273.118172045906;35748.4637730429;35758;36211.81894090513;36248.81875590605;30487.54268685927;32961.34077318488;32995.34009319752;33425.49861752124;33446.16384590307;25009.12468063609;25556.616650749882;25647.87176064108;25680.357991050372;25998.22005339843 20:58:27 INFO - PROCESS | 7160 | |2;jquery.html;343.3630615208786;366.41556717036326;367.06215619093206;370.22992176273357;383.5301755349697;12621.62135135945;14391.856081439182;16282.83717162828;16484.17579121045;17119.31522739089;16310.836891631081;16623.251953662086;16797.83202167978;16899.91550042251;16904.83095169048;5553.333599968009;5816.738246778884;5861.7948371807;5868.061110222366;5956.642601443906;5759.280089988752;5840.737166827482;5886.911696324559;5940.257467816523;5981.730822113015;5966.522678185756;5966.9403305967035;5969.403059694039;5975.820725378246;5976.432238937316;5925.792597259118;5926.703664816763;6560.245571759261;6827.21487028993;6870.416014638712;6466.838329041764;6711.932880671179;6717.16035495563;6726.83182920426;6728.192616885956;18856;19230.423087307405;19248.807511924842;20541.8972905136;23541.646875296883;2043.764967028781;2049.733534640502;2147.14114354258;2303.9539209215723;2559.7952163827035;13779;14526.564203073925;14801.70396592073;14881.404743810235;15209;1823.179569193868;1885.58517126232;1888.357958294173;1891.3474851176322;1946.698261769428;71153.64423177902;75186.62406687986;77816.22183778202;77904;79181.60409197975;16125.516234512983;16207.270672819515;17096.316147353966;17117.914410427868;17379.391721289696;28032.29919252035;28037.57943630847;28170.71829281722;28207;28405.85797071043;8476;8691.739247822576;8920.063393343735;9085.591148398338;9271.211946984447;7092.929070709227;7205.387542058879;7269.3094156055095;7393.519421237603;7397.667104980289;8097.878531822027;8128.9187108129345;8203;8389.119142490074;8499.150084991452;3197.6642452542146;3299.686529779667;3327.1183136468853;3351.2794749128566;3360.7143392811886;739.7226040234912;817.5217497763874;820.0446479850907;877.3639111644007;898.5058217980085;15266.923665381602;16184.595385115232;16226.594335141479;16290.185490725416;17078.829211707725;837.6398148796076;850.7107583421666;880.5377176982007;884.9247813935759;903.3856977255398;9186.908130918606;9217.354785164975;9576.090271424204;9646.614135434644;9733.853992190123;353671;355570;357646;370994;380766;49553.80577427822;50811.23783143256;59474.70262648659;79919;83062;939.5443210042987;946.4510583861344;995.2833959549258;1000.6897861662908;1001.3891526169031;15271.312790924212;15555.533333999998;15647.452339168074;15708.92145539265;16324.755128673318;36510.63489365178;37071;37522;38163.61836381601;38362.808185960006;49421;51430.48569514257;51771.482285176666;52398.476015240885;53316;7487.251274872469;7663.731769388045;8031.879521807295;10365.689029329133;10560.947195263974;11491.712707182387;11563.537458501565;11817.231879927776;12768.999285167793;12914;10233.84649230277;10459.94770026145;10562.630307939186;10619.840702389316;10992.725181870517;4979.726115063706;8092.919070809452;10093.788745350605;10430.843537346795;10694.358338499715;10232.130268927225;10343.431111288952;10365;10574.8413773795;10931.344119352865;11476.196666233283;11480;11591.6522504325;11865.703357416134;11881.108916831445;9985.650502232387;10454.529546170288;10488.790224195322;10685.839712404164;10691.198160137865 20:58:27 INFO - PROCESS | 7160 | |3;mootools.html;1342.141029740966;1371.7187976464822;1443.3072125379817;1649.9587510312233;1655.0731590309429;7325.157606875205;7941.133833549118;7948.205179482049;7950.483218590787;7953.840923181533;6584.078229047937;6810.863782724343;6811.965940170292;6955.652217389123;7772.766816995485;2010.6079314533672;2093.6126816538913;2096.140582361232;2109.92615258466;2116.47088227943;2135.7330333708287;2187.573423182472;2199.8900054997184;2207.5033117548583;2221.2114699281765;2194.8244140468723;2203.735551733786;2205.8676479411206;2205.9889700551475;2208.5472478142024;2118.1527389044427;2125.91496340147;2158.8989615296155;2164.6428339323993;2165.339571430713;2109.0825490911348;2116.904739286736;2119.5337025854287;2119.8728076315315;2143.7641859395453;7778.5721785301785;7802.843943121163;7862.449628526006;7887.053553573551;7888.842223155562;4515.096980603859;4671.229247174212;4674.976625116887;4675.812967481296;4677.438707355105;2862.4418238443513;2938.2507460597626;2961.7926745127634;3002.069358498872;3068.447679417704;955.3217215776807;979.6669132494915;989.1987490133015;1013.2096964367805;1020.209337763232;10660.147188224923;10664.840027399596;10672.893271067345;10673.306235094695;10682.626108086257;3846.8265430031943;3970.4441378207075;4088.2436749201493;4107.9178416431505;4132.73137246078;9012.54937253148;9032.63869445228;9043.59303831329;9046.954765226263;9053.321000924958;4632.467266264355;4632.97683511587;4639.350490931272;4642.651801114863;4643.11780761661;4136.751794892316;4225.302825033897;4247.6389506892265;4250.06498570314;4252.638525725348;3604.675579197885;3631.6005239423644;3711.925761484755;3718.5909549950024;3755.3240416724707;1179.9705007374712;1204.728935989413;1206.3968015992004;1221.6640423883325;1224.2593231095059;598.8622616798161;665.6738198282807;719.7013239505651;830.33158307563;850.9829803403898;4881.219004959261;5077.847664570068;5128.8461346159675;5211.270422140903;5213.061648903234;842.8482873082904;891.80826122384;900.1718419054486;922.6171138977384;929.8326301265702;3172.857221425041;3203.615566132079;3214.5660335854827;3260.6902344277255;3341.348437054751;9235.445873247627;9741.512924353754;9748.171405430618;9772.51137443125;9776.462294573867;9626.95186524063;9639.373440726331;9639.662611808553;9666;9669.129778319984;7070.328318809705;7182.3535881770895;7187.784366469119;7190.316919892706;7192.0290760747675;4792.113459010095;4792.976035119802;4850.684705494132;4874.073925954058;5005.224190250517;8484.745457636282;8503.532305722998;8704.825903482022;8717.738467845975;8816.559172041243;8588.398812083095;8825.073367296342;8894.243989260985;8909.688160914337;9021.90978090237;5682.687452190169;5791.971040144772;5931.169636251015;5962.344142144448;6179.443850053517;6691.397774200345;7093.787186384417;7173.964130179315;7201.819954501179;7202.351788339075;6304.968475157595;6417.26201486835;6472.902906456501;6689.09697190873;6718.932810672026;6270.184875966095;6359.491240700825;6360.840978975562;6528.2492513359675;6577.736890524326;6068.21113255274;6087.756489740361;6113.84715382119;6150.384961503813;6177.4749146323065;4186.560411156906;4253.9361909572;4299.355096735515;4301.827926882889;4392.472903251502;4433.933490997702;4442.133783912106;4508.887277817949;4549.658775591778;4665.2768820832825 20:58:27 INFO - PROCESS | 7160 | |4;prototype.html;278.0587710599621;278.11282010386867;282.2478095874494;286.1401488526976;286.3828449690917;4740.69185502942;4756.38167038285;4806.846356874346;4841.514109840918;4874.951250487494;4779.64152688548;4801.975990120053;4806.20697584899;4818.566329030386;4833.299171620113;3520.718342532604;3554.1647712787476;3735.477033215352;3744.7378683492166;3754.361758501048;3666.7066634669295;3691.8338674759702;3695.316366472198;3704.6480584344445;3723.4414837774416;3672.8163591820435;3681.337359275329;3691.338897496124;3693.4644476550884;3703.2778608171416;3487.9651203487892;3543.7519373643854;3680.1535646801117;3696.8706095286534;3721.0650461760006;3175.5871736674085;3179.7933134346426;3183.9681603183903;3190.6649801770945;3192.1062102611304;4615.376924115235;4659.324397962277;4668.579827815479;4679.508651591568;4682.742449165295;4142.1922725068625;4149.128682976579;4160.91678166438;4177.895552611179;4211.936820947688;4872.220444728861;4975.179095449246;4978.278149668277;4978.7510624469;4979.701217926936;3479.5302634144573;3481.3211423772123;3485.954213735869;3486.3027394520946;3500.912477188065;5262.842114736564;5273;5301.761420736076;5319.0957537218765;5326.92009619856;3376;3519.1378112362636;3554.147004718849;3573.8749143780365;3579.4451859961746;3588.569371675416;3591.8204089795404;3601.2077342984503;3607.296577167427;3611.4582812577796;4168.437260969791;4180.979095104505;4200.474940632421;4206.326987682018;4217.97891010543;4977.9751101244265;5091.9236211456855;5094.6688465249645;5095.85343297755;5114.744262786846;1224.2409705982348;1226.436293725507;1227.699213692633;1232.796588562877;1233.426456697622;760.4106817216591;781.4490783997268;788.8540619985321;798.1499702816482;803.2128514056258;3970.7021973351534;4218.451601291812;4304.418903447994;4446.755428451466;4453.19842428366;5037.566941091815;5111.3355263815465;5173.482651734872;5183.7558985843125;5194.4026436959475;4397.428334316518;4407.096545208225;4409.9559004410185;4411.669124815651;4414.073044660658;2642.7753640940737;2702.4459985702883;2715.511207982582;2733.7676297514936;2736.616873637692;4809.591184749265;4821.445533763592;4833.854984350475;4834.347363105936;4836.975815120902;5216.061109000417;5250.422453530108;5263.315768950089;5274.947250527445;5296.788128474895;4632.97683511587;4818.253170758468;4818.68678535901;4827.710337379768;4832.4684284728655;5145.974270128625;5155.355580552431;5161.7677204526635;5178.249153872743;5185.248139019896;5097.770600323069;5098.872528186676;5109.08036553424;5121.539061484485;5124.615653825904;4611.146937816515;4858.878528036686;4872.634552408513;4892.657513973988;4895.681780684244;3598.6581274778855;3634.164142247245;3652.379095553815;3658.8536458542426;3664.0656632558525;5275.920861187008;5278.340207474066;5292.311999440049;5304.787808487772;5315.096433606219;4998.825041123543;5060.165072762953;5106.846794596168;5119.257707632447;5132.204508301219;5039.47085556026;5048.596112310933;5053.949460505348;5072.82245121419;5080.390353157497;4873.098476781806;5004.274380214922;5008.9248661269385;5009.699418034929;5035.823746168867;4802.831900883452;4917.704937703749;5028.572571331478;5048.974755126201;5064.240363945438;4881;4898.750818541249;4918.631102667386;4925.433575138905;4932.556069953722 20:58:27 INFO - PROCESS | 7160 | |5;yui.html;625.6652690810417;652.168485181394;652.8074218105661;661.4476911778663;740.7888751705765;12187.268763874163;12930.28883411412;12973.675658108528;12975.67560810979;13015.804762928563;12464.31446270457;12602.36988150591;12653.683657908534;12659.367031648428;12851.935740321309;596.5466245653291;720.3121019426461;735.077477765405;755.2749360613817;755.6901670315171;743.1008479739495;745.1170363119693;750.1523278695067;754.5359603843651;754.9471536992413;794.990362239955;795.8050277681947;796.3151689546985;796.8485987662355;797.9281864632181;634.3592971099223;758.7306506190279;791.9247671471201;792.3304807437735;793.972210972616;579.0387955993032;579.2151634535186;579.5450571301508;580;580.0718849840264;12878.29169395683;12902.677433064155;12914.612561623073;12917.935410322889;12953.352332383343;11996.280223186637;12168.695782605417;12842.422091005927;13116.344182790917;13261.668458288523;11497.770044599145;11702.473388697528;11813.40932953349;11973.341466219354;12093.57672481459;4019.97990010051;4042.797860106983;4080.510338759338;4233.872983810491;4243.893902652428;64340.67829660868;64649.67675161641;66054.66972665154;66828.6658566709;67633.3236667632;9947.751306217258;10014.699559013241;10103.343282686748;10114.54484548197;10225.539850706737;19150.904245478683;19376.930844522525;19528.609427811363;19594.51013724668;19631.60736785285;6922.10012698346;6932.168139823253;7029.0862187915245;7196.532225405332;7201.171865235565;3669.889903302905;3711.480392745018;3718.925621487555;3763.7177211708686;3783.4892289541112;2812.9578056329174;2926.8536573171255;2934.427786581596;2937.9265518361785;2940.779441541893;494.75509622736973;506.1648280337399;512.7974450092192;518.7924830067927;534.6444614331426;424.8916526285839;473.0090460485278;513.9511746384162;518.2925306955977;534.3267482971406;7368.226336234618;7396.223396543285;7534.886976695354;7543.47195696307;7616.80957976055;493.58785414178845;530.6046994988681;541.7372574301461;564.5906717629767;565.6069032022705;3338.7162091222517;3487.6861082502696;3526.84129214186;3566.7503274770515;3611.6749492545273;56270.71864640651;56625;71213;104753.47623261987;104758;56949.71525142348;84677;87794;88445;89336.553317233;52230;76638.61680691561;76958.23041769622;78907.60546197233;78969.21030789618;6818.249992500921;6904.169290590834;6923.826904327432;6964.955256711533;7206;45713;45819;46256.53743462522;46745;47322.76338618285;36184.457233140995;49282;63359.68320158554;63598;63793;8721.433106848035;9407.341486095907;9478.52607369615;9575.856362154434;9712.805743885225;10455.268131230741;10543.15654747603;10704.411257380607;10818.24272300963;11052.957341982188;9365.157135857806;9424.95287523558;9562.713118606453;9900.455474948947;10116.797664046826;9866.112049915542;10005.899941000496;10063.647772327933;10094.293399462262;10584.259101863103;9304.302177336862;9503.857442138511;9685.370450920667;9883.209343252378;10104.949475252577;8226.30076443485;8255.876161857457;8285.295749861089;8313.251807337369;8821.867671985054;8148.511089334659;8388.161183881562;8541.188587084218;8642.654293828427;8673.262772664395 20:58:27 INFO - PROCESS | 7160 | __end_tp_report 20:58:27 INFO - PROCESS | 7160 | __start_cc_report 20:58:27 INFO - PROCESS | 7160 | _x_x_mozilla_cycle_collect,1803 20:58:27 INFO - PROCESS | 7160 | __end_cc_report 20:58:27 INFO - PROCESS | 7160 | __startTimestamp1472529507792__endTimestamp 20:58:27 INFO - PROCESS | 7160 | 20:58:27 INFO - PROCESS | 7160 | ------- Summary: start ------- 20:58:27 INFO - PROCESS | 7160 | Number of tests: 6 20:58:27 INFO - PROCESS | 7160 | 20:58:27 INFO - PROCESS | 7160 | [#0] dojo.html Cycles:165 Average:4651.46 Median:4766.19 stddev:486.45 (10.2%) stddev-sans-first:459.82 20:58:27 INFO - PROCESS | 7160 | Values: 2573.4 2588.3 2603.7 2613.7 2625.5 4523.9 4640.7 4641.4 4706.7 4779.6 4670.6 4672.5 4681.1 4686.2 4743.0 4318.1 4366.0 4386.9 4398.6 4398.9 4351.2 4356.3 4375.4 4389.6 4443.6 4391.8 4437.5 4462.0 4462.7 4463.7 4211.6 4284.9 4351.1 4390.2 4409.3 4206.6 4223.7 4242.5 4298.7 4309.0 4586.2 4661.7 4663.7 4670.6 4675.3 4798.3 4963.7 5008.6 5010.1 5027.0 5005.6 5047.5 5118.5 5122.7 5124.8 4726.7 4765.3 4765.4 4766.2 4821.7 5081.6 5083.3 5227.9 5230.0 5240.5 4929.0 4936.1 4944.8 5011.4 5012.8 5020.0 5020.5 5027.4 5030.2 5095.1 4877.0 4937.5 4979.9 4991.8 4993.3 4921.9 4942.8 4954.8 5053.6 5059.9 4329.3 4332.9 4373.3 4381.6 4384.1 3750.4 3773.0 3782.6 3822.3 3843.8 4217.4 4240.6 4271.1 4301.2 4313.2 5016.4 5025.8 5052.9 5075.6 5108.1 4227.3 4258.8 4263.3 4290.6 4311.8 4434.2 4495.3 4501.5 4510.3 4532.7 4689.2 4701.7 4724.9 4745.2 4751.6 5025.7 5041.0 5048.3 5053.5 5109.6 4545.9 4681.7 4686.0 4700.9 4751.4 4875.7 4950.1 4953.5 4969.8 5015.3 5018.9 5033.4 5033.5 5041.3 5078.1 4808.5 4873.4 4900.2 4904.6 4971.6 4858.4 4908.2 4931.8 4932.6 4935.3 4841.6 4857.2 4873.9 4875.9 4891.3 4894.5 4959.7 4962.3 4963.1 4976.8 4840.0 4844.8 4848.2 4881.0 4895.8 20:58:27 INFO - PROCESS | 7160 | 20:58:27 INFO - PROCESS | 7160 | [#1] ext.html Cycles:180 Average:48942.95 Median:33556.42 stddev:92726.89 (276.3%) stddev-sans-first:92915.86 20:58:27 INFO - PROCESS | 7160 | Values: 562.5 572.9 573.1 575.1 581.9 28037.9 39254.4 40477.4 40515.0 44080.0 40474.8 40700.4 40791.0 40901.8 40955.0 7697.4 7804.7 7842.4 7887.8 7894.0 7349.9 9835.1 10081.1 10091.4 10373.9 10154.7 10239.5 10246.5 10263.6 10270.6 10062.7 10087.8 10118.2 10132.8 10136.1 10045.4 10108.6 10119.1 10121.9 10127.2 37225.3 37480.4 37481.3 37534.8 37640.2 2795.0 2802.4 2900.3 2944.4 3117.7 28589.0 28629.0 28724.9 29289.9 31153.4 3327.2 3385.3 3387.2 3400.3 3405.6 261041.0 261791.0 262296.0 262354.0 263881.0 31836.0 32827.5 53500.7 53843.0 53873.0 33346.8 33446.8 33666.0 33681.3 33729.2 13143.3 13298.5 13302.6 13308.5 13310.3 10053.2 10280.7 10329.3 10383.5 10385.6 7311.4 7360.9 7474.4 7768.4 7821.5 3046.5 3048.2 3060.4 3064.4 3115.5 841.4 931.4 972.9 1002.3 1018.9 26500.3 27298.5 27710.3 27778.7 27786.0 893.6 914.9 937.7 948.1 992.7 14330.6 14675.2 14918.9 14972.7 14993.9 397765.0 399611.0 400119.0 400341.0 401186.0 48281.8 48612.5 48704.5 48791.5 48801.8 1053.6 1135.1 1178.8 1180.3 1189.6 27172.9 28358.3 28979.4 29589.9 30115.5 47887.5 49805.8 49838.5 53896.7 53965.5 372496.0 375450.0 375547.0 376035.0 376398.0 24279.6 25270.5 25301.5 26256.6 26417.5 41617.0 42914.6 43072.4 46599.3 47987.5 35786.0 35882.3 36007.6 36179.5 36767.4 36679.0 36882.8 37034.4 37448.0 37652.4 35273.1 35748.5 35758.0 36211.8 36248.8 30487.5 32961.3 32995.3 33425.5 33446.2 25009.1 25556.6 25647.9 25680.4 25998.2 20:58:27 INFO - PROCESS | 7160 | 20:58:27 INFO - PROCESS | 7160 | [#2] jquery.html Cycles:180 Average:24602.79 Median:18438.53 stddev:60005.59 (325.4%) stddev-sans-first:60146.27 20:58:27 INFO - PROCESS | 7160 | Values: 343.4 366.4 367.1 370.2 383.5 12621.6 14391.9 16282.8 16484.2 17119.3 16310.8 16623.3 16797.8 16899.9 16904.8 5553.3 5816.7 5861.8 5868.1 5956.6 5759.3 5840.7 5886.9 5940.3 5981.7 5966.5 5966.9 5969.4 5975.8 5976.4 5925.8 5926.7 6560.2 6827.2 6870.4 6466.8 6711.9 6717.2 6726.8 6728.2 18856.0 19230.4 19248.8 20541.9 23541.6 2043.8 2049.7 2147.1 2304.0 2559.8 13779.0 14526.6 14801.7 14881.4 15209.0 1823.2 1885.6 1888.4 1891.3 1946.7 71153.6 75186.6 77816.2 77904.0 79181.6 16125.5 16207.3 17096.3 17117.9 17379.4 28032.3 28037.6 28170.7 28207.0 28405.9 8476.0 8691.7 8920.1 9085.6 9271.2 7092.9 7205.4 7269.3 7393.5 7397.7 8097.9 8128.9 8203.0 8389.1 8499.2 3197.7 3299.7 3327.1 3351.3 3360.7 739.7 817.5 820.0 877.4 898.5 15266.9 16184.6 16226.6 16290.2 17078.8 837.6 850.7 880.5 884.9 903.4 9186.9 9217.4 9576.1 9646.6 9733.9 353671.0 355570.0 357646.0 370994.0 380766.0 49553.8 50811.2 59474.7 79919.0 83062.0 939.5 946.5 995.3 1000.7 1001.4 15271.3 15555.5 15647.5 15708.9 16324.8 36510.6 37071.0 37522.0 38163.6 38362.8 49421.0 51430.5 51771.5 52398.5 53316.0 7487.3 7663.7 8031.9 10365.7 10560.9 11491.7 11563.5 11817.2 12769.0 12914.0 10233.8 10459.9 10562.6 10619.8 10992.7 4979.7 8092.9 10093.8 10430.8 10694.4 10232.1 10343.4 10365.0 10574.8 10931.3 11476.2 11480.0 11591.7 11865.7 11881.1 9985.7 10454.5 10488.8 10685.8 10691.2 20:58:27 INFO - PROCESS | 7160 | 20:58:27 INFO - PROCESS | 7160 | [#3] mootools.html Cycles:180 Average:5017.51 Median:4877.65 stddev:2824.98 (57.9%) stddev-sans-first:2819.40 20:58:27 INFO - PROCESS | 7160 | Values: 1342.1 1371.7 1443.3 1650.0 1655.1 7325.2 7941.1 7948.2 7950.5 7953.8 6584.1 6810.9 6812.0 6955.7 7772.8 2010.6 2093.6 2096.1 2109.9 2116.5 2135.7 2187.6 2199.9 2207.5 2221.2 2194.8 2203.7 2205.9 2206.0 2208.5 2118.2 2125.9 2158.9 2164.6 2165.3 2109.1 2116.9 2119.5 2119.9 2143.8 7778.6 7802.8 7862.4 7887.1 7888.8 4515.1 4671.2 4675.0 4675.8 4677.4 2862.4 2938.3 2961.8 3002.1 3068.4 955.3 979.7 989.2 1013.2 1020.2 10660.1 10664.8 10672.9 10673.3 10682.6 3846.8 3970.4 4088.2 4107.9 4132.7 9012.5 9032.6 9043.6 9047.0 9053.3 4632.5 4633.0 4639.4 4642.7 4643.1 4136.8 4225.3 4247.6 4250.1 4252.6 3604.7 3631.6 3711.9 3718.6 3755.3 1180.0 1204.7 1206.4 1221.7 1224.3 598.9 665.7 719.7 830.3 851.0 4881.2 5077.8 5128.8 5211.3 5213.1 842.8 891.8 900.2 922.6 929.8 3172.9 3203.6 3214.6 3260.7 3341.3 9235.4 9741.5 9748.2 9772.5 9776.5 9627.0 9639.4 9639.7 9666.0 9669.1 7070.3 7182.4 7187.8 7190.3 7192.0 4792.1 4793.0 4850.7 4874.1 5005.2 8484.7 8503.5 8704.8 8717.7 8816.6 8588.4 8825.1 8894.2 8909.7 9021.9 5682.7 5792.0 5931.2 5962.3 6179.4 6691.4 7093.8 7174.0 7201.8 7202.4 6305.0 6417.3 6472.9 6689.1 6718.9 6270.2 6359.5 6360.8 6528.2 6577.7 6068.2 6087.8 6113.8 6150.4 6177.5 4186.6 4253.9 4299.4 4301.8 4392.5 4433.9 4442.1 4508.9 4549.7 4665.3 20:58:27 INFO - PROCESS | 7160 | 20:58:27 INFO - PROCESS | 7160 | [#4] prototype.html Cycles:180 Average:4143.97 Median:4802.40 stddev:1236.47 (25.7%) stddev-sans-first:1205.41 20:58:27 INFO - PROCESS | 7160 | Values: 278.1 278.1 282.2 286.1 286.4 4740.7 4756.4 4806.8 4841.5 4875.0 4779.6 4802.0 4806.2 4818.6 4833.3 3520.7 3554.2 3735.5 3744.7 3754.4 3666.7 3691.8 3695.3 3704.6 3723.4 3672.8 3681.3 3691.3 3693.5 3703.3 3488.0 3543.8 3680.2 3696.9 3721.1 3175.6 3179.8 3184.0 3190.7 3192.1 4615.4 4659.3 4668.6 4679.5 4682.7 4142.2 4149.1 4160.9 4177.9 4211.9 4872.2 4975.2 4978.3 4978.8 4979.7 3479.5 3481.3 3486.0 3486.3 3500.9 5262.8 5273.0 5301.8 5319.1 5326.9 3376.0 3519.1 3554.1 3573.9 3579.4 3588.6 3591.8 3601.2 3607.3 3611.5 4168.4 4181.0 4200.5 4206.3 4218.0 4978.0 5091.9 5094.7 5095.9 5114.7 1224.2 1226.4 1227.7 1232.8 1233.4 760.4 781.4 788.9 798.1 803.2 3970.7 4218.5 4304.4 4446.8 4453.2 5037.6 5111.3 5173.5 5183.8 5194.4 4397.4 4407.1 4410.0 4411.7 4414.1 2642.8 2702.4 2715.5 2733.8 2736.6 4809.6 4821.4 4833.9 4834.3 4837.0 5216.1 5250.4 5263.3 5274.9 5296.8 4633.0 4818.3 4818.7 4827.7 4832.5 5146.0 5155.4 5161.8 5178.2 5185.2 5097.8 5098.9 5109.1 5121.5 5124.6 4611.1 4858.9 4872.6 4892.7 4895.7 3598.7 3634.2 3652.4 3658.9 3664.1 5275.9 5278.3 5292.3 5304.8 5315.1 4998.8 5060.2 5106.8 5119.3 5132.2 5039.5 5048.6 5053.9 5072.8 5080.4 4873.1 5004.3 5008.9 5009.7 5035.8 4802.8 4917.7 5028.6 5049.0 5064.2 4881.0 4898.8 4918.6 4925.4 4932.6 20:58:27 INFO - PROCESS | 7160 | 20:58:27 INFO - PROCESS | 7160 | [#5] yui.html Cycles:180 Average:16690.60 Median:28595.30 stddev:23998.26 (83.9%) stddev-sans-first:24035.26 20:58:27 INFO - PROCESS | 7160 | Values: 625.7 652.2 652.8 661.4 740.8 12187.3 12930.3 12973.7 12975.7 13015.8 12464.3 12602.4 12653.7 12659.4 12851.9 596.5 720.3 735.1 755.3 755.7 743.1 745.1 750.2 754.5 754.9 795.0 795.8 796.3 796.8 797.9 634.4 758.7 791.9 792.3 794.0 579.0 579.2 579.5 580.0 580.1 12878.3 12902.7 12914.6 12917.9 12953.4 11996.3 12168.7 12842.4 13116.3 13261.7 11497.8 11702.5 11813.4 11973.3 12093.6 4020.0 4042.8 4080.5 4233.9 4243.9 64340.7 64649.7 66054.7 66828.7 67633.3 9947.8 10014.7 10103.3 10114.5 10225.5 19150.9 19376.9 19528.6 19594.5 19631.6 6922.1 6932.2 7029.1 7196.5 7201.2 3669.9 3711.5 3718.9 3763.7 3783.5 2813.0 2926.9 2934.4 2937.9 2940.8 494.8 506.2 512.8 518.8 534.6 424.9 473.0 514.0 518.3 534.3 7368.2 7396.2 7534.9 7543.5 7616.8 493.6 530.6 541.7 564.6 565.6 3338.7 3487.7 3526.8 3566.8 3611.7 56270.7 56625.0 71213.0 104753.5 104758.0 56949.7 84677.0 87794.0 88445.0 89336.6 52230.0 76638.6 76958.2 78907.6 78969.2 6818.2 6904.2 6923.8 6965.0 7206.0 45713.0 45819.0 46256.5 46745.0 47322.8 36184.5 49282.0 63359.7 63598.0 63793.0 8721.4 9407.3 9478.5 9575.9 9712.8 10455.3 10543.2 10704.4 10818.2 11053.0 9365.2 9425.0 9562.7 9900.5 10116.8 9866.1 10005.9 10063.6 10094.3 10584.3 9304.3 9503.9 9685.4 9883.2 10104.9 8226.3 8255.9 8285.3 8313.3 8821.9 8148.5 8388.2 8541.2 8642.7 8673.3 20:58:27 INFO - PROCESS | 7160 | -------- Summary: end -------- 20:58:27 INFO - PROCESS | 7160 | 20:58:28 INFO - TEST-INFO | 7160: exit 0 20:58:28 INFO - TEST-OK | dromaeo_css | took 1121125ms 20:58:28 INFO - TEST-START | kraken 20:58:28 INFO - operating with platform_type : linux_ 20:58:28 INFO - Initialising browser for kraken test... 20:58:28 INFO - TEST-INFO | started process 7465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBeKLkJ/profile http://localhost:44137/getInfo.html) 20:58:32 INFO - PROCESS | 7465 | __metrics Screen width/height:1600/1200 20:58:32 INFO - PROCESS | 7465 | colorDepth:24 20:58:32 INFO - PROCESS | 7465 | Browser inner width/height: 1024/697 20:58:32 INFO - PROCESS | 7465 | __metrics 20:58:33 INFO - PROCESS | 7465 | 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" 20:58:33 INFO - PROCESS | 7465 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:58:33 INFO - PROCESS | 7465 | console.error: PushService: 20:58:33 INFO - PROCESS | 7465 | stateChangeProcessEnqueue: Error transitioning state 20:58:33 INFO - PROCESS | 7465 | UnknownError 20:58:34 INFO - TEST-INFO | 7465: exit 0 20:58:34 INFO - Browser initialized. 20:58:34 INFO - Running cycle 1/1 for kraken test... 20:58:34 INFO - TEST-INFO | started process 7545 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBeKLkJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:58:46 INFO - PROCESS | 7545 | RSS: Main: 181223424 20:58:46 INFO - PROCESS | 7545 | 20:58:49 INFO - PROCESS | 7545 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44137/tests/kraken/driver.html?testName=audio-beat-detection) 20:58:50 INFO - PROCESS | 7545 | RSS: Main: 234737664 20:58:50 INFO - PROCESS | 7545 | 20:58:53 INFO - PROCESS | 7545 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44137/tests/kraken/driver.html?testName=audio-dft) 20:58:53 INFO - PROCESS | 7545 | RSS: Main: 224817152 20:58:53 INFO - PROCESS | 7545 | 20:58:57 INFO - PROCESS | 7545 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44137/tests/kraken/driver.html?testName=audio-fft) 20:58:57 INFO - PROCESS | 7545 | RSS: Main: 303800320 20:58:57 INFO - PROCESS | 7545 | 20:58:59 INFO - PROCESS | 7545 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44137/tests/kraken/driver.html?testName=audio-oscillator) 20:59:00 INFO - PROCESS | 7545 | RSS: Main: 213250048 20:59:00 INFO - PROCESS | 7545 | 20:59:02 INFO - PROCESS | 7545 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44137/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:59:03 INFO - PROCESS | 7545 | RSS: Main: 215044096 20:59:03 INFO - PROCESS | 7545 | 20:59:06 INFO - PROCESS | 7545 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44137/tests/kraken/driver.html?testName=imaging-darkroom) 20:59:07 INFO - PROCESS | 7545 | RSS: Main: 252829696 20:59:07 INFO - PROCESS | 7545 | 20:59:10 INFO - PROCESS | 7545 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44137/tests/kraken/driver.html?testName=imaging-desaturate) 20:59:11 INFO - PROCESS | 7545 | RSS: Main: 247451648 20:59:11 INFO - PROCESS | 7545 | 20:59:14 INFO - PROCESS | 7545 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44137/tests/kraken/driver.html?testName=json-parse-financial) 20:59:14 INFO - PROCESS | 7545 | RSS: Main: 250097664 20:59:14 INFO - PROCESS | 7545 | 20:59:16 INFO - PROCESS | 7545 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44137/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:59:17 INFO - PROCESS | 7545 | RSS: Main: 214085632 20:59:17 INFO - PROCESS | 7545 | 20:59:19 INFO - PROCESS | 7545 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:59:19 INFO - PROCESS | 7545 | RSS: Main: 221638656 20:59:19 INFO - PROCESS | 7545 | 20:59:21 INFO - PROCESS | 7545 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:59:22 INFO - PROCESS | 7545 | RSS: Main: 221982720 20:59:22 INFO - PROCESS | 7545 | 20:59:25 INFO - PROCESS | 7545 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:59:25 INFO - PROCESS | 7545 | RSS: Main: 223121408 20:59:25 INFO - PROCESS | 7545 | 20:59:28 INFO - PROCESS | 7545 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:59:29 INFO - PROCESS | 7545 | RSS: Main: 220950528 20:59:29 INFO - PROCESS | 7545 | 20:59:31 INFO - PROCESS | 7545 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44137/tests/kraken/driver.html?testName=ai-astar) 20:59:31 INFO - PROCESS | 7545 | RSS: Main: 272609280 20:59:31 INFO - PROCESS | 7545 | 20:59:31 INFO - PROCESS | 7545 | __start_tp_report 20:59:31 INFO - PROCESS | 7545 | _x_x_mozilla_page_load 20:59:31 INFO - PROCESS | 7545 | _x_x_mozilla_page_load_details 20:59:31 INFO - PROCESS | 7545 | |i|pagename|runs| 20:59:31 INFO - PROCESS | 7545 | |0;ai-astar;115;116;134;116;114;113;114;113;114;113 20:59:31 INFO - PROCESS | 7545 | |1;audio-beat-detection;151;125;154;185;124;152;147;127;190;123 20:59:31 INFO - PROCESS | 7545 | |2;audio-dft;163;163;164;163;165;161;165;162;161;161 20:59:31 INFO - PROCESS | 7545 | |3;audio-fft;75;75;76;178;77;75;76;77;169;75 20:59:31 INFO - PROCESS | 7545 | |4;audio-oscillator;84;84;137;84;84;83;146;84;83;133 20:59:31 INFO - PROCESS | 7545 | |5;imaging-gaussian-blur;117;117;116;117;117;117;116;117;117;117 20:59:31 INFO - PROCESS | 7545 | |6;imaging-darkroom;147;147;147;147;146;147;146;147;147;146 20:59:31 INFO - PROCESS | 7545 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;95;95 20:59:31 INFO - PROCESS | 7545 | |8;json-parse-financial;64;64;65;65;66;67;65;72;64;65 20:59:31 INFO - PROCESS | 7545 | |9;json-stringify-tinderbox;66;66;65;66;67;66;67;67;67;67 20:59:31 INFO - PROCESS | 7545 | |10;stanford-crypto-aes;82;82;82;82;92;85;93;82;85;81 20:59:31 INFO - PROCESS | 7545 | |11;stanford-crypto-ccm;134;133;132;133;132;132;137;128;171;140 20:59:31 INFO - PROCESS | 7545 | |12;stanford-crypto-pbkdf2;172;178;173;176;175;172;172;172;170;174 20:59:31 INFO - PROCESS | 7545 | |13;stanford-crypto-sha256-iterative;70;68;68;67;74;69;68;69;68;69 20:59:31 INFO - PROCESS | 7545 | __end_tp_report 20:59:31 INFO - PROCESS | 7545 | __start_cc_report 20:59:31 INFO - PROCESS | 7545 | _x_x_mozilla_cycle_collect,1988 20:59:31 INFO - PROCESS | 7545 | __end_cc_report 20:59:31 INFO - PROCESS | 7545 | __startTimestamp1472529571548__endTimestamp 20:59:31 INFO - PROCESS | 7545 | 20:59:31 INFO - PROCESS | 7545 | ------- Summary: start ------- 20:59:31 INFO - PROCESS | 7545 | Number of tests: 14 20:59:31 INFO - PROCESS | 7545 | 20:59:31 INFO - PROCESS | 7545 | [#0] ai-astar Cycles:10 Average:116.20 Median:114.50 stddev:6.36 (5.6%) stddev-sans-first:6.73 20:59:31 INFO - PROCESS | 7545 | Values: 115.0 116.0 134.0 116.0 114.0 113.0 114.0 113.0 114.0 113.0 20:59:31 INFO - PROCESS | 7545 | 20:59:31 INFO - PROCESS | 7545 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:151.50 stddev:24.42 (16.1%) stddev-sans-first:25.87 20:59:31 INFO - PROCESS | 7545 | Values: 151.0 125.0 154.0 185.0 124.0 152.0 147.0 127.0 190.0 123.0 20:59:31 INFO - PROCESS | 7545 | 20:59:31 INFO - PROCESS | 7545 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.55 (1.0%) stddev-sans-first:1.64 20:59:31 INFO - PROCESS | 7545 | Values: 163.0 163.0 164.0 163.0 165.0 161.0 165.0 162.0 161.0 161.0 20:59:31 INFO - PROCESS | 7545 | 20:59:31 INFO - PROCESS | 7545 | [#3] audio-fft Cycles:10 Average:95.30 Median:75.50 stddev:41.28 (54.7%) stddev-sans-first:43.12 20:59:31 INFO - PROCESS | 7545 | Values: 75.0 75.0 76.0 178.0 77.0 75.0 76.0 77.0 169.0 75.0 20:59:31 INFO - PROCESS | 7545 | 20:59:31 INFO - PROCESS | 7545 | [#4] audio-oscillator Cycles:10 Average:100.20 Median:84.00 stddev:26.73 (31.8%) stddev-sans-first:27.70 20:59:31 INFO - PROCESS | 7545 | Values: 84.0 84.0 137.0 84.0 84.0 83.0 146.0 84.0 83.0 133.0 20:59:31 INFO - PROCESS | 7545 | 20:59:31 INFO - PROCESS | 7545 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:59:31 INFO - PROCESS | 7545 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 20:59:31 INFO - PROCESS | 7545 | 20:59:31 INFO - PROCESS | 7545 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 20:59:31 INFO - PROCESS | 7545 | Values: 147.0 147.0 147.0 147.0 146.0 147.0 146.0 147.0 147.0 146.0 20:59:31 INFO - PROCESS | 7545 | 20:59:31 INFO - PROCESS | 7545 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:59:31 INFO - PROCESS | 7545 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 20:59:31 INFO - PROCESS | 7545 | 20:59:31 INFO - PROCESS | 7545 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:65.00 stddev:2.41 (3.7%) stddev-sans-first:2.47 20:59:31 INFO - PROCESS | 7545 | Values: 64.0 64.0 65.0 65.0 66.0 67.0 65.0 72.0 64.0 65.0 20:59:31 INFO - PROCESS | 7545 | 20:59:31 INFO - PROCESS | 7545 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 20:59:31 INFO - PROCESS | 7545 | Values: 66.0 66.0 65.0 66.0 67.0 66.0 67.0 67.0 67.0 67.0 20:59:31 INFO - PROCESS | 7545 | 20:59:31 INFO - PROCESS | 7545 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:83.50 stddev:4.38 (5.2%) stddev-sans-first:4.54 20:59:31 INFO - PROCESS | 7545 | Values: 82.0 82.0 82.0 82.0 92.0 85.0 93.0 82.0 85.0 81.0 20:59:31 INFO - PROCESS | 7545 | 20:59:31 INFO - PROCESS | 7545 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:133.50 stddev:12.30 (9.2%) stddev-sans-first:12.99 20:59:31 INFO - PROCESS | 7545 | Values: 134.0 133.0 132.0 133.0 132.0 132.0 137.0 128.0 171.0 140.0 20:59:31 INFO - PROCESS | 7545 | 20:59:31 INFO - PROCESS | 7545 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:173.50 stddev:2.37 (1.4%) stddev-sans-first:2.46 20:59:31 INFO - PROCESS | 7545 | Values: 172.0 178.0 173.0 176.0 175.0 172.0 172.0 172.0 170.0 174.0 20:59:31 INFO - PROCESS | 7545 | 20:59:31 INFO - PROCESS | 7545 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.94 (2.8%) stddev-sans-first:2.03 20:59:31 INFO - PROCESS | 7545 | Values: 70.0 68.0 68.0 67.0 74.0 69.0 68.0 69.0 68.0 69.0 20:59:31 INFO - PROCESS | 7545 | -------- Summary: end -------- 20:59:31 INFO - PROCESS | 7545 | 20:59:32 INFO - TEST-INFO | 7545: exit 0 20:59:32 INFO - TEST-OK | kraken | took 64054ms 20:59:32 INFO - SUITE-END | took 1185s 20:59:33 INFO - Completed test suite (00:19:45) 20:59:33 INFO - javascript benchmark 20:59:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2573.446708957574, 2588.314096764359, 2603.6615240018796, 2613.725558816325, 2625.4749050189967, 4523.909521809562, 4640.651951103664, 4641.350210970467, 4706.717596944181, 4779.569838714515, 4670.556297151774, 4672.5327467253255, 4681.110588988098, 4686.156491831469, 4742.976285118578, 4318.07161460286, 4365.978170109145, 4386.868393948187, 4398.626116780078, 4398.868033958986, 4351.19502891966, 4356.346548017791, 4375.409319741826, 4389.648828093745, 4443.622292105175, 4391.824327026915, 4437.534058923815, 4462.0, 4462.709923854939, 4463.73217606943, 4211.578842115795, 4284.850030248957, 4351.0862718829085, 4390.1878152541885, 4409.316555933835, 4206.6003729645945, 4223.66210703146, 4242.512111107231, 4298.720583162084, 4308.987387963826, 4586.151561961048, 4661.743604101773, 4663.720176789404, 4670.626349892001, 4675.345451636774, 4798.328234047236, 4963.726995015273, 5008.649394542384, 5010.123228435009, 5027.0448614763445, 5005.624578156653, 5047.47001564834, 5118.513741194618, 5122.718250496221, 5124.769385377667, 4726.692764970266, 4765.261384485445, 4765.356676848651, 4766.189747742892, 4821.710697358169, 5081.593472522263, 5083.262926875583, 5227.921581176285, 5229.973850130801, 5240.502152295526, 4928.950710492849, 4936.086823937583, 4944.826931057396, 5011.448740638527, 5012.7994880205115, 5020.046191223656, 5020.49795020495, 5027.396712394463, 5030.195168772979, 5095.108356037753, 4877.048975449753, 4937.530934561211, 4979.875503112378, 4991.825286115041, 4993.251012348104, 4921.926171107436, 4942.752862356868, 4954.777035033432, 5053.620978426633, 5059.8988020239385, 4329.28566786483, 4332.891677708019, 4373.2565463871215, 4381.6494680425485, 4384.079343337935, 3750.4186851038135, 3772.962270377261, 3782.5650050244026, 3822.3310920588788, 3843.8270277837564, 4217.367394890791, 4240.6395456385935, 4271.145770845781, 4301.204277208663, 4313.202057619351, 5016.372953380827, 5025.7989680412375, 5052.949470505321, 5075.568576671024, 5108.055009823194, 4227.32362821947, 4258.808353624095, 4263.253930562139, 4290.635295999812, 4311.784410779448, 4434.2240107981615, 4495.348174514677, 4501.48232953208, 4510.2783554631105, 4532.66005049616, 4689.249720044776, 4701.717896926264, 4724.905501889874, 4745.193317136026, 4751.596114330182, 5025.673331233458, 5041.0422019816115, 5048.268001139888, 5053.472094947029, 5109.642325037212, 4545.9090818182785, 4681.742504162167, 4685.969086800898, 4700.905981880412, 4751.40607424072, 4875.731834749123, 4950.084234416644, 4953.479884612064, 4969.801207951641, 5015.322931404214, 5018.899622007466, 5033.446320904624, 5033.471485494117, 5041.319421878, 5078.060558796635, 4808.495108013748, 4873.439554451284, 4900.191468407673, 4904.607631389409, 4971.552560269593, 4858.368412106403, 4908.190148625436, 4931.827386041471, 4932.580730637936, 4935.309056732132, 4841.612670986383, 4857.222844344888, 4873.878153046202, 4875.902481950412, 4891.33966914462, 4894.535019173173, 4959.677620954626, 4962.33008543842, 4963.057019166346, 4976.825811096594, 4839.975800120977, 4844.806207751651, 4848.175810112219, 4881.048195601824, 4895.828645997373], "value": 4620.220788335035, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.5274769193877, 572.8940146072977, 573.0802062689384, 575.0884847516686, 581.935987041425, 28037.859810700942, 39254.411183832264, 40477.39283910744, 40515.0, 44080.0, 40474.7976260119, 40700.389494157615, 40791.0, 40901.7954910225, 40955.0, 7697.384209263273, 7804.687812487494, 7842.411819113589, 7887.8422431551335, 7894.0, 7349.926500734978, 9835.065668761456, 10081.143102836268, 10091.394516329006, 10373.948130259376, 10154.746131346701, 10239.539220735047, 10246.487675616227, 10263.640772572962, 10270.589176432934, 10062.74843128924, 10087.798244035152, 10118.241131915061, 10132.797344053151, 10136.13842823361, 10045.447500387476, 10108.595656173744, 10119.089281964585, 10121.898781012169, 10127.189824814071, 37225.25549489022, 37480.43779343312, 37481.25037499262, 37534.81232593847, 37640.24719505622, 2794.986025069882, 2802.355458244595, 2900.260433589442, 2944.3522425066453, 3117.719405253538, 28589.0, 28629.0, 28724.8563757182, 29289.85355073232, 31153.376932461222, 3327.168207948013, 3385.2890892912274, 3387.1532116970757, 3400.336934297813, 3405.591329040531, 261041.0, 261791.0, 262296.0, 262354.0, 263881.0, 31836.0, 32827.50758738621, 53500.73249633727, 53843.0, 53873.0, 33346.833265834, 33446.832765836014, 33666.0, 33681.326373472395, 33729.15677108043, 13143.277119758313, 13298.468061277634, 13302.600921972356, 13308.467661293633, 13310.334483275798, 10053.195744340435, 10280.742981425374, 10329.276950613385, 10383.480825958823, 10385.584576616851, 7311.378532824663, 7360.926390736024, 7474.439417043744, 7768.378529717609, 7821.530708157528, 3046.491986466713, 3048.192229059301, 3060.372623612199, 3064.3718037802196, 3115.454795410794, 841.4236248170023, 931.4132096778986, 972.8783902012249, 1002.3284399452384, 1018.8828284747201, 26500.292337752733, 27298.45403091927, 27710.33615151832, 27778.72221277802, 27786.0, 893.6425429828121, 914.8627705844043, 937.723371605378, 948.0945696859483, 992.692265397729, 14330.57008289753, 14675.19286439256, 14918.850811491964, 14972.700545989019, 14993.925030374778, 397765.0, 399611.0, 400119.0, 400341.0, 401186.0, 48281.75859120752, 48612.513874861506, 48704.512954870705, 48791.5120848787, 48801.75599121982, 1053.578568572577, 1135.0579019413701, 1178.8172833210865, 1180.262336039975, 1189.6014835030362, 27172.864135679196, 28358.291042724097, 28979.420411592073, 29589.85205073961, 30115.54826677558, 47887.521124788305, 49805.75097124491, 49838.50161498338, 53896.73051634717, 53965.460345396044, 372496.0, 375450.0, 375547.0, 376035.0, 376398.0, 24279.635805463284, 25270.49459010846, 25301.493970120126, 26256.60615090737, 26417.471650567266, 41617.0, 42914.57085429106, 43072.35391469193, 46599.30101048419, 47987.5201247997, 35786.0, 35882.34415380742, 36007.63992360043, 36179.45730813987, 36767.44848827216, 36679.0, 36882.8155859219, 37034.44448333331, 37448.0, 37652.435213471275, 35273.118172045906, 35748.4637730429, 35758.0, 36211.81894090513, 36248.81875590605, 30487.54268685927, 32961.34077318488, 32995.34009319752, 33425.49861752124, 33446.16384590307, 25009.12468063609, 25556.616650749882, 25647.87176064108, 25680.357991050372, 25998.22005339843], "value": 16992.869935411974, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.3630615208786, 366.41556717036326, 367.06215619093206, 370.22992176273357, 383.5301755349697, 12621.62135135945, 14391.856081439182, 16282.83717162828, 16484.17579121045, 17119.31522739089, 16310.836891631081, 16623.251953662086, 16797.83202167978, 16899.91550042251, 16904.83095169048, 5553.333599968009, 5816.738246778884, 5861.7948371807, 5868.061110222366, 5956.642601443906, 5759.280089988752, 5840.737166827482, 5886.911696324559, 5940.257467816523, 5981.730822113015, 5966.522678185756, 5966.9403305967035, 5969.403059694039, 5975.820725378246, 5976.432238937316, 5925.792597259118, 5926.703664816763, 6560.245571759261, 6827.21487028993, 6870.416014638712, 6466.838329041764, 6711.932880671179, 6717.16035495563, 6726.83182920426, 6728.192616885956, 18856.0, 19230.423087307405, 19248.807511924842, 20541.8972905136, 23541.646875296883, 2043.764967028781, 2049.733534640502, 2147.14114354258, 2303.9539209215723, 2559.7952163827035, 13779.0, 14526.564203073925, 14801.70396592073, 14881.404743810235, 15209.0, 1823.179569193868, 1885.58517126232, 1888.357958294173, 1891.3474851176322, 1946.698261769428, 71153.64423177902, 75186.62406687986, 77816.22183778202, 77904.0, 79181.60409197975, 16125.516234512983, 16207.270672819515, 17096.316147353966, 17117.914410427868, 17379.391721289696, 28032.29919252035, 28037.57943630847, 28170.71829281722, 28207.0, 28405.85797071043, 8476.0, 8691.739247822576, 8920.063393343735, 9085.591148398338, 9271.211946984447, 7092.929070709227, 7205.387542058879, 7269.3094156055095, 7393.519421237603, 7397.667104980289, 8097.878531822027, 8128.9187108129345, 8203.0, 8389.119142490074, 8499.150084991452, 3197.6642452542146, 3299.686529779667, 3327.1183136468853, 3351.2794749128566, 3360.7143392811886, 739.7226040234912, 817.5217497763874, 820.0446479850907, 877.3639111644007, 898.5058217980085, 15266.923665381602, 16184.595385115232, 16226.594335141479, 16290.185490725416, 17078.829211707725, 837.6398148796076, 850.7107583421666, 880.5377176982007, 884.9247813935759, 903.3856977255398, 9186.908130918606, 9217.354785164975, 9576.090271424204, 9646.614135434644, 9733.853992190123, 353671.0, 355570.0, 357646.0, 370994.0, 380766.0, 49553.80577427822, 50811.23783143256, 59474.70262648659, 79919.0, 83062.0, 939.5443210042987, 946.4510583861344, 995.2833959549258, 1000.6897861662908, 1001.3891526169031, 15271.312790924212, 15555.533333999998, 15647.452339168074, 15708.92145539265, 16324.755128673318, 36510.63489365178, 37071.0, 37522.0, 38163.61836381601, 38362.808185960006, 49421.0, 51430.48569514257, 51771.482285176666, 52398.476015240885, 53316.0, 7487.251274872469, 7663.731769388045, 8031.879521807295, 10365.689029329133, 10560.947195263974, 11491.712707182387, 11563.537458501565, 11817.231879927776, 12768.999285167793, 12914.0, 10233.84649230277, 10459.94770026145, 10562.630307939186, 10619.840702389316, 10992.725181870517, 4979.726115063706, 8092.919070809452, 10093.788745350605, 10430.843537346795, 10694.358338499715, 10232.130268927225, 10343.431111288952, 10365.0, 10574.8413773795, 10931.344119352865, 11476.196666233283, 11480.0, 11591.6522504325, 11865.703357416134, 11881.108916831445, 9985.650502232387, 10454.529546170288, 10488.790224195322, 10685.839712404164, 10691.198160137865], "value": 9269.485628257897, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.141029740966, 1371.7187976464822, 1443.3072125379817, 1649.9587510312233, 1655.0731590309429, 7325.157606875205, 7941.133833549118, 7948.205179482049, 7950.483218590787, 7953.840923181533, 6584.078229047937, 6810.863782724343, 6811.965940170292, 6955.652217389123, 7772.766816995485, 2010.6079314533672, 2093.6126816538913, 2096.140582361232, 2109.92615258466, 2116.47088227943, 2135.7330333708287, 2187.573423182472, 2199.8900054997184, 2207.5033117548583, 2221.2114699281765, 2194.8244140468723, 2203.735551733786, 2205.8676479411206, 2205.9889700551475, 2208.5472478142024, 2118.1527389044427, 2125.91496340147, 2158.8989615296155, 2164.6428339323993, 2165.339571430713, 2109.0825490911348, 2116.904739286736, 2119.5337025854287, 2119.8728076315315, 2143.7641859395453, 7778.5721785301785, 7802.843943121163, 7862.449628526006, 7887.053553573551, 7888.842223155562, 4515.096980603859, 4671.229247174212, 4674.976625116887, 4675.812967481296, 4677.438707355105, 2862.4418238443513, 2938.2507460597626, 2961.7926745127634, 3002.069358498872, 3068.447679417704, 955.3217215776807, 979.6669132494915, 989.1987490133015, 1013.2096964367805, 1020.209337763232, 10660.147188224923, 10664.840027399596, 10672.893271067345, 10673.306235094695, 10682.626108086257, 3846.8265430031943, 3970.4441378207075, 4088.2436749201493, 4107.9178416431505, 4132.73137246078, 9012.54937253148, 9032.63869445228, 9043.59303831329, 9046.954765226263, 9053.321000924958, 4632.467266264355, 4632.97683511587, 4639.350490931272, 4642.651801114863, 4643.11780761661, 4136.751794892316, 4225.302825033897, 4247.6389506892265, 4250.06498570314, 4252.638525725348, 3604.675579197885, 3631.6005239423644, 3711.925761484755, 3718.5909549950024, 3755.3240416724707, 1179.9705007374712, 1204.728935989413, 1206.3968015992004, 1221.6640423883325, 1224.2593231095059, 598.8622616798161, 665.6738198282807, 719.7013239505651, 830.33158307563, 850.9829803403898, 4881.219004959261, 5077.847664570068, 5128.8461346159675, 5211.270422140903, 5213.061648903234, 842.8482873082904, 891.80826122384, 900.1718419054486, 922.6171138977384, 929.8326301265702, 3172.857221425041, 3203.615566132079, 3214.5660335854827, 3260.6902344277255, 3341.348437054751, 9235.445873247627, 9741.512924353754, 9748.171405430618, 9772.51137443125, 9776.462294573867, 9626.95186524063, 9639.373440726331, 9639.662611808553, 9666.0, 9669.129778319984, 7070.328318809705, 7182.3535881770895, 7187.784366469119, 7190.316919892706, 7192.0290760747675, 4792.113459010095, 4792.976035119802, 4850.684705494132, 4874.073925954058, 5005.224190250517, 8484.745457636282, 8503.532305722998, 8704.825903482022, 8717.738467845975, 8816.559172041243, 8588.398812083095, 8825.073367296342, 8894.243989260985, 8909.688160914337, 9021.90978090237, 5682.687452190169, 5791.971040144772, 5931.169636251015, 5962.344142144448, 6179.443850053517, 6691.397774200345, 7093.787186384417, 7173.964130179315, 7201.819954501179, 7202.351788339075, 6304.968475157595, 6417.26201486835, 6472.902906456501, 6689.09697190873, 6718.932810672026, 6270.184875966095, 6359.491240700825, 6360.840978975562, 6528.2492513359675, 6577.736890524326, 6068.21113255274, 6087.756489740361, 6113.84715382119, 6150.384961503813, 6177.4749146323065, 4186.560411156906, 4253.9361909572, 4299.355096735515, 4301.827926882889, 4392.472903251502, 4433.933490997702, 4442.133783912106, 4508.887277817949, 4549.658775591778, 4665.2768820832825], "value": 4053.5065783537216, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.0587710599621, 278.11282010386867, 282.2478095874494, 286.1401488526976, 286.3828449690917, 4740.69185502942, 4756.38167038285, 4806.846356874346, 4841.514109840918, 4874.951250487494, 4779.64152688548, 4801.975990120053, 4806.20697584899, 4818.566329030386, 4833.299171620113, 3520.718342532604, 3554.1647712787476, 3735.477033215352, 3744.7378683492166, 3754.361758501048, 3666.7066634669295, 3691.8338674759702, 3695.316366472198, 3704.6480584344445, 3723.4414837774416, 3672.8163591820435, 3681.337359275329, 3691.338897496124, 3693.4644476550884, 3703.2778608171416, 3487.9651203487892, 3543.7519373643854, 3680.1535646801117, 3696.8706095286534, 3721.0650461760006, 3175.5871736674085, 3179.7933134346426, 3183.9681603183903, 3190.6649801770945, 3192.1062102611304, 4615.376924115235, 4659.324397962277, 4668.579827815479, 4679.508651591568, 4682.742449165295, 4142.1922725068625, 4149.128682976579, 4160.91678166438, 4177.895552611179, 4211.936820947688, 4872.220444728861, 4975.179095449246, 4978.278149668277, 4978.7510624469, 4979.701217926936, 3479.5302634144573, 3481.3211423772123, 3485.954213735869, 3486.3027394520946, 3500.912477188065, 5262.842114736564, 5273.0, 5301.761420736076, 5319.0957537218765, 5326.92009619856, 3376.0, 3519.1378112362636, 3554.147004718849, 3573.8749143780365, 3579.4451859961746, 3588.569371675416, 3591.8204089795404, 3601.2077342984503, 3607.296577167427, 3611.4582812577796, 4168.437260969791, 4180.979095104505, 4200.474940632421, 4206.326987682018, 4217.97891010543, 4977.9751101244265, 5091.9236211456855, 5094.6688465249645, 5095.85343297755, 5114.744262786846, 1224.2409705982348, 1226.436293725507, 1227.699213692633, 1232.796588562877, 1233.426456697622, 760.4106817216591, 781.4490783997268, 788.8540619985321, 798.1499702816482, 803.2128514056258, 3970.7021973351534, 4218.451601291812, 4304.418903447994, 4446.755428451466, 4453.19842428366, 5037.566941091815, 5111.3355263815465, 5173.482651734872, 5183.7558985843125, 5194.4026436959475, 4397.428334316518, 4407.096545208225, 4409.9559004410185, 4411.669124815651, 4414.073044660658, 2642.7753640940737, 2702.4459985702883, 2715.511207982582, 2733.7676297514936, 2736.616873637692, 4809.591184749265, 4821.445533763592, 4833.854984350475, 4834.347363105936, 4836.975815120902, 5216.061109000417, 5250.422453530108, 5263.315768950089, 5274.947250527445, 5296.788128474895, 4632.97683511587, 4818.253170758468, 4818.68678535901, 4827.710337379768, 4832.4684284728655, 5145.974270128625, 5155.355580552431, 5161.7677204526635, 5178.249153872743, 5185.248139019896, 5097.770600323069, 5098.872528186676, 5109.08036553424, 5121.539061484485, 5124.615653825904, 4611.146937816515, 4858.878528036686, 4872.634552408513, 4892.657513973988, 4895.681780684244, 3598.6581274778855, 3634.164142247245, 3652.379095553815, 3658.8536458542426, 3664.0656632558525, 5275.920861187008, 5278.340207474066, 5292.311999440049, 5304.787808487772, 5315.096433606219, 4998.825041123543, 5060.165072762953, 5106.846794596168, 5119.257707632447, 5132.204508301219, 5039.47085556026, 5048.596112310933, 5053.949460505348, 5072.82245121419, 5080.390353157497, 4873.098476781806, 5004.274380214922, 5008.9248661269385, 5009.699418034929, 5035.823746168867, 4802.831900883452, 4917.704937703749, 5028.572571331478, 5048.974755126201, 5064.240363945438, 4881.0, 4898.750818541249, 4918.631102667386, 4925.433575138905, 4932.556069953722], "value": 3742.1468882235527, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.6652690810417, 652.168485181394, 652.8074218105661, 661.4476911778663, 740.7888751705765, 12187.268763874163, 12930.28883411412, 12973.675658108528, 12975.67560810979, 13015.804762928563, 12464.31446270457, 12602.36988150591, 12653.683657908534, 12659.367031648428, 12851.935740321309, 596.5466245653291, 720.3121019426461, 735.077477765405, 755.2749360613817, 755.6901670315171, 743.1008479739495, 745.1170363119693, 750.1523278695067, 754.5359603843651, 754.9471536992413, 794.990362239955, 795.8050277681947, 796.3151689546985, 796.8485987662355, 797.9281864632181, 634.3592971099223, 758.7306506190279, 791.9247671471201, 792.3304807437735, 793.972210972616, 579.0387955993032, 579.2151634535186, 579.5450571301508, 580.0, 580.0718849840264, 12878.29169395683, 12902.677433064155, 12914.612561623073, 12917.935410322889, 12953.352332383343, 11996.280223186637, 12168.695782605417, 12842.422091005927, 13116.344182790917, 13261.668458288523, 11497.770044599145, 11702.473388697528, 11813.40932953349, 11973.341466219354, 12093.57672481459, 4019.97990010051, 4042.797860106983, 4080.510338759338, 4233.872983810491, 4243.893902652428, 64340.67829660868, 64649.67675161641, 66054.66972665154, 66828.6658566709, 67633.3236667632, 9947.751306217258, 10014.699559013241, 10103.343282686748, 10114.54484548197, 10225.539850706737, 19150.904245478683, 19376.930844522525, 19528.609427811363, 19594.51013724668, 19631.60736785285, 6922.10012698346, 6932.168139823253, 7029.0862187915245, 7196.532225405332, 7201.171865235565, 3669.889903302905, 3711.480392745018, 3718.925621487555, 3763.7177211708686, 3783.4892289541112, 2812.9578056329174, 2926.8536573171255, 2934.427786581596, 2937.9265518361785, 2940.779441541893, 494.75509622736973, 506.1648280337399, 512.7974450092192, 518.7924830067927, 534.6444614331426, 424.8916526285839, 473.0090460485278, 513.9511746384162, 518.2925306955977, 534.3267482971406, 7368.226336234618, 7396.223396543285, 7534.886976695354, 7543.47195696307, 7616.80957976055, 493.58785414178845, 530.6046994988681, 541.7372574301461, 564.5906717629767, 565.6069032022705, 3338.7162091222517, 3487.6861082502696, 3526.84129214186, 3566.7503274770515, 3611.6749492545273, 56270.71864640651, 56625.0, 71213.0, 104753.47623261987, 104758.0, 56949.71525142348, 84677.0, 87794.0, 88445.0, 89336.553317233, 52230.0, 76638.61680691561, 76958.23041769622, 78907.60546197233, 78969.21030789618, 6818.249992500921, 6904.169290590834, 6923.826904327432, 6964.955256711533, 7206.0, 45713.0, 45819.0, 46256.53743462522, 46745.0, 47322.76338618285, 36184.457233140995, 49282.0, 63359.68320158554, 63598.0, 63793.0, 8721.433106848035, 9407.341486095907, 9478.52607369615, 9575.856362154434, 9712.805743885225, 10455.268131230741, 10543.15654747603, 10704.411257380607, 10818.24272300963, 11052.957341982188, 9365.157135857806, 9424.95287523558, 9562.713118606453, 9900.455474948947, 10116.797664046826, 9866.112049915542, 10005.899941000496, 10063.647772327933, 10094.293399462262, 10584.259101863103, 9304.302177336862, 9503.857442138511, 9685.370450920667, 9883.209343252378, 10104.949475252577, 8226.30076443485, 8255.876161857457, 8285.295749861089, 8313.251807337369, 8821.867671985054, 8148.511089334659, 8388.161183881562, 8541.188587084218, 8642.654293828427, 8673.262772664395], "value": 6194.1430225992935, "unit": "score"}], "name": "dromaeo_css", "value": 6394.820769125706, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 134.0, 116.0, 114.0, 113.0, 114.0, 113.0, 114.0, 113.0], "value": 116.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 154.0, 185.0, 124.0, 152.0, 147.0, 127.0, 190.0, 123.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 163.0, 165.0, 161.0, 165.0, 162.0, 161.0, 161.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 178.0, 77.0, 75.0, 76.0, 77.0, 169.0, 75.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 137.0, 84.0, 84.0, 83.0, 146.0, 84.0, 83.0, 133.0], "value": 100.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 65.0, 66.0, 67.0, 65.0, 72.0, 64.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 82.0, 92.0, 85.0, 93.0, 82.0, 85.0, 81.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 132.0, 133.0, 132.0, 132.0, 137.0, 128.0, 171.0, 140.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 178.0, 173.0, 176.0, 175.0, 172.0, 172.0, 172.0, 170.0, 174.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 68.0, 67.0, 74.0, 69.0, 68.0, 69.0, 68.0, 69.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1577.2, "alertThreshold": 2.0}]} 20:59:33 INFO - Return code: 0 20:59:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:59:33 INFO - # TBPL SUCCESS # 20:59:33 INFO - Running post-action listener: _resource_record_post_action 20:59:33 INFO - [mozharness: 2016-08-30 03:59:33.351481Z] Finished run-tests step (success) 20:59:33 INFO - Running post-run listener: _resource_record_post_run 20:59:33 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 372736; Write bytes: 410464256; Read time: 236; Write time: 329640 20:59:33 INFO - TinderboxPrint: CPU usage
13.0% 20:59:33 INFO - TinderboxPrint: I/O read bytes / time
372,736 / 236 20:59:33 INFO - TinderboxPrint: I/O write bytes / time
410,464,256 / 329,640 20:59:33 INFO - TinderboxPrint: CPU idle
8,342.0 (87.0%) 20:59:33 INFO - TinderboxPrint: CPU user
1,199.5 (12.5%) 20:59:33 INFO - TinderboxPrint: Swap in / out
0 / 0 20:59:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 28672; Write bytes: 113885184; Read time: 12; Write time: 109036 20:59:33 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 339968; Write bytes: 296579072; Read time: 212; Write time: 220604 20:59:34 INFO - Running post-run listener: _upload_blobber_files 20:59:34 INFO - Blob upload gear active. 20:59:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:59:34 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 20:59:34 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'] 20:59:34 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 20:59:34 INFO - (blobuploader) - INFO - Open directory for files ... 20:59:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:59:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:59:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:59:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:59:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:59:35 INFO - (blobuploader) - INFO - Done attempting. 20:59:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:59:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:59:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:59:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:59:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:59:40 INFO - (blobuploader) - INFO - Done attempting. 20:59:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:59:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:59:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:59:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:59:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:59:40 INFO - (blobuploader) - INFO - Done attempting. 20:59:40 INFO - (blobuploader) - INFO - Iteration through files over. 20:59:40 INFO - Return code: 0 20:59:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:59:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:59:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1c39dfbc035c5de0d3fe6e23df1100d508a1900556f99f0e04f0f32c083b68d7dae4e615da4649569ca680b6d2fa00f7721059837bfd13e2bc7254943e0e87b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c04e4d93d6b7472bdb77e57c9c86c1961bb48a42ceaea07e9051dac195b4db18763d4e517fe1f269cc1c5670043622ebd339243b4b7c6068ba690ad534babe25", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7bee146fc3782442b64fee859af12e1abc753c33ec195049af0cc298fbaf865321b64fcf9bc7f17b2c283ffe6c113d496d399a566feed36f5844f10a5e7a5dc0"} 20:59:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:59:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:59:40 INFO - Contents: 20:59:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1c39dfbc035c5de0d3fe6e23df1100d508a1900556f99f0e04f0f32c083b68d7dae4e615da4649569ca680b6d2fa00f7721059837bfd13e2bc7254943e0e87b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c04e4d93d6b7472bdb77e57c9c86c1961bb48a42ceaea07e9051dac195b4db18763d4e517fe1f269cc1c5670043622ebd339243b4b7c6068ba690ad534babe25", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7bee146fc3782442b64fee859af12e1abc753c33ec195049af0cc298fbaf865321b64fcf9bc7f17b2c283ffe6c113d496d399a566feed36f5844f10a5e7a5dc0"} 20:59:40 INFO - Running post-run listener: copy_logs_to_upload_dir 20:59:40 INFO - Copying logs to upload dir... 20:59:40 INFO - mkdir: /builds/slave/test/build/upload/logs 20:59:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.873938 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-29 20:59:40.603444) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 20:59:40.607094) ========= 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=ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119 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/1c39dfbc035c5de0d3fe6e23df1100d508a1900556f99f0e04f0f32c083b68d7dae4e615da4649569ca680b6d2fa00f7721059837bfd13e2bc7254943e0e87b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c04e4d93d6b7472bdb77e57c9c86c1961bb48a42ceaea07e9051dac195b4db18763d4e517fe1f269cc1c5670043622ebd339243b4b7c6068ba690ad534babe25", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7bee146fc3782442b64fee859af12e1abc753c33ec195049af0cc298fbaf865321b64fcf9bc7f17b2c283ffe6c113d496d399a566feed36f5844f10a5e7a5dc0"} build_url:https://queue.taskcluster.net/v1/task/GN1EdAu3Rxiw8l_SPc4WwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/GN1EdAu3Rxiw8l_SPc4WwA/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/1c39dfbc035c5de0d3fe6e23df1100d508a1900556f99f0e04f0f32c083b68d7dae4e615da4649569ca680b6d2fa00f7721059837bfd13e2bc7254943e0e87b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c04e4d93d6b7472bdb77e57c9c86c1961bb48a42ceaea07e9051dac195b4db18763d4e517fe1f269cc1c5670043622ebd339243b4b7c6068ba690ad534babe25", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7bee146fc3782442b64fee859af12e1abc753c33ec195049af0cc298fbaf865321b64fcf9bc7f17b2c283ffe6c113d496d399a566feed36f5844f10a5e7a5dc0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 20:59:40.636278) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 20:59:40.636612) ========= 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=ed14279e38b05397cf4aa391000001a4-1472528333.251077-1968005119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 20:59:40.721876) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 20:59:40.722727) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 20:59:40.723137) ========= ========= Total master_lag: 0.18 =========