builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1470962206.54 results: success (0) buildid: 20160811143001 builduid: 281a169a95b2403e851a81b3ab920d7b revision: 61340bd78a4bf05890f4b84a6ca57ba01c0ee29b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 17:36:46.537587) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 17:36:46.538036) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 17:36:46.538322) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 17:36:46.555004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 17:36:46.555301) ========= 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=41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-11 17:36:46-- 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% 42.4M=0s 2016-08-11 17:36:46 (42.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141183 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 17:36:46.712614) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 17:36:46.713183) ========= 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=41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017784 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 17:36:46.761135) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-11 17:36:46.761535) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 61340bd78a4bf05890f4b84a6ca57ba01c0ee29b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 61340bd78a4bf05890f4b84a6ca57ba01c0ee29b --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=41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-11 17:36:46,837 truncating revision to first 12 chars 2016-08-11 17:36:46,838 Setting DEBUG logging. 2016-08-11 17:36:46,838 attempt 1/10 2016-08-11 17:36:46,838 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/61340bd78a4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-11 17:36:47,824 unpacking tar archive at: fx-team-61340bd78a4b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.312656 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-11 17:36:48.090274) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 17:36:48.090797) ========= script_repo_revision: 61340bd78a4bf05890f4b84a6ca57ba01c0ee29b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 17:36:48.091445) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 17:36:48.091890) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 17:36:48.101462) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-08-11 17:36:48.101798) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:36:48 INFO - MultiFileLogger online at 20160811 17:36:48 in /builds/slave/test 17:36:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:36:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:36:48 INFO - {'append_to_log': False, 17:36:48 INFO - 'base_work_dir': '/builds/slave/test', 17:36:48 INFO - 'blob_upload_branch': 'Fx-Team', 17:36:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:36:48 INFO - 'branch': 'Fx-Team', 17:36:48 INFO - 'buildbot_json_path': 'buildprops.json', 17:36:48 INFO - 'config_files': ('talos/linux_config.py',), 17:36:48 INFO - 'default_actions': ('clobber', 17:36:48 INFO - 'read-buildbot-config', 17:36:48 INFO - 'download-and-extract', 17:36:48 INFO - 'populate-webroot', 17:36:48 INFO - 'create-virtualenv', 17:36:48 INFO - 'install', 17:36:48 INFO - 'run-tests'), 17:36:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:36:48 INFO - 'download_minidump_stackwalk': True, 17:36:48 INFO - 'download_symbols': 'ondemand', 17:36:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:36:48 INFO - 'tooltool.py': '/tools/tooltool.py', 17:36:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:36:48 INFO - '/tools/misc-python/virtualenv.py')}, 17:36:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:36:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:36:48 INFO - 'installer_path': 'installer.exe', 17:36:48 INFO - 'log_level': 'info', 17:36:48 INFO - 'log_name': 'talos', 17:36:48 INFO - 'log_to_console': True, 17:36:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:36:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:36:48 INFO - 'opt_config_files': (), 17:36:48 INFO - 'pip_index': False, 17:36:48 INFO - 'sps_profile': False, 17:36:48 INFO - 'sps_profile_interval': 0, 17:36:48 INFO - 'suite': 'dromaeojs-e10s', 17:36:48 INFO - 'system_bits': '32', 17:36:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:36:48 INFO - 'title': 'talos-linux64-ix-024', 17:36:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:36:48 INFO - 'use_talos_json': True, 17:36:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:36:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:36:48 INFO - 'work_dir': 'build'} 17:36:48 INFO - [mozharness: 2016-08-12 00:36:48.269659Z] Running clobber step. 17:36:48 INFO - Running pre-action listener: _resource_record_pre_action 17:36:48 INFO - Running main action method: clobber 17:36:48 INFO - rmtree: /builds/slave/test/build 17:36:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:36:48 INFO - Running post-action listener: _resource_record_post_action 17:36:48 INFO - [mozharness: 2016-08-12 00:36:48.723708Z] Finished clobber step (success) 17:36:48 INFO - [mozharness: 2016-08-12 00:36:48.723809Z] Running read-buildbot-config step. 17:36:48 INFO - Running pre-action listener: _resource_record_pre_action 17:36:48 INFO - Running main action method: read_buildbot_config 17:36:48 INFO - Using buildbot properties: 17:36:48 INFO - { 17:36:48 INFO - "project": "", 17:36:48 INFO - "product": "firefox", 17:36:48 INFO - "script_repo_revision": "production", 17:36:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:36:48 INFO - "repository": "", 17:36:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:36:48 INFO - "buildid": "20160811143001", 17:36:48 INFO - "pgo_build": "True", 17:36:48 INFO - "basedir": "/builds/slave/test", 17:36:48 INFO - "buildnumber": 692, 17:36:48 INFO - "slavename": "talos-linux64-ix-024", 17:36:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:36:48 INFO - "platform": "ubuntu64_hw", 17:36:48 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:36:48 INFO - "branch": "fx-team", 17:36:48 INFO - "repo_path": "integration/fx-team", 17:36:48 INFO - "revision": "61340bd78a4bf05890f4b84a6ca57ba01c0ee29b", 17:36:48 INFO - "stage_platform": "linux64-pgo", 17:36:48 INFO - "builduid": "281a169a95b2403e851a81b3ab920d7b", 17:36:48 INFO - "slavebuilddir": "test" 17:36:48 INFO - } 17:36:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/FgDZDRA5Tme9Aie72bfScQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 17:36:48 INFO - Running post-action listener: _resource_record_post_action 17:36:48 INFO - [mozharness: 2016-08-12 00:36:48.726276Z] Finished read-buildbot-config step (success) 17:36:48 INFO - [mozharness: 2016-08-12 00:36:48.726365Z] Running download-and-extract step. 17:36:48 INFO - Running pre-action listener: _resource_record_pre_action 17:36:48 INFO - Running main action method: download_and_extract 17:36:48 INFO - mkdir: /builds/slave/test/build/tests 17:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:48 INFO - trying https://queue.taskcluster.net/v1/task/FgDZDRA5Tme9Aie72bfScQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:36:48 INFO - Downloading https://queue.taskcluster.net/v1/task/FgDZDRA5Tme9Aie72bfScQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:36:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FgDZDRA5Tme9Aie72bfScQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:36:49 INFO - Downloaded 1361 bytes. 17:36:49 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:36:49 INFO - Using the following test package requirements: 17:36:49 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:36:49 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:36:49 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:36:49 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:49 INFO - u'jsshell-linux-x86_64.zip'], 17:36:49 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:36:49 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:36:49 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:36:49 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:36:49 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:36:49 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:36:49 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:49 INFO - trying https://queue.taskcluster.net/v1/task/FgDZDRA5Tme9Aie72bfScQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:36:49 INFO - Downloading https://queue.taskcluster.net/v1/task/FgDZDRA5Tme9Aie72bfScQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:36:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FgDZDRA5Tme9Aie72bfScQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:36:50 INFO - Downloaded 21833747 bytes. 17:36:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:36:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:36:51 INFO - Return code: 0 17:36:51 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:51 INFO - trying https://queue.taskcluster.net/v1/task/FgDZDRA5Tme9Aie72bfScQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:36:51 INFO - Downloading https://queue.taskcluster.net/v1/task/FgDZDRA5Tme9Aie72bfScQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:36:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FgDZDRA5Tme9Aie72bfScQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:36:52 INFO - Downloaded 21833747 bytes. 17:36:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:36:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:36:53 INFO - Return code: 0 17:36:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:53 INFO - trying https://queue.taskcluster.net/v1/task/FgDZDRA5Tme9Aie72bfScQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:36:53 INFO - Downloading https://queue.taskcluster.net/v1/task/FgDZDRA5Tme9Aie72bfScQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:36:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FgDZDRA5Tme9Aie72bfScQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:36:54 INFO - Downloaded 14413719 bytes. 17:36:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:36:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:36:54 INFO - Return code: 0 17:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:54 INFO - trying https://queue.taskcluster.net/v1/task/FgDZDRA5Tme9Aie72bfScQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:36:54 INFO - Downloading https://queue.taskcluster.net/v1/task/FgDZDRA5Tme9Aie72bfScQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:36:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FgDZDRA5Tme9Aie72bfScQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:36:56 INFO - Downloaded 59349453 bytes. 17:36:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FgDZDRA5Tme9Aie72bfScQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:36:56 INFO - mkdir: /builds/slave/test/properties 17:36:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:36:56 INFO - Writing to file /builds/slave/test/properties/build_url 17:36:56 INFO - Contents: 17:36:56 INFO - build_url:https://queue.taskcluster.net/v1/task/FgDZDRA5Tme9Aie72bfScQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:36:56 INFO - Running post-action listener: _resource_record_post_action 17:36:56 INFO - Running post-action listener: set_extra_try_arguments 17:36:56 INFO - [mozharness: 2016-08-12 00:36:56.744387Z] Finished download-and-extract step (success) 17:36:56 INFO - [mozharness: 2016-08-12 00:36:56.744620Z] Running populate-webroot step. 17:36:56 INFO - Running pre-action listener: _resource_record_pre_action 17:36:56 INFO - Running main action method: populate_webroot 17:36:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:36:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:36:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:36:56 INFO - '--tppagecycles', 17:36:56 INFO - '7'], 17:36:56 INFO - 'tests': ['tsvgm']}}, 17:36:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:36:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:36:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:36:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:36:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:36:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:36:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:56 INFO - 'talos_options': ['--disable-e10s'], 17:36:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:36:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:36:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:56 INFO - 'talos_options': ['--disable-e10s'], 17:36:56 INFO - 'tests': ['damp', 'tps']}, 17:36:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:56 INFO - 'tests': ['damp', 'tps']}, 17:36:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:36:56 INFO - 'tests': ['dromaeo_dom']}, 17:36:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:36:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:36:56 INFO - 'tests': ['basic_compositor_video']}, 17:36:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:36:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:36:56 INFO - 'tests': ['a11yr', 17:36:56 INFO - 'ts_paint', 17:36:56 INFO - 'tpaint', 17:36:56 INFO - 'sessionrestore', 17:36:56 INFO - 'sessionrestore_no_auto_restore', 17:36:56 INFO - 'tabpaint']}, 17:36:56 INFO - 'other-e10s': {'tests': ['a11yr', 17:36:56 INFO - 'ts_paint', 17:36:56 INFO - 'tpaint', 17:36:56 INFO - 'sessionrestore', 17:36:56 INFO - 'sessionrestore_no_auto_restore', 17:36:56 INFO - 'tabpaint']}, 17:36:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:36:56 INFO - 'ts_paint', 17:36:56 INFO - 'tpaint', 17:36:56 INFO - 'sessionrestore', 17:36:56 INFO - 'sessionrestore_no_auto_restore', 17:36:56 INFO - 'tabpaint']}, 17:36:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:36:56 INFO - 'ts_paint', 17:36:56 INFO - 'tpaint', 17:36:56 INFO - 'sessionrestore', 17:36:56 INFO - 'sessionrestore_no_auto_restore', 17:36:56 INFO - 'tabpaint']}, 17:36:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:36:56 INFO - 'tests': ['a11yr', 17:36:56 INFO - 'ts_paint', 17:36:56 INFO - 'tpaint', 17:36:56 INFO - 'sessionrestore', 17:36:56 INFO - 'sessionrestore_no_auto_restore', 17:36:56 INFO - 'tabpaint']}, 17:36:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:36:56 INFO - 'tests': ['a11yr', 17:36:56 INFO - 'ts_paint', 17:36:56 INFO - 'tpaint', 17:36:56 INFO - 'sessionrestore', 17:36:56 INFO - 'sessionrestore_no_auto_restore', 17:36:56 INFO - 'tabpaint']}, 17:36:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:36:56 INFO - 'tests': ['tsvgx', 17:36:56 INFO - 'tsvgr_opacity', 17:36:56 INFO - 'tart', 17:36:56 INFO - 'tscrollx', 17:36:56 INFO - 'cart']}, 17:36:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:36:56 INFO - 'tsvgr_opacity', 17:36:56 INFO - 'tart', 17:36:56 INFO - 'tscrollx', 17:36:56 INFO - 'cart']}, 17:36:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:56 INFO - 'talos_options': ['--disable-e10s'], 17:36:56 INFO - 'tests': ['tp5o']}, 17:36:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:56 INFO - 'tests': ['tp5o']}, 17:36:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:56 INFO - 'talos_options': ['--disable-e10s', 17:36:56 INFO - '--xperf_path', 17:36:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:36:56 INFO - 'tests': ['tp5n']}, 17:36:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:56 INFO - 'talos_options': ['--xperf_path', 17:36:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:36:56 INFO - 'tests': ['tp5n']}}, 17:36:56 INFO - 'talos.zip': {'path': '', 17:36:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:36:56 INFO - Running post-action listener: _resource_record_post_action 17:36:56 INFO - [mozharness: 2016-08-12 00:36:56.760957Z] Finished populate-webroot step (success) 17:36:56 INFO - [mozharness: 2016-08-12 00:36:56.761044Z] Running create-virtualenv step. 17:36:56 INFO - Running pre-action listener: _resource_record_pre_action 17:36:56 INFO - Running main action method: create_virtualenv 17:36:56 INFO - Creating virtualenv /builds/slave/test/build/venv 17:36:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:36:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:36:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:36:56 INFO - Using real prefix '/usr' 17:36:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:36:57 INFO - Installing distribute.............................................................................................................................................................................................done. 17:36:59 INFO - Installing pip.................done. 17:36:59 INFO - Return code: 0 17:36:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:59 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 0xc56030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf17180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf153b0>, '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 0xf162b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf16740>, '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': '41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:36:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:36:59 INFO - Using env: {'DISPLAY': ':0', 17:36:59 INFO - 'HOME': '/home/cltbld', 17:36:59 INFO - 'LANG': 'en_US.UTF-8', 17:36:59 INFO - 'LANGUAGE': 'en_US:en', 17:36:59 INFO - 'LOGNAME': 'cltbld', 17:36:59 INFO - 'MAIL': '/var/mail/cltbld', 17:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:59 INFO - 'MOZ_NO_REMOTE': '1', 17:36:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:59 INFO - 'NO_EM_RESTART': '1', 17:36:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:59 INFO - 'PWD': '/builds/slave/test', 17:36:59 INFO - 'SHELL': '/bin/bash', 17:36:59 INFO - 'SHLVL': '1', 17:36:59 INFO - 'TERM': 'linux', 17:36:59 INFO - 'TMOUT': '86400', 17:36:59 INFO - 'USER': 'cltbld', 17:36:59 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220', 17:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:59 INFO - '_': '/tools/buildbot/bin/python'} 17:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:36:59 INFO - Cleaning up... 17:36:59 INFO - Return code: 0 17:36:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:59 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 0xc56030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf17180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf153b0>, '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 0xf162b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf16740>, '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': '41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:36:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:36:59 INFO - Using env: {'DISPLAY': ':0', 17:36:59 INFO - 'HOME': '/home/cltbld', 17:36:59 INFO - 'LANG': 'en_US.UTF-8', 17:36:59 INFO - 'LANGUAGE': 'en_US:en', 17:36:59 INFO - 'LOGNAME': 'cltbld', 17:36:59 INFO - 'MAIL': '/var/mail/cltbld', 17:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:59 INFO - 'MOZ_NO_REMOTE': '1', 17:36:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:59 INFO - 'NO_EM_RESTART': '1', 17:36:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:59 INFO - 'PWD': '/builds/slave/test', 17:36:59 INFO - 'SHELL': '/bin/bash', 17:36:59 INFO - 'SHLVL': '1', 17:36:59 INFO - 'TERM': 'linux', 17:36:59 INFO - 'TMOUT': '86400', 17:36:59 INFO - 'USER': 'cltbld', 17:36:59 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220', 17:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:59 INFO - '_': '/tools/buildbot/bin/python'} 17:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:59 INFO - Downloading/unpacking psutil>=3.1.1 17:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:37:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:37:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:37:01 INFO - Installing collected packages: psutil 17:37:01 INFO - Running setup.py install for psutil 17:37:01 INFO - building 'psutil._psutil_linux' extension 17:37:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:37:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:37:02 INFO - building 'psutil._psutil_posix' extension 17:37:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:37:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:37:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:37:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:37:02 INFO - Successfully installed psutil 17:37:02 INFO - Cleaning up... 17:37:02 INFO - Return code: 0 17:37:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:37:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc56030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf17180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf153b0>, '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 0xf162b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf16740>, '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': '41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:37:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:37:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:37:02 INFO - Using env: {'DISPLAY': ':0', 17:37:02 INFO - 'HOME': '/home/cltbld', 17:37:02 INFO - 'LANG': 'en_US.UTF-8', 17:37:02 INFO - 'LANGUAGE': 'en_US:en', 17:37:02 INFO - 'LOGNAME': 'cltbld', 17:37:02 INFO - 'MAIL': '/var/mail/cltbld', 17:37:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:02 INFO - 'MOZ_NO_REMOTE': '1', 17:37:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:02 INFO - 'NO_EM_RESTART': '1', 17:37:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:02 INFO - 'PWD': '/builds/slave/test', 17:37:02 INFO - 'SHELL': '/bin/bash', 17:37:02 INFO - 'SHLVL': '1', 17:37:02 INFO - 'TERM': 'linux', 17:37:02 INFO - 'TMOUT': '86400', 17:37:02 INFO - 'USER': 'cltbld', 17:37:02 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220', 17:37:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:02 INFO - '_': '/tools/buildbot/bin/python'} 17:37:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:37:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:37:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:37:04 INFO - Installing collected packages: mozsystemmonitor 17:37:04 INFO - Running setup.py install for mozsystemmonitor 17:37:04 INFO - Successfully installed mozsystemmonitor 17:37:04 INFO - Cleaning up... 17:37:04 INFO - Return code: 0 17:37:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc56030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf17180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf153b0>, '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 0xf162b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf16740>, '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': '41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:37:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:37:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:37:04 INFO - Using env: {'DISPLAY': ':0', 17:37:04 INFO - 'HOME': '/home/cltbld', 17:37:04 INFO - 'LANG': 'en_US.UTF-8', 17:37:04 INFO - 'LANGUAGE': 'en_US:en', 17:37:04 INFO - 'LOGNAME': 'cltbld', 17:37:04 INFO - 'MAIL': '/var/mail/cltbld', 17:37:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:04 INFO - 'MOZ_NO_REMOTE': '1', 17:37:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:04 INFO - 'NO_EM_RESTART': '1', 17:37:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:04 INFO - 'PWD': '/builds/slave/test', 17:37:04 INFO - 'SHELL': '/bin/bash', 17:37:04 INFO - 'SHLVL': '1', 17:37:04 INFO - 'TERM': 'linux', 17:37:04 INFO - 'TMOUT': '86400', 17:37:04 INFO - 'USER': 'cltbld', 17:37:04 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220', 17:37:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:04 INFO - '_': '/tools/buildbot/bin/python'} 17:37:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:04 INFO - Downloading/unpacking jsonschema==2.5.1 17:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:37:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:07 INFO - Downloading functools32-3.2.3-2.tar.gz 17:37:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:37:07 INFO - warning: no files found matching '*.txt' 17:37:07 INFO - no previously-included directories found matching 'build' 17:37:07 INFO - no previously-included directories found matching 'dist' 17:37:07 INFO - no previously-included directories found matching '.git*' 17:37:07 INFO - Installing collected packages: jsonschema, functools32 17:37:07 INFO - Running setup.py install for functools32 17:37:07 INFO - warning: no files found matching '*.txt' 17:37:07 INFO - no previously-included directories found matching 'build' 17:37:07 INFO - no previously-included directories found matching 'dist' 17:37:07 INFO - no previously-included directories found matching '.git*' 17:37:07 INFO - Successfully installed jsonschema functools32 17:37:07 INFO - Cleaning up... 17:37:07 INFO - Return code: 0 17:37:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:37:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc56030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf17180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf153b0>, '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 0xf162b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf16740>, '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': '41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:37:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:37:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:37:07 INFO - Using env: {'DISPLAY': ':0', 17:37:07 INFO - 'HOME': '/home/cltbld', 17:37:07 INFO - 'LANG': 'en_US.UTF-8', 17:37:07 INFO - 'LANGUAGE': 'en_US:en', 17:37:07 INFO - 'LOGNAME': 'cltbld', 17:37:07 INFO - 'MAIL': '/var/mail/cltbld', 17:37:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:07 INFO - 'MOZ_NO_REMOTE': '1', 17:37:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:07 INFO - 'NO_EM_RESTART': '1', 17:37:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:07 INFO - 'PWD': '/builds/slave/test', 17:37:07 INFO - 'SHELL': '/bin/bash', 17:37:07 INFO - 'SHLVL': '1', 17:37:07 INFO - 'TERM': 'linux', 17:37:07 INFO - 'TMOUT': '86400', 17:37:07 INFO - 'USER': 'cltbld', 17:37:07 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220', 17:37:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:07 INFO - '_': '/tools/buildbot/bin/python'} 17:37:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:37:07 INFO - Cleaning up... 17:37:07 INFO - Return code: 0 17:37:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:37:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc56030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf17180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf153b0>, '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 0xf162b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf16740>, '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': '41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:37:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:37:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:37:07 INFO - Using env: {'DISPLAY': ':0', 17:37:07 INFO - 'HOME': '/home/cltbld', 17:37:07 INFO - 'LANG': 'en_US.UTF-8', 17:37:07 INFO - 'LANGUAGE': 'en_US:en', 17:37:07 INFO - 'LOGNAME': 'cltbld', 17:37:07 INFO - 'MAIL': '/var/mail/cltbld', 17:37:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:07 INFO - 'MOZ_NO_REMOTE': '1', 17:37:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:07 INFO - 'NO_EM_RESTART': '1', 17:37:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:07 INFO - 'PWD': '/builds/slave/test', 17:37:07 INFO - 'SHELL': '/bin/bash', 17:37:07 INFO - 'SHLVL': '1', 17:37:07 INFO - 'TERM': 'linux', 17:37:07 INFO - 'TMOUT': '86400', 17:37:07 INFO - 'USER': 'cltbld', 17:37:07 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220', 17:37:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:07 INFO - '_': '/tools/buildbot/bin/python'} 17:37:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:07 INFO - Downloading/unpacking blobuploader==1.2.4 17:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:09 INFO - Downloading blobuploader-1.2.4.tar.gz 17:37:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:37:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:37:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:10 INFO - Downloading docopt-0.6.1.tar.gz 17:37:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:37:10 INFO - Installing collected packages: blobuploader, requests, docopt 17:37:10 INFO - Running setup.py install for blobuploader 17:37:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:37:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:37:10 INFO - Running setup.py install for requests 17:37:10 INFO - Running setup.py install for docopt 17:37:10 INFO - Successfully installed blobuploader requests docopt 17:37:10 INFO - Cleaning up... 17:37:11 INFO - Return code: 0 17:37:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:37:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:11 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 0xc56030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf17180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf153b0>, '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 0xf162b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf16740>, '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': '41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:37:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:37:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:37:11 INFO - Using env: {'DISPLAY': ':0', 17:37:11 INFO - 'HOME': '/home/cltbld', 17:37:11 INFO - 'LANG': 'en_US.UTF-8', 17:37:11 INFO - 'LANGUAGE': 'en_US:en', 17:37:11 INFO - 'LOGNAME': 'cltbld', 17:37:11 INFO - 'MAIL': '/var/mail/cltbld', 17:37:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:11 INFO - 'MOZ_NO_REMOTE': '1', 17:37:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:11 INFO - 'NO_EM_RESTART': '1', 17:37:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:11 INFO - 'PWD': '/builds/slave/test', 17:37:11 INFO - 'SHELL': '/bin/bash', 17:37:11 INFO - 'SHLVL': '1', 17:37:11 INFO - 'TERM': 'linux', 17:37:11 INFO - 'TMOUT': '86400', 17:37:11 INFO - 'USER': 'cltbld', 17:37:11 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220', 17:37:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:11 INFO - '_': '/tools/buildbot/bin/python'} 17:37:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:37:11 INFO - Running setup.py (path:/tmp/pip-76HBHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:37:11 INFO - Running setup.py (path:/tmp/pip-C9j6dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:37:11 INFO - Running setup.py (path:/tmp/pip-ipcVGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:37:11 INFO - Running setup.py (path:/tmp/pip-1bV5cW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:37:11 INFO - Running setup.py (path:/tmp/pip-GWd9M6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:37:11 INFO - Running setup.py (path:/tmp/pip-hfG7Hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:37:11 INFO - Running setup.py (path:/tmp/pip-XAFoya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:37:11 INFO - Running setup.py (path:/tmp/pip-LKgqzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:37:11 INFO - Running setup.py (path:/tmp/pip-LRQaa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:37:11 INFO - Running setup.py (path:/tmp/pip-jp6yaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:37:11 INFO - Running setup.py (path:/tmp/pip-bHt1zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:37:12 INFO - Running setup.py (path:/tmp/pip-t7Y2xX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:37:12 INFO - Running setup.py (path:/tmp/pip-P3KxaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:37:12 INFO - Running setup.py (path:/tmp/pip-Dobw0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:37:12 INFO - Running setup.py (path:/tmp/pip-vhtXaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:37:12 INFO - Running setup.py (path:/tmp/pip-rXPmnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:37:12 INFO - Running setup.py (path:/tmp/pip-TLLYB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:37:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:37:12 INFO - Running setup.py install for manifestparser 17:37:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:37:12 INFO - Running setup.py install for mozcrash 17:37:12 INFO - Running setup.py install for mozdebug 17:37:12 INFO - Running setup.py install for mozdevice 17:37:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:37:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:37:12 INFO - Running setup.py install for mozfile 17:37:13 INFO - Running setup.py install for mozhttpd 17:37:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:37:13 INFO - Running setup.py install for mozinfo 17:37:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:37:13 INFO - Running setup.py install for mozInstall 17:37:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:37:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:37:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:37:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:37:13 INFO - Running setup.py install for mozleak 17:37:13 INFO - Running setup.py install for mozlog 17:37:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:37:13 INFO - Running setup.py install for moznetwork 17:37:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:37:13 INFO - Running setup.py install for mozprocess 17:37:13 INFO - Running setup.py install for mozprofile 17:37:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:37:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:37:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:37:13 INFO - Running setup.py install for mozrunner 17:37:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:37:13 INFO - Running setup.py install for mozscreenshot 17:37:14 INFO - Running setup.py install for moztest 17:37:14 INFO - Running setup.py install for mozversion 17:37:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:37:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:37:14 INFO - Cleaning up... 17:37:14 INFO - Return code: 0 17:37:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:37: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')]} 17:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37: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')]} 17:37:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:14 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 0xc56030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf17180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf153b0>, '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 0xf162b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf16740>, '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': '41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:37:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:37:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:37:14 INFO - Using env: {'DISPLAY': ':0', 17:37:14 INFO - 'HOME': '/home/cltbld', 17:37:14 INFO - 'LANG': 'en_US.UTF-8', 17:37:14 INFO - 'LANGUAGE': 'en_US:en', 17:37:14 INFO - 'LOGNAME': 'cltbld', 17:37:14 INFO - 'MAIL': '/var/mail/cltbld', 17:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:14 INFO - 'MOZ_NO_REMOTE': '1', 17:37:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:14 INFO - 'NO_EM_RESTART': '1', 17:37:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:14 INFO - 'PWD': '/builds/slave/test', 17:37:14 INFO - 'SHELL': '/bin/bash', 17:37:14 INFO - 'SHLVL': '1', 17:37:14 INFO - 'TERM': 'linux', 17:37:14 INFO - 'TMOUT': '86400', 17:37:14 INFO - 'USER': 'cltbld', 17:37:14 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220', 17:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:14 INFO - '_': '/tools/buildbot/bin/python'} 17:37:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:37:14 INFO - Running setup.py (path:/tmp/pip-mGdSTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:37:14 INFO - Running setup.py (path:/tmp/pip-uSnssI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:37:14 INFO - Running setup.py (path:/tmp/pip-M8hCPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:37:14 INFO - Running setup.py (path:/tmp/pip-W3eWdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:37:14 INFO - Running setup.py (path:/tmp/pip-Zn54rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:37:14 INFO - Running setup.py (path:/tmp/pip-028sex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:37:14 INFO - Running setup.py (path:/tmp/pip-NQfsIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:37:15 INFO - Running setup.py (path:/tmp/pip-lGsdtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:37:15 INFO - Running setup.py (path:/tmp/pip-Xxa1nS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:37:15 INFO - Running setup.py (path:/tmp/pip-4heAoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:37:15 INFO - Running setup.py (path:/tmp/pip-dE7wYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:37:15 INFO - Running setup.py (path:/tmp/pip-Qqoqxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:37:15 INFO - Running setup.py (path:/tmp/pip-1JyJGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:37:15 INFO - Running setup.py (path:/tmp/pip-flHO1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:37:15 INFO - Running setup.py (path:/tmp/pip-AEHMQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:37:15 INFO - Running setup.py (path:/tmp/pip-CzJuSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:37:15 INFO - Running setup.py (path:/tmp/pip-QhQF1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:37:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:37: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 17:37: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 17:37: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 17:37: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 17:37: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 17:37: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 17:37:17 INFO - Downloading blessings-1.6.tar.gz 17:37:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:37:17 INFO - Installing collected packages: blessings 17:37:17 INFO - Running setup.py install for blessings 17:37:17 INFO - Successfully installed blessings 17:37:17 INFO - Cleaning up... 17:37:17 INFO - Return code: 0 17:37:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:37:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:37:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:37:18 INFO - Reading from file tmpfile_stdout 17:37:18 INFO - Current package versions: 17:37:18 INFO - argparse == 1.2.1 17:37:18 INFO - blessings == 1.6 17:37:18 INFO - blobuploader == 1.2.4 17:37:18 INFO - docopt == 0.6.1 17:37:18 INFO - functools32 == 3.2.3-2 17:37:18 INFO - jsonschema == 2.5.1 17:37:18 INFO - manifestparser == 1.1 17:37:18 INFO - mozInstall == 1.12 17:37:18 INFO - mozcrash == 0.17 17:37:18 INFO - mozdebug == 0.1 17:37:18 INFO - mozdevice == 0.48 17:37:18 INFO - mozfile == 1.2 17:37:18 INFO - mozhttpd == 0.7 17:37:18 INFO - mozinfo == 0.9 17:37:18 INFO - mozleak == 0.1 17:37:18 INFO - mozlog == 3.3 17:37:18 INFO - moznetwork == 0.27 17:37:18 INFO - mozprocess == 0.23 17:37:18 INFO - mozprofile == 0.28 17:37:18 INFO - mozrunner == 6.12 17:37:18 INFO - mozscreenshot == 0.1 17:37:18 INFO - mozsystemmonitor == 0.3 17:37:18 INFO - moztest == 0.7 17:37:18 INFO - mozversion == 1.4 17:37:18 INFO - psutil == 3.1.1 17:37:18 INFO - requests == 1.2.3 17:37:18 INFO - wsgiref == 0.1.2 17:37:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:18 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 0xc56030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf17180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf153b0>, '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 0xf162b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf16740>, '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': '41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:37:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:37:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:37:18 INFO - Using env: {'DISPLAY': ':0', 17:37:18 INFO - 'HOME': '/home/cltbld', 17:37:18 INFO - 'LANG': 'en_US.UTF-8', 17:37:18 INFO - 'LANGUAGE': 'en_US:en', 17:37:18 INFO - 'LOGNAME': 'cltbld', 17:37:18 INFO - 'MAIL': '/var/mail/cltbld', 17:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:18 INFO - 'MOZ_NO_REMOTE': '1', 17:37:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:18 INFO - 'NO_EM_RESTART': '1', 17:37:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:18 INFO - 'PWD': '/builds/slave/test', 17:37:18 INFO - 'SHELL': '/bin/bash', 17:37:18 INFO - 'SHLVL': '1', 17:37:18 INFO - 'TERM': 'linux', 17:37:18 INFO - 'TMOUT': '86400', 17:37:18 INFO - 'USER': 'cltbld', 17:37:18 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220', 17:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:18 INFO - '_': '/tools/buildbot/bin/python'} 17:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:37:18 INFO - Cleaning up... 17:37:18 INFO - Return code: 0 17:37:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc56030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf17180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf153b0>, '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 0xf162b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf16740>, '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': '41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:37:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:37:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:37:18 INFO - Using env: {'DISPLAY': ':0', 17:37:18 INFO - 'HOME': '/home/cltbld', 17:37:18 INFO - 'LANG': 'en_US.UTF-8', 17:37:18 INFO - 'LANGUAGE': 'en_US:en', 17:37:18 INFO - 'LOGNAME': 'cltbld', 17:37:18 INFO - 'MAIL': '/var/mail/cltbld', 17:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:18 INFO - 'MOZ_NO_REMOTE': '1', 17:37:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:18 INFO - 'NO_EM_RESTART': '1', 17:37:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:18 INFO - 'PWD': '/builds/slave/test', 17:37:18 INFO - 'SHELL': '/bin/bash', 17:37:18 INFO - 'SHLVL': '1', 17:37:18 INFO - 'TERM': 'linux', 17:37:18 INFO - 'TMOUT': '86400', 17:37:18 INFO - 'USER': 'cltbld', 17:37:18 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220', 17:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:18 INFO - '_': '/tools/buildbot/bin/python'} 17:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:37:18 INFO - Cleaning up... 17:37:18 INFO - Return code: 0 17:37:18 INFO - Running post-action listener: _resource_record_post_action 17:37:18 INFO - Running post-action listener: _start_resource_monitoring 17:37:18 INFO - Starting resource monitoring. 17:37:18 INFO - [mozharness: 2016-08-12 00:37:18.568674Z] Finished create-virtualenv step (success) 17:37:18 INFO - [mozharness: 2016-08-12 00:37:18.569117Z] Running install step. 17:37:18 INFO - Running pre-action listener: _resource_record_pre_action 17:37:18 INFO - Running main action method: install 17:37:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:37:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:37:18 INFO - Reading from file tmpfile_stdout 17:37:18 INFO - Detecting whether we're running mozinstall >=1.0... 17:37:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:37:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:37:18 INFO - Reading from file tmpfile_stdout 17:37:18 INFO - Output received: 17:37:18 INFO - Usage: mozinstall [options] installer 17:37:18 INFO - Options: 17:37:18 INFO - -h, --help show this help message and exit 17:37:18 INFO - -d DEST, --destination=DEST 17:37:18 INFO - Directory to install application into. [default: 17:37:18 INFO - "/builds/slave/test"] 17:37:18 INFO - --app=APP Application being installed. [default: firefox] 17:37:18 INFO - mkdir: /builds/slave/test/build/application 17:37:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:37:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:37:35 INFO - Reading from file tmpfile_stdout 17:37:35 INFO - Output received: 17:37:35 INFO - /builds/slave/test/build/application/firefox/firefox 17:37:35 INFO - Running post-action listener: _resource_record_post_action 17:37:35 INFO - [mozharness: 2016-08-12 00:37:35.776749Z] Finished install step (success) 17:37:35 INFO - [mozharness: 2016-08-12 00:37:35.776996Z] Running run-tests step. 17:37:35 INFO - Running pre-action listener: _resource_record_pre_action 17:37:35 INFO - Running main action method: run_tests 17:37:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:37:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:37:35 INFO - Python 2.7.3 17:37:35 INFO - Return code: 0 17:37:35 INFO - grabbing minidump binary from tooltool 17:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:35 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 0xf153b0>, '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 0xf162b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf16740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:37:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:37:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:37:35 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:37:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:37:35 INFO - Return code: 0 17:37:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:37:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:37:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:37:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:37:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:37:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FgDZDRA5Tme9Aie72bfScQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:37:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FgDZDRA5Tme9Aie72bfScQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:37:35 INFO - Using env: {'DISPLAY': ':0', 17:37:35 INFO - 'HOME': '/home/cltbld', 17:37:35 INFO - 'LANG': 'en_US.UTF-8', 17:37:35 INFO - 'LANGUAGE': 'en_US:en', 17:37:35 INFO - 'LOGNAME': 'cltbld', 17:37:35 INFO - 'MAIL': '/var/mail/cltbld', 17:37:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:37:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:35 INFO - 'MOZ_NO_REMOTE': '1', 17:37:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:37:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:35 INFO - 'NO_EM_RESTART': '1', 17:37:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:35 INFO - 'PWD': '/builds/slave/test', 17:37:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:37:35 INFO - 'SHELL': '/bin/bash', 17:37:35 INFO - 'SHLVL': '1', 17:37:35 INFO - 'TERM': 'linux', 17:37:35 INFO - 'TMOUT': '86400', 17:37:35 INFO - 'USER': 'cltbld', 17:37:35 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220', 17:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:35 INFO - '_': '/tools/buildbot/bin/python'} 17:37:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FgDZDRA5Tme9Aie72bfScQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:37:36 INFO - mozversion application_buildid: 20160811143001 17:37:36 INFO - mozversion application_changeset: 61340bd78a4bf05890f4b84a6ca57ba01c0ee29b 17:37:36 INFO - mozversion application_display_name: Nightly 17:37:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:37:36 INFO - mozversion application_name: Firefox 17:37:36 INFO - mozversion application_remotingname: firefox 17:37:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:37:36 INFO - mozversion application_vendor: Mozilla 17:37:36 INFO - mozversion application_version: 51.0a1 17:37:36 INFO - mozversion platform_buildid: 20160811143001 17:37:36 INFO - mozversion platform_changeset: 61340bd78a4bf05890f4b84a6ca57ba01c0ee29b 17:37:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:37:36 INFO - mozversion platform_version: 51.0a1 17:37:36 INFO - using testdate: 1470962256 17:37:36 INFO - actual date: 1470962256 17:37:36 INFO - starting webserver on 'localhost:53285' 17:37:36 INFO - SUITE-START | Running 2 tests 17:37:36 INFO - TEST-START | dromaeo_css 17:37:36 INFO - operating with platform_type : linux_ 17:37:36 INFO - Initialising browser for dromaeo_css test... 17:37:36 INFO - TEST-INFO | started process 20090 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb44smw/profile http://localhost:53285/getInfo.html) 17:37:40 INFO - PROCESS | 20090 | __metrics Screen width/height:1600/1200 17:37:40 INFO - PROCESS | 20090 | colorDepth:24 17:37:40 INFO - PROCESS | 20090 | Browser inner width/height: 1024/697 17:37:40 INFO - PROCESS | 20090 | __metrics 17:37:41 ERROR - PROCESS | 20090 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 17:37:42 INFO - TEST-INFO | 20090: exit 0 17:37:42 INFO - Browser initialized. 17:37:42 INFO - Running cycle 1/1 for dromaeo_css test... 17:37:42 INFO - TEST-INFO | started process 20210 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb44smw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:37:53 INFO - PROCESS | 20210 | RSS: Main: 163180544 17:37:53 INFO - PROCESS | 20210 | 17:38:43 INFO - PROCESS | 20210 | 1470962323547 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:40:53 INFO - PROCESS | 20210 | Cycle 1(1): loaded http://localhost:53285/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53285/tests/dromaeo/cssquery-ext.html) 17:40:54 INFO - PROCESS | 20210 | RSS: Main: 164839424 17:40:54 INFO - PROCESS | 20210 | 17:43:56 INFO - PROCESS | 20210 | Cycle 1(1): loaded http://localhost:53285/tests/dromaeo/cssquery-ext.html (next: http://localhost:53285/tests/dromaeo/cssquery-jquery.html) 17:43:57 INFO - PROCESS | 20210 | RSS: Main: 164667392 17:43:57 INFO - PROCESS | 20210 | 17:46:59 INFO - PROCESS | 20210 | Cycle 1(1): loaded http://localhost:53285/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53285/tests/dromaeo/cssquery-mootools.html) 17:46:59 INFO - PROCESS | 20210 | RSS: Main: 169074688 17:46:59 INFO - PROCESS | 20210 | 17:50:01 INFO - PROCESS | 20210 | Cycle 1(1): loaded http://localhost:53285/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53285/tests/dromaeo/cssquery-prototype.html) 17:50:02 INFO - PROCESS | 20210 | RSS: Main: 163864576 17:50:02 INFO - PROCESS | 20210 | 17:53:04 INFO - PROCESS | 20210 | Cycle 1(1): loaded http://localhost:53285/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53285/tests/dromaeo/cssquery-yui.html) 17:53:05 INFO - PROCESS | 20210 | RSS: Main: 165695488 17:53:05 INFO - PROCESS | 20210 | 17:56:08 INFO - PROCESS | 20210 | Cycle 1(1): loaded http://localhost:53285/tests/dromaeo/cssquery-yui.html (next: http://localhost:53285/tests/dromaeo/cssquery-dojo.html) 17:56:08 INFO - PROCESS | 20210 | RSS: Main: 169345024 17:56:08 INFO - PROCESS | 20210 | 17:56:08 INFO - PROCESS | 20210 | __start_tp_report 17:56:08 INFO - PROCESS | 20210 | _x_x_mozilla_page_load 17:56:08 INFO - PROCESS | 20210 | _x_x_mozilla_page_load_details 17:56:08 INFO - PROCESS | 20210 | |i|pagename|runs| 17:56:08 INFO - PROCESS | 20210 | |0;dojo.html;3087.4133914556232;3098.4267910436556;3120.4851199552077;3126.359096385241;3139.183812208825;5224.712640804754;5265.078611243036;5309.044372013041;5339.332583427072;5378.273933019051;5344.118220493624;5352.973235133819;5392.838214853551;5407.810726624569;5423.430539793314;4677.555632214951;4774.212254977924;4921.704697718148;4954.752262386866;5072.797088116489;5001.324821149135;5002.649814512985;5020.6234532410035;5058.949410505903;5063.594912407017;4775.928361074587;4800.183968725325;4911.7544122793715;4947.084789313988;4980.252962055684;4816.662833601649;4839.201531747258;4856.902861942742;4869.586085182764;4941.629377796679;4832.395950506187;4895.094407534618;4895.143349913751;4895.437024742165;4919.975400122977;5246.554042906358;5295.7881684732565;5339.038972984861;5404.972975135139;5447.891042179174;5717.542596592262;5722.656640601577;5733.741981610838;5746;5774.769009239625;5729.255196824386;5732.5127364174095;5780.479756821906;5795.652260864362;5797.4782269595935;5233.4243233244315;5301.284326615896;5361.490658387447;5376.569874410038;5387.892242155135;5890.145928840294;5938.435848594377;5941.732622031933;5942.227510423703;5944.6730429826775;5649.943500564942;5675.971620141955;5694.658320500783;5709.429057094258;5714.342850572154;5501.312335958005;5720.2849643794525;5723.742431590588;5754.223179870748;5773.913391299134;5487.368952570426;5692.544596432275;5736.340320863154;5757.222774925415;5758.280214973129;5757.0788673811985;5777.508911742465;5783.508401785811;5788.971055144697;5807.274090738658;4257.957420425756;4345.67407444443;4445.59989600931;4447.199504089295;4504.61710754583;3877.9030524236555;3899.980500097538;3946.664533514626;3950.20995800841;3993.7603743775467;5435.293411856513;5500.642458240201;5516.3380394352935;5528.087865502228;5574.386817450078;5581.665100094007;5786.797462088891;5791.189233507313;5793.826185214366;5795.159701843209;5503.3395992481155;5527.419620939824;5533.6403133796175;5602.887942241214;5606.943930560724;4993.300937868701;5032.345795046621;5040.470750571138;5050.4697006814495;5071.974640126776;5736.368999409978;6042.788502402394;6043.153958445909;6044.1840351552855;6051.880402125621;5761.56788240892;5781.132830075354;5781.335146458043;5854.5609079320075;5929.792457263975;6050.667213303311;6060.606060606223;6068.969655151696;6077.24034495688;6085.604435711664;5505.174223866452;5711.828645140652;5776.913346299725;5780.710964451677;5790.131480277992;5738.713064346683;5775.1914731938405;5798.420157984167;5803.709814509342;5884.440978107073;5638.830835074954;5675.77296908119;5679.0345641240265;5679.574031947538;5695.373508913934;5369.48989845964;5634.267545219095;5634.52106570946;5636.971815140898;5663.150527420919;5486.423925487767;5616.21373007771;5621.887562248814;5621.887562248814;5644.971775141098;5668.234788303526;5712.742926568231;5727.226824378822;5735.340435849764;5749.942500574941;5318.867028324323;5453.072977593898;5535.16972454119;5558.194061861089;5558.416366281644 17:56:08 INFO - PROCESS | 20210 | |1;ext.html;543.9544041051709;580.817042631571;594.2037669522839;607.1136141233799;623.9469645080168;37400.25199496008;41789;41819.790901045526;42015.369769453406;42097.57902420975;42413.78793106038;42646.36030459546;43068.353974690406;43141.35287970683;43141.784291078504;8683.044865064854;8847.73456796297;8893.510856902867;8919.910800891972;8951.552422378887;8706.216440520351;8837.823243535126;8888.06675299094;8892.199702026815;8900.599473023729;8875.556222188865;8910.821783564325;8927.37508374414;8947.32895032872;8966.282697384226;8842.425242359226;8892.8666070009;8896.688615898445;8900.955495222483;8903.510306933116;8733.083026282276;8823.338249631239;8824.779380515474;8841.867371989425;8874.156955089256;40015.39976900349;40448.79775601133;40477.79761101176;40478.79760601208;40837.591624083674;3668.1196512836727;3740.5511338639267;3777.9811100944594;3787.0532366908274;4241.830326786925;32517;32902.6709732902;32988.835055824806;33017;33227.33545329104;3919.960800391988;3975.6421922026866;3985.2228815381013;4010.4184893190322;4084.7140700151003;355441;356166;358258;359693.9999999974;360759;35200;35900.10249743777;36003.059495183;38123.42814857779;55225.44774552283;37521.812390938416;37527.24945501129;37564.81217593949;37691.81154094212;37706.8114659425;12533.310667913353;12550;12593.307368094842;12651.430685619169;12758.425870835834;11455.885441145649;11474.254173478697;11487.25332853362;11530.654080377602;11534.653960381202;8620.310375170096;8622.482651040958;8670.86993695095;8702.08628094041;8711.91101112361;3301.8018918864946;3338.4658454647138;3361.3445378151514;3408.9147771305916;3430.5025771263026;987.1559816357055;1022.7187523431116;1134.4384529657873;1148.7932172208916;1155.9537618495167;32736.181595460304;32829.34341313208;33292.66707332896;33591.16022099467;33689.663103369145;1090.4820210400155;1100.2408338246585;1120.506976930148;1212.6180253220207;1259.4458438287124;16911.23899424529;17166.742498862528;17402.41474599598;17465.825341746673;17673.20470578827;578844;580053;583587;590280;881021;57854.42145578575;58056.709716451995;58233.4176658228;58440.4155958435;58481.41518584845;1358.395513996282;1362.3256488038287;1363.5023216525897;1365.6654119740726;1381.254122773691;29943.842261801732;32182.678173218905;32300.67699322977;32381.514277285387;32668.183295416853;48769.756151219015;49326.75336623294;49350.75324623498;49381.506184937694;49382;416773;420203;420798;421020;422000;28312;28824.423511529232;29813.850930746074;29815.701842982162;31149.688503114678;49542.75228623834;49668.75165624149;49727;51175.2323715152;51248;40890.38664419977;41445.1710965785;41822.163556729305;41899;43895.56104439042;40762;41249.79375103225;41669;42166;42432;35434.645653543135;40888;41093.1781364377;41097;41610.375844361755;35433.46849797203;36987.260254794215;38315.38194272078;38417.4237386445;38450;28649;28875.42249155047;28887.855560722903;28966.7103328964;29233.41533169367 17:56:08 INFO - PROCESS | 20210 | |2;jquery.html;378.72353182176994;379.2207014585027;395.6122999460529;396.9702272329576;418.13237532120854;19774.802251977493;20125.792452452864;20550.89724551379;20691.99999999998;20778.480537986557;18841.24635014601;19046.90476547619;19522;19559;19604.31384901529;5641.661500309974;5669.064604340299;5777.971110144444;5847.26909136358;5870.324912635059;5795.942040579604;5809.535237181015;5822.475977162055;5831.416858314177;5836.124581312816;5673.23411339468;5686.346070201938;5689.061304884689;5698.43015698431;5787.47912687858;5290.1800220965815;5745.109508026221;5831.533477321804;5838.948989181946;5858.443447872445;5320.14877619579;5433.022056029913;5449.56403487724;5466.726663666801;5476.726163691839;15260.389584416722;22783.31650050501;23130;23380.532389352116;23488.177913773106;2229.2420577003736;2298.0807676929194;2400.8559486430695;2423.4426082001064;2491.6636254105647;10371.896281037169;10418.166546676248;10759.892401075967;12842.871571284355;14549.127052376785;1902.3722171683312;1928.238345853394;1929.3343796390363;1966.488712934633;1978.9703154452695;81519.59240203821;82184.9999999994;84056.57971710163;85390.57304713498;85638.57180714118;10764.838527422095;10782.892171078345;10977.506012229309;11157.609483668033;11315.20793544444;15433.305501252471;15561.377544898078;15564.377424902877;15609.687806243812;15628.140452275007;7783.571903545359;7867.606619669108;8029.3175080118845;8148.674053037812;8182.590870456454;7327.853442931111;7409.061585033087;7422.109346878409;7541.321281084619;7722.498037627536;4303.376010478463;4531.478879928784;4568.177728008924;4862.149123903303;4869.366982292279;2002.4593359792775;2010.517475805796;2033.9593208135755;2037.2665840297482;2040.2553068130323;952.7665721898179;962.4273557233435;1025.9897401025894;1036.4662198967537;1051.810674078658;19305.613887722167;19868.90065549663;19935.202591896163;19953.700694489595;20000.799991999895;954.4178051388648;964.4502633498838;1034.182995433614;1034.4414016431194;1037.5642230263309;10503.107235885036;10927.398993055458;10944.124470042378;10982.176336774774;11116.777664446667;425714;491434;497997;498028;514438;92500;94030.52984735169;94789.5260523693;94888;96747.51626241964;964.71058682395;1007.8639383683255;1012.448215722433;1019.7756493571402;1026.9024442677933;14916.477923272634;17395.30418783285;17607.119644018003;17798.911005445407;17850.91074544619;40079.39880901731;41489;42461.363079553215;42470.362944555236;42732.14535709331;56826;57077;57704.42295576991;63616.363836361044;64460.35539644543;8335.583220839055;8437.156284371515;8673.262772664142;8797.043876247051;8891.19979201875;9584.233261339215;12388;13007.154534955198;13545;13613.11514751538;11858.288502689866;11897.345645989553;12030.939845300718;12166.330851803235;12204.75590488203;11463.828042579535;11756.412179391167;11802.689157440274;12049.51801927913;12243.938780306042;11807.586734464252;11902.821457677968;12009.879901200877;12322.075844311534;12368.319742414255;8692.348073894356;8699.217070463688;8751.212390884852;8779.341549383695;8960.148785865333;5725.856853578527;10218.335808172445;11682;11915.821262680893;12047.337396442928 17:56:08 INFO - PROCESS | 20210 | |3;mootools.html;1474.609228554433;1479.3860547872634;1608.9919550402246;1747.1875577856295;1770.5308093355254;7077.539959902602;7829.882551761721;7901.288884000439;8414.873776893344;8437.451565648229;8224.958875205615;8235.711750088749;8270.793230169249;8282.875756863652;8293.170682931705;2252.0203711385557;2283.8858057097164;2292.060255295329;2304.331743794298;2305.0664480885266;2209.0390680054147;2234.7876951689564;2260.08466571039;2265.954680906381;2270.500489892221;2279.7036385269976;2285.268714011517;2291.2209848651455;2297.5519773644146;2306.400335912658;2222.9666555001686;2244.36035729817;2244.753077161503;2247.6291411917014;2252.4368907773055;2205.7353117625826;2206.911723531057;2209.1384360099573;2216.1357070742424;2222.855514391559;8256.711015114503;8322.750317490485;8365.12166222544;8377.664893404257;8386.077531471534;4947.332110165117;5041.571466425358;5079.974600127012;5086.262491938648;5107.029664363759;3049.344390955933;3299.769016168845;3390.8304584770663;3394.389009978203;3468.3583537045474;1093.7101668057892;1100.1693721240413;1124.2860783402516;1131.7849608574427;1151.407025381929;11233.10135189183;11245.381504017276;11271.830922536168;11279.37963412012;11304.717382065432;4281.721688090264;4449.822007119679;4497.572730590588;4596.126735920165;4612.838550650711;9525.095115963972;9586.760330991781;9589.041095890356;9610.759731006641;9643.132118109264;5126.256692779601;5130.1535246684625;5136.510411980558;5143.022825663112;5149.48505149482;4006.318925782624;4662.300654901724;4748.121597504403;4751.976240118846;4762.023785124041;3737.7009839212797;3878.7090968176935;3956.8417263309143;3972.82122304497;4050.250703619781;1298.9025823063118;1301.4686434884059;1304.1132030219542;1306.941187646558;1312.923402809706;846.4413487098485;969.6121551379505;972.1590823937244;983.3460748602242;986.4722373530127;5577.860553486114;5771.134329850556;5795.565332600072;5866.208061911588;5962.40375962409;443.17569321062797;443.4102643484158;455.07392456351164;456.422625378896;459.7011942237506;4039.7576145431367;4082.285600020044;4113.4858142732155;4132.483439570054;4136.8138433770555;9788.412695238309;10169.644062457926;10189.847152292721;10193.337433066827;10242.180625549938;10099.545520451597;10145.695629131138;10167.28828981979;10178.338408003605;10178.541965611565;7356.926430735732;7398.556086634819;7408;7423.517471364344;7455.85088298231;5381.246625472359;5517.889642207214;5570.053090974463;5574.581906356958;5717.42825717425;9095.272378209595;9141.314401419788;9280.72157835266;9328.113829186217;9442.10300021497;9270.072992700676;9321.533923303943;9335.673251436167;9398.765030874283;9418.57616407277;6217.285012223652;7011.193712723102;7283.490155689051;7286.089238845145;7423.517471364344;7936.404769642185;8001.759947201594;8035.598220089089;8043.436959412785;8046.87929681067;6978.511504194657;7067.434605231466;7121.323474269936;7146.678399471933;7229;6992.440604751506;7012.7545535906;7040.260772618802;7162.319579639926;7235.63821808897;6678.666066696548;6694.0628312037325;6812.761553345609;6823.55646882951;6829.248782634006;5022.171341728574;5085.949140508696;5109.821156259513;5129.358830146231;5157.922631160611;5034.622403319692;5097.898042039213;5121.155009423553;5177.767000485062;5232.790688372423 17:56:08 INFO - PROCESS | 20210 | |4;prototype.html;325.6857132866783;329.3741890408225;336.5893609796048;339.45686900958486;341.520164169342;5485.725713714313;5579.63732357397;5581.916271255935;5591.6365436246615;5641;5516.9448305516935;5521.309836270466;5538.944610553894;5560;5567.721613919308;4031.8387264509383;4214.494260688722;4286.335617979218;4288.335308027261;4307.310830267158;4300.956990430087;4304.869089800537;4315.654747620199;4317.589828966259;4324.524302326741;4294.291441912081;4300.204462174492;4308.870733877989;4339.783010849461;4354.891127721817;4145.896352591164;4284.357346398066;4324.243257429937;4329.112531930962;4348.869533913988;3837.5992762641436;3858.1704933439164;3860.6911447084167;3864.3430616795213;3864.613538646141;5399.541039011689;5408.91886621701;5452.263944367499;5465.857132148991;5466.781328746845;4907.509249075064;4960.751962401865;4985.750712464399;5007.273945277951;5007.574356179693;5730.19777231188;5731.283589551306;5736.8852622947725;5776.10470377088;5819.301683797929;4214.91570168598;4230.76730779807;4242.151569686075;4242.745435273893;4242.766647834368;5816.272965879265;5951.256092988377;5964.373740757244;5969.70151492428;6082.665453400061;4314.352847072964;4337.284348082594;4340;4344.717593356421;4368.475782906008;4423.248047831877;4424.31423129409;4425.712328698689;4427.734335939854;4428.911421771547;4790.670484013647;4899.681520701143;4945.406551213805;4960.925586116211;4982.800687972441;5731.971340143273;5742.598018138774;5747.7929634777165;5749.88500229993;5833.445822646841;1504.6840163565773;1529.9923500382426;1542.6451916059145;1545.127003243164;1550.682110167413;930.437085563238;980.0493521284343;988.545269176187;995.6365926436944;998.650472334677;5437.401885792559;5521.337439507204;5526.309211348582;5580.441955804387;5611.410801865745;5861.238039054895;5882.852928676817;5905.881882362329;5909.409059094056;5920.911186332209;5396.596884809977;5464.590155738336;5514.283143191359;5539.750711218005;5559.388467268597;3126.6248050234117;3129.2959084205872;3143.9528407073913;3148.449021421242;3161.1780936956557;5849.356570777211;6086.543509236736;6104.816855494342;6105.389461053948;6121.540884433685;6087.817365479043;6102.115193296947;6123.693815309306;6169.889419904371;6177.62934223939;6228.377162283736;6256.186695729617;6270.7491700331475;6273.905891411632;6278.717457714322;5880.794172203952;5881.441263080172;5939.079442686218;5966.418898991684;5978.611390259619;5949.434803693643;5958;5991.191189189403;6015.308239552332;6028.125921741411;6047.213862197887;6078.6048906820915;6147.186579959012;6295.874082518232;6312.43188113072;4138.503379594468;4171.520275168395;4188.706790524634;4206.85276015338;4209.34755112958;6052.455279024909;6090.573659843769;6098.573099882966;6111.84720381994;6121.204243448323;5690.2887139107615;5841.4450627190345;5863.413658634103;5878.882422351615;5958.292948570581;5796.362400135898;5838.94161058384;5856.882862342814;5896.262967129109;5920.73356698941;5620.4098569649595;5746.5402767779315;5753.223314852441;5772.797952071657;5840.707964601668;5868.2077919480325;5878.911816322844;5894.2926848778425;5931.792387266425;5939.346671866005;5755.942440575541;5784.248047753765;5784.334801497882;5808;5834.533237341087 17:56:08 INFO - PROCESS | 20210 | |5;yui.html;751.3575892611817;765.9157492675802;784.8037990502374;834.2408408348405;846.2806614377776;14973.176475293854;15828.604284892883;15829.445969391074;15911.68176636468;15993.360265589363;15132.394704211818;15356.155411452366;15407.075575465451;15421;15494.84505154948;650.5608714117975;777.1102088109112;794.0590400375573;799.2646764976221;800.8918795962558;801.8636831738589;808.5876203136384;816.2694388522269;816.808050108224;819.0499021135485;872.5942436766902;874.7244617945327;874.8731433942074;875.671623141322;876.408424313589;853.9615717292737;865.926396256319;865.948043117415;870.4820631724114;870.7387783664875;633.733831790649;634.3878157577914;634.3941535833268;635.6853357587977;636.3731724251609;13584.592462226148;13592.86407135926;13616.251106189156;13647.727045459034;13650.658733531642;15584.220788960507;15603.531894043197;15606.609834754108;15620.999999999887;15744.448944286894;11791.351475668835;12178.878211217952;12245.387730613524;12272.815907761391;12642;3901.609839016104;3923.4311024901517;3923.8234279457492;3966.147278335172;4064.79676016201;86848;88077.55961220217;88388;89739.55130224307;90989.54505227432;11943.661971830987;11974.281543107441;12029;12066.517339306329;12288.75422491563;23411.882940585187;23424.414389640395;23531.41171470727;23573.88213058958;23592.292231233092;8481.872771908425;8492.235698787139;8635.654573817103;8758.86861697075;8934.329925255503;4708.4349878014855;4809.0862736080035;4820.927686084711;4886.560209581155;4887.095887260868;3479.739019573542;3590.389633762267;3605.513255710498;3613.259281847215;3619.638036196412;606.2755007765678;611.8837420890017;617.4874853871275;632.8639342541284;638.4732595608641;616.3128112154915;636.3477435628517;674.275154209227;702.6592102830124;709.5529816215751;9373.343865929455;9648.228141748643;9830.75423114428;9834.590525321342;9948.104670579683;625.0124207555765;696.8048946295046;716.158513746346;723.3598265534935;726.8037629839913;4602.010567727888;4707.741074240881;4773;4776.21192503233;4826.517348265145;126691;128750.35624822004;129206.35396822955;129674;134981;110813;114644;115370.42314788372;117230;119885;94598;94928.0507194933;98769;99901;102725;9068.818623627623;9222.170004699608;9288.674896378594;9328.347015708836;9335.766605834908;55442;55993.16010259768;56666;56954.430455694914;57261.71369143128;81049.59475202586;81935.18064819275;83232.16767832244;85056.57471712602;87270;12482.625521234377;12577.43401546951;12735.490580377053;12887.548935787203;12994.155379900276;13660.590182294547;13666.316684165553;13855.653608659864;13925.512607058705;14010.719785604435;13020.28388438645;13335.799963000756;13481.528146514825;13553.86446135526;13842.515511957034;12922.030847686274;13421.328933553088;13427.664308392368;13839;13940.721185576029;9864.950675246579;12243.877561224273;13557.118787278796;13559.118657287245;13701.520446784314;10723.517441714985;10752;11216.83174752363;11260.605878794202;11780.116491263017;9601.231901448007;9970.850437243593;10510.31682940637;11800.114991375853;11813.11401644863 17:56:08 INFO - PROCESS | 20210 | __end_tp_report 17:56:08 INFO - PROCESS | 20210 | __start_cc_report 17:56:08 INFO - PROCESS | 20210 | _x_x_mozilla_cycle_collect,343 17:56:08 INFO - PROCESS | 20210 | __end_cc_report 17:56:08 INFO - PROCESS | 20210 | __startTimestamp1470963368535__endTimestamp 17:56:08 INFO - PROCESS | 20210 | 17:56:08 INFO - PROCESS | 20210 | ------- Summary: start ------- 17:56:08 INFO - PROCESS | 20210 | Number of tests: 6 17:56:08 INFO - PROCESS | 20210 | 17:56:08 INFO - PROCESS | 20210 | [#0] dojo.html Cycles:165 Average:5362.23 Median:5574.39 stddev:615.20 (11.0%) stddev-sans-first:590.63 17:56:08 INFO - PROCESS | 20210 | Values: 3087.4 3098.4 3120.5 3126.4 3139.2 5224.7 5265.1 5309.0 5339.3 5378.3 5344.1 5353.0 5392.8 5407.8 5423.4 4677.6 4774.2 4921.7 4954.8 5072.8 5001.3 5002.6 5020.6 5058.9 5063.6 4775.9 4800.2 4911.8 4947.1 4980.3 4816.7 4839.2 4856.9 4869.6 4941.6 4832.4 4895.1 4895.1 4895.4 4920.0 5246.6 5295.8 5339.0 5405.0 5447.9 5717.5 5722.7 5733.7 5746.0 5774.8 5729.3 5732.5 5780.5 5795.7 5797.5 5233.4 5301.3 5361.5 5376.6 5387.9 5890.1 5938.4 5941.7 5942.2 5944.7 5649.9 5676.0 5694.7 5709.4 5714.3 5501.3 5720.3 5723.7 5754.2 5773.9 5487.4 5692.5 5736.3 5757.2 5758.3 5757.1 5777.5 5783.5 5789.0 5807.3 4258.0 4345.7 4445.6 4447.2 4504.6 3877.9 3900.0 3946.7 3950.2 3993.8 5435.3 5500.6 5516.3 5528.1 5574.4 5581.7 5786.8 5791.2 5793.8 5795.2 5503.3 5527.4 5533.6 5602.9 5606.9 4993.3 5032.3 5040.5 5050.5 5072.0 5736.4 6042.8 6043.2 6044.2 6051.9 5761.6 5781.1 5781.3 5854.6 5929.8 6050.7 6060.6 6069.0 6077.2 6085.6 5505.2 5711.8 5776.9 5780.7 5790.1 5738.7 5775.2 5798.4 5803.7 5884.4 5638.8 5675.8 5679.0 5679.6 5695.4 5369.5 5634.3 5634.5 5637.0 5663.2 5486.4 5616.2 5621.9 5621.9 5645.0 5668.2 5712.7 5727.2 5735.3 5749.9 5318.9 5453.1 5535.2 5558.2 5558.4 17:56:08 INFO - PROCESS | 20210 | 17:56:08 INFO - PROCESS | 20210 | [#1] ext.html Cycles:180 Average:61343.28 Median:40478.30 stddev:132208.62 (326.6%) stddev-sans-first:132500.69 17:56:08 INFO - PROCESS | 20210 | Values: 544.0 580.8 594.2 607.1 623.9 37400.3 41789.0 41819.8 42015.4 42097.6 42413.8 42646.4 43068.4 43141.4 43141.8 8683.0 8847.7 8893.5 8919.9 8951.6 8706.2 8837.8 8888.1 8892.2 8900.6 8875.6 8910.8 8927.4 8947.3 8966.3 8842.4 8892.9 8896.7 8901.0 8903.5 8733.1 8823.3 8824.8 8841.9 8874.2 40015.4 40448.8 40477.8 40478.8 40837.6 3668.1 3740.6 3778.0 3787.1 4241.8 32517.0 32902.7 32988.8 33017.0 33227.3 3920.0 3975.6 3985.2 4010.4 4084.7 355441.0 356166.0 358258.0 359694.0 360759.0 35200.0 35900.1 36003.1 38123.4 55225.4 37521.8 37527.2 37564.8 37691.8 37706.8 12533.3 12550.0 12593.3 12651.4 12758.4 11455.9 11474.3 11487.3 11530.7 11534.7 8620.3 8622.5 8670.9 8702.1 8711.9 3301.8 3338.5 3361.3 3408.9 3430.5 987.2 1022.7 1134.4 1148.8 1156.0 32736.2 32829.3 33292.7 33591.2 33689.7 1090.5 1100.2 1120.5 1212.6 1259.4 16911.2 17166.7 17402.4 17465.8 17673.2 578844.0 580053.0 583587.0 590280.0 881021.0 57854.4 58056.7 58233.4 58440.4 58481.4 1358.4 1362.3 1363.5 1365.7 1381.3 29943.8 32182.7 32300.7 32381.5 32668.2 48769.8 49326.8 49350.8 49381.5 49382.0 416773.0 420203.0 420798.0 421020.0 422000.0 28312.0 28824.4 29813.9 29815.7 31149.7 49542.8 49668.8 49727.0 51175.2 51248.0 40890.4 41445.2 41822.2 41899.0 43895.6 40762.0 41249.8 41669.0 42166.0 42432.0 35434.6 40888.0 41093.2 41097.0 41610.4 35433.5 36987.3 38315.4 38417.4 38450.0 28649.0 28875.4 28887.9 28966.7 29233.4 17:56:08 INFO - PROCESS | 20210 | 17:56:08 INFO - PROCESS | 20210 | [#2] jquery.html Cycles:180 Average:29098.48 Median:2412.15 stddev:80375.07 (3332.1%) stddev-sans-first:80571.61 17:56:08 INFO - PROCESS | 20210 | Values: 378.7 379.2 395.6 397.0 418.1 19774.8 20125.8 20550.9 20692.0 20778.5 18841.2 19046.9 19522.0 19559.0 19604.3 5641.7 5669.1 5778.0 5847.3 5870.3 5795.9 5809.5 5822.5 5831.4 5836.1 5673.2 5686.3 5689.1 5698.4 5787.5 5290.2 5745.1 5831.5 5838.9 5858.4 5320.1 5433.0 5449.6 5466.7 5476.7 15260.4 22783.3 23130.0 23380.5 23488.2 2229.2 2298.1 2400.9 2423.4 2491.7 10371.9 10418.2 10759.9 12842.9 14549.1 1902.4 1928.2 1929.3 1966.5 1979.0 81519.6 82185.0 84056.6 85390.6 85638.6 10764.8 10782.9 10977.5 11157.6 11315.2 15433.3 15561.4 15564.4 15609.7 15628.1 7783.6 7867.6 8029.3 8148.7 8182.6 7327.9 7409.1 7422.1 7541.3 7722.5 4303.4 4531.5 4568.2 4862.1 4869.4 2002.5 2010.5 2034.0 2037.3 2040.3 952.8 962.4 1026.0 1036.5 1051.8 19305.6 19868.9 19935.2 19953.7 20000.8 954.4 964.5 1034.2 1034.4 1037.6 10503.1 10927.4 10944.1 10982.2 11116.8 425714.0 491434.0 497997.0 498028.0 514438.0 92500.0 94030.5 94789.5 94888.0 96747.5 964.7 1007.9 1012.4 1019.8 1026.9 14916.5 17395.3 17607.1 17798.9 17850.9 40079.4 41489.0 42461.4 42470.4 42732.1 56826.0 57077.0 57704.4 63616.4 64460.4 8335.6 8437.2 8673.3 8797.0 8891.2 9584.2 12388.0 13007.2 13545.0 13613.1 11858.3 11897.3 12030.9 12166.3 12204.8 11463.8 11756.4 11802.7 12049.5 12243.9 11807.6 11902.8 12009.9 12322.1 12368.3 8692.3 8699.2 8751.2 8779.3 8960.1 5725.9 10218.3 11682.0 11915.8 12047.3 17:56:08 INFO - PROCESS | 20210 | 17:56:08 INFO - PROCESS | 20210 | [#3] mootools.html Cycles:180 Average:5461.45 Median:5092.08 stddev:3016.03 (59.2%) stddev-sans-first:3009.61 17:56:08 INFO - PROCESS | 20210 | Values: 1474.6 1479.4 1609.0 1747.2 1770.5 7077.5 7829.9 7901.3 8414.9 8437.5 8225.0 8235.7 8270.8 8282.9 8293.2 2252.0 2283.9 2292.1 2304.3 2305.1 2209.0 2234.8 2260.1 2266.0 2270.5 2279.7 2285.3 2291.2 2297.6 2306.4 2223.0 2244.4 2244.8 2247.6 2252.4 2205.7 2206.9 2209.1 2216.1 2222.9 8256.7 8322.8 8365.1 8377.7 8386.1 4947.3 5041.6 5080.0 5086.3 5107.0 3049.3 3299.8 3390.8 3394.4 3468.4 1093.7 1100.2 1124.3 1131.8 1151.4 11233.1 11245.4 11271.8 11279.4 11304.7 4281.7 4449.8 4497.6 4596.1 4612.8 9525.1 9586.8 9589.0 9610.8 9643.1 5126.3 5130.2 5136.5 5143.0 5149.5 4006.3 4662.3 4748.1 4752.0 4762.0 3737.7 3878.7 3956.8 3972.8 4050.3 1298.9 1301.5 1304.1 1306.9 1312.9 846.4 969.6 972.2 983.3 986.5 5577.9 5771.1 5795.6 5866.2 5962.4 443.2 443.4 455.1 456.4 459.7 4039.8 4082.3 4113.5 4132.5 4136.8 9788.4 10169.6 10189.8 10193.3 10242.2 10099.5 10145.7 10167.3 10178.3 10178.5 7356.9 7398.6 7408.0 7423.5 7455.9 5381.2 5517.9 5570.1 5574.6 5717.4 9095.3 9141.3 9280.7 9328.1 9442.1 9270.1 9321.5 9335.7 9398.8 9418.6 6217.3 7011.2 7283.5 7286.1 7423.5 7936.4 8001.8 8035.6 8043.4 8046.9 6978.5 7067.4 7121.3 7146.7 7229.0 6992.4 7012.8 7040.3 7162.3 7235.6 6678.7 6694.1 6812.8 6823.6 6829.2 5022.2 5085.9 5109.8 5129.4 5157.9 5034.6 5097.9 5121.2 5177.8 5232.8 17:56:08 INFO - PROCESS | 20210 | 17:56:08 INFO - PROCESS | 20210 | [#4] prototype.html Cycles:180 Average:4911.43 Median:5581.18 stddev:1444.22 (25.9%) stddev-sans-first:1406.66 17:56:08 INFO - PROCESS | 20210 | Values: 325.7 329.4 336.6 339.5 341.5 5485.7 5579.6 5581.9 5591.6 5641.0 5516.9 5521.3 5538.9 5560.0 5567.7 4031.8 4214.5 4286.3 4288.3 4307.3 4301.0 4304.9 4315.7 4317.6 4324.5 4294.3 4300.2 4308.9 4339.8 4354.9 4145.9 4284.4 4324.2 4329.1 4348.9 3837.6 3858.2 3860.7 3864.3 3864.6 5399.5 5408.9 5452.3 5465.9 5466.8 4907.5 4960.8 4985.8 5007.3 5007.6 5730.2 5731.3 5736.9 5776.1 5819.3 4214.9 4230.8 4242.2 4242.7 4242.8 5816.3 5951.3 5964.4 5969.7 6082.7 4314.4 4337.3 4340.0 4344.7 4368.5 4423.2 4424.3 4425.7 4427.7 4428.9 4790.7 4899.7 4945.4 4960.9 4982.8 5732.0 5742.6 5747.8 5749.9 5833.4 1504.7 1530.0 1542.6 1545.1 1550.7 930.4 980.0 988.5 995.6 998.7 5437.4 5521.3 5526.3 5580.4 5611.4 5861.2 5882.9 5905.9 5909.4 5920.9 5396.6 5464.6 5514.3 5539.8 5559.4 3126.6 3129.3 3144.0 3148.4 3161.2 5849.4 6086.5 6104.8 6105.4 6121.5 6087.8 6102.1 6123.7 6169.9 6177.6 6228.4 6256.2 6270.7 6273.9 6278.7 5880.8 5881.4 5939.1 5966.4 5978.6 5949.4 5958.0 5991.2 6015.3 6028.1 6047.2 6078.6 6147.2 6295.9 6312.4 4138.5 4171.5 4188.7 4206.9 4209.3 6052.5 6090.6 6098.6 6111.8 6121.2 5690.3 5841.4 5863.4 5878.9 5958.3 5796.4 5838.9 5856.9 5896.3 5920.7 5620.4 5746.5 5753.2 5772.8 5840.7 5868.2 5878.9 5894.3 5931.8 5939.3 5755.9 5784.2 5784.3 5808.0 5834.5 17:56:08 INFO - PROCESS | 20210 | 17:56:08 INFO - PROCESS | 20210 | [#5] yui.html Cycles:180 Average:22782.87 Median:4740.72 stddev:34457.90 (726.8%) stddev-sans-first:34514.85 17:56:08 INFO - PROCESS | 20210 | Values: 751.4 765.9 784.8 834.2 846.3 14973.2 15828.6 15829.4 15911.7 15993.4 15132.4 15356.2 15407.1 15421.0 15494.8 650.6 777.1 794.1 799.3 800.9 801.9 808.6 816.3 816.8 819.0 872.6 874.7 874.9 875.7 876.4 854.0 865.9 865.9 870.5 870.7 633.7 634.4 634.4 635.7 636.4 13584.6 13592.9 13616.3 13647.7 13650.7 15584.2 15603.5 15606.6 15621.0 15744.4 11791.4 12178.9 12245.4 12272.8 12642.0 3901.6 3923.4 3923.8 3966.1 4064.8 86848.0 88077.6 88388.0 89739.6 90989.5 11943.7 11974.3 12029.0 12066.5 12288.8 23411.9 23424.4 23531.4 23573.9 23592.3 8481.9 8492.2 8635.7 8758.9 8934.3 4708.4 4809.1 4820.9 4886.6 4887.1 3479.7 3590.4 3605.5 3613.3 3619.6 606.3 611.9 617.5 632.9 638.5 616.3 636.3 674.3 702.7 709.6 9373.3 9648.2 9830.8 9834.6 9948.1 625.0 696.8 716.2 723.4 726.8 4602.0 4707.7 4773.0 4776.2 4826.5 126691.0 128750.4 129206.4 129674.0 134981.0 110813.0 114644.0 115370.4 117230.0 119885.0 94598.0 94928.1 98769.0 99901.0 102725.0 9068.8 9222.2 9288.7 9328.3 9335.8 55442.0 55993.2 56666.0 56954.4 57261.7 81049.6 81935.2 83232.2 85056.6 87270.0 12482.6 12577.4 12735.5 12887.5 12994.2 13660.6 13666.3 13855.7 13925.5 14010.7 13020.3 13335.8 13481.5 13553.9 13842.5 12922.0 13421.3 13427.7 13839.0 13940.7 9865.0 12243.9 13557.1 13559.1 13701.5 10723.5 10752.0 11216.8 11260.6 11780.1 9601.2 9970.9 10510.3 11800.1 11813.1 17:56:08 INFO - PROCESS | 20210 | -------- Summary: end -------- 17:56:08 INFO - PROCESS | 20210 | 17:56:09 INFO - TEST-INFO | 20210: exit 0 17:56:09 INFO - TEST-OK | dromaeo_css | took 1113224ms 17:56:09 INFO - TEST-START | kraken 17:56:09 INFO - operating with platform_type : linux_ 17:56:09 INFO - Initialising browser for kraken test... 17:56:09 INFO - TEST-INFO | started process 20461 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLv_sAJ/profile http://localhost:53285/getInfo.html) 17:56:13 INFO - PROCESS | 20461 | __metrics Screen width/height:1600/1200 17:56:13 INFO - PROCESS | 20461 | colorDepth:24 17:56:13 INFO - PROCESS | 20461 | Browser inner width/height: 1024/697 17:56:13 INFO - PROCESS | 20461 | __metrics 17:56:14 ERROR - PROCESS | 20461 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 17:56:15 INFO - TEST-INFO | 20461: exit 0 17:56:15 INFO - Browser initialized. 17:56:15 INFO - Running cycle 1/1 for kraken test... 17:56:15 INFO - TEST-INFO | started process 20580 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLv_sAJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:56:27 INFO - PROCESS | 20580 | RSS: Main: 163151872 17:56:27 INFO - PROCESS | 20580 | 17:56:29 INFO - PROCESS | 20580 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53285/tests/kraken/driver.html?testName=audio-beat-detection) 17:56:30 INFO - PROCESS | 20580 | RSS: Main: 168345600 17:56:30 INFO - PROCESS | 20580 | 17:56:33 INFO - PROCESS | 20580 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53285/tests/kraken/driver.html?testName=audio-dft) 17:56:33 INFO - PROCESS | 20580 | RSS: Main: 167804928 17:56:33 INFO - PROCESS | 20580 | 17:56:36 INFO - PROCESS | 20580 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53285/tests/kraken/driver.html?testName=audio-fft) 17:56:37 INFO - PROCESS | 20580 | RSS: Main: 163905536 17:56:37 INFO - PROCESS | 20580 | 17:56:39 INFO - PROCESS | 20580 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53285/tests/kraken/driver.html?testName=audio-oscillator) 17:56:39 INFO - PROCESS | 20580 | RSS: Main: 164966400 17:56:39 INFO - PROCESS | 20580 | 17:56:42 INFO - PROCESS | 20580 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53285/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:56:42 INFO - PROCESS | 20580 | RSS: Main: 165015552 17:56:42 INFO - PROCESS | 20580 | 17:56:45 INFO - PROCESS | 20580 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53285/tests/kraken/driver.html?testName=imaging-darkroom) 17:56:46 INFO - PROCESS | 20580 | RSS: Main: 164618240 17:56:46 INFO - PROCESS | 20580 | 17:56:49 INFO - PROCESS | 20580 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53285/tests/kraken/driver.html?testName=imaging-desaturate) 17:56:50 INFO - PROCESS | 20580 | RSS: Main: 162349056 17:56:50 INFO - PROCESS | 20580 | 17:56:53 INFO - PROCESS | 20580 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53285/tests/kraken/driver.html?testName=json-parse-financial) 17:56:54 INFO - PROCESS | 20580 | RSS: Main: 164069376 17:56:54 INFO - PROCESS | 20580 | 17:56:55 INFO - PROCESS | 20580 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53285/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:56:56 INFO - PROCESS | 20580 | RSS: Main: 163844096 17:56:56 INFO - PROCESS | 20580 | 17:56:58 INFO - PROCESS | 20580 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53285/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:56:58 INFO - PROCESS | 20580 | RSS: Main: 163958784 17:56:58 INFO - PROCESS | 20580 | 17:57:00 INFO - PROCESS | 20580 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53285/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:57:01 INFO - PROCESS | 20580 | RSS: Main: 164708352 17:57:01 INFO - PROCESS | 20580 | 17:57:04 INFO - PROCESS | 20580 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:57:04 INFO - PROCESS | 20580 | RSS: Main: 165396480 17:57:04 INFO - PROCESS | 20580 | 17:57:07 INFO - PROCESS | 20580 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:57:08 INFO - PROCESS | 20580 | RSS: Main: 164978688 17:57:08 INFO - PROCESS | 20580 | 17:57:09 INFO - PROCESS | 20580 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53285/tests/kraken/driver.html?testName=ai-astar) 17:57:10 INFO - PROCESS | 20580 | RSS: Main: 166072320 17:57:10 INFO - PROCESS | 20580 | 17:57:10 INFO - PROCESS | 20580 | __start_tp_report 17:57:10 INFO - PROCESS | 20580 | _x_x_mozilla_page_load 17:57:10 INFO - PROCESS | 20580 | _x_x_mozilla_page_load_details 17:57:10 INFO - PROCESS | 20580 | |i|pagename|runs| 17:57:10 INFO - PROCESS | 20580 | |0;ai-astar;111;112;107;114;115;112;115;113;113;113 17:57:10 INFO - PROCESS | 20580 | |1;audio-beat-detection;150;117;143;172;121;150;149;123;185;119 17:57:10 INFO - PROCESS | 20580 | |2;audio-dft;163;161;168;163;166;167;168;161;163;163 17:57:10 INFO - PROCESS | 20580 | |3;audio-fft;74;75;76;182;76;78;74;75;170;77 17:57:10 INFO - PROCESS | 20580 | |4;audio-oscillator;85;87;166;84;85;84;137;84;83;143 17:57:10 INFO - PROCESS | 20580 | |5;imaging-gaussian-blur;118;117;116;117;117;117;118;117;119;117 17:57:10 INFO - PROCESS | 20580 | |6;imaging-darkroom;146;146;148;147;147;147;147;147;148;146 17:57:10 INFO - PROCESS | 20580 | |7;imaging-desaturate;95;106;96;95;96;95;95;97;96;95 17:57:10 INFO - PROCESS | 20580 | |8;json-parse-financial;51;54;52;51;52;52;53;52;53;53 17:57:10 INFO - PROCESS | 20580 | |9;json-stringify-tinderbox;63;61;60;61;61;61;60;60;60;61 17:57:10 INFO - PROCESS | 20580 | |10;stanford-crypto-aes;77;92;77;78;78;77;77;77;81;86 17:57:10 INFO - PROCESS | 20580 | |11;stanford-crypto-ccm;127;124;125;123;122;133;133;133;147;141 17:57:10 INFO - PROCESS | 20580 | |12;stanford-crypto-pbkdf2;160;162;164;164;164;169;161;163;167;164 17:57:10 INFO - PROCESS | 20580 | |13;stanford-crypto-sha256-iterative;67;66;66;66;66;63;66;70;64;63 17:57:10 INFO - PROCESS | 20580 | __end_tp_report 17:57:10 INFO - PROCESS | 20580 | __start_cc_report 17:57:10 INFO - PROCESS | 20580 | _x_x_mozilla_cycle_collect,868 17:57:10 INFO - PROCESS | 20580 | __end_cc_report 17:57:10 INFO - PROCESS | 20580 | __startTimestamp1470963430019__endTimestamp 17:57:10 INFO - PROCESS | 20580 | 17:57:10 INFO - PROCESS | 20580 | ------- Summary: start ------- 17:57:10 INFO - PROCESS | 20580 | Number of tests: 14 17:57:10 INFO - PROCESS | 20580 | 17:57:10 INFO - PROCESS | 20580 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:2.32 (2.1%) stddev-sans-first:2.40 17:57:10 INFO - PROCESS | 20580 | Values: 111.0 112.0 107.0 114.0 115.0 112.0 115.0 113.0 113.0 113.0 17:57:10 INFO - PROCESS | 20580 | 17:57:10 INFO - PROCESS | 20580 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:149.50 stddev:23.27 (15.6%) stddev-sans-first:24.54 17:57:10 INFO - PROCESS | 20580 | Values: 150.0 117.0 143.0 172.0 121.0 150.0 149.0 123.0 185.0 119.0 17:57:10 INFO - PROCESS | 20580 | 17:57:10 INFO - PROCESS | 20580 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.50 stddev:2.71 (1.6%) stddev-sans-first:2.83 17:57:10 INFO - PROCESS | 20580 | Values: 163.0 161.0 168.0 163.0 166.0 167.0 168.0 161.0 163.0 163.0 17:57:10 INFO - PROCESS | 20580 | 17:57:10 INFO - PROCESS | 20580 | [#3] audio-fft Cycles:10 Average:95.70 Median:75.50 stddev:42.43 (56.2%) stddev-sans-first:44.28 17:57:10 INFO - PROCESS | 20580 | Values: 74.0 75.0 76.0 182.0 76.0 78.0 74.0 75.0 170.0 77.0 17:57:10 INFO - PROCESS | 20580 | 17:57:10 INFO - PROCESS | 20580 | [#4] audio-oscillator Cycles:10 Average:103.80 Median:84.00 stddev:31.81 (37.9%) stddev-sans-first:33.00 17:57:10 INFO - PROCESS | 20580 | Values: 85.0 87.0 166.0 84.0 85.0 84.0 137.0 84.0 83.0 143.0 17:57:10 INFO - PROCESS | 20580 | 17:57:10 INFO - PROCESS | 20580 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 17:57:10 INFO - PROCESS | 20580 | Values: 118.0 117.0 116.0 117.0 117.0 117.0 118.0 117.0 119.0 117.0 17:57:10 INFO - PROCESS | 20580 | 17:57:10 INFO - PROCESS | 20580 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 17:57:10 INFO - PROCESS | 20580 | Values: 146.0 146.0 148.0 147.0 147.0 147.0 147.0 147.0 148.0 146.0 17:57:10 INFO - PROCESS | 20580 | 17:57:10 INFO - PROCESS | 20580 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:95.50 stddev:3.37 (3.5%) stddev-sans-first:3.53 17:57:10 INFO - PROCESS | 20580 | Values: 95.0 106.0 96.0 95.0 96.0 95.0 95.0 97.0 96.0 95.0 17:57:10 INFO - PROCESS | 20580 | 17:57:10 INFO - PROCESS | 20580 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.50 stddev:0.95 (1.8%) stddev-sans-first:0.88 17:57:10 INFO - PROCESS | 20580 | Values: 51.0 54.0 52.0 51.0 52.0 52.0 53.0 52.0 53.0 53.0 17:57:10 INFO - PROCESS | 20580 | 17:57:10 INFO - PROCESS | 20580 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.92 (1.5%) stddev-sans-first:0.53 17:57:10 INFO - PROCESS | 20580 | Values: 63.0 61.0 60.0 61.0 61.0 61.0 60.0 60.0 60.0 61.0 17:57:10 INFO - PROCESS | 20580 | 17:57:10 INFO - PROCESS | 20580 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:78.00 stddev:5.10 (6.5%) stddev-sans-first:5.29 17:57:10 INFO - PROCESS | 20580 | Values: 77.0 92.0 77.0 78.0 78.0 77.0 77.0 77.0 81.0 86.0 17:57:10 INFO - PROCESS | 20580 | 17:57:10 INFO - PROCESS | 20580 | [#11] stanford-crypto-ccm Cycles:10 Average:130.80 Median:133.00 stddev:8.26 (6.2%) stddev-sans-first:8.64 17:57:10 INFO - PROCESS | 20580 | Values: 127.0 124.0 125.0 123.0 122.0 133.0 133.0 133.0 147.0 141.0 17:57:10 INFO - PROCESS | 20580 | 17:57:10 INFO - PROCESS | 20580 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.80 Median:164.00 stddev:2.66 (1.6%) stddev-sans-first:2.44 17:57:10 INFO - PROCESS | 20580 | Values: 160.0 162.0 164.0 164.0 164.0 169.0 161.0 163.0 167.0 164.0 17:57:10 INFO - PROCESS | 20580 | 17:57:10 INFO - PROCESS | 20580 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:2.06 (3.1%) stddev-sans-first:2.13 17:57:10 INFO - PROCESS | 20580 | Values: 67.0 66.0 66.0 66.0 66.0 63.0 66.0 70.0 64.0 63.0 17:57:10 INFO - PROCESS | 20580 | -------- Summary: end -------- 17:57:10 INFO - PROCESS | 20580 | 17:57:10 INFO - TEST-INFO | 20580: exit 0 17:57:10 INFO - TEST-OK | kraken | took 61715ms 17:57:10 INFO - SUITE-END | took 1174s 17:57:11 INFO - Completed test suite (00:19:35) 17:57:11 INFO - javascript benchmark 17:57:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7196.12922800147, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3087.4133914556232, 3098.4267910436556, 3120.4851199552077, 3126.359096385241, 3139.183812208825, 5224.712640804754, 5265.078611243036, 5309.044372013041, 5339.332583427072, 5378.273933019051, 5344.118220493624, 5352.973235133819, 5392.838214853551, 5407.810726624569, 5423.430539793314, 4677.555632214951, 4774.212254977924, 4921.704697718148, 4954.752262386866, 5072.797088116489, 5001.324821149135, 5002.649814512985, 5020.6234532410035, 5058.949410505903, 5063.594912407017, 4775.928361074587, 4800.183968725325, 4911.7544122793715, 4947.084789313988, 4980.252962055684, 4816.662833601649, 4839.201531747258, 4856.902861942742, 4869.586085182764, 4941.629377796679, 4832.395950506187, 4895.094407534618, 4895.143349913751, 4895.437024742165, 4919.975400122977, 5246.554042906358, 5295.7881684732565, 5339.038972984861, 5404.972975135139, 5447.891042179174, 5717.542596592262, 5722.656640601577, 5733.741981610838, 5746.0, 5774.769009239625, 5729.255196824386, 5732.5127364174095, 5780.479756821906, 5795.652260864362, 5797.4782269595935, 5233.4243233244315, 5301.284326615896, 5361.490658387447, 5376.569874410038, 5387.892242155135, 5890.145928840294, 5938.435848594377, 5941.732622031933, 5942.227510423703, 5944.6730429826775, 5649.943500564942, 5675.971620141955, 5694.658320500783, 5709.429057094258, 5714.342850572154, 5501.312335958005, 5720.2849643794525, 5723.742431590588, 5754.223179870748, 5773.913391299134, 5487.368952570426, 5692.544596432275, 5736.340320863154, 5757.222774925415, 5758.280214973129, 5757.0788673811985, 5777.508911742465, 5783.508401785811, 5788.971055144697, 5807.274090738658, 4257.957420425756, 4345.67407444443, 4445.59989600931, 4447.199504089295, 4504.61710754583, 3877.9030524236555, 3899.980500097538, 3946.664533514626, 3950.20995800841, 3993.7603743775467, 5435.293411856513, 5500.642458240201, 5516.3380394352935, 5528.087865502228, 5574.386817450078, 5581.665100094007, 5786.797462088891, 5791.189233507313, 5793.826185214366, 5795.159701843209, 5503.3395992481155, 5527.419620939824, 5533.6403133796175, 5602.887942241214, 5606.943930560724, 4993.300937868701, 5032.345795046621, 5040.470750571138, 5050.4697006814495, 5071.974640126776, 5736.368999409978, 6042.788502402394, 6043.153958445909, 6044.1840351552855, 6051.880402125621, 5761.56788240892, 5781.132830075354, 5781.335146458043, 5854.5609079320075, 5929.792457263975, 6050.667213303311, 6060.606060606223, 6068.969655151696, 6077.24034495688, 6085.604435711664, 5505.174223866452, 5711.828645140652, 5776.913346299725, 5780.710964451677, 5790.131480277992, 5738.713064346683, 5775.1914731938405, 5798.420157984167, 5803.709814509342, 5884.440978107073, 5638.830835074954, 5675.77296908119, 5679.0345641240265, 5679.574031947538, 5695.373508913934, 5369.48989845964, 5634.267545219095, 5634.52106570946, 5636.971815140898, 5663.150527420919, 5486.423925487767, 5616.21373007771, 5621.887562248814, 5621.887562248814, 5644.971775141098, 5668.234788303526, 5712.742926568231, 5727.226824378822, 5735.340435849764, 5749.942500574941, 5318.867028324323, 5453.072977593898, 5535.16972454119, 5558.194061861089, 5558.416366281644], "value": 5320.472656375476, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.9544041051709, 580.817042631571, 594.2037669522839, 607.1136141233799, 623.9469645080168, 37400.25199496008, 41789.0, 41819.790901045526, 42015.369769453406, 42097.57902420975, 42413.78793106038, 42646.36030459546, 43068.353974690406, 43141.35287970683, 43141.784291078504, 8683.044865064854, 8847.73456796297, 8893.510856902867, 8919.910800891972, 8951.552422378887, 8706.216440520351, 8837.823243535126, 8888.06675299094, 8892.199702026815, 8900.599473023729, 8875.556222188865, 8910.821783564325, 8927.37508374414, 8947.32895032872, 8966.282697384226, 8842.425242359226, 8892.8666070009, 8896.688615898445, 8900.955495222483, 8903.510306933116, 8733.083026282276, 8823.338249631239, 8824.779380515474, 8841.867371989425, 8874.156955089256, 40015.39976900349, 40448.79775601133, 40477.79761101176, 40478.79760601208, 40837.591624083674, 3668.1196512836727, 3740.5511338639267, 3777.9811100944594, 3787.0532366908274, 4241.830326786925, 32517.0, 32902.6709732902, 32988.835055824806, 33017.0, 33227.33545329104, 3919.960800391988, 3975.6421922026866, 3985.2228815381013, 4010.4184893190322, 4084.7140700151003, 355441.0, 356166.0, 358258.0, 359693.9999999974, 360759.0, 35200.0, 35900.10249743777, 36003.059495183, 38123.42814857779, 55225.44774552283, 37521.812390938416, 37527.24945501129, 37564.81217593949, 37691.81154094212, 37706.8114659425, 12533.310667913353, 12550.0, 12593.307368094842, 12651.430685619169, 12758.425870835834, 11455.885441145649, 11474.254173478697, 11487.25332853362, 11530.654080377602, 11534.653960381202, 8620.310375170096, 8622.482651040958, 8670.86993695095, 8702.08628094041, 8711.91101112361, 3301.8018918864946, 3338.4658454647138, 3361.3445378151514, 3408.9147771305916, 3430.5025771263026, 987.1559816357055, 1022.7187523431116, 1134.4384529657873, 1148.7932172208916, 1155.9537618495167, 32736.181595460304, 32829.34341313208, 33292.66707332896, 33591.16022099467, 33689.663103369145, 1090.4820210400155, 1100.2408338246585, 1120.506976930148, 1212.6180253220207, 1259.4458438287124, 16911.23899424529, 17166.742498862528, 17402.41474599598, 17465.825341746673, 17673.20470578827, 578844.0, 580053.0, 583587.0, 590280.0, 881021.0, 57854.42145578575, 58056.709716451995, 58233.4176658228, 58440.4155958435, 58481.41518584845, 1358.395513996282, 1362.3256488038287, 1363.5023216525897, 1365.6654119740726, 1381.254122773691, 29943.842261801732, 32182.678173218905, 32300.67699322977, 32381.514277285387, 32668.183295416853, 48769.756151219015, 49326.75336623294, 49350.75324623498, 49381.506184937694, 49382.0, 416773.0, 420203.0, 420798.0, 421020.0, 422000.0, 28312.0, 28824.423511529232, 29813.850930746074, 29815.701842982162, 31149.688503114678, 49542.75228623834, 49668.75165624149, 49727.0, 51175.2323715152, 51248.0, 40890.38664419977, 41445.1710965785, 41822.163556729305, 41899.0, 43895.56104439042, 40762.0, 41249.79375103225, 41669.0, 42166.0, 42432.0, 35434.645653543135, 40888.0, 41093.1781364377, 41097.0, 41610.375844361755, 35433.46849797203, 36987.260254794215, 38315.38194272078, 38417.4237386445, 38450.0, 28649.0, 28875.42249155047, 28887.855560722903, 28966.7103328964, 29233.41533169367], "value": 18798.636826331436, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.72353182176994, 379.2207014585027, 395.6122999460529, 396.9702272329576, 418.13237532120854, 19774.802251977493, 20125.792452452864, 20550.89724551379, 20691.99999999998, 20778.480537986557, 18841.24635014601, 19046.90476547619, 19522.0, 19559.0, 19604.31384901529, 5641.661500309974, 5669.064604340299, 5777.971110144444, 5847.26909136358, 5870.324912635059, 5795.942040579604, 5809.535237181015, 5822.475977162055, 5831.416858314177, 5836.124581312816, 5673.23411339468, 5686.346070201938, 5689.061304884689, 5698.43015698431, 5787.47912687858, 5290.1800220965815, 5745.109508026221, 5831.533477321804, 5838.948989181946, 5858.443447872445, 5320.14877619579, 5433.022056029913, 5449.56403487724, 5466.726663666801, 5476.726163691839, 15260.389584416722, 22783.31650050501, 23130.0, 23380.532389352116, 23488.177913773106, 2229.2420577003736, 2298.0807676929194, 2400.8559486430695, 2423.4426082001064, 2491.6636254105647, 10371.896281037169, 10418.166546676248, 10759.892401075967, 12842.871571284355, 14549.127052376785, 1902.3722171683312, 1928.238345853394, 1929.3343796390363, 1966.488712934633, 1978.9703154452695, 81519.59240203821, 82184.9999999994, 84056.57971710163, 85390.57304713498, 85638.57180714118, 10764.838527422095, 10782.892171078345, 10977.506012229309, 11157.609483668033, 11315.20793544444, 15433.305501252471, 15561.377544898078, 15564.377424902877, 15609.687806243812, 15628.140452275007, 7783.571903545359, 7867.606619669108, 8029.3175080118845, 8148.674053037812, 8182.590870456454, 7327.853442931111, 7409.061585033087, 7422.109346878409, 7541.321281084619, 7722.498037627536, 4303.376010478463, 4531.478879928784, 4568.177728008924, 4862.149123903303, 4869.366982292279, 2002.4593359792775, 2010.517475805796, 2033.9593208135755, 2037.2665840297482, 2040.2553068130323, 952.7665721898179, 962.4273557233435, 1025.9897401025894, 1036.4662198967537, 1051.810674078658, 19305.613887722167, 19868.90065549663, 19935.202591896163, 19953.700694489595, 20000.799991999895, 954.4178051388648, 964.4502633498838, 1034.182995433614, 1034.4414016431194, 1037.5642230263309, 10503.107235885036, 10927.398993055458, 10944.124470042378, 10982.176336774774, 11116.777664446667, 425714.0, 491434.0, 497997.0, 498028.0, 514438.0, 92500.0, 94030.52984735169, 94789.5260523693, 94888.0, 96747.51626241964, 964.71058682395, 1007.8639383683255, 1012.448215722433, 1019.7756493571402, 1026.9024442677933, 14916.477923272634, 17395.30418783285, 17607.119644018003, 17798.911005445407, 17850.91074544619, 40079.39880901731, 41489.0, 42461.363079553215, 42470.362944555236, 42732.14535709331, 56826.0, 57077.0, 57704.42295576991, 63616.363836361044, 64460.35539644543, 8335.583220839055, 8437.156284371515, 8673.262772664142, 8797.043876247051, 8891.19979201875, 9584.233261339215, 12388.0, 13007.154534955198, 13545.0, 13613.11514751538, 11858.288502689866, 11897.345645989553, 12030.939845300718, 12166.330851803235, 12204.75590488203, 11463.828042579535, 11756.412179391167, 11802.689157440274, 12049.51801927913, 12243.938780306042, 11807.586734464252, 11902.821457677968, 12009.879901200877, 12322.075844311534, 12368.319742414255, 8692.348073894356, 8699.217070463688, 8751.212390884852, 8779.341549383695, 8960.148785865333, 5725.856853578527, 10218.335808172445, 11682.0, 11915.821262680893, 12047.337396442928], "value": 9261.50588214814, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1474.609228554433, 1479.3860547872634, 1608.9919550402246, 1747.1875577856295, 1770.5308093355254, 7077.539959902602, 7829.882551761721, 7901.288884000439, 8414.873776893344, 8437.451565648229, 8224.958875205615, 8235.711750088749, 8270.793230169249, 8282.875756863652, 8293.170682931705, 2252.0203711385557, 2283.8858057097164, 2292.060255295329, 2304.331743794298, 2305.0664480885266, 2209.0390680054147, 2234.7876951689564, 2260.08466571039, 2265.954680906381, 2270.500489892221, 2279.7036385269976, 2285.268714011517, 2291.2209848651455, 2297.5519773644146, 2306.400335912658, 2222.9666555001686, 2244.36035729817, 2244.753077161503, 2247.6291411917014, 2252.4368907773055, 2205.7353117625826, 2206.911723531057, 2209.1384360099573, 2216.1357070742424, 2222.855514391559, 8256.711015114503, 8322.750317490485, 8365.12166222544, 8377.664893404257, 8386.077531471534, 4947.332110165117, 5041.571466425358, 5079.974600127012, 5086.262491938648, 5107.029664363759, 3049.344390955933, 3299.769016168845, 3390.8304584770663, 3394.389009978203, 3468.3583537045474, 1093.7101668057892, 1100.1693721240413, 1124.2860783402516, 1131.7849608574427, 1151.407025381929, 11233.10135189183, 11245.381504017276, 11271.830922536168, 11279.37963412012, 11304.717382065432, 4281.721688090264, 4449.822007119679, 4497.572730590588, 4596.126735920165, 4612.838550650711, 9525.095115963972, 9586.760330991781, 9589.041095890356, 9610.759731006641, 9643.132118109264, 5126.256692779601, 5130.1535246684625, 5136.510411980558, 5143.022825663112, 5149.48505149482, 4006.318925782624, 4662.300654901724, 4748.121597504403, 4751.976240118846, 4762.023785124041, 3737.7009839212797, 3878.7090968176935, 3956.8417263309143, 3972.82122304497, 4050.250703619781, 1298.9025823063118, 1301.4686434884059, 1304.1132030219542, 1306.941187646558, 1312.923402809706, 846.4413487098485, 969.6121551379505, 972.1590823937244, 983.3460748602242, 986.4722373530127, 5577.860553486114, 5771.134329850556, 5795.565332600072, 5866.208061911588, 5962.40375962409, 443.17569321062797, 443.4102643484158, 455.07392456351164, 456.422625378896, 459.7011942237506, 4039.7576145431367, 4082.285600020044, 4113.4858142732155, 4132.483439570054, 4136.8138433770555, 9788.412695238309, 10169.644062457926, 10189.847152292721, 10193.337433066827, 10242.180625549938, 10099.545520451597, 10145.695629131138, 10167.28828981979, 10178.338408003605, 10178.541965611565, 7356.926430735732, 7398.556086634819, 7408.0, 7423.517471364344, 7455.85088298231, 5381.246625472359, 5517.889642207214, 5570.053090974463, 5574.581906356958, 5717.42825717425, 9095.272378209595, 9141.314401419788, 9280.72157835266, 9328.113829186217, 9442.10300021497, 9270.072992700676, 9321.533923303943, 9335.673251436167, 9398.765030874283, 9418.57616407277, 6217.285012223652, 7011.193712723102, 7283.490155689051, 7286.089238845145, 7423.517471364344, 7936.404769642185, 8001.759947201594, 8035.598220089089, 8043.436959412785, 8046.87929681067, 6978.511504194657, 7067.434605231466, 7121.323474269936, 7146.678399471933, 7229.0, 6992.440604751506, 7012.7545535906, 7040.260772618802, 7162.319579639926, 7235.63821808897, 6678.666066696548, 6694.0628312037325, 6812.761553345609, 6823.55646882951, 6829.248782634006, 5022.171341728574, 5085.949140508696, 5109.821156259513, 5129.358830146231, 5157.922631160611, 5034.622403319692, 5097.898042039213, 5121.155009423553, 5177.767000485062, 5232.790688372423], "value": 4362.365998007054, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.6857132866783, 329.3741890408225, 336.5893609796048, 339.45686900958486, 341.520164169342, 5485.725713714313, 5579.63732357397, 5581.916271255935, 5591.6365436246615, 5641.0, 5516.9448305516935, 5521.309836270466, 5538.944610553894, 5560.0, 5567.721613919308, 4031.8387264509383, 4214.494260688722, 4286.335617979218, 4288.335308027261, 4307.310830267158, 4300.956990430087, 4304.869089800537, 4315.654747620199, 4317.589828966259, 4324.524302326741, 4294.291441912081, 4300.204462174492, 4308.870733877989, 4339.783010849461, 4354.891127721817, 4145.896352591164, 4284.357346398066, 4324.243257429937, 4329.112531930962, 4348.869533913988, 3837.5992762641436, 3858.1704933439164, 3860.6911447084167, 3864.3430616795213, 3864.613538646141, 5399.541039011689, 5408.91886621701, 5452.263944367499, 5465.857132148991, 5466.781328746845, 4907.509249075064, 4960.751962401865, 4985.750712464399, 5007.273945277951, 5007.574356179693, 5730.19777231188, 5731.283589551306, 5736.8852622947725, 5776.10470377088, 5819.301683797929, 4214.91570168598, 4230.76730779807, 4242.151569686075, 4242.745435273893, 4242.766647834368, 5816.272965879265, 5951.256092988377, 5964.373740757244, 5969.70151492428, 6082.665453400061, 4314.352847072964, 4337.284348082594, 4340.0, 4344.717593356421, 4368.475782906008, 4423.248047831877, 4424.31423129409, 4425.712328698689, 4427.734335939854, 4428.911421771547, 4790.670484013647, 4899.681520701143, 4945.406551213805, 4960.925586116211, 4982.800687972441, 5731.971340143273, 5742.598018138774, 5747.7929634777165, 5749.88500229993, 5833.445822646841, 1504.6840163565773, 1529.9923500382426, 1542.6451916059145, 1545.127003243164, 1550.682110167413, 930.437085563238, 980.0493521284343, 988.545269176187, 995.6365926436944, 998.650472334677, 5437.401885792559, 5521.337439507204, 5526.309211348582, 5580.441955804387, 5611.410801865745, 5861.238039054895, 5882.852928676817, 5905.881882362329, 5909.409059094056, 5920.911186332209, 5396.596884809977, 5464.590155738336, 5514.283143191359, 5539.750711218005, 5559.388467268597, 3126.6248050234117, 3129.2959084205872, 3143.9528407073913, 3148.449021421242, 3161.1780936956557, 5849.356570777211, 6086.543509236736, 6104.816855494342, 6105.389461053948, 6121.540884433685, 6087.817365479043, 6102.115193296947, 6123.693815309306, 6169.889419904371, 6177.62934223939, 6228.377162283736, 6256.186695729617, 6270.7491700331475, 6273.905891411632, 6278.717457714322, 5880.794172203952, 5881.441263080172, 5939.079442686218, 5966.418898991684, 5978.611390259619, 5949.434803693643, 5958.0, 5991.191189189403, 6015.308239552332, 6028.125921741411, 6047.213862197887, 6078.6048906820915, 6147.186579959012, 6295.874082518232, 6312.43188113072, 4138.503379594468, 4171.520275168395, 4188.706790524634, 4206.85276015338, 4209.34755112958, 6052.455279024909, 6090.573659843769, 6098.573099882966, 6111.84720381994, 6121.204243448323, 5690.2887139107615, 5841.4450627190345, 5863.413658634103, 5878.882422351615, 5958.292948570581, 5796.362400135898, 5838.94161058384, 5856.882862342814, 5896.262967129109, 5920.73356698941, 5620.4098569649595, 5746.5402767779315, 5753.223314852441, 5772.797952071657, 5840.707964601668, 5868.2077919480325, 5878.911816322844, 5894.2926848778425, 5931.792387266425, 5939.346671866005, 5755.942440575541, 5784.248047753765, 5784.334801497882, 5808.0, 5834.533237341087], "value": 4446.816120086149, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.3575892611817, 765.9157492675802, 784.8037990502374, 834.2408408348405, 846.2806614377776, 14973.176475293854, 15828.604284892883, 15829.445969391074, 15911.68176636468, 15993.360265589363, 15132.394704211818, 15356.155411452366, 15407.075575465451, 15421.0, 15494.84505154948, 650.5608714117975, 777.1102088109112, 794.0590400375573, 799.2646764976221, 800.8918795962558, 801.8636831738589, 808.5876203136384, 816.2694388522269, 816.808050108224, 819.0499021135485, 872.5942436766902, 874.7244617945327, 874.8731433942074, 875.671623141322, 876.408424313589, 853.9615717292737, 865.926396256319, 865.948043117415, 870.4820631724114, 870.7387783664875, 633.733831790649, 634.3878157577914, 634.3941535833268, 635.6853357587977, 636.3731724251609, 13584.592462226148, 13592.86407135926, 13616.251106189156, 13647.727045459034, 13650.658733531642, 15584.220788960507, 15603.531894043197, 15606.609834754108, 15620.999999999887, 15744.448944286894, 11791.351475668835, 12178.878211217952, 12245.387730613524, 12272.815907761391, 12642.0, 3901.609839016104, 3923.4311024901517, 3923.8234279457492, 3966.147278335172, 4064.79676016201, 86848.0, 88077.55961220217, 88388.0, 89739.55130224307, 90989.54505227432, 11943.661971830987, 11974.281543107441, 12029.0, 12066.517339306329, 12288.75422491563, 23411.882940585187, 23424.414389640395, 23531.41171470727, 23573.88213058958, 23592.292231233092, 8481.872771908425, 8492.235698787139, 8635.654573817103, 8758.86861697075, 8934.329925255503, 4708.4349878014855, 4809.0862736080035, 4820.927686084711, 4886.560209581155, 4887.095887260868, 3479.739019573542, 3590.389633762267, 3605.513255710498, 3613.259281847215, 3619.638036196412, 606.2755007765678, 611.8837420890017, 617.4874853871275, 632.8639342541284, 638.4732595608641, 616.3128112154915, 636.3477435628517, 674.275154209227, 702.6592102830124, 709.5529816215751, 9373.343865929455, 9648.228141748643, 9830.75423114428, 9834.590525321342, 9948.104670579683, 625.0124207555765, 696.8048946295046, 716.158513746346, 723.3598265534935, 726.8037629839913, 4602.010567727888, 4707.741074240881, 4773.0, 4776.21192503233, 4826.517348265145, 126691.0, 128750.35624822004, 129206.35396822955, 129674.0, 134981.0, 110813.0, 114644.0, 115370.42314788372, 117230.0, 119885.0, 94598.0, 94928.0507194933, 98769.0, 99901.0, 102725.0, 9068.818623627623, 9222.170004699608, 9288.674896378594, 9328.347015708836, 9335.766605834908, 55442.0, 55993.16010259768, 56666.0, 56954.430455694914, 57261.71369143128, 81049.59475202586, 81935.18064819275, 83232.16767832244, 85056.57471712602, 87270.0, 12482.625521234377, 12577.43401546951, 12735.490580377053, 12887.548935787203, 12994.155379900276, 13660.590182294547, 13666.316684165553, 13855.653608659864, 13925.512607058705, 14010.719785604435, 13020.28388438645, 13335.799963000756, 13481.528146514825, 13553.86446135526, 13842.515511957034, 12922.030847686274, 13421.328933553088, 13427.664308392368, 13839.0, 13940.721185576029, 9864.950675246579, 12243.877561224273, 13557.118787278796, 13559.118657287245, 13701.520446784314, 10723.517441714985, 10752.0, 11216.83174752363, 11260.605878794202, 11780.116491263017, 9601.231901448007, 9970.850437243593, 10510.31682940637, 11800.114991375853, 11813.11401644863], "value": 7727.185635389943, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 107.0, 114.0, 115.0, 112.0, 115.0, 113.0, 113.0, 113.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 117.0, 143.0, 172.0, 121.0, 150.0, 149.0, 123.0, 185.0, 119.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 168.0, 163.0, 166.0, 167.0, 168.0, 161.0, 163.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 182.0, 76.0, 78.0, 74.0, 75.0, 170.0, 77.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 166.0, 84.0, 85.0, 84.0, 137.0, 84.0, 83.0, 143.0], "value": 103.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 119.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 106.0, 96.0, 95.0, 96.0, 95.0, 95.0, 97.0, 96.0, 95.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 54.0, 52.0, 51.0, 52.0, 52.0, 53.0, 52.0, 53.0, 53.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 60.0, 61.0, 61.0, 61.0, 60.0, 60.0, 60.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 92.0, 77.0, 78.0, 78.0, 77.0, 77.0, 77.0, 81.0, 86.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 124.0, 125.0, 123.0, 122.0, 133.0, 133.0, 133.0, 147.0, 141.0], "value": 130.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 164.0, 164.0, 164.0, 169.0, 161.0, 163.0, 167.0, 164.0], "value": 163.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 66.0, 63.0, 66.0, 70.0, 64.0, 63.0], "value": 65.7, "unit": "score"}]}]} 17:57:11 INFO - Return code: 0 17:57:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:57:11 ERROR - # TBPL SUCCESS # 17:57:11 INFO - Running post-action listener: _resource_record_post_action 17:57:11 INFO - [mozharness: 2016-08-12 00:57:11.308719Z] Finished run-tests step (success) 17:57:11 INFO - Running post-run listener: _resource_record_post_run 17:57:11 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 542142464; Read time: 216; Write time: 449572 17:57:11 INFO - TinderboxPrint: CPU usage
13.3% 17:57:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 216 17:57:11 INFO - TinderboxPrint: I/O write bytes / time
542,142,464 / 449,572 17:57:11 INFO - TinderboxPrint: CPU idle
8,243.2 (86.7%) 17:57:11 INFO - TinderboxPrint: CPU user
1,211.6 (12.7%) 17:57:11 INFO - TinderboxPrint: Swap in / out
0 / 0 17:57:11 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 248291328; Read time: 0; Write time: 227456 17:57:11 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293482496; Read time: 216; Write time: 222040 17:57:11 INFO - Running post-run listener: _upload_blobber_files 17:57:11 INFO - Blob upload gear active. 17:57:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:57:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:57:11 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:57:11 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:57:12 INFO - (blobuploader) - INFO - Open directory for files ... 17:57:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:57:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:57:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:57:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:57:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:57:13 INFO - (blobuploader) - INFO - Done attempting. 17:57:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:57:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:57:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:57:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:57:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:57:16 INFO - (blobuploader) - INFO - Done attempting. 17:57:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:57:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:57:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:57:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:57:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:57:17 INFO - (blobuploader) - INFO - Done attempting. 17:57:17 INFO - (blobuploader) - INFO - Iteration through files over. 17:57:17 INFO - Return code: 0 17:57:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:57:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:57:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1dc1003b6903965e7bd2571ee3f949f90cb05c3fe5c019992a1c69eb661784e66f188b6668c554b1737c9d3d4242e40a6ccc8db612af7e3a8e0a0fefd5279879", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dc13be77dc3ece0f0d36dceec7341607abbc698a5c72ac178a961d5ba68cadfecd1a5dc9ba2262bae34d10986def9a0b3dd60fae1408c26d4d95445ba11061b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb526b9ee0e04cfab8acd8517e8858cc3e11e25062a182cf9c884b94fa69fc44c4b75405b2577b84f0858225e57d2b4d78b3b3639ade6235d60cd0296fe41c5f"} 17:57:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:57:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:57:17 INFO - Contents: 17:57:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1dc1003b6903965e7bd2571ee3f949f90cb05c3fe5c019992a1c69eb661784e66f188b6668c554b1737c9d3d4242e40a6ccc8db612af7e3a8e0a0fefd5279879", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dc13be77dc3ece0f0d36dceec7341607abbc698a5c72ac178a961d5ba68cadfecd1a5dc9ba2262bae34d10986def9a0b3dd60fae1408c26d4d95445ba11061b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb526b9ee0e04cfab8acd8517e8858cc3e11e25062a182cf9c884b94fa69fc44c4b75405b2577b84f0858225e57d2b4d78b3b3639ade6235d60cd0296fe41c5f"} 17:57:17 INFO - Running post-run listener: copy_logs_to_upload_dir 17:57:17 INFO - Copying logs to upload dir... 17:57:17 INFO - mkdir: /builds/slave/test/build/upload/logs 17:57:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.634053 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-08-11 17:57:17.767389) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 17:57:17.770883) ========= 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=41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1dc1003b6903965e7bd2571ee3f949f90cb05c3fe5c019992a1c69eb661784e66f188b6668c554b1737c9d3d4242e40a6ccc8db612af7e3a8e0a0fefd5279879", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dc13be77dc3ece0f0d36dceec7341607abbc698a5c72ac178a961d5ba68cadfecd1a5dc9ba2262bae34d10986def9a0b3dd60fae1408c26d4d95445ba11061b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb526b9ee0e04cfab8acd8517e8858cc3e11e25062a182cf9c884b94fa69fc44c4b75405b2577b84f0858225e57d2b4d78b3b3639ade6235d60cd0296fe41c5f"} build_url:https://queue.taskcluster.net/v1/task/FgDZDRA5Tme9Aie72bfScQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011372 build_url: 'https://queue.taskcluster.net/v1/task/FgDZDRA5Tme9Aie72bfScQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1dc1003b6903965e7bd2571ee3f949f90cb05c3fe5c019992a1c69eb661784e66f188b6668c554b1737c9d3d4242e40a6ccc8db612af7e3a8e0a0fefd5279879", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dc13be77dc3ece0f0d36dceec7341607abbc698a5c72ac178a961d5ba68cadfecd1a5dc9ba2262bae34d10986def9a0b3dd60fae1408c26d4d95445ba11061b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb526b9ee0e04cfab8acd8517e8858cc3e11e25062a182cf9c884b94fa69fc44c4b75405b2577b84f0858225e57d2b4d78b3b3639ade6235d60cd0296fe41c5f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 17:57:17.802909) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 17:57:17.803521) ========= 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=41a7e32711b8e08598a63237000001d6-1470962205.864965-127262220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 17:57:17.887826) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 17:57:17.888368) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 17:57:17.888887) ========= ========= Total master_lag: 0.19 =========