builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-027 starttime: 1483746540.28 results: success (0) revision: 7b211ca0a5cb19ea69e354306d338b7d3389a59b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-06 15:49:00.278638) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-06 15:49:00.279186) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-06 15:49:00.279508) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-06 15:49:00.294755) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 15:49:00.295136) ========= 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=1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-06 15:49:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2017-01-06 15:49:00 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.100487 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 15:49:00.409915) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 15:49:00.410280) ========= 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=1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016502 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 15:49:00.460784) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 15:49:00.461181) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 7b211ca0a5cb19ea69e354306d338b7d3389a59b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/graphics --rev 7b211ca0a5cb19ea69e354306d338b7d3389a59b --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=1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-06 15:49:00,655 truncating revision to first 12 chars 2017-01-06 15:49:00,655 Setting DEBUG logging. 2017-01-06 15:49:00,655 attempt 1/10 2017-01-06 15:49:00,655 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/7b211ca0a5cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-06 15:49:00,985 unpacking tar archive at: graphics-7b211ca0a5cb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.699264 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 15:49:01.176120) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-06 15:49:01.176505) ========= script_repo_revision: 7b211ca0a5cb19ea69e354306d338b7d3389a59b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-06 15:49:01.177008) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-06 15:49:01.177332) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-06 15:49:01.187470) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-01-06 15:49:01.187809) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:49:01 INFO - MultiFileLogger online at 20170106 15:49:01 in /builds/slave/test 15:49:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 15:49:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:49:01 INFO - {'append_to_log': False, 15:49:01 INFO - 'base_work_dir': '/builds/slave/test', 15:49:01 INFO - 'blob_upload_branch': 'Graphics', 15:49:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:49:01 INFO - 'branch': 'Graphics', 15:49:01 INFO - 'buildbot_json_path': 'buildprops.json', 15:49:01 INFO - 'config_files': ('talos/linux_config.py',), 15:49:01 INFO - 'default_actions': ('clobber', 15:49:01 INFO - 'read-buildbot-config', 15:49:01 INFO - 'download-and-extract', 15:49:01 INFO - 'populate-webroot', 15:49:01 INFO - 'create-virtualenv', 15:49:01 INFO - 'install', 15:49:01 INFO - 'run-tests'), 15:49:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:49:01 INFO - 'download_minidump_stackwalk': True, 15:49:01 INFO - 'download_symbols': 'ondemand', 15:49:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:49:01 INFO - 'tooltool.py': '/tools/tooltool.py', 15:49:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:49:01 INFO - '/tools/misc-python/virtualenv.py')}, 15:49:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:49:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:49:01 INFO - 'installer_path': 'installer.exe', 15:49:01 INFO - 'log_level': 'info', 15:49:01 INFO - 'log_name': 'talos', 15:49:01 INFO - 'log_to_console': True, 15:49:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:49:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:49:01 INFO - 'opt_config_files': (), 15:49:01 INFO - 'pip_index': False, 15:49:01 INFO - 'sps_profile': False, 15:49:01 INFO - 'sps_profile_interval': 0, 15:49:01 INFO - 'suite': 'dromaeojs', 15:49:01 INFO - 'system_bits': '32', 15:49:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:49:01 INFO - 'title': 'talos-linux64-ix-027', 15:49:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:49:01 INFO - 'use_talos_json': True, 15:49:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:49:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:49:01 INFO - 'work_dir': 'build'} 15:49:01 INFO - [mozharness: 2017-01-06 23:49:01.481174Z] Running clobber step. 15:49:01 INFO - Running pre-action listener: _resource_record_pre_action 15:49:01 INFO - Running main action method: clobber 15:49:01 INFO - rmtree: /builds/slave/test/build 15:49:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:49:01 INFO - Running post-action listener: _resource_record_post_action 15:49:01 INFO - [mozharness: 2017-01-06 23:49:01.986977Z] Finished clobber step (success) 15:49:01 INFO - [mozharness: 2017-01-06 23:49:01.987079Z] Running read-buildbot-config step. 15:49:01 INFO - Running pre-action listener: _resource_record_pre_action 15:49:01 INFO - Running main action method: read_buildbot_config 15:49:01 INFO - Using buildbot properties: 15:49:01 INFO - { 15:49:01 INFO - "project": "", 15:49:01 INFO - "product": "firefox", 15:49:01 INFO - "who": "nsilva@mozilla.com", 15:49:01 INFO - "installer_path": "public/build/target.tar.bz2", 15:49:01 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 15:49:01 INFO - "repository": "https://hg.mozilla.org/projects/graphics/", 15:49:01 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 15:49:01 INFO - "stage_platform": "linux64", 15:49:01 INFO - "basedir": "/builds/slave/test", 15:49:01 INFO - "buildnumber": 46, 15:49:01 INFO - "platform": "ubuntu64_hw", 15:49:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:49:01 INFO - "slavebuilddir": "test", 15:49:01 INFO - "taskId": "ePkQID0_SLeC3PWcES1upg", 15:49:01 INFO - "branch": "graphics", 15:49:01 INFO - "script_repo_revision": "default", 15:49:01 INFO - "revision": "7b211ca0a5cb19ea69e354306d338b7d3389a59b", 15:49:01 INFO - "slavename": "talos-linux64-ix-027", 15:49:01 INFO - "repo_path": "projects/graphics" 15:49:01 INFO - } 15:49:01 INFO - Finding installer, test and symbols from parent task. 15:49:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ePkQID0_SLeC3PWcES1upg'}, attempt #1 15:49:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ePkQID0_SLeC3PWcES1upg'}, attempt #1 15:49:02 INFO - Task dependencies: bidY83D9Q_-Tgk0tZPmPMQ 15:49:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ'}, attempt #1 15:49:03 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/target.tar.bz2 15:49:03 INFO - Set test_url: https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/test_packages.json 15:49:03 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/target.crashreporter-symbols.zip 15:49:03 INFO - Running post-action listener: _resource_record_post_action 15:49:03 INFO - [mozharness: 2017-01-06 23:49:03.433745Z] Finished read-buildbot-config step (success) 15:49:03 INFO - [mozharness: 2017-01-06 23:49:03.433964Z] Running download-and-extract step. 15:49:03 INFO - Running pre-action listener: _resource_record_pre_action 15:49:03 INFO - Running main action method: download_and_extract 15:49:03 INFO - mkdir: /builds/slave/test/build/tests 15:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:03 INFO - trying https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/target.test_packages.json 15:49:03 INFO - Downloading https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:49:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:49:04 INFO - Downloaded 896 bytes. 15:49:04 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:49:04 INFO - Using the following test package requirements: 15:49:04 INFO - {u'common': [u'target.common.tests.zip'], 15:49:04 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:49:04 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:49:04 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:49:04 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:49:04 INFO - u'mozbase': [u'target.common.tests.zip'], 15:49:04 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:49:04 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:49:04 INFO - u'web-platform': [u'target.common.tests.zip', 15:49:04 INFO - u'target.web-platform.tests.zip'], 15:49:04 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:49:04 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:49:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/target.common.tests.zip 15:49:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:49:04 INFO - Fetch https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/target.common.tests.zip into memory 15:49:04 INFO - Expected file size: 20246889 15:49:04 INFO - Obtained file size: 20246889 15:49:08 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:49:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/target.common.tests.zip 15:49:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:49:08 INFO - Fetch https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/target.common.tests.zip into memory 15:49:09 INFO - Expected file size: 20246889 15:49:09 INFO - Obtained file size: 20246889 15:49:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/target.talos.tests.zip 15:49:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:49:14 INFO - Fetch https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/target.talos.tests.zip into memory 15:49:14 INFO - Expected file size: 14403730 15:49:14 INFO - Obtained file size: 14403730 15:49:15 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')]} 15:49:15 INFO - trying https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/target.tar.bz2 15:49:15 INFO - Downloading https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:49:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:49:16 INFO - Downloaded 55794215 bytes. 15:49:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/target.tar.bz2 15:49:16 INFO - mkdir: /builds/slave/test/properties 15:49:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:49:16 INFO - Writing to file /builds/slave/test/properties/build_url 15:49:16 INFO - Contents: 15:49:16 INFO - build_url:https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/target.tar.bz2 15:49:16 INFO - Running post-action listener: _resource_record_post_action 15:49:16 INFO - Running post-action listener: set_extra_try_arguments 15:49:16 INFO - [mozharness: 2017-01-06 23:49:16.136639Z] Finished download-and-extract step (success) 15:49:16 INFO - [mozharness: 2017-01-06 23:49:16.136735Z] Running populate-webroot step. 15:49:16 INFO - Running pre-action listener: _resource_record_pre_action 15:49:16 INFO - Running main action method: populate_webroot 15:49:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:49:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:49:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:49:16 INFO - '--tppagecycles', 15:49:16 INFO - '7'], 15:49:16 INFO - 'tests': ['tsvgm']}}, 15:49:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:49:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:49:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:49:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:49:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:49:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:49:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:49:16 INFO - 'talos_options': ['--disable-e10s'], 15:49:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:49:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:49:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:49:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:49:16 INFO - 'talos_options': ['--disable-e10s'], 15:49:16 INFO - 'tests': ['damp', 'tps']}, 15:49:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:49:16 INFO - 'tests': ['damp', 'tps']}, 15:49:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:49:16 INFO - 'tests': ['dromaeo_dom']}, 15:49:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:49:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:49:16 INFO - 'tests': ['basic_compositor_video']}, 15:49:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:49:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:49:16 INFO - 'tests': ['a11yr', 15:49:16 INFO - 'ts_paint', 15:49:16 INFO - 'tpaint', 15:49:16 INFO - 'sessionrestore', 15:49:16 INFO - 'sessionrestore_no_auto_restore', 15:49:16 INFO - 'tabpaint']}, 15:49:16 INFO - 'other-e10s': {'tests': ['a11yr', 15:49:16 INFO - 'ts_paint', 15:49:16 INFO - 'tpaint', 15:49:16 INFO - 'sessionrestore', 15:49:16 INFO - 'sessionrestore_no_auto_restore', 15:49:16 INFO - 'tabpaint']}, 15:49:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:49:16 INFO - 'ts_paint', 15:49:16 INFO - 'tpaint', 15:49:16 INFO - 'sessionrestore', 15:49:16 INFO - 'sessionrestore_no_auto_restore', 15:49:16 INFO - 'tabpaint']}, 15:49:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:49:16 INFO - 'ts_paint', 15:49:16 INFO - 'tpaint', 15:49:16 INFO - 'sessionrestore', 15:49:16 INFO - 'sessionrestore_no_auto_restore', 15:49:16 INFO - 'tabpaint']}, 15:49:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:49:16 INFO - 'tests': ['a11yr', 15:49:16 INFO - 'ts_paint', 15:49:16 INFO - 'tpaint', 15:49:16 INFO - 'sessionrestore', 15:49:16 INFO - 'sessionrestore_no_auto_restore', 15:49:16 INFO - 'tabpaint']}, 15:49:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:49:16 INFO - 'tests': ['a11yr', 15:49:16 INFO - 'ts_paint', 15:49:16 INFO - 'tpaint', 15:49:16 INFO - 'sessionrestore', 15:49:16 INFO - 'sessionrestore_no_auto_restore', 15:49:16 INFO - 'tabpaint']}, 15:49:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:49:16 INFO - 'tests': ['tsvgx', 15:49:16 INFO - 'tsvgr_opacity', 15:49:16 INFO - 'tart', 15:49:16 INFO - 'tscrollx', 15:49:16 INFO - 'cart', 15:49:16 INFO - 'tsvg_static']}, 15:49:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:49:16 INFO - 'tsvgr_opacity', 15:49:16 INFO - 'tart', 15:49:16 INFO - 'tscrollx', 15:49:16 INFO - 'cart', 15:49:16 INFO - 'tsvg_static']}, 15:49:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:49:16 INFO - 'talos_options': ['--disable-e10s'], 15:49:16 INFO - 'tests': ['tp5o']}, 15:49:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:49:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:49:16 INFO - 'talos_options': ['--disable-e10s', 15:49:16 INFO - '--xperf_path', 15:49:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:49:16 INFO - 'tests': ['tp5n']}, 15:49:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:49:16 INFO - 'talos_options': ['--xperf_path', 15:49:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:49:16 INFO - 'tests': ['tp5n']}}, 15:49:16 INFO - 'talos.zip': {'path': '', 15:49:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:49:16 INFO - Running post-action listener: _resource_record_post_action 15:49:16 INFO - [mozharness: 2017-01-06 23:49:16.149901Z] Finished populate-webroot step (success) 15:49:16 INFO - [mozharness: 2017-01-06 23:49:16.149994Z] Running create-virtualenv step. 15:49:16 INFO - Running pre-action listener: _resource_record_pre_action 15:49:16 INFO - Running main action method: create_virtualenv 15:49:16 INFO - Creating virtualenv /builds/slave/test/build/venv 15:49:16 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 15:49:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:49:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:49:16 INFO - Using real prefix '/usr' 15:49:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:49:16 INFO - Installing distribute.............................................................................................................................................................................................done. 15:49:18 INFO - Installing pip.................done. 15:49:18 INFO - Return code: 0 15:49:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:49:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:49:18 INFO - Reading from file tmpfile_stdout 15:49:18 INFO - Output received: 15:49:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:49:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xecd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123ec70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123c3f0>, '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 0x123ccf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123d1a0>, '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': '1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939', '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 15:49:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:49:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:49:18 INFO - Using env: {'DISPLAY': ':0', 15:49:18 INFO - 'HOME': '/home/cltbld', 15:49:18 INFO - 'LANG': 'en_US.UTF-8', 15:49:18 INFO - 'LANGUAGE': 'en_US:en', 15:49:18 INFO - 'LOGNAME': 'cltbld', 15:49:18 INFO - 'MAIL': '/var/mail/cltbld', 15:49:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:18 INFO - 'MOZ_NO_REMOTE': '1', 15:49:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:18 INFO - 'NO_EM_RESTART': '1', 15:49:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:18 INFO - 'PWD': '/builds/slave/test', 15:49:18 INFO - 'SHELL': '/bin/bash', 15:49:18 INFO - 'SHLVL': '1', 15:49:18 INFO - 'TERM': 'linux', 15:49:18 INFO - 'TMOUT': '86400', 15:49:18 INFO - 'USER': 'cltbld', 15:49:18 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939', 15:49:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:18 INFO - '_': '/tools/buildbot/bin/python'} 15:49:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:19 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 15:49:19 INFO - Cleaning up... 15:49:19 INFO - Return code: 0 15:49:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xecd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123ec70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123c3f0>, '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 0x123ccf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123d1a0>, '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': '1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939', '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 15:49:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:49:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:49:19 INFO - Using env: {'DISPLAY': ':0', 15:49:19 INFO - 'HOME': '/home/cltbld', 15:49:19 INFO - 'LANG': 'en_US.UTF-8', 15:49:19 INFO - 'LANGUAGE': 'en_US:en', 15:49:19 INFO - 'LOGNAME': 'cltbld', 15:49:19 INFO - 'MAIL': '/var/mail/cltbld', 15:49:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:19 INFO - 'MOZ_NO_REMOTE': '1', 15:49:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:19 INFO - 'NO_EM_RESTART': '1', 15:49:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:19 INFO - 'PWD': '/builds/slave/test', 15:49:19 INFO - 'SHELL': '/bin/bash', 15:49:19 INFO - 'SHLVL': '1', 15:49:19 INFO - 'TERM': 'linux', 15:49:19 INFO - 'TMOUT': '86400', 15:49:19 INFO - 'USER': 'cltbld', 15:49:19 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939', 15:49:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:19 INFO - '_': '/tools/buildbot/bin/python'} 15:49:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:19 INFO - Downloading/unpacking psutil>=3.1.1 15:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:49:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:49:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:49:21 INFO - Installing collected packages: psutil 15:49:21 INFO - Running setup.py install for psutil 15:49:21 INFO - building 'psutil._psutil_linux' extension 15:49:21 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 15:49:21 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 15:49:21 INFO - building 'psutil._psutil_posix' extension 15:49:21 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 15:49:21 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 15:49:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:49:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:49:22 INFO - Successfully installed psutil 15:49:22 INFO - Cleaning up... 15:49:22 INFO - Return code: 0 15:49:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:49:22 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')]} 15:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:22 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')]} 15:49:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:22 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 0xecd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123ec70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123c3f0>, '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 0x123ccf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123d1a0>, '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': '1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939', '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 15:49:22 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 15:49:22 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 15:49:22 INFO - Using env: {'DISPLAY': ':0', 15:49:22 INFO - 'HOME': '/home/cltbld', 15:49:22 INFO - 'LANG': 'en_US.UTF-8', 15:49:22 INFO - 'LANGUAGE': 'en_US:en', 15:49:22 INFO - 'LOGNAME': 'cltbld', 15:49:22 INFO - 'MAIL': '/var/mail/cltbld', 15:49:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:22 INFO - 'MOZ_NO_REMOTE': '1', 15:49:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:22 INFO - 'NO_EM_RESTART': '1', 15:49:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:22 INFO - 'PWD': '/builds/slave/test', 15:49:22 INFO - 'SHELL': '/bin/bash', 15:49:22 INFO - 'SHLVL': '1', 15:49:22 INFO - 'TERM': 'linux', 15:49:22 INFO - 'TMOUT': '86400', 15:49:22 INFO - 'USER': 'cltbld', 15:49:22 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939', 15:49:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:22 INFO - '_': '/tools/buildbot/bin/python'} 15:49:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:49: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 15:49: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 15:49: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 15:49: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 15:49: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 15:49: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 15:49:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:49:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:49:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:49:24 INFO - Installing collected packages: mozsystemmonitor 15:49:24 INFO - Running setup.py install for mozsystemmonitor 15:49:24 INFO - Successfully installed mozsystemmonitor 15:49:24 INFO - Cleaning up... 15:49:24 INFO - Return code: 0 15:49:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:49: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')]} 15:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49: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')]} 15:49:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xecd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123ec70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123c3f0>, '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 0x123ccf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123d1a0>, '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': '1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939', '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 15:49: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==2.5.1'] in /builds/slave/test/build 15:49: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==2.5.1 15:49:24 INFO - Using env: {'DISPLAY': ':0', 15:49:24 INFO - 'HOME': '/home/cltbld', 15:49:24 INFO - 'LANG': 'en_US.UTF-8', 15:49:24 INFO - 'LANGUAGE': 'en_US:en', 15:49:24 INFO - 'LOGNAME': 'cltbld', 15:49:24 INFO - 'MAIL': '/var/mail/cltbld', 15:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:24 INFO - 'MOZ_NO_REMOTE': '1', 15:49:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:24 INFO - 'NO_EM_RESTART': '1', 15:49:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:24 INFO - 'PWD': '/builds/slave/test', 15:49:24 INFO - 'SHELL': '/bin/bash', 15:49:24 INFO - 'SHLVL': '1', 15:49:24 INFO - 'TERM': 'linux', 15:49:24 INFO - 'TMOUT': '86400', 15:49:24 INFO - 'USER': 'cltbld', 15:49:24 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939', 15:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:24 INFO - '_': '/tools/buildbot/bin/python'} 15:49:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:24 INFO - Downloading/unpacking jsonschema==2.5.1 15:49:24 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 15:49:24 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 15:49:24 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 15:49:24 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 15:49:24 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 15:49:24 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 15:49:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:49:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:49:26 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 15:49:26 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 15:49:26 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 15:49:26 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 15:49:26 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 15:49:26 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 15:49:26 INFO - Downloading functools32-3.2.3-2.tar.gz 15:49:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:49:27 INFO - warning: no files found matching '*.txt' 15:49:27 INFO - no previously-included directories found matching 'build' 15:49:27 INFO - no previously-included directories found matching 'dist' 15:49:27 INFO - no previously-included directories found matching '.git*' 15:49:27 INFO - Installing collected packages: jsonschema, functools32 15:49:27 INFO - Running setup.py install for functools32 15:49:27 INFO - warning: no files found matching '*.txt' 15:49:27 INFO - no previously-included directories found matching 'build' 15:49:27 INFO - no previously-included directories found matching 'dist' 15:49:27 INFO - no previously-included directories found matching '.git*' 15:49:27 INFO - Successfully installed jsonschema functools32 15:49:27 INFO - Cleaning up... 15:49:27 INFO - Return code: 0 15:49:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:27 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 0xecd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123ec70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123c3f0>, '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 0x123ccf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123d1a0>, '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': '1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939', '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 15:49:27 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 15:49:27 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 15:49:27 INFO - Using env: {'DISPLAY': ':0', 15:49:27 INFO - 'HOME': '/home/cltbld', 15:49:27 INFO - 'LANG': 'en_US.UTF-8', 15:49:27 INFO - 'LANGUAGE': 'en_US:en', 15:49:27 INFO - 'LOGNAME': 'cltbld', 15:49:27 INFO - 'MAIL': '/var/mail/cltbld', 15:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:27 INFO - 'MOZ_NO_REMOTE': '1', 15:49:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:27 INFO - 'NO_EM_RESTART': '1', 15:49:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:27 INFO - 'PWD': '/builds/slave/test', 15:49:27 INFO - 'SHELL': '/bin/bash', 15:49:27 INFO - 'SHLVL': '1', 15:49:27 INFO - 'TERM': 'linux', 15:49:27 INFO - 'TMOUT': '86400', 15:49:27 INFO - 'USER': 'cltbld', 15:49:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939', 15:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:27 INFO - '_': '/tools/buildbot/bin/python'} 15:49:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:49:27 INFO - Cleaning up... 15:49:27 INFO - Return code: 0 15:49:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:27 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 0xecd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123ec70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123c3f0>, '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 0x123ccf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123d1a0>, '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': '1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939', '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 15:49:27 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 15:49:27 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 15:49:27 INFO - Using env: {'DISPLAY': ':0', 15:49:27 INFO - 'HOME': '/home/cltbld', 15:49:27 INFO - 'LANG': 'en_US.UTF-8', 15:49:27 INFO - 'LANGUAGE': 'en_US:en', 15:49:27 INFO - 'LOGNAME': 'cltbld', 15:49:27 INFO - 'MAIL': '/var/mail/cltbld', 15:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:27 INFO - 'MOZ_NO_REMOTE': '1', 15:49:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:27 INFO - 'NO_EM_RESTART': '1', 15:49:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:27 INFO - 'PWD': '/builds/slave/test', 15:49:27 INFO - 'SHELL': '/bin/bash', 15:49:27 INFO - 'SHLVL': '1', 15:49:27 INFO - 'TERM': 'linux', 15:49:27 INFO - 'TMOUT': '86400', 15:49:27 INFO - 'USER': 'cltbld', 15:49:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939', 15:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:27 INFO - '_': '/tools/buildbot/bin/python'} 15:49:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:27 INFO - Downloading/unpacking blobuploader==1.2.4 15:49:27 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 15:49:27 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 15:49:27 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 15:49:27 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 15:49:27 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 15:49:27 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 15:49:29 INFO - Downloading blobuploader-1.2.4.tar.gz 15:49:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:49:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:49:29 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 15:49:29 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 15:49:29 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 15:49:29 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 15:49:29 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 15:49:29 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 15:49:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:49:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:49:30 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 15:49:30 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 15:49:30 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 15:49:30 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 15:49:30 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 15:49:30 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 15:49:30 INFO - Downloading docopt-0.6.1.tar.gz 15:49:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:49:30 INFO - Installing collected packages: blobuploader, requests, docopt 15:49:30 INFO - Running setup.py install for blobuploader 15:49:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:49:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:49:30 INFO - Running setup.py install for requests 15:49:30 INFO - Running setup.py install for docopt 15:49:31 INFO - Successfully installed blobuploader requests docopt 15:49:31 INFO - Cleaning up... 15:49:31 INFO - Return code: 0 15:49:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:31 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 0xecd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123ec70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123c3f0>, '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 0x123ccf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123d1a0>, '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': '1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939', '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 15:49:31 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 15:49:31 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 15:49:31 INFO - Using env: {'DISPLAY': ':0', 15:49:31 INFO - 'HOME': '/home/cltbld', 15:49:31 INFO - 'LANG': 'en_US.UTF-8', 15:49:31 INFO - 'LANGUAGE': 'en_US:en', 15:49:31 INFO - 'LOGNAME': 'cltbld', 15:49:31 INFO - 'MAIL': '/var/mail/cltbld', 15:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:31 INFO - 'MOZ_NO_REMOTE': '1', 15:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:31 INFO - 'NO_EM_RESTART': '1', 15:49:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:31 INFO - 'PWD': '/builds/slave/test', 15:49:31 INFO - 'SHELL': '/bin/bash', 15:49:31 INFO - 'SHLVL': '1', 15:49:31 INFO - 'TERM': 'linux', 15:49:31 INFO - 'TMOUT': '86400', 15:49:31 INFO - 'USER': 'cltbld', 15:49:31 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939', 15:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:31 INFO - '_': '/tools/buildbot/bin/python'} 15:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:49:31 INFO - Running setup.py (path:/tmp/pip-_foBQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:49:31 INFO - Running setup.py (path:/tmp/pip-GACKKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:49:31 INFO - Running setup.py (path:/tmp/pip-2vP209-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:49:31 INFO - Running setup.py (path:/tmp/pip-ibaBTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:49:31 INFO - Running setup.py (path:/tmp/pip-6BaXVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:49:31 INFO - Running setup.py (path:/tmp/pip-dfHrdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:49:31 INFO - Running setup.py (path:/tmp/pip-Q13VKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:49:31 INFO - Running setup.py (path:/tmp/pip-bbxfsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:49:31 INFO - Running setup.py (path:/tmp/pip-dCyH90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:49:32 INFO - Running setup.py (path:/tmp/pip-cgLzqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:49:32 INFO - Running setup.py (path:/tmp/pip-CLeYxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:49:32 INFO - Running setup.py (path:/tmp/pip-_cx6cL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:49:32 INFO - Running setup.py (path:/tmp/pip-aMuWNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:49:32 INFO - Running setup.py (path:/tmp/pip-3AyElX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:32 INFO - Running setup.py (path:/tmp/pip-9M4HYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:49:32 INFO - Running setup.py (path:/tmp/pip-LRZdRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:49:32 INFO - Running setup.py (path:/tmp/pip-bjWF7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:49:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:49:32 INFO - Running setup.py install for manifestparser 15:49:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:49:32 INFO - Running setup.py install for mozcrash 15:49:32 INFO - Running setup.py install for mozdebug 15:49:32 INFO - Running setup.py install for mozdevice 15:49:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:49:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:49:33 INFO - Running setup.py install for mozfile 15:49:33 INFO - Running setup.py install for mozhttpd 15:49:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:49:33 INFO - Running setup.py install for mozinfo 15:49:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:49:33 INFO - Running setup.py install for mozInstall 15:49:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:49:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:49:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:49:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:49:33 INFO - Running setup.py install for mozleak 15:49:33 INFO - Running setup.py install for mozlog 15:49:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:49:33 INFO - Running setup.py install for moznetwork 15:49:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:49:33 INFO - Running setup.py install for mozprocess 15:49:33 INFO - Running setup.py install for mozprofile 15:49:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:49:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:49:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:49:33 INFO - Running setup.py install for mozrunner 15:49:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:49:34 INFO - Running setup.py install for mozscreenshot 15:49:34 INFO - Running setup.py install for moztest 15:49:34 INFO - Running setup.py install for mozversion 15:49:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:49:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:49:34 INFO - Cleaning up... 15:49:34 INFO - Return code: 0 15:49:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:34 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')]} 15:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:34 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')]} 15:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:34 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 0xecd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123ec70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123c3f0>, '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 0x123ccf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123d1a0>, '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': '1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939', '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 15:49:34 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 15:49:34 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 15:49:34 INFO - Using env: {'DISPLAY': ':0', 15:49:34 INFO - 'HOME': '/home/cltbld', 15:49:34 INFO - 'LANG': 'en_US.UTF-8', 15:49:34 INFO - 'LANGUAGE': 'en_US:en', 15:49:34 INFO - 'LOGNAME': 'cltbld', 15:49:34 INFO - 'MAIL': '/var/mail/cltbld', 15:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:34 INFO - 'MOZ_NO_REMOTE': '1', 15:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:34 INFO - 'NO_EM_RESTART': '1', 15:49:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:34 INFO - 'PWD': '/builds/slave/test', 15:49:34 INFO - 'SHELL': '/bin/bash', 15:49:34 INFO - 'SHLVL': '1', 15:49:34 INFO - 'TERM': 'linux', 15:49:34 INFO - 'TMOUT': '86400', 15:49:34 INFO - 'USER': 'cltbld', 15:49:34 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939', 15:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:34 INFO - '_': '/tools/buildbot/bin/python'} 15:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:49:34 INFO - Running setup.py (path:/tmp/pip-eQXk4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:49:34 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)) 15:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:49:34 INFO - Running setup.py (path:/tmp/pip-EhAYe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 15:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:49:34 INFO - Running setup.py (path:/tmp/pip-D2D9r6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:49:34 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)) 15:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:49:34 INFO - Running setup.py (path:/tmp/pip-j5WbkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 15:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:49:34 INFO - Running setup.py (path:/tmp/pip-e5xwNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:49:35 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)) 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:49:35 INFO - Running setup.py (path:/tmp/pip-5d0TVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:49:35 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)) 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:49:35 INFO - Running setup.py (path:/tmp/pip-EclkXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:49:35 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)) 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:49:35 INFO - Running setup.py (path:/tmp/pip-ks6jUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:49:35 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)) 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:49:35 INFO - Running setup.py (path:/tmp/pip-OQiAKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:49:35 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)) 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:49:35 INFO - Running setup.py (path:/tmp/pip-EmUxfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:49:35 INFO - Running setup.py (path:/tmp/pip-MGAWkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:49:35 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)) 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:49:35 INFO - Running setup.py (path:/tmp/pip-Q9iSfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:49:35 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)) 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:49:35 INFO - Running setup.py (path:/tmp/pip-pXCRc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:49:35 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)) 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:49:35 INFO - Running setup.py (path:/tmp/pip-1zSGUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:35 INFO - Running setup.py (path:/tmp/pip-s9HTd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:35 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)) 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:49:35 INFO - Running setup.py (path:/tmp/pip-EIWhvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:49:35 INFO - Running setup.py (path:/tmp/pip-Wr6pvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:49:35 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)) 15:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:49:35 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)) 15:49:35 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:49:35 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:49:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:49:35 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 15:49:35 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 15:49:35 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 15:49:35 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 15:49:35 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 15:49:35 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 15:49:38 INFO - Downloading blessings-1.6.tar.gz 15:49:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:49:39 INFO - Installing collected packages: blessings 15:49:39 INFO - Running setup.py install for blessings 15:49:39 INFO - Successfully installed blessings 15:49:39 INFO - Cleaning up... 15:49:39 INFO - Return code: 0 15:49:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:49:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:39 INFO - Reading from file tmpfile_stdout 15:49:39 INFO - Current package versions: 15:49:39 INFO - argparse == 1.2.1 15:49:39 INFO - blessings == 1.6 15:49:39 INFO - blobuploader == 1.2.4 15:49:39 INFO - docopt == 0.6.1 15:49:39 INFO - functools32 == 3.2.3-2 15:49:39 INFO - jsonschema == 2.5.1 15:49:39 INFO - manifestparser == 1.1 15:49:39 INFO - mozInstall == 1.12 15:49:39 INFO - mozcrash == 1.0 15:49:39 INFO - mozdebug == 0.1 15:49:39 INFO - mozdevice == 0.49 15:49:39 INFO - mozfile == 1.2 15:49:39 INFO - mozhttpd == 0.7 15:49:39 INFO - mozinfo == 0.9 15:49:39 INFO - mozleak == 0.1 15:49:39 INFO - mozlog == 3.4 15:49:39 INFO - moznetwork == 0.27 15:49:39 INFO - mozprocess == 0.23 15:49:39 INFO - mozprofile == 0.28 15:49:39 INFO - mozrunner == 6.13 15:49:39 INFO - mozscreenshot == 0.1 15:49:39 INFO - mozsystemmonitor == 0.3 15:49:39 INFO - moztest == 0.8 15:49:39 INFO - mozversion == 1.4 15:49:39 INFO - psutil == 3.1.1 15:49:39 INFO - requests == 1.2.3 15:49:39 INFO - wsgiref == 0.1.2 15:49:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:39 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')]} 15:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:39 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')]} 15:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:39 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 0xecd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123ec70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123c3f0>, '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 0x123ccf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123d1a0>, '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': '1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939', '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 15:49:39 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 15:49:39 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 15:49:39 INFO - Using env: {'DISPLAY': ':0', 15:49:39 INFO - 'HOME': '/home/cltbld', 15:49:39 INFO - 'LANG': 'en_US.UTF-8', 15:49:39 INFO - 'LANGUAGE': 'en_US:en', 15:49:39 INFO - 'LOGNAME': 'cltbld', 15:49:39 INFO - 'MAIL': '/var/mail/cltbld', 15:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:39 INFO - 'MOZ_NO_REMOTE': '1', 15:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:39 INFO - 'NO_EM_RESTART': '1', 15:49:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:39 INFO - 'PWD': '/builds/slave/test', 15:49:39 INFO - 'SHELL': '/bin/bash', 15:49:39 INFO - 'SHLVL': '1', 15:49:39 INFO - 'TERM': 'linux', 15:49:39 INFO - 'TMOUT': '86400', 15:49:39 INFO - 'USER': 'cltbld', 15:49:39 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939', 15:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:39 INFO - '_': '/tools/buildbot/bin/python'} 15:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:39 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)) 15:49:39 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)) 15:49:39 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)) 15:49:39 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)) 15:49:39 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)) 15:49:39 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)) 15:49:39 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)) 15:49:39 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)) 15:49:39 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)) 15:49:39 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)) 15:49:39 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)) 15:49:39 INFO - Cleaning up... 15:49:39 INFO - Return code: 0 15:49:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:49:39 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')]} 15:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:39 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')]} 15:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:39 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 0xecd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123ec70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123c3f0>, '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 0x123ccf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123d1a0>, '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': '1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939', '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 15:49:39 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 15:49:39 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 15:49:39 INFO - Using env: {'DISPLAY': ':0', 15:49:39 INFO - 'HOME': '/home/cltbld', 15:49:39 INFO - 'LANG': 'en_US.UTF-8', 15:49:39 INFO - 'LANGUAGE': 'en_US:en', 15:49:39 INFO - 'LOGNAME': 'cltbld', 15:49:39 INFO - 'MAIL': '/var/mail/cltbld', 15:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:39 INFO - 'MOZ_NO_REMOTE': '1', 15:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:39 INFO - 'NO_EM_RESTART': '1', 15:49:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:39 INFO - 'PWD': '/builds/slave/test', 15:49:39 INFO - 'SHELL': '/bin/bash', 15:49:39 INFO - 'SHLVL': '1', 15:49:39 INFO - 'TERM': 'linux', 15:49:39 INFO - 'TMOUT': '86400', 15:49:39 INFO - 'USER': 'cltbld', 15:49:39 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939', 15:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:39 INFO - '_': '/tools/buildbot/bin/python'} 15:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:49:39 INFO - Cleaning up... 15:49:39 INFO - Return code: 0 15:49:39 INFO - Running post-action listener: _resource_record_post_action 15:49:39 INFO - Running post-action listener: _start_resource_monitoring 15:49:39 INFO - Starting resource monitoring. 15:49:39 INFO - [mozharness: 2017-01-06 23:49:39.897773Z] Finished create-virtualenv step (success) 15:49:39 INFO - [mozharness: 2017-01-06 23:49:39.898279Z] Running install step. 15:49:39 INFO - Running pre-action listener: _resource_record_pre_action 15:49:39 INFO - Running main action method: install 15:49:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:40 INFO - Reading from file tmpfile_stdout 15:49:40 INFO - Detecting whether we're running mozinstall >=1.0... 15:49:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:49:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:49:40 INFO - Reading from file tmpfile_stdout 15:49:40 INFO - Output received: 15:49:40 INFO - Usage: mozinstall [options] installer 15:49:40 INFO - Options: 15:49:40 INFO - -h, --help show this help message and exit 15:49:40 INFO - -d DEST, --destination=DEST 15:49:40 INFO - Directory to install application into. [default: 15:49:40 INFO - "/builds/slave/test"] 15:49:40 INFO - --app=APP Application being installed. [default: firefox] 15:49:40 INFO - mkdir: /builds/slave/test/build/application 15:49:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:49:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:49:56 INFO - Reading from file tmpfile_stdout 15:49:56 INFO - Output received: 15:49:56 INFO - /builds/slave/test/build/application/firefox/firefox 15:49:56 INFO - Running post-action listener: _resource_record_post_action 15:49:56 INFO - [mozharness: 2017-01-06 23:49:56.288757Z] Finished install step (success) 15:49:56 INFO - [mozharness: 2017-01-06 23:49:56.289005Z] Running run-tests step. 15:49:56 INFO - Running pre-action listener: _resource_record_pre_action 15:49:56 INFO - Running main action method: run_tests 15:49:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:49:56 INFO - Python 2.7.3 15:49:56 INFO - Return code: 0 15:49:56 INFO - grabbing minidump binary from tooltool 15:49: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')]} 15:49:56 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 0x123c3f0>, '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 0x123ccf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123d1a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:49:56 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 15:49:56 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 15:49:56 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 15:49:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:49:56 INFO - Return code: 0 15:49:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:49:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:49:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:49:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:49:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:49:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 15:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 15:49:56 INFO - Using env: {'DISPLAY': ':0', 15:49:56 INFO - 'HOME': '/home/cltbld', 15:49:56 INFO - 'LANG': 'en_US.UTF-8', 15:49:56 INFO - 'LANGUAGE': 'en_US:en', 15:49:56 INFO - 'LOGNAME': 'cltbld', 15:49:56 INFO - 'MAIL': '/var/mail/cltbld', 15:49:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:49:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:56 INFO - 'MOZ_NO_REMOTE': '1', 15:49:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:56 INFO - 'NO_EM_RESTART': '1', 15:49:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:56 INFO - 'PWD': '/builds/slave/test', 15:49:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:49:56 INFO - 'SHELL': '/bin/bash', 15:49:56 INFO - 'SHLVL': '1', 15:49:56 INFO - 'TERM': 'linux', 15:49:56 INFO - 'TMOUT': '86400', 15:49:56 INFO - 'USER': 'cltbld', 15:49:56 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939', 15:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:56 INFO - '_': '/tools/buildbot/bin/python'} 15:49:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 15:49:56 INFO - mozversion application_buildid: 20170106181032 15:49:56 INFO - mozversion application_changeset: 7b211ca0a5cb19ea69e354306d338b7d3389a59b 15:49:56 INFO - mozversion application_display_name: Nightly 15:49:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:49:56 INFO - mozversion application_name: Firefox 15:49:56 INFO - mozversion application_remotingname: firefox 15:49:56 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 15:49:56 INFO - mozversion application_vendor: Mozilla 15:49:56 INFO - mozversion application_version: 53.0a1 15:49:56 INFO - mozversion platform_buildid: 20170106181032 15:49:56 INFO - mozversion platform_changeset: 7b211ca0a5cb19ea69e354306d338b7d3389a59b 15:49:56 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 15:49:56 INFO - mozversion platform_version: 53.0a1 15:49:56 INFO - using testdate: 1483746596 15:49:56 INFO - actual date: 1483746596 15:49:56 INFO - starting webserver on 'localhost:33510' 15:49:56 INFO - SUITE-START | Running 2 tests 15:49:56 INFO - TEST-START | dromaeo_css 15:49:56 INFO - operating with platform_type : linux_ 15:49:56 INFO - Initialising browser for dromaeo_css test... 15:49:56 INFO - TEST-INFO | started process 3202 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUXayZn/profile http://localhost:33510/getInfo.html) 15:49:57 INFO - PROCESS | 3202 | 1483746597132 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 15:50:00 INFO - PROCESS | 3202 | __metrics Screen width/height:1600/1200 15:50:00 INFO - PROCESS | 3202 | colorDepth:24 15:50:00 INFO - PROCESS | 3202 | Browser inner width/height: 1024/697 15:50:00 INFO - PROCESS | 3202 | __metrics 15:50:01 INFO - PROCESS | 3202 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:50:01 INFO - PROCESS | 3202 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:50:01 INFO - PROCESS | 3202 | console.error: PushService: 15:50:01 INFO - PROCESS | 3202 | stateChangeProcessEnqueue: Error transitioning state 15:50:01 INFO - PROCESS | 3202 | UnknownError 15:50:02 INFO - TEST-INFO | 3202: exit 0 15:50:02 INFO - Browser initialized. 15:50:02 INFO - Running cycle 1/1 for dromaeo_css test... 15:50:02 INFO - TEST-INFO | started process 3285 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUXayZn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:50:14 INFO - PROCESS | 3285 | RSS: Main: 152231936 15:50:14 INFO - PROCESS | 3285 | 15:53:18 INFO - PROCESS | 3285 | Cycle 1(1): loaded http://localhost:33510/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33510/tests/dromaeo/cssquery-ext.html) 15:53:20 INFO - PROCESS | 3285 | RSS: Main: 258564096 15:53:20 INFO - PROCESS | 3285 | 15:55:02 INFO - PROCESS | 3285 | ************************* 15:55:02 INFO - PROCESS | 3285 | A coding exception was thrown and uncaught in a Task. 15:55:02 INFO - PROCESS | 3285 | 15:55:02 INFO - PROCESS | 3285 | Full message: ReferenceError: fetch is not defined 15:55:02 INFO - PROCESS | 3285 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 15:55:02 INFO - PROCESS | 3285 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 15:55:02 INFO - PROCESS | 3285 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 15:55:02 INFO - PROCESS | 3285 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 15:55:02 INFO - PROCESS | 3285 | TaskImpl@resource://gre/modules/Task.jsm:277:3 15:55:02 INFO - PROCESS | 3285 | asyncFunction@resource://gre/modules/Task.jsm:252:14 15:55:02 INFO - PROCESS | 3285 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 15:55:02 INFO - PROCESS | 3285 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 15:55:02 INFO - PROCESS | 3285 | TaskImpl@resource://gre/modules/Task.jsm:277:3 15:55:02 INFO - PROCESS | 3285 | asyncFunction@resource://gre/modules/Task.jsm:252:14 15:55:02 INFO - PROCESS | 3285 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 15:55:02 INFO - PROCESS | 3285 | 15:55:02 INFO - PROCESS | 3285 | ************************* 15:56:22 INFO - PROCESS | 3285 | Cycle 1(1): loaded http://localhost:33510/tests/dromaeo/cssquery-ext.html (next: http://localhost:33510/tests/dromaeo/cssquery-jquery.html) 15:56:23 INFO - PROCESS | 3285 | RSS: Main: 235118592 15:56:23 INFO - PROCESS | 3285 | 15:59:25 INFO - PROCESS | 3285 | Cycle 1(1): loaded http://localhost:33510/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33510/tests/dromaeo/cssquery-mootools.html) 15:59:26 INFO - PROCESS | 3285 | RSS: Main: 184532992 15:59:26 INFO - PROCESS | 3285 | 16:02:28 INFO - PROCESS | 3285 | Cycle 1(1): loaded http://localhost:33510/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33510/tests/dromaeo/cssquery-prototype.html) 16:02:29 INFO - PROCESS | 3285 | RSS: Main: 194711552 16:02:29 INFO - PROCESS | 3285 | 16:05:32 INFO - PROCESS | 3285 | Cycle 1(1): loaded http://localhost:33510/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33510/tests/dromaeo/cssquery-yui.html) 16:05:33 INFO - PROCESS | 3285 | RSS: Main: 184311808 16:05:33 INFO - PROCESS | 3285 | 16:08:35 INFO - PROCESS | 3285 | Cycle 1(1): loaded http://localhost:33510/tests/dromaeo/cssquery-yui.html (next: http://localhost:33510/tests/dromaeo/cssquery-dojo.html) 16:08:35 INFO - PROCESS | 3285 | RSS: Main: 252133376 16:08:35 INFO - PROCESS | 3285 | 16:08:35 INFO - PROCESS | 3285 | __start_tp_report 16:08:35 INFO - PROCESS | 3285 | _x_x_mozilla_page_load 16:08:35 INFO - PROCESS | 3285 | _x_x_mozilla_page_load_details 16:08:35 INFO - PROCESS | 3285 | |i|pagename|runs| 16:08:35 INFO - PROCESS | 3285 | |0;dojo.html;2534.3917459809645;2575.278921901866;2587.9870600647005;2600.0379859452005;2608.9086881959124;4585.220512512872;4594.37975873257;4725.432948046235;4763.261694437363;4775.928361074582;4698.624110071195;4705;4715.882102947428;4771.069641419916;4818.397700287464;4294.227039132955;4333.826646934119;4356.215881141393;4421.977890110561;4496.235639941201;4017.3170561004554;4326.97836510817;4421.24838777407;4459.977700111511;4492.438445194351;4307.052448461333;4332.848350307724;4356.803943822536;4361.825526978917;4458.398116254297;4305.182015417092;4339.978300108511;4362.498312694049;4362.563743625612;4424.823007079713;4339.349097635349;4349.195398851222;4356.8257269709175;4386.8903277418;4393.187260356813;4724.267738500538;4728.598069164125;4751.14479393709;4755.881102972418;4761.47623761386;4910.533499317559;4940.580050695695;5026.773795179189;5027.748612569357;5066.138756411382;5104.285400043997;5111.335526381584;5119.974400128012;5153.896922061538;5167.224916262553;4767.380240568704;4773.66584339093;4775.307580400822;4776.593989510861;4811.350467686888;5105.642605017613;5154.149565321755;5155.149400348975;5223.608229382736;5265.921011184835;4955.331030310862;4988.775505102207;4995.275685025724;4997.0505603935135;5003.2995380646735;5070.594352451795;5074.49255074497;5075.670081444694;5076.137056700296;5080.110980578384;4991.4758950310425;5016.874578135576;5069.619778516626;5118.974405128025;5131.204663277198;5084.415292241366;5088.872778180576;5093.363329583802;5098.668586541863;5130.05094057593;4363.105563359503;4363.8968623919745;4367.017421080295;4398.208322501981;4409.779511024436;3717.20080182762;3736.1220113273357;3754.9061273468383;3756.7933763642714;3791.734578579473;4413.889652758642;4422.358757980075;4450.221211288012;4455.688101832905;4458.286674132123;5123.923141152885;5127.538521533005;5128.512791284822;5129.461406552333;5142.434332223453;4252.893677658021;4274.764887931194;4280.571942805756;4416.403785488982;4462.107578484316;4474.440694913136;4490.034642551867;4499.21263778844;4499.52754960731;4501.639868810487;4678.485366609671;4766.213574760126;4786.928196077131;4788.904221915612;4842.709437433765;5144.819931302386;5145.485451454824;5146.974265128651;5148.9227661584355;5194.792208311776;4807.086653535817;4808.422989241313;4815;4819.855404337875;4871;4849.442314133919;4899.167141585867;4946.678465899849;4952.281919121635;5101.6173786966865;5109.9233511498105;5112.667676601009;5118.43697193301;5135.229715542699;5163.974180129076;4901.779419926183;4971.154903666313;4971.552560269593;4976.328195693535;4979.128652485873;4816.8554943351755;4853.126437241331;4907.803687852446;4969.428515720739;5021.347224860745;4860.198067318995;4913.6069114471475;4914.582260507754;4944.826931057396;4970.676906001243;4940.654154209171;4991.675541089818;4993.550580447777;5018.222175562793;5066.265391518135;4728.030753695415;4754.548317909793;4916.532929371704;4916.778744956414;4956.504349565014 16:08:35 INFO - PROCESS | 3285 | |1;ext.html;539.3743257820928;560.9382967873534;562.9071203251464;575.3872126185614;579.9879210777194;29891.85054074729;42511.574884251146;45077.32384014238;45244;45278.773606132;42042.7897860511;42494;42497.575024249745;42601.36097958525;42607.786961065154;7644.159142494321;7729.845403091949;7905;7915.881261781049;7919.524828510279;7516.774496765106;10108.797824043515;10364;10366.170706343475;10368.274220804547;10170.338927969695;10219.18246540275;10247;10247.180225581973;10249.897501025007;10096.747581310452;10159.13647339977;10169.23730720199;10170.694879153638;10172.6948191554;9888.060634239735;9955.203583713286;9957.601695932153;9959.701208963743;9964.850527242097;38942.80528597339;39278.410823837665;39298.41052384216;39301.60698393008;39319.60680393188;3715.5912849586525;3819.9045023874346;3825.9808700956596;3843.846246150151;3861.8251542932326;29330.853345733136;29341.973030944027;29594.852025739732;29677.70322296771;30890.84554577235;3321.1697075731067;3359.7312215022985;3375.0043737097617;3390.55922730046;3423.9486407703903;183220;183454;183555;183726;184167;52256;52543.73728131411;52559.474405256224;52572;52652;56285.155722664196;56318.43681563132;56485;56491.43508564862;56492.71753641288;14257;14681.265936703123;14687;14709.779353309708;14719.264036798117;10139.898601014043;10333.896661033445;11176.385298808482;11404.144689148181;11497.827532587018;16598.25307861125;16767.748483772753;16867.240974156193;17015.91492042532;17111.973281603143;6110.51115910735;6319;6322.968385158137;6323.881789137436;6374.003130356955;795.6061749434067;819.5533434278333;823.7075838077516;823.880537322097;832.887560179368;27131.593026104623;28093.71906280952;28122.91581640281;28284.575731364046;28649.427011459655;905.9864102038474;969.2100937735722;976.2336565795816;980.6861804222581;994.1450352696675;13930.721385572231;14997.175155366342;15128.470503532324;15133.319000644997;15286.159261240738;125025.37487312687;125654;125683;125805.22584322485;126020;51629.48370516322;51765.2235216472;51847.48152518427;51906;51953.220701689504;1161.6224726963771;1200.4357951762831;1210.4189988805422;1217.0750229825396;1223.6267938278731;25286.87356563279;26653.333666658487;27199.72800271972;27755.167344979684;27772.44455110846;43378.349324759525;43766.34350484809;43769.34345984749;43795.78102109469;43882.56117438785;287219;288499;288935;288998;289430;29914;37226.255474890895;37528.81235593914;37601.811990939874;40301.1939761209;37904.810475947445;41491.36138217871;42008.78995605002;42801.143977120904;42819.357709633754;32225.51661725029;34687.306253874274;35085.649143508235;35336.46995295021;35840;31839.522407164375;31910.84044579762;32287.677123228466;32990.34019319648;33540.49689254614;32498.18754531061;33286.500702489;33304.50043249305;33516.832415837765;33655.83172084124;27666.446671066064;29212;30644.508309383982;30775;31597.684023159472;22963.081476740743;23468.178613748438;23692.763072369056;23750.762492375547;24012.39969000789 16:08:35 INFO - PROCESS | 3285 | |2;jquery.html;360.76009453713283;377.2135098320003;380.99037550491187;385.1699587389176;406.7478163538606;13512.864871351283;16955.06747128909;16999.32002719891;17651.293948242055;17899.73150402745;17543.649127017452;17685.734713979302;18073.819261807377;18126.909365453153;18282.451526454195;4794.42466903972;5125.718085505296;5156.278121063054;5159.535641792238;5165.199394093921;3873.8063096845185;4033.2336855997414;4957.330760347361;5049.091163590552;5675.34733505648;5878.470937615613;5974.581779275452;5990.281166260055;5998.490128339096;6017.849553761147;5825.475707186331;5935.73289201987;5979.1031345298115;5981.671008094553;6010.398960103998;5277.762500687479;5280;5287.603429742785;5296.894062118775;5303.946960530384;21707.565848683094;21721;21746.13015479379;21767.891160544095;21846.344609661737;2294.724633044029;2344.0975224538506;2354.21133920137;2362.799162071226;2439.353571303606;13353.86646133536;13811.51659691916;14010.719785604231;14048.508302209475;14282.714345713028;1663.534210421084;1728.420978972046;1750.1774166141893;1758.6922288599444;1765.7792775903013;64606.67696661487;79615;80053;81957;83607;9810.852837207447;9945.35355201924;10045.29682922203;10059.849102263472;10135.239857010754;13850.16898986064;13888.583342499742;13891.722165556632;13891.930540347234;13901.0964287321;7387.445941554405;7499.250074992567;7667.271609197117;7735.7679269622;7765.495242809199;7238.782836514913;7319.15829679583;7321.670524826395;7462.216467270859;7508.621120495799;6382.766031888802;6386.584871983307;6399.616023038632;6432.195975503062;6579.967100164565;1703.276107654242;1774.4853992342335;1785.7142857142794;1812.9365472208674;1845.1143451143257;976.3214565876648;985.6796541124163;986.3835103060587;990.8910019897805;1030.1192480429124;17603.471895843144;17730.91134544319;18017;18431.354902578347;18745.437636870916;984.4093543873762;985.4826216236534;988.2341185581089;1020.3928662445833;1030.2324768047852;9829.754256143511;10178.338408003456;10364.274500784873;10388.480575971322;10405.635802746867;481495;485329;486018;496712;500870;76728.23271767322;77934;79167;81811.18188818036;82169.58915205386;929.0802105915095;937.8640097186006;965.8309795785709;985.1281615769952;988.4020167798523;16082;16244.756328655316;16520.504384868473;16943.576410589834;17038.14809259557;38742.80628596839;39567.40648890327;39656.60343396645;40713.796431017654;42652.24194733671;49355;51367.74316128396;53903;54725;56063.71968140297;7821.804454888674;7831.04223944014;7909.9209007909185;7982.201779821971;8095.55474448911;10009.949950250202;11841.526338946345;12247.387630618256;12353;12494.750104998031;10277.126444252322;10466.63366782159;10500.36997780105;10629.25595208328;11064.668059958214;10358.585656573954;10665;10749.355038697704;10852.403117828595;10972.615958441416;10155.339902906288;10337.74155646115;10621.946890265499;10887.945560272148;11044.33733975964;7935.761927142195;8090.55501947375;8132.430729848854;8195.549244791593;8439.746807595782;8828.293736500937;10269;10375.221858360805;10587.523561439908;10829.458527073457 16:08:35 INFO - PROCESS | 3285 | |3;mootools.html;1340.4772138865842;1350.7298540291945;1358.3887250737168;1361.8501964783877;1367.8221831161948;6661.533692641517;6965.616891070989;6978.1626204855365;6979.0229367888405;7002.929970700297;6168.753249870011;6325.3042165361885;6688.230853451854;6854.177498700163;6920.550164239334;2066.5453600207966;2101.243552321163;2104.2635077722825;2105.1368938735122;2107.725995620567;2100.978990210101;2126.6916297136904;2127.393692797553;2131.818795402393;2136.476563242008;1839.2367167625418;1904.4286713985819;2030.3096947038005;2066.5246993191577;2103.852730308879;1991.890446025468;1993.5614164883848;1998.0409403486262;2001.8498612604112;2004.1782869023775;2029.52306208041;2037.9388618341472;2048.7131801547794;2051.8974051297378;2054.476108592314;6869.313068693141;7023.61370124643;7028.578285302899;7048.682809273544;7056.964715176443;4276.615104640598;4398.142362239365;4404.14119246747;4410.977945110286;4412.889677758082;2771.5842623606623;2868.1108856254627;2918.9562156567667;2949.557566365041;2970.628671416073;1134.8865113488669;1173.6185739634568;1184.7156682396248;1225.5611333446377;1236.7402845402476;8995.955020224923;9067.274618030542;9068.682596109105;9085.81828363429;9096.909030909672;3799.7530160539477;3861.903452413656;4016.819243134066;4040.1919616076902;4050.210209009215;7910.802229944297;7973.401994850409;7984.760457186294;7985.081715602664;8025.598720063974;4208.137331846964;4256.489221293403;4258.808353624032;4359.825606975749;4375.671824613167;3601.8019008954234;3686.060054686038;3894.2600905827803;3896.532416110085;3924.6664033556895;3339.315440334774;3372.2412457196933;3474.4614584739406;3476.89569312921;3494.1963348430004;1145.5131569083105;1150.8158694608821;1159.7100724818795;1160.228448082016;1169.0705888818409;672.7914346552584;685.8216863615396;687.2440315652842;806.4153488720631;847.7922908887363;4643.907121857544;4692.6480513960905;4723.929141062887;4883.193218509175;4893.877653058702;894.1639567004871;896.5248418338291;911.4485736129546;913.6939125393068;940.6284517615503;3276.3447310537986;3360.764746467724;3363.814990175515;3380.645032271625;3472.774269672463;7875.409344299201;8165.959170204111;8192.467489613156;8281.461704989157;8285;8050.476719013245;8214.548199848947;8220.38347123968;8236.299914507214;8254.587270636444;6487.513436492282;6617.272100068989;6657.7669781557415;6661.866762664719;6669.499787515956;4535.345946994782;4643.628509719282;4794.065157294294;4805.711657300573;4862.5380588844;7585.848283034419;7613.124490683421;7659.425543084402;7719.768406947801;7725.420593455401;7532.096148462219;7774.844503110019;7821.882671759814;7837.294643482114;7838;5460.645058071213;5554.305711786027;5559.805406810742;5943.91084133747;6099.176611157614;6481.902771458337;6568.6058836469965;6576.934230657632;6640;6647;6013.428724271363;6021.217241758543;6027.638341699512;6046.939530604814;6098.115773212948;6045.6070355426755;6072.514198864169;6075.908861367171;6077.149199112039;6083.057126145454;5363.168708849978;5369.946300537101;5396.541293989898;5398.595105367034;5405.378381486022;4230.894227644333;4242.236397448489;4247.681423893282;4333.523312435566;4356.782160892006;4068.9186216276103;4103.548609652996;4131.628153466202;4231.40760293553;4258.276093064124 16:08:35 INFO - PROCESS | 3285 | |4;prototype.html;345.3076581454184;348.9531405782652;349;359.2778515184479;359.3101245608432;4942.851714448563;4947.529984651462;4960.702357858527;4970.826021089262;4985;4667.436408803047;4744.715317080978;4829.637777166709;4880.341153944217;4907.214845624691;3942.9211415771665;3952.189801090784;3968.3452230381954;3972.36442169253;3976.960230397688;3948.151147503286;3969.523657161145;3973.3443981742976;3981.6814654827544;3983.760974341534;3745.4756334113245;3870.980645096771;3875;3942.9802850985707;3974.370508091683;3928.4500169976227;3939.8227079781477;3964.643182113595;3968.6626636735914;3969.364901615728;3572.3391172632887;3572.99956012317;3585.032041348821;3599.5140656011627;3608.170120872188;4725.66920315578;4776.952230477686;4820.071971211509;4888.70667759932;4898.412190537123;4516.458025036984;4517.661175411858;4518.52555481673;4526.4794548627;4530.59224669778;5145.665531740425;5157.458466860963;5159.071367153911;5169.922451163236;5212.801055757159;3792.848286068554;3902.20004898995;3914.5498267699295;3929.469521614574;3932.960670393288;5325.068113080196;5334.839954801362;5343.759530821122;5379.246905433242;5384.165454354581;4014.136960553495;4020.4572382728543;4029.294873397144;4055.5944405559208;4056.6551843093666;4139.234241665241;4139.992103829641;4145.191687620885;4158.355454904495;4167.791610419466;4179.2477354076555;4266.74131131317;4336.9783151084675;4339;4360.171567402183;5166.147585648401;5170.6122040847085;5174.818881339135;5178.456262092502;5193.350831146106;1235.2403271987662;1242.5400154818053;1244.4213440750095;1247.7005518675453;1248.825164476974;833.5373867503594;844.4046946902419;857.7726902370877;870.621279743301;879.6804792810784;4420.204363214652;4449.421575195269;4474.194644963873;4475.753833539186;4489.7979590918485;5229.52934235913;5243.895122097537;5247.212918062245;5249.448807875118;5251.159814429673;4361;4440.400545926259;4470.401326931851;4504.729716216972;4529.705569137996;2750.436160587115;2767.51568475516;2771.9307017324327;2772.7643150332046;2787.2056463908093;4846.49758574843;4865.7323847188745;4878.365812444359;4888.926666100011;4898.853034408973;5155.226715992556;5228.209548077613;5230.895382092337;5260.736963151904;5307.814226502054;4804.213556137432;4809.495003024702;4826.5037838269545;4827.25177597473;4847.951520484891;5116.718580478109;5144.331236939174;5159.420289855072;5165;5166.664166829144;4989.426215985208;5091.236314552847;5241.161414173714;5311.203319502106;5320.5477534408465;5038.521340472649;5040.319556859777;5042.773075211551;5043.949560504495;5055.34280543527;3797.1456422305864;3798.2593394287846;3808.504894363715;3812.6949844011856;3816.31306364857;5149.948500514947;5247.134222853187;5292.364916210079;5352.250684904038;5405.72971351423;5152.639315248047;5183.403908550565;5183.714895680774;5188.169892817131;5196.726801933551;5209.322788037531;5209.4009188943755;5211.661242019257;5216.530512253916;5222.2688823565495;4894.755262236803;5095.312132862165;5136.845894623168;5140.3712934336845;5147.279380886604;4975.875603109951;5015.523525265094;5110.9488905110475;5158.638895277295;5166.638335316492;5068.974655126701;5083.923741143812;5084.898302034013;5084.949150508448;5098.209777484496 16:08:35 INFO - PROCESS | 3285 | |5;yui.html;567.2738894215406;589.7139887154732;696.9825754356141;741.6921977379387;754.22315015534;12436.564720234794;13090.541831035891;13115.73768524629;13131.868681313195;13203.141795783267;13077.280749558795;13123.6719082023;13159;13162.210267383964;13168.670783230424;662.9270780214173;682.4608559238196;786.532013451998;796.0367954774715;807.7536351412816;801.3789313282194;813.7070654564352;815.6859609050499;815.9388045896552;816.2408959667507;855.9529225892574;857.5069335132292;858.0518527027638;859.188067276424;859.415597393772;694.5936627073169;715.2668514772348;813.5932033983008;855.4396870050095;856.3448961544392;617.7343742190856;620.798240571816;621.0249907644999;621.1335187413533;621.6425555305717;12914.096013279075;12935.094543381967;12986.02604804634;12998.220106793622;13013.154144980546;13104.213747175105;13166.802497962539;13287.20276783396;13344.466221351135;13475.86524134756;12084.879151208463;12126.514939402414;12127.332996685178;12595.370231488389;12679.239245645198;3998.640122388999;4000.599940006005;4007.4189242559664;4124.154548317588;4141.482314710661;68284;69095.99999999949;69892.650536747;70467;72020;10296.691099267035;10420.218483613608;10430.68707938763;10434.269601128;10954.671359859218;19862;19879;19930.601387972158;20025.699614505793;20195.899020504803;6070.0591408331775;6111.113888486145;6180.6291622502795;6196.039613859859;6342.746290148342;3491.912702182415;3539.2744487380023;3564.480890671298;3637.654422829827;3673.9632603674154;2755.793315501345;2807.6630804303204;2822.5766135079903;2827.515554333991;2847.5301575239855;476.6710969431081;477.1078083982974;477.24356894322193;480.47628085387095;482.4933819489522;546.3443867359185;552.7015411677729;555.1727925391219;556.7105105345198;560.2240896358572;7398.704051837866;7429.5170813898;7433;7646.502977306457;7840;507.3708601334319;514.0823629820752;516.235970763265;520.2612290547431;528.2103255632777;3409.3863104640905;3487.2502411981545;3532.0816587687386;3611.7832930024283;3615.584207816135;65931.67034164799;67526;68577.65711171512;71270;72007;57783;58387.416125839045;60123;60130.69934650299;60676.69661651752;52264.73867630638;52843.99999999923;52880.423915217114;53312;53690.46309536933;6904.206016307988;6904.344087311697;7020.473464490082;7033.683484243119;7260.891086633599;35172.648273516934;36219;37258.6274137266;37699.81150094232;38426;44405;44717.10565788731;45026.77486612677;45467;45758.313625296316;8327.541985190872;8418.915810841812;8470.364722645949;8557.31541476668;8675.566221689016;9300.488473134043;9304.255659547356;9378.718638440858;9455.905440945779;9645.228381729305;8758.430702004349;8767.605457754544;8805.603747831236;8930.732078037669;8945.59744811472;8715.864613169813;8732.126787321216;8809.955950220208;8819.426737262058;8837.955810221165;8593.65625374978;8597.732936091359;8632.223099920786;8924.97362803286;8962;7569.772906812805;7795.41534384912;7805.765827025199;7820.061592608696;7967.123616402076;7409.221786771029;7530.623468826647;7658.540487570764;7743.806404839699;7785.299323060952 16:08:35 INFO - PROCESS | 3285 | __end_tp_report 16:08:35 INFO - PROCESS | 3285 | __start_cc_report 16:08:35 INFO - PROCESS | 3285 | _x_x_mozilla_cycle_collect,1133 16:08:35 INFO - PROCESS | 3285 | __end_cc_report 16:08:35 INFO - PROCESS | 3285 | __startTimestamp1483747715965__endTimestamp 16:08:35 INFO - PROCESS | 3285 | 16:08:35 INFO - PROCESS | 3285 | ------- Summary: start ------- 16:08:35 INFO - PROCESS | 3285 | Number of tests: 6 16:08:35 INFO - PROCESS | 3285 | 16:08:35 INFO - PROCESS | 3285 | [#0] dojo.html Cycles:165 Average:4693.88 Median:4815.00 stddev:505.13 (10.5%) stddev-sans-first:477.42 16:08:35 INFO - PROCESS | 3285 | Values: 2534.4 2575.3 2588.0 2600.0 2608.9 4585.2 4594.4 4725.4 4763.3 4775.9 4698.6 4705.0 4715.9 4771.1 4818.4 4294.2 4333.8 4356.2 4422.0 4496.2 4017.3 4327.0 4421.2 4460.0 4492.4 4307.1 4332.8 4356.8 4361.8 4458.4 4305.2 4340.0 4362.5 4362.6 4424.8 4339.3 4349.2 4356.8 4386.9 4393.2 4724.3 4728.6 4751.1 4755.9 4761.5 4910.5 4940.6 5026.8 5027.7 5066.1 5104.3 5111.3 5120.0 5153.9 5167.2 4767.4 4773.7 4775.3 4776.6 4811.4 5105.6 5154.1 5155.1 5223.6 5265.9 4955.3 4988.8 4995.3 4997.1 5003.3 5070.6 5074.5 5075.7 5076.1 5080.1 4991.5 5016.9 5069.6 5119.0 5131.2 5084.4 5088.9 5093.4 5098.7 5130.1 4363.1 4363.9 4367.0 4398.2 4409.8 3717.2 3736.1 3754.9 3756.8 3791.7 4413.9 4422.4 4450.2 4455.7 4458.3 5123.9 5127.5 5128.5 5129.5 5142.4 4252.9 4274.8 4280.6 4416.4 4462.1 4474.4 4490.0 4499.2 4499.5 4501.6 4678.5 4766.2 4786.9 4788.9 4842.7 5144.8 5145.5 5147.0 5148.9 5194.8 4807.1 4808.4 4815.0 4819.9 4871.0 4849.4 4899.2 4946.7 4952.3 5101.6 5109.9 5112.7 5118.4 5135.2 5164.0 4901.8 4971.2 4971.6 4976.3 4979.1 4816.9 4853.1 4907.8 4969.4 5021.3 4860.2 4913.6 4914.6 4944.8 4970.7 4940.7 4991.7 4993.6 5018.2 5066.3 4728.0 4754.5 4916.5 4916.8 4956.5 16:08:35 INFO - PROCESS | 3285 | 16:08:35 INFO - PROCESS | 3285 | [#1] ext.html Cycles:180 Average:37901.95 Median:33528.66 stddev:55023.59 (164.1%) stddev-sans-first:55106.43 16:08:35 INFO - PROCESS | 3285 | Values: 539.4 560.9 562.9 575.4 580.0 29891.9 42511.6 45077.3 45244.0 45278.8 42042.8 42494.0 42497.6 42601.4 42607.8 7644.2 7729.8 7905.0 7915.9 7919.5 7516.8 10108.8 10364.0 10366.2 10368.3 10170.3 10219.2 10247.0 10247.2 10249.9 10096.7 10159.1 10169.2 10170.7 10172.7 9888.1 9955.2 9957.6 9959.7 9964.9 38942.8 39278.4 39298.4 39301.6 39319.6 3715.6 3819.9 3826.0 3843.8 3861.8 29330.9 29342.0 29594.9 29677.7 30890.8 3321.2 3359.7 3375.0 3390.6 3423.9 183220.0 183454.0 183555.0 183726.0 184167.0 52256.0 52543.7 52559.5 52572.0 52652.0 56285.2 56318.4 56485.0 56491.4 56492.7 14257.0 14681.3 14687.0 14709.8 14719.3 10139.9 10333.9 11176.4 11404.1 11497.8 16598.3 16767.7 16867.2 17015.9 17112.0 6110.5 6319.0 6323.0 6323.9 6374.0 795.6 819.6 823.7 823.9 832.9 27131.6 28093.7 28122.9 28284.6 28649.4 906.0 969.2 976.2 980.7 994.1 13930.7 14997.2 15128.5 15133.3 15286.2 125025.4 125654.0 125683.0 125805.2 126020.0 51629.5 51765.2 51847.5 51906.0 51953.2 1161.6 1200.4 1210.4 1217.1 1223.6 25286.9 26653.3 27199.7 27755.2 27772.4 43378.3 43766.3 43769.3 43795.8 43882.6 287219.0 288499.0 288935.0 288998.0 289430.0 29914.0 37226.3 37528.8 37601.8 40301.2 37904.8 41491.4 42008.8 42801.1 42819.4 32225.5 34687.3 35085.6 35336.5 35840.0 31839.5 31910.8 32287.7 32990.3 33540.5 32498.2 33286.5 33304.5 33516.8 33655.8 27666.4 29212.0 30644.5 30775.0 31597.7 22963.1 23468.2 23692.8 23750.8 24012.4 16:08:35 INFO - PROCESS | 3285 | 16:08:35 INFO - PROCESS | 3285 | [#2] jquery.html Cycles:180 Average:27987.99 Median:39612.00 stddev:80543.09 (203.3%) stddev-sans-first:80742.32 16:08:35 INFO - PROCESS | 3285 | Values: 360.8 377.2 381.0 385.2 406.7 13512.9 16955.1 16999.3 17651.3 17899.7 17543.6 17685.7 18073.8 18126.9 18282.5 4794.4 5125.7 5156.3 5159.5 5165.2 3873.8 4033.2 4957.3 5049.1 5675.3 5878.5 5974.6 5990.3 5998.5 6017.8 5825.5 5935.7 5979.1 5981.7 6010.4 5277.8 5280.0 5287.6 5296.9 5303.9 21707.6 21721.0 21746.1 21767.9 21846.3 2294.7 2344.1 2354.2 2362.8 2439.4 13353.9 13811.5 14010.7 14048.5 14282.7 1663.5 1728.4 1750.2 1758.7 1765.8 64606.7 79615.0 80053.0 81957.0 83607.0 9810.9 9945.4 10045.3 10059.8 10135.2 13850.2 13888.6 13891.7 13891.9 13901.1 7387.4 7499.3 7667.3 7735.8 7765.5 7238.8 7319.2 7321.7 7462.2 7508.6 6382.8 6386.6 6399.6 6432.2 6580.0 1703.3 1774.5 1785.7 1812.9 1845.1 976.3 985.7 986.4 990.9 1030.1 17603.5 17730.9 18017.0 18431.4 18745.4 984.4 985.5 988.2 1020.4 1030.2 9829.8 10178.3 10364.3 10388.5 10405.6 481495.0 485329.0 486018.0 496712.0 500870.0 76728.2 77934.0 79167.0 81811.2 82169.6 929.1 937.9 965.8 985.1 988.4 16082.0 16244.8 16520.5 16943.6 17038.1 38742.8 39567.4 39656.6 40713.8 42652.2 49355.0 51367.7 53903.0 54725.0 56063.7 7821.8 7831.0 7909.9 7982.2 8095.6 10009.9 11841.5 12247.4 12353.0 12494.8 10277.1 10466.6 10500.4 10629.3 11064.7 10358.6 10665.0 10749.4 10852.4 10972.6 10155.3 10337.7 10621.9 10887.9 11044.3 7935.8 8090.6 8132.4 8195.5 8439.7 8828.3 10269.0 10375.2 10587.5 10829.5 16:08:35 INFO - PROCESS | 3285 | 16:08:35 INFO - PROCESS | 3285 | [#3] mootools.html Cycles:180 Average:4595.12 Median:4799.89 stddev:2411.50 (50.2%) stddev-sans-first:2405.86 16:08:35 INFO - PROCESS | 3285 | Values: 1340.5 1350.7 1358.4 1361.9 1367.8 6661.5 6965.6 6978.2 6979.0 7002.9 6168.8 6325.3 6688.2 6854.2 6920.6 2066.5 2101.2 2104.3 2105.1 2107.7 2101.0 2126.7 2127.4 2131.8 2136.5 1839.2 1904.4 2030.3 2066.5 2103.9 1991.9 1993.6 1998.0 2001.8 2004.2 2029.5 2037.9 2048.7 2051.9 2054.5 6869.3 7023.6 7028.6 7048.7 7057.0 4276.6 4398.1 4404.1 4411.0 4412.9 2771.6 2868.1 2919.0 2949.6 2970.6 1134.9 1173.6 1184.7 1225.6 1236.7 8996.0 9067.3 9068.7 9085.8 9096.9 3799.8 3861.9 4016.8 4040.2 4050.2 7910.8 7973.4 7984.8 7985.1 8025.6 4208.1 4256.5 4258.8 4359.8 4375.7 3601.8 3686.1 3894.3 3896.5 3924.7 3339.3 3372.2 3474.5 3476.9 3494.2 1145.5 1150.8 1159.7 1160.2 1169.1 672.8 685.8 687.2 806.4 847.8 4643.9 4692.6 4723.9 4883.2 4893.9 894.2 896.5 911.4 913.7 940.6 3276.3 3360.8 3363.8 3380.6 3472.8 7875.4 8166.0 8192.5 8281.5 8285.0 8050.5 8214.5 8220.4 8236.3 8254.6 6487.5 6617.3 6657.8 6661.9 6669.5 4535.3 4643.6 4794.1 4805.7 4862.5 7585.8 7613.1 7659.4 7719.8 7725.4 7532.1 7774.8 7821.9 7837.3 7838.0 5460.6 5554.3 5559.8 5943.9 6099.2 6481.9 6568.6 6576.9 6640.0 6647.0 6013.4 6021.2 6027.6 6046.9 6098.1 6045.6 6072.5 6075.9 6077.1 6083.1 5363.2 5369.9 5396.5 5398.6 5405.4 4230.9 4242.2 4247.7 4333.5 4356.8 4068.9 4103.5 4131.6 4231.4 4258.3 16:08:35 INFO - PROCESS | 3285 | 16:08:35 INFO - PROCESS | 3285 | [#4] prototype.html Cycles:180 Average:4305.52 Median:4847.22 stddev:1220.15 (25.2%) stddev-sans-first:1186.82 16:08:35 INFO - PROCESS | 3285 | Values: 345.3 349.0 349.0 359.3 359.3 4942.9 4947.5 4960.7 4970.8 4985.0 4667.4 4744.7 4829.6 4880.3 4907.2 3942.9 3952.2 3968.3 3972.4 3977.0 3948.2 3969.5 3973.3 3981.7 3983.8 3745.5 3871.0 3875.0 3943.0 3974.4 3928.5 3939.8 3964.6 3968.7 3969.4 3572.3 3573.0 3585.0 3599.5 3608.2 4725.7 4777.0 4820.1 4888.7 4898.4 4516.5 4517.7 4518.5 4526.5 4530.6 5145.7 5157.5 5159.1 5169.9 5212.8 3792.8 3902.2 3914.5 3929.5 3933.0 5325.1 5334.8 5343.8 5379.2 5384.2 4014.1 4020.5 4029.3 4055.6 4056.7 4139.2 4140.0 4145.2 4158.4 4167.8 4179.2 4266.7 4337.0 4339.0 4360.2 5166.1 5170.6 5174.8 5178.5 5193.4 1235.2 1242.5 1244.4 1247.7 1248.8 833.5 844.4 857.8 870.6 879.7 4420.2 4449.4 4474.2 4475.8 4489.8 5229.5 5243.9 5247.2 5249.4 5251.2 4361.0 4440.4 4470.4 4504.7 4529.7 2750.4 2767.5 2771.9 2772.8 2787.2 4846.5 4865.7 4878.4 4888.9 4898.9 5155.2 5228.2 5230.9 5260.7 5307.8 4804.2 4809.5 4826.5 4827.3 4848.0 5116.7 5144.3 5159.4 5165.0 5166.7 4989.4 5091.2 5241.2 5311.2 5320.5 5038.5 5040.3 5042.8 5043.9 5055.3 3797.1 3798.3 3808.5 3812.7 3816.3 5149.9 5247.1 5292.4 5352.3 5405.7 5152.6 5183.4 5183.7 5188.2 5196.7 5209.3 5209.4 5211.7 5216.5 5222.3 4894.8 5095.3 5136.8 5140.4 5147.3 4975.9 5015.5 5110.9 5158.6 5166.6 5069.0 5083.9 5084.9 5084.9 5098.2 16:08:35 INFO - PROCESS | 3285 | 16:08:35 INFO - PROCESS | 3285 | [#5] yui.html Cycles:180 Average:14697.79 Median:60403.70 stddev:19555.36 (32.4%) stddev-sans-first:19581.44 16:08:35 INFO - PROCESS | 3285 | Values: 567.3 589.7 697.0 741.7 754.2 12436.6 13090.5 13115.7 13131.9 13203.1 13077.3 13123.7 13159.0 13162.2 13168.7 662.9 682.5 786.5 796.0 807.8 801.4 813.7 815.7 815.9 816.2 856.0 857.5 858.1 859.2 859.4 694.6 715.3 813.6 855.4 856.3 617.7 620.8 621.0 621.1 621.6 12914.1 12935.1 12986.0 12998.2 13013.2 13104.2 13166.8 13287.2 13344.5 13475.9 12084.9 12126.5 12127.3 12595.4 12679.2 3998.6 4000.6 4007.4 4124.2 4141.5 68284.0 69096.0 69892.7 70467.0 72020.0 10296.7 10420.2 10430.7 10434.3 10954.7 19862.0 19879.0 19930.6 20025.7 20195.9 6070.1 6111.1 6180.6 6196.0 6342.7 3491.9 3539.3 3564.5 3637.7 3674.0 2755.8 2807.7 2822.6 2827.5 2847.5 476.7 477.1 477.2 480.5 482.5 546.3 552.7 555.2 556.7 560.2 7398.7 7429.5 7433.0 7646.5 7840.0 507.4 514.1 516.2 520.3 528.2 3409.4 3487.3 3532.1 3611.8 3615.6 65931.7 67526.0 68577.7 71270.0 72007.0 57783.0 58387.4 60123.0 60130.7 60676.7 52264.7 52844.0 52880.4 53312.0 53690.5 6904.2 6904.3 7020.5 7033.7 7260.9 35172.6 36219.0 37258.6 37699.8 38426.0 44405.0 44717.1 45026.8 45467.0 45758.3 8327.5 8418.9 8470.4 8557.3 8675.6 9300.5 9304.3 9378.7 9455.9 9645.2 8758.4 8767.6 8805.6 8930.7 8945.6 8715.9 8732.1 8810.0 8819.4 8838.0 8593.7 8597.7 8632.2 8925.0 8962.0 7569.8 7795.4 7805.8 7820.1 7967.1 7409.2 7530.6 7658.5 7743.8 7785.3 16:08:35 INFO - PROCESS | 3285 | -------- Summary: end -------- 16:08:35 INFO - PROCESS | 3285 | 16:08:36 INFO - TEST-INFO | 3285: exit 0 16:08:36 INFO - TEST-OK | dromaeo_css | took 1120231ms 16:08:36 INFO - TEST-START | kraken 16:08:36 INFO - operating with platform_type : linux_ 16:08:36 INFO - Initialising browser for kraken test... 16:08:36 INFO - TEST-INFO | started process 3587 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKYxrdN/profile http://localhost:33510/getInfo.html) 16:08:37 INFO - PROCESS | 3587 | 1483747717307 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 16:08:40 INFO - PROCESS | 3587 | __metrics Screen width/height:1600/1200 16:08:40 INFO - PROCESS | 3587 | colorDepth:24 16:08:40 INFO - PROCESS | 3587 | Browser inner width/height: 1024/697 16:08:40 INFO - PROCESS | 3587 | __metrics 16:08:41 INFO - PROCESS | 3587 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:08:41 INFO - PROCESS | 3587 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:08:42 INFO - TEST-INFO | 3587: exit 0 16:08:42 INFO - Browser initialized. 16:08:42 INFO - Running cycle 1/1 for kraken test... 16:08:42 INFO - TEST-INFO | started process 3669 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKYxrdN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:54 INFO - PROCESS | 3669 | RSS: Main: 152231936 16:08:54 INFO - PROCESS | 3669 | 16:08:57 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33510/tests/kraken/driver.html?testName=audio-beat-detection) 16:08:58 INFO - PROCESS | 3669 | RSS: Main: 206737408 16:08:58 INFO - PROCESS | 3669 | 16:09:01 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33510/tests/kraken/driver.html?testName=audio-dft) 16:09:01 INFO - PROCESS | 3669 | RSS: Main: 185630720 16:09:01 INFO - PROCESS | 3669 | 16:09:04 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33510/tests/kraken/driver.html?testName=audio-fft) 16:09:05 INFO - PROCESS | 3669 | RSS: Main: 267788288 16:09:05 INFO - PROCESS | 3669 | 16:09:07 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33510/tests/kraken/driver.html?testName=audio-oscillator) 16:09:08 INFO - PROCESS | 3669 | RSS: Main: 179335168 16:09:08 INFO - PROCESS | 3669 | 16:09:10 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33510/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:09:10 INFO - PROCESS | 3669 | RSS: Main: 182710272 16:09:10 INFO - PROCESS | 3669 | 16:09:14 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33510/tests/kraken/driver.html?testName=imaging-darkroom) 16:09:14 INFO - PROCESS | 3669 | RSS: Main: 222064640 16:09:14 INFO - PROCESS | 3669 | 16:09:18 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33510/tests/kraken/driver.html?testName=imaging-desaturate) 16:09:18 INFO - PROCESS | 3669 | RSS: Main: 221712384 16:09:18 INFO - PROCESS | 3669 | 16:09:21 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33510/tests/kraken/driver.html?testName=json-parse-financial) 16:09:22 INFO - PROCESS | 3669 | RSS: Main: 219914240 16:09:22 INFO - PROCESS | 3669 | 16:09:23 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33510/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:09:24 INFO - PROCESS | 3669 | RSS: Main: 182800384 16:09:24 INFO - PROCESS | 3669 | 16:09:26 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33510/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:09:26 INFO - PROCESS | 3669 | RSS: Main: 190676992 16:09:26 INFO - PROCESS | 3669 | 16:09:29 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33510/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:09:29 INFO - PROCESS | 3669 | RSS: Main: 197857280 16:09:29 INFO - PROCESS | 3669 | 16:09:32 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33510/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:09:33 INFO - PROCESS | 3669 | RSS: Main: 206405632 16:09:33 INFO - PROCESS | 3669 | 16:09:36 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33510/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:09:36 INFO - PROCESS | 3669 | RSS: Main: 204132352 16:09:36 INFO - PROCESS | 3669 | 16:09:38 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:33510/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33510/tests/kraken/driver.html?testName=ai-astar) 16:09:38 INFO - PROCESS | 3669 | RSS: Main: 254984192 16:09:38 INFO - PROCESS | 3669 | 16:09:38 INFO - PROCESS | 3669 | __start_tp_report 16:09:38 INFO - PROCESS | 3669 | _x_x_mozilla_page_load 16:09:38 INFO - PROCESS | 3669 | _x_x_mozilla_page_load_details 16:09:38 INFO - PROCESS | 3669 | |i|pagename|runs| 16:09:38 INFO - PROCESS | 3669 | |0;ai-astar;109;117;114;117;115;115;116;116;115;115 16:09:38 INFO - PROCESS | 3669 | |1;audio-beat-detection;159;124;125;162;131;128;124;120;148;123 16:09:38 INFO - PROCESS | 3669 | |2;audio-dft;161;163;163;162;163;163;161;163;160;162 16:09:38 INFO - PROCESS | 3669 | |3;audio-fft;74;75;78;108;76;77;77;76;93;76 16:09:38 INFO - PROCESS | 3669 | |4;audio-oscillator;85;84;120;83;84;85;104;84;84;112 16:09:38 INFO - PROCESS | 3669 | |5;imaging-gaussian-blur;117;117;117;117;117;118;117;117;118;117 16:09:38 INFO - PROCESS | 3669 | |6;imaging-darkroom;150;149;150;149;149;150;149;149;149;148 16:09:38 INFO - PROCESS | 3669 | |7;imaging-desaturate;95;96;95;95;94;95;96;96;95;95 16:09:38 INFO - PROCESS | 3669 | |8;json-parse-financial;60;61;60;59;60;61;61;61;61;62 16:09:38 INFO - PROCESS | 3669 | |9;json-stringify-tinderbox;67;68;71;67;68;68;67;67;67;68 16:09:38 INFO - PROCESS | 3669 | |10;stanford-crypto-aes;85;84;85;93;86;84;83;85;84;85 16:09:38 INFO - PROCESS | 3669 | |11;stanford-crypto-ccm;133;142;132;131;129;134;129;142;180;131 16:09:38 INFO - PROCESS | 3669 | |12;stanford-crypto-pbkdf2;174;175;174;175;178;172;173;174;172;180 16:09:38 INFO - PROCESS | 3669 | |13;stanford-crypto-sha256-iterative;69;70;69;69;68;68;67;68;68;66 16:09:38 INFO - PROCESS | 3669 | __end_tp_report 16:09:38 INFO - PROCESS | 3669 | __start_cc_report 16:09:38 INFO - PROCESS | 3669 | _x_x_mozilla_cycle_collect,1845 16:09:38 INFO - PROCESS | 3669 | __end_cc_report 16:09:38 INFO - PROCESS | 3669 | __startTimestamp1483747778860__endTimestamp 16:09:38 INFO - PROCESS | 3669 | 16:09:38 INFO - PROCESS | 3669 | ------- Summary: start ------- 16:09:38 INFO - PROCESS | 3669 | Number of tests: 14 16:09:38 INFO - PROCESS | 3669 | 16:09:38 INFO - PROCESS | 3669 | [#0] ai-astar Cycles:10 Average:114.90 Median:115.50 stddev:2.28 (2.0%) stddev-sans-first:1.01 16:09:38 INFO - PROCESS | 3669 | Values: 109.0 117.0 114.0 117.0 115.0 115.0 116.0 116.0 115.0 115.0 16:09:38 INFO - PROCESS | 3669 | 16:09:38 INFO - PROCESS | 3669 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:129.50 stddev:15.80 (12.2%) stddev-sans-first:14.03 16:09:38 INFO - PROCESS | 3669 | Values: 159.0 124.0 125.0 162.0 131.0 128.0 124.0 120.0 148.0 123.0 16:09:38 INFO - PROCESS | 3669 | 16:09:38 INFO - PROCESS | 3669 | [#2] audio-dft Cycles:10 Average:162.10 Median:163.00 stddev:1.10 (0.7%) stddev-sans-first:1.09 16:09:38 INFO - PROCESS | 3669 | Values: 161.0 163.0 163.0 162.0 163.0 163.0 161.0 163.0 160.0 162.0 16:09:38 INFO - PROCESS | 3669 | 16:09:38 INFO - PROCESS | 3669 | [#3] audio-fft Cycles:10 Average:81.00 Median:76.50 stddev:10.92 (14.3%) stddev-sans-first:11.29 16:09:38 INFO - PROCESS | 3669 | Values: 74.0 75.0 78.0 108.0 76.0 77.0 77.0 76.0 93.0 76.0 16:09:38 INFO - PROCESS | 3669 | 16:09:38 INFO - PROCESS | 3669 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:84.00 stddev:13.99 (16.7%) stddev-sans-first:14.57 16:09:38 INFO - PROCESS | 3669 | Values: 85.0 84.0 120.0 83.0 84.0 85.0 104.0 84.0 84.0 112.0 16:09:38 INFO - PROCESS | 3669 | 16:09:38 INFO - PROCESS | 3669 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:09:38 INFO - PROCESS | 3669 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 117.0 16:09:38 INFO - PROCESS | 3669 | 16:09:38 INFO - PROCESS | 3669 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 16:09:38 INFO - PROCESS | 3669 | Values: 150.0 149.0 150.0 149.0 149.0 150.0 149.0 149.0 149.0 148.0 16:09:38 INFO - PROCESS | 3669 | 16:09:38 INFO - PROCESS | 3669 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 16:09:38 INFO - PROCESS | 3669 | Values: 95.0 96.0 95.0 95.0 94.0 95.0 96.0 96.0 95.0 95.0 16:09:38 INFO - PROCESS | 3669 | 16:09:38 INFO - PROCESS | 3669 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:61.00 stddev:0.84 (1.4%) stddev-sans-first:0.87 16:09:38 INFO - PROCESS | 3669 | Values: 60.0 61.0 60.0 59.0 60.0 61.0 61.0 61.0 61.0 62.0 16:09:38 INFO - PROCESS | 3669 | 16:09:38 INFO - PROCESS | 3669 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:1.23 (1.8%) stddev-sans-first:1.27 16:09:38 INFO - PROCESS | 3669 | Values: 67.0 68.0 71.0 67.0 68.0 68.0 67.0 67.0 67.0 68.0 16:09:38 INFO - PROCESS | 3669 | 16:09:38 INFO - PROCESS | 3669 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.00 stddev:2.80 (3.3%) stddev-sans-first:2.96 16:09:38 INFO - PROCESS | 3669 | Values: 85.0 84.0 85.0 93.0 86.0 84.0 83.0 85.0 84.0 85.0 16:09:38 INFO - PROCESS | 3669 | 16:09:38 INFO - PROCESS | 3669 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:133.50 stddev:15.39 (11.5%) stddev-sans-first:16.21 16:09:38 INFO - PROCESS | 3669 | Values: 133.0 142.0 132.0 131.0 129.0 134.0 129.0 142.0 180.0 131.0 16:09:38 INFO - PROCESS | 3669 | 16:09:38 INFO - PROCESS | 3669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.70 Median:174.50 stddev:2.54 (1.5%) stddev-sans-first:2.68 16:09:38 INFO - PROCESS | 3669 | Values: 174.0 175.0 174.0 175.0 178.0 172.0 173.0 174.0 172.0 180.0 16:09:38 INFO - PROCESS | 3669 | 16:09:38 INFO - PROCESS | 3669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:1.14 (1.7%) stddev-sans-first:1.17 16:09:38 INFO - PROCESS | 3669 | Values: 69.0 70.0 69.0 69.0 68.0 68.0 67.0 68.0 68.0 66.0 16:09:38 INFO - PROCESS | 3669 | -------- Summary: end -------- 16:09:38 INFO - PROCESS | 3669 | 16:09:39 INFO - TEST-INFO | 3669: exit 0 16:09:40 INFO - TEST-OK | kraken | took 63213ms 16:09:40 INFO - SUITE-END | took 1183s 16:09:40 INFO - Completed test suite (00:19:43) 16:09:40 INFO - javascript benchmark 16:09:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2534.3917459809645, 2575.278921901866, 2587.9870600647005, 2600.0379859452005, 2608.9086881959124, 4585.220512512872, 4594.37975873257, 4725.432948046235, 4763.261694437363, 4775.928361074582, 4698.624110071195, 4705.0, 4715.882102947428, 4771.069641419916, 4818.397700287464, 4294.227039132955, 4333.826646934119, 4356.215881141393, 4421.977890110561, 4496.235639941201, 4017.3170561004554, 4326.97836510817, 4421.24838777407, 4459.977700111511, 4492.438445194351, 4307.052448461333, 4332.848350307724, 4356.803943822536, 4361.825526978917, 4458.398116254297, 4305.182015417092, 4339.978300108511, 4362.498312694049, 4362.563743625612, 4424.823007079713, 4339.349097635349, 4349.195398851222, 4356.8257269709175, 4386.8903277418, 4393.187260356813, 4724.267738500538, 4728.598069164125, 4751.14479393709, 4755.881102972418, 4761.47623761386, 4910.533499317559, 4940.580050695695, 5026.773795179189, 5027.748612569357, 5066.138756411382, 5104.285400043997, 5111.335526381584, 5119.974400128012, 5153.896922061538, 5167.224916262553, 4767.380240568704, 4773.66584339093, 4775.307580400822, 4776.593989510861, 4811.350467686888, 5105.642605017613, 5154.149565321755, 5155.149400348975, 5223.608229382736, 5265.921011184835, 4955.331030310862, 4988.775505102207, 4995.275685025724, 4997.0505603935135, 5003.2995380646735, 5070.594352451795, 5074.49255074497, 5075.670081444694, 5076.137056700296, 5080.110980578384, 4991.4758950310425, 5016.874578135576, 5069.619778516626, 5118.974405128025, 5131.204663277198, 5084.415292241366, 5088.872778180576, 5093.363329583802, 5098.668586541863, 5130.05094057593, 4363.105563359503, 4363.8968623919745, 4367.017421080295, 4398.208322501981, 4409.779511024436, 3717.20080182762, 3736.1220113273357, 3754.9061273468383, 3756.7933763642714, 3791.734578579473, 4413.889652758642, 4422.358757980075, 4450.221211288012, 4455.688101832905, 4458.286674132123, 5123.923141152885, 5127.538521533005, 5128.512791284822, 5129.461406552333, 5142.434332223453, 4252.893677658021, 4274.764887931194, 4280.571942805756, 4416.403785488982, 4462.107578484316, 4474.440694913136, 4490.034642551867, 4499.21263778844, 4499.52754960731, 4501.639868810487, 4678.485366609671, 4766.213574760126, 4786.928196077131, 4788.904221915612, 4842.709437433765, 5144.819931302386, 5145.485451454824, 5146.974265128651, 5148.9227661584355, 5194.792208311776, 4807.086653535817, 4808.422989241313, 4815.0, 4819.855404337875, 4871.0, 4849.442314133919, 4899.167141585867, 4946.678465899849, 4952.281919121635, 5101.6173786966865, 5109.9233511498105, 5112.667676601009, 5118.43697193301, 5135.229715542699, 5163.974180129076, 4901.779419926183, 4971.154903666313, 4971.552560269593, 4976.328195693535, 4979.128652485873, 4816.8554943351755, 4853.126437241331, 4907.803687852446, 4969.428515720739, 5021.347224860745, 4860.198067318995, 4913.6069114471475, 4914.582260507754, 4944.826931057396, 4970.676906001243, 4940.654154209171, 4991.675541089818, 4993.550580447777, 5018.222175562793, 5066.265391518135, 4728.030753695415, 4754.548317909793, 4916.532929371704, 4916.778744956414, 4956.504349565014], "value": 4660.425917540791, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.3743257820928, 560.9382967873534, 562.9071203251464, 575.3872126185614, 579.9879210777194, 29891.85054074729, 42511.574884251146, 45077.32384014238, 45244.0, 45278.773606132, 42042.7897860511, 42494.0, 42497.575024249745, 42601.36097958525, 42607.786961065154, 7644.159142494321, 7729.845403091949, 7905.0, 7915.881261781049, 7919.524828510279, 7516.774496765106, 10108.797824043515, 10364.0, 10366.170706343475, 10368.274220804547, 10170.338927969695, 10219.18246540275, 10247.0, 10247.180225581973, 10249.897501025007, 10096.747581310452, 10159.13647339977, 10169.23730720199, 10170.694879153638, 10172.6948191554, 9888.060634239735, 9955.203583713286, 9957.601695932153, 9959.701208963743, 9964.850527242097, 38942.80528597339, 39278.410823837665, 39298.41052384216, 39301.60698393008, 39319.60680393188, 3715.5912849586525, 3819.9045023874346, 3825.9808700956596, 3843.846246150151, 3861.8251542932326, 29330.853345733136, 29341.973030944027, 29594.852025739732, 29677.70322296771, 30890.84554577235, 3321.1697075731067, 3359.7312215022985, 3375.0043737097617, 3390.55922730046, 3423.9486407703903, 183220.0, 183454.0, 183555.0, 183726.0, 184167.0, 52256.0, 52543.73728131411, 52559.474405256224, 52572.0, 52652.0, 56285.155722664196, 56318.43681563132, 56485.0, 56491.43508564862, 56492.71753641288, 14257.0, 14681.265936703123, 14687.0, 14709.779353309708, 14719.264036798117, 10139.898601014043, 10333.896661033445, 11176.385298808482, 11404.144689148181, 11497.827532587018, 16598.25307861125, 16767.748483772753, 16867.240974156193, 17015.91492042532, 17111.973281603143, 6110.51115910735, 6319.0, 6322.968385158137, 6323.881789137436, 6374.003130356955, 795.6061749434067, 819.5533434278333, 823.7075838077516, 823.880537322097, 832.887560179368, 27131.593026104623, 28093.71906280952, 28122.91581640281, 28284.575731364046, 28649.427011459655, 905.9864102038474, 969.2100937735722, 976.2336565795816, 980.6861804222581, 994.1450352696675, 13930.721385572231, 14997.175155366342, 15128.470503532324, 15133.319000644997, 15286.159261240738, 125025.37487312687, 125654.0, 125683.0, 125805.22584322485, 126020.0, 51629.48370516322, 51765.2235216472, 51847.48152518427, 51906.0, 51953.220701689504, 1161.6224726963771, 1200.4357951762831, 1210.4189988805422, 1217.0750229825396, 1223.6267938278731, 25286.87356563279, 26653.333666658487, 27199.72800271972, 27755.167344979684, 27772.44455110846, 43378.349324759525, 43766.34350484809, 43769.34345984749, 43795.78102109469, 43882.56117438785, 287219.0, 288499.0, 288935.0, 288998.0, 289430.0, 29914.0, 37226.255474890895, 37528.81235593914, 37601.811990939874, 40301.1939761209, 37904.810475947445, 41491.36138217871, 42008.78995605002, 42801.143977120904, 42819.357709633754, 32225.51661725029, 34687.306253874274, 35085.649143508235, 35336.46995295021, 35840.0, 31839.522407164375, 31910.84044579762, 32287.677123228466, 32990.34019319648, 33540.49689254614, 32498.18754531061, 33286.500702489, 33304.50043249305, 33516.832415837765, 33655.83172084124, 27666.446671066064, 29212.0, 30644.508309383982, 30775.0, 31597.684023159472, 22963.081476740743, 23468.178613748438, 23692.763072369056, 23750.762492375547, 24012.39969000789], "value": 17315.139957193103, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.76009453713283, 377.2135098320003, 380.99037550491187, 385.1699587389176, 406.7478163538606, 13512.864871351283, 16955.06747128909, 16999.32002719891, 17651.293948242055, 17899.73150402745, 17543.649127017452, 17685.734713979302, 18073.819261807377, 18126.909365453153, 18282.451526454195, 4794.42466903972, 5125.718085505296, 5156.278121063054, 5159.535641792238, 5165.199394093921, 3873.8063096845185, 4033.2336855997414, 4957.330760347361, 5049.091163590552, 5675.34733505648, 5878.470937615613, 5974.581779275452, 5990.281166260055, 5998.490128339096, 6017.849553761147, 5825.475707186331, 5935.73289201987, 5979.1031345298115, 5981.671008094553, 6010.398960103998, 5277.762500687479, 5280.0, 5287.603429742785, 5296.894062118775, 5303.946960530384, 21707.565848683094, 21721.0, 21746.13015479379, 21767.891160544095, 21846.344609661737, 2294.724633044029, 2344.0975224538506, 2354.21133920137, 2362.799162071226, 2439.353571303606, 13353.86646133536, 13811.51659691916, 14010.719785604231, 14048.508302209475, 14282.714345713028, 1663.534210421084, 1728.420978972046, 1750.1774166141893, 1758.6922288599444, 1765.7792775903013, 64606.67696661487, 79615.0, 80053.0, 81957.0, 83607.0, 9810.852837207447, 9945.35355201924, 10045.29682922203, 10059.849102263472, 10135.239857010754, 13850.16898986064, 13888.583342499742, 13891.722165556632, 13891.930540347234, 13901.0964287321, 7387.445941554405, 7499.250074992567, 7667.271609197117, 7735.7679269622, 7765.495242809199, 7238.782836514913, 7319.15829679583, 7321.670524826395, 7462.216467270859, 7508.621120495799, 6382.766031888802, 6386.584871983307, 6399.616023038632, 6432.195975503062, 6579.967100164565, 1703.276107654242, 1774.4853992342335, 1785.7142857142794, 1812.9365472208674, 1845.1143451143257, 976.3214565876648, 985.6796541124163, 986.3835103060587, 990.8910019897805, 1030.1192480429124, 17603.471895843144, 17730.91134544319, 18017.0, 18431.354902578347, 18745.437636870916, 984.4093543873762, 985.4826216236534, 988.2341185581089, 1020.3928662445833, 1030.2324768047852, 9829.754256143511, 10178.338408003456, 10364.274500784873, 10388.480575971322, 10405.635802746867, 481495.0, 485329.0, 486018.0, 496712.0, 500870.0, 76728.23271767322, 77934.0, 79167.0, 81811.18188818036, 82169.58915205386, 929.0802105915095, 937.8640097186006, 965.8309795785709, 985.1281615769952, 988.4020167798523, 16082.0, 16244.756328655316, 16520.504384868473, 16943.576410589834, 17038.14809259557, 38742.80628596839, 39567.40648890327, 39656.60343396645, 40713.796431017654, 42652.24194733671, 49355.0, 51367.74316128396, 53903.0, 54725.0, 56063.71968140297, 7821.804454888674, 7831.04223944014, 7909.9209007909185, 7982.201779821971, 8095.55474448911, 10009.949950250202, 11841.526338946345, 12247.387630618256, 12353.0, 12494.750104998031, 10277.126444252322, 10466.63366782159, 10500.36997780105, 10629.25595208328, 11064.668059958214, 10358.585656573954, 10665.0, 10749.355038697704, 10852.403117828595, 10972.615958441416, 10155.339902906288, 10337.74155646115, 10621.946890265499, 10887.945560272148, 11044.33733975964, 7935.761927142195, 8090.55501947375, 8132.430729848854, 8195.549244791593, 8439.746807595782, 8828.293736500937, 10269.0, 10375.221858360805, 10587.523561439908, 10829.458527073457], "value": 8803.44122650591, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.4772138865842, 1350.7298540291945, 1358.3887250737168, 1361.8501964783877, 1367.8221831161948, 6661.533692641517, 6965.616891070989, 6978.1626204855365, 6979.0229367888405, 7002.929970700297, 6168.753249870011, 6325.3042165361885, 6688.230853451854, 6854.177498700163, 6920.550164239334, 2066.5453600207966, 2101.243552321163, 2104.2635077722825, 2105.1368938735122, 2107.725995620567, 2100.978990210101, 2126.6916297136904, 2127.393692797553, 2131.818795402393, 2136.476563242008, 1839.2367167625418, 1904.4286713985819, 2030.3096947038005, 2066.5246993191577, 2103.852730308879, 1991.890446025468, 1993.5614164883848, 1998.0409403486262, 2001.8498612604112, 2004.1782869023775, 2029.52306208041, 2037.9388618341472, 2048.7131801547794, 2051.8974051297378, 2054.476108592314, 6869.313068693141, 7023.61370124643, 7028.578285302899, 7048.682809273544, 7056.964715176443, 4276.615104640598, 4398.142362239365, 4404.14119246747, 4410.977945110286, 4412.889677758082, 2771.5842623606623, 2868.1108856254627, 2918.9562156567667, 2949.557566365041, 2970.628671416073, 1134.8865113488669, 1173.6185739634568, 1184.7156682396248, 1225.5611333446377, 1236.7402845402476, 8995.955020224923, 9067.274618030542, 9068.682596109105, 9085.81828363429, 9096.909030909672, 3799.7530160539477, 3861.903452413656, 4016.819243134066, 4040.1919616076902, 4050.210209009215, 7910.802229944297, 7973.401994850409, 7984.760457186294, 7985.081715602664, 8025.598720063974, 4208.137331846964, 4256.489221293403, 4258.808353624032, 4359.825606975749, 4375.671824613167, 3601.8019008954234, 3686.060054686038, 3894.2600905827803, 3896.532416110085, 3924.6664033556895, 3339.315440334774, 3372.2412457196933, 3474.4614584739406, 3476.89569312921, 3494.1963348430004, 1145.5131569083105, 1150.8158694608821, 1159.7100724818795, 1160.228448082016, 1169.0705888818409, 672.7914346552584, 685.8216863615396, 687.2440315652842, 806.4153488720631, 847.7922908887363, 4643.907121857544, 4692.6480513960905, 4723.929141062887, 4883.193218509175, 4893.877653058702, 894.1639567004871, 896.5248418338291, 911.4485736129546, 913.6939125393068, 940.6284517615503, 3276.3447310537986, 3360.764746467724, 3363.814990175515, 3380.645032271625, 3472.774269672463, 7875.409344299201, 8165.959170204111, 8192.467489613156, 8281.461704989157, 8285.0, 8050.476719013245, 8214.548199848947, 8220.38347123968, 8236.299914507214, 8254.587270636444, 6487.513436492282, 6617.272100068989, 6657.7669781557415, 6661.866762664719, 6669.499787515956, 4535.345946994782, 4643.628509719282, 4794.065157294294, 4805.711657300573, 4862.5380588844, 7585.848283034419, 7613.124490683421, 7659.425543084402, 7719.768406947801, 7725.420593455401, 7532.096148462219, 7774.844503110019, 7821.882671759814, 7837.294643482114, 7838.0, 5460.645058071213, 5554.305711786027, 5559.805406810742, 5943.91084133747, 6099.176611157614, 6481.902771458337, 6568.6058836469965, 6576.934230657632, 6640.0, 6647.0, 6013.428724271363, 6021.217241758543, 6027.638341699512, 6046.939530604814, 6098.115773212948, 6045.6070355426755, 6072.514198864169, 6075.908861367171, 6077.149199112039, 6083.057126145454, 5363.168708849978, 5369.946300537101, 5396.541293989898, 5398.595105367034, 5405.378381486022, 4230.894227644333, 4242.236397448489, 4247.681423893282, 4333.523312435566, 4356.782160892006, 4068.9186216276103, 4103.548609652996, 4131.628153466202, 4231.40760293553, 4258.276093064124], "value": 3805.6347250277863, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.3076581454184, 348.9531405782652, 349.0, 359.2778515184479, 359.3101245608432, 4942.851714448563, 4947.529984651462, 4960.702357858527, 4970.826021089262, 4985.0, 4667.436408803047, 4744.715317080978, 4829.637777166709, 4880.341153944217, 4907.214845624691, 3942.9211415771665, 3952.189801090784, 3968.3452230381954, 3972.36442169253, 3976.960230397688, 3948.151147503286, 3969.523657161145, 3973.3443981742976, 3981.6814654827544, 3983.760974341534, 3745.4756334113245, 3870.980645096771, 3875.0, 3942.9802850985707, 3974.370508091683, 3928.4500169976227, 3939.8227079781477, 3964.643182113595, 3968.6626636735914, 3969.364901615728, 3572.3391172632887, 3572.99956012317, 3585.032041348821, 3599.5140656011627, 3608.170120872188, 4725.66920315578, 4776.952230477686, 4820.071971211509, 4888.70667759932, 4898.412190537123, 4516.458025036984, 4517.661175411858, 4518.52555481673, 4526.4794548627, 4530.59224669778, 5145.665531740425, 5157.458466860963, 5159.071367153911, 5169.922451163236, 5212.801055757159, 3792.848286068554, 3902.20004898995, 3914.5498267699295, 3929.469521614574, 3932.960670393288, 5325.068113080196, 5334.839954801362, 5343.759530821122, 5379.246905433242, 5384.165454354581, 4014.136960553495, 4020.4572382728543, 4029.294873397144, 4055.5944405559208, 4056.6551843093666, 4139.234241665241, 4139.992103829641, 4145.191687620885, 4158.355454904495, 4167.791610419466, 4179.2477354076555, 4266.74131131317, 4336.9783151084675, 4339.0, 4360.171567402183, 5166.147585648401, 5170.6122040847085, 5174.818881339135, 5178.456262092502, 5193.350831146106, 1235.2403271987662, 1242.5400154818053, 1244.4213440750095, 1247.7005518675453, 1248.825164476974, 833.5373867503594, 844.4046946902419, 857.7726902370877, 870.621279743301, 879.6804792810784, 4420.204363214652, 4449.421575195269, 4474.194644963873, 4475.753833539186, 4489.7979590918485, 5229.52934235913, 5243.895122097537, 5247.212918062245, 5249.448807875118, 5251.159814429673, 4361.0, 4440.400545926259, 4470.401326931851, 4504.729716216972, 4529.705569137996, 2750.436160587115, 2767.51568475516, 2771.9307017324327, 2772.7643150332046, 2787.2056463908093, 4846.49758574843, 4865.7323847188745, 4878.365812444359, 4888.926666100011, 4898.853034408973, 5155.226715992556, 5228.209548077613, 5230.895382092337, 5260.736963151904, 5307.814226502054, 4804.213556137432, 4809.495003024702, 4826.5037838269545, 4827.25177597473, 4847.951520484891, 5116.718580478109, 5144.331236939174, 5159.420289855072, 5165.0, 5166.664166829144, 4989.426215985208, 5091.236314552847, 5241.161414173714, 5311.203319502106, 5320.5477534408465, 5038.521340472649, 5040.319556859777, 5042.773075211551, 5043.949560504495, 5055.34280543527, 3797.1456422305864, 3798.2593394287846, 3808.504894363715, 3812.6949844011856, 3816.31306364857, 5149.948500514947, 5247.134222853187, 5292.364916210079, 5352.250684904038, 5405.72971351423, 5152.639315248047, 5183.403908550565, 5183.714895680774, 5188.169892817131, 5196.726801933551, 5209.322788037531, 5209.4009188943755, 5211.661242019257, 5216.530512253916, 5222.2688823565495, 4894.755262236803, 5095.312132862165, 5136.845894623168, 5140.3712934336845, 5147.279380886604, 4975.875603109951, 5015.523525265094, 5110.9488905110475, 5158.638895277295, 5166.638335316492, 5068.974655126701, 5083.923741143812, 5084.898302034013, 5084.949150508448, 5098.209777484496], "value": 3922.6728173627703, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.2738894215406, 589.7139887154732, 696.9825754356141, 741.6921977379387, 754.22315015534, 12436.564720234794, 13090.541831035891, 13115.73768524629, 13131.868681313195, 13203.141795783267, 13077.280749558795, 13123.6719082023, 13159.0, 13162.210267383964, 13168.670783230424, 662.9270780214173, 682.4608559238196, 786.532013451998, 796.0367954774715, 807.7536351412816, 801.3789313282194, 813.7070654564352, 815.6859609050499, 815.9388045896552, 816.2408959667507, 855.9529225892574, 857.5069335132292, 858.0518527027638, 859.188067276424, 859.415597393772, 694.5936627073169, 715.2668514772348, 813.5932033983008, 855.4396870050095, 856.3448961544392, 617.7343742190856, 620.798240571816, 621.0249907644999, 621.1335187413533, 621.6425555305717, 12914.096013279075, 12935.094543381967, 12986.02604804634, 12998.220106793622, 13013.154144980546, 13104.213747175105, 13166.802497962539, 13287.20276783396, 13344.466221351135, 13475.86524134756, 12084.879151208463, 12126.514939402414, 12127.332996685178, 12595.370231488389, 12679.239245645198, 3998.640122388999, 4000.599940006005, 4007.4189242559664, 4124.154548317588, 4141.482314710661, 68284.0, 69095.99999999949, 69892.650536747, 70467.0, 72020.0, 10296.691099267035, 10420.218483613608, 10430.68707938763, 10434.269601128, 10954.671359859218, 19862.0, 19879.0, 19930.601387972158, 20025.699614505793, 20195.899020504803, 6070.0591408331775, 6111.113888486145, 6180.6291622502795, 6196.039613859859, 6342.746290148342, 3491.912702182415, 3539.2744487380023, 3564.480890671298, 3637.654422829827, 3673.9632603674154, 2755.793315501345, 2807.6630804303204, 2822.5766135079903, 2827.515554333991, 2847.5301575239855, 476.6710969431081, 477.1078083982974, 477.24356894322193, 480.47628085387095, 482.4933819489522, 546.3443867359185, 552.7015411677729, 555.1727925391219, 556.7105105345198, 560.2240896358572, 7398.704051837866, 7429.5170813898, 7433.0, 7646.502977306457, 7840.0, 507.3708601334319, 514.0823629820752, 516.235970763265, 520.2612290547431, 528.2103255632777, 3409.3863104640905, 3487.2502411981545, 3532.0816587687386, 3611.7832930024283, 3615.584207816135, 65931.67034164799, 67526.0, 68577.65711171512, 71270.0, 72007.0, 57783.0, 58387.416125839045, 60123.0, 60130.69934650299, 60676.69661651752, 52264.73867630638, 52843.99999999923, 52880.423915217114, 53312.0, 53690.46309536933, 6904.206016307988, 6904.344087311697, 7020.473464490082, 7033.683484243119, 7260.891086633599, 35172.648273516934, 36219.0, 37258.6274137266, 37699.81150094232, 38426.0, 44405.0, 44717.10565788731, 45026.77486612677, 45467.0, 45758.313625296316, 8327.541985190872, 8418.915810841812, 8470.364722645949, 8557.31541476668, 8675.566221689016, 9300.488473134043, 9304.255659547356, 9378.718638440858, 9455.905440945779, 9645.228381729305, 8758.430702004349, 8767.605457754544, 8805.603747831236, 8930.732078037669, 8945.59744811472, 8715.864613169813, 8732.126787321216, 8809.955950220208, 8819.426737262058, 8837.955810221165, 8593.65625374978, 8597.732936091359, 8632.223099920786, 8924.97362803286, 8962.0, 7569.772906812805, 7795.41534384912, 7805.765827025199, 7820.061592608696, 7967.123616402076, 7409.221786771029, 7530.623468826647, 7658.540487570764, 7743.806404839699, 7785.299323060952], "value": 5934.473622921501, "unit": "score"}], "name": "dromaeo_css", "value": 6307.026470686965, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 117.0, 114.0, 117.0, 115.0, 115.0, 116.0, 116.0, 115.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 124.0, 125.0, 162.0, 131.0, 128.0, 124.0, 120.0, 148.0, 123.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 162.0, 163.0, 163.0, 161.0, 163.0, 160.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 78.0, 108.0, 76.0, 77.0, 77.0, 76.0, 93.0, 76.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 120.0, 83.0, 84.0, 85.0, 104.0, 84.0, 84.0, 112.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 150.0, 149.0, 149.0, 150.0, 149.0, 149.0, 149.0, 148.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 59.0, 60.0, 61.0, 61.0, 61.0, 61.0, 62.0], "value": 60.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 71.0, 67.0, 68.0, 68.0, 67.0, 67.0, 67.0, 68.0], "value": 67.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 93.0, 86.0, 84.0, 83.0, 85.0, 84.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 142.0, 132.0, 131.0, 129.0, 134.0, 129.0, 142.0, 180.0, 131.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 175.0, 174.0, 175.0, 178.0, 172.0, 173.0, 174.0, 172.0, 180.0], "value": 174.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 69.0, 68.0, 68.0, 67.0, 68.0, 68.0, 66.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1541.5000000000002, "alertThreshold": 2.0}]} 16:09:40 INFO - Return code: 0 16:09:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:09:40 INFO - # TBPL SUCCESS # 16:09:40 INFO - Running post-action listener: _resource_record_post_action 16:09:40 INFO - [mozharness: 2017-01-07 00:09:40.196623Z] Finished run-tests step (success) 16:09:40 INFO - Running post-run listener: _resource_record_post_run 16:09:40 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 383094784; Read time: 8; Write time: 352080 16:09:40 INFO - TinderboxPrint: CPU usage
13.1% 16:09:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 16:09:40 INFO - TinderboxPrint: I/O write bytes / time
383,094,784 / 352,080 16:09:40 INFO - TinderboxPrint: CPU idle
8,320.8 (86.9%) 16:09:40 INFO - TinderboxPrint: CPU user
1,212.1 (12.7%) 16:09:40 INFO - TinderboxPrint: Swap in / out
0 / 0 16:09:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99774464; Read time: 0; Write time: 101572 16:09:40 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 282869760; Read time: 0; Write time: 250504 16:09:40 INFO - Running post-run listener: _upload_blobber_files 16:09:40 INFO - Blob upload gear active. 16:09:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:09:40 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 16:09:40 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:09:40 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:09:41 INFO - (blobuploader) - INFO - Open directory for files ... 16:09:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:09:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:09:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:42 INFO - (blobuploader) - INFO - Done attempting. 16:09:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:09:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:09:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:45 INFO - (blobuploader) - INFO - Done attempting. 16:09:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:09:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:09:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:46 INFO - (blobuploader) - INFO - Done attempting. 16:09:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:09:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:09:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:46 INFO - (blobuploader) - INFO - Done attempting. 16:09:46 INFO - (blobuploader) - INFO - Iteration through files over. 16:09:46 INFO - Return code: 0 16:09:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:09:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:09:46 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e1932de1796df85813d36a040d9ba7edc200607d9a96ac530aa2aa786efa950690ebbaa9246cf76203bfa2354f41b5b4bb64f090fc02260d76937d49ac119ca9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f470c67fbf97ad4c93fbe074eb62c81426471b6dbd34fb7d9b5439b71ff7cf72df25b398be6afed4431bf7166f626cdeb50c35bf06bbe6cec3583db76657af9c", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/28557caaf161ea5f8150f331e0aa6b10b76f70b3c6e4009602ee518ead8cb76c5f3e60e2db2b88ffb9893e22a7fef51600303314008b3547f76624cd6a02146e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/00e295dbabc81d6748924533dd64e67c036fc41c50cc410328e91c69574c451faeea997f546b8d80f540e2b46a81c421c232d822b376738ced8c210cbf2a1ab0"} 16:09:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:09:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:09:46 INFO - Contents: 16:09:46 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e1932de1796df85813d36a040d9ba7edc200607d9a96ac530aa2aa786efa950690ebbaa9246cf76203bfa2354f41b5b4bb64f090fc02260d76937d49ac119ca9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f470c67fbf97ad4c93fbe074eb62c81426471b6dbd34fb7d9b5439b71ff7cf72df25b398be6afed4431bf7166f626cdeb50c35bf06bbe6cec3583db76657af9c", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/28557caaf161ea5f8150f331e0aa6b10b76f70b3c6e4009602ee518ead8cb76c5f3e60e2db2b88ffb9893e22a7fef51600303314008b3547f76624cd6a02146e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/00e295dbabc81d6748924533dd64e67c036fc41c50cc410328e91c69574c451faeea997f546b8d80f540e2b46a81c421c232d822b376738ced8c210cbf2a1ab0"} 16:09:46 INFO - Running post-run listener: copy_logs_to_upload_dir 16:09:46 INFO - Copying logs to upload dir... 16:09:46 INFO - mkdir: /builds/slave/test/build/upload/logs 16:09:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.451080 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-01-06 16:09:46.658598) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-06 16:09:46.662638) ========= 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=1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e1932de1796df85813d36a040d9ba7edc200607d9a96ac530aa2aa786efa950690ebbaa9246cf76203bfa2354f41b5b4bb64f090fc02260d76937d49ac119ca9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f470c67fbf97ad4c93fbe074eb62c81426471b6dbd34fb7d9b5439b71ff7cf72df25b398be6afed4431bf7166f626cdeb50c35bf06bbe6cec3583db76657af9c", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/28557caaf161ea5f8150f331e0aa6b10b76f70b3c6e4009602ee518ead8cb76c5f3e60e2db2b88ffb9893e22a7fef51600303314008b3547f76624cd6a02146e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/00e295dbabc81d6748924533dd64e67c036fc41c50cc410328e91c69574c451faeea997f546b8d80f540e2b46a81c421c232d822b376738ced8c210cbf2a1ab0"} build_url:https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011410 build_url: 'https://queue.taskcluster.net/v1/task/bidY83D9Q_-Tgk0tZPmPMQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e1932de1796df85813d36a040d9ba7edc200607d9a96ac530aa2aa786efa950690ebbaa9246cf76203bfa2354f41b5b4bb64f090fc02260d76937d49ac119ca9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f470c67fbf97ad4c93fbe074eb62c81426471b6dbd34fb7d9b5439b71ff7cf72df25b398be6afed4431bf7166f626cdeb50c35bf06bbe6cec3583db76657af9c", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/28557caaf161ea5f8150f331e0aa6b10b76f70b3c6e4009602ee518ead8cb76c5f3e60e2db2b88ffb9893e22a7fef51600303314008b3547f76624cd6a02146e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/00e295dbabc81d6748924533dd64e67c036fc41c50cc410328e91c69574c451faeea997f546b8d80f540e2b46a81c421c232d822b376738ced8c210cbf2a1ab0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-06 16:09:46.689316) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 16:09:46.689689) ========= 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=1f5564757af27664ca02d71f000001b0-1483746539.725900-1748813939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 16:09:46.775595) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-06 16:09:46.775947) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-06 16:09:46.776294) ========= ========= Total master_lag: 0.18 =========