builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-057 starttime: 1471885168.54 results: success (0) buildid: 20160822083415 builduid: 9d113c52882747508773e1dbede12a3b revision: 3b7148db9a79bb17fd85df31690c98ffb5c8a541 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 09:59:28.540334) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 09:59:28.540783) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 09:59:28.541129) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 09:59:28.556267) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:59:28.556594) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-22 09:59:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 102M=0s 2016-08-22 09:59:30 (102 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126630 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:59:28.696462) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:59:28.696749) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018876 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:59:28.746273) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:59:28.746622) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3b7148db9a79bb17fd85df31690c98ffb5c8a541 --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 3b7148db9a79bb17fd85df31690c98ffb5c8a541 --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=934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-22 09:59:30,177 truncating revision to first 12 chars 2016-08-22 09:59:30,177 Setting DEBUG logging. 2016-08-22 09:59:30,177 attempt 1/10 2016-08-22 09:59:30,177 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3b7148db9a79?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 09:59:30,479 unpacking tar archive at: fx-team-3b7148db9a79/testing/mozharness/ program finished with exit code 0 elapsedTime=0.616654 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:59:29.376887) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 09:59:29.377190) ========= script_repo_revision: 3b7148db9a79bb17fd85df31690c98ffb5c8a541 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 09:59:29.377577) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 09:59:29.377855) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 09:59:29.385877) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-22 09:59:29.386183) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:59:30 INFO - MultiFileLogger online at 20160822 09:59:30 in /builds/slave/test 09:59:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:59:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:59:30 INFO - {'append_to_log': False, 09:59:30 INFO - 'base_work_dir': '/builds/slave/test', 09:59:30 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:59:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:59:30 INFO - 'branch': 'Fx-Team-Non-PGO', 09:59:30 INFO - 'buildbot_json_path': 'buildprops.json', 09:59:30 INFO - 'config_files': ('talos/linux_config.py',), 09:59:30 INFO - 'default_actions': ('clobber', 09:59:30 INFO - 'read-buildbot-config', 09:59:30 INFO - 'download-and-extract', 09:59:30 INFO - 'populate-webroot', 09:59:30 INFO - 'create-virtualenv', 09:59:30 INFO - 'install', 09:59:30 INFO - 'run-tests'), 09:59:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:59:30 INFO - 'download_minidump_stackwalk': True, 09:59:30 INFO - 'download_symbols': 'ondemand', 09:59:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:59:30 INFO - 'tooltool.py': '/tools/tooltool.py', 09:59:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:59:30 INFO - '/tools/misc-python/virtualenv.py')}, 09:59:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:59:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:59:30 INFO - 'installer_path': 'installer.exe', 09:59:30 INFO - 'log_level': 'info', 09:59:30 INFO - 'log_name': 'talos', 09:59:30 INFO - 'log_to_console': True, 09:59:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:59:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:59:30 INFO - 'opt_config_files': (), 09:59:30 INFO - 'pip_index': False, 09:59:30 INFO - 'sps_profile': False, 09:59:30 INFO - 'sps_profile_interval': 0, 09:59:30 INFO - 'suite': 'dromaeojs', 09:59:30 INFO - 'system_bits': '32', 09:59:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:59:30 INFO - 'title': 'talos-linux64-ix-057', 09:59:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:59:30 INFO - 'use_talos_json': True, 09:59:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:59:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:59:30 INFO - 'work_dir': 'build'} 09:59:30 INFO - [mozharness: 2016-08-22 16:59:30.906272Z] Running clobber step. 09:59:30 INFO - Running pre-action listener: _resource_record_pre_action 09:59:30 INFO - Running main action method: clobber 09:59:30 INFO - rmtree: /builds/slave/test/build 09:59:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:59:31 INFO - Running post-action listener: _resource_record_post_action 09:59:31 INFO - [mozharness: 2016-08-22 16:59:31.874250Z] Finished clobber step (success) 09:59:31 INFO - [mozharness: 2016-08-22 16:59:31.874350Z] Running read-buildbot-config step. 09:59:31 INFO - Running pre-action listener: _resource_record_pre_action 09:59:31 INFO - Running main action method: read_buildbot_config 09:59:31 INFO - Using buildbot properties: 09:59:31 INFO - { 09:59:31 INFO - "project": "", 09:59:31 INFO - "product": "firefox", 09:59:31 INFO - "script_repo_revision": "production", 09:59:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:59:31 INFO - "repository": "", 09:59:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:59:31 INFO - "buildid": "20160822083415", 09:59:31 INFO - "pgo_build": "False", 09:59:31 INFO - "basedir": "/builds/slave/test", 09:59:31 INFO - "buildnumber": 3253, 09:59:31 INFO - "slavename": "talos-linux64-ix-057", 09:59:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:59:31 INFO - "platform": "ubuntu64_hw", 09:59:31 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:59:31 INFO - "branch": "fx-team", 09:59:31 INFO - "repo_path": "integration/fx-team", 09:59:31 INFO - "revision": "3b7148db9a79bb17fd85df31690c98ffb5c8a541", 09:59:31 INFO - "stage_platform": "linux64", 09:59:31 INFO - "builduid": "9d113c52882747508773e1dbede12a3b", 09:59:31 INFO - "slavebuilddir": "test" 09:59:31 INFO - } 09:59:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/DunxWiY3RMizgnIHsUPPaw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 09:59:31 INFO - Running post-action listener: _resource_record_post_action 09:59:31 INFO - [mozharness: 2016-08-22 16:59:31.876787Z] Finished read-buildbot-config step (success) 09:59:31 INFO - [mozharness: 2016-08-22 16:59:31.876875Z] Running download-and-extract step. 09:59:31 INFO - Running pre-action listener: _resource_record_pre_action 09:59:31 INFO - Running main action method: download_and_extract 09:59:31 INFO - mkdir: /builds/slave/test/build/tests 09:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:31 INFO - trying https://queue.taskcluster.net/v1/task/DunxWiY3RMizgnIHsUPPaw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:59:31 INFO - Downloading https://queue.taskcluster.net/v1/task/DunxWiY3RMizgnIHsUPPaw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:59:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DunxWiY3RMizgnIHsUPPaw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:59:32 INFO - Downloaded 1361 bytes. 09:59:32 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:59:32 INFO - Using the following test package requirements: 09:59:32 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:59:32 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:59:32 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:59:32 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:32 INFO - u'jsshell-linux-x86_64.zip'], 09:59:32 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:59:32 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:59:32 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:59:32 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:59:32 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:59:32 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:59:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:59: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:59:32 INFO - trying https://queue.taskcluster.net/v1/task/DunxWiY3RMizgnIHsUPPaw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:59:32 INFO - Downloading https://queue.taskcluster.net/v1/task/DunxWiY3RMizgnIHsUPPaw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:59:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DunxWiY3RMizgnIHsUPPaw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:59:33 INFO - Downloaded 20330904 bytes. 09:59:33 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:59:37 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:59: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:59:37 INFO - trying https://queue.taskcluster.net/v1/task/DunxWiY3RMizgnIHsUPPaw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:59:37 INFO - Downloading https://queue.taskcluster.net/v1/task/DunxWiY3RMizgnIHsUPPaw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:59:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DunxWiY3RMizgnIHsUPPaw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:59:38 INFO - Downloaded 20330904 bytes. 09:59:38 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:59:42 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:59:42 INFO - trying https://queue.taskcluster.net/v1/task/DunxWiY3RMizgnIHsUPPaw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 09:59:42 INFO - Downloading https://queue.taskcluster.net/v1/task/DunxWiY3RMizgnIHsUPPaw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 09:59:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DunxWiY3RMizgnIHsUPPaw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:59:43 INFO - Downloaded 14413981 bytes. 09:59:43 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:59:43 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:59:43 INFO - trying https://queue.taskcluster.net/v1/task/DunxWiY3RMizgnIHsUPPaw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:59:43 INFO - Downloading https://queue.taskcluster.net/v1/task/DunxWiY3RMizgnIHsUPPaw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:59:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DunxWiY3RMizgnIHsUPPaw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:59:44 INFO - Downloaded 55764686 bytes. 09:59:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DunxWiY3RMizgnIHsUPPaw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:59:44 INFO - mkdir: /builds/slave/test/properties 09:59:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:59:44 INFO - Writing to file /builds/slave/test/properties/build_url 09:59:44 INFO - Contents: 09:59:44 INFO - build_url:https://queue.taskcluster.net/v1/task/DunxWiY3RMizgnIHsUPPaw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:59:45 INFO - Running post-action listener: _resource_record_post_action 09:59:45 INFO - Running post-action listener: set_extra_try_arguments 09:59:45 INFO - [mozharness: 2016-08-22 16:59:45.651867Z] Finished download-and-extract step (success) 09:59:45 INFO - [mozharness: 2016-08-22 16:59:45.652091Z] Running populate-webroot step. 09:59:45 INFO - Running pre-action listener: _resource_record_pre_action 09:59:45 INFO - Running main action method: populate_webroot 09:59:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:59:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:59:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:59:45 INFO - '--tppagecycles', 09:59:45 INFO - '7'], 09:59:45 INFO - 'tests': ['tsvgm']}}, 09:59:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:59:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:59:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:59:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:59:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:59:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:59:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:45 INFO - 'talos_options': ['--disable-e10s'], 09:59:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:59:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:59:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:45 INFO - 'talos_options': ['--disable-e10s'], 09:59:45 INFO - 'tests': ['damp', 'tps']}, 09:59:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:45 INFO - 'tests': ['damp', 'tps']}, 09:59:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:59:45 INFO - 'tests': ['dromaeo_dom']}, 09:59:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:59:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:59:45 INFO - 'tests': ['basic_compositor_video']}, 09:59:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:59:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:59:45 INFO - 'tests': ['a11yr', 09:59:45 INFO - 'ts_paint', 09:59:45 INFO - 'tpaint', 09:59:45 INFO - 'sessionrestore', 09:59:45 INFO - 'sessionrestore_no_auto_restore', 09:59:45 INFO - 'tabpaint']}, 09:59:45 INFO - 'other-e10s': {'tests': ['a11yr', 09:59:45 INFO - 'ts_paint', 09:59:45 INFO - 'tpaint', 09:59:45 INFO - 'sessionrestore', 09:59:45 INFO - 'sessionrestore_no_auto_restore', 09:59:45 INFO - 'tabpaint']}, 09:59:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:59:45 INFO - 'ts_paint', 09:59:45 INFO - 'tpaint', 09:59:45 INFO - 'sessionrestore', 09:59:45 INFO - 'sessionrestore_no_auto_restore', 09:59:45 INFO - 'tabpaint']}, 09:59:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:59:45 INFO - 'ts_paint', 09:59:45 INFO - 'tpaint', 09:59:45 INFO - 'sessionrestore', 09:59:45 INFO - 'sessionrestore_no_auto_restore', 09:59:45 INFO - 'tabpaint']}, 09:59:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:59:45 INFO - 'tests': ['a11yr', 09:59:45 INFO - 'ts_paint', 09:59:45 INFO - 'tpaint', 09:59:45 INFO - 'sessionrestore', 09:59:45 INFO - 'sessionrestore_no_auto_restore', 09:59:45 INFO - 'tabpaint']}, 09:59:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:59:45 INFO - 'tests': ['a11yr', 09:59:45 INFO - 'ts_paint', 09:59:45 INFO - 'tpaint', 09:59:45 INFO - 'sessionrestore', 09:59:45 INFO - 'sessionrestore_no_auto_restore', 09:59:45 INFO - 'tabpaint']}, 09:59:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:59:45 INFO - 'tests': ['tsvgx', 09:59:45 INFO - 'tsvgr_opacity', 09:59:45 INFO - 'tart', 09:59:45 INFO - 'tscrollx', 09:59:45 INFO - 'cart']}, 09:59:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:59:45 INFO - 'tsvgr_opacity', 09:59:45 INFO - 'tart', 09:59:45 INFO - 'tscrollx', 09:59:45 INFO - 'cart']}, 09:59:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:45 INFO - 'talos_options': ['--disable-e10s'], 09:59:45 INFO - 'tests': ['tp5o']}, 09:59:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:45 INFO - 'tests': ['tp5o']}, 09:59:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:45 INFO - 'talos_options': ['--disable-e10s', 09:59:45 INFO - '--xperf_path', 09:59:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:59:45 INFO - 'tests': ['tp5n']}, 09:59:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:45 INFO - 'talos_options': ['--xperf_path', 09:59:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:59:45 INFO - 'tests': ['tp5n']}}, 09:59:45 INFO - 'talos.zip': {'path': '', 09:59:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:59:45 INFO - Running post-action listener: _resource_record_post_action 09:59:45 INFO - [mozharness: 2016-08-22 16:59:45.673218Z] Finished populate-webroot step (success) 09:59:45 INFO - [mozharness: 2016-08-22 16:59:45.673305Z] Running create-virtualenv step. 09:59:45 INFO - Running pre-action listener: _resource_record_pre_action 09:59:45 INFO - Running main action method: create_virtualenv 09:59:45 INFO - Creating virtualenv /builds/slave/test/build/venv 09:59:45 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:59:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:59:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:59:45 INFO - Using real prefix '/usr' 09:59:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:59:46 INFO - Installing distribute.............................................................................................................................................................................................done. 09:59:48 INFO - Installing pip.................done. 09:59:48 INFO - Return code: 0 09:59:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:48 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 0x7fce9a4f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ada230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4090>, '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 0x2ad79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7e40>, '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': '934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177', '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:59:48 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:59:48 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:59:48 INFO - Using env: {'DISPLAY': ':0', 09:59:48 INFO - 'HOME': '/home/cltbld', 09:59:48 INFO - 'LANG': 'en_US.UTF-8', 09:59:48 INFO - 'LANGUAGE': 'en_US:en', 09:59:48 INFO - 'LOGNAME': 'cltbld', 09:59:48 INFO - 'MAIL': '/var/mail/cltbld', 09:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:48 INFO - 'MOZ_NO_REMOTE': '1', 09:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:48 INFO - 'NO_EM_RESTART': '1', 09:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:48 INFO - 'PWD': '/builds/slave/test', 09:59:48 INFO - 'SHELL': '/bin/bash', 09:59:48 INFO - 'SHLVL': '1', 09:59:48 INFO - 'TERM': 'linux', 09:59:48 INFO - 'TMOUT': '86400', 09:59:48 INFO - 'USER': 'cltbld', 09:59:48 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177', 09:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:48 INFO - '_': '/tools/buildbot/bin/python'} 09:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:48 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:59:48 INFO - Cleaning up... 09:59:48 INFO - Return code: 0 09:59:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:48 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 0x7fce9a4f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ada230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4090>, '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 0x2ad79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7e40>, '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': '934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177', '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:59:48 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:59:48 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:59:48 INFO - Using env: {'DISPLAY': ':0', 09:59:48 INFO - 'HOME': '/home/cltbld', 09:59:48 INFO - 'LANG': 'en_US.UTF-8', 09:59:48 INFO - 'LANGUAGE': 'en_US:en', 09:59:48 INFO - 'LOGNAME': 'cltbld', 09:59:48 INFO - 'MAIL': '/var/mail/cltbld', 09:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:48 INFO - 'MOZ_NO_REMOTE': '1', 09:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:48 INFO - 'NO_EM_RESTART': '1', 09:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:48 INFO - 'PWD': '/builds/slave/test', 09:59:48 INFO - 'SHELL': '/bin/bash', 09:59:48 INFO - 'SHLVL': '1', 09:59:48 INFO - 'TERM': 'linux', 09:59:48 INFO - 'TMOUT': '86400', 09:59:48 INFO - 'USER': 'cltbld', 09:59:48 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177', 09:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:48 INFO - '_': '/tools/buildbot/bin/python'} 09:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:48 INFO - Downloading/unpacking psutil>=3.1.1 09:59: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:59: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:59: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:59: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:59: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:59: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:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:59:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:59:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:59:50 INFO - Installing collected packages: psutil 09:59:50 INFO - Running setup.py install for psutil 09:59:50 INFO - building 'psutil._psutil_linux' extension 09:59:50 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:59:50 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:59:50 INFO - building 'psutil._psutil_posix' extension 09:59:50 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:59:51 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:59:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:59:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:59:51 INFO - Successfully installed psutil 09:59:51 INFO - Cleaning up... 09:59:51 INFO - Return code: 0 09:59:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:51 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 0x7fce9a4f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ada230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4090>, '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 0x2ad79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7e40>, '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': '934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177', '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:59:51 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:59:51 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:59:51 INFO - Using env: {'DISPLAY': ':0', 09:59:51 INFO - 'HOME': '/home/cltbld', 09:59:51 INFO - 'LANG': 'en_US.UTF-8', 09:59:51 INFO - 'LANGUAGE': 'en_US:en', 09:59:51 INFO - 'LOGNAME': 'cltbld', 09:59:51 INFO - 'MAIL': '/var/mail/cltbld', 09:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:51 INFO - 'MOZ_NO_REMOTE': '1', 09:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:51 INFO - 'NO_EM_RESTART': '1', 09:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:51 INFO - 'PWD': '/builds/slave/test', 09:59:51 INFO - 'SHELL': '/bin/bash', 09:59:51 INFO - 'SHLVL': '1', 09:59:51 INFO - 'TERM': 'linux', 09:59:51 INFO - 'TMOUT': '86400', 09:59:51 INFO - 'USER': 'cltbld', 09:59:51 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177', 09:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:51 INFO - '_': '/tools/buildbot/bin/python'} 09:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:59: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:59: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:59: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:59: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:59: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:59: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:59:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:59:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:59:53 INFO - Installing collected packages: mozsystemmonitor 09:59:53 INFO - Running setup.py install for mozsystemmonitor 09:59:53 INFO - Successfully installed mozsystemmonitor 09:59:53 INFO - Cleaning up... 09:59:53 INFO - Return code: 0 09:59:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:53 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 0x7fce9a4f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ada230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4090>, '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 0x2ad79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7e40>, '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': '934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177', '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:59:53 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:59:53 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:59:53 INFO - Using env: {'DISPLAY': ':0', 09:59:53 INFO - 'HOME': '/home/cltbld', 09:59:53 INFO - 'LANG': 'en_US.UTF-8', 09:59:53 INFO - 'LANGUAGE': 'en_US:en', 09:59:53 INFO - 'LOGNAME': 'cltbld', 09:59:53 INFO - 'MAIL': '/var/mail/cltbld', 09:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:53 INFO - 'MOZ_NO_REMOTE': '1', 09:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:53 INFO - 'NO_EM_RESTART': '1', 09:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:53 INFO - 'PWD': '/builds/slave/test', 09:59:53 INFO - 'SHELL': '/bin/bash', 09:59:53 INFO - 'SHLVL': '1', 09:59:53 INFO - 'TERM': 'linux', 09:59:53 INFO - 'TMOUT': '86400', 09:59:53 INFO - 'USER': 'cltbld', 09:59:53 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177', 09:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:53 INFO - '_': '/tools/buildbot/bin/python'} 09:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:53 INFO - Downloading/unpacking jsonschema==2.5.1 09:59:53 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:59:53 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:59:53 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:59:53 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:59:53 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:59:53 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:59:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:59:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:59:55 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:59:55 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:59:55 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:59:55 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:59:55 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:59:55 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:59:55 INFO - Downloading functools32-3.2.3-2.tar.gz 09:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:59:55 INFO - warning: no files found matching '*.txt' 09:59:55 INFO - no previously-included directories found matching 'build' 09:59:55 INFO - no previously-included directories found matching 'dist' 09:59:55 INFO - no previously-included directories found matching '.git*' 09:59:55 INFO - Installing collected packages: jsonschema, functools32 09:59:55 INFO - Running setup.py install for functools32 09:59:56 INFO - warning: no files found matching '*.txt' 09:59:56 INFO - no previously-included directories found matching 'build' 09:59:56 INFO - no previously-included directories found matching 'dist' 09:59:56 INFO - no previously-included directories found matching '.git*' 09:59:56 INFO - Successfully installed jsonschema functools32 09:59:56 INFO - Cleaning up... 09:59:56 INFO - Return code: 0 09:59:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:59: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:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59: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:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:56 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 0x7fce9a4f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ada230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4090>, '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 0x2ad79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7e40>, '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': '934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177', '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:59:56 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:59:56 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:59:56 INFO - Using env: {'DISPLAY': ':0', 09:59:56 INFO - 'HOME': '/home/cltbld', 09:59:56 INFO - 'LANG': 'en_US.UTF-8', 09:59:56 INFO - 'LANGUAGE': 'en_US:en', 09:59:56 INFO - 'LOGNAME': 'cltbld', 09:59:56 INFO - 'MAIL': '/var/mail/cltbld', 09:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:56 INFO - 'MOZ_NO_REMOTE': '1', 09:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:56 INFO - 'NO_EM_RESTART': '1', 09:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:56 INFO - 'PWD': '/builds/slave/test', 09:59:56 INFO - 'SHELL': '/bin/bash', 09:59:56 INFO - 'SHLVL': '1', 09:59:56 INFO - 'TERM': 'linux', 09:59:56 INFO - 'TMOUT': '86400', 09:59:56 INFO - 'USER': 'cltbld', 09:59:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177', 09:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:56 INFO - '_': '/tools/buildbot/bin/python'} 09:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:59:56 INFO - Cleaning up... 09:59:56 INFO - Return code: 0 09:59:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:59: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:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59: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:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:56 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 0x7fce9a4f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ada230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4090>, '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 0x2ad79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7e40>, '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': '934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177', '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:59:56 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:59:56 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:59:56 INFO - Using env: {'DISPLAY': ':0', 09:59:56 INFO - 'HOME': '/home/cltbld', 09:59:56 INFO - 'LANG': 'en_US.UTF-8', 09:59:56 INFO - 'LANGUAGE': 'en_US:en', 09:59:56 INFO - 'LOGNAME': 'cltbld', 09:59:56 INFO - 'MAIL': '/var/mail/cltbld', 09:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:56 INFO - 'MOZ_NO_REMOTE': '1', 09:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:56 INFO - 'NO_EM_RESTART': '1', 09:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:56 INFO - 'PWD': '/builds/slave/test', 09:59:56 INFO - 'SHELL': '/bin/bash', 09:59:56 INFO - 'SHLVL': '1', 09:59:56 INFO - 'TERM': 'linux', 09:59:56 INFO - 'TMOUT': '86400', 09:59:56 INFO - 'USER': 'cltbld', 09:59:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177', 09:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:56 INFO - '_': '/tools/buildbot/bin/python'} 09:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:56 INFO - Downloading/unpacking blobuploader==1.2.4 09:59:56 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:59:56 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:59:56 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:59:56 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:59:56 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:59:56 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:59:58 INFO - Downloading blobuploader-1.2.4.tar.gz 09:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:59:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:59:58 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:59:58 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:59:58 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:59:58 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:59:58 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:59:58 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:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:59:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:59:58 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:59:58 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:59:58 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:59:58 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:59:58 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:59:58 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:59:59 INFO - Downloading docopt-0.6.1.tar.gz 09:59:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:59:59 INFO - Installing collected packages: blobuploader, requests, docopt 09:59:59 INFO - Running setup.py install for blobuploader 09:59:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:59:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:59:59 INFO - Running setup.py install for requests 09:59:59 INFO - Running setup.py install for docopt 09:59:59 INFO - Successfully installed blobuploader requests docopt 09:59:59 INFO - Cleaning up... 09:59:59 INFO - Return code: 0 09:59:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:59 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 0x7fce9a4f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ada230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4090>, '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 0x2ad79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7e40>, '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': '934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177', '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:59:59 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:59:59 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:59:59 INFO - Using env: {'DISPLAY': ':0', 09:59:59 INFO - 'HOME': '/home/cltbld', 09:59:59 INFO - 'LANG': 'en_US.UTF-8', 09:59:59 INFO - 'LANGUAGE': 'en_US:en', 09:59:59 INFO - 'LOGNAME': 'cltbld', 09:59:59 INFO - 'MAIL': '/var/mail/cltbld', 09:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:59 INFO - 'MOZ_NO_REMOTE': '1', 09:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:59 INFO - 'NO_EM_RESTART': '1', 09:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:59 INFO - 'PWD': '/builds/slave/test', 09:59:59 INFO - 'SHELL': '/bin/bash', 09:59:59 INFO - 'SHLVL': '1', 09:59:59 INFO - 'TERM': 'linux', 09:59:59 INFO - 'TMOUT': '86400', 09:59:59 INFO - 'USER': 'cltbld', 09:59:59 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177', 09:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:59 INFO - '_': '/tools/buildbot/bin/python'} 09:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:59:59 INFO - Running setup.py (path:/tmp/pip-oQJW6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:00:00 INFO - Running setup.py (path:/tmp/pip-SFSTkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:00:00 INFO - Running setup.py (path:/tmp/pip-YWkQrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:00:00 INFO - Running setup.py (path:/tmp/pip-FJFT2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:00:00 INFO - Running setup.py (path:/tmp/pip-ItsjTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:00:00 INFO - Running setup.py (path:/tmp/pip-epLiVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:00:00 INFO - Running setup.py (path:/tmp/pip-0nP5u9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:00:00 INFO - Running setup.py (path:/tmp/pip-PyS0yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:00:00 INFO - Running setup.py (path:/tmp/pip-P6mUJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:00:00 INFO - Running setup.py (path:/tmp/pip-qXDxgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:00:00 INFO - Running setup.py (path:/tmp/pip-xtJwep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:00:00 INFO - Running setup.py (path:/tmp/pip-QvHyLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:00:00 INFO - Running setup.py (path:/tmp/pip-O6Jg20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:00:00 INFO - Running setup.py (path:/tmp/pip-0c2CC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:01 INFO - Running setup.py (path:/tmp/pip-lzjEGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:00:01 INFO - Running setup.py (path:/tmp/pip-eaD23n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:00:01 INFO - Running setup.py (path:/tmp/pip-niGNL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:00:01 INFO - Running setup.py install for manifestparser 10:00:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:00:01 INFO - Running setup.py install for mozcrash 10:00:01 INFO - Running setup.py install for mozdebug 10:00:01 INFO - Running setup.py install for mozdevice 10:00:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:00:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:00:01 INFO - Running setup.py install for mozfile 10:00:01 INFO - Running setup.py install for mozhttpd 10:00:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:00:01 INFO - Running setup.py install for mozinfo 10:00:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:00:01 INFO - Running setup.py install for mozInstall 10:00:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:00:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:00:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:00:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:00:02 INFO - Running setup.py install for mozleak 10:00:02 INFO - Running setup.py install for mozlog 10:00:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:00:02 INFO - Running setup.py install for moznetwork 10:00:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:00:02 INFO - Running setup.py install for mozprocess 10:00:02 INFO - Running setup.py install for mozprofile 10:00:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:00:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:00:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:00:02 INFO - Running setup.py install for mozrunner 10:00:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:00:02 INFO - Running setup.py install for mozscreenshot 10:00:02 INFO - Running setup.py install for moztest 10:00:02 INFO - Running setup.py install for mozversion 10:00:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:00:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:00:03 INFO - Cleaning up... 10:00:03 INFO - Return code: 0 10:00:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:03 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')]} 10:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:03 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')]} 10:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:03 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 0x7fce9a4f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ada230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4090>, '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 0x2ad79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7e40>, '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': '934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177', '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 10:00:03 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 10:00:03 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 10:00:03 INFO - Using env: {'DISPLAY': ':0', 10:00:03 INFO - 'HOME': '/home/cltbld', 10:00:03 INFO - 'LANG': 'en_US.UTF-8', 10:00:03 INFO - 'LANGUAGE': 'en_US:en', 10:00:03 INFO - 'LOGNAME': 'cltbld', 10:00:03 INFO - 'MAIL': '/var/mail/cltbld', 10:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:03 INFO - 'MOZ_NO_REMOTE': '1', 10:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:03 INFO - 'NO_EM_RESTART': '1', 10:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:03 INFO - 'PWD': '/builds/slave/test', 10:00:03 INFO - 'SHELL': '/bin/bash', 10:00:03 INFO - 'SHLVL': '1', 10:00:03 INFO - 'TERM': 'linux', 10:00:03 INFO - 'TMOUT': '86400', 10:00:03 INFO - 'USER': 'cltbld', 10:00:03 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177', 10:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:03 INFO - '_': '/tools/buildbot/bin/python'} 10:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:00:03 INFO - Running setup.py (path:/tmp/pip-np6s5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:00:03 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)) 10:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:00:03 INFO - Running setup.py (path:/tmp/pip-KDVftp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:00:03 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)) 10:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:00:03 INFO - Running setup.py (path:/tmp/pip-0vJTyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:00:03 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)) 10:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:00:03 INFO - Running setup.py (path:/tmp/pip-mlYJif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:00:03 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)) 10:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:00:03 INFO - Running setup.py (path:/tmp/pip-vVhtBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:00:03 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)) 10:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:00:03 INFO - Running setup.py (path:/tmp/pip-6G7RG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:00:03 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)) 10:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:00:03 INFO - Running setup.py (path:/tmp/pip-ouRU7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:00:03 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)) 10:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:00:03 INFO - Running setup.py (path:/tmp/pip-zSWDs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:00:03 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)) 10:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:00:03 INFO - Running setup.py (path:/tmp/pip-EBUZmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:00:03 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)) 10:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:00:03 INFO - Running setup.py (path:/tmp/pip-8MCxOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:00:03 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)) 10:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:00:03 INFO - Running setup.py (path:/tmp/pip-pJgiGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:00:04 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)) 10:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:00:04 INFO - Running setup.py (path:/tmp/pip-oJxLgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:00:04 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)) 10:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:00:04 INFO - Running setup.py (path:/tmp/pip-FXfMlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:00:04 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)) 10:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:00:04 INFO - Running setup.py (path:/tmp/pip-K30JqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:00:04 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)) 10:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:04 INFO - Running setup.py (path:/tmp/pip-Isfzdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:04 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)) 10:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:00:04 INFO - Running setup.py (path:/tmp/pip-zoapsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:00:04 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)) 10:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:00:04 INFO - Running setup.py (path:/tmp/pip-BsgNyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:04 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)) 10:00:04 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)) 10:00:04 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)) 10:00:04 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)) 10:00:04 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)) 10:00:04 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)) 10:00:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:06 INFO - Downloading blessings-1.6.tar.gz 10:00:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:00:06 INFO - Installing collected packages: blessings 10:00:06 INFO - Running setup.py install for blessings 10:00:06 INFO - Successfully installed blessings 10:00:06 INFO - Cleaning up... 10:00:06 INFO - Return code: 0 10:00:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:00:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:06 INFO - Reading from file tmpfile_stdout 10:00:06 INFO - Current package versions: 10:00:06 INFO - argparse == 1.2.1 10:00:06 INFO - blessings == 1.6 10:00:06 INFO - blobuploader == 1.2.4 10:00:06 INFO - docopt == 0.6.1 10:00:06 INFO - functools32 == 3.2.3-2 10:00:06 INFO - jsonschema == 2.5.1 10:00:06 INFO - manifestparser == 1.1 10:00:06 INFO - mozInstall == 1.12 10:00:06 INFO - mozcrash == 0.17 10:00:06 INFO - mozdebug == 0.1 10:00:06 INFO - mozdevice == 0.48 10:00:06 INFO - mozfile == 1.2 10:00:06 INFO - mozhttpd == 0.7 10:00:06 INFO - mozinfo == 0.9 10:00:06 INFO - mozleak == 0.1 10:00:06 INFO - mozlog == 3.3 10:00:06 INFO - moznetwork == 0.27 10:00:06 INFO - mozprocess == 0.23 10:00:06 INFO - mozprofile == 0.28 10:00:06 INFO - mozrunner == 6.12 10:00:06 INFO - mozscreenshot == 0.1 10:00:06 INFO - mozsystemmonitor == 0.3 10:00:06 INFO - moztest == 0.7 10:00:06 INFO - mozversion == 1.4 10:00:06 INFO - psutil == 3.1.1 10:00:06 INFO - requests == 1.2.3 10:00:06 INFO - wsgiref == 0.1.2 10:00:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:06 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 0x7fce9a4f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ada230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4090>, '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 0x2ad79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7e40>, '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': '934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177', '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 10:00:06 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 10:00:06 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 10:00:06 INFO - Using env: {'DISPLAY': ':0', 10:00:06 INFO - 'HOME': '/home/cltbld', 10:00:06 INFO - 'LANG': 'en_US.UTF-8', 10:00:06 INFO - 'LANGUAGE': 'en_US:en', 10:00:06 INFO - 'LOGNAME': 'cltbld', 10:00:06 INFO - 'MAIL': '/var/mail/cltbld', 10:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:06 INFO - 'MOZ_NO_REMOTE': '1', 10:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:06 INFO - 'NO_EM_RESTART': '1', 10:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:06 INFO - 'PWD': '/builds/slave/test', 10:00:06 INFO - 'SHELL': '/bin/bash', 10:00:06 INFO - 'SHLVL': '1', 10:00:06 INFO - 'TERM': 'linux', 10:00:06 INFO - 'TMOUT': '86400', 10:00:06 INFO - 'USER': 'cltbld', 10:00:06 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177', 10:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:06 INFO - '_': '/tools/buildbot/bin/python'} 10:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:07 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)) 10:00:07 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)) 10:00:07 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)) 10:00:07 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)) 10:00:07 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)) 10:00:07 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)) 10:00:07 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)) 10:00:07 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)) 10:00:07 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)) 10:00:07 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)) 10:00:07 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)) 10:00:07 INFO - Cleaning up... 10:00:07 INFO - Return code: 0 10:00:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce9a4f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ada230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4090>, '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 0x2ad79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7e40>, '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': '934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177', '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 10:00:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:00:07 INFO - Using env: {'DISPLAY': ':0', 10:00:07 INFO - 'HOME': '/home/cltbld', 10:00:07 INFO - 'LANG': 'en_US.UTF-8', 10:00:07 INFO - 'LANGUAGE': 'en_US:en', 10:00:07 INFO - 'LOGNAME': 'cltbld', 10:00:07 INFO - 'MAIL': '/var/mail/cltbld', 10:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:07 INFO - 'MOZ_NO_REMOTE': '1', 10:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:07 INFO - 'NO_EM_RESTART': '1', 10:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:07 INFO - 'PWD': '/builds/slave/test', 10:00:07 INFO - 'SHELL': '/bin/bash', 10:00:07 INFO - 'SHLVL': '1', 10:00:07 INFO - 'TERM': 'linux', 10:00:07 INFO - 'TMOUT': '86400', 10:00:07 INFO - 'USER': 'cltbld', 10:00:07 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177', 10:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:07 INFO - '_': '/tools/buildbot/bin/python'} 10:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:00:07 INFO - Cleaning up... 10:00:07 INFO - Return code: 0 10:00:07 INFO - Running post-action listener: _resource_record_post_action 10:00:07 INFO - Running post-action listener: _start_resource_monitoring 10:00:07 INFO - Starting resource monitoring. 10:00:07 INFO - [mozharness: 2016-08-22 17:00:07.317726Z] Finished create-virtualenv step (success) 10:00:07 INFO - [mozharness: 2016-08-22 17:00:07.318191Z] Running install step. 10:00:07 INFO - Running pre-action listener: _resource_record_pre_action 10:00:07 INFO - Running main action method: install 10:00:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:07 INFO - Reading from file tmpfile_stdout 10:00:07 INFO - Detecting whether we're running mozinstall >=1.0... 10:00:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:00:07 INFO - Reading from file tmpfile_stdout 10:00:07 INFO - Output received: 10:00:07 INFO - Usage: mozinstall [options] installer 10:00:07 INFO - Options: 10:00:07 INFO - -h, --help show this help message and exit 10:00:07 INFO - -d DEST, --destination=DEST 10:00:07 INFO - Directory to install application into. [default: 10:00:07 INFO - "/builds/slave/test"] 10:00:07 INFO - --app=APP Application being installed. [default: firefox] 10:00:07 INFO - mkdir: /builds/slave/test/build/application 10:00:07 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'] 10:00:07 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 10:00:23 INFO - Reading from file tmpfile_stdout 10:00:23 INFO - Output received: 10:00:23 INFO - /builds/slave/test/build/application/firefox/firefox 10:00:23 INFO - Running post-action listener: _resource_record_post_action 10:00:23 INFO - [mozharness: 2016-08-22 17:00:23.734679Z] Finished install step (success) 10:00:23 INFO - [mozharness: 2016-08-22 17:00:23.734926Z] Running run-tests step. 10:00:23 INFO - Running pre-action listener: _resource_record_pre_action 10:00:23 INFO - Running main action method: run_tests 10:00:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:00:23 INFO - Python 2.7.3 10:00:23 INFO - Return code: 0 10:00:23 INFO - grabbing minidump binary from tooltool 10:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:23 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 0x2ad4090>, '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 0x2ad79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:00:23 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 10:00:23 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 10:00:23 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 10:00:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:00:23 INFO - Return code: 0 10:00:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:00:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:00:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:00:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:00:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:00:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DunxWiY3RMizgnIHsUPPaw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 10:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DunxWiY3RMizgnIHsUPPaw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 10:00:23 INFO - Using env: {'DISPLAY': ':0', 10:00:23 INFO - 'HOME': '/home/cltbld', 10:00:23 INFO - 'LANG': 'en_US.UTF-8', 10:00:23 INFO - 'LANGUAGE': 'en_US:en', 10:00:23 INFO - 'LOGNAME': 'cltbld', 10:00:23 INFO - 'MAIL': '/var/mail/cltbld', 10:00:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:00:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:23 INFO - 'MOZ_NO_REMOTE': '1', 10:00:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:23 INFO - 'NO_EM_RESTART': '1', 10:00:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:23 INFO - 'PWD': '/builds/slave/test', 10:00:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:00:23 INFO - 'SHELL': '/bin/bash', 10:00:23 INFO - 'SHLVL': '1', 10:00:23 INFO - 'TERM': 'linux', 10:00:23 INFO - 'TMOUT': '86400', 10:00:23 INFO - 'USER': 'cltbld', 10:00:23 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177', 10:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:23 INFO - '_': '/tools/buildbot/bin/python'} 10:00:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DunxWiY3RMizgnIHsUPPaw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 10:00:24 INFO - mozversion application_buildid: 20160822083415 10:00:24 INFO - mozversion application_changeset: 3b7148db9a79bb17fd85df31690c98ffb5c8a541 10:00:24 INFO - mozversion application_display_name: Nightly 10:00:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:00:24 INFO - mozversion application_name: Firefox 10:00:24 INFO - mozversion application_remotingname: firefox 10:00:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:00:24 INFO - mozversion application_vendor: Mozilla 10:00:24 INFO - mozversion application_version: 51.0a1 10:00:24 INFO - mozversion platform_buildid: 20160822083415 10:00:24 INFO - mozversion platform_changeset: 3b7148db9a79bb17fd85df31690c98ffb5c8a541 10:00:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:00:24 INFO - mozversion platform_version: 51.0a1 10:00:24 INFO - using testdate: 1471885224 10:00:24 INFO - actual date: 1471885224 10:00:24 INFO - starting webserver on 'localhost:58475' 10:00:24 INFO - SUITE-START | Running 2 tests 10:00:24 INFO - TEST-START | dromaeo_css 10:00:24 INFO - operating with platform_type : linux_ 10:00:24 INFO - Initialising browser for dromaeo_css test... 10:00:24 INFO - TEST-INFO | started process 19158 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphOzQv5/profile http://localhost:58475/getInfo.html) 10:00:28 INFO - PROCESS | 19158 | __metrics Screen width/height:1600/1200 10:00:28 INFO - PROCESS | 19158 | colorDepth:24 10:00:28 INFO - PROCESS | 19158 | Browser inner width/height: 1024/697 10:00:28 INFO - PROCESS | 19158 | __metrics 10:00:29 INFO - PROCESS | 19158 | 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" 10:00:29 INFO - PROCESS | 19158 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:00:29 INFO - PROCESS | 19158 | console.error: PushService: 10:00:29 INFO - PROCESS | 19158 | stateChangeProcessEnqueue: Error transitioning state 10:00:29 INFO - PROCESS | 19158 | UnknownError 10:00:30 INFO - TEST-INFO | 19158: exit 0 10:00:30 INFO - Browser initialized. 10:00:30 INFO - Running cycle 1/1 for dromaeo_css test... 10:00:30 INFO - TEST-INFO | started process 19238 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphOzQv5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:00:42 INFO - PROCESS | 19238 | RSS: Main: 175529984 10:00:42 INFO - PROCESS | 19238 | 10:01:33 INFO - PROCESS | 19238 | 1471885293532 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] 10:03:46 INFO - PROCESS | 19238 | Cycle 1(1): loaded http://localhost:58475/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58475/tests/dromaeo/cssquery-ext.html) 10:03:47 INFO - PROCESS | 19238 | RSS: Main: 266235904 10:03:47 INFO - PROCESS | 19238 | 10:06:50 INFO - PROCESS | 19238 | Cycle 1(1): loaded http://localhost:58475/tests/dromaeo/cssquery-ext.html (next: http://localhost:58475/tests/dromaeo/cssquery-jquery.html) 10:06:51 INFO - PROCESS | 19238 | RSS: Main: 274628608 10:06:51 INFO - PROCESS | 19238 | 10:09:53 INFO - PROCESS | 19238 | Cycle 1(1): loaded http://localhost:58475/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58475/tests/dromaeo/cssquery-mootools.html) 10:09:54 INFO - PROCESS | 19238 | RSS: Main: 246214656 10:09:54 INFO - PROCESS | 19238 | 10:12:56 INFO - PROCESS | 19238 | Cycle 1(1): loaded http://localhost:58475/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58475/tests/dromaeo/cssquery-prototype.html) 10:12:56 INFO - PROCESS | 19238 | RSS: Main: 222658560 10:12:57 INFO - PROCESS | 19238 | 10:16:00 INFO - PROCESS | 19238 | Cycle 1(1): loaded http://localhost:58475/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58475/tests/dromaeo/cssquery-yui.html) 10:16:00 INFO - PROCESS | 19238 | RSS: Main: 219709440 10:16:00 INFO - PROCESS | 19238 | 10:19:03 INFO - PROCESS | 19238 | Cycle 1(1): loaded http://localhost:58475/tests/dromaeo/cssquery-yui.html (next: http://localhost:58475/tests/dromaeo/cssquery-dojo.html) 10:19:03 INFO - PROCESS | 19238 | RSS: Main: 312528896 10:19:03 INFO - PROCESS | 19238 | 10:19:03 INFO - PROCESS | 19238 | __start_tp_report 10:19:03 INFO - PROCESS | 19238 | _x_x_mozilla_page_load 10:19:03 INFO - PROCESS | 19238 | _x_x_mozilla_page_load_details 10:19:03 INFO - PROCESS | 19238 | |i|pagename|runs| 10:19:03 INFO - PROCESS | 19238 | |0;dojo.html;2567.050191429171;2596.117320111162;2601.414681696618;2613.7647611714942;2627.4613704190633;4613.861584152481;4651.4650815156265;4679.578837904588;4700.41244844394;4760.119377915088;4671.48613652498;4714.599259062975;4723.669343145981;4732.976335118328;4825.227963525827;4144.730592511492;4373.409589705381;4373.431453910987;4382.364557139213;4429.335599660045;4375.190589740892;4392.648588112943;4405.889852753675;4411.316245981878;4427.15883982044;4240.660747140221;4252.468441444819;4303.634191093761;4322.740635561876;4376.343548467724;4334.848280310205;4355.542668019875;4359.716618419824;4359.782010899442;4369.169857727022;4341.522432532419;4343.978280108579;4353.020570371673;4372.125574885035;4373.497047839507;4587.357769912215;4639.489656137822;4672.906541869143;4685.273782563708;4744.715317080986;5050.090983622947;5083.059633967728;5094.694318340911;5095.312132862054;5106.719130447824;5065.772040258197;5068.873278168038;5075.137226671474;5080.822171223989;5083.898322033576;4547.886302842389;4634.443866736014;4672.602828759525;4679.766011699401;4754;5171.120909445403;5180.663256888291;5184.974075129676;5192.324997750268;5207.270982062514;4978.303037574742;4987.625928055338;4988.575971042502;4990.30135780991;4990.950090499121;4842.83050093245;4924.335214745964;4957.578605818474;4998.6500944933505;5055.747212639353;4972.726500042532;5000.024995125988;5006.799728010911;5012.022655582199;5016.172331565251;4975.5522003019905;4979.850604481871;4984.102861484967;4988.201887697951;4990.10178167926;4108.4453598764385;4141.689373296955;4141.7100802943505;4199.076203235283;4236.046889449849;3632.945505817415;3665.138692407282;3696.4455331699924;3729.198222382201;3746.044758586543;4301.720388174758;4302.26861433557;4305.268104422255;4312;4315.8489452869;5003.649744517922;5040.949590504121;5054.039732450822;5057.115004874132;5067.037262920034;4134.069834287321;4256.042390462121;4282.978585107055;4294.355846622969;4377.037051848588;4554.453465584151;4560.726356418625;4578.45058592971;4578.816847326137;4579.152856721517;4784.928226076611;4802.111609352281;4804.711717296974;4807.326974223542;4811.975940120277;4872.074305881871;5003.574696150868;5061.924071139009;5069.188929771219;5149.768260428365;4778.116048531033;4792.976035119802;4816.181249187716;4817.927731084106;4823.807047718052;5050.77271522775;5059.291699162047;5066.6200034998255;5068.518490743373;5068.619853510928;4914.041761856403;4988.476209997898;5028.396592408934;5055.090083784954;5105.463926287686;4966;4969.950300496948;4975.179095449211;4976.328195693535;4984.7258400788305;4967.850964471072;4972.0801651694555;4972.254161875748;4974.278729584263;4982;4705.623550115914;4795.088933102699;4832.226843704991;4837.4920633334405;4887.340209071872;4998.800047998039;5009.223570346602;5010.799568017239;5016.874578135576;5017.724025178651;4896.6572339935865;4910;4910.803567857246;4912.975435122801;4916.336294600326 10:19:03 INFO - PROCESS | 19238 | |1;ext.html;545.9754311056005;550.6200721502163;560.3248086056302;569.0042425754929;576.5560518400835;37209.44185837215;38758.22483550327;38934.610653893455;41927.371089433684;41972;39516;40011;40015.39976900349;40028.39957400641;40096.19807603846;7623.123340815821;7763.107242667081;7764.369482408701;7771.883421748678;7775.028121484815;7661.157272700027;7753.573553454557;7753.806154846146;7763.301302882739;7763.340116090139;7762.611869406535;7804.3756499479905;7805.336546393535;7809.648565814524;7822.37421006321;7746.0317460317465;7774.805629859242;7775.844483110334;7777.183395743478;7781.3385862201785;7702.345300649452;7771.339436147878;7782.377409807258;7782.961085194538;7786.104597971249;37363.626363736286;37430.625693742986;37481.43777843335;37578;37834;2559.7303657612283;2593.351662084479;2649.814512984092;2692.31346006769;2980.225141463235;27633.86183069072;27807;28083;28252.15243542697;28323.433531329465;3285.375778602058;3395.4906763985355;3417.8803741868915;3423.246885685145;3483.477478378238;267191;269408.999999998;269599;269650.33846276894;270321;51678.22482662763;52087.479125208265;52201.7389913048;52273;52344;31454.685453145175;32380.35239295201;32472.675273246965;34200.657993420245;34328.48507272393;13254.337283135805;13347.93326033383;13368.33158342079;13371.39828707691;13390.330483475787;9902.158316543031;9996.850047249298;10005.399676019462;10007.749806254757;10009.799804003878;17269.740953885703;17306.913465432845;17340.47978560645;17352.739708904377;17380.21789019497;6674.833129171712;6700.966495167493;6718.32816718334;6767.323267673193;6805.319468053254;789.9131095579596;836.1095433363448;866.2853146154448;898.3217670658742;967.5210770668424;27246.5913011301;27917.720822791918;28001.57997630037;28199.57700634492;28516;887.5163036145316;965.5703212070702;978.4814048554277;981.5828272983953;995.1093771074848;14711.970162088552;14732.316920769808;14834.62913427173;14868.287614090013;14995.475158369623;397520;398810;402079;402114;402891;47510.762446187546;48219;48342.5165748345;48347.27479087817;48380.75809621;1078.396098185019;1107.1917500224881;1158.623447379622;1165.976680466386;1186.063010221915;26904;28392.85803570969;29390.942634015413;29414.352268410796;29895.55156672608;35293.64706352904;35627.82186089053;35663.28673426569;35671;35716.46425303674;245334;245719;245963;246889;246977;21922.23272185466;24133.155339563033;24244.636330454705;24953.750462495143;25795.065370097695;41009.794951025055;41226.175476490906;41490.170196596504;41502.792486037375;41728.58271417247;35058.47412288767;35331.293374131856;35372.82313588416;35715.46426803652;35891;35103.64896351004;35108.473372898916;35188.82405587956;35712.821435892656;35796.821015894755;33417.83291083529;35101.64898351086;35167.12082197965;36647.63352366549;38594.42108368433;30952;32890;33575.32849343048;33596.32807343888;33688;24808;25315.240542783748;25572.8721356392;25577;25595.52120491449 10:19:03 INFO - PROCESS | 19238 | |2;jquery.html;339.2528478336568;363.35141771937083;369.1583190326057;370.9610490898456;379.16772683958703;12827;16303.510894673163;16679.249433775465;17067.487975360727;18219.45341639753;14032.298385080756;14703.705925881475;15369.154696491716;15430.151341676203;16024.43914462994;4365.541618130098;4883.243097319921;5086.41506226785;5100;5155.871103222412;3703.759255648388;3919.4120881867807;5063.265826455162;5717.77128914845;6009.038553831388;6070.5447091468095;6075.45320921117;6078.696065196745;6079.726412311456;6083.239595050619;5809;5996.310424301218;6028.7588496460085;6032.728527216286;6046.758129674808;5193.714345710984;5298.443663415324;5305.787768489295;5310.787568497255;5314.229436731653;19315.90342048281;20043.298484553117;21076.78923210779;21529.892350538146;21561.1375544978;1846.1323178106268;1929.4501067195781;1957.3345062678757;2090.8954552272326;2254.1659585953303;8847.557622118868;8874.778130546723;8884.777880552972;9150.222231110363;9338.95330523343;1649.364994477123;1651.5293141454629;1692.089235442839;1752.4479788866595;1753.097154965194;68927.3107268926;70152.29847701508;71003;71672.28327716708;72693;9404;9515.90484095164;9645.855312170323;9805.117539421486;9999.200063994864;13382.93308533451;13403.530876419278;13431.19412835233;13450.529231477047;13451.596452106452;6750.493712971547;6920.515563910579;6956.860862782716;7094.787156385317;7138.143422789299;6448.097266382711;6497.642629655415;6667.566608170453;6718.462522998148;6721.294264102296;4185.267578173807;4222.289972561118;4246.915061698749;4269.1034882674985;4326.6754993375625;1674.112720258265;1726.3094762095263;1747.7291019891936;1761.12824152043;1810.1763697517597;640.9711562979677;799.4723482501521;890.2966656341417;896.6458248991743;901.9458832470073;16384.75422868658;16563.368454725452;17314;17480.82519174792;18201.63596728058;783.9098503672037;818.165471219353;853.3429259470297;890.3233542507611;898.2634239923331;9445.858312125323;9986.35088719231;9990.850137247948;10023.498825058718;10117.44354060519;377520;379019;379954;380553;382722;73497;76251;77239.61380193176;77751.61124194456;80056;894.5482531321771;898.2768871058861;926.4858003807951;939.4504215034145;944.3578366710566;11834.822477663014;15240.847591523943;15972.440964566184;16080.115593642462;17167.399141030004;37853.81073094617;37989.04460126698;38662.420063698504;39350.80324598359;39779.60220397759;48683.75658121687;49272.75363623159;49423.25865112098;50020.49979500304;50536;7022.54353467023;7452.143003554444;7475;7552.471327007057;7656.80857978555;10387.636432724817;10752.247342685936;11123.165762568002;11355.772884542097;11656.417179140839;9628.133467987915;9714.902850971683;9732;9743.902560974582;10089.091981721387;9469.715908522756;9485.905140948778;9640.373375730554;9884.11043006133;10368.377897326185;9467.337286389886;9604.75988100303;9759;9961.252906032221;10078.596856125672;7289.380402665833;7322.0847394075745;7468.775936721907;7501.399888009056;7532.284432978859;9371.906280937103;9674.177694896012;9812.460314682761;9999.700008999742;10070.69787906364 10:19:03 INFO - PROCESS | 19238 | |3;mootools.html;1368.0833841326314;1388.4931999820064;1468.676891083962;1632.3633782824693;1675.514100910736;6805.149356330458;7035.472339574527;7766.3398611118055;8184.017917849859;8205.548694821782;7467;7770.067591888967;7783.104942931564;7985.760427187193;7997.120316765166;2138.9893050534724;2162.4053385319007;2164.2425151197035;2166.7074944882397;2176.216562037665;1830.8535317174594;2115.3548167808813;2148.892555372233;2178.7930146636045;2195.1329224956135;2157.7302837145357;2165.3287480880977;2174.4672555223992;2191.2549733090746;2191.638379667361;2062.834973202148;2064.5045189154644;2124.6388114020656;2124.7556530998977;2127.276725913197;2063.13348393675;2072.1193492765665;2081.739782527184;2081.9271325503537;2083.541620843412;7855.921440785633;7858.1356050834365;7888.842223155505;7951.522908625443;7958.880616790752;4311.568843115663;4447.710898791601;4451.755153466558;4454;4504.324351347292;2701.6757989041243;2839.701831307724;2890.638670166229;2893.450244453547;2937.324415384452;860.5439117267858;894.4767311123001;899.2895612466144;899.6221586933503;906.4470672889532;10663.360198388044;10714.410707411089;10723.731906702316;10759.946200269027;10772.78454430907;3837.5394952605866;3955.110100227426;3975.5030621172355;4146.5853414658295;4161.854335098317;9321.114494123047;9326.90673093274;9337.486438245962;9350.57922393494;9350.766230844283;4555.567221113989;4556.567126123013;4557.407537020166;4560.224761790503;4561.178987782165;4116.670666346685;4172.687048471316;4174.269502836992;4177.561356057631;4178.415021896937;3521.3485505181625;3671.4125739881492;3698.2418604186078;3703.185299234218;3738.476613274144;1046.7226185060965;1083;1128.1651577832345;1148.586508856811;1150.246588484544;600.5105838741412;710.8755967705631;721.9602921839244;731.440448057226;759.1649185895582;5026.89946201074;5040.294358789773;5152.098382782998;5159.922601160985;5184.455632158569;835.4319063037071;843.9915600844035;844.4426678392232;856.7405913307429;880.8766772651834;3385.8307084646162;3444.2594842109065;3461.8961431157104;3473.565804274466;3519.7184225261917;9321.72034838956;9710.320277580502;9775.266854985905;9792.314537982273;9842.50787460624;9538.570764315622;9738.659146929824;9741.707748767549;9936;9942.105210531086;7447.292507211806;7515.924840751522;7538.396928245727;7563.470557061063;7580.696772129053;4878.243872199815;4904.435989861212;4936.605071594192;5008.173651347487;5171.534561889298;9017.692434597078;9089.545522723705;9104.04407537199;9181.173694367271;9284.071592840932;9046.638134474548;9201.263898888206;9307.953460232655;9348.859767103635;9362.251019918254;6602.537822352389;6616.073749674953;6667.366600172976;6690.397864192246;6692.83267918306;7255.600941948243;7310.8903366448485;7315.817104572428;7328.047353843966;7336.96331518339;6328.841778955563;6399.264084630141;6426.3573642635365;6534.901976470262;6665.50008749336;6505.707243173973;6514.609123452608;6524.869502610016;6714.194296684429;6725.4283385910785;6006.279246490449;6057.212562366864;6065.3934606539;6094.969525152346;6100.206973093647;4333.523312435566;4436.622887054507;4452.285869940031;4481.140326764356;4538.931916021328;4387.714798538085;4442.378067070548;4487.461504619467;4500.909981800281;4516.232240519054 10:19:03 INFO - PROCESS | 19238 | |4;prototype.html;287.1901238507409;290.9781766367523;291.2689150232916;294.1557729316861;295.09847416143685;4795.081967213107;4796.544328288815;4819.879503012422;4829.5170482951735;4864.394749732589;4756.167670657638;4756.215224487955;4778.68938518996;4781.617470602352;4797.664163508556;3533.734969877263;3654.287413954267;3670.596234414212;3733.4026555751084;3743.4759133721163;3763.5295588051495;3768.4912536807456;3780.281746468176;3781.9621803782024;3792.288513712695;3710.2208536207427;3716.1081340478227;3717.293714194308;3727;3727.1427571658533;3532.5937517185466;3624.4200927851416;3725.5529336479663;3746.831392587313;3751.456038874348;3282.2122690554097;3297.1262615406936;3325.700686938187;3327.4177019021818;3331.93336133276;4619.766163685434;4631.652626053059;4643.30519360431;4652.325412815123;4652.395188625491;4157.210130075307;4251.086016506466;4251.192273468062;4263.872083837458;4283.215909658716;4941.8517444476365;4960.280759289883;4975.701457912537;4985.725785081819;4989.55094041538;3611.2416392557593;3626.8005259710703;3631;3634.182308980485;3635.127569383329;5086.135356989321;5216.7913283468615;5228.372595288552;5246.317978662788;5249.640230252641;3713.665770080652;3725.8882233533036;3735.1969326594913;3738.738288319846;3745.138618117848;3781.7498588339895;3782.2624588205035;3782.962170378261;3786.2995345861104;3787.3561494545993;4245.681573881971;4255.936160957588;4256.978715106467;4257.127288905767;4267.8079486423185;4765.233428023294;4948.604111671129;4994.9750251248515;5002.598752598773;5006.424261209934;1293.275765571283;1305.549585393038;1305.9934700326437;1309.18830325199;1309.4696647857634;802;844.7719115838812;844.9704260350982;853.9316854651613;854.6154230596256;4182.598829392127;4287.742735435884;4289.62731925787;4293.248681480728;4300.827966881352;5013.298138260573;5203.375594928557;5203.453637368098;5210.166373380241;5213.5851017583545;4407.515173330931;4407.867763967086;4409.919569705443;4412.4043254160915;4428.13651337986;2659.4415172813924;2725.9182224533297;2755.917322480329;2764.226016715323;2765.6681198256338;4858.44127925286;4878.804847806119;4881.731504767272;4884.413870335511;4895.118878601815;5172.663776854568;5294.7617357219015;5322;5326.893462130735;5334.59990500714;4869.659123861366;4893.559579637849;4898.730569818694;4901.897073158582;4903.436104847846;5192.922106168335;5199.220116982483;5200.5438477226435;5200.895982080261;5204.531592156724;4786.353842231393;4959.504049595012;5014.044522636102;5098.1588037973315;5107.233914912644;4869.634777391639;4899.412070551557;4904.239842824368;4904.5340692634145;4913.926291105565;3551.715862731027;3563.518924945099;3564.9108772279865;3566.197605538733;3566.2154326048226;5049.318342023927;5165.690058596496;5185.948140518546;5199.168133098686;5202.713850738246;5013.598912087097;5062.139436295912;5068.163752980864;5076.695398276115;5083.313752643346;5059.696418214919;5072.898542029213;5076.720780356968;5083.694978301313;5096.43939166684;4806.4953179917;5005.62457815658;5008.195410569947;5013.949860501349;5018.698878067327;4857.465678775261;4944.579710724629;5080.7205603692155;5113.565346945551;5119.846404607868;4931.72875491837;4969.900601988013;5006;5008.549230569266;5010.9248361273885 10:19:03 INFO - PROCESS | 19238 | |5;yui.html;561.1470564741593;593.8159170657096;599.1222858512278;615.7352338494447;635.3773302163877;11894.940525297372;13228.537001204959;13239.933800330997;13257.270850103241;13279.867201328008;10875.293105948107;11231.831522527169;11273.830892536618;11282.548698052067;12557.183783054095;728.0971595221913;747.3834086878347;749.3218637133376;749.5015814483389;749.9875168522478;752.446951490654;760.6272926266117;760.9239076092401;762.2834535536578;762.572959142879;787.4212453846418;797.143071198461;801.5511313664338;802.9799255018613;804.2199066905122;792.7621713485931;792.7780221537979;792.9612208007528;793.1552896165623;793.623029061197;581.3779256195872;581.5551103405897;581.822544124042;581.8836232753424;582.4059459351438;11193.10455163585;11229.27009744364;11239.494222759995;11243.550257989671;11251.43742812856;10489.842652360221;10503.894961050368;10533.525991330333;10554.894451055545;10965.122790176767;9501.667441639509;9531.189848862856;9735.756606084833;9782.5597848097;9790.608375664964;3254.495553189259;3258.8696452141885;3261.3966416213075;3372.6964573188284;3381.22231886665;64092.67953660248;65616.34383656198;66536.66731666359;69168.30831691719;69427;7812.6093695315;7838.608069596611;8195.95902020498;8216.383771217183;8224.177582241728;16297.266623001993;16341.346346146258;16416.835831641532;16417.42539011129;16457.670846583;6739.898901516482;6774.932250677529;6848.760293389708;6865;7220.205777364486;3693.3536631089987;3714.145746478271;3724.404095344732;3768.397056471006;3828.4065969774174;2791.2184588315304;2921.8100823446407;2924.883004679789;2934.0317695160547;2937.588737576741;475.4294846184523;480.79566184371504;487.6586389527274;495.9510635007006;496.90061987602627;480.9567138957511;492.31568120312795;523.4268476018754;528.8862894477705;539.9001184780828;7260.636968151572;7629.3133617974645;7778.727744528915;7826.608669566499;7929.563873986986;465.8742139622351;469.317143556125;534.6631622078144;537.4303238567131;554.4649413316089;3566.5720113586535;3710.9443358349645;3789.734718569729;3918.549366822852;3965.6232657897453;96708;100705;102053.48973255235;102096;102472.48763756282;88267;89326;89417;89494;90766.54616727006;76231.23768762352;76884.61557692288;78814.21185788183;79194.20805791869;79583.60208198921;6804.081449004519;6868.656567171722;7090.574565526085;7353.632318384166;7361.852762944818;43024.354634679876;45100.0979980392;46239.537604623525;47147.292790607484;47671.52328476671;62441.375586245376;62732.686336568026;65006;65182;68669.65665171642;9224.982383707691;9335.113164249386;9408.76478088026;9534.735245999738;9680.85478717834;10192.235582331503;10206.13247873939;10390.636327728493;10785.568577256821;11022.228444009163;8550.78623034429;9036.45781253127;9233.953830230806;9314.673986410444;9334.533273336441;9347.439153650803;9360.672376467064;9915.801683966425;10223.079922806983;10553.894461055292;9021.413608115452;9044.321675874204;9187.03536128697;9449.574769135543;9651.517424128626;8246.83506329882;8470.745877623682;8634.913650863411;8656.740297791077;8662.78343041429;8348.749537513884;8394.874076888973;8723.389362744547;9062;9102.362834601514 10:19:03 INFO - PROCESS | 19238 | __end_tp_report 10:19:03 INFO - PROCESS | 19238 | __start_cc_report 10:19:03 INFO - PROCESS | 19238 | _x_x_mozilla_cycle_collect,960 10:19:03 INFO - PROCESS | 19238 | __end_cc_report 10:19:03 INFO - PROCESS | 19238 | __startTimestamp1471886343968__endTimestamp 10:19:03 INFO - PROCESS | 19238 | 10:19:03 INFO - PROCESS | 19238 | ------- Summary: start ------- 10:19:03 INFO - PROCESS | 19238 | Number of tests: 6 10:19:03 INFO - PROCESS | 19238 | 10:19:03 INFO - PROCESS | 19238 | [#0] dojo.html Cycles:165 Average:4661.25 Median:4811.98 stddev:503.67 (10.5%) stddev-sans-first:477.67 10:19:03 INFO - PROCESS | 19238 | Values: 2567.1 2596.1 2601.4 2613.8 2627.5 4613.9 4651.5 4679.6 4700.4 4760.1 4671.5 4714.6 4723.7 4733.0 4825.2 4144.7 4373.4 4373.4 4382.4 4429.3 4375.2 4392.6 4405.9 4411.3 4427.2 4240.7 4252.5 4303.6 4322.7 4376.3 4334.8 4355.5 4359.7 4359.8 4369.2 4341.5 4344.0 4353.0 4372.1 4373.5 4587.4 4639.5 4672.9 4685.3 4744.7 5050.1 5083.1 5094.7 5095.3 5106.7 5065.8 5068.9 5075.1 5080.8 5083.9 4547.9 4634.4 4672.6 4679.8 4754.0 5171.1 5180.7 5185.0 5192.3 5207.3 4978.3 4987.6 4988.6 4990.3 4991.0 4842.8 4924.3 4957.6 4998.7 5055.7 4972.7 5000.0 5006.8 5012.0 5016.2 4975.6 4979.9 4984.1 4988.2 4990.1 4108.4 4141.7 4141.7 4199.1 4236.0 3632.9 3665.1 3696.4 3729.2 3746.0 4301.7 4302.3 4305.3 4312.0 4315.8 5003.6 5040.9 5054.0 5057.1 5067.0 4134.1 4256.0 4283.0 4294.4 4377.0 4554.5 4560.7 4578.5 4578.8 4579.2 4784.9 4802.1 4804.7 4807.3 4812.0 4872.1 5003.6 5061.9 5069.2 5149.8 4778.1 4793.0 4816.2 4817.9 4823.8 5050.8 5059.3 5066.6 5068.5 5068.6 4914.0 4988.5 5028.4 5055.1 5105.5 4966.0 4970.0 4975.2 4976.3 4984.7 4967.9 4972.1 4972.3 4974.3 4982.0 4705.6 4795.1 4832.2 4837.5 4887.3 4998.8 5009.2 5010.8 5016.9 5017.7 4896.7 4910.0 4910.8 4913.0 4916.3 10:19:03 INFO - PROCESS | 19238 | 10:19:03 INFO - PROCESS | 19238 | [#1] ext.html Cycles:180 Average:45227.32 Median:35691.91 stddev:82450.93 (231.0%) stddev-sans-first:82613.97 10:19:03 INFO - PROCESS | 19238 | Values: 546.0 550.6 560.3 569.0 576.6 37209.4 38758.2 38934.6 41927.4 41972.0 39516.0 40011.0 40015.4 40028.4 40096.2 7623.1 7763.1 7764.4 7771.9 7775.0 7661.2 7753.6 7753.8 7763.3 7763.3 7762.6 7804.4 7805.3 7809.6 7822.4 7746.0 7774.8 7775.8 7777.2 7781.3 7702.3 7771.3 7782.4 7783.0 7786.1 37363.6 37430.6 37481.4 37578.0 37834.0 2559.7 2593.4 2649.8 2692.3 2980.2 27633.9 27807.0 28083.0 28252.2 28323.4 3285.4 3395.5 3417.9 3423.2 3483.5 267191.0 269409.0 269599.0 269650.3 270321.0 51678.2 52087.5 52201.7 52273.0 52344.0 31454.7 32380.4 32472.7 34200.7 34328.5 13254.3 13347.9 13368.3 13371.4 13390.3 9902.2 9996.9 10005.4 10007.7 10009.8 17269.7 17306.9 17340.5 17352.7 17380.2 6674.8 6701.0 6718.3 6767.3 6805.3 789.9 836.1 866.3 898.3 967.5 27246.6 27917.7 28001.6 28199.6 28516.0 887.5 965.6 978.5 981.6 995.1 14712.0 14732.3 14834.6 14868.3 14995.5 397520.0 398810.0 402079.0 402114.0 402891.0 47510.8 48219.0 48342.5 48347.3 48380.8 1078.4 1107.2 1158.6 1166.0 1186.1 26904.0 28392.9 29390.9 29414.4 29895.6 35293.6 35627.8 35663.3 35671.0 35716.5 245334.0 245719.0 245963.0 246889.0 246977.0 21922.2 24133.2 24244.6 24953.8 25795.1 41009.8 41226.2 41490.2 41502.8 41728.6 35058.5 35331.3 35372.8 35715.5 35891.0 35103.6 35108.5 35188.8 35712.8 35796.8 33417.8 35101.6 35167.1 36647.6 38594.4 30952.0 32890.0 33575.3 33596.3 33688.0 24808.0 25315.2 25572.9 25577.0 25595.5 10:19:03 INFO - PROCESS | 19238 | 10:19:03 INFO - PROCESS | 19238 | [#2] jquery.html Cycles:180 Average:23918.05 Median:5302.12 stddev:62865.73 (1185.7%) stddev-sans-first:63017.16 10:19:03 INFO - PROCESS | 19238 | Values: 339.3 363.4 369.2 371.0 379.2 12827.0 16303.5 16679.2 17067.5 18219.5 14032.3 14703.7 15369.2 15430.2 16024.4 4365.5 4883.2 5086.4 5100.0 5155.9 3703.8 3919.4 5063.3 5717.8 6009.0 6070.5 6075.5 6078.7 6079.7 6083.2 5809.0 5996.3 6028.8 6032.7 6046.8 5193.7 5298.4 5305.8 5310.8 5314.2 19315.9 20043.3 21076.8 21529.9 21561.1 1846.1 1929.5 1957.3 2090.9 2254.2 8847.6 8874.8 8884.8 9150.2 9339.0 1649.4 1651.5 1692.1 1752.4 1753.1 68927.3 70152.3 71003.0 71672.3 72693.0 9404.0 9515.9 9645.9 9805.1 9999.2 13382.9 13403.5 13431.2 13450.5 13451.6 6750.5 6920.5 6956.9 7094.8 7138.1 6448.1 6497.6 6667.6 6718.5 6721.3 4185.3 4222.3 4246.9 4269.1 4326.7 1674.1 1726.3 1747.7 1761.1 1810.2 641.0 799.5 890.3 896.6 901.9 16384.8 16563.4 17314.0 17480.8 18201.6 783.9 818.2 853.3 890.3 898.3 9445.9 9986.4 9990.9 10023.5 10117.4 377520.0 379019.0 379954.0 380553.0 382722.0 73497.0 76251.0 77239.6 77751.6 80056.0 894.5 898.3 926.5 939.5 944.4 11834.8 15240.8 15972.4 16080.1 17167.4 37853.8 37989.0 38662.4 39350.8 39779.6 48683.8 49272.8 49423.3 50020.5 50536.0 7022.5 7452.1 7475.0 7552.5 7656.8 10387.6 10752.2 11123.2 11355.8 11656.4 9628.1 9714.9 9732.0 9743.9 10089.1 9469.7 9485.9 9640.4 9884.1 10368.4 9467.3 9604.8 9759.0 9961.3 10078.6 7289.4 7322.1 7468.8 7501.4 7532.3 9371.9 9674.2 9812.5 9999.7 10070.7 10:19:03 INFO - PROCESS | 19238 | 10:19:03 INFO - PROCESS | 19238 | [#3] mootools.html Cycles:180 Average:5102.22 Median:5096.20 stddev:2933.19 (57.6%) stddev-sans-first:2928.00 10:19:03 INFO - PROCESS | 19238 | Values: 1368.1 1388.5 1468.7 1632.4 1675.5 6805.1 7035.5 7766.3 8184.0 8205.5 7467.0 7770.1 7783.1 7985.8 7997.1 2139.0 2162.4 2164.2 2166.7 2176.2 1830.9 2115.4 2148.9 2178.8 2195.1 2157.7 2165.3 2174.5 2191.3 2191.6 2062.8 2064.5 2124.6 2124.8 2127.3 2063.1 2072.1 2081.7 2081.9 2083.5 7855.9 7858.1 7888.8 7951.5 7958.9 4311.6 4447.7 4451.8 4454.0 4504.3 2701.7 2839.7 2890.6 2893.5 2937.3 860.5 894.5 899.3 899.6 906.4 10663.4 10714.4 10723.7 10759.9 10772.8 3837.5 3955.1 3975.5 4146.6 4161.9 9321.1 9326.9 9337.5 9350.6 9350.8 4555.6 4556.6 4557.4 4560.2 4561.2 4116.7 4172.7 4174.3 4177.6 4178.4 3521.3 3671.4 3698.2 3703.2 3738.5 1046.7 1083.0 1128.2 1148.6 1150.2 600.5 710.9 722.0 731.4 759.2 5026.9 5040.3 5152.1 5159.9 5184.5 835.4 844.0 844.4 856.7 880.9 3385.8 3444.3 3461.9 3473.6 3519.7 9321.7 9710.3 9775.3 9792.3 9842.5 9538.6 9738.7 9741.7 9936.0 9942.1 7447.3 7515.9 7538.4 7563.5 7580.7 4878.2 4904.4 4936.6 5008.2 5171.5 9017.7 9089.5 9104.0 9181.2 9284.1 9046.6 9201.3 9308.0 9348.9 9362.3 6602.5 6616.1 6667.4 6690.4 6692.8 7255.6 7310.9 7315.8 7328.0 7337.0 6328.8 6399.3 6426.4 6534.9 6665.5 6505.7 6514.6 6524.9 6714.2 6725.4 6006.3 6057.2 6065.4 6095.0 6100.2 4333.5 4436.6 4452.3 4481.1 4538.9 4387.7 4442.4 4487.5 4500.9 4516.2 10:19:03 INFO - PROCESS | 19238 | 10:19:03 INFO - PROCESS | 19238 | [#4] prototype.html Cycles:180 Average:4171.34 Median:4790.72 stddev:1212.79 (25.3%) stddev-sans-first:1180.63 10:19:03 INFO - PROCESS | 19238 | Values: 287.2 291.0 291.3 294.2 295.1 4795.1 4796.5 4819.9 4829.5 4864.4 4756.2 4756.2 4778.7 4781.6 4797.7 3533.7 3654.3 3670.6 3733.4 3743.5 3763.5 3768.5 3780.3 3782.0 3792.3 3710.2 3716.1 3717.3 3727.0 3727.1 3532.6 3624.4 3725.6 3746.8 3751.5 3282.2 3297.1 3325.7 3327.4 3331.9 4619.8 4631.7 4643.3 4652.3 4652.4 4157.2 4251.1 4251.2 4263.9 4283.2 4941.9 4960.3 4975.7 4985.7 4989.6 3611.2 3626.8 3631.0 3634.2 3635.1 5086.1 5216.8 5228.4 5246.3 5249.6 3713.7 3725.9 3735.2 3738.7 3745.1 3781.7 3782.3 3783.0 3786.3 3787.4 4245.7 4255.9 4257.0 4257.1 4267.8 4765.2 4948.6 4995.0 5002.6 5006.4 1293.3 1305.5 1306.0 1309.2 1309.5 802.0 844.8 845.0 853.9 854.6 4182.6 4287.7 4289.6 4293.2 4300.8 5013.3 5203.4 5203.5 5210.2 5213.6 4407.5 4407.9 4409.9 4412.4 4428.1 2659.4 2725.9 2755.9 2764.2 2765.7 4858.4 4878.8 4881.7 4884.4 4895.1 5172.7 5294.8 5322.0 5326.9 5334.6 4869.7 4893.6 4898.7 4901.9 4903.4 5192.9 5199.2 5200.5 5200.9 5204.5 4786.4 4959.5 5014.0 5098.2 5107.2 4869.6 4899.4 4904.2 4904.5 4913.9 3551.7 3563.5 3564.9 3566.2 3566.2 5049.3 5165.7 5185.9 5199.2 5202.7 5013.6 5062.1 5068.2 5076.7 5083.3 5059.7 5072.9 5076.7 5083.7 5096.4 4806.5 5005.6 5008.2 5013.9 5018.7 4857.5 4944.6 5080.7 5113.6 5119.8 4931.7 4969.9 5006.0 5008.5 5010.9 10:19:03 INFO - PROCESS | 19238 | 10:19:03 INFO - PROCESS | 19238 | [#5] yui.html Cycles:180 Average:17584.97 Median:65399.17 stddev:26810.13 (41.0%) stddev-sans-first:26854.86 10:19:03 INFO - PROCESS | 19238 | Values: 561.1 593.8 599.1 615.7 635.4 11894.9 13228.5 13239.9 13257.3 13279.9 10875.3 11231.8 11273.8 11282.5 12557.2 728.1 747.4 749.3 749.5 750.0 752.4 760.6 760.9 762.3 762.6 787.4 797.1 801.6 803.0 804.2 792.8 792.8 793.0 793.2 793.6 581.4 581.6 581.8 581.9 582.4 11193.1 11229.3 11239.5 11243.6 11251.4 10489.8 10503.9 10533.5 10554.9 10965.1 9501.7 9531.2 9735.8 9782.6 9790.6 3254.5 3258.9 3261.4 3372.7 3381.2 64092.7 65616.3 66536.7 69168.3 69427.0 7812.6 7838.6 8196.0 8216.4 8224.2 16297.3 16341.3 16416.8 16417.4 16457.7 6739.9 6774.9 6848.8 6865.0 7220.2 3693.4 3714.1 3724.4 3768.4 3828.4 2791.2 2921.8 2924.9 2934.0 2937.6 475.4 480.8 487.7 496.0 496.9 481.0 492.3 523.4 528.9 539.9 7260.6 7629.3 7778.7 7826.6 7929.6 465.9 469.3 534.7 537.4 554.5 3566.6 3710.9 3789.7 3918.5 3965.6 96708.0 100705.0 102053.5 102096.0 102472.5 88267.0 89326.0 89417.0 89494.0 90766.5 76231.2 76884.6 78814.2 79194.2 79583.6 6804.1 6868.7 7090.6 7353.6 7361.9 43024.4 45100.1 46239.5 47147.3 47671.5 62441.4 62732.7 65006.0 65182.0 68669.7 9225.0 9335.1 9408.8 9534.7 9680.9 10192.2 10206.1 10390.6 10785.6 11022.2 8550.8 9036.5 9234.0 9314.7 9334.5 9347.4 9360.7 9915.8 10223.1 10553.9 9021.4 9044.3 9187.0 9449.6 9651.5 8246.8 8470.7 8634.9 8656.7 8662.8 8348.7 8394.9 8723.4 9062.0 9102.4 10:19:03 INFO - PROCESS | 19238 | -------- Summary: end -------- 10:19:03 INFO - PROCESS | 19238 | 10:19:04 INFO - TEST-INFO | 19238: exit 0 10:19:04 INFO - TEST-OK | dromaeo_css | took 1120934ms 10:19:04 INFO - TEST-START | kraken 10:19:04 INFO - operating with platform_type : linux_ 10:19:04 INFO - Initialising browser for kraken test... 10:19:04 INFO - TEST-INFO | started process 19547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpajBUxQ/profile http://localhost:58475/getInfo.html) 10:19:09 INFO - PROCESS | 19547 | __metrics Screen width/height:1600/1200 10:19:09 INFO - PROCESS | 19547 | colorDepth:24 10:19:09 INFO - PROCESS | 19547 | Browser inner width/height: 1024/697 10:19:09 INFO - PROCESS | 19547 | __metrics 10:19:10 INFO - PROCESS | 19547 | 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" 10:19:10 INFO - PROCESS | 19547 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:19:10 INFO - PROCESS | 19547 | console.error: PushService: 10:19:10 INFO - PROCESS | 19547 | stateChangeProcessEnqueue: Error transitioning state 10:19:10 INFO - PROCESS | 19547 | UnknownError 10:19:11 INFO - TEST-INFO | 19547: exit 0 10:19:11 INFO - Browser initialized. 10:19:11 INFO - Running cycle 1/1 for kraken test... 10:19:11 INFO - TEST-INFO | started process 19632 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpajBUxQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:19:23 INFO - PROCESS | 19632 | RSS: Main: 175357952 10:19:23 INFO - PROCESS | 19632 | 10:19:26 INFO - PROCESS | 19632 | Cycle 1(1): loaded http://localhost:58475/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58475/tests/kraken/driver.html?testName=audio-beat-detection) 10:19:27 INFO - PROCESS | 19632 | RSS: Main: 236208128 10:19:27 INFO - PROCESS | 19632 | 10:19:30 INFO - PROCESS | 19632 | Cycle 1(1): loaded http://localhost:58475/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58475/tests/kraken/driver.html?testName=audio-dft) 10:19:30 INFO - PROCESS | 19632 | RSS: Main: 227332096 10:19:30 INFO - PROCESS | 19632 | 10:19:34 INFO - PROCESS | 19632 | Cycle 1(1): loaded http://localhost:58475/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58475/tests/kraken/driver.html?testName=audio-fft) 10:19:34 INFO - PROCESS | 19632 | RSS: Main: 303771648 10:19:34 INFO - PROCESS | 19632 | 10:19:36 INFO - PROCESS | 19632 | Cycle 1(1): loaded http://localhost:58475/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58475/tests/kraken/driver.html?testName=audio-oscillator) 10:19:37 INFO - PROCESS | 19632 | RSS: Main: 211009536 10:19:37 INFO - PROCESS | 19632 | 10:19:39 INFO - PROCESS | 19632 | Cycle 1(1): loaded http://localhost:58475/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58475/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:19:40 INFO - PROCESS | 19632 | RSS: Main: 214011904 10:19:40 INFO - PROCESS | 19632 | 10:19:43 INFO - PROCESS | 19632 | Cycle 1(1): loaded http://localhost:58475/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58475/tests/kraken/driver.html?testName=imaging-darkroom) 10:19:44 INFO - PROCESS | 19632 | RSS: Main: 251039744 10:19:44 INFO - PROCESS | 19632 | 10:19:47 INFO - PROCESS | 19632 | Cycle 1(1): loaded http://localhost:58475/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58475/tests/kraken/driver.html?testName=imaging-desaturate) 10:19:48 INFO - PROCESS | 19632 | RSS: Main: 245166080 10:19:48 INFO - PROCESS | 19632 | 10:19:51 INFO - PROCESS | 19632 | Cycle 1(1): loaded http://localhost:58475/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58475/tests/kraken/driver.html?testName=json-parse-financial) 10:19:52 INFO - PROCESS | 19632 | RSS: Main: 247726080 10:19:52 INFO - PROCESS | 19632 | 10:19:53 INFO - PROCESS | 19632 | Cycle 1(1): loaded http://localhost:58475/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58475/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:19:54 INFO - PROCESS | 19632 | RSS: Main: 211296256 10:19:54 INFO - PROCESS | 19632 | 10:19:56 INFO - PROCESS | 19632 | Cycle 1(1): loaded http://localhost:58475/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58475/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:19:57 INFO - PROCESS | 19632 | RSS: Main: 218640384 10:19:57 INFO - PROCESS | 19632 | 10:19:59 INFO - PROCESS | 19632 | Cycle 1(1): loaded http://localhost:58475/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58475/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:20:00 INFO - PROCESS | 19632 | RSS: Main: 222965760 10:20:00 INFO - PROCESS | 19632 | 10:20:02 INFO - PROCESS | 19632 | Cycle 1(1): loaded http://localhost:58475/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58475/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:20:03 INFO - PROCESS | 19632 | RSS: Main: 218537984 10:20:03 INFO - PROCESS | 19632 | 10:20:06 INFO - PROCESS | 19632 | Cycle 1(1): loaded http://localhost:58475/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58475/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:20:07 INFO - PROCESS | 19632 | RSS: Main: 221581312 10:20:07 INFO - PROCESS | 19632 | 10:20:08 INFO - PROCESS | 19632 | Cycle 1(1): loaded http://localhost:58475/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58475/tests/kraken/driver.html?testName=ai-astar) 10:20:09 INFO - PROCESS | 19632 | RSS: Main: 273641472 10:20:09 INFO - PROCESS | 19632 | 10:20:09 INFO - PROCESS | 19632 | __start_tp_report 10:20:09 INFO - PROCESS | 19632 | _x_x_mozilla_page_load 10:20:09 INFO - PROCESS | 19632 | _x_x_mozilla_page_load_details 10:20:09 INFO - PROCESS | 19632 | |i|pagename|runs| 10:20:09 INFO - PROCESS | 19632 | |0;ai-astar;100;115;114;115;116;117;120;116;116;115 10:20:09 INFO - PROCESS | 19632 | |1;audio-beat-detection;156;121;148;180;121;158;151;125;187;121 10:20:09 INFO - PROCESS | 19632 | |2;audio-dft;161;160;160;160;161;162;162;160;160;162 10:20:09 INFO - PROCESS | 19632 | |3;audio-fft;76;76;78;164;77;78;81;77;170;77 10:20:09 INFO - PROCESS | 19632 | |4;audio-oscillator;87;88;158;87;87;87;140;86;86;149 10:20:09 INFO - PROCESS | 19632 | |5;imaging-gaussian-blur;117;117;117;116;118;117;117;117;117;117 10:20:09 INFO - PROCESS | 19632 | |6;imaging-darkroom;146;146;147;147;146;147;147;147;145;146 10:20:09 INFO - PROCESS | 19632 | |7;imaging-desaturate;95;95;95;95;96;96;95;95;96;95 10:20:09 INFO - PROCESS | 19632 | |8;json-parse-financial;66;66;68;69;67;67;68;67;67;67 10:20:09 INFO - PROCESS | 19632 | |9;json-stringify-tinderbox;66;66;68;66;67;66;66;67;66;67 10:20:09 INFO - PROCESS | 19632 | |10;stanford-crypto-aes;89;82;82;83;85;81;82;83;82;81 10:20:09 INFO - PROCESS | 19632 | |11;stanford-crypto-ccm;143;134;137;147;144;132;132;134;148;135 10:20:09 INFO - PROCESS | 19632 | |12;stanford-crypto-pbkdf2;174;175;173;173;186;174;175;173;176;172 10:20:09 INFO - PROCESS | 19632 | |13;stanford-crypto-sha256-iterative;69;77;68;70;67;69;68;70;67;69 10:20:09 INFO - PROCESS | 19632 | __end_tp_report 10:20:09 INFO - PROCESS | 19632 | __start_cc_report 10:20:09 INFO - PROCESS | 19632 | _x_x_mozilla_cycle_collect,2030 10:20:09 INFO - PROCESS | 19632 | __end_cc_report 10:20:09 INFO - PROCESS | 19632 | __startTimestamp1471886409154__endTimestamp 10:20:09 INFO - PROCESS | 19632 | 10:20:09 INFO - PROCESS | 19632 | ------- Summary: start ------- 10:20:09 INFO - PROCESS | 19632 | Number of tests: 14 10:20:09 INFO - PROCESS | 19632 | 10:20:09 INFO - PROCESS | 19632 | [#0] ai-astar Cycles:10 Average:114.40 Median:116.00 stddev:5.32 (4.6%) stddev-sans-first:1.73 10:20:09 INFO - PROCESS | 19632 | Values: 100.0 115.0 114.0 115.0 116.0 117.0 120.0 116.0 116.0 115.0 10:20:09 INFO - PROCESS | 19632 | 10:20:09 INFO - PROCESS | 19632 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:153.50 stddev:24.54 (16.0%) stddev-sans-first:25.80 10:20:09 INFO - PROCESS | 19632 | Values: 156.0 121.0 148.0 180.0 121.0 158.0 151.0 125.0 187.0 121.0 10:20:09 INFO - PROCESS | 19632 | 10:20:09 INFO - PROCESS | 19632 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 10:20:09 INFO - PROCESS | 19632 | Values: 161.0 160.0 160.0 160.0 161.0 162.0 162.0 160.0 160.0 162.0 10:20:09 INFO - PROCESS | 19632 | 10:20:09 INFO - PROCESS | 19632 | [#3] audio-fft Cycles:10 Average:95.40 Median:77.00 stddev:37.79 (49.1%) stddev-sans-first:39.42 10:20:09 INFO - PROCESS | 19632 | Values: 76.0 76.0 78.0 164.0 77.0 78.0 81.0 77.0 170.0 77.0 10:20:09 INFO - PROCESS | 19632 | 10:20:09 INFO - PROCESS | 19632 | [#4] audio-oscillator Cycles:10 Average:105.50 Median:87.00 stddev:30.32 (34.9%) stddev-sans-first:31.41 10:20:09 INFO - PROCESS | 19632 | Values: 87.0 88.0 158.0 87.0 87.0 87.0 140.0 86.0 86.0 149.0 10:20:09 INFO - PROCESS | 19632 | 10:20:09 INFO - PROCESS | 19632 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 10:20:09 INFO - PROCESS | 19632 | Values: 117.0 117.0 117.0 116.0 118.0 117.0 117.0 117.0 117.0 117.0 10:20:09 INFO - PROCESS | 19632 | 10:20:09 INFO - PROCESS | 19632 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 10:20:09 INFO - PROCESS | 19632 | Values: 146.0 146.0 147.0 147.0 146.0 147.0 147.0 147.0 145.0 146.0 10:20:09 INFO - PROCESS | 19632 | 10:20:09 INFO - PROCESS | 19632 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:20:09 INFO - PROCESS | 19632 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 10:20:09 INFO - PROCESS | 19632 | 10:20:09 INFO - PROCESS | 19632 | [#8] json-parse-financial Cycles:10 Average:67.20 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 10:20:09 INFO - PROCESS | 19632 | Values: 66.0 66.0 68.0 69.0 67.0 67.0 68.0 67.0 67.0 67.0 10:20:09 INFO - PROCESS | 19632 | 10:20:09 INFO - PROCESS | 19632 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 10:20:09 INFO - PROCESS | 19632 | Values: 66.0 66.0 68.0 66.0 67.0 66.0 66.0 67.0 66.0 67.0 10:20:09 INFO - PROCESS | 19632 | 10:20:09 INFO - PROCESS | 19632 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:82.50 stddev:2.40 (2.9%) stddev-sans-first:1.22 10:20:09 INFO - PROCESS | 19632 | Values: 89.0 82.0 82.0 83.0 85.0 81.0 82.0 83.0 82.0 81.0 10:20:09 INFO - PROCESS | 19632 | 10:20:09 INFO - PROCESS | 19632 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:140.00 stddev:6.26 (4.5%) stddev-sans-first:6.43 10:20:09 INFO - PROCESS | 19632 | Values: 143.0 134.0 137.0 147.0 144.0 132.0 132.0 134.0 148.0 135.0 10:20:09 INFO - PROCESS | 19632 | 10:20:09 INFO - PROCESS | 19632 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.10 Median:174.50 stddev:4.01 (2.3%) stddev-sans-first:4.24 10:20:09 INFO - PROCESS | 19632 | Values: 174.0 175.0 173.0 173.0 186.0 174.0 175.0 173.0 176.0 172.0 10:20:09 INFO - PROCESS | 19632 | 10:20:09 INFO - PROCESS | 19632 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.00 stddev:2.88 (4.2%) stddev-sans-first:3.05 10:20:09 INFO - PROCESS | 19632 | Values: 69.0 77.0 68.0 70.0 67.0 69.0 68.0 70.0 67.0 69.0 10:20:09 INFO - PROCESS | 19632 | -------- Summary: end -------- 10:20:09 INFO - PROCESS | 19632 | 10:20:10 INFO - TEST-INFO | 19632: exit 0 10:20:10 INFO - TEST-OK | kraken | took 65486ms 10:20:10 INFO - SUITE-END | took 1186s 10:20:10 INFO - Completed test suite (00:19:46) 10:20:10 INFO - javascript benchmark 10:20:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2567.050191429171, 2596.117320111162, 2601.414681696618, 2613.7647611714942, 2627.4613704190633, 4613.861584152481, 4651.4650815156265, 4679.578837904588, 4700.41244844394, 4760.119377915088, 4671.48613652498, 4714.599259062975, 4723.669343145981, 4732.976335118328, 4825.227963525827, 4144.730592511492, 4373.409589705381, 4373.431453910987, 4382.364557139213, 4429.335599660045, 4375.190589740892, 4392.648588112943, 4405.889852753675, 4411.316245981878, 4427.15883982044, 4240.660747140221, 4252.468441444819, 4303.634191093761, 4322.740635561876, 4376.343548467724, 4334.848280310205, 4355.542668019875, 4359.716618419824, 4359.782010899442, 4369.169857727022, 4341.522432532419, 4343.978280108579, 4353.020570371673, 4372.125574885035, 4373.497047839507, 4587.357769912215, 4639.489656137822, 4672.906541869143, 4685.273782563708, 4744.715317080986, 5050.090983622947, 5083.059633967728, 5094.694318340911, 5095.312132862054, 5106.719130447824, 5065.772040258197, 5068.873278168038, 5075.137226671474, 5080.822171223989, 5083.898322033576, 4547.886302842389, 4634.443866736014, 4672.602828759525, 4679.766011699401, 4754.0, 5171.120909445403, 5180.663256888291, 5184.974075129676, 5192.324997750268, 5207.270982062514, 4978.303037574742, 4987.625928055338, 4988.575971042502, 4990.30135780991, 4990.950090499121, 4842.83050093245, 4924.335214745964, 4957.578605818474, 4998.6500944933505, 5055.747212639353, 4972.726500042532, 5000.024995125988, 5006.799728010911, 5012.022655582199, 5016.172331565251, 4975.5522003019905, 4979.850604481871, 4984.102861484967, 4988.201887697951, 4990.10178167926, 4108.4453598764385, 4141.689373296955, 4141.7100802943505, 4199.076203235283, 4236.046889449849, 3632.945505817415, 3665.138692407282, 3696.4455331699924, 3729.198222382201, 3746.044758586543, 4301.720388174758, 4302.26861433557, 4305.268104422255, 4312.0, 4315.8489452869, 5003.649744517922, 5040.949590504121, 5054.039732450822, 5057.115004874132, 5067.037262920034, 4134.069834287321, 4256.042390462121, 4282.978585107055, 4294.355846622969, 4377.037051848588, 4554.453465584151, 4560.726356418625, 4578.45058592971, 4578.816847326137, 4579.152856721517, 4784.928226076611, 4802.111609352281, 4804.711717296974, 4807.326974223542, 4811.975940120277, 4872.074305881871, 5003.574696150868, 5061.924071139009, 5069.188929771219, 5149.768260428365, 4778.116048531033, 4792.976035119802, 4816.181249187716, 4817.927731084106, 4823.807047718052, 5050.77271522775, 5059.291699162047, 5066.6200034998255, 5068.518490743373, 5068.619853510928, 4914.041761856403, 4988.476209997898, 5028.396592408934, 5055.090083784954, 5105.463926287686, 4966.0, 4969.950300496948, 4975.179095449211, 4976.328195693535, 4984.7258400788305, 4967.850964471072, 4972.0801651694555, 4972.254161875748, 4974.278729584263, 4982.0, 4705.623550115914, 4795.088933102699, 4832.226843704991, 4837.4920633334405, 4887.340209071872, 4998.800047998039, 5009.223570346602, 5010.799568017239, 5016.874578135576, 5017.724025178651, 4896.6572339935865, 4910.0, 4910.803567857246, 4912.975435122801, 4916.336294600326], "value": 4628.002098583328, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.9754311056005, 550.6200721502163, 560.3248086056302, 569.0042425754929, 576.5560518400835, 37209.44185837215, 38758.22483550327, 38934.610653893455, 41927.371089433684, 41972.0, 39516.0, 40011.0, 40015.39976900349, 40028.39957400641, 40096.19807603846, 7623.123340815821, 7763.107242667081, 7764.369482408701, 7771.883421748678, 7775.028121484815, 7661.157272700027, 7753.573553454557, 7753.806154846146, 7763.301302882739, 7763.340116090139, 7762.611869406535, 7804.3756499479905, 7805.336546393535, 7809.648565814524, 7822.37421006321, 7746.0317460317465, 7774.805629859242, 7775.844483110334, 7777.183395743478, 7781.3385862201785, 7702.345300649452, 7771.339436147878, 7782.377409807258, 7782.961085194538, 7786.104597971249, 37363.626363736286, 37430.625693742986, 37481.43777843335, 37578.0, 37834.0, 2559.7303657612283, 2593.351662084479, 2649.814512984092, 2692.31346006769, 2980.225141463235, 27633.86183069072, 27807.0, 28083.0, 28252.15243542697, 28323.433531329465, 3285.375778602058, 3395.4906763985355, 3417.8803741868915, 3423.246885685145, 3483.477478378238, 267191.0, 269408.999999998, 269599.0, 269650.33846276894, 270321.0, 51678.22482662763, 52087.479125208265, 52201.7389913048, 52273.0, 52344.0, 31454.685453145175, 32380.35239295201, 32472.675273246965, 34200.657993420245, 34328.48507272393, 13254.337283135805, 13347.93326033383, 13368.33158342079, 13371.39828707691, 13390.330483475787, 9902.158316543031, 9996.850047249298, 10005.399676019462, 10007.749806254757, 10009.799804003878, 17269.740953885703, 17306.913465432845, 17340.47978560645, 17352.739708904377, 17380.21789019497, 6674.833129171712, 6700.966495167493, 6718.32816718334, 6767.323267673193, 6805.319468053254, 789.9131095579596, 836.1095433363448, 866.2853146154448, 898.3217670658742, 967.5210770668424, 27246.5913011301, 27917.720822791918, 28001.57997630037, 28199.57700634492, 28516.0, 887.5163036145316, 965.5703212070702, 978.4814048554277, 981.5828272983953, 995.1093771074848, 14711.970162088552, 14732.316920769808, 14834.62913427173, 14868.287614090013, 14995.475158369623, 397520.0, 398810.0, 402079.0, 402114.0, 402891.0, 47510.762446187546, 48219.0, 48342.5165748345, 48347.27479087817, 48380.75809621, 1078.396098185019, 1107.1917500224881, 1158.623447379622, 1165.976680466386, 1186.063010221915, 26904.0, 28392.85803570969, 29390.942634015413, 29414.352268410796, 29895.55156672608, 35293.64706352904, 35627.82186089053, 35663.28673426569, 35671.0, 35716.46425303674, 245334.0, 245719.0, 245963.0, 246889.0, 246977.0, 21922.23272185466, 24133.155339563033, 24244.636330454705, 24953.750462495143, 25795.065370097695, 41009.794951025055, 41226.175476490906, 41490.170196596504, 41502.792486037375, 41728.58271417247, 35058.47412288767, 35331.293374131856, 35372.82313588416, 35715.46426803652, 35891.0, 35103.64896351004, 35108.473372898916, 35188.82405587956, 35712.821435892656, 35796.821015894755, 33417.83291083529, 35101.64898351086, 35167.12082197965, 36647.63352366549, 38594.42108368433, 30952.0, 32890.0, 33575.32849343048, 33596.32807343888, 33688.0, 24808.0, 25315.240542783748, 25572.8721356392, 25577.0, 25595.52120491449], "value": 16791.79118261886, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.2528478336568, 363.35141771937083, 369.1583190326057, 370.9610490898456, 379.16772683958703, 12827.0, 16303.510894673163, 16679.249433775465, 17067.487975360727, 18219.45341639753, 14032.298385080756, 14703.705925881475, 15369.154696491716, 15430.151341676203, 16024.43914462994, 4365.541618130098, 4883.243097319921, 5086.41506226785, 5100.0, 5155.871103222412, 3703.759255648388, 3919.4120881867807, 5063.265826455162, 5717.77128914845, 6009.038553831388, 6070.5447091468095, 6075.45320921117, 6078.696065196745, 6079.726412311456, 6083.239595050619, 5809.0, 5996.310424301218, 6028.7588496460085, 6032.728527216286, 6046.758129674808, 5193.714345710984, 5298.443663415324, 5305.787768489295, 5310.787568497255, 5314.229436731653, 19315.90342048281, 20043.298484553117, 21076.78923210779, 21529.892350538146, 21561.1375544978, 1846.1323178106268, 1929.4501067195781, 1957.3345062678757, 2090.8954552272326, 2254.1659585953303, 8847.557622118868, 8874.778130546723, 8884.777880552972, 9150.222231110363, 9338.95330523343, 1649.364994477123, 1651.5293141454629, 1692.089235442839, 1752.4479788866595, 1753.097154965194, 68927.3107268926, 70152.29847701508, 71003.0, 71672.28327716708, 72693.0, 9404.0, 9515.90484095164, 9645.855312170323, 9805.117539421486, 9999.200063994864, 13382.93308533451, 13403.530876419278, 13431.19412835233, 13450.529231477047, 13451.596452106452, 6750.493712971547, 6920.515563910579, 6956.860862782716, 7094.787156385317, 7138.143422789299, 6448.097266382711, 6497.642629655415, 6667.566608170453, 6718.462522998148, 6721.294264102296, 4185.267578173807, 4222.289972561118, 4246.915061698749, 4269.1034882674985, 4326.6754993375625, 1674.112720258265, 1726.3094762095263, 1747.7291019891936, 1761.12824152043, 1810.1763697517597, 640.9711562979677, 799.4723482501521, 890.2966656341417, 896.6458248991743, 901.9458832470073, 16384.75422868658, 16563.368454725452, 17314.0, 17480.82519174792, 18201.63596728058, 783.9098503672037, 818.165471219353, 853.3429259470297, 890.3233542507611, 898.2634239923331, 9445.858312125323, 9986.35088719231, 9990.850137247948, 10023.498825058718, 10117.44354060519, 377520.0, 379019.0, 379954.0, 380553.0, 382722.0, 73497.0, 76251.0, 77239.61380193176, 77751.61124194456, 80056.0, 894.5482531321771, 898.2768871058861, 926.4858003807951, 939.4504215034145, 944.3578366710566, 11834.822477663014, 15240.847591523943, 15972.440964566184, 16080.115593642462, 17167.399141030004, 37853.81073094617, 37989.04460126698, 38662.420063698504, 39350.80324598359, 39779.60220397759, 48683.75658121687, 49272.75363623159, 49423.25865112098, 50020.49979500304, 50536.0, 7022.54353467023, 7452.143003554444, 7475.0, 7552.471327007057, 7656.80857978555, 10387.636432724817, 10752.247342685936, 11123.165762568002, 11355.772884542097, 11656.417179140839, 9628.133467987915, 9714.902850971683, 9732.0, 9743.902560974582, 10089.091981721387, 9469.715908522756, 9485.905140948778, 9640.373375730554, 9884.11043006133, 10368.377897326185, 9467.337286389886, 9604.75988100303, 9759.0, 9961.252906032221, 10078.596856125672, 7289.380402665833, 7322.0847394075745, 7468.775936721907, 7501.399888009056, 7532.284432978859, 9371.906280937103, 9674.177694896012, 9812.460314682761, 9999.700008999742, 10070.69787906364], "value": 8067.058345982896, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.0833841326314, 1388.4931999820064, 1468.676891083962, 1632.3633782824693, 1675.514100910736, 6805.149356330458, 7035.472339574527, 7766.3398611118055, 8184.017917849859, 8205.548694821782, 7467.0, 7770.067591888967, 7783.104942931564, 7985.760427187193, 7997.120316765166, 2138.9893050534724, 2162.4053385319007, 2164.2425151197035, 2166.7074944882397, 2176.216562037665, 1830.8535317174594, 2115.3548167808813, 2148.892555372233, 2178.7930146636045, 2195.1329224956135, 2157.7302837145357, 2165.3287480880977, 2174.4672555223992, 2191.2549733090746, 2191.638379667361, 2062.834973202148, 2064.5045189154644, 2124.6388114020656, 2124.7556530998977, 2127.276725913197, 2063.13348393675, 2072.1193492765665, 2081.739782527184, 2081.9271325503537, 2083.541620843412, 7855.921440785633, 7858.1356050834365, 7888.842223155505, 7951.522908625443, 7958.880616790752, 4311.568843115663, 4447.710898791601, 4451.755153466558, 4454.0, 4504.324351347292, 2701.6757989041243, 2839.701831307724, 2890.638670166229, 2893.450244453547, 2937.324415384452, 860.5439117267858, 894.4767311123001, 899.2895612466144, 899.6221586933503, 906.4470672889532, 10663.360198388044, 10714.410707411089, 10723.731906702316, 10759.946200269027, 10772.78454430907, 3837.5394952605866, 3955.110100227426, 3975.5030621172355, 4146.5853414658295, 4161.854335098317, 9321.114494123047, 9326.90673093274, 9337.486438245962, 9350.57922393494, 9350.766230844283, 4555.567221113989, 4556.567126123013, 4557.407537020166, 4560.224761790503, 4561.178987782165, 4116.670666346685, 4172.687048471316, 4174.269502836992, 4177.561356057631, 4178.415021896937, 3521.3485505181625, 3671.4125739881492, 3698.2418604186078, 3703.185299234218, 3738.476613274144, 1046.7226185060965, 1083.0, 1128.1651577832345, 1148.586508856811, 1150.246588484544, 600.5105838741412, 710.8755967705631, 721.9602921839244, 731.440448057226, 759.1649185895582, 5026.89946201074, 5040.294358789773, 5152.098382782998, 5159.922601160985, 5184.455632158569, 835.4319063037071, 843.9915600844035, 844.4426678392232, 856.7405913307429, 880.8766772651834, 3385.8307084646162, 3444.2594842109065, 3461.8961431157104, 3473.565804274466, 3519.7184225261917, 9321.72034838956, 9710.320277580502, 9775.266854985905, 9792.314537982273, 9842.50787460624, 9538.570764315622, 9738.659146929824, 9741.707748767549, 9936.0, 9942.105210531086, 7447.292507211806, 7515.924840751522, 7538.396928245727, 7563.470557061063, 7580.696772129053, 4878.243872199815, 4904.435989861212, 4936.605071594192, 5008.173651347487, 5171.534561889298, 9017.692434597078, 9089.545522723705, 9104.04407537199, 9181.173694367271, 9284.071592840932, 9046.638134474548, 9201.263898888206, 9307.953460232655, 9348.859767103635, 9362.251019918254, 6602.537822352389, 6616.073749674953, 6667.366600172976, 6690.397864192246, 6692.83267918306, 7255.600941948243, 7310.8903366448485, 7315.817104572428, 7328.047353843966, 7336.96331518339, 6328.841778955563, 6399.264084630141, 6426.3573642635365, 6534.901976470262, 6665.50008749336, 6505.707243173973, 6514.609123452608, 6524.869502610016, 6714.194296684429, 6725.4283385910785, 6006.279246490449, 6057.212562366864, 6065.3934606539, 6094.969525152346, 6100.206973093647, 4333.523312435566, 4436.622887054507, 4452.285869940031, 4481.140326764356, 4538.931916021328, 4387.714798538085, 4442.378067070548, 4487.461504619467, 4500.909981800281, 4516.232240519054], "value": 4066.0911583414118, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.1901238507409, 290.9781766367523, 291.2689150232916, 294.1557729316861, 295.09847416143685, 4795.081967213107, 4796.544328288815, 4819.879503012422, 4829.5170482951735, 4864.394749732589, 4756.167670657638, 4756.215224487955, 4778.68938518996, 4781.617470602352, 4797.664163508556, 3533.734969877263, 3654.287413954267, 3670.596234414212, 3733.4026555751084, 3743.4759133721163, 3763.5295588051495, 3768.4912536807456, 3780.281746468176, 3781.9621803782024, 3792.288513712695, 3710.2208536207427, 3716.1081340478227, 3717.293714194308, 3727.0, 3727.1427571658533, 3532.5937517185466, 3624.4200927851416, 3725.5529336479663, 3746.831392587313, 3751.456038874348, 3282.2122690554097, 3297.1262615406936, 3325.700686938187, 3327.4177019021818, 3331.93336133276, 4619.766163685434, 4631.652626053059, 4643.30519360431, 4652.325412815123, 4652.395188625491, 4157.210130075307, 4251.086016506466, 4251.192273468062, 4263.872083837458, 4283.215909658716, 4941.8517444476365, 4960.280759289883, 4975.701457912537, 4985.725785081819, 4989.55094041538, 3611.2416392557593, 3626.8005259710703, 3631.0, 3634.182308980485, 3635.127569383329, 5086.135356989321, 5216.7913283468615, 5228.372595288552, 5246.317978662788, 5249.640230252641, 3713.665770080652, 3725.8882233533036, 3735.1969326594913, 3738.738288319846, 3745.138618117848, 3781.7498588339895, 3782.2624588205035, 3782.962170378261, 3786.2995345861104, 3787.3561494545993, 4245.681573881971, 4255.936160957588, 4256.978715106467, 4257.127288905767, 4267.8079486423185, 4765.233428023294, 4948.604111671129, 4994.9750251248515, 5002.598752598773, 5006.424261209934, 1293.275765571283, 1305.549585393038, 1305.9934700326437, 1309.18830325199, 1309.4696647857634, 802.0, 844.7719115838812, 844.9704260350982, 853.9316854651613, 854.6154230596256, 4182.598829392127, 4287.742735435884, 4289.62731925787, 4293.248681480728, 4300.827966881352, 5013.298138260573, 5203.375594928557, 5203.453637368098, 5210.166373380241, 5213.5851017583545, 4407.515173330931, 4407.867763967086, 4409.919569705443, 4412.4043254160915, 4428.13651337986, 2659.4415172813924, 2725.9182224533297, 2755.917322480329, 2764.226016715323, 2765.6681198256338, 4858.44127925286, 4878.804847806119, 4881.731504767272, 4884.413870335511, 4895.118878601815, 5172.663776854568, 5294.7617357219015, 5322.0, 5326.893462130735, 5334.59990500714, 4869.659123861366, 4893.559579637849, 4898.730569818694, 4901.897073158582, 4903.436104847846, 5192.922106168335, 5199.220116982483, 5200.5438477226435, 5200.895982080261, 5204.531592156724, 4786.353842231393, 4959.504049595012, 5014.044522636102, 5098.1588037973315, 5107.233914912644, 4869.634777391639, 4899.412070551557, 4904.239842824368, 4904.5340692634145, 4913.926291105565, 3551.715862731027, 3563.518924945099, 3564.9108772279865, 3566.197605538733, 3566.2154326048226, 5049.318342023927, 5165.690058596496, 5185.948140518546, 5199.168133098686, 5202.713850738246, 5013.598912087097, 5062.139436295912, 5068.163752980864, 5076.695398276115, 5083.313752643346, 5059.696418214919, 5072.898542029213, 5076.720780356968, 5083.694978301313, 5096.43939166684, 4806.4953179917, 5005.62457815658, 5008.195410569947, 5013.949860501349, 5018.698878067327, 4857.465678775261, 4944.579710724629, 5080.7205603692155, 5113.565346945551, 5119.846404607868, 4931.72875491837, 4969.900601988013, 5006.0, 5008.549230569266, 5010.9248361273885], "value": 3783.9973765724903, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.1470564741593, 593.8159170657096, 599.1222858512278, 615.7352338494447, 635.3773302163877, 11894.940525297372, 13228.537001204959, 13239.933800330997, 13257.270850103241, 13279.867201328008, 10875.293105948107, 11231.831522527169, 11273.830892536618, 11282.548698052067, 12557.183783054095, 728.0971595221913, 747.3834086878347, 749.3218637133376, 749.5015814483389, 749.9875168522478, 752.446951490654, 760.6272926266117, 760.9239076092401, 762.2834535536578, 762.572959142879, 787.4212453846418, 797.143071198461, 801.5511313664338, 802.9799255018613, 804.2199066905122, 792.7621713485931, 792.7780221537979, 792.9612208007528, 793.1552896165623, 793.623029061197, 581.3779256195872, 581.5551103405897, 581.822544124042, 581.8836232753424, 582.4059459351438, 11193.10455163585, 11229.27009744364, 11239.494222759995, 11243.550257989671, 11251.43742812856, 10489.842652360221, 10503.894961050368, 10533.525991330333, 10554.894451055545, 10965.122790176767, 9501.667441639509, 9531.189848862856, 9735.756606084833, 9782.5597848097, 9790.608375664964, 3254.495553189259, 3258.8696452141885, 3261.3966416213075, 3372.6964573188284, 3381.22231886665, 64092.67953660248, 65616.34383656198, 66536.66731666359, 69168.30831691719, 69427.0, 7812.6093695315, 7838.608069596611, 8195.95902020498, 8216.383771217183, 8224.177582241728, 16297.266623001993, 16341.346346146258, 16416.835831641532, 16417.42539011129, 16457.670846583, 6739.898901516482, 6774.932250677529, 6848.760293389708, 6865.0, 7220.205777364486, 3693.3536631089987, 3714.145746478271, 3724.404095344732, 3768.397056471006, 3828.4065969774174, 2791.2184588315304, 2921.8100823446407, 2924.883004679789, 2934.0317695160547, 2937.588737576741, 475.4294846184523, 480.79566184371504, 487.6586389527274, 495.9510635007006, 496.90061987602627, 480.9567138957511, 492.31568120312795, 523.4268476018754, 528.8862894477705, 539.9001184780828, 7260.636968151572, 7629.3133617974645, 7778.727744528915, 7826.608669566499, 7929.563873986986, 465.8742139622351, 469.317143556125, 534.6631622078144, 537.4303238567131, 554.4649413316089, 3566.5720113586535, 3710.9443358349645, 3789.734718569729, 3918.549366822852, 3965.6232657897453, 96708.0, 100705.0, 102053.48973255235, 102096.0, 102472.48763756282, 88267.0, 89326.0, 89417.0, 89494.0, 90766.54616727006, 76231.23768762352, 76884.61557692288, 78814.21185788183, 79194.20805791869, 79583.60208198921, 6804.081449004519, 6868.656567171722, 7090.574565526085, 7353.632318384166, 7361.852762944818, 43024.354634679876, 45100.0979980392, 46239.537604623525, 47147.292790607484, 47671.52328476671, 62441.375586245376, 62732.686336568026, 65006.0, 65182.0, 68669.65665171642, 9224.982383707691, 9335.113164249386, 9408.76478088026, 9534.735245999738, 9680.85478717834, 10192.235582331503, 10206.13247873939, 10390.636327728493, 10785.568577256821, 11022.228444009163, 8550.78623034429, 9036.45781253127, 9233.953830230806, 9314.673986410444, 9334.533273336441, 9347.439153650803, 9360.672376467064, 9915.801683966425, 10223.079922806983, 10553.894461055292, 9021.413608115452, 9044.321675874204, 9187.03536128697, 9449.574769135543, 9651.517424128626, 8246.83506329882, 8470.745877623682, 8634.913650863411, 8656.740297791077, 8662.78343041429, 8348.749537513884, 8394.874076888973, 8723.389362744547, 9062.0, 9102.362834601514], "value": 6075.876815271926, "unit": "score"}], "name": "dromaeo_css", "value": 6232.541707842669, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 115.0, 114.0, 115.0, 116.0, 117.0, 120.0, 116.0, 116.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 121.0, 148.0, 180.0, 121.0, 158.0, 151.0, 125.0, 187.0, 121.0], "value": 146.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 160.0, 161.0, 162.0, 162.0, 160.0, 160.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 164.0, 77.0, 78.0, 81.0, 77.0, 170.0, 77.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 158.0, 87.0, 87.0, 87.0, 140.0, 86.0, 86.0, 149.0], "value": 105.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 145.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 69.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0], "value": 67.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 66.0, 67.0, 66.0, 66.0, 67.0, 66.0, 67.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 82.0, 82.0, 83.0, 85.0, 81.0, 82.0, 83.0, 82.0, 81.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 134.0, 137.0, 147.0, 144.0, 132.0, 132.0, 134.0, 148.0, 135.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 175.0, 173.0, 173.0, 186.0, 174.0, 175.0, 173.0, 176.0, 172.0], "value": 175.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 77.0, 68.0, 70.0, 67.0, 69.0, 68.0, 70.0, 67.0, 69.0], "value": 69.4, "unit": "score"}], "name": "kraken", "value": 1581.3999999999999, "alertThreshold": 2.0}]} 10:20:10 INFO - Return code: 0 10:20:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:20:10 INFO - # TBPL SUCCESS # 10:20:10 INFO - Running post-action listener: _resource_record_post_action 10:20:10 INFO - [mozharness: 2016-08-22 17:20:10.927745Z] Finished run-tests step (success) 10:20:10 INFO - Running post-run listener: _resource_record_post_run 10:20:10 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 421838848; Read time: 8; Write time: 279372 10:20:10 INFO - TinderboxPrint: CPU usage
13.2% 10:20:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 10:20:10 INFO - TinderboxPrint: I/O write bytes / time
421,838,848 / 279,372 10:20:10 INFO - TinderboxPrint: CPU idle
8,326.8 (86.7%) 10:20:10 INFO - TinderboxPrint: CPU user
1,204.3 (12.5%) 10:20:10 INFO - TinderboxPrint: Swap in / out
0 / 0 10:20:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 130605056; Read time: 0; Write time: 93232 10:20:11 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 291233792; Read time: 0; Write time: 186140 10:20:11 INFO - Running post-run listener: _upload_blobber_files 10:20:11 INFO - Blob upload gear active. 10:20:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:20:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:20:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:20:11 INFO - (blobuploader) - INFO - Open directory for files ... 10:20:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:20:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:20:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:12 INFO - (blobuploader) - INFO - Done attempting. 10:20:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:20:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:20:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:16 INFO - (blobuploader) - INFO - Done attempting. 10:20:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:20:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:20:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:17 INFO - (blobuploader) - INFO - Done attempting. 10:20:17 INFO - (blobuploader) - INFO - Iteration through files over. 10:20:17 INFO - Return code: 0 10:20:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:20:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:20:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1abf3c1c032b4cc7801ecdf49e308b5925fc8581d929b46611c74af2610274fbdd01e8056a67195b373a8262ea24024e1938232f71254eb9934c2e19f012a9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc5654563ed5f1f9e0eea247d0a87d6bd13acd6fc64949ebfcbf2b9fad1c931be313b178aad25b2cdcc80c0f3b7fb8c0cc49867a148c4a26a4f0aad68f7eff95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fe5c7d80cd884058f98fbb5319bb550e83f1a0f9f2c0707d1fdde502aeb51a8954917306950a69d060265a0b78933ab9cc231d185f30288a9cea6c737076a31c"} 10:20:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:20:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:20:17 INFO - Contents: 10:20:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1abf3c1c032b4cc7801ecdf49e308b5925fc8581d929b46611c74af2610274fbdd01e8056a67195b373a8262ea24024e1938232f71254eb9934c2e19f012a9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc5654563ed5f1f9e0eea247d0a87d6bd13acd6fc64949ebfcbf2b9fad1c931be313b178aad25b2cdcc80c0f3b7fb8c0cc49867a148c4a26a4f0aad68f7eff95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fe5c7d80cd884058f98fbb5319bb550e83f1a0f9f2c0707d1fdde502aeb51a8954917306950a69d060265a0b78933ab9cc231d185f30288a9cea6c737076a31c"} 10:20:17 INFO - Running post-run listener: copy_logs_to_upload_dir 10:20:17 INFO - Copying logs to upload dir... 10:20:17 INFO - mkdir: /builds/slave/test/build/upload/logs 10:20:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.896314 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-22 10:20:16.297818) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 10:20:16.301162) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177 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-Non-PGO/sha512/b1abf3c1c032b4cc7801ecdf49e308b5925fc8581d929b46611c74af2610274fbdd01e8056a67195b373a8262ea24024e1938232f71254eb9934c2e19f012a9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc5654563ed5f1f9e0eea247d0a87d6bd13acd6fc64949ebfcbf2b9fad1c931be313b178aad25b2cdcc80c0f3b7fb8c0cc49867a148c4a26a4f0aad68f7eff95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fe5c7d80cd884058f98fbb5319bb550e83f1a0f9f2c0707d1fdde502aeb51a8954917306950a69d060265a0b78933ab9cc231d185f30288a9cea6c737076a31c"} build_url:https://queue.taskcluster.net/v1/task/DunxWiY3RMizgnIHsUPPaw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011173 build_url: 'https://queue.taskcluster.net/v1/task/DunxWiY3RMizgnIHsUPPaw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1abf3c1c032b4cc7801ecdf49e308b5925fc8581d929b46611c74af2610274fbdd01e8056a67195b373a8262ea24024e1938232f71254eb9934c2e19f012a9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc5654563ed5f1f9e0eea247d0a87d6bd13acd6fc64949ebfcbf2b9fad1c931be313b178aad25b2cdcc80c0f3b7fb8c0cc49867a148c4a26a4f0aad68f7eff95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fe5c7d80cd884058f98fbb5319bb550e83f1a0f9f2c0707d1fdde502aeb51a8954917306950a69d060265a0b78933ab9cc231d185f30288a9cea6c737076a31c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 10:20:16.327428) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 10:20:16.327818) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1471882362.855350-1975200177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004385 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 10:20:16.411924) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 10:20:16.412325) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 10:20:16.412700) ========= ========= Total master_lag: 0.17 =========