builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1470886070.84 results: success (0) buildid: 20160810173002 builduid: 456109daf319450bb6fde18e8cb67c8c revision: c4a79e57209adab8f38ca9ea9da8317bf748235a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:50.844981) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:50.845657) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:50.845941) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:50.860876) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:50.861210) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-10 20:27:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 21.2M=0.001s 2016-08-10 20:27:51 (21.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072872 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:50.947556) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:50.947834) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017260 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:50.997610) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-10 20:27:50.997932) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c4a79e57209adab8f38ca9ea9da8317bf748235a --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 c4a79e57209adab8f38ca9ea9da8317bf748235a --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=e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-10 20:27:51,190 truncating revision to first 12 chars 2016-08-10 20:27:51,190 Setting DEBUG logging. 2016-08-10 20:27:51,190 attempt 1/10 2016-08-10 20:27:51,190 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c4a79e57209a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-10 20:27:52,488 unpacking tar archive at: fx-team-c4a79e57209a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.665353 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-10 20:27:52.677801) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:52.678123) ========= script_repo_revision: c4a79e57209adab8f38ca9ea9da8317bf748235a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:52.678527) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:52.678805) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:52.689614) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-10 20:27:52.689882) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:27:52 INFO - MultiFileLogger online at 20160810 20:27:52 in /builds/slave/test 20:27:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:27:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:27:52 INFO - {'append_to_log': False, 20:27:52 INFO - 'base_work_dir': '/builds/slave/test', 20:27:52 INFO - 'blob_upload_branch': 'Fx-Team', 20:27:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:27:52 INFO - 'branch': 'Fx-Team', 20:27:52 INFO - 'buildbot_json_path': 'buildprops.json', 20:27:52 INFO - 'config_files': ('talos/linux_config.py',), 20:27:52 INFO - 'default_actions': ('clobber', 20:27:52 INFO - 'read-buildbot-config', 20:27:52 INFO - 'download-and-extract', 20:27:52 INFO - 'populate-webroot', 20:27:52 INFO - 'create-virtualenv', 20:27:52 INFO - 'install', 20:27:52 INFO - 'run-tests'), 20:27:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:27:52 INFO - 'download_minidump_stackwalk': True, 20:27:52 INFO - 'download_symbols': 'ondemand', 20:27:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:27:52 INFO - 'tooltool.py': '/tools/tooltool.py', 20:27:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:27:52 INFO - '/tools/misc-python/virtualenv.py')}, 20:27:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:27:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:27:52 INFO - 'installer_path': 'installer.exe', 20:27:52 INFO - 'log_level': 'info', 20:27:52 INFO - 'log_name': 'talos', 20:27:52 INFO - 'log_to_console': True, 20:27:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:27:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:27:52 INFO - 'opt_config_files': (), 20:27:52 INFO - 'pip_index': False, 20:27:52 INFO - 'sps_profile': False, 20:27:52 INFO - 'sps_profile_interval': 0, 20:27:52 INFO - 'suite': 'dromaeojs', 20:27:52 INFO - 'system_bits': '32', 20:27:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:27:52 INFO - 'title': 'talos-linux64-ix-067', 20:27:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:27:52 INFO - 'use_talos_json': True, 20:27:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:27:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:27:52 INFO - 'work_dir': 'build'} 20:27:52 INFO - [mozharness: 2016-08-11 03:27:52.978029Z] Running clobber step. 20:27:52 INFO - Running pre-action listener: _resource_record_pre_action 20:27:52 INFO - Running main action method: clobber 20:27:52 INFO - rmtree: /builds/slave/test/build 20:27:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:27:53 INFO - Running post-action listener: _resource_record_post_action 20:27:53 INFO - [mozharness: 2016-08-11 03:27:53.952004Z] Finished clobber step (success) 20:27:53 INFO - [mozharness: 2016-08-11 03:27:53.952105Z] Running read-buildbot-config step. 20:27:53 INFO - Running pre-action listener: _resource_record_pre_action 20:27:53 INFO - Running main action method: read_buildbot_config 20:27:53 INFO - Using buildbot properties: 20:27:53 INFO - { 20:27:53 INFO - "project": "", 20:27:53 INFO - "product": "firefox", 20:27:53 INFO - "script_repo_revision": "production", 20:27:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:27:53 INFO - "repository": "", 20:27:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:27:53 INFO - "buildid": "20160810173002", 20:27:53 INFO - "pgo_build": "True", 20:27:53 INFO - "basedir": "/builds/slave/test", 20:27:53 INFO - "buildnumber": 972, 20:27:53 INFO - "slavename": "talos-linux64-ix-067", 20:27:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:27:53 INFO - "platform": "ubuntu64_hw", 20:27:53 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:27:53 INFO - "branch": "fx-team", 20:27:53 INFO - "repo_path": "integration/fx-team", 20:27:53 INFO - "revision": "c4a79e57209adab8f38ca9ea9da8317bf748235a", 20:27:53 INFO - "stage_platform": "linux64-pgo", 20:27:53 INFO - "builduid": "456109daf319450bb6fde18e8cb67c8c", 20:27:53 INFO - "slavebuilddir": "test" 20:27:53 INFO - } 20:27:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 20:27:53 INFO - Running post-action listener: _resource_record_post_action 20:27:53 INFO - [mozharness: 2016-08-11 03:27:53.954751Z] Finished read-buildbot-config step (success) 20:27:53 INFO - [mozharness: 2016-08-11 03:27:53.954841Z] Running download-and-extract step. 20:27:53 INFO - Running pre-action listener: _resource_record_pre_action 20:27:53 INFO - Running main action method: download_and_extract 20:27:53 INFO - mkdir: /builds/slave/test/build/tests 20:27: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')]} 20:27:53 INFO - trying https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:27:53 INFO - Downloading https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:27:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:27:54 INFO - Downloaded 1361 bytes. 20:27:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:27:54 INFO - Using the following test package requirements: 20:27:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:27:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:27:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:27:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:54 INFO - u'jsshell-linux-x86_64.zip'], 20:27:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:27:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:27:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:27:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:27:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:27:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:27:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:27:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:27:54 INFO - trying https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:27:54 INFO - Downloading https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:27:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:27:55 INFO - Downloaded 21832512 bytes. 20:27:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:27:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:27:56 INFO - Return code: 0 20:27:56 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:27:56 INFO - trying https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:27:56 INFO - Downloading https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:27:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:27:58 INFO - Downloaded 21832512 bytes. 20:27:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:27:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:27:59 INFO - Return code: 0 20:27: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')]} 20:27:59 INFO - trying https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:27:59 INFO - Downloading https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:27:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:28:00 INFO - Downloaded 14413719 bytes. 20:28:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:28:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:28:00 INFO - Return code: 0 20:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:00 INFO - trying https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:28:00 INFO - Downloading https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:28:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:28:02 INFO - Downloaded 59338728 bytes. 20:28:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:28:02 INFO - mkdir: /builds/slave/test/properties 20:28:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:28:02 INFO - Writing to file /builds/slave/test/properties/build_url 20:28:02 INFO - Contents: 20:28:02 INFO - build_url:https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:28:03 INFO - Running post-action listener: _resource_record_post_action 20:28:03 INFO - Running post-action listener: set_extra_try_arguments 20:28:03 INFO - [mozharness: 2016-08-11 03:28:03.431760Z] Finished download-and-extract step (success) 20:28:03 INFO - [mozharness: 2016-08-11 03:28:03.431995Z] Running populate-webroot step. 20:28:03 INFO - Running pre-action listener: _resource_record_pre_action 20:28:03 INFO - Running main action method: populate_webroot 20:28:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:28:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:28:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:28:03 INFO - '--tppagecycles', 20:28:03 INFO - '7'], 20:28:03 INFO - 'tests': ['tsvgm']}}, 20:28:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:28:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:28:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:28:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:28:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:28:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:28:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:03 INFO - 'talos_options': ['--disable-e10s'], 20:28:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:28:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:28:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:03 INFO - 'talos_options': ['--disable-e10s'], 20:28:03 INFO - 'tests': ['damp', 'tps']}, 20:28:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:03 INFO - 'tests': ['damp', 'tps']}, 20:28:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:28:03 INFO - 'tests': ['dromaeo_dom']}, 20:28:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:28:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:28:03 INFO - 'tests': ['basic_compositor_video']}, 20:28:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:28:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:28:03 INFO - 'tests': ['a11yr', 20:28:03 INFO - 'ts_paint', 20:28:03 INFO - 'tpaint', 20:28:03 INFO - 'sessionrestore', 20:28:03 INFO - 'sessionrestore_no_auto_restore', 20:28:03 INFO - 'tabpaint']}, 20:28:03 INFO - 'other-e10s': {'tests': ['a11yr', 20:28:03 INFO - 'ts_paint', 20:28:03 INFO - 'tpaint', 20:28:03 INFO - 'sessionrestore', 20:28:03 INFO - 'sessionrestore_no_auto_restore', 20:28:03 INFO - 'tabpaint']}, 20:28:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:28:03 INFO - 'ts_paint', 20:28:03 INFO - 'tpaint', 20:28:03 INFO - 'sessionrestore', 20:28:03 INFO - 'sessionrestore_no_auto_restore', 20:28:03 INFO - 'tabpaint']}, 20:28:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:28:03 INFO - 'ts_paint', 20:28:03 INFO - 'tpaint', 20:28:03 INFO - 'sessionrestore', 20:28:03 INFO - 'sessionrestore_no_auto_restore', 20:28:03 INFO - 'tabpaint']}, 20:28:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:28:03 INFO - 'tests': ['a11yr', 20:28:03 INFO - 'ts_paint', 20:28:03 INFO - 'tpaint', 20:28:03 INFO - 'sessionrestore', 20:28:03 INFO - 'sessionrestore_no_auto_restore', 20:28:03 INFO - 'tabpaint']}, 20:28:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:28:03 INFO - 'tests': ['a11yr', 20:28:03 INFO - 'ts_paint', 20:28:03 INFO - 'tpaint', 20:28:03 INFO - 'sessionrestore', 20:28:03 INFO - 'sessionrestore_no_auto_restore', 20:28:03 INFO - 'tabpaint']}, 20:28:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:28:03 INFO - 'tests': ['tsvgx', 20:28:03 INFO - 'tsvgr_opacity', 20:28:03 INFO - 'tart', 20:28:03 INFO - 'tscrollx', 20:28:03 INFO - 'cart']}, 20:28:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:28:03 INFO - 'tsvgr_opacity', 20:28:03 INFO - 'tart', 20:28:03 INFO - 'tscrollx', 20:28:03 INFO - 'cart']}, 20:28:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:03 INFO - 'talos_options': ['--disable-e10s'], 20:28:03 INFO - 'tests': ['tp5o']}, 20:28:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:03 INFO - 'tests': ['tp5o']}, 20:28:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:03 INFO - 'talos_options': ['--disable-e10s', 20:28:03 INFO - '--xperf_path', 20:28:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:28:03 INFO - 'tests': ['tp5n']}, 20:28:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:03 INFO - 'talos_options': ['--xperf_path', 20:28:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:28:03 INFO - 'tests': ['tp5n']}}, 20:28:03 INFO - 'talos.zip': {'path': '', 20:28:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:28:03 INFO - Running post-action listener: _resource_record_post_action 20:28:03 INFO - [mozharness: 2016-08-11 03:28:03.450967Z] Finished populate-webroot step (success) 20:28:03 INFO - [mozharness: 2016-08-11 03:28:03.451056Z] Running create-virtualenv step. 20:28:03 INFO - Running pre-action listener: _resource_record_pre_action 20:28:03 INFO - Running main action method: create_virtualenv 20:28:03 INFO - Creating virtualenv /builds/slave/test/build/venv 20:28:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:28:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:28:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:28:03 INFO - Using real prefix '/usr' 20:28:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:28:04 INFO - Installing distribute.............................................................................................................................................................................................done. 20:28:05 INFO - Installing pip.................done. 20:28:06 INFO - Return code: 0 20:28:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:06 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 0x1314030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d33b0>, '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 0x15d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d4740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:28:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:28:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:28:06 INFO - Using env: {'DISPLAY': ':0', 20:28:06 INFO - 'HOME': '/home/cltbld', 20:28:06 INFO - 'LANG': 'en_US.UTF-8', 20:28:06 INFO - 'LANGUAGE': 'en_US:en', 20:28:06 INFO - 'LOGNAME': 'cltbld', 20:28:06 INFO - 'MAIL': '/var/mail/cltbld', 20:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:06 INFO - 'MOZ_NO_REMOTE': '1', 20:28:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:06 INFO - 'NO_EM_RESTART': '1', 20:28:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:06 INFO - 'PWD': '/builds/slave/test', 20:28:06 INFO - 'SHELL': '/bin/bash', 20:28:06 INFO - 'SHLVL': '1', 20:28:06 INFO - 'TERM': 'linux', 20:28:06 INFO - 'TMOUT': '86400', 20:28:06 INFO - 'USER': 'cltbld', 20:28:06 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410', 20:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:06 INFO - '_': '/tools/buildbot/bin/python'} 20:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:28:06 INFO - Cleaning up... 20:28:06 INFO - Return code: 0 20:28:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:06 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 0x1314030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d33b0>, '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 0x15d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d4740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:28:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:28:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:28:06 INFO - Using env: {'DISPLAY': ':0', 20:28:06 INFO - 'HOME': '/home/cltbld', 20:28:06 INFO - 'LANG': 'en_US.UTF-8', 20:28:06 INFO - 'LANGUAGE': 'en_US:en', 20:28:06 INFO - 'LOGNAME': 'cltbld', 20:28:06 INFO - 'MAIL': '/var/mail/cltbld', 20:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:06 INFO - 'MOZ_NO_REMOTE': '1', 20:28:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:06 INFO - 'NO_EM_RESTART': '1', 20:28:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:06 INFO - 'PWD': '/builds/slave/test', 20:28:06 INFO - 'SHELL': '/bin/bash', 20:28:06 INFO - 'SHLVL': '1', 20:28:06 INFO - 'TERM': 'linux', 20:28:06 INFO - 'TMOUT': '86400', 20:28:06 INFO - 'USER': 'cltbld', 20:28:06 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410', 20:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:06 INFO - '_': '/tools/buildbot/bin/python'} 20:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:06 INFO - Downloading/unpacking psutil>=3.1.1 20:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:28:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:28:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:28:08 INFO - Installing collected packages: psutil 20:28:08 INFO - Running setup.py install for psutil 20:28:08 INFO - building 'psutil._psutil_linux' extension 20:28:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:28:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:28:08 INFO - building 'psutil._psutil_posix' extension 20:28:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:28:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:28:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:28:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:28:08 INFO - Successfully installed psutil 20:28:08 INFO - Cleaning up... 20:28:08 INFO - Return code: 0 20:28:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:08 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 0x1314030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d33b0>, '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 0x15d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d4740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:28:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:28:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:28:08 INFO - Using env: {'DISPLAY': ':0', 20:28:08 INFO - 'HOME': '/home/cltbld', 20:28:08 INFO - 'LANG': 'en_US.UTF-8', 20:28:08 INFO - 'LANGUAGE': 'en_US:en', 20:28:08 INFO - 'LOGNAME': 'cltbld', 20:28:08 INFO - 'MAIL': '/var/mail/cltbld', 20:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:08 INFO - 'MOZ_NO_REMOTE': '1', 20:28:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:08 INFO - 'NO_EM_RESTART': '1', 20:28:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:08 INFO - 'PWD': '/builds/slave/test', 20:28:08 INFO - 'SHELL': '/bin/bash', 20:28:08 INFO - 'SHLVL': '1', 20:28:08 INFO - 'TERM': 'linux', 20:28:08 INFO - 'TMOUT': '86400', 20:28:08 INFO - 'USER': 'cltbld', 20:28:08 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410', 20:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:08 INFO - '_': '/tools/buildbot/bin/python'} 20:28:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:28:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:28:11 INFO - Installing collected packages: mozsystemmonitor 20:28:11 INFO - Running setup.py install for mozsystemmonitor 20:28:11 INFO - Successfully installed mozsystemmonitor 20:28:11 INFO - Cleaning up... 20:28:11 INFO - Return code: 0 20:28:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:11 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 0x1314030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d33b0>, '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 0x15d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d4740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:28:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:28:11 INFO - Using env: {'DISPLAY': ':0', 20:28:11 INFO - 'HOME': '/home/cltbld', 20:28:11 INFO - 'LANG': 'en_US.UTF-8', 20:28:11 INFO - 'LANGUAGE': 'en_US:en', 20:28:11 INFO - 'LOGNAME': 'cltbld', 20:28:11 INFO - 'MAIL': '/var/mail/cltbld', 20:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:11 INFO - 'MOZ_NO_REMOTE': '1', 20:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:11 INFO - 'NO_EM_RESTART': '1', 20:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:11 INFO - 'PWD': '/builds/slave/test', 20:28:11 INFO - 'SHELL': '/bin/bash', 20:28:11 INFO - 'SHLVL': '1', 20:28:11 INFO - 'TERM': 'linux', 20:28:11 INFO - 'TMOUT': '86400', 20:28:11 INFO - 'USER': 'cltbld', 20:28:11 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410', 20:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:11 INFO - '_': '/tools/buildbot/bin/python'} 20:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:11 INFO - Downloading/unpacking jsonschema==2.5.1 20:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:28:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:13 INFO - Downloading functools32-3.2.3-2.tar.gz 20:28:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:28:13 INFO - warning: no files found matching '*.txt' 20:28:13 INFO - no previously-included directories found matching 'build' 20:28:13 INFO - no previously-included directories found matching 'dist' 20:28:13 INFO - no previously-included directories found matching '.git*' 20:28:13 INFO - Installing collected packages: jsonschema, functools32 20:28:13 INFO - Running setup.py install for functools32 20:28:13 INFO - warning: no files found matching '*.txt' 20:28:13 INFO - no previously-included directories found matching 'build' 20:28:13 INFO - no previously-included directories found matching 'dist' 20:28:13 INFO - no previously-included directories found matching '.git*' 20:28:13 INFO - Successfully installed jsonschema functools32 20:28:13 INFO - Cleaning up... 20:28:13 INFO - Return code: 0 20:28:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1314030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d33b0>, '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 0x15d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d4740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:28:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:28:13 INFO - Using env: {'DISPLAY': ':0', 20:28:13 INFO - 'HOME': '/home/cltbld', 20:28:13 INFO - 'LANG': 'en_US.UTF-8', 20:28:13 INFO - 'LANGUAGE': 'en_US:en', 20:28:13 INFO - 'LOGNAME': 'cltbld', 20:28:13 INFO - 'MAIL': '/var/mail/cltbld', 20:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:13 INFO - 'MOZ_NO_REMOTE': '1', 20:28:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:13 INFO - 'NO_EM_RESTART': '1', 20:28:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:13 INFO - 'PWD': '/builds/slave/test', 20:28:13 INFO - 'SHELL': '/bin/bash', 20:28:13 INFO - 'SHLVL': '1', 20:28:13 INFO - 'TERM': 'linux', 20:28:13 INFO - 'TMOUT': '86400', 20:28:13 INFO - 'USER': 'cltbld', 20:28:13 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410', 20:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:13 INFO - '_': '/tools/buildbot/bin/python'} 20:28:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:28:14 INFO - Cleaning up... 20:28:14 INFO - Return code: 0 20:28:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1314030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d33b0>, '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 0x15d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d4740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:28:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:28:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:28:14 INFO - Using env: {'DISPLAY': ':0', 20:28:14 INFO - 'HOME': '/home/cltbld', 20:28:14 INFO - 'LANG': 'en_US.UTF-8', 20:28:14 INFO - 'LANGUAGE': 'en_US:en', 20:28:14 INFO - 'LOGNAME': 'cltbld', 20:28:14 INFO - 'MAIL': '/var/mail/cltbld', 20:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:14 INFO - 'MOZ_NO_REMOTE': '1', 20:28:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:14 INFO - 'NO_EM_RESTART': '1', 20:28:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:14 INFO - 'PWD': '/builds/slave/test', 20:28:14 INFO - 'SHELL': '/bin/bash', 20:28:14 INFO - 'SHLVL': '1', 20:28:14 INFO - 'TERM': 'linux', 20:28:14 INFO - 'TMOUT': '86400', 20:28:14 INFO - 'USER': 'cltbld', 20:28:14 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410', 20:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:14 INFO - '_': '/tools/buildbot/bin/python'} 20:28:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:14 INFO - Downloading/unpacking blobuploader==1.2.4 20:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:16 INFO - Downloading blobuploader-1.2.4.tar.gz 20:28:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:28:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:28:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:16 INFO - Downloading docopt-0.6.1.tar.gz 20:28:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:28:16 INFO - Installing collected packages: blobuploader, requests, docopt 20:28:16 INFO - Running setup.py install for blobuploader 20:28:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:28:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:28:17 INFO - Running setup.py install for requests 20:28:17 INFO - Running setup.py install for docopt 20:28:17 INFO - Successfully installed blobuploader requests docopt 20:28:17 INFO - Cleaning up... 20:28:17 INFO - Return code: 0 20:28:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:28:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:17 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 0x1314030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d33b0>, '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 0x15d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d4740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:28:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:28:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:28:17 INFO - Using env: {'DISPLAY': ':0', 20:28:17 INFO - 'HOME': '/home/cltbld', 20:28:17 INFO - 'LANG': 'en_US.UTF-8', 20:28:17 INFO - 'LANGUAGE': 'en_US:en', 20:28:17 INFO - 'LOGNAME': 'cltbld', 20:28:17 INFO - 'MAIL': '/var/mail/cltbld', 20:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:17 INFO - 'MOZ_NO_REMOTE': '1', 20:28:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:17 INFO - 'NO_EM_RESTART': '1', 20:28:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:17 INFO - 'PWD': '/builds/slave/test', 20:28:17 INFO - 'SHELL': '/bin/bash', 20:28:17 INFO - 'SHLVL': '1', 20:28:17 INFO - 'TERM': 'linux', 20:28:17 INFO - 'TMOUT': '86400', 20:28:17 INFO - 'USER': 'cltbld', 20:28:17 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410', 20:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:17 INFO - '_': '/tools/buildbot/bin/python'} 20:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:28:17 INFO - Running setup.py (path:/tmp/pip-gXJ7XM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:28:17 INFO - Running setup.py (path:/tmp/pip-Aazj1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:28:17 INFO - Running setup.py (path:/tmp/pip-F14FgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:28:17 INFO - Running setup.py (path:/tmp/pip-pF3IKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:28:18 INFO - Running setup.py (path:/tmp/pip-yox8r4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:28:18 INFO - Running setup.py (path:/tmp/pip-qJrZG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:28:18 INFO - Running setup.py (path:/tmp/pip-7hfyIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:28:18 INFO - Running setup.py (path:/tmp/pip-dOt6c9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:28:18 INFO - Running setup.py (path:/tmp/pip-LjExnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:28:18 INFO - Running setup.py (path:/tmp/pip-IiwNp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:28:18 INFO - Running setup.py (path:/tmp/pip-gP9iv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:28:18 INFO - Running setup.py (path:/tmp/pip-QFrQdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:28:18 INFO - Running setup.py (path:/tmp/pip-ASAr5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:28:18 INFO - Running setup.py (path:/tmp/pip-d3PCg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:28:18 INFO - Running setup.py (path:/tmp/pip-Rfkuvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:28:18 INFO - Running setup.py (path:/tmp/pip-sgFJYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:28:18 INFO - Running setup.py (path:/tmp/pip-0Xotw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:28:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:28:18 INFO - Running setup.py install for manifestparser 20:28:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:28:19 INFO - Running setup.py install for mozcrash 20:28:19 INFO - Running setup.py install for mozdebug 20:28:19 INFO - Running setup.py install for mozdevice 20:28:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:28:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:28:19 INFO - Running setup.py install for mozfile 20:28:19 INFO - Running setup.py install for mozhttpd 20:28:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:28:19 INFO - Running setup.py install for mozinfo 20:28:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:28:19 INFO - Running setup.py install for mozInstall 20:28:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:28:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:28:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:28:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:28:19 INFO - Running setup.py install for mozleak 20:28:19 INFO - Running setup.py install for mozlog 20:28:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:28:20 INFO - Running setup.py install for moznetwork 20:28:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:28:20 INFO - Running setup.py install for mozprocess 20:28:20 INFO - Running setup.py install for mozprofile 20:28:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:28:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:28:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:28:20 INFO - Running setup.py install for mozrunner 20:28:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:28:20 INFO - Running setup.py install for mozscreenshot 20:28:20 INFO - Running setup.py install for moztest 20:28:20 INFO - Running setup.py install for mozversion 20:28:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:28:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:28:20 INFO - Cleaning up... 20:28:20 INFO - Return code: 0 20:28:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:20 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 0x1314030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d33b0>, '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 0x15d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d4740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:28:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:28:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:28:20 INFO - Using env: {'DISPLAY': ':0', 20:28:20 INFO - 'HOME': '/home/cltbld', 20:28:20 INFO - 'LANG': 'en_US.UTF-8', 20:28:20 INFO - 'LANGUAGE': 'en_US:en', 20:28:20 INFO - 'LOGNAME': 'cltbld', 20:28:20 INFO - 'MAIL': '/var/mail/cltbld', 20:28:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:20 INFO - 'MOZ_NO_REMOTE': '1', 20:28:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:20 INFO - 'NO_EM_RESTART': '1', 20:28:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:20 INFO - 'PWD': '/builds/slave/test', 20:28:20 INFO - 'SHELL': '/bin/bash', 20:28:20 INFO - 'SHLVL': '1', 20:28:20 INFO - 'TERM': 'linux', 20:28:20 INFO - 'TMOUT': '86400', 20:28:20 INFO - 'USER': 'cltbld', 20:28:20 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410', 20:28:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:20 INFO - '_': '/tools/buildbot/bin/python'} 20:28:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:28:20 INFO - Running setup.py (path:/tmp/pip-5GAZPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:28:21 INFO - Running setup.py (path:/tmp/pip-FbC5V1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:28:21 INFO - Running setup.py (path:/tmp/pip-wZ0Uqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:28:21 INFO - Running setup.py (path:/tmp/pip-pk64T8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:28:21 INFO - Running setup.py (path:/tmp/pip-dzifif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:28:21 INFO - Running setup.py (path:/tmp/pip-QUAPNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:28:21 INFO - Running setup.py (path:/tmp/pip-X762UO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:28:21 INFO - Running setup.py (path:/tmp/pip-3npdJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:28:21 INFO - Running setup.py (path:/tmp/pip-HzSfmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:28:21 INFO - Running setup.py (path:/tmp/pip-ahbYrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:28:21 INFO - Running setup.py (path:/tmp/pip-ENYltQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:28:21 INFO - Running setup.py (path:/tmp/pip-LW4ubT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:28:21 INFO - Running setup.py (path:/tmp/pip-DgeLxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:28:21 INFO - Running setup.py (path:/tmp/pip-M3bDuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:28:21 INFO - Running setup.py (path:/tmp/pip-04AhXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:28:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:28:22 INFO - Running setup.py (path:/tmp/pip-K9rXI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:28:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:28:22 INFO - Running setup.py (path:/tmp/pip-OoI3Hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:28:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:28:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:28:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:28:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:28:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:28:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:28:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:24 INFO - Downloading blessings-1.6.tar.gz 20:28:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:28:24 INFO - Installing collected packages: blessings 20:28:24 INFO - Running setup.py install for blessings 20:28:24 INFO - Successfully installed blessings 20:28:24 INFO - Cleaning up... 20:28:24 INFO - Return code: 0 20:28:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:28:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:28:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:28:24 INFO - Reading from file tmpfile_stdout 20:28:24 INFO - Current package versions: 20:28:24 INFO - argparse == 1.2.1 20:28:24 INFO - blessings == 1.6 20:28:24 INFO - blobuploader == 1.2.4 20:28:24 INFO - docopt == 0.6.1 20:28:24 INFO - functools32 == 3.2.3-2 20:28:24 INFO - jsonschema == 2.5.1 20:28:24 INFO - manifestparser == 1.1 20:28:24 INFO - mozInstall == 1.12 20:28:24 INFO - mozcrash == 0.17 20:28:24 INFO - mozdebug == 0.1 20:28:24 INFO - mozdevice == 0.48 20:28:24 INFO - mozfile == 1.2 20:28:24 INFO - mozhttpd == 0.7 20:28:24 INFO - mozinfo == 0.9 20:28:24 INFO - mozleak == 0.1 20:28:24 INFO - mozlog == 3.3 20:28:24 INFO - moznetwork == 0.27 20:28:24 INFO - mozprocess == 0.23 20:28:24 INFO - mozprofile == 0.28 20:28:24 INFO - mozrunner == 6.12 20:28:24 INFO - mozscreenshot == 0.1 20:28:24 INFO - mozsystemmonitor == 0.3 20:28:24 INFO - moztest == 0.7 20:28:24 INFO - mozversion == 1.4 20:28:24 INFO - psutil == 3.1.1 20:28:24 INFO - requests == 1.2.3 20:28:24 INFO - wsgiref == 0.1.2 20:28:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:24 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 0x1314030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d33b0>, '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 0x15d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d4740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:28:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:28:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:28:24 INFO - Using env: {'DISPLAY': ':0', 20:28:24 INFO - 'HOME': '/home/cltbld', 20:28:24 INFO - 'LANG': 'en_US.UTF-8', 20:28:24 INFO - 'LANGUAGE': 'en_US:en', 20:28:24 INFO - 'LOGNAME': 'cltbld', 20:28:24 INFO - 'MAIL': '/var/mail/cltbld', 20:28:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:24 INFO - 'MOZ_NO_REMOTE': '1', 20:28:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:24 INFO - 'NO_EM_RESTART': '1', 20:28:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:24 INFO - 'PWD': '/builds/slave/test', 20:28:24 INFO - 'SHELL': '/bin/bash', 20:28:24 INFO - 'SHLVL': '1', 20:28:24 INFO - 'TERM': 'linux', 20:28:24 INFO - 'TMOUT': '86400', 20:28:24 INFO - 'USER': 'cltbld', 20:28:24 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410', 20:28:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:24 INFO - '_': '/tools/buildbot/bin/python'} 20:28:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:28:24 INFO - Cleaning up... 20:28:24 INFO - Return code: 0 20:28:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:24 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 0x1314030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d33b0>, '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 0x15d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d4740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:28:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:28:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:28:24 INFO - Using env: {'DISPLAY': ':0', 20:28:24 INFO - 'HOME': '/home/cltbld', 20:28:24 INFO - 'LANG': 'en_US.UTF-8', 20:28:24 INFO - 'LANGUAGE': 'en_US:en', 20:28:24 INFO - 'LOGNAME': 'cltbld', 20:28:24 INFO - 'MAIL': '/var/mail/cltbld', 20:28:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:24 INFO - 'MOZ_NO_REMOTE': '1', 20:28:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:24 INFO - 'NO_EM_RESTART': '1', 20:28:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:24 INFO - 'PWD': '/builds/slave/test', 20:28:24 INFO - 'SHELL': '/bin/bash', 20:28:24 INFO - 'SHLVL': '1', 20:28:24 INFO - 'TERM': 'linux', 20:28:24 INFO - 'TMOUT': '86400', 20:28:24 INFO - 'USER': 'cltbld', 20:28:24 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410', 20:28:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:24 INFO - '_': '/tools/buildbot/bin/python'} 20:28:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:28:24 INFO - Cleaning up... 20:28:24 INFO - Return code: 0 20:28:24 INFO - Running post-action listener: _resource_record_post_action 20:28:24 INFO - Running post-action listener: _start_resource_monitoring 20:28:25 INFO - Starting resource monitoring. 20:28:25 INFO - [mozharness: 2016-08-11 03:28:25.008615Z] Finished create-virtualenv step (success) 20:28:25 INFO - [mozharness: 2016-08-11 03:28:25.009104Z] Running install step. 20:28:25 INFO - Running pre-action listener: _resource_record_pre_action 20:28:25 INFO - Running main action method: install 20:28:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:28:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:28:25 INFO - Reading from file tmpfile_stdout 20:28:25 INFO - Detecting whether we're running mozinstall >=1.0... 20:28:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:28:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:28:25 INFO - Reading from file tmpfile_stdout 20:28:25 INFO - Output received: 20:28:25 INFO - Usage: mozinstall [options] installer 20:28:25 INFO - Options: 20:28:25 INFO - -h, --help show this help message and exit 20:28:25 INFO - -d DEST, --destination=DEST 20:28:25 INFO - Directory to install application into. [default: 20:28:25 INFO - "/builds/slave/test"] 20:28:25 INFO - --app=APP Application being installed. [default: firefox] 20:28:25 INFO - mkdir: /builds/slave/test/build/application 20:28:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:28:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:28:42 INFO - Reading from file tmpfile_stdout 20:28:42 INFO - Output received: 20:28:42 INFO - /builds/slave/test/build/application/firefox/firefox 20:28:42 INFO - Running post-action listener: _resource_record_post_action 20:28:42 INFO - [mozharness: 2016-08-11 03:28:42.207180Z] Finished install step (success) 20:28:42 INFO - [mozharness: 2016-08-11 03:28:42.207430Z] Running run-tests step. 20:28:42 INFO - Running pre-action listener: _resource_record_pre_action 20:28:42 INFO - Running main action method: run_tests 20:28:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:28:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:28:42 INFO - Python 2.7.3 20:28:42 INFO - Return code: 0 20:28:42 INFO - grabbing minidump binary from tooltool 20:28: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')]} 20:28:42 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 0x15d33b0>, '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 0x15d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d4740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:28:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:28:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:28:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:28:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:28:42 INFO - Return code: 0 20:28:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:28:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:28:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:28:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:28:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:28:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:28:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:28:42 INFO - Using env: {'DISPLAY': ':0', 20:28:42 INFO - 'HOME': '/home/cltbld', 20:28:42 INFO - 'LANG': 'en_US.UTF-8', 20:28:42 INFO - 'LANGUAGE': 'en_US:en', 20:28:42 INFO - 'LOGNAME': 'cltbld', 20:28:42 INFO - 'MAIL': '/var/mail/cltbld', 20:28:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:28:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:28:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:42 INFO - 'MOZ_NO_REMOTE': '1', 20:28:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:28:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:42 INFO - 'NO_EM_RESTART': '1', 20:28:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:42 INFO - 'PWD': '/builds/slave/test', 20:28:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:28:42 INFO - 'SHELL': '/bin/bash', 20:28:42 INFO - 'SHLVL': '1', 20:28:42 INFO - 'TERM': 'linux', 20:28:42 INFO - 'TMOUT': '86400', 20:28:42 INFO - 'USER': 'cltbld', 20:28:42 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410', 20:28:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:42 INFO - '_': '/tools/buildbot/bin/python'} 20:28:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:28:42 INFO - mozversion application_buildid: 20160810173002 20:28:42 INFO - mozversion application_changeset: c4a79e57209adab8f38ca9ea9da8317bf748235a 20:28:42 INFO - mozversion application_display_name: Nightly 20:28:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:28:42 INFO - mozversion application_name: Firefox 20:28:42 INFO - mozversion application_remotingname: firefox 20:28:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:28:42 INFO - mozversion application_vendor: Mozilla 20:28:42 INFO - mozversion application_version: 51.0a1 20:28:42 INFO - mozversion platform_buildid: 20160810173002 20:28:42 INFO - mozversion platform_changeset: c4a79e57209adab8f38ca9ea9da8317bf748235a 20:28:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:28:42 INFO - mozversion platform_version: 51.0a1 20:28:42 INFO - using testdate: 1470886122 20:28:42 INFO - actual date: 1470886122 20:28:42 INFO - starting webserver on 'localhost:48775' 20:28:42 INFO - SUITE-START | Running 2 tests 20:28:42 INFO - TEST-START | dromaeo_css 20:28:42 INFO - operating with platform_type : linux_ 20:28:42 INFO - Initialising browser for dromaeo_css test... 20:28:42 INFO - TEST-INFO | started process 25097 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfqt0kr/profile http://localhost:48775/getInfo.html) 20:28:46 INFO - PROCESS | 25097 | __metrics Screen width/height:1600/1200 20:28:46 INFO - PROCESS | 25097 | colorDepth:24 20:28:46 INFO - PROCESS | 25097 | Browser inner width/height: 1024/697 20:28:46 INFO - PROCESS | 25097 | __metrics 20:28:46 INFO - PROCESS | 25097 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:28:46 INFO - PROCESS | 25097 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:28:47 INFO - TEST-INFO | 25097: exit 0 20:28:47 INFO - Browser initialized. 20:28:47 INFO - Running cycle 1/1 for dromaeo_css test... 20:28:47 INFO - TEST-INFO | started process 25176 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfqt0kr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:28:59 INFO - PROCESS | 25176 | RSS: Main: 155037696 20:28:59 INFO - PROCESS | 25176 | 20:29:51 INFO - PROCESS | 25176 | 1470886191088 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:32:00 INFO - PROCESS | 25176 | Cycle 1(1): loaded http://localhost:48775/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48775/tests/dromaeo/cssquery-ext.html) 20:32:01 INFO - PROCESS | 25176 | RSS: Main: 261455872 20:32:01 INFO - PROCESS | 25176 | 20:35:03 INFO - PROCESS | 25176 | Cycle 1(1): loaded http://localhost:48775/tests/dromaeo/cssquery-ext.html (next: http://localhost:48775/tests/dromaeo/cssquery-jquery.html) 20:35:04 INFO - PROCESS | 25176 | RSS: Main: 244142080 20:35:04 INFO - PROCESS | 25176 | 20:38:06 INFO - PROCESS | 25176 | Cycle 1(1): loaded http://localhost:48775/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48775/tests/dromaeo/cssquery-mootools.html) 20:38:07 INFO - PROCESS | 25176 | RSS: Main: 215654400 20:38:07 INFO - PROCESS | 25176 | 20:41:09 INFO - PROCESS | 25176 | Cycle 1(1): loaded http://localhost:48775/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48775/tests/dromaeo/cssquery-prototype.html) 20:41:09 INFO - PROCESS | 25176 | RSS: Main: 239808512 20:41:09 INFO - PROCESS | 25176 | 20:44:12 INFO - PROCESS | 25176 | Cycle 1(1): loaded http://localhost:48775/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48775/tests/dromaeo/cssquery-yui.html) 20:44:12 INFO - PROCESS | 25176 | RSS: Main: 182960128 20:44:12 INFO - PROCESS | 25176 | 20:47:15 INFO - PROCESS | 25176 | Cycle 1(1): loaded http://localhost:48775/tests/dromaeo/cssquery-yui.html (next: http://localhost:48775/tests/dromaeo/cssquery-dojo.html) 20:47:16 INFO - PROCESS | 25176 | RSS: Main: 272379904 20:47:16 INFO - PROCESS | 25176 | 20:47:16 INFO - PROCESS | 25176 | __start_tp_report 20:47:16 INFO - PROCESS | 25176 | _x_x_mozilla_page_load 20:47:16 INFO - PROCESS | 25176 | _x_x_mozilla_page_load_details 20:47:16 INFO - PROCESS | 25176 | |i|pagename|runs| 20:47:16 INFO - PROCESS | 25176 | |0;dojo.html;3028;3032.029750479846;3053.9694603053968;3071.124729452104;3090.181102007968;5261.552768014723;5348.251244825728;5365.731713414329;5454.809081682142;5478.04134276501;5404.108322126855;5411.242426060355;5436.91844622331;5451;5518.613697041209;4907.631927605435;4935.531124543163;4973.4280557735965;4987.875303117415;5160.819371322004;5049.4950504949575;5083.542481176693;5102.2091575805625;5114.744262786846;5120.948790512084;4852.902941941159;4885.975570122162;4921.360223171001;4962.801487940478;5041.672291301072;4861.784553861535;4872.098661747588;4875.68308059975;4944.085344211332;5002.849914502571;4905.8773530661665;4929.5915110898295;4941.950580494185;4956.454789973136;5031.245313203049;5308.92036619451;5411.080116380225;5459.808906688247;5483.122700367922;5487.6158668893195;5862.296524417055;5864.296284445893;5904.409559044061;5913.9112913306335;5916.349201587822;5904.084866845646;5948.762049518057;5960.552958528127;5964;5975.492083172892;5323.307969963918;5412.648177868466;5420.891582168413;5459.071957767189;5539.25220095286;6032.507908803344;6064.090386442069;6066.939330606638;6069.393060693984;6076.392360763976;5823.767049318065;5828.358880523224;5831.562632802556;5832.825015249549;5834.883302334015;5586;5744.569157313218;5862.941370586324;5864.03243464832;5937.376575459514;5753.3958934311295;5797.681127537941;5797.855053623609;5834.970825145847;5847.766089356463;5764.250647415893;5769.365369809318;5773.191753154561;5830.3586605473365;5831.358550559435;4288.292431748727;4327.242732521796;4420.469543654782;4423.137939240115;4454.532274111237;3916.353801622757;3916.706247031484;3922.7842468663926;3931.4495970564144;3973.602639736061;5465.9180112298345;5477.780888764405;5531.308586426697;5579.637323573955;5585.134304182858;5669.801556945487;5851.414858514115;5858.8242352729485;5865.912011319833;5869.618474799125;5460.290162278879;5523;5535.252740880011;5566.304211973504;5609.214709940612;5057.190849464068;5060.797568097309;5076.746162691925;5080.13637681595;5129.230615407719;5887.735051922759;6052.243469566304;6095.786647467317;6100.206973093469;6103.664298463538;5839.445252700986;5898.734556945034;5910.290765108214;5948.315943666534;5995.190649262294;6110.327863934875;6121.418465245794;6121.877562448637;6124.418180272867;6163.691815409301;5466.34403871522;5792.884142317214;5837.883242335045;5850.619709718854;5851.970740146272;5798.942010580009;5840.737166827588;5849.298084229919;5898.882022359615;5945.91081133792;5708.686022268815;5746.511546518593;5756.65460072397;5758.769649214152;5765.452282033368;5569.888602228014;5732.398098199629;5734.770609175586;5738.569607279387;5745.396733342939;5606.915896261641;5637.661740295595;5651.321841379061;5687.857803554779;5728.541716662574;5770.13447982806;5782.595218334676;5819.0689489681445;5836.299644042742;5838.2702162229725;5396.3524377075;5630.831075067755;5636.041872881702;5639.577031722719;5640.210370548209 20:47:16 INFO - PROCESS | 25176 | |1;ext.html;576.8615532272254;586.9706514674267;597.7489454429142;607.0590584593879;617.1360095865788;43522.34716479251;44709;44771.552284477184;44838.55161448385;48793.268100978516;45887.77056114715;46558.767206163924;46569.767151164284;46648.76675616617;46676.766616166875;8026.117127116042;8879.378443508973;9022.323325750562;9028.638854445848;10587.417692026935;10421.739456513573;10848.457577121151;10853.782924341509;10856.077233435168;10859.185561082912;10968.23222374434;10984.615538456155;11007.504662290215;11013.724656883562;11016.394098324588;10780.02979731824;10845.783084338347;10875.456227188688;10884.07485363741;10890.61882834105;10660.680179594547;10719.946400267949;10731.248812583044;10732.624358147505;10738.731531711692;43035;43230.56769432328;43375.56624433747;43497;43514.782426087986;3322.8670853165845;3346.5147553604593;3351.447011243142;3368.781029233092;3488.5116083748294;32157.83921080403;34154.65845341564;34278.31443371119;34438.65561344379;35832.925012249674;4270.466191726035;4272;4364.869053928387;4409.140217657558;4417.536158703322;343202;355729;356553.9999999974;358156;484954.99999999645;60753.69623151856;61696.07455888165;61710.69144654338;61712.38287617156;61764.69117654383;37336.81331593324;38141;65906;66032;66274.33725662682;17464.126793660267;17622.735658965124;17623.471295861145;17628.647427051386;17644.735328970077;12047.33739644328;12931.353432328346;13357.465701371837;13446.462141514425;13450.596482105553;19530.396524116062;19677.21291148338;19720.40838774839;19739.901300493406;19814.50463738418;7181.533200342065;7237.986681864543;7281;7334.96332518334;7460.552366858006;1044.3525014490913;1086.9945650271698;1096.0957210301533;1152.573547787324;1199.682084247675;33133.83433082819;33599.83200083984;33660.83169584136;33848.66151338455;34034.76852638623;1124.1793490751634;1130.5534313945946;1138.2544433396138;1151.8272259161026;1223.1682455930054;17246.741298880526;17538.649227015387;17557.20992555338;17619.911900440417;17648.382306619205;520862;523063;524366;529030;529977;58994.41005589975;59347;59378.40621593815;59450;59481;1244.104244943639;1365.0922136778931;1400.9509667161803;1411.535168926315;1425.2161311278755;32855.50716739203;33957.49063763996;34264.828675856465;34551.82724086363;34836.129096772784;49760.751196243786;50855.74572127264;50886.74556627193;50917.49082509128;50967.490325096274;385448;388640;388676;390241;391041;28733.856330718212;29517.852410737807;29547.85226073856;31105;31344.373112538076;49275;49316.75341623269;49539.50460495349;50062.499375005784;50253.497465024884;41073.58926410697;42063.57936420719;42269;42544.36183457312;44204.557954420045;42153.57846421619;42244.577554225296;42378.78810605927;43595;43652;41745.37381939334;41861.16277674369;43029.78485107554;43077;43172.13655726931;34797.8260108708;37319.25361492809;37580.90715981507;37716.62283377131;38324.80837595906;28792.856035719687;28800.135995920155;28950.565741514314;28951.420971580872;29096.27259318534 20:47:16 INFO - PROCESS | 25176 | |2;jquery.html;367.42497990644654;373.89530931339215;395.7467220978574;401.2036108324974;422.13041135261363;15387.538373848774;17509.824901750977;19981.30065447708;20000.0999955002;20185.59628807423;19129.71305430416;19598;19651;19813.90093049533;19960;5756.395578464253;5836.766529338822;5893.970530147343;5942.049272116462;5956.642601443928;5569.554435645159;5696.943030569703;5703.57223208259;5704.743286552115;5818.679972601505;5614.635048721841;5649.604527683064;5663.631863928852;5744.31068271808;5773.769049238025;5739.655620662732;5767.682777447239;5850.4734573888345;5856.677882716449;5862.06207006879;4542.682012259143;4546.249868771649;4562.1560011398;4641.76791160444;5106.029854327666;22875.313740587808;22950.540989180125;23364.766352336428;23500.76499235003;23897.163599274118;2164.6103701333755;2673.255981945816;2750.6974232834373;2997.9100626981226;3053.3587946531256;10858.565657373696;11090.833637495443;11136.220464567483;11180.273282236629;11234;1852.6479968806018;1899.335232668555;1955.9706604400944;1977.7824439311664;2014.2949967511254;78402.06468070703;84179;85985;87078.99999999936;87797;10920.344779313267;11076;11152.10783137347;11424.942875285737;11537.192396532162;15841.128737919295;15912.840871591136;15915.204239787965;15928.76106858398;15964.600884977968;8326.916730832736;8427.873581896276;8440.366972477088;8601.31189504838;8674.956625216833;8104.594770261463;8206.343492520584;8230.465019773816;8429.452085614415;8437.468759372165;4885;4901.436334821541;4914.729689867092;4948.604111671129;5053.494650534917;1918.6642337590865;1953.247999520195;1960.7058941158941;2023.736914201174;2036.53159773253;887.5917078143997;961.20700422152;980.2990861534038;1050.112654806687;1060.1359891688248;20035;20120.89939550293;20334.186632534827;20589.588208235753;20725.58548829015;976.3897564022486;981.2983716642492;999.7900440907491;1024.4826362686795;1025.4718819807806;9496.43021418717;11304.717382065513;11372.886271137348;11395.94302028501;11428.714282143013;452371;463787;464056;469650;478154.35687966214;96347;98141;99420;99704.50147749214;103987.4800625992;966.5167416291854;969.5927710361665;1000.7398076500162;1007.1439276614818;1009.6365308489085;14001.299935003413;16340.59148521249;17214.225359858585;17909.462716118538;18117.728234076236;43594.56405435905;43620.78189609032;44573.331400029674;44700.32949505825;45465;62395;63131.36868631255;63297;64068.679656601416;66155.66922165359;8380.706675266336;8582.313414926915;8618;8816.779580510538;9100.31747618918;12167.39163041862;13104.934475327562;13490.392932317873;13644.317784110557;13977.371018304404;11020.559177633126;11332.150088743541;11816.054715622558;11863.58477453285;12257.693557660774;9975.102240798364;10040.949795250977;11413.543458261576;11781.352025638673;12366.134370593973;12140.757184856076;12208.938955305166;12209.267443953391;12296.262224266573;12313.630591082281;8642.956785216034;8779.209871111376;8840.248578870867;8867.0689577596;9102.59038343263;8735.877147992967;11622.94188529052;11692;11872.76254474923;12143.210691305037 20:47:16 INFO - PROCESS | 25176 | |3;mootools.html;1328.0305377074742;1420.630636034631;1510.2297828107664;1641.5978085369086;1819.4268805326321;8597.1402859714;8996.145366190209;9096.363254572174;9362.81274374512;9379.71860844174;9173.128552787475;9271.258299336054;9289.581968811402;9291.396059256143;9300;2387.7731615496546;2412.8190385721055;2414.1912459326145;2414.8068154547595;2415.5651982643117;2344.742078371378;2376.702912135983;2402;2402.915897943564;2404.5551572959057;2351.9176828810996;2375.58427275227;2383.5828729972272;2392.055138220402;2405.9759402406016;2327.848689835172;2334.2297041976108;2402.6636270922086;2410.554047501209;2415.3961509622595;2282.2696737044153;2305.1125316753005;2309.9538009239723;2310.2838120182796;2310.4223944013997;9023.864642030374;9140.771480712969;9287.76780580484;9307.581158847868;9308.581113849894;5254.395744489394;5383.192521121824;5391.541718953894;5401.594880383947;5413.945860541384;3394.35507253621;3398.745094117951;3423.058658868806;3463.79217246966;3466.532018177539;1090.2804149261528;1097.8517900083466;1108.3626914524182;1108.8780234174235;1117.6255954255334;12965.222086674736;13028.218306901616;13083.738325233537;13084;13110.86889131106;4268.189044081614;4464.374987501752;4508.752018638941;4590.862274131781;4608.239640459354;10165.9325770793;10181.083702466665;10193.0316619921;10193.74515637115;10202.081812636898;5229;5234.502722241381;5238.1618940969265;5240.9475905241225;5241.449647787003;4350.869473915787;4755.857324280277;4880.316755654211;4914.778834952435;4929.260610908321;3816.580176180618;3911.0808959894403;3984.322665146932;4009.67922566194;4025.577314382006;1161.0943464098018;1166.2302880099094;1171.0807016492013;1171.7305019845312;1180.740237147826;779.9103103143211;919.8620206969008;941.8775559177263;979.9216062714966;982.611868312027;6071.332153463116;6156.29202641693;6206.286277078104;6358.745650173942;6446.871062578816;434.13823560232913;436.50456731609216;439.3124759750979;447.09240242307516;455.13524303823;4153.854615088458;4232.597903199191;4242.427272318259;4263.253930562201;4291.527931927485;11274.774504509864;11780.941095294469;11797.17419780607;11851.46668399924;11864.347460889734;11742.412879355998;11750.764984700258;11751.47118379675;11753.588624398106;11755.294682319089;8064.798380040546;8449.619767110495;8468.068512463624;8665.306775457948;8666.393352465393;6202.317745048132;6282.340354262737;6304.968475157595;6402.775902843565;6551.6069035858;9964.601415943282;10316.587336506456;10721.731956701145;10764.300320479144;10781.083607893417;10149.34029288094;10725.30285531438;10731.731706707082;10818.459077046273;10872.402017889091;7144.428445724226;7380.741674041383;7491.812704682427;7691.50005249657;7960.363170946426;8728.738137855875;9034.91581010283;9089.636414543344;9092.318076144447;9098.181163695299;7858.253465920729;7964.123946365779;8152.83694326122;8177.141400153137;8397.95801020991;7811.960940195263;7825.452218344662;7899.723509677134;7944.285014348737;7971.681132754857;7193.5324203926575;7204.855902882018;7259.05632267823;7296.9270307298375;7299.5620262784405;5312.335958005249;5315.176147697113;5345.9465405347;5394.433584473573;5567.05360088794;5438.83683489496;5464.80873169453;5518.33779946409;5528.557715382679;5594.1608758686525 20:47:16 INFO - PROCESS | 25176 | |4;prototype.html;329.1674085766397;335.4498622259494;344.76900476680623;345.37487148261647;347.3885960709153;5208.1927301268315;5288.576913846892;5298.549623282016;5300.204969254613;5308.203769434577;4994.450610432849;5121.411037730662;5138.177891537345;5144.434112247659;5270.736463176835;4045.393191021341;4070.8778736637946;4147.5645057269;4178.164367126572;4218.177455396199;4177.644900183488;4177.686673499485;4184.4351012613215;4184.91630167398;4202.075543380452;4033.8705162554534;4134.090500089976;4166.375043743433;4168.166366726667;4173.123644034757;4135.813888375031;4141.8964525886795;4150.4682143892205;4160.563140870196;4166.562510936354;3710.3135919854913;3712.6844218241213;3713.9071523211865;3718.4050551911837;3734.869279575229;5032.270320803463;5147.433782283946;5150.61370397218;5150.97424512875;5156.149235376159;4703.811847526094;4750.548697873696;4757.096151731194;4764.452088009889;4770.330384365479;5461.42655021225;5470.8085217017615;5481.369642491125;5490.972545137289;5513.9448605513835;3967.3850553164307;4058.939115913264;4072.8981775455554;4074.348104303327;4084.9379161417946;5676.744546495418;5678.432156784289;5681.460261275213;5682.54539636828;5695.746935674187;4166.854160104382;4177.4778152730905;4179.784714101531;4183.55262171627;4190.266703326905;4078.34746440574;4227.133437645275;4239.703220774516;4247.0444150066605;4265.50946641134;4685.9531404686195;4691.225947718656;4727.409073865767;4794.7842347093765;4809.591184749265;5461.344638643388;5475.233467314579;5481.616286859961;5517.972410137923;5538.889222215533;1363.9770172370722;1451.2743628185908;1467.3470305713854;1470.4412323317072;1472.9631759206106;956.8516879883629;977.7213494154274;997.1922742578535;1009.7425156585024;1020.9795804083876;5169.638125331266;5183.714895680699;5207.505286997729;5245.790168393221;5255.343082114736;5452.427495112956;5604.579656525777;5622.128570071645;5646.20953066571;5695.629784064023;5246.396664383568;5249.475052494797;5267.367915850123;5286.5726253911225;5289.841304760786;2933.7359637632717;2970.514742628686;2970.8217506949654;3001;3001.564773107887;5583.553315734732;5805.187273781674;5812.651240925558;5815.505682016991;5837.664934026338;5697.202391665171;5702.6863522506665;5704.828855134353;5706.600537962303;5722.170285308607;5731.592731052968;5774.278215223181;5779.306483222041;5813.244278243801;5845.246426072162;5329.760160792851;5520.365158006881;5560.860978475571;5564.860878478071;5566.357924412389;5484.122540393518;5500.5874559409;5511.944880551304;5521.806736764194;5564.91652625219;5609.411011843861;5750;5753.475329037725;5770.307563092456;5855.677937713296;4171.499420069611;4224.070704445017;4239.279322515118;4273.358996150602;4294.227039132986;5734.598578099493;5752;5752.395998420106;5757.280339957505;5771.451712087345;5326.813561525483;5545.584081193846;5563.193336966036;5611.943880561305;5621.971890140523;5466.535344495763;5523.613347065667;5531.9723401382735;5537.667739935617;5547.972260138674;5285.048691235615;5360.892782144413;5506.807261745819;5534.7509362078;5570.777168913198;5547.278853748987;5553.250311207935;5568.721563921868;5571.832845014494;5585.676522469124;5457.345118585637;5470.452954704498;5500;5537.723113844372;5553.055980483408 20:47:16 INFO - PROCESS | 25176 | |5;yui.html;709.5671640299413;738.7451329291392;751.169957197297;776.0105865022097;872.402404353018;15678.451254206106;17052;17077.23152458139;17131.14344282787;17132.14339283037;15548.300326485336;15750.763738543903;15771.60570985726;15778.053316801;15789.526314210563;808.046505123955;824.2087595907906;829.7718127514921;831.4512421801612;832.9416940814145;833.8707500337428;839.6557411461272;840.4957025784511;841.3689732700475;842.2377748137945;710.3713213805793;832.4755404095412;867.1155421470097;870.2341939093589;877.5042101212795;867.9652813887437;868.5179725252482;868.8392647360258;869.3914260018013;869.4696235296464;629.6096420219448;630.1398590923402;630.3035146163515;630.6499892559627;631.3560168627973;12076.335801530913;14887.404503819942;15203.923980380137;15221.847781522154;15814.525564233092;15102.244887755678;15513.844861551466;15743.448979285784;15769.526914192593;15884.523464295975;13059.477620895153;13106.737865242641;13205.735885282336;13250.271235082068;13359.933200333937;3920.607939206085;3981.3828856527284;4065.9593404066172;4135.338345864678;4139.689523285735;60583.09125363167;60767.39232607706;60781;61322.38677613256;61420.69289653568;11242.55029798799;11596.826047609293;11705.356205408614;11730.296182229093;11868.762624747456;21368.465788355104;21370.145194192057;21384;21528.246511372028;21608.78391216099;8514.48913065218;8643.697470588499;9063.320250981204;9200.263978881807;9288.953555232181;4971.726555039435;5051.3433253676785;5056.292119103328;5125.897482050338;5134.512221338967;3787.16682329887;3892.8832135035996;3900.6099390061336;3905.921881562353;3909.7849618270698;665.1652176518438;668.1114118222752;693.3378623414627;695.1484431571284;698.7589281697806;568.6843801690019;705.8341289796894;744.8696478116308;753.1263734068455;765.1010063175746;8705.256739601906;9818.263630227619;10001;10150.381576382728;10161.54273057714;731.8243621530901;739.7737162750252;744.8212429017105;756.4704706705328;774.4656187230793;5007.624428167902;5119.462456442095;5196.740162991835;5219.478052194826;5282.1548552232225;111297.44351278353;126816;127709;128379;130875;59041.409585904454;87111;96302;107067;108183.45908270408;76987;77721.22278777252;82373.58813205895;84212.57893710615;97431;9844.310898237054;10076.395416275047;10178.796424071625;10906.454677266263;11138.832917506083;41907;43410.13179736325;46119.538804612865;50296.74851625718;51608.48391516037;75288.62355688405;76840.61579692065;77715.2228477708;77887.6105619491;78714.21285787069;12911.5480958166;12914.22514649124;13130.606081817561;13131.60605181846;13324.200547967153;14068.648283792987;14215.50245741394;14510.492132775302;14576.708465830412;14720.411183552538;14899.627509312353;14926.253687315808;15201.163935983184;15205.923970380078;15736.449224277096;14295.92852035733;14543.20012399286;14751.852481475047;14925;15046.849531504546;14223.573292801233;14305.499307524187;14437.06159099655;14927.823154292118;14934.925325373304;11001.61494347694;11293.548258069584;11374.94312528432;11395.259308144945;11653.53385864556;10524.36853788775;11314.717132071435;11472.31166130035;11475.368854713071;11537.423128843357 20:47:16 INFO - PROCESS | 25176 | __end_tp_report 20:47:16 INFO - PROCESS | 25176 | __start_cc_report 20:47:16 INFO - PROCESS | 25176 | _x_x_mozilla_cycle_collect,962 20:47:16 INFO - PROCESS | 25176 | __end_cc_report 20:47:16 INFO - PROCESS | 25176 | __startTimestamp1470887236220__endTimestamp 20:47:16 INFO - PROCESS | 25176 | 20:47:16 INFO - PROCESS | 25176 | ------- Summary: start ------- 20:47:16 INFO - PROCESS | 25176 | Number of tests: 6 20:47:16 INFO - PROCESS | 25176 | 20:47:16 INFO - PROCESS | 25176 | [#0] dojo.html Cycles:165 Average:5432.71 Median:5637.66 stddev:646.51 (11.5%) stddev-sans-first:620.36 20:47:16 INFO - PROCESS | 25176 | Values: 3028.0 3032.0 3054.0 3071.1 3090.2 5261.6 5348.3 5365.7 5454.8 5478.0 5404.1 5411.2 5436.9 5451.0 5518.6 4907.6 4935.5 4973.4 4987.9 5160.8 5049.5 5083.5 5102.2 5114.7 5120.9 4852.9 4886.0 4921.4 4962.8 5041.7 4861.8 4872.1 4875.7 4944.1 5002.8 4905.9 4929.6 4942.0 4956.5 5031.2 5308.9 5411.1 5459.8 5483.1 5487.6 5862.3 5864.3 5904.4 5913.9 5916.3 5904.1 5948.8 5960.6 5964.0 5975.5 5323.3 5412.6 5420.9 5459.1 5539.3 6032.5 6064.1 6066.9 6069.4 6076.4 5823.8 5828.4 5831.6 5832.8 5834.9 5586.0 5744.6 5862.9 5864.0 5937.4 5753.4 5797.7 5797.9 5835.0 5847.8 5764.3 5769.4 5773.2 5830.4 5831.4 4288.3 4327.2 4420.5 4423.1 4454.5 3916.4 3916.7 3922.8 3931.4 3973.6 5465.9 5477.8 5531.3 5579.6 5585.1 5669.8 5851.4 5858.8 5865.9 5869.6 5460.3 5523.0 5535.3 5566.3 5609.2 5057.2 5060.8 5076.7 5080.1 5129.2 5887.7 6052.2 6095.8 6100.2 6103.7 5839.4 5898.7 5910.3 5948.3 5995.2 6110.3 6121.4 6121.9 6124.4 6163.7 5466.3 5792.9 5837.9 5850.6 5852.0 5798.9 5840.7 5849.3 5898.9 5945.9 5708.7 5746.5 5756.7 5758.8 5765.5 5569.9 5732.4 5734.8 5738.6 5745.4 5606.9 5637.7 5651.3 5687.9 5728.5 5770.1 5782.6 5819.1 5836.3 5838.3 5396.4 5630.8 5636.0 5639.6 5640.2 20:47:16 INFO - PROCESS | 25176 | 20:47:16 INFO - PROCESS | 25176 | [#1] ext.html Cycles:180 Average:60291.47 Median:36576.09 stddev:115658.87 (316.2%) stddev-sans-first:115896.42 20:47:16 INFO - PROCESS | 25176 | Values: 576.9 587.0 597.7 607.1 617.1 43522.3 44709.0 44771.6 44838.6 48793.3 45887.8 46558.8 46569.8 46648.8 46676.8 8026.1 8879.4 9022.3 9028.6 10587.4 10421.7 10848.5 10853.8 10856.1 10859.2 10968.2 10984.6 11007.5 11013.7 11016.4 10780.0 10845.8 10875.5 10884.1 10890.6 10660.7 10719.9 10731.2 10732.6 10738.7 43035.0 43230.6 43375.6 43497.0 43514.8 3322.9 3346.5 3351.4 3368.8 3488.5 32157.8 34154.7 34278.3 34438.7 35832.9 4270.5 4272.0 4364.9 4409.1 4417.5 343202.0 355729.0 356554.0 358156.0 484955.0 60753.7 61696.1 61710.7 61712.4 61764.7 37336.8 38141.0 65906.0 66032.0 66274.3 17464.1 17622.7 17623.5 17628.6 17644.7 12047.3 12931.4 13357.5 13446.5 13450.6 19530.4 19677.2 19720.4 19739.9 19814.5 7181.5 7238.0 7281.0 7335.0 7460.6 1044.4 1087.0 1096.1 1152.6 1199.7 33133.8 33599.8 33660.8 33848.7 34034.8 1124.2 1130.6 1138.3 1151.8 1223.2 17246.7 17538.6 17557.2 17619.9 17648.4 520862.0 523063.0 524366.0 529030.0 529977.0 58994.4 59347.0 59378.4 59450.0 59481.0 1244.1 1365.1 1401.0 1411.5 1425.2 32855.5 33957.5 34264.8 34551.8 34836.1 49760.8 50855.7 50886.7 50917.5 50967.5 385448.0 388640.0 388676.0 390241.0 391041.0 28733.9 29517.9 29547.9 31105.0 31344.4 49275.0 49316.8 49539.5 50062.5 50253.5 41073.6 42063.6 42269.0 42544.4 44204.6 42153.6 42244.6 42378.8 43595.0 43652.0 41745.4 41861.2 43029.8 43077.0 43172.1 34797.8 37319.3 37580.9 37716.6 38324.8 28792.9 28800.1 28950.6 28951.4 29096.3 20:47:16 INFO - PROCESS | 25176 | 20:47:16 INFO - PROCESS | 25176 | [#2] jquery.html Cycles:180 Average:28956.24 Median:370.66 stddev:77246.26 (20840.2%) stddev-sans-first:77433.13 20:47:16 INFO - PROCESS | 25176 | Values: 367.4 373.9 395.7 401.2 422.1 15387.5 17509.8 19981.3 20000.1 20185.6 19129.7 19598.0 19651.0 19813.9 19960.0 5756.4 5836.8 5894.0 5942.0 5956.6 5569.6 5696.9 5703.6 5704.7 5818.7 5614.6 5649.6 5663.6 5744.3 5773.8 5739.7 5767.7 5850.5 5856.7 5862.1 4542.7 4546.2 4562.2 4641.8 5106.0 22875.3 22950.5 23364.8 23500.8 23897.2 2164.6 2673.3 2750.7 2997.9 3053.4 10858.6 11090.8 11136.2 11180.3 11234.0 1852.6 1899.3 1956.0 1977.8 2014.3 78402.1 84179.0 85985.0 87079.0 87797.0 10920.3 11076.0 11152.1 11424.9 11537.2 15841.1 15912.8 15915.2 15928.8 15964.6 8326.9 8427.9 8440.4 8601.3 8675.0 8104.6 8206.3 8230.5 8429.5 8437.5 4885.0 4901.4 4914.7 4948.6 5053.5 1918.7 1953.2 1960.7 2023.7 2036.5 887.6 961.2 980.3 1050.1 1060.1 20035.0 20120.9 20334.2 20589.6 20725.6 976.4 981.3 999.8 1024.5 1025.5 9496.4 11304.7 11372.9 11395.9 11428.7 452371.0 463787.0 464056.0 469650.0 478154.4 96347.0 98141.0 99420.0 99704.5 103987.5 966.5 969.6 1000.7 1007.1 1009.6 14001.3 16340.6 17214.2 17909.5 18117.7 43594.6 43620.8 44573.3 44700.3 45465.0 62395.0 63131.4 63297.0 64068.7 66155.7 8380.7 8582.3 8618.0 8816.8 9100.3 12167.4 13104.9 13490.4 13644.3 13977.4 11020.6 11332.2 11816.1 11863.6 12257.7 9975.1 10040.9 11413.5 11781.4 12366.1 12140.8 12208.9 12209.3 12296.3 12313.6 8643.0 8779.2 8840.2 8867.1 9102.6 8735.9 11622.9 11692.0 11872.8 12143.2 20:47:16 INFO - PROCESS | 25176 | 20:47:16 INFO - PROCESS | 25176 | [#3] mootools.html Cycles:180 Average:5991.84 Median:2477.92 stddev:3515.61 (141.9%) stddev-sans-first:3508.00 20:47:16 INFO - PROCESS | 25176 | Values: 1328.0 1420.6 1510.2 1641.6 1819.4 8597.1 8996.1 9096.4 9362.8 9379.7 9173.1 9271.3 9289.6 9291.4 9300.0 2387.8 2412.8 2414.2 2414.8 2415.6 2344.7 2376.7 2402.0 2402.9 2404.6 2351.9 2375.6 2383.6 2392.1 2406.0 2327.8 2334.2 2402.7 2410.6 2415.4 2282.3 2305.1 2310.0 2310.3 2310.4 9023.9 9140.8 9287.8 9307.6 9308.6 5254.4 5383.2 5391.5 5401.6 5413.9 3394.4 3398.7 3423.1 3463.8 3466.5 1090.3 1097.9 1108.4 1108.9 1117.6 12965.2 13028.2 13083.7 13084.0 13110.9 4268.2 4464.4 4508.8 4590.9 4608.2 10165.9 10181.1 10193.0 10193.7 10202.1 5229.0 5234.5 5238.2 5240.9 5241.4 4350.9 4755.9 4880.3 4914.8 4929.3 3816.6 3911.1 3984.3 4009.7 4025.6 1161.1 1166.2 1171.1 1171.7 1180.7 779.9 919.9 941.9 979.9 982.6 6071.3 6156.3 6206.3 6358.7 6446.9 434.1 436.5 439.3 447.1 455.1 4153.9 4232.6 4242.4 4263.3 4291.5 11274.8 11780.9 11797.2 11851.5 11864.3 11742.4 11750.8 11751.5 11753.6 11755.3 8064.8 8449.6 8468.1 8665.3 8666.4 6202.3 6282.3 6305.0 6402.8 6551.6 9964.6 10316.6 10721.7 10764.3 10781.1 10149.3 10725.3 10731.7 10818.5 10872.4 7144.4 7380.7 7491.8 7691.5 7960.4 8728.7 9034.9 9089.6 9092.3 9098.2 7858.3 7964.1 8152.8 8177.1 8398.0 7812.0 7825.5 7899.7 7944.3 7971.7 7193.5 7204.9 7259.1 7296.9 7299.6 5312.3 5315.2 5345.9 5394.4 5567.1 5438.8 5464.8 5518.3 5528.6 5594.2 20:47:16 INFO - PROCESS | 25176 | 20:47:16 INFO - PROCESS | 25176 | [#4] prototype.html Cycles:180 Average:4664.08 Median:5277.89 stddev:1339.26 (25.4%) stddev-sans-first:1302.89 20:47:16 INFO - PROCESS | 25176 | Values: 329.2 335.4 344.8 345.4 347.4 5208.2 5288.6 5298.5 5300.2 5308.2 4994.5 5121.4 5138.2 5144.4 5270.7 4045.4 4070.9 4147.6 4178.2 4218.2 4177.6 4177.7 4184.4 4184.9 4202.1 4033.9 4134.1 4166.4 4168.2 4173.1 4135.8 4141.9 4150.5 4160.6 4166.6 3710.3 3712.7 3713.9 3718.4 3734.9 5032.3 5147.4 5150.6 5151.0 5156.1 4703.8 4750.5 4757.1 4764.5 4770.3 5461.4 5470.8 5481.4 5491.0 5513.9 3967.4 4058.9 4072.9 4074.3 4084.9 5676.7 5678.4 5681.5 5682.5 5695.7 4166.9 4177.5 4179.8 4183.6 4190.3 4078.3 4227.1 4239.7 4247.0 4265.5 4686.0 4691.2 4727.4 4794.8 4809.6 5461.3 5475.2 5481.6 5518.0 5538.9 1364.0 1451.3 1467.3 1470.4 1473.0 956.9 977.7 997.2 1009.7 1021.0 5169.6 5183.7 5207.5 5245.8 5255.3 5452.4 5604.6 5622.1 5646.2 5695.6 5246.4 5249.5 5267.4 5286.6 5289.8 2933.7 2970.5 2970.8 3001.0 3001.6 5583.6 5805.2 5812.7 5815.5 5837.7 5697.2 5702.7 5704.8 5706.6 5722.2 5731.6 5774.3 5779.3 5813.2 5845.2 5329.8 5520.4 5560.9 5564.9 5566.4 5484.1 5500.6 5511.9 5521.8 5564.9 5609.4 5750.0 5753.5 5770.3 5855.7 4171.5 4224.1 4239.3 4273.4 4294.2 5734.6 5752.0 5752.4 5757.3 5771.5 5326.8 5545.6 5563.2 5611.9 5622.0 5466.5 5523.6 5532.0 5537.7 5548.0 5285.0 5360.9 5506.8 5534.8 5570.8 5547.3 5553.3 5568.7 5571.8 5585.7 5457.3 5470.5 5500.0 5537.7 5553.1 20:47:16 INFO - PROCESS | 25176 | 20:47:16 INFO - PROCESS | 25176 | [#5] yui.html Cycles:180 Average:20641.21 Median:4023.67 stddev:29626.89 (736.3%) stddev-sans-first:29672.20 20:47:16 INFO - PROCESS | 25176 | Values: 709.6 738.7 751.2 776.0 872.4 15678.5 17052.0 17077.2 17131.1 17132.1 15548.3 15750.8 15771.6 15778.1 15789.5 808.0 824.2 829.8 831.5 832.9 833.9 839.7 840.5 841.4 842.2 710.4 832.5 867.1 870.2 877.5 868.0 868.5 868.8 869.4 869.5 629.6 630.1 630.3 630.6 631.4 12076.3 14887.4 15203.9 15221.8 15814.5 15102.2 15513.8 15743.4 15769.5 15884.5 13059.5 13106.7 13205.7 13250.3 13359.9 3920.6 3981.4 4066.0 4135.3 4139.7 60583.1 60767.4 60781.0 61322.4 61420.7 11242.6 11596.8 11705.4 11730.3 11868.8 21368.5 21370.1 21384.0 21528.2 21608.8 8514.5 8643.7 9063.3 9200.3 9289.0 4971.7 5051.3 5056.3 5125.9 5134.5 3787.2 3892.9 3900.6 3905.9 3909.8 665.2 668.1 693.3 695.1 698.8 568.7 705.8 744.9 753.1 765.1 8705.3 9818.3 10001.0 10150.4 10161.5 731.8 739.8 744.8 756.5 774.5 5007.6 5119.5 5196.7 5219.5 5282.2 111297.4 126816.0 127709.0 128379.0 130875.0 59041.4 87111.0 96302.0 107067.0 108183.5 76987.0 77721.2 82373.6 84212.6 97431.0 9844.3 10076.4 10178.8 10906.5 11138.8 41907.0 43410.1 46119.5 50296.7 51608.5 75288.6 76840.6 77715.2 77887.6 78714.2 12911.5 12914.2 13130.6 13131.6 13324.2 14068.6 14215.5 14510.5 14576.7 14720.4 14899.6 14926.3 15201.2 15205.9 15736.4 14295.9 14543.2 14751.9 14925.0 15046.8 14223.6 14305.5 14437.1 14927.8 14934.9 11001.6 11293.5 11374.9 11395.3 11653.5 10524.4 11314.7 11472.3 11475.4 11537.4 20:47:16 INFO - PROCESS | 25176 | -------- Summary: end -------- 20:47:16 INFO - PROCESS | 25176 | 20:47:16 INFO - TEST-INFO | 25176: exit 0 20:47:16 INFO - TEST-OK | dromaeo_css | took 1114510ms 20:47:16 INFO - TEST-START | kraken 20:47:16 INFO - operating with platform_type : linux_ 20:47:16 INFO - Initialising browser for kraken test... 20:47:16 INFO - TEST-INFO | started process 25370 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS7IoAc/profile http://localhost:48775/getInfo.html) 20:47:20 INFO - PROCESS | 25370 | __metrics Screen width/height:1600/1200 20:47:20 INFO - PROCESS | 25370 | colorDepth:24 20:47:20 INFO - PROCESS | 25370 | Browser inner width/height: 1024/697 20:47:20 INFO - PROCESS | 25370 | __metrics 20:47:21 INFO - PROCESS | 25370 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:47:21 INFO - PROCESS | 25370 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:47:22 INFO - TEST-INFO | 25370: exit 0 20:47:22 INFO - Browser initialized. 20:47:22 INFO - Running cycle 1/1 for kraken test... 20:47:22 INFO - TEST-INFO | started process 25452 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS7IoAc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:47:33 INFO - PROCESS | 25452 | RSS: Main: 155611136 20:47:33 INFO - PROCESS | 25452 | 20:47:36 INFO - PROCESS | 25452 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48775/tests/kraken/driver.html?testName=audio-beat-detection) 20:47:37 INFO - PROCESS | 25452 | RSS: Main: 211820544 20:47:37 INFO - PROCESS | 25452 | 20:47:39 INFO - PROCESS | 25452 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48775/tests/kraken/driver.html?testName=audio-dft) 20:47:40 INFO - PROCESS | 25452 | RSS: Main: 191410176 20:47:40 INFO - PROCESS | 25452 | 20:47:43 INFO - PROCESS | 25452 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48775/tests/kraken/driver.html?testName=audio-fft) 20:47:44 INFO - PROCESS | 25452 | RSS: Main: 267513856 20:47:44 INFO - PROCESS | 25452 | 20:47:46 INFO - PROCESS | 25452 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48775/tests/kraken/driver.html?testName=audio-oscillator) 20:47:46 INFO - PROCESS | 25452 | RSS: Main: 177233920 20:47:46 INFO - PROCESS | 25452 | 20:47:49 INFO - PROCESS | 25452 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48775/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:47:49 INFO - PROCESS | 25452 | RSS: Main: 183336960 20:47:49 INFO - PROCESS | 25452 | 20:47:52 INFO - PROCESS | 25452 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48775/tests/kraken/driver.html?testName=imaging-darkroom) 20:47:53 INFO - PROCESS | 25452 | RSS: Main: 218091520 20:47:53 INFO - PROCESS | 25452 | 20:47:56 INFO - PROCESS | 25452 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48775/tests/kraken/driver.html?testName=imaging-desaturate) 20:47:57 INFO - PROCESS | 25452 | RSS: Main: 218169344 20:47:57 INFO - PROCESS | 25452 | 20:48:00 INFO - PROCESS | 25452 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48775/tests/kraken/driver.html?testName=json-parse-financial) 20:48:00 INFO - PROCESS | 25452 | RSS: Main: 218226688 20:48:00 INFO - PROCESS | 25452 | 20:48:02 INFO - PROCESS | 25452 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48775/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:48:02 INFO - PROCESS | 25452 | RSS: Main: 182366208 20:48:02 INFO - PROCESS | 25452 | 20:48:04 INFO - PROCESS | 25452 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48775/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:48:05 INFO - PROCESS | 25452 | RSS: Main: 187011072 20:48:05 INFO - PROCESS | 25452 | 20:48:07 INFO - PROCESS | 25452 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48775/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:48:07 INFO - PROCESS | 25452 | RSS: Main: 191746048 20:48:07 INFO - PROCESS | 25452 | 20:48:10 INFO - PROCESS | 25452 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:48:10 INFO - PROCESS | 25452 | RSS: Main: 187764736 20:48:10 INFO - PROCESS | 25452 | 20:48:13 INFO - PROCESS | 25452 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:48:14 INFO - PROCESS | 25452 | RSS: Main: 191492096 20:48:14 INFO - PROCESS | 25452 | 20:48:15 INFO - PROCESS | 25452 | Cycle 1(1): loaded http://localhost:48775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48775/tests/kraken/driver.html?testName=ai-astar) 20:48:16 INFO - PROCESS | 25452 | RSS: Main: 241889280 20:48:16 INFO - PROCESS | 25452 | 20:48:16 INFO - PROCESS | 25452 | __start_tp_report 20:48:16 INFO - PROCESS | 25452 | _x_x_mozilla_page_load 20:48:16 INFO - PROCESS | 25452 | _x_x_mozilla_page_load_details 20:48:16 INFO - PROCESS | 25452 | |i|pagename|runs| 20:48:16 INFO - PROCESS | 25452 | |0;ai-astar;101;113;111;111;113;112;110;110;112;109 20:48:16 INFO - PROCESS | 25452 | |1;audio-beat-detection;143;115;117;175;118;118;148;116;146;117 20:48:16 INFO - PROCESS | 25452 | |2;audio-dft;162;160;161;161;161;160;162;161;164;163 20:48:16 INFO - PROCESS | 25452 | |3;audio-fft;74;75;75;110;76;75;75;75;105;74 20:48:16 INFO - PROCESS | 25452 | |4;audio-oscillator;83;84;124;84;84;84;133;84;83;134 20:48:16 INFO - PROCESS | 25452 | |5;imaging-gaussian-blur;116;117;118;117;117;117;117;117;116;117 20:48:16 INFO - PROCESS | 25452 | |6;imaging-darkroom;145;146;146;147;146;147;146;146;146;146 20:48:16 INFO - PROCESS | 25452 | |7;imaging-desaturate;94;95;95;95;95;95;95;94;94;95 20:48:16 INFO - PROCESS | 25452 | |8;json-parse-financial;50;49;50;49;48;49;50;50;49;48 20:48:16 INFO - PROCESS | 25452 | |9;json-stringify-tinderbox;61;61;61;61;61;61;61;65;64;61 20:48:16 INFO - PROCESS | 25452 | |10;stanford-crypto-aes;77;76;75;76;85;76;76;75;75;74 20:48:16 INFO - PROCESS | 25452 | |11;stanford-crypto-ccm;122;119;129;134;118;117;121;120;144;123 20:48:16 INFO - PROCESS | 25452 | |12;stanford-crypto-pbkdf2;164;158;164;158;162;158;160;163;160;161 20:48:16 INFO - PROCESS | 25452 | |13;stanford-crypto-sha256-iterative;66;66;71;62;62;63;62;62;63;61 20:48:16 INFO - PROCESS | 25452 | __end_tp_report 20:48:16 INFO - PROCESS | 25452 | __start_cc_report 20:48:16 INFO - PROCESS | 25452 | _x_x_mozilla_cycle_collect,1654 20:48:16 INFO - PROCESS | 25452 | __end_cc_report 20:48:16 INFO - PROCESS | 25452 | __startTimestamp1470887296117__endTimestamp 20:48:16 INFO - PROCESS | 25452 | 20:48:16 INFO - PROCESS | 25452 | ------- Summary: start ------- 20:48:16 INFO - PROCESS | 25452 | Number of tests: 14 20:48:16 INFO - PROCESS | 25452 | 20:48:16 INFO - PROCESS | 25452 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.50 stddev:3.49 (3.1%) stddev-sans-first:1.39 20:48:16 INFO - PROCESS | 25452 | Values: 101.0 113.0 111.0 111.0 113.0 112.0 110.0 110.0 112.0 109.0 20:48:16 INFO - PROCESS | 25452 | 20:48:16 INFO - PROCESS | 25452 | [#1] audio-beat-detection Cycles:10 Average:131.30 Median:130.50 stddev:20.56 (15.8%) stddev-sans-first:21.37 20:48:16 INFO - PROCESS | 25452 | Values: 143.0 115.0 117.0 175.0 118.0 118.0 148.0 116.0 146.0 117.0 20:48:16 INFO - PROCESS | 25452 | 20:48:16 INFO - PROCESS | 25452 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.27 (0.8%) stddev-sans-first:1.33 20:48:16 INFO - PROCESS | 25452 | Values: 162.0 160.0 161.0 161.0 161.0 160.0 162.0 161.0 164.0 163.0 20:48:16 INFO - PROCESS | 25452 | 20:48:16 INFO - PROCESS | 25452 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:13.82 (18.4%) stddev-sans-first:14.39 20:48:16 INFO - PROCESS | 25452 | Values: 74.0 75.0 75.0 110.0 76.0 75.0 75.0 75.0 105.0 74.0 20:48:16 INFO - PROCESS | 25452 | 20:48:16 INFO - PROCESS | 25452 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:84.00 stddev:22.67 (27.0%) stddev-sans-first:23.41 20:48:16 INFO - PROCESS | 25452 | Values: 83.0 84.0 124.0 84.0 84.0 84.0 133.0 84.0 83.0 134.0 20:48:16 INFO - PROCESS | 25452 | 20:48:16 INFO - PROCESS | 25452 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 20:48:16 INFO - PROCESS | 25452 | Values: 116.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 20:48:16 INFO - PROCESS | 25452 | 20:48:16 INFO - PROCESS | 25452 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 20:48:16 INFO - PROCESS | 25452 | Values: 145.0 146.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 20:48:16 INFO - PROCESS | 25452 | 20:48:16 INFO - PROCESS | 25452 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 20:48:16 INFO - PROCESS | 25452 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 20:48:16 INFO - PROCESS | 25452 | 20:48:16 INFO - PROCESS | 25452 | [#8] json-parse-financial Cycles:10 Average:49.20 Median:49.50 stddev:0.79 (1.6%) stddev-sans-first:0.78 20:48:16 INFO - PROCESS | 25452 | Values: 50.0 49.0 50.0 49.0 48.0 49.0 50.0 50.0 49.0 48.0 20:48:16 INFO - PROCESS | 25452 | 20:48:16 INFO - PROCESS | 25452 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:61.00 stddev:1.49 (2.4%) stddev-sans-first:1.56 20:48:16 INFO - PROCESS | 25452 | Values: 61.0 61.0 61.0 61.0 61.0 61.0 61.0 65.0 64.0 61.0 20:48:16 INFO - PROCESS | 25452 | 20:48:16 INFO - PROCESS | 25452 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:76.00 stddev:3.10 (4.1%) stddev-sans-first:3.28 20:48:16 INFO - PROCESS | 25452 | Values: 77.0 76.0 75.0 76.0 85.0 76.0 76.0 75.0 75.0 74.0 20:48:16 INFO - PROCESS | 25452 | 20:48:16 INFO - PROCESS | 25452 | [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:122.50 stddev:8.56 (7.0%) stddev-sans-first:9.03 20:48:16 INFO - PROCESS | 25452 | Values: 122.0 119.0 129.0 134.0 118.0 117.0 121.0 120.0 144.0 123.0 20:48:16 INFO - PROCESS | 25452 | 20:48:16 INFO - PROCESS | 25452 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:161.50 stddev:2.39 (1.5%) stddev-sans-first:2.24 20:48:16 INFO - PROCESS | 25452 | Values: 164.0 158.0 164.0 158.0 162.0 158.0 160.0 163.0 160.0 161.0 20:48:16 INFO - PROCESS | 25452 | 20:48:16 INFO - PROCESS | 25452 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.00 stddev:3.05 (4.8%) stddev-sans-first:3.13 20:48:16 INFO - PROCESS | 25452 | Values: 66.0 66.0 71.0 62.0 62.0 63.0 62.0 62.0 63.0 61.0 20:48:16 INFO - PROCESS | 25452 | -------- Summary: end -------- 20:48:16 INFO - PROCESS | 25452 | 20:48:17 INFO - TEST-INFO | 25452: exit 0 20:48:17 INFO - TEST-OK | kraken | took 60152ms 20:48:17 INFO - SUITE-END | took 1174s 20:48:17 INFO - Completed test suite (00:19:34) 20:48:17 INFO - javascript benchmark 20:48:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3028.0, 3032.029750479846, 3053.9694603053968, 3071.124729452104, 3090.181102007968, 5261.552768014723, 5348.251244825728, 5365.731713414329, 5454.809081682142, 5478.04134276501, 5404.108322126855, 5411.242426060355, 5436.91844622331, 5451.0, 5518.613697041209, 4907.631927605435, 4935.531124543163, 4973.4280557735965, 4987.875303117415, 5160.819371322004, 5049.4950504949575, 5083.542481176693, 5102.2091575805625, 5114.744262786846, 5120.948790512084, 4852.902941941159, 4885.975570122162, 4921.360223171001, 4962.801487940478, 5041.672291301072, 4861.784553861535, 4872.098661747588, 4875.68308059975, 4944.085344211332, 5002.849914502571, 4905.8773530661665, 4929.5915110898295, 4941.950580494185, 4956.454789973136, 5031.245313203049, 5308.92036619451, 5411.080116380225, 5459.808906688247, 5483.122700367922, 5487.6158668893195, 5862.296524417055, 5864.296284445893, 5904.409559044061, 5913.9112913306335, 5916.349201587822, 5904.084866845646, 5948.762049518057, 5960.552958528127, 5964.0, 5975.492083172892, 5323.307969963918, 5412.648177868466, 5420.891582168413, 5459.071957767189, 5539.25220095286, 6032.507908803344, 6064.090386442069, 6066.939330606638, 6069.393060693984, 6076.392360763976, 5823.767049318065, 5828.358880523224, 5831.562632802556, 5832.825015249549, 5834.883302334015, 5586.0, 5744.569157313218, 5862.941370586324, 5864.03243464832, 5937.376575459514, 5753.3958934311295, 5797.681127537941, 5797.855053623609, 5834.970825145847, 5847.766089356463, 5764.250647415893, 5769.365369809318, 5773.191753154561, 5830.3586605473365, 5831.358550559435, 4288.292431748727, 4327.242732521796, 4420.469543654782, 4423.137939240115, 4454.532274111237, 3916.353801622757, 3916.706247031484, 3922.7842468663926, 3931.4495970564144, 3973.602639736061, 5465.9180112298345, 5477.780888764405, 5531.308586426697, 5579.637323573955, 5585.134304182858, 5669.801556945487, 5851.414858514115, 5858.8242352729485, 5865.912011319833, 5869.618474799125, 5460.290162278879, 5523.0, 5535.252740880011, 5566.304211973504, 5609.214709940612, 5057.190849464068, 5060.797568097309, 5076.746162691925, 5080.13637681595, 5129.230615407719, 5887.735051922759, 6052.243469566304, 6095.786647467317, 6100.206973093469, 6103.664298463538, 5839.445252700986, 5898.734556945034, 5910.290765108214, 5948.315943666534, 5995.190649262294, 6110.327863934875, 6121.418465245794, 6121.877562448637, 6124.418180272867, 6163.691815409301, 5466.34403871522, 5792.884142317214, 5837.883242335045, 5850.619709718854, 5851.970740146272, 5798.942010580009, 5840.737166827588, 5849.298084229919, 5898.882022359615, 5945.91081133792, 5708.686022268815, 5746.511546518593, 5756.65460072397, 5758.769649214152, 5765.452282033368, 5569.888602228014, 5732.398098199629, 5734.770609175586, 5738.569607279387, 5745.396733342939, 5606.915896261641, 5637.661740295595, 5651.321841379061, 5687.857803554779, 5728.541716662574, 5770.13447982806, 5782.595218334676, 5819.0689489681445, 5836.299644042742, 5838.2702162229725, 5396.3524377075, 5630.831075067755, 5636.041872881702, 5639.577031722719, 5640.210370548209], "value": 5386.480383146163, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.8615532272254, 586.9706514674267, 597.7489454429142, 607.0590584593879, 617.1360095865788, 43522.34716479251, 44709.0, 44771.552284477184, 44838.55161448385, 48793.268100978516, 45887.77056114715, 46558.767206163924, 46569.767151164284, 46648.76675616617, 46676.766616166875, 8026.117127116042, 8879.378443508973, 9022.323325750562, 9028.638854445848, 10587.417692026935, 10421.739456513573, 10848.457577121151, 10853.782924341509, 10856.077233435168, 10859.185561082912, 10968.23222374434, 10984.615538456155, 11007.504662290215, 11013.724656883562, 11016.394098324588, 10780.02979731824, 10845.783084338347, 10875.456227188688, 10884.07485363741, 10890.61882834105, 10660.680179594547, 10719.946400267949, 10731.248812583044, 10732.624358147505, 10738.731531711692, 43035.0, 43230.56769432328, 43375.56624433747, 43497.0, 43514.782426087986, 3322.8670853165845, 3346.5147553604593, 3351.447011243142, 3368.781029233092, 3488.5116083748294, 32157.83921080403, 34154.65845341564, 34278.31443371119, 34438.65561344379, 35832.925012249674, 4270.466191726035, 4272.0, 4364.869053928387, 4409.140217657558, 4417.536158703322, 343202.0, 355729.0, 356553.9999999974, 358156.0, 484954.99999999645, 60753.69623151856, 61696.07455888165, 61710.69144654338, 61712.38287617156, 61764.69117654383, 37336.81331593324, 38141.0, 65906.0, 66032.0, 66274.33725662682, 17464.126793660267, 17622.735658965124, 17623.471295861145, 17628.647427051386, 17644.735328970077, 12047.33739644328, 12931.353432328346, 13357.465701371837, 13446.462141514425, 13450.596482105553, 19530.396524116062, 19677.21291148338, 19720.40838774839, 19739.901300493406, 19814.50463738418, 7181.533200342065, 7237.986681864543, 7281.0, 7334.96332518334, 7460.552366858006, 1044.3525014490913, 1086.9945650271698, 1096.0957210301533, 1152.573547787324, 1199.682084247675, 33133.83433082819, 33599.83200083984, 33660.83169584136, 33848.66151338455, 34034.76852638623, 1124.1793490751634, 1130.5534313945946, 1138.2544433396138, 1151.8272259161026, 1223.1682455930054, 17246.741298880526, 17538.649227015387, 17557.20992555338, 17619.911900440417, 17648.382306619205, 520862.0, 523063.0, 524366.0, 529030.0, 529977.0, 58994.41005589975, 59347.0, 59378.40621593815, 59450.0, 59481.0, 1244.104244943639, 1365.0922136778931, 1400.9509667161803, 1411.535168926315, 1425.2161311278755, 32855.50716739203, 33957.49063763996, 34264.828675856465, 34551.82724086363, 34836.129096772784, 49760.751196243786, 50855.74572127264, 50886.74556627193, 50917.49082509128, 50967.490325096274, 385448.0, 388640.0, 388676.0, 390241.0, 391041.0, 28733.856330718212, 29517.852410737807, 29547.85226073856, 31105.0, 31344.373112538076, 49275.0, 49316.75341623269, 49539.50460495349, 50062.499375005784, 50253.497465024884, 41073.58926410697, 42063.57936420719, 42269.0, 42544.36183457312, 44204.557954420045, 42153.57846421619, 42244.577554225296, 42378.78810605927, 43595.0, 43652.0, 41745.37381939334, 41861.16277674369, 43029.78485107554, 43077.0, 43172.13655726931, 34797.8260108708, 37319.25361492809, 37580.90715981507, 37716.62283377131, 38324.80837595906, 28792.856035719687, 28800.135995920155, 28950.565741514314, 28951.420971580872, 29096.27259318534], "value": 20991.982783210275, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.42497990644654, 373.89530931339215, 395.7467220978574, 401.2036108324974, 422.13041135261363, 15387.538373848774, 17509.824901750977, 19981.30065447708, 20000.0999955002, 20185.59628807423, 19129.71305430416, 19598.0, 19651.0, 19813.90093049533, 19960.0, 5756.395578464253, 5836.766529338822, 5893.970530147343, 5942.049272116462, 5956.642601443928, 5569.554435645159, 5696.943030569703, 5703.57223208259, 5704.743286552115, 5818.679972601505, 5614.635048721841, 5649.604527683064, 5663.631863928852, 5744.31068271808, 5773.769049238025, 5739.655620662732, 5767.682777447239, 5850.4734573888345, 5856.677882716449, 5862.06207006879, 4542.682012259143, 4546.249868771649, 4562.1560011398, 4641.76791160444, 5106.029854327666, 22875.313740587808, 22950.540989180125, 23364.766352336428, 23500.76499235003, 23897.163599274118, 2164.6103701333755, 2673.255981945816, 2750.6974232834373, 2997.9100626981226, 3053.3587946531256, 10858.565657373696, 11090.833637495443, 11136.220464567483, 11180.273282236629, 11234.0, 1852.6479968806018, 1899.335232668555, 1955.9706604400944, 1977.7824439311664, 2014.2949967511254, 78402.06468070703, 84179.0, 85985.0, 87078.99999999936, 87797.0, 10920.344779313267, 11076.0, 11152.10783137347, 11424.942875285737, 11537.192396532162, 15841.128737919295, 15912.840871591136, 15915.204239787965, 15928.76106858398, 15964.600884977968, 8326.916730832736, 8427.873581896276, 8440.366972477088, 8601.31189504838, 8674.956625216833, 8104.594770261463, 8206.343492520584, 8230.465019773816, 8429.452085614415, 8437.468759372165, 4885.0, 4901.436334821541, 4914.729689867092, 4948.604111671129, 5053.494650534917, 1918.6642337590865, 1953.247999520195, 1960.7058941158941, 2023.736914201174, 2036.53159773253, 887.5917078143997, 961.20700422152, 980.2990861534038, 1050.112654806687, 1060.1359891688248, 20035.0, 20120.89939550293, 20334.186632534827, 20589.588208235753, 20725.58548829015, 976.3897564022486, 981.2983716642492, 999.7900440907491, 1024.4826362686795, 1025.4718819807806, 9496.43021418717, 11304.717382065513, 11372.886271137348, 11395.94302028501, 11428.714282143013, 452371.0, 463787.0, 464056.0, 469650.0, 478154.35687966214, 96347.0, 98141.0, 99420.0, 99704.50147749214, 103987.4800625992, 966.5167416291854, 969.5927710361665, 1000.7398076500162, 1007.1439276614818, 1009.6365308489085, 14001.299935003413, 16340.59148521249, 17214.225359858585, 17909.462716118538, 18117.728234076236, 43594.56405435905, 43620.78189609032, 44573.331400029674, 44700.32949505825, 45465.0, 62395.0, 63131.36868631255, 63297.0, 64068.679656601416, 66155.66922165359, 8380.706675266336, 8582.313414926915, 8618.0, 8816.779580510538, 9100.31747618918, 12167.39163041862, 13104.934475327562, 13490.392932317873, 13644.317784110557, 13977.371018304404, 11020.559177633126, 11332.150088743541, 11816.054715622558, 11863.58477453285, 12257.693557660774, 9975.102240798364, 10040.949795250977, 11413.543458261576, 11781.352025638673, 12366.134370593973, 12140.757184856076, 12208.938955305166, 12209.267443953391, 12296.262224266573, 12313.630591082281, 8642.956785216034, 8779.209871111376, 8840.248578870867, 8867.0689577596, 9102.59038343263, 8735.877147992967, 11622.94188529052, 11692.0, 11872.76254474923, 12143.210691305037], "value": 9361.854358324752, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.0305377074742, 1420.630636034631, 1510.2297828107664, 1641.5978085369086, 1819.4268805326321, 8597.1402859714, 8996.145366190209, 9096.363254572174, 9362.81274374512, 9379.71860844174, 9173.128552787475, 9271.258299336054, 9289.581968811402, 9291.396059256143, 9300.0, 2387.7731615496546, 2412.8190385721055, 2414.1912459326145, 2414.8068154547595, 2415.5651982643117, 2344.742078371378, 2376.702912135983, 2402.0, 2402.915897943564, 2404.5551572959057, 2351.9176828810996, 2375.58427275227, 2383.5828729972272, 2392.055138220402, 2405.9759402406016, 2327.848689835172, 2334.2297041976108, 2402.6636270922086, 2410.554047501209, 2415.3961509622595, 2282.2696737044153, 2305.1125316753005, 2309.9538009239723, 2310.2838120182796, 2310.4223944013997, 9023.864642030374, 9140.771480712969, 9287.76780580484, 9307.581158847868, 9308.581113849894, 5254.395744489394, 5383.192521121824, 5391.541718953894, 5401.594880383947, 5413.945860541384, 3394.35507253621, 3398.745094117951, 3423.058658868806, 3463.79217246966, 3466.532018177539, 1090.2804149261528, 1097.8517900083466, 1108.3626914524182, 1108.8780234174235, 1117.6255954255334, 12965.222086674736, 13028.218306901616, 13083.738325233537, 13084.0, 13110.86889131106, 4268.189044081614, 4464.374987501752, 4508.752018638941, 4590.862274131781, 4608.239640459354, 10165.9325770793, 10181.083702466665, 10193.0316619921, 10193.74515637115, 10202.081812636898, 5229.0, 5234.502722241381, 5238.1618940969265, 5240.9475905241225, 5241.449647787003, 4350.869473915787, 4755.857324280277, 4880.316755654211, 4914.778834952435, 4929.260610908321, 3816.580176180618, 3911.0808959894403, 3984.322665146932, 4009.67922566194, 4025.577314382006, 1161.0943464098018, 1166.2302880099094, 1171.0807016492013, 1171.7305019845312, 1180.740237147826, 779.9103103143211, 919.8620206969008, 941.8775559177263, 979.9216062714966, 982.611868312027, 6071.332153463116, 6156.29202641693, 6206.286277078104, 6358.745650173942, 6446.871062578816, 434.13823560232913, 436.50456731609216, 439.3124759750979, 447.09240242307516, 455.13524303823, 4153.854615088458, 4232.597903199191, 4242.427272318259, 4263.253930562201, 4291.527931927485, 11274.774504509864, 11780.941095294469, 11797.17419780607, 11851.46668399924, 11864.347460889734, 11742.412879355998, 11750.764984700258, 11751.47118379675, 11753.588624398106, 11755.294682319089, 8064.798380040546, 8449.619767110495, 8468.068512463624, 8665.306775457948, 8666.393352465393, 6202.317745048132, 6282.340354262737, 6304.968475157595, 6402.775902843565, 6551.6069035858, 9964.601415943282, 10316.587336506456, 10721.731956701145, 10764.300320479144, 10781.083607893417, 10149.34029288094, 10725.30285531438, 10731.731706707082, 10818.459077046273, 10872.402017889091, 7144.428445724226, 7380.741674041383, 7491.812704682427, 7691.50005249657, 7960.363170946426, 8728.738137855875, 9034.91581010283, 9089.636414543344, 9092.318076144447, 9098.181163695299, 7858.253465920729, 7964.123946365779, 8152.83694326122, 8177.141400153137, 8397.95801020991, 7811.960940195263, 7825.452218344662, 7899.723509677134, 7944.285014348737, 7971.681132754857, 7193.5324203926575, 7204.855902882018, 7259.05632267823, 7296.9270307298375, 7299.5620262784405, 5312.335958005249, 5315.176147697113, 5345.9465405347, 5394.433584473573, 5567.05360088794, 5438.83683489496, 5464.80873169453, 5518.33779946409, 5528.557715382679, 5594.1608758686525], "value": 4648.4393447947805, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.1674085766397, 335.4498622259494, 344.76900476680623, 345.37487148261647, 347.3885960709153, 5208.1927301268315, 5288.576913846892, 5298.549623282016, 5300.204969254613, 5308.203769434577, 4994.450610432849, 5121.411037730662, 5138.177891537345, 5144.434112247659, 5270.736463176835, 4045.393191021341, 4070.8778736637946, 4147.5645057269, 4178.164367126572, 4218.177455396199, 4177.644900183488, 4177.686673499485, 4184.4351012613215, 4184.91630167398, 4202.075543380452, 4033.8705162554534, 4134.090500089976, 4166.375043743433, 4168.166366726667, 4173.123644034757, 4135.813888375031, 4141.8964525886795, 4150.4682143892205, 4160.563140870196, 4166.562510936354, 3710.3135919854913, 3712.6844218241213, 3713.9071523211865, 3718.4050551911837, 3734.869279575229, 5032.270320803463, 5147.433782283946, 5150.61370397218, 5150.97424512875, 5156.149235376159, 4703.811847526094, 4750.548697873696, 4757.096151731194, 4764.452088009889, 4770.330384365479, 5461.42655021225, 5470.8085217017615, 5481.369642491125, 5490.972545137289, 5513.9448605513835, 3967.3850553164307, 4058.939115913264, 4072.8981775455554, 4074.348104303327, 4084.9379161417946, 5676.744546495418, 5678.432156784289, 5681.460261275213, 5682.54539636828, 5695.746935674187, 4166.854160104382, 4177.4778152730905, 4179.784714101531, 4183.55262171627, 4190.266703326905, 4078.34746440574, 4227.133437645275, 4239.703220774516, 4247.0444150066605, 4265.50946641134, 4685.9531404686195, 4691.225947718656, 4727.409073865767, 4794.7842347093765, 4809.591184749265, 5461.344638643388, 5475.233467314579, 5481.616286859961, 5517.972410137923, 5538.889222215533, 1363.9770172370722, 1451.2743628185908, 1467.3470305713854, 1470.4412323317072, 1472.9631759206106, 956.8516879883629, 977.7213494154274, 997.1922742578535, 1009.7425156585024, 1020.9795804083876, 5169.638125331266, 5183.714895680699, 5207.505286997729, 5245.790168393221, 5255.343082114736, 5452.427495112956, 5604.579656525777, 5622.128570071645, 5646.20953066571, 5695.629784064023, 5246.396664383568, 5249.475052494797, 5267.367915850123, 5286.5726253911225, 5289.841304760786, 2933.7359637632717, 2970.514742628686, 2970.8217506949654, 3001.0, 3001.564773107887, 5583.553315734732, 5805.187273781674, 5812.651240925558, 5815.505682016991, 5837.664934026338, 5697.202391665171, 5702.6863522506665, 5704.828855134353, 5706.600537962303, 5722.170285308607, 5731.592731052968, 5774.278215223181, 5779.306483222041, 5813.244278243801, 5845.246426072162, 5329.760160792851, 5520.365158006881, 5560.860978475571, 5564.860878478071, 5566.357924412389, 5484.122540393518, 5500.5874559409, 5511.944880551304, 5521.806736764194, 5564.91652625219, 5609.411011843861, 5750.0, 5753.475329037725, 5770.307563092456, 5855.677937713296, 4171.499420069611, 4224.070704445017, 4239.279322515118, 4273.358996150602, 4294.227039132986, 5734.598578099493, 5752.0, 5752.395998420106, 5757.280339957505, 5771.451712087345, 5326.813561525483, 5545.584081193846, 5563.193336966036, 5611.943880561305, 5621.971890140523, 5466.535344495763, 5523.613347065667, 5531.9723401382735, 5537.667739935617, 5547.972260138674, 5285.048691235615, 5360.892782144413, 5506.807261745819, 5534.7509362078, 5570.777168913198, 5547.278853748987, 5553.250311207935, 5568.721563921868, 5571.832845014494, 5585.676522469124, 5457.345118585637, 5470.452954704498, 5500.0, 5537.723113844372, 5553.055980483408], "value": 4242.271398283664, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.5671640299413, 738.7451329291392, 751.169957197297, 776.0105865022097, 872.402404353018, 15678.451254206106, 17052.0, 17077.23152458139, 17131.14344282787, 17132.14339283037, 15548.300326485336, 15750.763738543903, 15771.60570985726, 15778.053316801, 15789.526314210563, 808.046505123955, 824.2087595907906, 829.7718127514921, 831.4512421801612, 832.9416940814145, 833.8707500337428, 839.6557411461272, 840.4957025784511, 841.3689732700475, 842.2377748137945, 710.3713213805793, 832.4755404095412, 867.1155421470097, 870.2341939093589, 877.5042101212795, 867.9652813887437, 868.5179725252482, 868.8392647360258, 869.3914260018013, 869.4696235296464, 629.6096420219448, 630.1398590923402, 630.3035146163515, 630.6499892559627, 631.3560168627973, 12076.335801530913, 14887.404503819942, 15203.923980380137, 15221.847781522154, 15814.525564233092, 15102.244887755678, 15513.844861551466, 15743.448979285784, 15769.526914192593, 15884.523464295975, 13059.477620895153, 13106.737865242641, 13205.735885282336, 13250.271235082068, 13359.933200333937, 3920.607939206085, 3981.3828856527284, 4065.9593404066172, 4135.338345864678, 4139.689523285735, 60583.09125363167, 60767.39232607706, 60781.0, 61322.38677613256, 61420.69289653568, 11242.55029798799, 11596.826047609293, 11705.356205408614, 11730.296182229093, 11868.762624747456, 21368.465788355104, 21370.145194192057, 21384.0, 21528.246511372028, 21608.78391216099, 8514.48913065218, 8643.697470588499, 9063.320250981204, 9200.263978881807, 9288.953555232181, 4971.726555039435, 5051.3433253676785, 5056.292119103328, 5125.897482050338, 5134.512221338967, 3787.16682329887, 3892.8832135035996, 3900.6099390061336, 3905.921881562353, 3909.7849618270698, 665.1652176518438, 668.1114118222752, 693.3378623414627, 695.1484431571284, 698.7589281697806, 568.6843801690019, 705.8341289796894, 744.8696478116308, 753.1263734068455, 765.1010063175746, 8705.256739601906, 9818.263630227619, 10001.0, 10150.381576382728, 10161.54273057714, 731.8243621530901, 739.7737162750252, 744.8212429017105, 756.4704706705328, 774.4656187230793, 5007.624428167902, 5119.462456442095, 5196.740162991835, 5219.478052194826, 5282.1548552232225, 111297.44351278353, 126816.0, 127709.0, 128379.0, 130875.0, 59041.409585904454, 87111.0, 96302.0, 107067.0, 108183.45908270408, 76987.0, 77721.22278777252, 82373.58813205895, 84212.57893710615, 97431.0, 9844.310898237054, 10076.395416275047, 10178.796424071625, 10906.454677266263, 11138.832917506083, 41907.0, 43410.13179736325, 46119.538804612865, 50296.74851625718, 51608.48391516037, 75288.62355688405, 76840.61579692065, 77715.2228477708, 77887.6105619491, 78714.21285787069, 12911.5480958166, 12914.22514649124, 13130.606081817561, 13131.60605181846, 13324.200547967153, 14068.648283792987, 14215.50245741394, 14510.492132775302, 14576.708465830412, 14720.411183552538, 14899.627509312353, 14926.253687315808, 15201.163935983184, 15205.923970380078, 15736.449224277096, 14295.92852035733, 14543.20012399286, 14751.852481475047, 14925.0, 15046.849531504546, 14223.573292801233, 14305.499307524187, 14437.06159099655, 14927.823154292118, 14934.925325373304, 11001.61494347694, 11293.548258069584, 11374.94312528432, 11395.259308144945, 11653.53385864556, 10524.36853788775, 11314.717132071435, 11472.31166130035, 11475.368854713071, 11537.423128843357], "value": 7762.304795722244, "unit": "score"}], "name": "dromaeo_css", "value": 7383.753877309012, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 111.0, 111.0, 113.0, 112.0, 110.0, 110.0, 112.0, 109.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 115.0, 117.0, 175.0, 118.0, 118.0, 148.0, 116.0, 146.0, 117.0], "value": 131.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 161.0, 161.0, 160.0, 162.0, 161.0, 164.0, 163.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 110.0, 76.0, 75.0, 75.0, 75.0, 105.0, 74.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 124.0, 84.0, 84.0, 84.0, 133.0, 84.0, 83.0, 134.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 50.0, 49.0, 48.0, 49.0, 50.0, 50.0, 49.0, 48.0], "value": 49.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 65.0, 64.0, 61.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 76.0, 85.0, 76.0, 76.0, 75.0, 75.0, 74.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 119.0, 129.0, 134.0, 118.0, 117.0, 121.0, 120.0, 144.0, 123.0], "value": 124.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 158.0, 164.0, 158.0, 162.0, 158.0, 160.0, 163.0, 160.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 71.0, 62.0, 62.0, 63.0, 62.0, 62.0, 63.0, 61.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1476.5, "alertThreshold": 2.0}]} 20:48:17 INFO - Return code: 0 20:48:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:48:17 INFO - # TBPL SUCCESS # 20:48:17 INFO - Running post-action listener: _resource_record_post_action 20:48:17 INFO - [mozharness: 2016-08-11 03:48:17.459546Z] Finished run-tests step (success) 20:48:17 INFO - Running post-run listener: _resource_record_post_run 20:48:17 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 559763456; Read time: 24; Write time: 519252 20:48:17 INFO - TinderboxPrint: CPU usage
13.0% 20:48:17 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 20:48:17 INFO - TinderboxPrint: I/O write bytes / time
559,763,456 / 519,252 20:48:17 INFO - TinderboxPrint: CPU idle
8,276.2 (87.0%) 20:48:17 INFO - TinderboxPrint: CPU user
1,194.6 (12.6%) 20:48:17 INFO - TinderboxPrint: Swap in / out
0 / 0 20:48:17 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 259702784; Read time: 0; Write time: 270396 20:48:17 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295235584; Read time: 8; Write time: 248104 20:48:18 INFO - Running post-run listener: _upload_blobber_files 20:48:18 INFO - Blob upload gear active. 20:48:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:48:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:48:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:48:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:48:18 INFO - (blobuploader) - INFO - Open directory for files ... 20:48:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:48:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:48:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:48:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:48:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:48:21 INFO - (blobuploader) - INFO - Done attempting. 20:48:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:48:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:48:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:48:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:48:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:48:22 INFO - (blobuploader) - INFO - Done attempting. 20:48:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:48:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:48:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:48:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:48:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:48:23 INFO - (blobuploader) - INFO - Done attempting. 20:48:23 INFO - (blobuploader) - INFO - Iteration through files over. 20:48:23 INFO - Return code: 0 20:48:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:48:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:48:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08936e307e40958a488b9754c95897bf951b206148c4cf8907b61e61e40ca7175624c5d1d0608c2fceae717d460976ba8f0a21bf174b7405358e3e4d62089e9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65f3f8ed34cc8d5a47ca5c47fd415a5ed79a62461e4a7d59f984c868163c91e926e310d8636e76970786d4b0d1894aa14eda2b14b1b0900ca25ad62e5a6f3281", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dae783c7ea104f4050bbbe4165727778ce76a2a81dc6e167e26dd75adacad4baf15b035c84c270a6e013c8fd373acf978de7d3f24f6744cabe4530d40ce18d50"} 20:48:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:48:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:48:23 INFO - Contents: 20:48:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08936e307e40958a488b9754c95897bf951b206148c4cf8907b61e61e40ca7175624c5d1d0608c2fceae717d460976ba8f0a21bf174b7405358e3e4d62089e9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65f3f8ed34cc8d5a47ca5c47fd415a5ed79a62461e4a7d59f984c868163c91e926e310d8636e76970786d4b0d1894aa14eda2b14b1b0900ca25ad62e5a6f3281", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dae783c7ea104f4050bbbe4165727778ce76a2a81dc6e167e26dd75adacad4baf15b035c84c270a6e013c8fd373acf978de7d3f24f6744cabe4530d40ce18d50"} 20:48:23 INFO - Running post-run listener: copy_logs_to_upload_dir 20:48:23 INFO - Copying logs to upload dir... 20:48:23 INFO - mkdir: /builds/slave/test/build/upload/logs 20:48:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.443333 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-10 20:48:23.133643) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 20:48:23.137261) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08936e307e40958a488b9754c95897bf951b206148c4cf8907b61e61e40ca7175624c5d1d0608c2fceae717d460976ba8f0a21bf174b7405358e3e4d62089e9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65f3f8ed34cc8d5a47ca5c47fd415a5ed79a62461e4a7d59f984c868163c91e926e310d8636e76970786d4b0d1894aa14eda2b14b1b0900ca25ad62e5a6f3281", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dae783c7ea104f4050bbbe4165727778ce76a2a81dc6e167e26dd75adacad4baf15b035c84c270a6e013c8fd373acf978de7d3f24f6744cabe4530d40ce18d50"} build_url:https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011141 build_url: 'https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/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/sha512/08936e307e40958a488b9754c95897bf951b206148c4cf8907b61e61e40ca7175624c5d1d0608c2fceae717d460976ba8f0a21bf174b7405358e3e4d62089e9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65f3f8ed34cc8d5a47ca5c47fd415a5ed79a62461e4a7d59f984c868163c91e926e310d8636e76970786d4b0d1894aa14eda2b14b1b0900ca25ad62e5a6f3281", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dae783c7ea104f4050bbbe4165727778ce76a2a81dc6e167e26dd75adacad4baf15b035c84c270a6e013c8fd373acf978de7d3f24f6744cabe4530d40ce18d50"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 20:48:23.161625) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 20:48:23.161908) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1470885566.555415-1883290410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 20:48:23.244830) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 20:48:23.245149) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 20:48:23.245469) ========= ========= Total master_lag: 0.15 =========