builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-006 starttime: 1472746765.84 results: success (0) buildid: 20160901082420 builduid: 53aefe31f9da4aeabfa0f638a9600bb6 revision: 9d715b38e5f094c63df4fa560fd00b6ff6852f9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 09:19:25.836890) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 09:19:25.837433) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 09:19:25.837723) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 09:19:25.852720) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:19:25.853078) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-01 09:19:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-09-01 09:19:26 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142743 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:19:26.010615) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:19:26.010924) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018707 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:19:26.061053) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:19:26.061399) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9d715b38e5f094c63df4fa560fd00b6ff6852f9b --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 9d715b38e5f094c63df4fa560fd00b6ff6852f9b --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=e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-01 09:19:26,425 truncating revision to first 12 chars 2016-09-01 09:19:26,426 Setting DEBUG logging. 2016-09-01 09:19:26,426 attempt 1/10 2016-09-01 09:19:26,426 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9d715b38e5f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 09:19:26,748 unpacking tar archive at: fx-team-9d715b38e5f0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646006 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:19:26.722898) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 09:19:26.723285) ========= script_repo_revision: 9d715b38e5f094c63df4fa560fd00b6ff6852f9b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 09:19:26.723756) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 09:19:26.724128) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 09:19:26.735634) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-09-01 09:19:26.736034) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:19:27 INFO - MultiFileLogger online at 20160901 09:19:27 in /builds/slave/test 09:19:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:19:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:19:27 INFO - {'append_to_log': False, 09:19:27 INFO - 'base_work_dir': '/builds/slave/test', 09:19:27 INFO - 'blob_upload_branch': 'Fx-Team', 09:19:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:19:27 INFO - 'branch': 'Fx-Team', 09:19:27 INFO - 'buildbot_json_path': 'buildprops.json', 09:19:27 INFO - 'config_files': ('talos/linux_config.py',), 09:19:27 INFO - 'default_actions': ('clobber', 09:19:27 INFO - 'read-buildbot-config', 09:19:27 INFO - 'download-and-extract', 09:19:27 INFO - 'populate-webroot', 09:19:27 INFO - 'create-virtualenv', 09:19:27 INFO - 'install', 09:19:27 INFO - 'run-tests'), 09:19:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:19:27 INFO - 'download_minidump_stackwalk': True, 09:19:27 INFO - 'download_symbols': 'ondemand', 09:19:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:19:27 INFO - 'tooltool.py': '/tools/tooltool.py', 09:19:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:19:27 INFO - '/tools/misc-python/virtualenv.py')}, 09:19:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:19:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:19:27 INFO - 'installer_path': 'installer.exe', 09:19:27 INFO - 'log_level': 'info', 09:19:27 INFO - 'log_name': 'talos', 09:19:27 INFO - 'log_to_console': True, 09:19:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:19:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:19:27 INFO - 'opt_config_files': (), 09:19:27 INFO - 'pip_index': False, 09:19:27 INFO - 'sps_profile': False, 09:19:27 INFO - 'sps_profile_interval': 0, 09:19:27 INFO - 'suite': 'dromaeojs', 09:19:27 INFO - 'system_bits': '32', 09:19:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:19:27 INFO - 'title': 'talos-linux64-ix-006', 09:19:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:19:27 INFO - 'use_talos_json': True, 09:19:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:19:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:19:27 INFO - 'work_dir': 'build'} 09:19:27 INFO - [mozharness: 2016-09-01 16:19:27.195216Z] Running clobber step. 09:19:27 INFO - Running pre-action listener: _resource_record_pre_action 09:19:27 INFO - Running main action method: clobber 09:19:27 INFO - rmtree: /builds/slave/test/build 09:19:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:19:27 INFO - Running post-action listener: _resource_record_post_action 09:19:27 INFO - [mozharness: 2016-09-01 16:19:27.691376Z] Finished clobber step (success) 09:19:27 INFO - [mozharness: 2016-09-01 16:19:27.691479Z] Running read-buildbot-config step. 09:19:27 INFO - Running pre-action listener: _resource_record_pre_action 09:19:27 INFO - Running main action method: read_buildbot_config 09:19:27 INFO - Using buildbot properties: 09:19:27 INFO - { 09:19:27 INFO - "project": "", 09:19:27 INFO - "product": "firefox", 09:19:27 INFO - "script_repo_revision": "production", 09:19:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:19:27 INFO - "repository": "", 09:19:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 09:19:27 INFO - "buildid": "20160901082420", 09:19:27 INFO - "stage_platform": "linux64-pgo", 09:19:27 INFO - "basedir": "/builds/slave/test", 09:19:27 INFO - "buildnumber": 1024, 09:19:27 INFO - "platform": "ubuntu64_hw", 09:19:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:19:27 INFO - "slavebuilddir": "test", 09:19:27 INFO - "branch": "fx-team", 09:19:27 INFO - "revision": "9d715b38e5f094c63df4fa560fd00b6ff6852f9b", 09:19:27 INFO - "slavename": "talos-linux64-ix-006", 09:19:27 INFO - "builduid": "53aefe31f9da4aeabfa0f638a9600bb6", 09:19:27 INFO - "repo_path": "integration/fx-team" 09:19:27 INFO - } 09:19:27 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 09:19:27 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/firefox-51.0a1.en-US.linux-x86_64.test_packages.json. 09:19:27 INFO - Running post-action listener: _resource_record_post_action 09:19:27 INFO - [mozharness: 2016-09-01 16:19:27.693864Z] Finished read-buildbot-config step (success) 09:19:27 INFO - [mozharness: 2016-09-01 16:19:27.693953Z] Running download-and-extract step. 09:19:27 INFO - Running pre-action listener: _resource_record_pre_action 09:19:27 INFO - Running main action method: download_and_extract 09:19:27 INFO - mkdir: /builds/slave/test/build/tests 09:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:27 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:19:27 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/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 09:19:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/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 09:19:27 INFO - Downloaded 1361 bytes. 09:19:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:19:27 INFO - Using the following test package requirements: 09:19:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:19:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:19:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:19:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:27 INFO - u'jsshell-linux-x86_64.zip'], 09:19:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:19:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:19:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:19:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:19:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:19:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:19:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:27 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:19:27 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/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 09:19:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/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 09:19:28 INFO - Downloaded 21905498 bytes. 09:19:28 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 09:19:32 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 09:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:32 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:19:32 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/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 09:19:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/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 09:19:32 INFO - Downloaded 21905498 bytes. 09:19:32 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 09:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:37 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 09:19:37 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/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 09:19:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/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 09:19:37 INFO - Downloaded 14413998 bytes. 09:19:37 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 09:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:37 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:19:37 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/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 09:19:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/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 09:19:38 INFO - Downloaded 59733953 bytes. 09:19:38 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:19:38 INFO - mkdir: /builds/slave/test/properties 09:19:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:19:38 INFO - Writing to file /builds/slave/test/properties/build_url 09:19:38 INFO - Contents: 09:19:38 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:19:38 INFO - Running post-action listener: _resource_record_post_action 09:19:38 INFO - Running post-action listener: set_extra_try_arguments 09:19:38 INFO - [mozharness: 2016-09-01 16:19:38.698865Z] Finished download-and-extract step (success) 09:19:38 INFO - [mozharness: 2016-09-01 16:19:38.699094Z] Running populate-webroot step. 09:19:38 INFO - Running pre-action listener: _resource_record_pre_action 09:19:38 INFO - Running main action method: populate_webroot 09:19:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:19:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:19:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:19:38 INFO - '--tppagecycles', 09:19:38 INFO - '7'], 09:19:38 INFO - 'tests': ['tsvgm']}}, 09:19:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:19:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:19:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:19:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:19:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:19:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:19:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:38 INFO - 'talos_options': ['--disable-e10s'], 09:19:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:38 INFO - 'talos_options': ['--disable-e10s'], 09:19:38 INFO - 'tests': ['damp', 'tps']}, 09:19:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:38 INFO - 'tests': ['damp', 'tps']}, 09:19:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:19:38 INFO - 'tests': ['dromaeo_dom']}, 09:19:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:19:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:19:38 INFO - 'tests': ['basic_compositor_video']}, 09:19:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:19:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:19:38 INFO - 'tests': ['a11yr', 09:19:38 INFO - 'ts_paint', 09:19:38 INFO - 'tpaint', 09:19:38 INFO - 'sessionrestore', 09:19:38 INFO - 'sessionrestore_no_auto_restore', 09:19:38 INFO - 'tabpaint']}, 09:19:38 INFO - 'other-e10s': {'tests': ['a11yr', 09:19:38 INFO - 'ts_paint', 09:19:38 INFO - 'tpaint', 09:19:38 INFO - 'sessionrestore', 09:19:38 INFO - 'sessionrestore_no_auto_restore', 09:19:38 INFO - 'tabpaint']}, 09:19:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:19:38 INFO - 'ts_paint', 09:19:38 INFO - 'tpaint', 09:19:38 INFO - 'sessionrestore', 09:19:38 INFO - 'sessionrestore_no_auto_restore', 09:19:38 INFO - 'tabpaint']}, 09:19:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:19:38 INFO - 'ts_paint', 09:19:38 INFO - 'tpaint', 09:19:38 INFO - 'sessionrestore', 09:19:38 INFO - 'sessionrestore_no_auto_restore', 09:19:38 INFO - 'tabpaint']}, 09:19:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:19:38 INFO - 'tests': ['a11yr', 09:19:38 INFO - 'ts_paint', 09:19:38 INFO - 'tpaint', 09:19:38 INFO - 'sessionrestore', 09:19:38 INFO - 'sessionrestore_no_auto_restore', 09:19:38 INFO - 'tabpaint']}, 09:19:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:19:38 INFO - 'tests': ['a11yr', 09:19:38 INFO - 'ts_paint', 09:19:38 INFO - 'tpaint', 09:19:38 INFO - 'sessionrestore', 09:19:38 INFO - 'sessionrestore_no_auto_restore', 09:19:38 INFO - 'tabpaint']}, 09:19:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:19:38 INFO - 'tests': ['tsvgx', 09:19:38 INFO - 'tsvgr_opacity', 09:19:38 INFO - 'tart', 09:19:38 INFO - 'tscrollx', 09:19:38 INFO - 'cart']}, 09:19:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:19:38 INFO - 'tsvgr_opacity', 09:19:38 INFO - 'tart', 09:19:38 INFO - 'tscrollx', 09:19:38 INFO - 'cart']}, 09:19:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:38 INFO - 'talos_options': ['--disable-e10s'], 09:19:38 INFO - 'tests': ['tp5o']}, 09:19:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:38 INFO - 'tests': ['tp5o']}, 09:19:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:38 INFO - 'talos_options': ['--disable-e10s', 09:19:38 INFO - '--xperf_path', 09:19:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:38 INFO - 'tests': ['tp5n']}, 09:19:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:38 INFO - 'talos_options': ['--xperf_path', 09:19:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:38 INFO - 'tests': ['tp5n']}}, 09:19:38 INFO - 'talos.zip': {'path': '', 09:19:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:19:38 INFO - Running post-action listener: _resource_record_post_action 09:19:38 INFO - [mozharness: 2016-09-01 16:19:38.721358Z] Finished populate-webroot step (success) 09:19:38 INFO - [mozharness: 2016-09-01 16:19:38.721450Z] Running create-virtualenv step. 09:19:38 INFO - Running pre-action listener: _resource_record_pre_action 09:19:38 INFO - Running main action method: create_virtualenv 09:19:38 INFO - Creating virtualenv /builds/slave/test/build/venv 09:19:38 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 09:19:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:19:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:19:38 INFO - Using real prefix '/usr' 09:19:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:19:39 INFO - Installing distribute.............................................................................................................................................................................................done. 09:19:41 INFO - Installing pip.................done. 09:19:41 INFO - Return code: 0 09:19:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:19:41 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')]} 09:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:41 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')]} 09:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:41 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 0x7ff5ebc4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16968d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1725760>, '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 0x1726660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1726af0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277', '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 09:19:41 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 09:19:41 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 09:19:41 INFO - Using env: {'DISPLAY': ':0', 09:19:41 INFO - 'HOME': '/home/cltbld', 09:19:41 INFO - 'LANG': 'en_US.UTF-8', 09:19:41 INFO - 'LANGUAGE': 'en_US:en', 09:19:41 INFO - 'LOGNAME': 'cltbld', 09:19:41 INFO - 'MAIL': '/var/mail/cltbld', 09:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:41 INFO - 'MOZ_NO_REMOTE': '1', 09:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:41 INFO - 'NO_EM_RESTART': '1', 09:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:41 INFO - 'PWD': '/builds/slave/test', 09:19:41 INFO - 'SHELL': '/bin/bash', 09:19:41 INFO - 'SHLVL': '1', 09:19:41 INFO - 'TERM': 'linux', 09:19:41 INFO - 'TMOUT': '86400', 09:19:41 INFO - 'USER': 'cltbld', 09:19:41 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277', 09:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:41 INFO - '_': '/tools/buildbot/bin/python'} 09:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:41 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 09:19:41 INFO - Cleaning up... 09:19:41 INFO - Return code: 0 09:19:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:19:41 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')]} 09:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:41 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')]} 09:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:41 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 0x7ff5ebc4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16968d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1725760>, '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 0x1726660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1726af0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277', '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 09:19:41 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 09:19:41 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 09:19:41 INFO - Using env: {'DISPLAY': ':0', 09:19:41 INFO - 'HOME': '/home/cltbld', 09:19:41 INFO - 'LANG': 'en_US.UTF-8', 09:19:41 INFO - 'LANGUAGE': 'en_US:en', 09:19:41 INFO - 'LOGNAME': 'cltbld', 09:19:41 INFO - 'MAIL': '/var/mail/cltbld', 09:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:41 INFO - 'MOZ_NO_REMOTE': '1', 09:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:41 INFO - 'NO_EM_RESTART': '1', 09:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:41 INFO - 'PWD': '/builds/slave/test', 09:19:41 INFO - 'SHELL': '/bin/bash', 09:19:41 INFO - 'SHLVL': '1', 09:19:41 INFO - 'TERM': 'linux', 09:19:41 INFO - 'TMOUT': '86400', 09:19:41 INFO - 'USER': 'cltbld', 09:19:41 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277', 09:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:41 INFO - '_': '/tools/buildbot/bin/python'} 09:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:41 INFO - Downloading/unpacking psutil>=3.1.1 09:19:41 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 09:19:41 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 09:19:41 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 09:19:41 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 09:19:41 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 09:19:41 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 09:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:19:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:43 INFO - Installing collected packages: psutil 09:19:43 INFO - Running setup.py install for psutil 09:19:43 INFO - building 'psutil._psutil_linux' extension 09:19:43 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 09:19:43 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 09:19:43 INFO - building 'psutil._psutil_posix' extension 09:19:43 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 09:19:44 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 09:19:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:44 INFO - Successfully installed psutil 09:19:44 INFO - Cleaning up... 09:19:44 INFO - Return code: 0 09:19:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:44 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 0x7ff5ebc4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16968d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1725760>, '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 0x1726660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1726af0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277', '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 09:19:44 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 09:19:44 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 09:19:44 INFO - Using env: {'DISPLAY': ':0', 09:19:44 INFO - 'HOME': '/home/cltbld', 09:19:44 INFO - 'LANG': 'en_US.UTF-8', 09:19:44 INFO - 'LANGUAGE': 'en_US:en', 09:19:44 INFO - 'LOGNAME': 'cltbld', 09:19:44 INFO - 'MAIL': '/var/mail/cltbld', 09:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:44 INFO - 'MOZ_NO_REMOTE': '1', 09:19:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:44 INFO - 'NO_EM_RESTART': '1', 09:19:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:44 INFO - 'PWD': '/builds/slave/test', 09:19:44 INFO - 'SHELL': '/bin/bash', 09:19:44 INFO - 'SHLVL': '1', 09:19:44 INFO - 'TERM': 'linux', 09:19:44 INFO - 'TMOUT': '86400', 09:19:44 INFO - 'USER': 'cltbld', 09:19:44 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277', 09:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:44 INFO - '_': '/tools/buildbot/bin/python'} 09:19:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:19:44 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 09:19:44 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 09:19:44 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 09:19:44 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 09:19:44 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 09:19:44 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 09:19:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:19:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:19:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:19:46 INFO - Installing collected packages: mozsystemmonitor 09:19:46 INFO - Running setup.py install for mozsystemmonitor 09:19:46 INFO - Successfully installed mozsystemmonitor 09:19:46 INFO - Cleaning up... 09:19:46 INFO - Return code: 0 09:19:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:19:46 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')]} 09:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:46 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')]} 09:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:46 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 0x7ff5ebc4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16968d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1725760>, '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 0x1726660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1726af0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277', '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 09:19:46 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 09:19:46 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 09:19:46 INFO - Using env: {'DISPLAY': ':0', 09:19:46 INFO - 'HOME': '/home/cltbld', 09:19:46 INFO - 'LANG': 'en_US.UTF-8', 09:19:46 INFO - 'LANGUAGE': 'en_US:en', 09:19:46 INFO - 'LOGNAME': 'cltbld', 09:19:46 INFO - 'MAIL': '/var/mail/cltbld', 09:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:46 INFO - 'MOZ_NO_REMOTE': '1', 09:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:46 INFO - 'NO_EM_RESTART': '1', 09:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:46 INFO - 'PWD': '/builds/slave/test', 09:19:46 INFO - 'SHELL': '/bin/bash', 09:19:46 INFO - 'SHLVL': '1', 09:19:46 INFO - 'TERM': 'linux', 09:19:46 INFO - 'TMOUT': '86400', 09:19:46 INFO - 'USER': 'cltbld', 09:19:46 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277', 09:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:46 INFO - '_': '/tools/buildbot/bin/python'} 09:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:46 INFO - Downloading/unpacking jsonschema==2.5.1 09:19:46 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 09:19:46 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 09:19:46 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 09:19:46 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 09:19:46 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 09:19:46 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 09:19:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:19:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:19:48 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 09:19:48 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 09:19:48 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 09:19:48 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 09:19:48 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 09:19:48 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 09:19:49 INFO - Downloading functools32-3.2.3-2.tar.gz 09:19:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:19:49 INFO - warning: no files found matching '*.txt' 09:19:49 INFO - no previously-included directories found matching 'build' 09:19:49 INFO - no previously-included directories found matching 'dist' 09:19:49 INFO - no previously-included directories found matching '.git*' 09:19:49 INFO - Installing collected packages: jsonschema, functools32 09:19:49 INFO - Running setup.py install for functools32 09:19:49 INFO - warning: no files found matching '*.txt' 09:19:49 INFO - no previously-included directories found matching 'build' 09:19:49 INFO - no previously-included directories found matching 'dist' 09:19:49 INFO - no previously-included directories found matching '.git*' 09:19:49 INFO - Successfully installed jsonschema functools32 09:19:49 INFO - Cleaning up... 09:19:49 INFO - Return code: 0 09:19:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:19: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')]} 09:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19: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')]} 09:19:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:49 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 0x7ff5ebc4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16968d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1725760>, '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 0x1726660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1726af0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277', '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 09:19:49 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 09:19:49 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 09:19:49 INFO - Using env: {'DISPLAY': ':0', 09:19:49 INFO - 'HOME': '/home/cltbld', 09:19:49 INFO - 'LANG': 'en_US.UTF-8', 09:19:49 INFO - 'LANGUAGE': 'en_US:en', 09:19:49 INFO - 'LOGNAME': 'cltbld', 09:19:49 INFO - 'MAIL': '/var/mail/cltbld', 09:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:49 INFO - 'MOZ_NO_REMOTE': '1', 09:19:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:49 INFO - 'NO_EM_RESTART': '1', 09:19:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:49 INFO - 'PWD': '/builds/slave/test', 09:19:49 INFO - 'SHELL': '/bin/bash', 09:19:49 INFO - 'SHLVL': '1', 09:19:49 INFO - 'TERM': 'linux', 09:19:49 INFO - 'TMOUT': '86400', 09:19:49 INFO - 'USER': 'cltbld', 09:19:49 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277', 09:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:49 INFO - '_': '/tools/buildbot/bin/python'} 09:19:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:19:49 INFO - Cleaning up... 09:19:49 INFO - Return code: 0 09:19:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:19: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')]} 09:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19: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')]} 09:19:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:49 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 0x7ff5ebc4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16968d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1725760>, '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 0x1726660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1726af0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277', '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 09:19:49 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 09:19:49 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 09:19:49 INFO - Using env: {'DISPLAY': ':0', 09:19:49 INFO - 'HOME': '/home/cltbld', 09:19:49 INFO - 'LANG': 'en_US.UTF-8', 09:19:49 INFO - 'LANGUAGE': 'en_US:en', 09:19:49 INFO - 'LOGNAME': 'cltbld', 09:19:49 INFO - 'MAIL': '/var/mail/cltbld', 09:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:49 INFO - 'MOZ_NO_REMOTE': '1', 09:19:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:49 INFO - 'NO_EM_RESTART': '1', 09:19:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:49 INFO - 'PWD': '/builds/slave/test', 09:19:49 INFO - 'SHELL': '/bin/bash', 09:19:49 INFO - 'SHLVL': '1', 09:19:49 INFO - 'TERM': 'linux', 09:19:49 INFO - 'TMOUT': '86400', 09:19:49 INFO - 'USER': 'cltbld', 09:19:49 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277', 09:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:49 INFO - '_': '/tools/buildbot/bin/python'} 09:19:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:49 INFO - Downloading/unpacking blobuploader==1.2.4 09:19:49 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 09:19:49 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 09:19:49 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 09:19:49 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 09:19:49 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 09:19:49 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 09:19:51 INFO - Downloading blobuploader-1.2.4.tar.gz 09:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:19:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:19:51 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 09:19:51 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 09:19:51 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 09:19:51 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 09:19:51 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 09:19:51 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 09:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:19:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:19:52 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 09:19:52 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 09:19:52 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 09:19:52 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 09:19:52 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 09:19:52 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 09:19:52 INFO - Downloading docopt-0.6.1.tar.gz 09:19:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:19:52 INFO - Installing collected packages: blobuploader, requests, docopt 09:19:52 INFO - Running setup.py install for blobuploader 09:19:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:19:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:19:52 INFO - Running setup.py install for requests 09:19:52 INFO - Running setup.py install for docopt 09:19:52 INFO - Successfully installed blobuploader requests docopt 09:19:52 INFO - Cleaning up... 09:19:52 INFO - Return code: 0 09:19:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:52 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')]} 09:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:52 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')]} 09:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:52 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 0x7ff5ebc4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16968d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1725760>, '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 0x1726660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1726af0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277', '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 09:19:52 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 09:19:52 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 09:19:52 INFO - Using env: {'DISPLAY': ':0', 09:19:52 INFO - 'HOME': '/home/cltbld', 09:19:52 INFO - 'LANG': 'en_US.UTF-8', 09:19:52 INFO - 'LANGUAGE': 'en_US:en', 09:19:52 INFO - 'LOGNAME': 'cltbld', 09:19:52 INFO - 'MAIL': '/var/mail/cltbld', 09:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:52 INFO - 'MOZ_NO_REMOTE': '1', 09:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:52 INFO - 'NO_EM_RESTART': '1', 09:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:52 INFO - 'PWD': '/builds/slave/test', 09:19:52 INFO - 'SHELL': '/bin/bash', 09:19:52 INFO - 'SHLVL': '1', 09:19:52 INFO - 'TERM': 'linux', 09:19:52 INFO - 'TMOUT': '86400', 09:19:52 INFO - 'USER': 'cltbld', 09:19:52 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277', 09:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:52 INFO - '_': '/tools/buildbot/bin/python'} 09:19:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:53 INFO - Running setup.py (path:/tmp/pip-6XiOHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:53 INFO - Running setup.py (path:/tmp/pip-3LtI8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:53 INFO - Running setup.py (path:/tmp/pip-dUtDxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:53 INFO - Running setup.py (path:/tmp/pip-DiCc9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:53 INFO - Running setup.py (path:/tmp/pip-DnP1Cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:53 INFO - Running setup.py (path:/tmp/pip-pCmb8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:53 INFO - Running setup.py (path:/tmp/pip-Vy_A9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:53 INFO - Running setup.py (path:/tmp/pip-hsYOlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:53 INFO - Running setup.py (path:/tmp/pip-Z5vRo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:53 INFO - Running setup.py (path:/tmp/pip-IFnzdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:53 INFO - Running setup.py (path:/tmp/pip-UwIL5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:53 INFO - Running setup.py (path:/tmp/pip-MWOahu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:54 INFO - Running setup.py (path:/tmp/pip-Fwd3e4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:54 INFO - Running setup.py (path:/tmp/pip-HsmH_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:54 INFO - Running setup.py (path:/tmp/pip-2ekU6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:54 INFO - Running setup.py (path:/tmp/pip-ODId_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:54 INFO - Running setup.py (path:/tmp/pip-gWVeT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:19:54 INFO - Running setup.py install for manifestparser 09:19:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:19:54 INFO - Running setup.py install for mozcrash 09:19:54 INFO - Running setup.py install for mozdebug 09:19:54 INFO - Running setup.py install for mozdevice 09:19:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:19:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:19:54 INFO - Running setup.py install for mozfile 09:19:54 INFO - Running setup.py install for mozhttpd 09:19:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:19:55 INFO - Running setup.py install for mozinfo 09:19:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:19:55 INFO - Running setup.py install for mozInstall 09:19:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:19:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:19:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:19:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:19:55 INFO - Running setup.py install for mozleak 09:19:55 INFO - Running setup.py install for mozlog 09:19:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:19:55 INFO - Running setup.py install for moznetwork 09:19:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:19:55 INFO - Running setup.py install for mozprocess 09:19:55 INFO - Running setup.py install for mozprofile 09:19:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:19:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:19:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:19:55 INFO - Running setup.py install for mozrunner 09:19:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:19:55 INFO - Running setup.py install for mozscreenshot 09:19:55 INFO - Running setup.py install for moztest 09:19:56 INFO - Running setup.py install for mozversion 09:19:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:19:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:19:56 INFO - Cleaning up... 09:19:56 INFO - Return code: 0 09:19:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:56 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 0x7ff5ebc4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16968d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1725760>, '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 0x1726660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1726af0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277', '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 09:19:56 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 09:19:56 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 09:19:56 INFO - Using env: {'DISPLAY': ':0', 09:19:56 INFO - 'HOME': '/home/cltbld', 09:19:56 INFO - 'LANG': 'en_US.UTF-8', 09:19:56 INFO - 'LANGUAGE': 'en_US:en', 09:19:56 INFO - 'LOGNAME': 'cltbld', 09:19:56 INFO - 'MAIL': '/var/mail/cltbld', 09:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:56 INFO - 'MOZ_NO_REMOTE': '1', 09:19:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:56 INFO - 'NO_EM_RESTART': '1', 09:19:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:56 INFO - 'PWD': '/builds/slave/test', 09:19:56 INFO - 'SHELL': '/bin/bash', 09:19:56 INFO - 'SHLVL': '1', 09:19:56 INFO - 'TERM': 'linux', 09:19:56 INFO - 'TMOUT': '86400', 09:19:56 INFO - 'USER': 'cltbld', 09:19:56 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277', 09:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:56 INFO - '_': '/tools/buildbot/bin/python'} 09:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:56 INFO - Running setup.py (path:/tmp/pip-e65wjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:56 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)) 09:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:56 INFO - Running setup.py (path:/tmp/pip-kWM7gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:56 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)) 09:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:56 INFO - Running setup.py (path:/tmp/pip-grp6av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:56 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)) 09:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:56 INFO - Running setup.py (path:/tmp/pip-_R4Hv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:56 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)) 09:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:56 INFO - Running setup.py (path:/tmp/pip-ZDoSTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:56 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)) 09:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:56 INFO - Running setup.py (path:/tmp/pip-oVI4jX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:56 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)) 09:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:56 INFO - Running setup.py (path:/tmp/pip-Aw6J4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:56 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)) 09:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:56 INFO - Running setup.py (path:/tmp/pip-awRZmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:57 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)) 09:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:57 INFO - Running setup.py (path:/tmp/pip-vnZDsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:57 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)) 09:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:57 INFO - Running setup.py (path:/tmp/pip-c75n5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:57 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)) 09:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:57 INFO - Running setup.py (path:/tmp/pip-2GHbwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:57 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)) 09:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:57 INFO - Running setup.py (path:/tmp/pip-Ujdxcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:57 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)) 09:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:57 INFO - Running setup.py (path:/tmp/pip-PHIcui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:57 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)) 09:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:57 INFO - Running setup.py (path:/tmp/pip-2BMEb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:57 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)) 09:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:57 INFO - Running setup.py (path:/tmp/pip-uV4Z9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:57 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)) 09:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:57 INFO - Running setup.py (path:/tmp/pip-k7Qw1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:57 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)) 09:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:57 INFO - Running setup.py (path:/tmp/pip-gVhLYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:57 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)) 09:19:57 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)) 09:19:57 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)) 09:19:57 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)) 09:19:57 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)) 09:19:57 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)) 09:19:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:19:57 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 09:19:57 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 09:19:57 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 09:19:57 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 09:19:57 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 09:19:57 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 09:19:59 INFO - Downloading blessings-1.6.tar.gz 09:19:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:19:59 INFO - Installing collected packages: blessings 09:19:59 INFO - Running setup.py install for blessings 09:19:59 INFO - Successfully installed blessings 09:19:59 INFO - Cleaning up... 09:19:59 INFO - Return code: 0 09:19:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:19:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:20:00 INFO - Reading from file tmpfile_stdout 09:20:00 INFO - Current package versions: 09:20:00 INFO - argparse == 1.2.1 09:20:00 INFO - blessings == 1.6 09:20:00 INFO - blobuploader == 1.2.4 09:20:00 INFO - docopt == 0.6.1 09:20:00 INFO - functools32 == 3.2.3-2 09:20:00 INFO - jsonschema == 2.5.1 09:20:00 INFO - manifestparser == 1.1 09:20:00 INFO - mozInstall == 1.12 09:20:00 INFO - mozcrash == 0.17 09:20:00 INFO - mozdebug == 0.1 09:20:00 INFO - mozdevice == 0.48 09:20:00 INFO - mozfile == 1.2 09:20:00 INFO - mozhttpd == 0.7 09:20:00 INFO - mozinfo == 0.9 09:20:00 INFO - mozleak == 0.1 09:20:00 INFO - mozlog == 3.3 09:20:00 INFO - moznetwork == 0.27 09:20:00 INFO - mozprocess == 0.23 09:20:00 INFO - mozprofile == 0.28 09:20:00 INFO - mozrunner == 6.12 09:20:00 INFO - mozscreenshot == 0.1 09:20:00 INFO - mozsystemmonitor == 0.3 09:20:00 INFO - moztest == 0.7 09:20:00 INFO - mozversion == 1.4 09:20:00 INFO - psutil == 3.1.1 09:20:00 INFO - requests == 1.2.3 09:20:00 INFO - wsgiref == 0.1.2 09:20:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:00 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 0x7ff5ebc4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16968d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1725760>, '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 0x1726660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1726af0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277', '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 09:20:00 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 09:20:00 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 09:20:00 INFO - Using env: {'DISPLAY': ':0', 09:20:00 INFO - 'HOME': '/home/cltbld', 09:20:00 INFO - 'LANG': 'en_US.UTF-8', 09:20:00 INFO - 'LANGUAGE': 'en_US:en', 09:20:00 INFO - 'LOGNAME': 'cltbld', 09:20:00 INFO - 'MAIL': '/var/mail/cltbld', 09:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:00 INFO - 'MOZ_NO_REMOTE': '1', 09:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:00 INFO - 'NO_EM_RESTART': '1', 09:20:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:00 INFO - 'PWD': '/builds/slave/test', 09:20:00 INFO - 'SHELL': '/bin/bash', 09:20:00 INFO - 'SHLVL': '1', 09:20:00 INFO - 'TERM': 'linux', 09:20:00 INFO - 'TMOUT': '86400', 09:20:00 INFO - 'USER': 'cltbld', 09:20:00 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277', 09:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:00 INFO - '_': '/tools/buildbot/bin/python'} 09:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:00 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)) 09:20:00 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)) 09:20:00 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)) 09:20:00 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)) 09:20:00 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)) 09:20:00 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)) 09:20:00 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)) 09:20:00 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)) 09:20:00 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)) 09:20:00 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)) 09:20:00 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)) 09:20:00 INFO - Cleaning up... 09:20:00 INFO - Return code: 0 09:20:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:00 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 0x7ff5ebc4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16968d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1725760>, '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 0x1726660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1726af0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277', '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 09:20:00 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 09:20:00 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 09:20:00 INFO - Using env: {'DISPLAY': ':0', 09:20:00 INFO - 'HOME': '/home/cltbld', 09:20:00 INFO - 'LANG': 'en_US.UTF-8', 09:20:00 INFO - 'LANGUAGE': 'en_US:en', 09:20:00 INFO - 'LOGNAME': 'cltbld', 09:20:00 INFO - 'MAIL': '/var/mail/cltbld', 09:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:00 INFO - 'MOZ_NO_REMOTE': '1', 09:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:00 INFO - 'NO_EM_RESTART': '1', 09:20:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:00 INFO - 'PWD': '/builds/slave/test', 09:20:00 INFO - 'SHELL': '/bin/bash', 09:20:00 INFO - 'SHLVL': '1', 09:20:00 INFO - 'TERM': 'linux', 09:20:00 INFO - 'TMOUT': '86400', 09:20:00 INFO - 'USER': 'cltbld', 09:20:00 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277', 09:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:00 INFO - '_': '/tools/buildbot/bin/python'} 09:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:20:00 INFO - Cleaning up... 09:20:00 INFO - Return code: 0 09:20:00 INFO - Running post-action listener: _resource_record_post_action 09:20:00 INFO - Running post-action listener: _start_resource_monitoring 09:20:00 INFO - Starting resource monitoring. 09:20:00 INFO - [mozharness: 2016-09-01 16:20:00.488424Z] Finished create-virtualenv step (success) 09:20:00 INFO - [mozharness: 2016-09-01 16:20:00.488935Z] Running install step. 09:20:00 INFO - Running pre-action listener: _resource_record_pre_action 09:20:00 INFO - Running main action method: install 09:20:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:20:00 INFO - Reading from file tmpfile_stdout 09:20:00 INFO - Detecting whether we're running mozinstall >=1.0... 09:20:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:20:00 INFO - Reading from file tmpfile_stdout 09:20:00 INFO - Output received: 09:20:00 INFO - Usage: mozinstall [options] installer 09:20:00 INFO - Options: 09:20:00 INFO - -h, --help show this help message and exit 09:20:00 INFO - -d DEST, --destination=DEST 09:20:00 INFO - Directory to install application into. [default: 09:20:00 INFO - "/builds/slave/test"] 09:20:00 INFO - --app=APP Application being installed. [default: firefox] 09:20:00 INFO - mkdir: /builds/slave/test/build/application 09:20:00 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'] 09:20:00 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 09:20:17 INFO - Reading from file tmpfile_stdout 09:20:17 INFO - Output received: 09:20:17 INFO - /builds/slave/test/build/application/firefox/firefox 09:20:17 INFO - Running post-action listener: _resource_record_post_action 09:20:17 INFO - [mozharness: 2016-09-01 16:20:17.786653Z] Finished install step (success) 09:20:17 INFO - [mozharness: 2016-09-01 16:20:17.786909Z] Running run-tests step. 09:20:17 INFO - Running pre-action listener: _resource_record_pre_action 09:20:17 INFO - Running main action method: run_tests 09:20:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:20:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:20:17 INFO - Python 2.7.3 09:20:17 INFO - Return code: 0 09:20:17 INFO - grabbing minidump binary from tooltool 09:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:17 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 0x1725760>, '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 0x1726660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1726af0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:20:17 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 09:20:17 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 09:20:17 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 09:20:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:20:17 INFO - Return code: 0 09:20:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:20:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:20:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:20:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:20:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:20:17 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:20:17 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:20:17 INFO - Using env: {'DISPLAY': ':0', 09:20:17 INFO - 'HOME': '/home/cltbld', 09:20:17 INFO - 'LANG': 'en_US.UTF-8', 09:20:17 INFO - 'LANGUAGE': 'en_US:en', 09:20:17 INFO - 'LOGNAME': 'cltbld', 09:20:17 INFO - 'MAIL': '/var/mail/cltbld', 09:20:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:20:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:20:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:17 INFO - 'MOZ_NO_REMOTE': '1', 09:20:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:20:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:17 INFO - 'NO_EM_RESTART': '1', 09:20:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:17 INFO - 'PWD': '/builds/slave/test', 09:20:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:20:17 INFO - 'SHELL': '/bin/bash', 09:20:17 INFO - 'SHLVL': '1', 09:20:17 INFO - 'TERM': 'linux', 09:20:17 INFO - 'TMOUT': '86400', 09:20:17 INFO - 'USER': 'cltbld', 09:20:17 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277', 09:20:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:17 INFO - '_': '/tools/buildbot/bin/python'} 09:20:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:20:18 INFO - mozversion application_buildid: 20160901053002 09:20:18 INFO - mozversion application_changeset: 9d715b38e5f094c63df4fa560fd00b6ff6852f9b 09:20:18 INFO - mozversion application_display_name: Nightly 09:20:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:20:18 INFO - mozversion application_name: Firefox 09:20:18 INFO - mozversion application_remotingname: firefox 09:20:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:20:18 INFO - mozversion application_vendor: Mozilla 09:20:18 INFO - mozversion application_version: 51.0a1 09:20:18 INFO - mozversion platform_buildid: 20160901053002 09:20:18 INFO - mozversion platform_changeset: 9d715b38e5f094c63df4fa560fd00b6ff6852f9b 09:20:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:20:18 INFO - mozversion platform_version: 51.0a1 09:20:18 INFO - using testdate: 1472746818 09:20:18 INFO - actual date: 1472746818 09:20:18 INFO - starting webserver on 'localhost:46458' 09:20:18 INFO - SUITE-START | Running 2 tests 09:20:18 INFO - TEST-START | dromaeo_css 09:20:18 INFO - operating with platform_type : linux_ 09:20:18 INFO - Initialising browser for dromaeo_css test... 09:20:18 INFO - TEST-INFO | started process 14960 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkThS9v/profile http://localhost:46458/getInfo.html) 09:20:22 INFO - PROCESS | 14960 | __metrics Screen width/height:1600/1200 09:20:22 INFO - PROCESS | 14960 | colorDepth:24 09:20:22 INFO - PROCESS | 14960 | Browser inner width/height: 1024/697 09:20:22 INFO - PROCESS | 14960 | __metrics 09:20:22 INFO - PROCESS | 14960 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:20:22 INFO - PROCESS | 14960 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:20:23 INFO - PROCESS | 14960 | console.error: PushService: 09:20:23 INFO - PROCESS | 14960 | stateChangeProcessEnqueue: Error transitioning state 09:20:23 INFO - PROCESS | 14960 | UnknownError 09:20:24 INFO - TEST-INFO | 14960: exit 0 09:20:24 INFO - Browser initialized. 09:20:24 INFO - Running cycle 1/1 for dromaeo_css test... 09:20:24 INFO - TEST-INFO | started process 15041 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkThS9v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:20:36 INFO - PROCESS | 15041 | RSS: Main: 180559872 09:20:36 INFO - PROCESS | 15041 | 09:21:27 INFO - PROCESS | 15041 | 1472746887836 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] 09:23:37 INFO - PROCESS | 15041 | Cycle 1(1): loaded http://localhost:46458/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46458/tests/dromaeo/cssquery-ext.html) 09:23:38 INFO - PROCESS | 15041 | RSS: Main: 317276160 09:23:38 INFO - PROCESS | 15041 | 09:26:41 INFO - PROCESS | 15041 | Cycle 1(1): loaded http://localhost:46458/tests/dromaeo/cssquery-ext.html (next: http://localhost:46458/tests/dromaeo/cssquery-jquery.html) 09:26:41 INFO - PROCESS | 15041 | RSS: Main: 272560128 09:26:41 INFO - PROCESS | 15041 | 09:29:43 INFO - PROCESS | 15041 | Cycle 1(1): loaded http://localhost:46458/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46458/tests/dromaeo/cssquery-mootools.html) 09:29:44 INFO - PROCESS | 15041 | RSS: Main: 215961600 09:29:44 INFO - PROCESS | 15041 | 09:32:46 INFO - PROCESS | 15041 | Cycle 1(1): loaded http://localhost:46458/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46458/tests/dromaeo/cssquery-prototype.html) 09:32:47 INFO - PROCESS | 15041 | RSS: Main: 265347072 09:32:47 INFO - PROCESS | 15041 | 09:35:49 INFO - PROCESS | 15041 | Cycle 1(1): loaded http://localhost:46458/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46458/tests/dromaeo/cssquery-yui.html) 09:35:50 INFO - PROCESS | 15041 | RSS: Main: 215060480 09:35:50 INFO - PROCESS | 15041 | 09:38:53 INFO - PROCESS | 15041 | Cycle 1(1): loaded http://localhost:46458/tests/dromaeo/cssquery-yui.html (next: http://localhost:46458/tests/dromaeo/cssquery-dojo.html) 09:38:53 INFO - PROCESS | 15041 | RSS: Main: 301039616 09:38:53 INFO - PROCESS | 15041 | 09:38:53 INFO - PROCESS | 15041 | __start_tp_report 09:38:53 INFO - PROCESS | 15041 | _x_x_mozilla_page_load 09:38:53 INFO - PROCESS | 15041 | _x_x_mozilla_page_load_details 09:38:53 INFO - PROCESS | 15041 | |i|pagename|runs| 09:38:53 INFO - PROCESS | 15041 | |0;dojo.html;3053.4656435123857;3056.2359410147465;3067.8312692801887;3097.8141311521294;3127.1869313978373;5247.842564723055;5257.8948421031555;5297.12597421425;5367.838964831051;5403.2165336026255;5311.362636483627;5319;5327.786888524454;5381.946180538203;5384.434634363394;4862.416510018803;4895.55939965403;4921.114199444099;4921.606271498289;4922.458529561745;4832.130216561018;4901.926471102936;4942.5304596063315;4948.084604348189;4950.975245123787;4955.6035517158725;4977.751112444382;5004.149294619923;5032.924506132411;5039.77321020555;4792.592629626486;4852.56326930578;4874.049560335736;4904.8528544143555;4913.017396520674;4725.574698277172;4732.952670473285;4755.857324280277;4833.250846118857;4837.7339246341435;5314.123169676998;5330.92003619946;5346.759395827197;5356.407495795153;5358.4641535846495;5541.445855414427;5639;5665.688387138705;5690.3456102548325;5698.7435565399655;5712.714364281769;5733.655980641175;5756.7121643917635;5765.423457654243;5840.415958404168;5359.758810853521;5362.597805164551;5362.678239305654;5369.624126311121;5394.002109609734;5683.857903552444;5807.970960145172;5868.765249390062;5879.823605291848;5880.14737863016;5651.265335506358;5656.377798442168;5658.830235092953;5715.657060576295;5725.484706376446;5712.485876271156;5719.885602287931;5719.971400142973;5721.056025755704;5740.684262365527;5471.8084867029465;5587.273654424899;5645.463680950304;5724.3130824300515;5730.484256416859;5683.119116536944;5754.942450575524;5758.337791154071;5761.769529218868;5765;4402.669799765031;4411.647068234533;4412.911741765147;4413.360062790877;4422.5356337584735;3913.7651740895635;3915.941260881089;3917.2948869203246;3926.254011737818;3993.201359728066;5243.4232234454175;5307.575393968474;5317.9202311965355;5319.707416092152;5394.352677678625;5624.043912534797;5626.634268772516;5632.070708333161;5634.098544232903;5634.661920284796;5290.8941821164135;5319.361676598833;5324.334458192726;5329.413764485904;5387;4938.654294199443;5010.749462526932;5015.4733752956145;5028.120078986163;5091.9236211456855;5978.880422391528;5983.222181116427;5983.34183239852;5990.31111422192;5992.970035149797;5599.720013999202;5717.7141142941855;5783.595148339576;5786.913196302143;5787;5877.294724633071;5943.762249509971;5966.075258334965;6061.242344706911;6068.8786224276155;5685.545156387397;5689.914651280317;5699.173619825019;5753.654780713171;5760.94239057604;5754.165645981393;5796.536277097738;5805.912911306249;5808.215890854681;5815.79644712433;5450.073487507054;5549.500544950974;5641.26663533738;5652.943470565242;5664.943350566442;5603.299587551556;5655.208270842168;5658.434156584309;5698.230738850368;5718.628289161191;5581.972090139686;5584.748686309207;5596.300462442195;5600.439956004367;5604.215409842707;5486;5495.2856128703015;5564.805231816867;5657.094864821774;5687.630304030225;5492.642978206404;5494.862628434321;5501.0648189807025;5545.390007099297;5562.666240025612 09:38:53 INFO - PROCESS | 15041 | |1;ext.html;548.7141636236502;588.6262223488085;613.3743581546822;622.5424313129848;638.0779773227688;31159.68840311596;42719.572804271986;43629.56370436291;43659.78170109153;43685.34471982915;44951.32573011408;45350.54649453505;45388.773056134676;45395.77302113493;45441;8077;8893.377463577552;9038.683646072388;9041.457512549236;10800.567977280938;10801.891981080207;10836.133109351273;10893.727656808564;10917.23579349446;10923.344599324066;10851.620193293236;10894.346339219632;10898.073663738553;10905.781884362308;10906.127509799237;10825.458727063655;10862.565497380136;10871.728206794893;10875.619353322674;10887.891121088845;10761.08530774885;10814.323779814142;10832.837507437394;10874.891251087467;10893.291936024134;41146.588534114875;41790.79104604488;41859.372109418386;41887;41890.79054604738;3433.656634336571;3605.7656252343513;3608.440691692792;3620.945685814715;3816.580176180618;31349.686503135134;31484;31551.36897262065;31674.841625791953;32691;4189.099343641102;4305.22505948929;4325.610695037431;4364.716293440948;4414.448193975753;351799;352166;352707;353296;353451.23274383723;56970.43029569734;57325;57363.42636573665;57398.7130064347;57420.13869791957;36605;37188.62811371906;37235.441468378;38912;60674.393256066876;16529.173541322885;16623.83376166223;16722.74915876263;16745.581360466087;16745.91627041857;11993.700157496132;12613.62159135209;12971.5459958901;13054.54309099177;13207.735845283232;18357.63284734298;18443.72334414985;18523.72214416785;18545.165467553994;18592.163352649164;6869.569990668231;6960.547564408297;7056.506044576933;7092.148942126978;7184.425245980309;869.7347309070668;971.1162841813915;990.4008075114596;993.6919554937992;994.5922171909482;30108.397832043236;31562.36875262528;31710.524342134886;31795.523067154012;32430;1061.623123791043;1065.6057258814287;1072.3887384191091;1091.7652704668376;1142.5315620595516;15954.60113497172;16503.587410314598;16667.749983750255;16745.413910513074;16870.831291686925;564821;568154;568229;568259;570754;57649.13526297109;58218;58290.708546457;58312.41687583155;58429;1168.8889555492215;1303.9739205216033;1312.2257867857818;1335.4658136745186;1349.5546469664987;30264;31344.21639459032;31667;31910.873867930037;32503.674963250065;49200.75399622979;49774;49795.25307120469;49846.501534984185;49868;391400;392853.00057992473;393464;393785;394138;27850.860745696144;28675.71324286814;28684.282892927844;29813.10560683183;29902.60779137707;44502.77748611236;46929;47901;48196.7590162047;48681.756591216814;39467.605323946394;40033.599664004156;40050.1989960205;40232.79883600563;41831.58168418277;39449.21101577895;39619.80190099031;39968.4004739935;40434.39348409717;41366.37950430806;39263;39786.20427591374;40333.77329813549;40354.596454036255;40379.19241615092;32122.91201071923;36081;36184.91445256647;36374.780736725115;37053;26896.59655105136;27264.454710906066;27516.862415687792;27632.309192270353;27653.58519622167 09:38:53 INFO - PROCESS | 15041 | |2;jquery.html;370.8145927036482;395.47994387380595;402.6718224646913;410.3618872653024;424.92351376752174;15848.524544263677;19224.423267301987;19348.12933417996;19661.50846228845;20029.298974535894;19096.522586935334;19554.413367598958;19613.70579441306;20171.29400470984;20378.388648340537;5159.355080614923;5592.5246354059855;5812.738426770806;5836.6789826559525;5857.560682948774;5514.393416724157;5643.068893632566;5747.540196784247;5785.82642520725;5807.361190269067;5571.4428557144165;5759.856003599902;5779.682117483537;5784;5787.536997040248;5700.059490184115;5731.426857314277;5738;5741.368449470555;5743.62666426681;5167.664101833407;5423.078076726966;5456.263404440389;5518.944810551883;5525.11598144299;13897.374618142107;14039.719205615933;14183.078099923472;19022.239110435567;22830.657540136912;2390.53384590005;2440.6339049142593;2504.874756262198;2624.3439140214946;2840.062779282832;10305.484725763681;10696.790962711155;10792.51433685486;11938.761224775455;14396.496122635763;1839.1631807527542;1890.6124244529976;1916.3484415298865;1930.4594713480249;1942.747442832437;74699;75098.62450687711;76453;79059.6047019767;85331.57334213352;10808.243422960475;11271.774564508663;11312.6040588579;11516.827247591293;11611.361375124281;15915.920420398055;15939.840601594067;15943.123128228059;15951.282192301374;15955.441559545592;8218.917810821815;8468.872966905501;8548.786280343042;8775.210231079234;8830.470171789713;8011.196418734177;8173.18268173178;8227.465214761021;8286.212809783061;8433.28317093054;4827.975860120677;4830.372051633335;4889.584385327216;4898.436679781799;4998.850034498971;1906.3613689413924;1984.960300793976;2026.2199053364561;2051.4358551398186;2069.8447616428525;843.8143608406141;936.765808547863;937.3579098317674;963.4075043848123;978.3542861711236;19236;20225.29211477591;20308;20347.796522034885;20389.796102039087;984.8473486609587;1014.5485259059795;1030.5465595138114;1072.8873468285717;1078.6817888722846;10318.741777299294;10962.835557466644;11152.888471115184;11188.66434006981;11237;506901;512331;513461;544998;546007.7490313711;96299;96899;97691.51154244183;98291.50854245682;100011.49994249982;978.6917121106828;1000.5897581991348;1044.5143008501084;1056.3661802918189;1063.1760385701143;17160.828391715924;17344.352286532758;17808.46574602764;17868.46394608164;17879.642407151525;42050.78974605107;42883.571164287954;43233.56766432295;43836.34245486256;44431.63923758225;56210;59445.668445473864;60248.39751602428;61702.38297617146;62712;8587.871181932402;8647;8709.738707838775;8831.337649676172;8880.777980550538;12484.87515124837;12642.683932901751;12643.494260229856;12795.232286062866;12861.292628905127;11280.49237784318;11373.31760094397;11437.656870293904;11447.484863181011;12044.457999389873;11519.884801152217;11722.120840936794;11755.706107347385;12273;12293.93853030729;9007.874015748032;11413.372264525531;11619.825702614298;11662.825057624312;11802.34447249362;8298.70954516589;8432;8464.449810762528;8665.740027799176;8690.565471726515;10750.73123171927;11413;11555.711107222387;11640.35978021217;11648.883511165119 09:38:53 INFO - PROCESS | 15041 | |3;mootools.html;1318.018076532983;1434.3043623842439;1473.9115653060815;1584.445444094567;1735.5314065202388;8536.48781073136;8965.462072275659;8998.32512561558;9257.76855578611;9274.07259274074;8997.955010224956;9137.040610735876;9143.177114059734;9144.771380715469;9170.449773013625;2477.826552141351;2497.962530562043;2503.9374015649573;2505.3235626380865;2507.699076110869;2393;2499.7750202481775;2507.5987841945293;2509.297396728919;2509.6611957385703;2454.9631755523683;2477.2815883393796;2484.3416494628937;2486.154707399484;2487.141936032075;2401.1715957994465;2420.9757902420924;2427.781499665021;2432.1852179519883;2434.379233295516;2371.6086845670443;2396.6524853896262;2400.135951057618;2401.435662619283;2402.1952645863657;8948.418352807112;8964.103589641049;8981.236594889442;9005.909940900572;9016.59425325862;5376.11294136467;5612.5229355504425;5618.438156184349;5618.803341883015;5622.943770562324;3386.8814591489427;3422.691957723817;3473.14907847579;3474.617792042873;3476.5654293213347;1009.8232809258424;1035.1356617224626;1047.2302857399804;1049.559185142242;1079.632924805562;12411.93794031033;12425.254484730945;12559.246445213224;12565.497380104876;12620.621381358482;4538.909221815611;4665.2768820832825;4779.95220047802;4815.686980346266;4821.5178482152205;9852.408855468695;9862.950685246527;9863.654772082942;9868.259880508991;9870.30907836459;5360.946390536123;5409.215663728737;5416.864578385572;5419.132938729785;5428.538574221236;4380.167768124046;4755.548222918817;4898.436679781871;4938.802447902115;5000.699958002531;3839.827207775657;3923.097687531884;3934;4025.1144748155357;4025.1345960618023;1172.876847930972;1189.8884417248833;1196.5991392883482;1204.3917821500086;1217.4312201255343;899.4333569851083;935.9766005849772;955.6320816485703;973.7857671312441;1001.7495626093477;6013.1581578579035;6131.50947924165;6172.290186628506;6184.288806787187;6435.871282574416;981.1709105805583;981.4111533080095;985.9112679858847;993.9403635781877;1004.1815920025156;4264.424302719155;4352.847650332286;4366;4395.428594282723;4396.758178300161;10949.945250273699;11378.601748938747;11393.3164010158;11403.258788178742;11424.828627570592;11271.154663400277;11274.210805243718;11302.886971130349;11396.658100257006;11401.030912372375;7939.880901786478;8302.70940517079;8448.957755211184;8561.0582835888;8580.442271252474;6301.243850737941;6365.395287447685;6438.227412710505;6575.408213260638;6584.8353791155605;9795.706128816148;10442.269041167348;10444;10445.843312350473;10545.10366618846;10286.434246116536;10435.478226088817;10436.843447348449;10566.207534434794;10604.522796474022;7207.207207207098;7657.310842024244;7919.802004949923;7989.920100798918;8100.0684921234815;8745.868811967954;8916.15296546827;8916.375853690179;8918.063603321558;8920.955395222982;7524.887126692995;7592.506487078323;7849.843003140019;8192.877106843522;8194.549299788569;7763.92236077632;7794.532328060334;7835.725749598737;7842.529448233125;7931.960340198262;7180;7290.781276561712;7293.452991025801;7294.598797066213;7300.12398512182;5263;5308.336457942757;5356.705381203916;5422.05114105038;5545.1682247663175;5483.122700367922;5492.368377636623;5520;5603.551715862803;5679.318481782213 09:38:53 INFO - PROCESS | 15041 | |4;prototype.html;328.921058945853;331.51764183113556;337.7196926550963;345.751059237349;349.1707195410899;5116.002379535992;5173.896522069565;5281.92077118843;5313.176457649066;5332.733363331832;5223.817166399177;5227.26818245446;5247.317848679676;5261.289725887013;5288.418273989858;4175.392473897557;4187.560306167854;4192.832286708528;4193.559676233997;4214.9367759483475;3970.3721474195586;4114.6091121343425;4183.937240941373;4190.916181676364;4200.075983283673;4097.7541347519245;4104.651104656108;4110.383442483637;4112.1775644870995;4118.238125946695;4090.1206240658253;4093.774842383668;4095.3037983542868;4103.343465045608;4129.648979836687;3634.5275114235246;3637.654422829827;3649.6532829381167;3659.8654417130774;3660.981695091534;5068.873278168038;5093.872653183663;5123.385193776733;5147.044123233185;5165.819196328148;4670.435404139617;4683.765811709435;4685.789139488731;4688.320193571913;4697.271922851964;5469.288992430958;5481.369642491125;5482.506574408282;5489.39616642169;5492.835214943558;3802.1825307559006;3991.980040099781;3999.6200360965663;4008.2183974125055;4031.879043628696;5711.942880571182;5725.541956643458;5769.336526299488;5770.163326317703;5800.506956908625;4123.97938010308;4125.50493940729;4127.504699436026;4130.463039804867;4136.669066474675;3926.430667553189;4158.6465150462545;4185.204811085884;4193.9370909435775;4197;4709.646776491708;4739.7439678485225;4743.0830039525445;4744.7627618618935;4753.83361582343;5558.722063896789;5570.927688819125;5586.715055537249;5607.467290607386;5608.96234196675;1361.6051345109806;1367.384676895401;1410.0059458082233;1442.5816513211262;1442.8917831162705;965.8937516873139;988.367444835306;997.2869398380193;1008.8335424654849;1010.782681723433;5288.629795914249;5341.893162136736;5352.785888564414;5360.437154098841;5365.463453654681;5600.971995139998;5602.299712535933;5608.541779137454;5614.606977511617;5632.887342253132;5198.64835142858;5315.681059136464;5327.147656375039;5331;5371.167469042305;2621.252942911299;2621.702257382608;2638.261286839688;2643.9735602644114;2646.4971655385416;5056.533605254435;5072.18844984808;5097.694138351637;5106.625419180024;5110.361204849394;4874.53691899269;5044.243363495505;5047.52048555394;5057.747112644427;5058.027369325966;5005.74971251436;5044.108459327752;5052.292679024939;5071.974640126776;5092;4894.730789806453;4927.187014142626;4938.678985865908;4981;4999.875028118644;4965.503449655005;5248.2390053442805;5642.520385767091;5683.119116536944;5701.831124619526;5897.528197744256;5908.586398952032;5911.970440147772;5917.319508256605;5919.023361145363;4137.089840235143;4143;4175.561566035522;4180.895477612962;4185.895352616209;5410.702411367412;5505.201745746925;5729.255196824386;5748.798792042258;5754.2519472469985;5379.193121031876;5437.5318663959715;5482.945170548243;5483.7806487740045;5555.583331250092;5517.69652669107;5549.972250138723;5602.887942241214;5608.10270356741;5621.241132447068;5356.866078348073;5515.283013208257;5534.640248384003;5539.529140023144;5543.750531226024;5619.353774316006;5629.831105066854;5632.5493960482245;5635.380108188014;5645.379008309001;5458.4541545845095;5516.80691175823;5516.834494965157;5517.117261238182;5521.779128834802 09:38:53 INFO - PROCESS | 15041 | |5;yui.html;748.6369110981175;750.4409215134725;753.1827966656181;780.1730166024015;819.2503858969044;14275.143491390523;15062.924685376558;15108.622284442894;15125.697486050272;15127.92436037821;15492.535223943272;15572.922135389335;15617.21913904306;15643.217839108056;15649.687006259897;655.6688872119573;775.1821827971488;793.4564823096168;795.0141824138085;797.2466019611484;804.4368941740776;806.0770417871533;806.209914284002;806.2622700229283;807.1807115777461;843.3801156150255;848.5333066813259;849.4223927729141;850.6172222499869;850.6469815026757;674.1707699529582;811.0672726364669;834.8163404051099;840.8360369727906;840.9915900840974;625.2340882419046;626.2829060725489;626.3110578363809;626.5081910700125;626.6177631644694;13622;13646.454141834414;13693.246871422069;13721.039527233097;13779.517716879862;12777.872221277761;13080.328653478018;13873.098248613807;13874.722505549833;14257.28713564328;12310.384480775925;12447.502099915993;12478.563250286197;12546.121771476;13212.405441755143;4283.892902677427;4300.65594752419;4306.246406878784;4534.750588717619;4556.179887620227;67297.66351168213;68370.9999999995;69427.61144777076;80397.19602803956;82100.20048095421;10381.169506439466;10544.209184311207;10796.78406431867;10921.453927303603;10961.780764384826;21241;21509.13963441476;21515.354539363845;21516.13935442596;21623.67564486534;8052.235037671412;8080.676772929017;8141.715039973573;8272;8275.213854683796;4432.977835110868;4482.238019536687;4570.634349252118;4624.930626040612;4685.109829132454;3494.0915362006062;3630.146915474861;3637.381645120336;3637.5998640149564;3638.5633723953297;593.4243783529969;596.1683451585014;608.5527137553894;611.4191518057863;613.4264462727275;617.8146556033172;663.8406782372195;669.1167658690579;690.689189864563;712.3909057755648;9127.406718563272;9151;9444.291678124031;9467.242620590336;9608.855867161998;699.433458898294;709.8473828126978;724.7861880745193;732.3226015935345;741.9332260096617;4410.977945110254;4527.3999434694515;4606.100373816926;4607.631389488833;4612.469565999886;96553;126422;130114;131735;132893;108149;109543.45228273807;109851.45074274577;111719.44140279246;114505.53405921013;93549.06450935539;95046.52476737573;95510;96272;100822;8411.621477033426;8463.280621147025;8559.57202139878;8719.651213951625;8907.55462226899;56166.719166403906;56637;57308.426915730306;57501.137482938626;57536.42463575311;77330.61334693516;80564.59717701374;84451.5777421109;84865;87743.56128219319;10660.25378223517;10762.19283553721;11110.333379997226;11176.105911526896;11372.43137843088;12009.879901201226;12166.756664866476;12323.137380383287;12328.32194229326;12546.121771476273;11493.82759258595;11820.70448238801;11924.701882453008;12422.006239500637;12574.811377829157;11542.856007391772;11881.108916831445;11901;12077.939610301892;12502.312372819582;11392.829107563559;11456.94271528637;11513.36676482768;11697.532098715956;12095.758084838079;9484.905150948678;9726.854097188407;9967.505930665937;10209.438480883622;10338.570435947397;9892;10095.848562271425;10132.964016519632;10218.386896786216;10305.433201174008 09:38:53 INFO - PROCESS | 15041 | __end_tp_report 09:38:53 INFO - PROCESS | 15041 | __start_cc_report 09:38:53 INFO - PROCESS | 15041 | _x_x_mozilla_cycle_collect,1201 09:38:53 INFO - PROCESS | 15041 | __end_cc_report 09:38:53 INFO - PROCESS | 15041 | __startTimestamp1472747933912__endTimestamp 09:38:53 INFO - PROCESS | 15041 | 09:38:53 INFO - PROCESS | 15041 | ------- Summary: start ------- 09:38:53 INFO - PROCESS | 15041 | Number of tests: 6 09:38:53 INFO - PROCESS | 15041 | 09:38:53 INFO - PROCESS | 15041 | [#0] dojo.html Cycles:165 Average:5325.42 Median:5541.45 stddev:602.40 (10.9%) stddev-sans-first:577.28 09:38:53 INFO - PROCESS | 15041 | Values: 3053.5 3056.2 3067.8 3097.8 3127.2 5247.8 5257.9 5297.1 5367.8 5403.2 5311.4 5319.0 5327.8 5381.9 5384.4 4862.4 4895.6 4921.1 4921.6 4922.5 4832.1 4901.9 4942.5 4948.1 4951.0 4955.6 4977.8 5004.1 5032.9 5039.8 4792.6 4852.6 4874.0 4904.9 4913.0 4725.6 4733.0 4755.9 4833.3 4837.7 5314.1 5330.9 5346.8 5356.4 5358.5 5541.4 5639.0 5665.7 5690.3 5698.7 5712.7 5733.7 5756.7 5765.4 5840.4 5359.8 5362.6 5362.7 5369.6 5394.0 5683.9 5808.0 5868.8 5879.8 5880.1 5651.3 5656.4 5658.8 5715.7 5725.5 5712.5 5719.9 5720.0 5721.1 5740.7 5471.8 5587.3 5645.5 5724.3 5730.5 5683.1 5754.9 5758.3 5761.8 5765.0 4402.7 4411.6 4412.9 4413.4 4422.5 3913.8 3915.9 3917.3 3926.3 3993.2 5243.4 5307.6 5317.9 5319.7 5394.4 5624.0 5626.6 5632.1 5634.1 5634.7 5290.9 5319.4 5324.3 5329.4 5387.0 4938.7 5010.7 5015.5 5028.1 5091.9 5978.9 5983.2 5983.3 5990.3 5993.0 5599.7 5717.7 5783.6 5786.9 5787.0 5877.3 5943.8 5966.1 6061.2 6068.9 5685.5 5689.9 5699.2 5753.7 5760.9 5754.2 5796.5 5805.9 5808.2 5815.8 5450.1 5549.5 5641.3 5652.9 5664.9 5603.3 5655.2 5658.4 5698.2 5718.6 5582.0 5584.7 5596.3 5600.4 5604.2 5486.0 5495.3 5564.8 5657.1 5687.6 5492.6 5494.9 5501.1 5545.4 5562.7 09:38:53 INFO - PROCESS | 15041 | 09:38:53 INFO - PROCESS | 15041 | [#1] ext.html Cycles:180 Average:59435.67 Median:36829.00 stddev:118836.01 (322.7%) stddev-sans-first:119087.12 09:38:53 INFO - PROCESS | 15041 | Values: 548.7 588.6 613.4 622.5 638.1 31159.7 42719.6 43629.6 43659.8 43685.3 44951.3 45350.5 45388.8 45395.8 45441.0 8077.0 8893.4 9038.7 9041.5 10800.6 10801.9 10836.1 10893.7 10917.2 10923.3 10851.6 10894.3 10898.1 10905.8 10906.1 10825.5 10862.6 10871.7 10875.6 10887.9 10761.1 10814.3 10832.8 10874.9 10893.3 41146.6 41790.8 41859.4 41887.0 41890.8 3433.7 3605.8 3608.4 3620.9 3816.6 31349.7 31484.0 31551.4 31674.8 32691.0 4189.1 4305.2 4325.6 4364.7 4414.4 351799.0 352166.0 352707.0 353296.0 353451.2 56970.4 57325.0 57363.4 57398.7 57420.1 36605.0 37188.6 37235.4 38912.0 60674.4 16529.2 16623.8 16722.7 16745.6 16745.9 11993.7 12613.6 12971.5 13054.5 13207.7 18357.6 18443.7 18523.7 18545.2 18592.2 6869.6 6960.5 7056.5 7092.1 7184.4 869.7 971.1 990.4 993.7 994.6 30108.4 31562.4 31710.5 31795.5 32430.0 1061.6 1065.6 1072.4 1091.8 1142.5 15954.6 16503.6 16667.7 16745.4 16870.8 564821.0 568154.0 568229.0 568259.0 570754.0 57649.1 58218.0 58290.7 58312.4 58429.0 1168.9 1304.0 1312.2 1335.5 1349.6 30264.0 31344.2 31667.0 31910.9 32503.7 49200.8 49774.0 49795.3 49846.5 49868.0 391400.0 392853.0 393464.0 393785.0 394138.0 27850.9 28675.7 28684.3 29813.1 29902.6 44502.8 46929.0 47901.0 48196.8 48681.8 39467.6 40033.6 40050.2 40232.8 41831.6 39449.2 39619.8 39968.4 40434.4 41366.4 39263.0 39786.2 40333.8 40354.6 40379.2 32122.9 36081.0 36184.9 36374.8 37053.0 26896.6 27264.5 27516.9 27632.3 27653.6 09:38:53 INFO - PROCESS | 15041 | 09:38:53 INFO - PROCESS | 15041 | [#2] jquery.html Cycles:180 Average:30073.46 Median:2564.61 stddev:86496.58 (3372.7%) stddev-sans-first:86710.48 09:38:53 INFO - PROCESS | 15041 | Values: 370.8 395.5 402.7 410.4 424.9 15848.5 19224.4 19348.1 19661.5 20029.3 19096.5 19554.4 19613.7 20171.3 20378.4 5159.4 5592.5 5812.7 5836.7 5857.6 5514.4 5643.1 5747.5 5785.8 5807.4 5571.4 5759.9 5779.7 5784.0 5787.5 5700.1 5731.4 5738.0 5741.4 5743.6 5167.7 5423.1 5456.3 5518.9 5525.1 13897.4 14039.7 14183.1 19022.2 22830.7 2390.5 2440.6 2504.9 2624.3 2840.1 10305.5 10696.8 10792.5 11938.8 14396.5 1839.2 1890.6 1916.3 1930.5 1942.7 74699.0 75098.6 76453.0 79059.6 85331.6 10808.2 11271.8 11312.6 11516.8 11611.4 15915.9 15939.8 15943.1 15951.3 15955.4 8218.9 8468.9 8548.8 8775.2 8830.5 8011.2 8173.2 8227.5 8286.2 8433.3 4828.0 4830.4 4889.6 4898.4 4998.9 1906.4 1985.0 2026.2 2051.4 2069.8 843.8 936.8 937.4 963.4 978.4 19236.0 20225.3 20308.0 20347.8 20389.8 984.8 1014.5 1030.5 1072.9 1078.7 10318.7 10962.8 11152.9 11188.7 11237.0 506901.0 512331.0 513461.0 544998.0 546007.7 96299.0 96899.0 97691.5 98291.5 100011.5 978.7 1000.6 1044.5 1056.4 1063.2 17160.8 17344.4 17808.5 17868.5 17879.6 42050.8 42883.6 43233.6 43836.3 44431.6 56210.0 59445.7 60248.4 61702.4 62712.0 8587.9 8647.0 8709.7 8831.3 8880.8 12484.9 12642.7 12643.5 12795.2 12861.3 11280.5 11373.3 11437.7 11447.5 12044.5 11519.9 11722.1 11755.7 12273.0 12293.9 9007.9 11413.4 11619.8 11662.8 11802.3 8298.7 8432.0 8464.4 8665.7 8690.6 10750.7 11413.0 11555.7 11640.4 11648.9 09:38:53 INFO - PROCESS | 15041 | 09:38:53 INFO - PROCESS | 15041 | [#3] mootools.html Cycles:180 Average:5964.50 Median:5131.85 stddev:3365.78 (65.6%) stddev-sans-first:3357.11 09:38:53 INFO - PROCESS | 15041 | Values: 1318.0 1434.3 1473.9 1584.4 1735.5 8536.5 8965.5 8998.3 9257.8 9274.1 8998.0 9137.0 9143.2 9144.8 9170.4 2477.8 2498.0 2503.9 2505.3 2507.7 2393.0 2499.8 2507.6 2509.3 2509.7 2455.0 2477.3 2484.3 2486.2 2487.1 2401.2 2421.0 2427.8 2432.2 2434.4 2371.6 2396.7 2400.1 2401.4 2402.2 8948.4 8964.1 8981.2 9005.9 9016.6 5376.1 5612.5 5618.4 5618.8 5622.9 3386.9 3422.7 3473.1 3474.6 3476.6 1009.8 1035.1 1047.2 1049.6 1079.6 12411.9 12425.3 12559.2 12565.5 12620.6 4538.9 4665.3 4780.0 4815.7 4821.5 9852.4 9863.0 9863.7 9868.3 9870.3 5360.9 5409.2 5416.9 5419.1 5428.5 4380.2 4755.5 4898.4 4938.8 5000.7 3839.8 3923.1 3934.0 4025.1 4025.1 1172.9 1189.9 1196.6 1204.4 1217.4 899.4 936.0 955.6 973.8 1001.7 6013.2 6131.5 6172.3 6184.3 6435.9 981.2 981.4 985.9 993.9 1004.2 4264.4 4352.8 4366.0 4395.4 4396.8 10949.9 11378.6 11393.3 11403.3 11424.8 11271.2 11274.2 11302.9 11396.7 11401.0 7939.9 8302.7 8449.0 8561.1 8580.4 6301.2 6365.4 6438.2 6575.4 6584.8 9795.7 10442.3 10444.0 10445.8 10545.1 10286.4 10435.5 10436.8 10566.2 10604.5 7207.2 7657.3 7919.8 7989.9 8100.1 8745.9 8916.2 8916.4 8918.1 8921.0 7524.9 7592.5 7849.8 8192.9 8194.5 7763.9 7794.5 7835.7 7842.5 7932.0 7180.0 7290.8 7293.5 7294.6 7300.1 5263.0 5308.3 5356.7 5422.1 5545.2 5483.1 5492.4 5520.0 5603.6 5679.3 09:38:53 INFO - PROCESS | 15041 | 09:38:53 INFO - PROCESS | 15041 | [#4] prototype.html Cycles:180 Average:4579.24 Median:5092.94 stddev:1328.02 (26.1%) stddev-sans-first:1292.86 09:38:53 INFO - PROCESS | 15041 | Values: 328.9 331.5 337.7 345.8 349.2 5116.0 5173.9 5281.9 5313.2 5332.7 5223.8 5227.3 5247.3 5261.3 5288.4 4175.4 4187.6 4192.8 4193.6 4214.9 3970.4 4114.6 4183.9 4190.9 4200.1 4097.8 4104.7 4110.4 4112.2 4118.2 4090.1 4093.8 4095.3 4103.3 4129.6 3634.5 3637.7 3649.7 3659.9 3661.0 5068.9 5093.9 5123.4 5147.0 5165.8 4670.4 4683.8 4685.8 4688.3 4697.3 5469.3 5481.4 5482.5 5489.4 5492.8 3802.2 3992.0 3999.6 4008.2 4031.9 5711.9 5725.5 5769.3 5770.2 5800.5 4124.0 4125.5 4127.5 4130.5 4136.7 3926.4 4158.6 4185.2 4193.9 4197.0 4709.6 4739.7 4743.1 4744.8 4753.8 5558.7 5570.9 5586.7 5607.5 5609.0 1361.6 1367.4 1410.0 1442.6 1442.9 965.9 988.4 997.3 1008.8 1010.8 5288.6 5341.9 5352.8 5360.4 5365.5 5601.0 5602.3 5608.5 5614.6 5632.9 5198.6 5315.7 5327.1 5331.0 5371.2 2621.3 2621.7 2638.3 2644.0 2646.5 5056.5 5072.2 5097.7 5106.6 5110.4 4874.5 5044.2 5047.5 5057.7 5058.0 5005.7 5044.1 5052.3 5072.0 5092.0 4894.7 4927.2 4938.7 4981.0 4999.9 4965.5 5248.2 5642.5 5683.1 5701.8 5897.5 5908.6 5912.0 5917.3 5919.0 4137.1 4143.0 4175.6 4180.9 4185.9 5410.7 5505.2 5729.3 5748.8 5754.3 5379.2 5437.5 5482.9 5483.8 5555.6 5517.7 5550.0 5602.9 5608.1 5621.2 5356.9 5515.3 5534.6 5539.5 5543.8 5619.4 5629.8 5632.5 5635.4 5645.4 5458.5 5516.8 5516.8 5517.1 5521.8 09:38:53 INFO - PROCESS | 15041 | 09:38:53 INFO - PROCESS | 15041 | [#5] yui.html Cycles:180 Average:21543.54 Median:4588.37 stddev:32861.22 (716.2%) stddev-sans-first:32916.31 09:38:53 INFO - PROCESS | 15041 | Values: 748.6 750.4 753.2 780.2 819.3 14275.1 15062.9 15108.6 15125.7 15127.9 15492.5 15572.9 15617.2 15643.2 15649.7 655.7 775.2 793.5 795.0 797.2 804.4 806.1 806.2 806.3 807.2 843.4 848.5 849.4 850.6 850.6 674.2 811.1 834.8 840.8 841.0 625.2 626.3 626.3 626.5 626.6 13622.0 13646.5 13693.2 13721.0 13779.5 12777.9 13080.3 13873.1 13874.7 14257.3 12310.4 12447.5 12478.6 12546.1 13212.4 4283.9 4300.7 4306.2 4534.8 4556.2 67297.7 68371.0 69427.6 80397.2 82100.2 10381.2 10544.2 10796.8 10921.5 10961.8 21241.0 21509.1 21515.4 21516.1 21623.7 8052.2 8080.7 8141.7 8272.0 8275.2 4433.0 4482.2 4570.6 4624.9 4685.1 3494.1 3630.1 3637.4 3637.6 3638.6 593.4 596.2 608.6 611.4 613.4 617.8 663.8 669.1 690.7 712.4 9127.4 9151.0 9444.3 9467.2 9608.9 699.4 709.8 724.8 732.3 741.9 4411.0 4527.4 4606.1 4607.6 4612.5 96553.0 126422.0 130114.0 131735.0 132893.0 108149.0 109543.5 109851.5 111719.4 114505.5 93549.1 95046.5 95510.0 96272.0 100822.0 8411.6 8463.3 8559.6 8719.7 8907.6 56166.7 56637.0 57308.4 57501.1 57536.4 77330.6 80564.6 84451.6 84865.0 87743.6 10660.3 10762.2 11110.3 11176.1 11372.4 12009.9 12166.8 12323.1 12328.3 12546.1 11493.8 11820.7 11924.7 12422.0 12574.8 11542.9 11881.1 11901.0 12077.9 12502.3 11392.8 11456.9 11513.4 11697.5 12095.8 9484.9 9726.9 9967.5 10209.4 10338.6 9892.0 10095.8 10133.0 10218.4 10305.4 09:38:53 INFO - PROCESS | 15041 | -------- Summary: end -------- 09:38:53 INFO - PROCESS | 15041 | 09:38:54 INFO - TEST-INFO | 15041: exit 0 09:38:54 INFO - TEST-OK | dromaeo_css | took 1116718ms 09:38:54 INFO - TEST-START | kraken 09:38:54 INFO - operating with platform_type : linux_ 09:38:54 INFO - Initialising browser for kraken test... 09:38:54 INFO - TEST-INFO | started process 15347 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyxaddo/profile http://localhost:46458/getInfo.html) 09:38:59 INFO - PROCESS | 15347 | __metrics Screen width/height:1600/1200 09:38:59 INFO - PROCESS | 15347 | colorDepth:24 09:38:59 INFO - PROCESS | 15347 | Browser inner width/height: 1024/697 09:38:59 INFO - PROCESS | 15347 | __metrics 09:38:59 INFO - PROCESS | 15347 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:38:59 INFO - PROCESS | 15347 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:39:00 INFO - PROCESS | 15347 | console.error: PushService: 09:39:00 INFO - PROCESS | 15347 | stateChangeProcessEnqueue: Error transitioning state 09:39:00 INFO - PROCESS | 15347 | UnknownError 09:39:00 INFO - TEST-INFO | 15347: exit 0 09:39:00 INFO - Browser initialized. 09:39:00 INFO - Running cycle 1/1 for kraken test... 09:39:00 INFO - TEST-INFO | started process 15431 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyxaddo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:39:12 INFO - PROCESS | 15431 | RSS: Main: 180121600 09:39:12 INFO - PROCESS | 15431 | 09:39:15 INFO - PROCESS | 15431 | Cycle 1(1): loaded http://localhost:46458/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46458/tests/kraken/driver.html?testName=audio-beat-detection) 09:39:16 INFO - PROCESS | 15431 | RSS: Main: 234135552 09:39:16 INFO - PROCESS | 15431 | 09:39:18 INFO - PROCESS | 15431 | Cycle 1(1): loaded http://localhost:46458/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46458/tests/kraken/driver.html?testName=audio-dft) 09:39:19 INFO - PROCESS | 15431 | RSS: Main: 224509952 09:39:19 INFO - PROCESS | 15431 | 09:39:22 INFO - PROCESS | 15431 | Cycle 1(1): loaded http://localhost:46458/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46458/tests/kraken/driver.html?testName=audio-fft) 09:39:23 INFO - PROCESS | 15431 | RSS: Main: 301772800 09:39:23 INFO - PROCESS | 15431 | 09:39:25 INFO - PROCESS | 15431 | Cycle 1(1): loaded http://localhost:46458/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46458/tests/kraken/driver.html?testName=audio-oscillator) 09:39:25 INFO - PROCESS | 15431 | RSS: Main: 212316160 09:39:25 INFO - PROCESS | 15431 | 09:39:27 INFO - PROCESS | 15431 | Cycle 1(1): loaded http://localhost:46458/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46458/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:39:28 INFO - PROCESS | 15431 | RSS: Main: 214159360 09:39:28 INFO - PROCESS | 15431 | 09:39:31 INFO - PROCESS | 15431 | Cycle 1(1): loaded http://localhost:46458/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46458/tests/kraken/driver.html?testName=imaging-darkroom) 09:39:32 INFO - PROCESS | 15431 | RSS: Main: 252243968 09:39:32 INFO - PROCESS | 15431 | 09:39:35 INFO - PROCESS | 15431 | Cycle 1(1): loaded http://localhost:46458/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46458/tests/kraken/driver.html?testName=imaging-desaturate) 09:39:36 INFO - PROCESS | 15431 | RSS: Main: 251969536 09:39:36 INFO - PROCESS | 15431 | 09:39:38 INFO - PROCESS | 15431 | Cycle 1(1): loaded http://localhost:46458/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46458/tests/kraken/driver.html?testName=json-parse-financial) 09:39:39 INFO - PROCESS | 15431 | RSS: Main: 251707392 09:39:39 INFO - PROCESS | 15431 | 09:39:40 INFO - PROCESS | 15431 | Cycle 1(1): loaded http://localhost:46458/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46458/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:39:41 INFO - PROCESS | 15431 | RSS: Main: 214126592 09:39:41 INFO - PROCESS | 15431 | 09:39:43 INFO - PROCESS | 15431 | Cycle 1(1): loaded http://localhost:46458/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46458/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:39:43 INFO - PROCESS | 15431 | RSS: Main: 221650944 09:39:43 INFO - PROCESS | 15431 | 09:39:45 INFO - PROCESS | 15431 | Cycle 1(1): loaded http://localhost:46458/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46458/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:39:46 INFO - PROCESS | 15431 | RSS: Main: 222478336 09:39:46 INFO - PROCESS | 15431 | 09:39:49 INFO - PROCESS | 15431 | Cycle 1(1): loaded http://localhost:46458/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46458/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:39:49 INFO - PROCESS | 15431 | RSS: Main: 223907840 09:39:49 INFO - PROCESS | 15431 | 09:39:52 INFO - PROCESS | 15431 | Cycle 1(1): loaded http://localhost:46458/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46458/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:39:53 INFO - PROCESS | 15431 | RSS: Main: 222150656 09:39:53 INFO - PROCESS | 15431 | 09:39:54 INFO - PROCESS | 15431 | Cycle 1(1): loaded http://localhost:46458/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46458/tests/kraken/driver.html?testName=ai-astar) 09:39:55 INFO - PROCESS | 15431 | RSS: Main: 273252352 09:39:55 INFO - PROCESS | 15431 | 09:39:55 INFO - PROCESS | 15431 | __start_tp_report 09:39:55 INFO - PROCESS | 15431 | _x_x_mozilla_page_load 09:39:55 INFO - PROCESS | 15431 | _x_x_mozilla_page_load_details 09:39:55 INFO - PROCESS | 15431 | |i|pagename|runs| 09:39:55 INFO - PROCESS | 15431 | |0;ai-astar;110;110;127;111;110;112;113;111;109;111 09:39:55 INFO - PROCESS | 15431 | |1;audio-beat-detection;159;122;141;183;118;157;152;121;187;120 09:39:55 INFO - PROCESS | 15431 | |2;audio-dft;162;162;162;162;161;162;162;162;163;162 09:39:55 INFO - PROCESS | 15431 | |3;audio-fft;75;77;76;171;76;76;75;75;168;75 09:39:55 INFO - PROCESS | 15431 | |4;audio-oscillator;82;83;147;83;83;82;157;83;82;140 09:39:55 INFO - PROCESS | 15431 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;116;116 09:39:55 INFO - PROCESS | 15431 | |6;imaging-darkroom;147;146;146;145;146;146;146;145;146;145 09:39:55 INFO - PROCESS | 15431 | |7;imaging-desaturate;96;96;95;95;94;96;96;95;96;96 09:39:55 INFO - PROCESS | 15431 | |8;json-parse-financial;52;52;52;52;52;52;53;52;54;52 09:39:55 INFO - PROCESS | 15431 | |9;json-stringify-tinderbox;62;62;62;62;62;62;63;63;64;67 09:39:55 INFO - PROCESS | 15431 | |10;stanford-crypto-aes;79;87;78;79;80;79;79;78;78;77 09:39:55 INFO - PROCESS | 15431 | |11;stanford-crypto-ccm;133;124;124;125;133;121;124;123;161;122 09:39:55 INFO - PROCESS | 15431 | |12;stanford-crypto-pbkdf2;160;161;161;164;166;167;163;161;165;166 09:39:55 INFO - PROCESS | 15431 | |13;stanford-crypto-sha256-iterative;69;65;66;64;64;65;64;64;64;64 09:39:55 INFO - PROCESS | 15431 | __end_tp_report 09:39:55 INFO - PROCESS | 15431 | __start_cc_report 09:39:55 INFO - PROCESS | 15431 | _x_x_mozilla_cycle_collect,1722 09:39:55 INFO - PROCESS | 15431 | __end_cc_report 09:39:55 INFO - PROCESS | 15431 | __startTimestamp1472747995120__endTimestamp 09:39:55 INFO - PROCESS | 15431 | 09:39:55 INFO - PROCESS | 15431 | ------- Summary: start ------- 09:39:55 INFO - PROCESS | 15431 | Number of tests: 14 09:39:55 INFO - PROCESS | 15431 | 09:39:55 INFO - PROCESS | 15431 | [#0] ai-astar Cycles:10 Average:112.40 Median:111.00 stddev:5.25 (4.7%) stddev-sans-first:5.50 09:39:55 INFO - PROCESS | 15431 | Values: 110.0 110.0 127.0 111.0 110.0 112.0 113.0 111.0 109.0 111.0 09:39:55 INFO - PROCESS | 15431 | 09:39:55 INFO - PROCESS | 15431 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:154.50 stddev:25.95 (16.8%) stddev-sans-first:27.10 09:39:55 INFO - PROCESS | 15431 | Values: 159.0 122.0 141.0 183.0 118.0 157.0 152.0 121.0 187.0 120.0 09:39:55 INFO - PROCESS | 15431 | 09:39:55 INFO - PROCESS | 15431 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 09:39:55 INFO - PROCESS | 15431 | Values: 162.0 162.0 162.0 162.0 161.0 162.0 162.0 162.0 163.0 162.0 09:39:55 INFO - PROCESS | 15431 | 09:39:55 INFO - PROCESS | 15431 | [#3] audio-fft Cycles:10 Average:94.40 Median:75.50 stddev:39.59 (52.4%) stddev-sans-first:41.37 09:39:55 INFO - PROCESS | 15431 | Values: 75.0 77.0 76.0 171.0 76.0 76.0 75.0 75.0 168.0 75.0 09:39:55 INFO - PROCESS | 15431 | 09:39:55 INFO - PROCESS | 15431 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:82.50 stddev:31.86 (38.6%) stddev-sans-first:32.95 09:39:55 INFO - PROCESS | 15431 | Values: 82.0 83.0 147.0 83.0 83.0 82.0 157.0 83.0 82.0 140.0 09:39:55 INFO - PROCESS | 15431 | 09:39:55 INFO - PROCESS | 15431 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 09:39:55 INFO - PROCESS | 15431 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 09:39:55 INFO - PROCESS | 15431 | 09:39:55 INFO - PROCESS | 15431 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 09:39:55 INFO - PROCESS | 15431 | Values: 147.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 145.0 09:39:55 INFO - PROCESS | 15431 | 09:39:55 INFO - PROCESS | 15431 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.71 (0.7%) stddev-sans-first:0.73 09:39:55 INFO - PROCESS | 15431 | Values: 96.0 96.0 95.0 95.0 94.0 96.0 96.0 95.0 96.0 96.0 09:39:55 INFO - PROCESS | 15431 | 09:39:55 INFO - PROCESS | 15431 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:0.67 (1.3%) stddev-sans-first:0.71 09:39:55 INFO - PROCESS | 15431 | Values: 52.0 52.0 52.0 52.0 52.0 52.0 53.0 52.0 54.0 52.0 09:39:55 INFO - PROCESS | 15431 | 09:39:55 INFO - PROCESS | 15431 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:62.50 stddev:1.60 (2.6%) stddev-sans-first:1.66 09:39:55 INFO - PROCESS | 15431 | Values: 62.0 62.0 62.0 62.0 62.0 62.0 63.0 63.0 64.0 67.0 09:39:55 INFO - PROCESS | 15431 | 09:39:55 INFO - PROCESS | 15431 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:2.80 (3.5%) stddev-sans-first:2.96 09:39:55 INFO - PROCESS | 15431 | Values: 79.0 87.0 78.0 79.0 80.0 79.0 79.0 78.0 78.0 77.0 09:39:55 INFO - PROCESS | 15431 | 09:39:55 INFO - PROCESS | 15431 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:124.50 stddev:12.00 (9.6%) stddev-sans-first:12.64 09:39:55 INFO - PROCESS | 15431 | Values: 133.0 124.0 124.0 125.0 133.0 121.0 124.0 123.0 161.0 122.0 09:39:55 INFO - PROCESS | 15431 | 09:39:55 INFO - PROCESS | 15431 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.40 Median:164.50 stddev:2.55 (1.5%) stddev-sans-first:2.39 09:39:55 INFO - PROCESS | 15431 | Values: 160.0 161.0 161.0 164.0 166.0 167.0 163.0 161.0 165.0 166.0 09:39:55 INFO - PROCESS | 15431 | 09:39:55 INFO - PROCESS | 15431 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:64.50 stddev:1.60 (2.5%) stddev-sans-first:0.73 09:39:55 INFO - PROCESS | 15431 | Values: 69.0 65.0 66.0 64.0 64.0 65.0 64.0 64.0 64.0 64.0 09:39:55 INFO - PROCESS | 15431 | -------- Summary: end -------- 09:39:55 INFO - PROCESS | 15431 | 09:39:56 INFO - TEST-INFO | 15431: exit 0 09:39:56 INFO - TEST-OK | kraken | took 61531ms 09:39:56 INFO - SUITE-END | took 1178s 09:39:56 INFO - Completed test suite (00:19:38) 09:39:56 INFO - javascript benchmark 09:39:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3053.4656435123857, 3056.2359410147465, 3067.8312692801887, 3097.8141311521294, 3127.1869313978373, 5247.842564723055, 5257.8948421031555, 5297.12597421425, 5367.838964831051, 5403.2165336026255, 5311.362636483627, 5319.0, 5327.786888524454, 5381.946180538203, 5384.434634363394, 4862.416510018803, 4895.55939965403, 4921.114199444099, 4921.606271498289, 4922.458529561745, 4832.130216561018, 4901.926471102936, 4942.5304596063315, 4948.084604348189, 4950.975245123787, 4955.6035517158725, 4977.751112444382, 5004.149294619923, 5032.924506132411, 5039.77321020555, 4792.592629626486, 4852.56326930578, 4874.049560335736, 4904.8528544143555, 4913.017396520674, 4725.574698277172, 4732.952670473285, 4755.857324280277, 4833.250846118857, 4837.7339246341435, 5314.123169676998, 5330.92003619946, 5346.759395827197, 5356.407495795153, 5358.4641535846495, 5541.445855414427, 5639.0, 5665.688387138705, 5690.3456102548325, 5698.7435565399655, 5712.714364281769, 5733.655980641175, 5756.7121643917635, 5765.423457654243, 5840.415958404168, 5359.758810853521, 5362.597805164551, 5362.678239305654, 5369.624126311121, 5394.002109609734, 5683.857903552444, 5807.970960145172, 5868.765249390062, 5879.823605291848, 5880.14737863016, 5651.265335506358, 5656.377798442168, 5658.830235092953, 5715.657060576295, 5725.484706376446, 5712.485876271156, 5719.885602287931, 5719.971400142973, 5721.056025755704, 5740.684262365527, 5471.8084867029465, 5587.273654424899, 5645.463680950304, 5724.3130824300515, 5730.484256416859, 5683.119116536944, 5754.942450575524, 5758.337791154071, 5761.769529218868, 5765.0, 4402.669799765031, 4411.647068234533, 4412.911741765147, 4413.360062790877, 4422.5356337584735, 3913.7651740895635, 3915.941260881089, 3917.2948869203246, 3926.254011737818, 3993.201359728066, 5243.4232234454175, 5307.575393968474, 5317.9202311965355, 5319.707416092152, 5394.352677678625, 5624.043912534797, 5626.634268772516, 5632.070708333161, 5634.098544232903, 5634.661920284796, 5290.8941821164135, 5319.361676598833, 5324.334458192726, 5329.413764485904, 5387.0, 4938.654294199443, 5010.749462526932, 5015.4733752956145, 5028.120078986163, 5091.9236211456855, 5978.880422391528, 5983.222181116427, 5983.34183239852, 5990.31111422192, 5992.970035149797, 5599.720013999202, 5717.7141142941855, 5783.595148339576, 5786.913196302143, 5787.0, 5877.294724633071, 5943.762249509971, 5966.075258334965, 6061.242344706911, 6068.8786224276155, 5685.545156387397, 5689.914651280317, 5699.173619825019, 5753.654780713171, 5760.94239057604, 5754.165645981393, 5796.536277097738, 5805.912911306249, 5808.215890854681, 5815.79644712433, 5450.073487507054, 5549.500544950974, 5641.26663533738, 5652.943470565242, 5664.943350566442, 5603.299587551556, 5655.208270842168, 5658.434156584309, 5698.230738850368, 5718.628289161191, 5581.972090139686, 5584.748686309207, 5596.300462442195, 5600.439956004367, 5604.215409842707, 5486.0, 5495.2856128703015, 5564.805231816867, 5657.094864821774, 5687.630304030225, 5492.642978206404, 5494.862628434321, 5501.0648189807025, 5545.390007099297, 5562.666240025612], "value": 5284.727521529209, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.7141636236502, 588.6262223488085, 613.3743581546822, 622.5424313129848, 638.0779773227688, 31159.68840311596, 42719.572804271986, 43629.56370436291, 43659.78170109153, 43685.34471982915, 44951.32573011408, 45350.54649453505, 45388.773056134676, 45395.77302113493, 45441.0, 8077.0, 8893.377463577552, 9038.683646072388, 9041.457512549236, 10800.567977280938, 10801.891981080207, 10836.133109351273, 10893.727656808564, 10917.23579349446, 10923.344599324066, 10851.620193293236, 10894.346339219632, 10898.073663738553, 10905.781884362308, 10906.127509799237, 10825.458727063655, 10862.565497380136, 10871.728206794893, 10875.619353322674, 10887.891121088845, 10761.08530774885, 10814.323779814142, 10832.837507437394, 10874.891251087467, 10893.291936024134, 41146.588534114875, 41790.79104604488, 41859.372109418386, 41887.0, 41890.79054604738, 3433.656634336571, 3605.7656252343513, 3608.440691692792, 3620.945685814715, 3816.580176180618, 31349.686503135134, 31484.0, 31551.36897262065, 31674.841625791953, 32691.0, 4189.099343641102, 4305.22505948929, 4325.610695037431, 4364.716293440948, 4414.448193975753, 351799.0, 352166.0, 352707.0, 353296.0, 353451.23274383723, 56970.43029569734, 57325.0, 57363.42636573665, 57398.7130064347, 57420.13869791957, 36605.0, 37188.62811371906, 37235.441468378, 38912.0, 60674.393256066876, 16529.173541322885, 16623.83376166223, 16722.74915876263, 16745.581360466087, 16745.91627041857, 11993.700157496132, 12613.62159135209, 12971.5459958901, 13054.54309099177, 13207.735845283232, 18357.63284734298, 18443.72334414985, 18523.72214416785, 18545.165467553994, 18592.163352649164, 6869.569990668231, 6960.547564408297, 7056.506044576933, 7092.148942126978, 7184.425245980309, 869.7347309070668, 971.1162841813915, 990.4008075114596, 993.6919554937992, 994.5922171909482, 30108.397832043236, 31562.36875262528, 31710.524342134886, 31795.523067154012, 32430.0, 1061.623123791043, 1065.6057258814287, 1072.3887384191091, 1091.7652704668376, 1142.5315620595516, 15954.60113497172, 16503.587410314598, 16667.749983750255, 16745.413910513074, 16870.831291686925, 564821.0, 568154.0, 568229.0, 568259.0, 570754.0, 57649.13526297109, 58218.0, 58290.708546457, 58312.41687583155, 58429.0, 1168.8889555492215, 1303.9739205216033, 1312.2257867857818, 1335.4658136745186, 1349.5546469664987, 30264.0, 31344.21639459032, 31667.0, 31910.873867930037, 32503.674963250065, 49200.75399622979, 49774.0, 49795.25307120469, 49846.501534984185, 49868.0, 391400.0, 392853.00057992473, 393464.0, 393785.0, 394138.0, 27850.860745696144, 28675.71324286814, 28684.282892927844, 29813.10560683183, 29902.60779137707, 44502.77748611236, 46929.0, 47901.0, 48196.7590162047, 48681.756591216814, 39467.605323946394, 40033.599664004156, 40050.1989960205, 40232.79883600563, 41831.58168418277, 39449.21101577895, 39619.80190099031, 39968.4004739935, 40434.39348409717, 41366.37950430806, 39263.0, 39786.20427591374, 40333.77329813549, 40354.596454036255, 40379.19241615092, 32122.91201071923, 36081.0, 36184.91445256647, 36374.780736725115, 37053.0, 26896.59655105136, 27264.454710906066, 27516.862415687792, 27632.309192270353, 27653.58519622167], "value": 20132.653209217216, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.8145927036482, 395.47994387380595, 402.6718224646913, 410.3618872653024, 424.92351376752174, 15848.524544263677, 19224.423267301987, 19348.12933417996, 19661.50846228845, 20029.298974535894, 19096.522586935334, 19554.413367598958, 19613.70579441306, 20171.29400470984, 20378.388648340537, 5159.355080614923, 5592.5246354059855, 5812.738426770806, 5836.6789826559525, 5857.560682948774, 5514.393416724157, 5643.068893632566, 5747.540196784247, 5785.82642520725, 5807.361190269067, 5571.4428557144165, 5759.856003599902, 5779.682117483537, 5784.0, 5787.536997040248, 5700.059490184115, 5731.426857314277, 5738.0, 5741.368449470555, 5743.62666426681, 5167.664101833407, 5423.078076726966, 5456.263404440389, 5518.944810551883, 5525.11598144299, 13897.374618142107, 14039.719205615933, 14183.078099923472, 19022.239110435567, 22830.657540136912, 2390.53384590005, 2440.6339049142593, 2504.874756262198, 2624.3439140214946, 2840.062779282832, 10305.484725763681, 10696.790962711155, 10792.51433685486, 11938.761224775455, 14396.496122635763, 1839.1631807527542, 1890.6124244529976, 1916.3484415298865, 1930.4594713480249, 1942.747442832437, 74699.0, 75098.62450687711, 76453.0, 79059.6047019767, 85331.57334213352, 10808.243422960475, 11271.774564508663, 11312.6040588579, 11516.827247591293, 11611.361375124281, 15915.920420398055, 15939.840601594067, 15943.123128228059, 15951.282192301374, 15955.441559545592, 8218.917810821815, 8468.872966905501, 8548.786280343042, 8775.210231079234, 8830.470171789713, 8011.196418734177, 8173.18268173178, 8227.465214761021, 8286.212809783061, 8433.28317093054, 4827.975860120677, 4830.372051633335, 4889.584385327216, 4898.436679781799, 4998.850034498971, 1906.3613689413924, 1984.960300793976, 2026.2199053364561, 2051.4358551398186, 2069.8447616428525, 843.8143608406141, 936.765808547863, 937.3579098317674, 963.4075043848123, 978.3542861711236, 19236.0, 20225.29211477591, 20308.0, 20347.796522034885, 20389.796102039087, 984.8473486609587, 1014.5485259059795, 1030.5465595138114, 1072.8873468285717, 1078.6817888722846, 10318.741777299294, 10962.835557466644, 11152.888471115184, 11188.66434006981, 11237.0, 506901.0, 512331.0, 513461.0, 544998.0, 546007.7490313711, 96299.0, 96899.0, 97691.51154244183, 98291.50854245682, 100011.49994249982, 978.6917121106828, 1000.5897581991348, 1044.5143008501084, 1056.3661802918189, 1063.1760385701143, 17160.828391715924, 17344.352286532758, 17808.46574602764, 17868.46394608164, 17879.642407151525, 42050.78974605107, 42883.571164287954, 43233.56766432295, 43836.34245486256, 44431.63923758225, 56210.0, 59445.668445473864, 60248.39751602428, 61702.38297617146, 62712.0, 8587.871181932402, 8647.0, 8709.738707838775, 8831.337649676172, 8880.777980550538, 12484.87515124837, 12642.683932901751, 12643.494260229856, 12795.232286062866, 12861.292628905127, 11280.49237784318, 11373.31760094397, 11437.656870293904, 11447.484863181011, 12044.457999389873, 11519.884801152217, 11722.120840936794, 11755.706107347385, 12273.0, 12293.93853030729, 9007.874015748032, 11413.372264525531, 11619.825702614298, 11662.825057624312, 11802.34447249362, 8298.70954516589, 8432.0, 8464.449810762528, 8665.740027799176, 8690.565471726515, 10750.73123171927, 11413.0, 11555.711107222387, 11640.35978021217, 11648.883511165119], "value": 9277.645813401918, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1318.018076532983, 1434.3043623842439, 1473.9115653060815, 1584.445444094567, 1735.5314065202388, 8536.48781073136, 8965.462072275659, 8998.32512561558, 9257.76855578611, 9274.07259274074, 8997.955010224956, 9137.040610735876, 9143.177114059734, 9144.771380715469, 9170.449773013625, 2477.826552141351, 2497.962530562043, 2503.9374015649573, 2505.3235626380865, 2507.699076110869, 2393.0, 2499.7750202481775, 2507.5987841945293, 2509.297396728919, 2509.6611957385703, 2454.9631755523683, 2477.2815883393796, 2484.3416494628937, 2486.154707399484, 2487.141936032075, 2401.1715957994465, 2420.9757902420924, 2427.781499665021, 2432.1852179519883, 2434.379233295516, 2371.6086845670443, 2396.6524853896262, 2400.135951057618, 2401.435662619283, 2402.1952645863657, 8948.418352807112, 8964.103589641049, 8981.236594889442, 9005.909940900572, 9016.59425325862, 5376.11294136467, 5612.5229355504425, 5618.438156184349, 5618.803341883015, 5622.943770562324, 3386.8814591489427, 3422.691957723817, 3473.14907847579, 3474.617792042873, 3476.5654293213347, 1009.8232809258424, 1035.1356617224626, 1047.2302857399804, 1049.559185142242, 1079.632924805562, 12411.93794031033, 12425.254484730945, 12559.246445213224, 12565.497380104876, 12620.621381358482, 4538.909221815611, 4665.2768820832825, 4779.95220047802, 4815.686980346266, 4821.5178482152205, 9852.408855468695, 9862.950685246527, 9863.654772082942, 9868.259880508991, 9870.30907836459, 5360.946390536123, 5409.215663728737, 5416.864578385572, 5419.132938729785, 5428.538574221236, 4380.167768124046, 4755.548222918817, 4898.436679781871, 4938.802447902115, 5000.699958002531, 3839.827207775657, 3923.097687531884, 3934.0, 4025.1144748155357, 4025.1345960618023, 1172.876847930972, 1189.8884417248833, 1196.5991392883482, 1204.3917821500086, 1217.4312201255343, 899.4333569851083, 935.9766005849772, 955.6320816485703, 973.7857671312441, 1001.7495626093477, 6013.1581578579035, 6131.50947924165, 6172.290186628506, 6184.288806787187, 6435.871282574416, 981.1709105805583, 981.4111533080095, 985.9112679858847, 993.9403635781877, 1004.1815920025156, 4264.424302719155, 4352.847650332286, 4366.0, 4395.428594282723, 4396.758178300161, 10949.945250273699, 11378.601748938747, 11393.3164010158, 11403.258788178742, 11424.828627570592, 11271.154663400277, 11274.210805243718, 11302.886971130349, 11396.658100257006, 11401.030912372375, 7939.880901786478, 8302.70940517079, 8448.957755211184, 8561.0582835888, 8580.442271252474, 6301.243850737941, 6365.395287447685, 6438.227412710505, 6575.408213260638, 6584.8353791155605, 9795.706128816148, 10442.269041167348, 10444.0, 10445.843312350473, 10545.10366618846, 10286.434246116536, 10435.478226088817, 10436.843447348449, 10566.207534434794, 10604.522796474022, 7207.207207207098, 7657.310842024244, 7919.802004949923, 7989.920100798918, 8100.0684921234815, 8745.868811967954, 8916.15296546827, 8916.375853690179, 8918.063603321558, 8920.955395222982, 7524.887126692995, 7592.506487078323, 7849.843003140019, 8192.877106843522, 8194.549299788569, 7763.92236077632, 7794.532328060334, 7835.725749598737, 7842.529448233125, 7931.960340198262, 7180.0, 7290.781276561712, 7293.452991025801, 7294.598797066213, 7300.12398512182, 5263.0, 5308.336457942757, 5356.705381203916, 5422.05114105038, 5545.1682247663175, 5483.122700367922, 5492.368377636623, 5520.0, 5603.551715862803, 5679.318481782213], "value": 4761.843163489709, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.921058945853, 331.51764183113556, 337.7196926550963, 345.751059237349, 349.1707195410899, 5116.002379535992, 5173.896522069565, 5281.92077118843, 5313.176457649066, 5332.733363331832, 5223.817166399177, 5227.26818245446, 5247.317848679676, 5261.289725887013, 5288.418273989858, 4175.392473897557, 4187.560306167854, 4192.832286708528, 4193.559676233997, 4214.9367759483475, 3970.3721474195586, 4114.6091121343425, 4183.937240941373, 4190.916181676364, 4200.075983283673, 4097.7541347519245, 4104.651104656108, 4110.383442483637, 4112.1775644870995, 4118.238125946695, 4090.1206240658253, 4093.774842383668, 4095.3037983542868, 4103.343465045608, 4129.648979836687, 3634.5275114235246, 3637.654422829827, 3649.6532829381167, 3659.8654417130774, 3660.981695091534, 5068.873278168038, 5093.872653183663, 5123.385193776733, 5147.044123233185, 5165.819196328148, 4670.435404139617, 4683.765811709435, 4685.789139488731, 4688.320193571913, 4697.271922851964, 5469.288992430958, 5481.369642491125, 5482.506574408282, 5489.39616642169, 5492.835214943558, 3802.1825307559006, 3991.980040099781, 3999.6200360965663, 4008.2183974125055, 4031.879043628696, 5711.942880571182, 5725.541956643458, 5769.336526299488, 5770.163326317703, 5800.506956908625, 4123.97938010308, 4125.50493940729, 4127.504699436026, 4130.463039804867, 4136.669066474675, 3926.430667553189, 4158.6465150462545, 4185.204811085884, 4193.9370909435775, 4197.0, 4709.646776491708, 4739.7439678485225, 4743.0830039525445, 4744.7627618618935, 4753.83361582343, 5558.722063896789, 5570.927688819125, 5586.715055537249, 5607.467290607386, 5608.96234196675, 1361.6051345109806, 1367.384676895401, 1410.0059458082233, 1442.5816513211262, 1442.8917831162705, 965.8937516873139, 988.367444835306, 997.2869398380193, 1008.8335424654849, 1010.782681723433, 5288.629795914249, 5341.893162136736, 5352.785888564414, 5360.437154098841, 5365.463453654681, 5600.971995139998, 5602.299712535933, 5608.541779137454, 5614.606977511617, 5632.887342253132, 5198.64835142858, 5315.681059136464, 5327.147656375039, 5331.0, 5371.167469042305, 2621.252942911299, 2621.702257382608, 2638.261286839688, 2643.9735602644114, 2646.4971655385416, 5056.533605254435, 5072.18844984808, 5097.694138351637, 5106.625419180024, 5110.361204849394, 4874.53691899269, 5044.243363495505, 5047.52048555394, 5057.747112644427, 5058.027369325966, 5005.74971251436, 5044.108459327752, 5052.292679024939, 5071.974640126776, 5092.0, 4894.730789806453, 4927.187014142626, 4938.678985865908, 4981.0, 4999.875028118644, 4965.503449655005, 5248.2390053442805, 5642.520385767091, 5683.119116536944, 5701.831124619526, 5897.528197744256, 5908.586398952032, 5911.970440147772, 5917.319508256605, 5919.023361145363, 4137.089840235143, 4143.0, 4175.561566035522, 4180.895477612962, 4185.895352616209, 5410.702411367412, 5505.201745746925, 5729.255196824386, 5748.798792042258, 5754.2519472469985, 5379.193121031876, 5437.5318663959715, 5482.945170548243, 5483.7806487740045, 5555.583331250092, 5517.69652669107, 5549.972250138723, 5602.887942241214, 5608.10270356741, 5621.241132447068, 5356.866078348073, 5515.283013208257, 5534.640248384003, 5539.529140023144, 5543.750531226024, 5619.353774316006, 5629.831105066854, 5632.5493960482245, 5635.380108188014, 5645.379008309001, 5458.4541545845095, 5516.80691175823, 5516.834494965157, 5517.117261238182, 5521.779128834802], "value": 4162.651717767243, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.6369110981175, 750.4409215134725, 753.1827966656181, 780.1730166024015, 819.2503858969044, 14275.143491390523, 15062.924685376558, 15108.622284442894, 15125.697486050272, 15127.92436037821, 15492.535223943272, 15572.922135389335, 15617.21913904306, 15643.217839108056, 15649.687006259897, 655.6688872119573, 775.1821827971488, 793.4564823096168, 795.0141824138085, 797.2466019611484, 804.4368941740776, 806.0770417871533, 806.209914284002, 806.2622700229283, 807.1807115777461, 843.3801156150255, 848.5333066813259, 849.4223927729141, 850.6172222499869, 850.6469815026757, 674.1707699529582, 811.0672726364669, 834.8163404051099, 840.8360369727906, 840.9915900840974, 625.2340882419046, 626.2829060725489, 626.3110578363809, 626.5081910700125, 626.6177631644694, 13622.0, 13646.454141834414, 13693.246871422069, 13721.039527233097, 13779.517716879862, 12777.872221277761, 13080.328653478018, 13873.098248613807, 13874.722505549833, 14257.28713564328, 12310.384480775925, 12447.502099915993, 12478.563250286197, 12546.121771476, 13212.405441755143, 4283.892902677427, 4300.65594752419, 4306.246406878784, 4534.750588717619, 4556.179887620227, 67297.66351168213, 68370.9999999995, 69427.61144777076, 80397.19602803956, 82100.20048095421, 10381.169506439466, 10544.209184311207, 10796.78406431867, 10921.453927303603, 10961.780764384826, 21241.0, 21509.13963441476, 21515.354539363845, 21516.13935442596, 21623.67564486534, 8052.235037671412, 8080.676772929017, 8141.715039973573, 8272.0, 8275.213854683796, 4432.977835110868, 4482.238019536687, 4570.634349252118, 4624.930626040612, 4685.109829132454, 3494.0915362006062, 3630.146915474861, 3637.381645120336, 3637.5998640149564, 3638.5633723953297, 593.4243783529969, 596.1683451585014, 608.5527137553894, 611.4191518057863, 613.4264462727275, 617.8146556033172, 663.8406782372195, 669.1167658690579, 690.689189864563, 712.3909057755648, 9127.406718563272, 9151.0, 9444.291678124031, 9467.242620590336, 9608.855867161998, 699.433458898294, 709.8473828126978, 724.7861880745193, 732.3226015935345, 741.9332260096617, 4410.977945110254, 4527.3999434694515, 4606.100373816926, 4607.631389488833, 4612.469565999886, 96553.0, 126422.0, 130114.0, 131735.0, 132893.0, 108149.0, 109543.45228273807, 109851.45074274577, 111719.44140279246, 114505.53405921013, 93549.06450935539, 95046.52476737573, 95510.0, 96272.0, 100822.0, 8411.621477033426, 8463.280621147025, 8559.57202139878, 8719.651213951625, 8907.55462226899, 56166.719166403906, 56637.0, 57308.426915730306, 57501.137482938626, 57536.42463575311, 77330.61334693516, 80564.59717701374, 84451.5777421109, 84865.0, 87743.56128219319, 10660.25378223517, 10762.19283553721, 11110.333379997226, 11176.105911526896, 11372.43137843088, 12009.879901201226, 12166.756664866476, 12323.137380383287, 12328.32194229326, 12546.121771476273, 11493.82759258595, 11820.70448238801, 11924.701882453008, 12422.006239500637, 12574.811377829157, 11542.856007391772, 11881.108916831445, 11901.0, 12077.939610301892, 12502.312372819582, 11392.829107563559, 11456.94271528637, 11513.36676482768, 11697.532098715956, 12095.758084838079, 9484.905150948678, 9726.854097188407, 9967.505930665937, 10209.438480883622, 10338.570435947397, 9892.0, 10095.848562271425, 10132.964016519632, 10218.386896786216, 10305.433201174008], "value": 7370.709750464008, "unit": "score"}], "name": "dromaeo_css", "value": 7241.749683336207, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 127.0, 111.0, 110.0, 112.0, 113.0, 111.0, 109.0, 111.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 122.0, 141.0, 183.0, 118.0, 157.0, 152.0, 121.0, 187.0, 120.0], "value": 146.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 161.0, 162.0, 162.0, 162.0, 163.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 171.0, 76.0, 76.0, 75.0, 75.0, 168.0, 75.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 147.0, 83.0, 83.0, 82.0, 157.0, 83.0, 82.0, 140.0], "value": 102.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 94.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 52.0, 52.0, 52.0, 53.0, 52.0, 54.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 63.0, 64.0, 67.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 87.0, 78.0, 79.0, 80.0, 79.0, 79.0, 78.0, 78.0, 77.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 124.0, 124.0, 125.0, 133.0, 121.0, 124.0, 123.0, 161.0, 122.0], "value": 129.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 164.0, 166.0, 167.0, 163.0, 161.0, 165.0, 166.0], "value": 163.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 66.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1526.9000000000003, "alertThreshold": 2.0}]} 09:39:56 INFO - Return code: 0 09:39:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:39:56 INFO - # TBPL SUCCESS # 09:39:56 INFO - Running post-action listener: _resource_record_post_action 09:39:56 INFO - [mozharness: 2016-09-01 16:39:56.937522Z] Finished run-tests step (success) 09:39:56 INFO - Running post-run listener: _resource_record_post_run 09:39:57 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 422690816; Read time: 20; Write time: 283292 09:39:57 INFO - TinderboxPrint: CPU usage
13.1% 09:39:57 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 09:39:57 INFO - TinderboxPrint: I/O write bytes / time
422,690,816 / 283,292 09:39:57 INFO - TinderboxPrint: CPU idle
8,293.8 (86.9%) 09:39:57 INFO - TinderboxPrint: CPU user
1,199.4 (12.6%) 09:39:57 INFO - TinderboxPrint: Swap in / out
0 / 0 09:39:57 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 126046208; Read time: 0; Write time: 99624 09:39:57 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 289095680; Read time: 0; Write time: 182360 09:39:57 INFO - Running post-run listener: _upload_blobber_files 09:39:57 INFO - Blob upload gear active. 09:39:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:39:57 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 09:39:57 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'] 09:39:57 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 09:39:57 INFO - (blobuploader) - INFO - Open directory for files ... 09:39:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:39:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:40:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:40:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:40:01 INFO - (blobuploader) - INFO - Done attempting. 09:40:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:40:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:40:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:40:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:40:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:40:02 INFO - (blobuploader) - INFO - Done attempting. 09:40:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:40:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:40:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:40:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:40:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:40:03 INFO - (blobuploader) - INFO - Done attempting. 09:40:03 INFO - (blobuploader) - INFO - Iteration through files over. 09:40:03 INFO - Return code: 0 09:40:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:40:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:40:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/508546fb1cba36114a68eed87034e68711df9932454e082b206cf369e66e936bd72f75c3e3fe654c64e2dca0e7f7549d0888bfce6fe02d07d41a145cf1b0ea2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/875cb3e583f5f4ea5c7a68a2e5d6ecc1225557c15b051ca55f9253550f93841d9beb62618a6c6020e125750419771915b3bcfec73a19e0e9974fb65ab18de49f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d41b9201b4740c930be394ddcb0a9848a5ae40451e0990176a05cd9e5c9840e466d767dc629f722ce3b6be4d9b08ad50adea8a5713fc587fee73426715b3af90"} 09:40:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:40:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:40:03 INFO - Contents: 09:40:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/508546fb1cba36114a68eed87034e68711df9932454e082b206cf369e66e936bd72f75c3e3fe654c64e2dca0e7f7549d0888bfce6fe02d07d41a145cf1b0ea2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/875cb3e583f5f4ea5c7a68a2e5d6ecc1225557c15b051ca55f9253550f93841d9beb62618a6c6020e125750419771915b3bcfec73a19e0e9974fb65ab18de49f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d41b9201b4740c930be394ddcb0a9848a5ae40451e0990176a05cd9e5c9840e466d767dc629f722ce3b6be4d9b08ad50adea8a5713fc587fee73426715b3af90"} 09:40:03 INFO - Running post-run listener: copy_logs_to_upload_dir 09:40:03 INFO - Copying logs to upload dir... 09:40:03 INFO - mkdir: /builds/slave/test/build/upload/logs 09:40:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.035302 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-09-01 09:40:02.792198) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 09:40:02.797909) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/508546fb1cba36114a68eed87034e68711df9932454e082b206cf369e66e936bd72f75c3e3fe654c64e2dca0e7f7549d0888bfce6fe02d07d41a145cf1b0ea2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/875cb3e583f5f4ea5c7a68a2e5d6ecc1225557c15b051ca55f9253550f93841d9beb62618a6c6020e125750419771915b3bcfec73a19e0e9974fb65ab18de49f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d41b9201b4740c930be394ddcb0a9848a5ae40451e0990176a05cd9e5c9840e466d767dc629f722ce3b6be4d9b08ad50adea8a5713fc587fee73426715b3af90"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011238 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/508546fb1cba36114a68eed87034e68711df9932454e082b206cf369e66e936bd72f75c3e3fe654c64e2dca0e7f7549d0888bfce6fe02d07d41a145cf1b0ea2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/875cb3e583f5f4ea5c7a68a2e5d6ecc1225557c15b051ca55f9253550f93841d9beb62618a6c6020e125750419771915b3bcfec73a19e0e9974fb65ab18de49f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d41b9201b4740c930be394ddcb0a9848a5ae40451e0990176a05cd9e5c9840e466d767dc629f722ce3b6be4d9b08ad50adea8a5713fc587fee73426715b3af90"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 09:40:02.823822) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:40:02.824173) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1472746765.468624-158846277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:40:02.911246) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 09:40:02.911682) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 09:40:02.912182) ========= ========= Total master_lag: 0.18 =========