builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1483974217.45 results: success (0) revision: 2977ca1224525680cbfb5c3ce3018818b6dfd8f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 07:03:37.451389) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 07:03:37.451816) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 07:03:37.452170) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 07:03:37.466517) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 07:03:37.466770) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-09 07:03:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.3M=0s 2017-01-09 07:03:38 (66.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.100173 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 07:03:37.580381) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 07:03:37.580688) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015294 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 07:03:37.630024) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 07:03:37.630365) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2977ca1224525680cbfb5c3ce3018818b6dfd8f2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 2977ca1224525680cbfb5c3ce3018818b6dfd8f2 --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=78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-09 07:03:38,867 truncating revision to first 12 chars 2017-01-09 07:03:38,867 Setting DEBUG logging. 2017-01-09 07:03:38,867 attempt 1/10 2017-01-09 07:03:38,867 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2977ca122452?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-09 07:03:39,211 unpacking tar archive at: mozilla-central-2977ca122452/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660899 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 07:03:38.303490) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 07:03:38.303787) ========= script_repo_revision: 2977ca1224525680cbfb5c3ce3018818b6dfd8f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 07:03:38.304174) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 07:03:38.304437) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 07:03:38.311998) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-01-09 07:03:38.312281) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:03:39 INFO - MultiFileLogger online at 20170109 07:03:39 in /builds/slave/test 07:03:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:03:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:03:39 INFO - {'append_to_log': False, 07:03:39 INFO - 'base_work_dir': '/builds/slave/test', 07:03:39 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:03:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:03:39 INFO - 'branch': 'Firefox-Non-PGO', 07:03:39 INFO - 'buildbot_json_path': 'buildprops.json', 07:03:39 INFO - 'config_files': ('talos/linux_config.py',), 07:03:39 INFO - 'default_actions': ('clobber', 07:03:39 INFO - 'read-buildbot-config', 07:03:39 INFO - 'download-and-extract', 07:03:39 INFO - 'populate-webroot', 07:03:39 INFO - 'create-virtualenv', 07:03:39 INFO - 'install', 07:03:39 INFO - 'run-tests'), 07:03:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:03:39 INFO - 'download_minidump_stackwalk': True, 07:03:39 INFO - 'download_symbols': 'ondemand', 07:03:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:03:39 INFO - 'tooltool.py': '/tools/tooltool.py', 07:03:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:03:39 INFO - '/tools/misc-python/virtualenv.py')}, 07:03:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:03:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:03:39 INFO - 'installer_path': 'installer.exe', 07:03:39 INFO - 'log_level': 'info', 07:03:39 INFO - 'log_name': 'talos', 07:03:39 INFO - 'log_to_console': True, 07:03:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:03:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:03:39 INFO - 'opt_config_files': (), 07:03:39 INFO - 'pip_index': False, 07:03:39 INFO - 'sps_profile': False, 07:03:39 INFO - 'sps_profile_interval': 0, 07:03:39 INFO - 'suite': 'dromaeojs', 07:03:39 INFO - 'system_bits': '32', 07:03:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:03:39 INFO - 'title': 'talos-linux64-ix-019', 07:03:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:03:39 INFO - 'use_talos_json': True, 07:03:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:03:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:03:39 INFO - 'work_dir': 'build'} 07:03:39 INFO - [mozharness: 2017-01-09 15:03:39.642251Z] Running clobber step. 07:03:39 INFO - Running pre-action listener: _resource_record_pre_action 07:03:39 INFO - Running main action method: clobber 07:03:39 INFO - rmtree: /builds/slave/test/build 07:03:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:03:40 INFO - Running post-action listener: _resource_record_post_action 07:03:40 INFO - [mozharness: 2017-01-09 15:03:40.098526Z] Finished clobber step (success) 07:03:40 INFO - [mozharness: 2017-01-09 15:03:40.098627Z] Running read-buildbot-config step. 07:03:40 INFO - Running pre-action listener: _resource_record_pre_action 07:03:40 INFO - Running main action method: read_buildbot_config 07:03:40 INFO - Using buildbot properties: 07:03:40 INFO - { 07:03:40 INFO - "project": "", 07:03:40 INFO - "product": "firefox", 07:03:40 INFO - "who": "ffxbld@noreply.mozilla.org", 07:03:40 INFO - "installer_path": "public/build/target.tar.bz2", 07:03:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:03:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:03:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:03:40 INFO - "stage_platform": "linux64", 07:03:40 INFO - "basedir": "/builds/slave/test", 07:03:40 INFO - "buildnumber": 377, 07:03:40 INFO - "platform": "ubuntu64_hw", 07:03:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:03:40 INFO - "slavebuilddir": "test", 07:03:40 INFO - "taskId": "Fu1iABRCSfW1K-xYSN0Yzg", 07:03:40 INFO - "branch": "mozilla-central", 07:03:40 INFO - "script_repo_revision": "production", 07:03:40 INFO - "revision": "2977ca1224525680cbfb5c3ce3018818b6dfd8f2", 07:03:40 INFO - "slavename": "talos-linux64-ix-019", 07:03:40 INFO - "repo_path": "mozilla-central" 07:03:40 INFO - } 07:03:40 INFO - Finding installer, test and symbols from parent task. 07:03:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fu1iABRCSfW1K-xYSN0Yzg'}, attempt #1 07:03:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fu1iABRCSfW1K-xYSN0Yzg'}, attempt #1 07:03:41 INFO - Task dependencies: eBoj-SJiSrScToruqlPnAg 07:03:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg'}, attempt #1 07:03:41 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/target.tar.bz2 07:03:41 INFO - Set test_url: https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/test_packages.json 07:03:41 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/target.crashreporter-symbols.zip 07:03:41 INFO - Running post-action listener: _resource_record_post_action 07:03:41 INFO - [mozharness: 2017-01-09 15:03:41.483693Z] Finished read-buildbot-config step (success) 07:03:41 INFO - [mozharness: 2017-01-09 15:03:41.483908Z] Running download-and-extract step. 07:03:41 INFO - Running pre-action listener: _resource_record_pre_action 07:03:41 INFO - Running main action method: download_and_extract 07:03:41 INFO - mkdir: /builds/slave/test/build/tests 07:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:41 INFO - trying https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/target.test_packages.json 07:03:41 INFO - Downloading https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:03:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:03:42 INFO - Downloaded 896 bytes. 07:03:42 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:03:42 INFO - Using the following test package requirements: 07:03:42 INFO - {u'common': [u'target.common.tests.zip'], 07:03:42 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:03:42 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:03:42 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:03:42 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:03:42 INFO - u'mozbase': [u'target.common.tests.zip'], 07:03:42 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:03:42 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:03:42 INFO - u'web-platform': [u'target.common.tests.zip', 07:03:42 INFO - u'target.web-platform.tests.zip'], 07:03:42 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:03:42 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:03:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/target.common.tests.zip 07:03:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:03:42 INFO - Fetch https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/target.common.tests.zip into memory 07:03:44 INFO - Expected file size: 20251352 07:03:44 INFO - Obtained file size: 20251352 07:03:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:03:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/target.common.tests.zip 07:03:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:03:48 INFO - Fetch https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/target.common.tests.zip into memory 07:03:48 INFO - Expected file size: 20251352 07:03:48 INFO - Obtained file size: 20251352 07:03:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/target.talos.tests.zip 07:03:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:03:53 INFO - Fetch https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/target.talos.tests.zip into memory 07:03:55 INFO - Expected file size: 14403537 07:03:55 INFO - Obtained file size: 14403537 07:03:55 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')]} 07:03:55 INFO - trying https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/target.tar.bz2 07:03:55 INFO - Downloading https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:03:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:03:57 INFO - Downloaded 55938624 bytes. 07:03:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/target.tar.bz2 07:03:57 INFO - mkdir: /builds/slave/test/properties 07:03:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:03:57 INFO - Writing to file /builds/slave/test/properties/build_url 07:03:57 INFO - Contents: 07:03:57 INFO - build_url:https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/target.tar.bz2 07:03:57 INFO - Running post-action listener: _resource_record_post_action 07:03:57 INFO - Running post-action listener: set_extra_try_arguments 07:03:57 INFO - [mozharness: 2017-01-09 15:03:57.484692Z] Finished download-and-extract step (success) 07:03:57 INFO - [mozharness: 2017-01-09 15:03:57.484833Z] Running populate-webroot step. 07:03:57 INFO - Running pre-action listener: _resource_record_pre_action 07:03:57 INFO - Running main action method: populate_webroot 07:03:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:03:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:03:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:03:57 INFO - '--tppagecycles', 07:03:57 INFO - '7'], 07:03:57 INFO - 'tests': ['tsvgm']}}, 07:03:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:03:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:03:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:03:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:03:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:03:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:03:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:03:57 INFO - 'talos_options': ['--disable-e10s'], 07:03:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:03:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:03:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:03:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:03:57 INFO - 'talos_options': ['--disable-e10s'], 07:03:57 INFO - 'tests': ['damp', 'tps']}, 07:03:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:03:57 INFO - 'tests': ['damp', 'tps']}, 07:03:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:03:57 INFO - 'tests': ['dromaeo_dom']}, 07:03:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:03:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:03:57 INFO - 'tests': ['basic_compositor_video']}, 07:03:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:03:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:03:57 INFO - 'tests': ['a11yr', 07:03:57 INFO - 'ts_paint', 07:03:57 INFO - 'tpaint', 07:03:57 INFO - 'sessionrestore', 07:03:57 INFO - 'sessionrestore_no_auto_restore', 07:03:57 INFO - 'tabpaint']}, 07:03:57 INFO - 'other-e10s': {'tests': ['a11yr', 07:03:57 INFO - 'ts_paint', 07:03:57 INFO - 'tpaint', 07:03:57 INFO - 'sessionrestore', 07:03:57 INFO - 'sessionrestore_no_auto_restore', 07:03:57 INFO - 'tabpaint']}, 07:03:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:03:57 INFO - 'ts_paint', 07:03:57 INFO - 'tpaint', 07:03:57 INFO - 'sessionrestore', 07:03:57 INFO - 'sessionrestore_no_auto_restore', 07:03:57 INFO - 'tabpaint']}, 07:03:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:03:57 INFO - 'ts_paint', 07:03:57 INFO - 'tpaint', 07:03:57 INFO - 'sessionrestore', 07:03:57 INFO - 'sessionrestore_no_auto_restore', 07:03:57 INFO - 'tabpaint']}, 07:03:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:03:57 INFO - 'tests': ['a11yr', 07:03:57 INFO - 'ts_paint', 07:03:57 INFO - 'tpaint', 07:03:57 INFO - 'sessionrestore', 07:03:57 INFO - 'sessionrestore_no_auto_restore', 07:03:57 INFO - 'tabpaint']}, 07:03:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:03:57 INFO - 'tests': ['a11yr', 07:03:57 INFO - 'ts_paint', 07:03:57 INFO - 'tpaint', 07:03:57 INFO - 'sessionrestore', 07:03:57 INFO - 'sessionrestore_no_auto_restore', 07:03:57 INFO - 'tabpaint']}, 07:03:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:03:57 INFO - 'tests': ['tsvgx', 07:03:57 INFO - 'tsvgr_opacity', 07:03:57 INFO - 'tart', 07:03:57 INFO - 'tscrollx', 07:03:57 INFO - 'cart', 07:03:57 INFO - 'tsvg_static']}, 07:03:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:03:57 INFO - 'tsvgr_opacity', 07:03:57 INFO - 'tart', 07:03:57 INFO - 'tscrollx', 07:03:57 INFO - 'cart', 07:03:57 INFO - 'tsvg_static']}, 07:03:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:03:57 INFO - 'talos_options': ['--disable-e10s'], 07:03:57 INFO - 'tests': ['tp5o']}, 07:03:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:03:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:03:57 INFO - 'talos_options': ['--disable-e10s', 07:03:57 INFO - '--xperf_path', 07:03:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:03:57 INFO - 'tests': ['tp5n']}, 07:03:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:03:57 INFO - 'talos_options': ['--xperf_path', 07:03:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:03:57 INFO - 'tests': ['tp5n']}}, 07:03:57 INFO - 'talos.zip': {'path': '', 07:03:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:03:57 INFO - Running post-action listener: _resource_record_post_action 07:03:57 INFO - [mozharness: 2017-01-09 15:03:57.501355Z] Finished populate-webroot step (success) 07:03:57 INFO - [mozharness: 2017-01-09 15:03:57.501444Z] Running create-virtualenv step. 07:03:57 INFO - Running pre-action listener: _resource_record_pre_action 07:03:57 INFO - Running main action method: create_virtualenv 07:03:57 INFO - Creating virtualenv /builds/slave/test/build/venv 07:03:57 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 07:03:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:03:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:03:57 INFO - Using real prefix '/usr' 07:03:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:03:58 INFO - Installing distribute.............................................................................................................................................................................................done. 07:04:00 INFO - Installing pip.................done. 07:04:00 INFO - Return code: 0 07:04:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:04:00 INFO - Reading from file tmpfile_stdout 07:04:00 INFO - Output received: 07:04:00 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) 07:04:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d46850>, '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 0x1cbb6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbb60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638', '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 07:04:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:04:00 INFO - Using env: {'DISPLAY': ':0', 07:04:00 INFO - 'HOME': '/home/cltbld', 07:04:00 INFO - 'LANG': 'en_US.UTF-8', 07:04:00 INFO - 'LANGUAGE': 'en_US:en', 07:04:00 INFO - 'LOGNAME': 'cltbld', 07:04:00 INFO - 'MAIL': '/var/mail/cltbld', 07:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:00 INFO - 'MOZ_NO_REMOTE': '1', 07:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:00 INFO - 'NO_EM_RESTART': '1', 07:04:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:00 INFO - 'PWD': '/builds/slave/test', 07:04:00 INFO - 'SHELL': '/bin/bash', 07:04:00 INFO - 'SHLVL': '1', 07:04:00 INFO - 'TERM': 'linux', 07:04:00 INFO - 'TMOUT': '86400', 07:04:00 INFO - 'USER': 'cltbld', 07:04:00 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638', 07:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:00 INFO - '_': '/tools/buildbot/bin/python'} 07:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:00 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 07:04:00 INFO - Cleaning up... 07:04:00 INFO - Return code: 0 07:04:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x194b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d46850>, '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 0x1cbb6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbb60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638', '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 07:04:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:04:00 INFO - Using env: {'DISPLAY': ':0', 07:04:00 INFO - 'HOME': '/home/cltbld', 07:04:00 INFO - 'LANG': 'en_US.UTF-8', 07:04:00 INFO - 'LANGUAGE': 'en_US:en', 07:04:00 INFO - 'LOGNAME': 'cltbld', 07:04:00 INFO - 'MAIL': '/var/mail/cltbld', 07:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:00 INFO - 'MOZ_NO_REMOTE': '1', 07:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:00 INFO - 'NO_EM_RESTART': '1', 07:04:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:00 INFO - 'PWD': '/builds/slave/test', 07:04:00 INFO - 'SHELL': '/bin/bash', 07:04:00 INFO - 'SHLVL': '1', 07:04:00 INFO - 'TERM': 'linux', 07:04:00 INFO - 'TMOUT': '86400', 07:04:00 INFO - 'USER': 'cltbld', 07:04:00 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638', 07:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:00 INFO - '_': '/tools/buildbot/bin/python'} 07:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:00 INFO - Downloading/unpacking psutil>=3.1.1 07:04:00 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 07:04:00 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 07:04:00 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 07:04:00 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 07:04:00 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 07:04:00 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 07:04:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:04:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:04:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:04:02 INFO - Installing collected packages: psutil 07:04:02 INFO - Running setup.py install for psutil 07:04:02 INFO - building 'psutil._psutil_linux' extension 07:04:02 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 07:04:03 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 07:04:03 INFO - building 'psutil._psutil_posix' extension 07:04:03 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 07:04:03 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 07:04:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:04:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:04:03 INFO - Successfully installed psutil 07:04:03 INFO - Cleaning up... 07:04:03 INFO - Return code: 0 07:04:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:04: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')]} 07:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04: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')]} 07:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:03 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 0x194b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d46850>, '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 0x1cbb6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbb60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638', '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 07:04:03 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 07:04:03 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 07:04:03 INFO - Using env: {'DISPLAY': ':0', 07:04:03 INFO - 'HOME': '/home/cltbld', 07:04:03 INFO - 'LANG': 'en_US.UTF-8', 07:04:03 INFO - 'LANGUAGE': 'en_US:en', 07:04:03 INFO - 'LOGNAME': 'cltbld', 07:04:03 INFO - 'MAIL': '/var/mail/cltbld', 07:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:03 INFO - 'MOZ_NO_REMOTE': '1', 07:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:03 INFO - 'NO_EM_RESTART': '1', 07:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:03 INFO - 'PWD': '/builds/slave/test', 07:04:03 INFO - 'SHELL': '/bin/bash', 07:04:03 INFO - 'SHLVL': '1', 07:04:03 INFO - 'TERM': 'linux', 07:04:03 INFO - 'TMOUT': '86400', 07:04:03 INFO - 'USER': 'cltbld', 07:04:03 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638', 07:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:03 INFO - '_': '/tools/buildbot/bin/python'} 07:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:04:03 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 07:04:03 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 07:04:03 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 07:04:03 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 07:04:03 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 07:04:03 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 07:04:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:04:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:04:05 INFO - Installing collected packages: mozsystemmonitor 07:04:05 INFO - Running setup.py install for mozsystemmonitor 07:04:05 INFO - Successfully installed mozsystemmonitor 07:04:05 INFO - Cleaning up... 07:04:05 INFO - Return code: 0 07:04:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:04:05 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')]} 07:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:05 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')]} 07:04:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:05 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 0x194b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d46850>, '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 0x1cbb6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbb60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638', '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 07:04:05 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 07:04:05 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 07:04:05 INFO - Using env: {'DISPLAY': ':0', 07:04:05 INFO - 'HOME': '/home/cltbld', 07:04:05 INFO - 'LANG': 'en_US.UTF-8', 07:04:05 INFO - 'LANGUAGE': 'en_US:en', 07:04:05 INFO - 'LOGNAME': 'cltbld', 07:04:05 INFO - 'MAIL': '/var/mail/cltbld', 07:04:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:05 INFO - 'MOZ_NO_REMOTE': '1', 07:04:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:05 INFO - 'NO_EM_RESTART': '1', 07:04:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:05 INFO - 'PWD': '/builds/slave/test', 07:04:05 INFO - 'SHELL': '/bin/bash', 07:04:05 INFO - 'SHLVL': '1', 07:04:05 INFO - 'TERM': 'linux', 07:04:05 INFO - 'TMOUT': '86400', 07:04:05 INFO - 'USER': 'cltbld', 07:04:05 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638', 07:04:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:05 INFO - '_': '/tools/buildbot/bin/python'} 07:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:06 INFO - Downloading/unpacking jsonschema==2.5.1 07:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:04:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:04:08 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 07:04:08 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 07:04:08 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 07:04:08 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 07:04:08 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 07:04:08 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 07:04:08 INFO - Downloading functools32-3.2.3-2.tar.gz 07:04:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:04:08 INFO - warning: no files found matching '*.txt' 07:04:08 INFO - no previously-included directories found matching 'build' 07:04:08 INFO - no previously-included directories found matching 'dist' 07:04:08 INFO - no previously-included directories found matching '.git*' 07:04:08 INFO - Installing collected packages: jsonschema, functools32 07:04:08 INFO - Running setup.py install for functools32 07:04:08 INFO - warning: no files found matching '*.txt' 07:04:08 INFO - no previously-included directories found matching 'build' 07:04:08 INFO - no previously-included directories found matching 'dist' 07:04:08 INFO - no previously-included directories found matching '.git*' 07:04:08 INFO - Successfully installed jsonschema functools32 07:04:08 INFO - Cleaning up... 07:04:08 INFO - Return code: 0 07:04:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x194b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d46850>, '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 0x1cbb6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbb60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638', '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 07:04:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:04:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:04:08 INFO - Using env: {'DISPLAY': ':0', 07:04:08 INFO - 'HOME': '/home/cltbld', 07:04:08 INFO - 'LANG': 'en_US.UTF-8', 07:04:08 INFO - 'LANGUAGE': 'en_US:en', 07:04:08 INFO - 'LOGNAME': 'cltbld', 07:04:08 INFO - 'MAIL': '/var/mail/cltbld', 07:04:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:08 INFO - 'MOZ_NO_REMOTE': '1', 07:04:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:08 INFO - 'NO_EM_RESTART': '1', 07:04:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:08 INFO - 'PWD': '/builds/slave/test', 07:04:08 INFO - 'SHELL': '/bin/bash', 07:04:08 INFO - 'SHLVL': '1', 07:04:08 INFO - 'TERM': 'linux', 07:04:08 INFO - 'TMOUT': '86400', 07:04:08 INFO - 'USER': 'cltbld', 07:04:08 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638', 07:04:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:08 INFO - '_': '/tools/buildbot/bin/python'} 07:04:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:04:08 INFO - Cleaning up... 07:04:08 INFO - Return code: 0 07:04:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x194b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d46850>, '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 0x1cbb6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbb60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638', '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 07:04:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:04:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:04:08 INFO - Using env: {'DISPLAY': ':0', 07:04:08 INFO - 'HOME': '/home/cltbld', 07:04:08 INFO - 'LANG': 'en_US.UTF-8', 07:04:08 INFO - 'LANGUAGE': 'en_US:en', 07:04:08 INFO - 'LOGNAME': 'cltbld', 07:04:08 INFO - 'MAIL': '/var/mail/cltbld', 07:04:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:08 INFO - 'MOZ_NO_REMOTE': '1', 07:04:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:08 INFO - 'NO_EM_RESTART': '1', 07:04:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:08 INFO - 'PWD': '/builds/slave/test', 07:04:08 INFO - 'SHELL': '/bin/bash', 07:04:08 INFO - 'SHLVL': '1', 07:04:08 INFO - 'TERM': 'linux', 07:04:08 INFO - 'TMOUT': '86400', 07:04:08 INFO - 'USER': 'cltbld', 07:04:08 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638', 07:04:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:08 INFO - '_': '/tools/buildbot/bin/python'} 07:04:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:09 INFO - Downloading/unpacking blobuploader==1.2.4 07:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:11 INFO - Downloading blobuploader-1.2.4.tar.gz 07:04:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:04:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:04:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:11 INFO - Downloading docopt-0.6.1.tar.gz 07:04:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:04:11 INFO - Installing collected packages: blobuploader, requests, docopt 07:04:11 INFO - Running setup.py install for blobuploader 07:04:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:04:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:04:11 INFO - Running setup.py install for requests 07:04:12 INFO - Running setup.py install for docopt 07:04:12 INFO - Successfully installed blobuploader requests docopt 07:04:12 INFO - Cleaning up... 07:04:12 INFO - Return code: 0 07:04:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:04:12 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')]} 07:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:12 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')]} 07:04:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:12 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 0x194b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d46850>, '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 0x1cbb6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbb60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638', '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 07:04:12 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 07:04:12 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 07:04:12 INFO - Using env: {'DISPLAY': ':0', 07:04:12 INFO - 'HOME': '/home/cltbld', 07:04:12 INFO - 'LANG': 'en_US.UTF-8', 07:04:12 INFO - 'LANGUAGE': 'en_US:en', 07:04:12 INFO - 'LOGNAME': 'cltbld', 07:04:12 INFO - 'MAIL': '/var/mail/cltbld', 07:04:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:12 INFO - 'MOZ_NO_REMOTE': '1', 07:04:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:12 INFO - 'NO_EM_RESTART': '1', 07:04:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:12 INFO - 'PWD': '/builds/slave/test', 07:04:12 INFO - 'SHELL': '/bin/bash', 07:04:12 INFO - 'SHLVL': '1', 07:04:12 INFO - 'TERM': 'linux', 07:04:12 INFO - 'TMOUT': '86400', 07:04:12 INFO - 'USER': 'cltbld', 07:04:12 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638', 07:04:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:12 INFO - '_': '/tools/buildbot/bin/python'} 07:04:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:04:12 INFO - Running setup.py (path:/tmp/pip-X42wHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:04:12 INFO - Running setup.py (path:/tmp/pip-52YmIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:04:12 INFO - Running setup.py (path:/tmp/pip-lgvfq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:04:12 INFO - Running setup.py (path:/tmp/pip-JAXqyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:04:12 INFO - Running setup.py (path:/tmp/pip-5uarMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:04:13 INFO - Running setup.py (path:/tmp/pip-uQsmcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:04:13 INFO - Running setup.py (path:/tmp/pip-RvLhNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:04:13 INFO - Running setup.py (path:/tmp/pip-VXOgxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:04:13 INFO - Running setup.py (path:/tmp/pip-hiV_Du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:04:13 INFO - Running setup.py (path:/tmp/pip-DQxrW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:04:13 INFO - Running setup.py (path:/tmp/pip-SEnfo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:04:13 INFO - Running setup.py (path:/tmp/pip-S8pppQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:04:13 INFO - Running setup.py (path:/tmp/pip-PsbsBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:04:13 INFO - Running setup.py (path:/tmp/pip-3PA5St-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:04:13 INFO - Running setup.py (path:/tmp/pip-aE9JpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:04:13 INFO - Running setup.py (path:/tmp/pip-DfGsYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:04:13 INFO - Running setup.py (path:/tmp/pip-9oPBKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:04:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:04:13 INFO - Running setup.py install for manifestparser 07:04:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:04:13 INFO - Running setup.py install for mozcrash 07:04:14 INFO - Running setup.py install for mozdebug 07:04:14 INFO - Running setup.py install for mozdevice 07:04:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:04:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:04:14 INFO - Running setup.py install for mozfile 07:04:14 INFO - Running setup.py install for mozhttpd 07:04:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:04:14 INFO - Running setup.py install for mozinfo 07:04:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:04:14 INFO - Running setup.py install for mozInstall 07:04:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:04:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:04:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:04:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:04:14 INFO - Running setup.py install for mozleak 07:04:14 INFO - Running setup.py install for mozlog 07:04:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:04:14 INFO - Running setup.py install for moznetwork 07:04:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:04:15 INFO - Running setup.py install for mozprocess 07:04:15 INFO - Running setup.py install for mozprofile 07:04:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:04:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:04:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:04:15 INFO - Running setup.py install for mozrunner 07:04:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:04:15 INFO - Running setup.py install for mozscreenshot 07:04:15 INFO - Running setup.py install for moztest 07:04:15 INFO - Running setup.py install for mozversion 07:04:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:04:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:04:15 INFO - Cleaning up... 07:04:15 INFO - Return code: 0 07:04:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:04: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')]} 07:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04: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')]} 07:04:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:15 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 0x194b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d46850>, '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 0x1cbb6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbb60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638', '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 07:04:15 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 07:04:15 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 07:04:15 INFO - Using env: {'DISPLAY': ':0', 07:04:15 INFO - 'HOME': '/home/cltbld', 07:04:15 INFO - 'LANG': 'en_US.UTF-8', 07:04:15 INFO - 'LANGUAGE': 'en_US:en', 07:04:15 INFO - 'LOGNAME': 'cltbld', 07:04:15 INFO - 'MAIL': '/var/mail/cltbld', 07:04:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:15 INFO - 'MOZ_NO_REMOTE': '1', 07:04:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:15 INFO - 'NO_EM_RESTART': '1', 07:04:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:15 INFO - 'PWD': '/builds/slave/test', 07:04:15 INFO - 'SHELL': '/bin/bash', 07:04:15 INFO - 'SHLVL': '1', 07:04:15 INFO - 'TERM': 'linux', 07:04:15 INFO - 'TMOUT': '86400', 07:04:15 INFO - 'USER': 'cltbld', 07:04:15 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638', 07:04:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:15 INFO - '_': '/tools/buildbot/bin/python'} 07:04:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:04:15 INFO - Running setup.py (path:/tmp/pip-U2eDfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:04:15 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)) 07:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:04:15 INFO - Running setup.py (path:/tmp/pip-bOVTkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:04:16 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)) 07:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:04:16 INFO - Running setup.py (path:/tmp/pip-QDu3vJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:04:16 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)) 07:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:04:16 INFO - Running setup.py (path:/tmp/pip-wfIE5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:04:16 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)) 07:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:04:16 INFO - Running setup.py (path:/tmp/pip-qClTZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:04:16 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)) 07:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:04:16 INFO - Running setup.py (path:/tmp/pip-IM1N_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:04:16 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)) 07:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:04:16 INFO - Running setup.py (path:/tmp/pip-Jvd8AT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:04:16 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)) 07:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:04:16 INFO - Running setup.py (path:/tmp/pip-D9Hf2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:04:16 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)) 07:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:04:16 INFO - Running setup.py (path:/tmp/pip-otwKGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:04:16 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)) 07:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:04:16 INFO - Running setup.py (path:/tmp/pip-gnyu_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:04:16 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)) 07:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:04:16 INFO - Running setup.py (path:/tmp/pip-etCw3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:04:16 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)) 07:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:04:16 INFO - Running setup.py (path:/tmp/pip-K1skzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 07:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:04:16 INFO - Running setup.py (path:/tmp/pip-SFpBbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:04:16 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)) 07:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:04:16 INFO - Running setup.py (path:/tmp/pip-8QdAU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:04:16 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)) 07:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:04:16 INFO - Running setup.py (path:/tmp/pip-AFuUPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:04:16 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)) 07:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:04:16 INFO - Running setup.py (path:/tmp/pip-_lDjNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:04:17 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)) 07:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:04:17 INFO - Running setup.py (path:/tmp/pip-31ZNO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:04:17 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)) 07:04:17 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)) 07:04:17 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)) 07:04:17 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)) 07:04:17 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)) 07:04:17 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)) 07:04:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:04:17 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 07:04:17 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 07:04:17 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 07:04:17 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 07:04:17 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 07:04:17 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 07:04:19 INFO - Downloading blessings-1.6.tar.gz 07:04:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:04:19 INFO - Installing collected packages: blessings 07:04:19 INFO - Running setup.py install for blessings 07:04:19 INFO - Successfully installed blessings 07:04:19 INFO - Cleaning up... 07:04:19 INFO - Return code: 0 07:04:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:04:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:04:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:04:19 INFO - Reading from file tmpfile_stdout 07:04:19 INFO - Current package versions: 07:04:19 INFO - argparse == 1.2.1 07:04:19 INFO - blessings == 1.6 07:04:19 INFO - blobuploader == 1.2.4 07:04:19 INFO - docopt == 0.6.1 07:04:19 INFO - functools32 == 3.2.3-2 07:04:19 INFO - jsonschema == 2.5.1 07:04:19 INFO - manifestparser == 1.1 07:04:19 INFO - mozInstall == 1.12 07:04:19 INFO - mozcrash == 1.0 07:04:19 INFO - mozdebug == 0.1 07:04:19 INFO - mozdevice == 0.49 07:04:19 INFO - mozfile == 1.2 07:04:19 INFO - mozhttpd == 0.7 07:04:19 INFO - mozinfo == 0.9 07:04:19 INFO - mozleak == 0.1 07:04:19 INFO - mozlog == 3.4 07:04:19 INFO - moznetwork == 0.27 07:04:19 INFO - mozprocess == 0.24 07:04:19 INFO - mozprofile == 0.28 07:04:19 INFO - mozrunner == 6.13 07:04:19 INFO - mozscreenshot == 0.1 07:04:19 INFO - mozsystemmonitor == 0.3 07:04:19 INFO - moztest == 0.8 07:04:19 INFO - mozversion == 1.4 07:04:19 INFO - psutil == 3.1.1 07:04:19 INFO - requests == 1.2.3 07:04:19 INFO - wsgiref == 0.1.2 07:04:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:04: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')]} 07:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04: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')]} 07:04:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:19 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 0x194b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d46850>, '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 0x1cbb6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbb60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638', '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 07:04:19 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 07:04:19 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 07:04:19 INFO - Using env: {'DISPLAY': ':0', 07:04:19 INFO - 'HOME': '/home/cltbld', 07:04:19 INFO - 'LANG': 'en_US.UTF-8', 07:04:19 INFO - 'LANGUAGE': 'en_US:en', 07:04:19 INFO - 'LOGNAME': 'cltbld', 07:04:19 INFO - 'MAIL': '/var/mail/cltbld', 07:04:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:19 INFO - 'MOZ_NO_REMOTE': '1', 07:04:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:19 INFO - 'NO_EM_RESTART': '1', 07:04:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:19 INFO - 'PWD': '/builds/slave/test', 07:04:19 INFO - 'SHELL': '/bin/bash', 07:04:19 INFO - 'SHLVL': '1', 07:04:19 INFO - 'TERM': 'linux', 07:04:19 INFO - 'TMOUT': '86400', 07:04:19 INFO - 'USER': 'cltbld', 07:04:19 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638', 07:04:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:19 INFO - '_': '/tools/buildbot/bin/python'} 07:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:19 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)) 07:04:19 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)) 07:04:19 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)) 07:04:19 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)) 07:04:19 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)) 07:04:19 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)) 07:04:19 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)) 07:04:19 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)) 07:04:19 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)) 07:04:19 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)) 07:04:19 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)) 07:04:19 INFO - Cleaning up... 07:04:19 INFO - Return code: 0 07:04:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:04: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')]} 07:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04: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')]} 07:04:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d46850>, '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 0x1cbb6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbb60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638', '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 07:04: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', 'jsonschema'] in /builds/slave/test/build 07:04: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 jsonschema 07:04:19 INFO - Using env: {'DISPLAY': ':0', 07:04:19 INFO - 'HOME': '/home/cltbld', 07:04:19 INFO - 'LANG': 'en_US.UTF-8', 07:04:19 INFO - 'LANGUAGE': 'en_US:en', 07:04:19 INFO - 'LOGNAME': 'cltbld', 07:04:19 INFO - 'MAIL': '/var/mail/cltbld', 07:04:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:19 INFO - 'MOZ_NO_REMOTE': '1', 07:04:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:19 INFO - 'NO_EM_RESTART': '1', 07:04:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:19 INFO - 'PWD': '/builds/slave/test', 07:04:19 INFO - 'SHELL': '/bin/bash', 07:04:19 INFO - 'SHLVL': '1', 07:04:19 INFO - 'TERM': 'linux', 07:04:19 INFO - 'TMOUT': '86400', 07:04:19 INFO - 'USER': 'cltbld', 07:04:19 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638', 07:04:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:19 INFO - '_': '/tools/buildbot/bin/python'} 07:04:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:04:20 INFO - Cleaning up... 07:04:20 INFO - Return code: 0 07:04:20 INFO - Running post-action listener: _resource_record_post_action 07:04:20 INFO - Running post-action listener: _start_resource_monitoring 07:04:20 INFO - Starting resource monitoring. 07:04:20 INFO - [mozharness: 2017-01-09 15:04:20.111881Z] Finished create-virtualenv step (success) 07:04:20 INFO - [mozharness: 2017-01-09 15:04:20.112384Z] Running install step. 07:04:20 INFO - Running pre-action listener: _resource_record_pre_action 07:04:20 INFO - Running main action method: install 07:04:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:04:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:04:20 INFO - Reading from file tmpfile_stdout 07:04:20 INFO - Detecting whether we're running mozinstall >=1.0... 07:04:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:04:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:04:20 INFO - Reading from file tmpfile_stdout 07:04:20 INFO - Output received: 07:04:20 INFO - Usage: mozinstall [options] installer 07:04:20 INFO - Options: 07:04:20 INFO - -h, --help show this help message and exit 07:04:20 INFO - -d DEST, --destination=DEST 07:04:20 INFO - Directory to install application into. [default: 07:04:20 INFO - "/builds/slave/test"] 07:04:20 INFO - --app=APP Application being installed. [default: firefox] 07:04:20 INFO - mkdir: /builds/slave/test/build/application 07:04:20 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'] 07:04:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:04:36 INFO - Reading from file tmpfile_stdout 07:04:36 INFO - Output received: 07:04:36 INFO - /builds/slave/test/build/application/firefox/firefox 07:04:36 INFO - Running post-action listener: _resource_record_post_action 07:04:36 INFO - [mozharness: 2017-01-09 15:04:36.459352Z] Finished install step (success) 07:04:36 INFO - [mozharness: 2017-01-09 15:04:36.459625Z] Running run-tests step. 07:04:36 INFO - Running pre-action listener: _resource_record_pre_action 07:04:36 INFO - Running main action method: run_tests 07:04:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:04:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:04:36 INFO - Python 2.7.3 07:04:36 INFO - Return code: 0 07:04:36 INFO - grabbing minidump binary from tooltool 07:04:36 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')]} 07:04:36 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 0x1d46850>, '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 0x1cbb6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:04:36 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 07:04:36 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 07:04:36 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 07:04:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:04:36 INFO - Return code: 0 07:04:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:04:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:04:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:04:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:04:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:04:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 07:04:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 07:04:36 INFO - Using env: {'DISPLAY': ':0', 07:04:36 INFO - 'HOME': '/home/cltbld', 07:04:36 INFO - 'LANG': 'en_US.UTF-8', 07:04:36 INFO - 'LANGUAGE': 'en_US:en', 07:04:36 INFO - 'LOGNAME': 'cltbld', 07:04:36 INFO - 'MAIL': '/var/mail/cltbld', 07:04:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:04:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:04:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:36 INFO - 'MOZ_NO_REMOTE': '1', 07:04:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:04:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:36 INFO - 'NO_EM_RESTART': '1', 07:04:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:36 INFO - 'PWD': '/builds/slave/test', 07:04:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:04:36 INFO - 'SHELL': '/bin/bash', 07:04:36 INFO - 'SHLVL': '1', 07:04:36 INFO - 'TERM': 'linux', 07:04:36 INFO - 'TMOUT': '86400', 07:04:36 INFO - 'USER': 'cltbld', 07:04:36 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638', 07:04:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:36 INFO - '_': '/tools/buildbot/bin/python'} 07:04:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 07:04:36 INFO - mozversion application_buildid: 20170109143722 07:04:36 INFO - mozversion application_changeset: 2977ca1224525680cbfb5c3ce3018818b6dfd8f2 07:04:36 INFO - mozversion application_display_name: Nightly 07:04:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:04:36 INFO - mozversion application_name: Firefox 07:04:36 INFO - mozversion application_remotingname: firefox 07:04:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:04:36 INFO - mozversion application_vendor: Mozilla 07:04:36 INFO - mozversion application_version: 53.0a1 07:04:36 INFO - mozversion platform_buildid: 20170109143722 07:04:36 INFO - mozversion platform_changeset: 2977ca1224525680cbfb5c3ce3018818b6dfd8f2 07:04:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:04:36 INFO - mozversion platform_version: 53.0a1 07:04:36 INFO - using testdate: 1483974276 07:04:36 INFO - actual date: 1483974276 07:04:36 INFO - starting webserver on 'localhost:45446' 07:04:36 INFO - SUITE-START | Running 2 tests 07:04:36 INFO - TEST-START | dromaeo_css 07:04:36 INFO - operating with platform_type : linux_ 07:04:36 INFO - Initialising browser for dromaeo_css test... 07:04:36 INFO - TEST-INFO | started process 29302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE7eyZ_/profile http://localhost:45446/getInfo.html) 07:04:37 INFO - PROCESS | 29302 | 1483974277288 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:4906 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3761 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2794 < 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 07:04:40 INFO - PROCESS | 29302 | __metrics Screen width/height:1600/1200 07:04:40 INFO - PROCESS | 29302 | colorDepth:24 07:04:40 INFO - PROCESS | 29302 | Browser inner width/height: 1024/697 07:04:40 INFO - PROCESS | 29302 | __metrics 07:04:41 INFO - PROCESS | 29302 | 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" 07:04:41 INFO - PROCESS | 29302 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:04:42 INFO - PROCESS | 29302 | console.error: PushService: 07:04:42 INFO - PROCESS | 29302 | stateChangeProcessEnqueue: Error transitioning state 07:04:42 INFO - PROCESS | 29302 | UnknownError 07:04:42 INFO - TEST-INFO | 29302: exit 0 07:04:42 INFO - Browser initialized. 07:04:42 INFO - Running cycle 1/1 for dromaeo_css test... 07:04:42 INFO - TEST-INFO | started process 29381 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE7eyZ_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:04:54 INFO - PROCESS | 29381 | RSS: Main: 151883776 07:04:54 INFO - PROCESS | 29381 | 07:07:59 INFO - PROCESS | 29381 | Cycle 1(1): loaded http://localhost:45446/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45446/tests/dromaeo/cssquery-ext.html) 07:08:02 INFO - PROCESS | 29381 | RSS: Main: 383934464 07:08:02 INFO - PROCESS | 29381 | 07:09:43 INFO - PROCESS | 29381 | ************************* 07:09:43 INFO - PROCESS | 29381 | A coding exception was thrown and uncaught in a Task. 07:09:43 INFO - PROCESS | 29381 | 07:09:43 INFO - PROCESS | 29381 | Full message: ReferenceError: fetch is not defined 07:09:43 INFO - PROCESS | 29381 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 07:09:43 INFO - PROCESS | 29381 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 07:09:43 INFO - PROCESS | 29381 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 07:09:43 INFO - PROCESS | 29381 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 07:09:43 INFO - PROCESS | 29381 | TaskImpl@resource://gre/modules/Task.jsm:277:3 07:09:43 INFO - PROCESS | 29381 | asyncFunction@resource://gre/modules/Task.jsm:252:14 07:09:43 INFO - PROCESS | 29381 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 07:09:43 INFO - PROCESS | 29381 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 07:09:43 INFO - PROCESS | 29381 | TaskImpl@resource://gre/modules/Task.jsm:277:3 07:09:43 INFO - PROCESS | 29381 | asyncFunction@resource://gre/modules/Task.jsm:252:14 07:09:43 INFO - PROCESS | 29381 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 07:09:43 INFO - PROCESS | 29381 | 07:09:43 INFO - PROCESS | 29381 | ************************* 07:11:04 INFO - PROCESS | 29381 | Cycle 1(1): loaded http://localhost:45446/tests/dromaeo/cssquery-ext.html (next: http://localhost:45446/tests/dromaeo/cssquery-jquery.html) 07:11:05 INFO - PROCESS | 29381 | RSS: Main: 242348032 07:11:05 INFO - PROCESS | 29381 | 07:14:07 INFO - PROCESS | 29381 | Cycle 1(1): loaded http://localhost:45446/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45446/tests/dromaeo/cssquery-mootools.html) 07:14:08 INFO - PROCESS | 29381 | RSS: Main: 221962240 07:14:08 INFO - PROCESS | 29381 | 07:17:10 INFO - PROCESS | 29381 | Cycle 1(1): loaded http://localhost:45446/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45446/tests/dromaeo/cssquery-prototype.html) 07:17:11 INFO - PROCESS | 29381 | RSS: Main: 184922112 07:17:11 INFO - PROCESS | 29381 | 07:20:14 INFO - PROCESS | 29381 | Cycle 1(1): loaded http://localhost:45446/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45446/tests/dromaeo/cssquery-yui.html) 07:20:14 INFO - PROCESS | 29381 | RSS: Main: 186445824 07:20:14 INFO - PROCESS | 29381 | 07:23:17 INFO - PROCESS | 29381 | Cycle 1(1): loaded http://localhost:45446/tests/dromaeo/cssquery-yui.html (next: http://localhost:45446/tests/dromaeo/cssquery-dojo.html) 07:23:18 INFO - PROCESS | 29381 | RSS: Main: 264785920 07:23:18 INFO - PROCESS | 29381 | 07:23:18 INFO - PROCESS | 29381 | __start_tp_report 07:23:18 INFO - PROCESS | 29381 | _x_x_mozilla_page_load 07:23:18 INFO - PROCESS | 29381 | _x_x_mozilla_page_load_details 07:23:18 INFO - PROCESS | 29381 | |i|pagename|runs| 07:23:18 INFO - PROCESS | 29381 | |0;dojo.html;2633.6049592561117;2651.0456235755137;2685.1139124089054;2689.7713694335966;2692.919212423628;4704.741239231841;4752.358431611731;4788.760561971896;4835.854924352267;4867.756612169391;4802.663813533054;4819.421669399668;4821.325014497965;4853.951460485394;4899.779509922053;4359.2371335016405;4377.124575084979;4423.911521769563;4466.665000124987;4566.429196350457;4094.877153685394;4427.358033085201;4491.438570178728;4521.457425108975;4567.862964111082;4306.5262821089655;4347.7826108694435;4413.227685155117;4414.293713005935;4474.217012022899;4349.108432771274;4358.433403657536;4405.163019026407;4428.933565996513;4487.640988720895;4404.955950440519;4408.382826404306;4412.470503539564;4425.982024134467;4454.398656181406;4771.379720636295;4788.11419887322;4804.831830885937;4814.3019262207135;4835.830745923876;5044.949550504484;5045.268436076748;5113.539781419653;5142.845714628567;5154.561862241714;5198.324217851693;5205.7917683293;5219;5245.26566280721;5261;4842.128416884994;4850.902981940377;4853.95146048542;4867.61059115277;4894.853154405374;5186.481351864783;5201.739913004335;5233;5254.842354729364;5315.548178404879;5070.923936140961;5074.797008119634;5078.619103567247;5123.410807757081;5123.820666276662;5039.496050395004;5078.339815823919;5159.613029022838;5171.043356978971;5207.479252074838;5050.974745126251;5100.974495127501;5101.158308879068;5101.234814777738;5104.719240441811;5089.262057001714;5100.719460429637;5102.08162530748;5109.6678715883345;5113.411957624847;4375.759333236639;4392.1874453226255;4396.648268138605;4429.778511074498;4444.799984000728;3809.3143234218105;3811.5045044144085;3816.9427458588143;3843.55799083109;3852.2295540891932;4352.499462561783;4383.824647014084;4497.539007233509;4500.774961251925;4563.498015218323;5083.491650834887;5147.948520514747;5150.356205474316;5159.355080614923;5213.817516386908;4441.622462090694;4443.089166720814;4443.666724995638;4448.822047118144;4487.955120448753;4543.727376357429;4544.295634176708;4616.792244349012;4625.121226966866;4668.1130585189385;4804.495527969513;4804.8318308859025;4832.782524786463;4844.8304309349005;4896.167651499182;5173.1722924331925;5179.637425380187;5180.171172612364;5182.404023537341;5186.4035635902355;4854.927176092432;4859.611231101433;4860.927086093782;4896.265560165861;4900.191468407673;4968.503149685002;4989.575886049726;4992.201247800334;5049.2426136079885;5060.468650791614;5072.923906141485;5122.718250496258;5124.180131178993;5124.385073791169;5125.205593133071;4919.237518184687;4964.553190212898;4965;4966.354373931365;4967.975160124176;4968.55283024515;4969.3291405659775;4971.776270067928;4973.254011898244;4978.4025916890205;4915.729634870117;4932.112219800327;4933.186024305949;4933.333999909966;4944.381952255968;5017.648764586444;5020.673656212481;5026.798928042837;5031.6729412588065;5034.823781167642;4910.680805747615;4918.2376731606655;4924.901501970012;4970.478099799614;4970.751462426936 07:23:18 INFO - PROCESS | 29381 | |1;ext.html;501.64383287865616;510.8416390918815;515.1165750737484;529.3462573721455;546.1398297681153;31876.20309492264;32965.67034329656;32985.67014329853;39157;40613.796931015306;41848.37227441583;42346.57653423465;42388;42392.576074239245;42453.15093698124;7563.470557060994;7724.266194711521;7726.613669316512;7733;7736.535807851547;7492;7583.355414789749;7690.423218258625;7692.3076923076915;9703.175230105415;9676.371035882645;10052.89947100527;10053;10056.849147262797;10057.396556206615;9940.105390514853;10025.298229123964;10026.197904167722;10028.49857507129;10030.799384012278;9788.657396991071;9847.359921605144;9851.113399794052;9859.30984831062;9862;38150.23699526022;38446.23107537834;38463.423048654295;38512.422313665316;38563.61436385656;3247.561579186803;3290.226796702773;3309.3712194682935;3337.9666203337897;3366.3603915256267;28215;28288;28968.42063158746;28974.710252897414;29089.272768180752;3105.021918095815;3136.7333776629016;3209.1174926895055;3257.641659417462;3375.932481350384;258765;258881;259035;259131;259383;53743;53981.73009135008;54118.458815411344;54227;54289.72855135699;56494.717526412926;56567.151492727644;56696.43303566994;56873.14690279649;56876;12515.436805343781;12927.741445171045;12927.935360323327;12934.935325323313;12939.676508087185;9675.90324096764;9796.314258002014;9799.804003919882;9804.313698041211;9805.607775689035;14068.171137752232;14429.20639364845;14454.566363009126;14950.626234344229;14954;5870.295564532198;6222.253329600477;6271.4669253114;6308.968455157695;6315.400036996478;764.7743915544817;776.9184235655288;788.7239466186788;805.5086397297644;806.6571707024491;25940.87029564878;26160;26372.60441093385;26430.339241519116;26678.866605666848;914.5244472874068;923.6628630549801;928.7863791327898;968.1431932739576;969.0842154164388;13085.149465284916;13136.802947955788;13188.406521706545;13333.733325333438;14354.210518421378;348568;350814;353752;354794;356558;35752.10619734476;35769.1057723559;35801.64198357983;35819.4627080594;35865.46201806923;1236.3014896583402;1249.9937500312622;1255.4852510470846;1259.3010878962264;1271.5740227023866;22170.224042158447;24021;24034.46714725687;25284.747152528238;25382.61926071147;36208.63791362053;36314.63685363113;36330.818345908105;36404.63595364012;36458;298982;299811;300912;301253;302860;22803.54392912099;23121.190758323377;23195.53608927846;23221;23222.187223447097;35629.82185089162;36248.27503449969;36303.455448168825;36796.63203367932;36883;29405.558916616697;30624.234394140323;30953;31049;31975;29946.850265748533;30047.849760751058;30382.240443988194;30411.54382684217;31756.523652145697;30233.395332092794;30657.693423066376;30812.53781193239;30967.225819353796;31128.377432451678;25810;27895.302617434725;27953;27970.300742481602;28185.43629127447;21814.345569632937;22020.33938981833;22116.778832211472;22156.667649985586;22241.110355585595 07:23:18 INFO - PROCESS | 29381 | |2;jquery.html;353.2176229651322;357.9821008949552;364.2223852075818;367.35686733949245;386.7486134012891;13577.52478663247;17018.5745356366;17481.562960925985;17823.37618183364;17930.731039034425;16965.15174241289;17025.233864476097;17059.317627294924;17138.742918856195;17212.569685757862;4823.541763532458;5165.81919632813;5203.739813009353;5205.16717325228;5217.686938783685;3875.5155605549307;4044.9797751011206;5034.496550344955;5126.333576635032;5802.506786923117;6045.214122164112;6118.143459915593;6145.2625684917875;6154.076888466743;6169.259688837324;5914.378990206031;5979.671118088503;6012.669303188323;6033.396660333975;6128.448439640431;5294.761735721863;5296.020236256305;5299.867503312448;5300.708461034642;5303.549198318147;20775.79224207769;21069.683954740693;21192.576148476943;21275.680864787042;21375.144994200215;2301.689271948299;2349.036894873094;2361.5276944610973;2364.9408764780846;2445.095314733542;12831.550895718605;13322.333883305893;13424.731505369838;13817.240051797147;13964.371603277878;1700.4388551777884;1739.356438117892;1764.7264673975426;1765.1350838089372;1796.616605213978;60823.695881520754;72530;74029.62985185093;74686.99999999946;75468.24531754667;9242.907570924339;9580.425174489554;9625.759356016155;9762.46306453152;9958.651447199458;13072.673183170307;13107.868921310665;13109.27898965566;13308.401121949535;13422.328883555978;6662.600243985376;6842.623655698984;6940.826479338057;7016.228214896358;7033.542819716702;6420.903686444707;6421.3899679531305;6503.25212600557;6560.540762146699;6616.239132499728;6245.156903818017;6297.905531417033;6351.618902865843;6376.904346434807;6423.454006409507;1677.8406051425095;1701.4555342290596;1717.107104305754;1722.422988298934;1723.1901006526912;903.6520939438232;916.2944532709777;929.5305870535336;930.3069213436033;932.7434955387187;16964.406245781338;17607;17642.38251661186;18091.909540452478;18097;888.4669198480989;897.2059727141527;900.3247564326755;910.644848509082;911.252772726358;9470.384425012353;10041.698749037541;10185.541650625739;10228.10414250669;10283.794324113476;500323;504803;507962;517913;521045;79302.20697793063;80765;81276;83014.58492707497;83983;939.3377668743519;944.9811003780023;966.4491239993278;967.3857100740939;976.584951395654;15107.54677359681;15107.697846043238;15654.608634784221;15713.528594142193;15916.0450372978;36351.63648363482;36435.27129457449;37535.43696844604;37827.810860945516;38076.428853566664;47858.76070619764;47913.52086479091;47918.926891214636;47981.52018479771;50125.49874501208;5677.68772717488;7499.1750907399055;7509.136449308399;7635.847283054197;7796.025496812898;12126.090543209471;12290.631281061582;12314.753704925672;12374.381280936097;12494.625161245178;9435.198008169382;10076.445795481319;10350.430726310125;10452.425116618659;10869.402182880018;10244.180465562886;10706.250562460553;10766.138708903425;10795.946020270163;10818.404987725751;9807.950960245438;9848.753781155528;10090.54592543352;10324.174066074846;10714.14286857034;7412.481126321106;7428.814279643052;7445.478816482794;7485.812854678677;7853.332466740391;7961.323287520626;10190.235732319958;10196.796064078528;10253.743656408351;10469.633562825264 07:23:18 INFO - PROCESS | 29381 | |3;mootools.html;1141.7374003979085;1148.609472779255;1153.4521102476324;1164.6156768266474;1197.3893314409652;5978.043513037915;6582;6877.105976223084;6892.069570607967;6993.580385176881;6054.334023257438;6203.906941395871;6276.246850377961;6280.120783090371;6559.8360040999;2005.4184286556917;2066.0599427260636;2068.4725395024248;2074.2532688232222;2078.3141563284157;1993.7607487101568;2079.688046792978;2080;2081.1363284237023;2085.9269925552608;1830.7894592121943;1904.5714714189335;2051.866628669132;2071.6167509010806;2072.8030837070455;1891.1962415973226;1955.892425916574;1964.6856502959458;1975.190172029461;1978.0307649251906;2041.428400047974;2078.420400495619;2079.6984437256665;2079.7088407622946;2086.613976414353;6880.139982502187;7009.983552384927;7010.579365238051;7022.683979220948;7028.086348774677;4279.87160385189;4372.453443319585;4392.648588112943;4398.626116780046;4403.53762854902;2573.3437973316873;2697.5549034409496;2746.093789049609;2753.3804893898914;2755.5728862026417;926.4117285523673;969.1277849935044;1011;1017.7811770469384;1033.6950599573145;8778.078301778285;8788.51663158526;8837.779055523599;8897.866532002025;9007.909920900773;3680.9079773005888;3825.273198092409;3859.054531639766;3936.8622098226424;3987.7407968481957;7843.294103530596;7861.685532578633;7897.565633890191;7905.525668459911;7943.4836735612;4195.202911446815;4263.16868210696;4263.722858014219;4263.786810659454;4405.493368262627;3804.2011177653003;3911.0808959894403;3916.099297161612;3924.823382947774;3933.6853051755793;3405.7105146062368;3422.6748458896363;3474.444088945807;3481.1819222482695;3487.7907325560545;1094.9397783122006;1128.418864284894;1133.3539882267194;1142.3374442823308;1145.2441388683428;659.5844617890698;697.6755808549049;803.9276465118168;840.0759164918663;842.0022273605797;4578.748168850679;4626.976865115653;4650.86047418578;4771.498992605796;4848.188295444906;496.07234471538453;506.4656787089582;507.7918053598007;512.5566385076881;574.8534123798405;3334.416477116495;3470.5661792275964;3482.669146431085;3515.8945231643092;3526.4181410067563;8087.3125784308995;8143.267105960374;8250;8258.710945116893;8278.71024514139;7800.492967957065;8212.384071194565;8214.342852571779;8219.8356032879;8232.876506852403;6554.901676474857;6588.143541339595;6589.86820263592;6591.802245932726;6603.603783772893;4852.951470485391;4877.731724755031;4964.05682920244;4992.126377883783;5165.974170129125;7395.18652948186;7521.172671006294;7559.773206803805;7564.394848412004;7592.696292148473;7574.583397913168;7614.314711675976;7625.466217364731;7629.961850190713;7653.88519172224;6168.691565421801;6234.812955611339;6235.75056997715;6238.4073513018;6246.750129994749;6574.605523668595;6611.438027767694;6666.566673166229;6668.566543174678;6670.299618540177;4921.9507804921495;6023.3073196582955;6058.0610005449225;6104.603200791934;6213.2233470816145;5886.646801191942;5993.280806303272;5999.280086389661;6093.6039157454625;6128.66292353907;5560.638558493685;5565.0817615094675;5565.55475561946;5579.051561234681;5580.135079062752;3903.687704983651;4031.2945234583244;4108.424820525189;4109.054917368962;4283.828646854091;4146.4036346006405;4250.638695710899;4318.913621727485;4367.257566213815;4421.579949904753 07:23:18 INFO - PROCESS | 29381 | |4;prototype.html;345.9913502162446;349.8062687661648;354.6985062696708;355.41001936784943;356.11327793793464;4872.3909511311085;4879.3656824612835;4880.560749532541;4892.850180207653;4904.817356276459;4814.975925120379;4828.637852161084;4833.806647734086;4834.540718631724;4850.660453768229;3452.482127680843;3719.5822715235176;3795.430685397185;3901.210634396406;3942.7831469269177;3877.263319969197;3886.5919078496777;3889.9691581730863;3895.2599006188875;3899.824507897137;3839.3281175794264;3868.729188956774;3881.1849511602454;3890.144168282973;3897.3179693553516;3688.3176612326806;3735.906602334936;3775.962240377616;3844.2503711776217;3879.612038796126;3480.3561341151717;3494.877679281238;3502.807345595991;3502.8248587570774;3508.2808024354945;4746.335513028179;4748.406449193851;4755.619550435957;4757.500462451462;4773.856784296477;4316.007318316773;4446.644268458515;4474.239379305526;4481.274709236967;4498.145352383037;5045.495450454961;5077.771500282496;5079.615607456109;5096.362954630671;5102.744862756847;3765.510483637137;3770.3213421584105;3772.2078363543687;3780.865740277933;3800.809959502014;5084.288199652088;5230.110881150214;5345.251664766935;5354.143337066051;5354.223637572569;3826.7563042011457;3888.261230366278;3898.8440462381186;3918.1575961168487;3942.1327307992196;3963.4847469828737;3977.1449138435373;3985.4021896715726;3990.5610382857863;4011.478507793968;4449.621782148553;4456.774387043524;4461.442319710036;4464.1071785643;4488.708233964782;4919.77860996256;5071.54356107952;5072.568831649277;5087.821926232564;5095.1847704367865;1338.0900987328516;1343.8185844911006;1345.2533843716635;1357.4230951845623;1362.7410791949499;897.6364572348078;958.1903291718487;960.6877764726491;969.5588507229194;971.4656938683837;4320.935185972213;4321.762303073361;4357.411749413852;4368.475782906072;4373.278409062533;5109;5133.922991155136;5137.383513978347;5141.357330333708;5189.273501709764;4183.644390226804;4360.890977725582;4389.62688171509;4394.2749446340995;4422.977885110554;2661;2687.6640419947507;2688.4407043914484;2709.5122877881777;2709.6071069695176;4757.3577567028005;4766.428028636586;4777.880552986134;4789.928151077736;4797.784099715521;5033.295338652591;5112.9744351278005;5191.273221748958;5202.635815492955;5242.9213561796605;4667.953320466752;4740.155906456168;4749.287606858929;4763.4522029967;4782.976085119552;5064.797408103635;5087.287779710769;5106;5124.846909445345;5128.666636668605;4870.293807397837;5005.4744251853035;5010.49895010496;5014.4484106747495;5039.924401134059;4730.385049943623;4730.503297153749;4769.332293478985;4793.880152996064;4843.854684359475;3899.3176194166476;3924.430957511202;3980.164165525272;3981.3231750603045;3989.660878825216;5256.159014557652;5262;5266.73666316675;5269.657472264291;5284.309021113207;4888.5111488850835;5014.222795466709;5049.480714760342;5088.414832294334;5090.974545127251;5039.672421292605;5045.142325804549;5051.141305977919;5066.31604733371;5066.847994560169;4989.850304490871;5005.499450054966;5009.073321435546;5031.672941258953;5031.949680503149;4895.534924182197;5068.923966140437;5079.136546787129;5081.517255860687;5098.419489958125;4943.703377797344;4960.528749768766;4964.808445972868;4972.2790195422185;4975.751212439436 07:23:18 INFO - PROCESS | 29381 | |5;yui.html;658.7924803686841;675.392147067639;694.7394726977384;699.2902204262671;706.0961968680089;12935.288559129243;14133.434662613508;14151.221682807454;14157.079789813668;14160.71678566428;13246.867531324708;13356.398962046707;13365.665858353546;13400;13474.5283915063;658.1049772309655;679.6465837764359;781.5467029123123;789.7314912929588;798.8641930871737;809.9473534220257;810.3395732478041;810.5096416667919;811.3387589114852;813.8535063688533;857.2242120880613;865.0830120072711;866.3199388480012;866.4627930682985;866.5753780647469;692.9272426395231;710.1159056974101;823.4606332851992;843.5824266987819;862.7239283429305;623.0311865049846;623.507429130986;623.9251289845248;624.048326302388;624.54720327762;13316.667083322898;13578.864211357859;13618.046736728433;13619.455221791117;13632.113912595649;12849.35753212345;13309.800352994713;13319.933400333033;13327.800082998763;13355.19868807865;11735.413229338585;11806.350650714206;11822.290662560188;12047.91568758807;12420.503179872794;4075.9388609170887;4217.5993280638595;4311.051568654891;4327.37253098299;4331.155424692186;59051;60076.39923600752;60390.39609603935;61179.38820611826;62109;10471.172783348453;10542.314749541256;10567.418791966516;10666.839997400046;10876.129909607213;20146.597068058556;20164.29424970119;20169.798302017087;20185.596288074157;20192.39422817318;6520.380563846427;6636.83407914806;6670.833229169212;6751.864962700718;6870.793876183722;3548.609652938175;3647.398179300386;3651.94522082169;3670.1742108026015;3680.35593771089;2798.0626490126037;2832.702566230516;2846.6157068795446;2863.498887694645;2886.870090845917;477.36748807829764;488.66282265236873;528.9523942845085;558.8826346467288;570.597728601335;637.1366797988751;658.2495954611651;664.6262344119817;664.9035889796049;672.2403683837233;9135.223506001932;9515.333926625208;9525.380850244712;9597.712068637951;9653;639.7345101782709;659.8416380068749;663.3234101216829;663.717919884057;667.2393471442559;4331.7834108294455;4427.512973572904;4606.976965115153;4619.076184762994;4625.722456652545;64416.35583644197;67855.66072169706;69085;70032.6498367505;70420;44964.77517612391;53388;56593;58852.41147588555;58913;51852;52854.20718689223;53491.465085348646;54323.18515222354;54806;8457.281131103678;8564.957175214084;8651.394402391772;8667.696630617898;8849.823003540021;35565.46651800173;35685.28629427449;36440.088997774204;36729.44905826361;36862.44706329353;32895.506567401986;44809.327860081474;45051.549484504736;46437.195350581176;48056.5194348066;10079.949600251952;10323.690289291333;10365.844512332473;10543.736406589896;10589.788204236027;11626.186166968231;11703;11735;11824.46789894474;12038.638840834788;10746.731331716457;11052.447377631248;11055.778884422105;11086.889131108908;11142.83285750698;9599.568019439283;9671.564779584794;9862.408255504693;10240.795184096127;10624.521896514521;11849.822252666045;11996.400179990791;12166.330851803235;12299.44652490658;12727.554535591209;10018.499075046364;10414.427206503715;10422.947885260524;10490.737731556772;10838.729031774268;9958.799410851514;9958.800823983334;10204.336718113298;10305.845412318971;10776.784464310827 07:23:18 INFO - PROCESS | 29381 | __end_tp_report 07:23:18 INFO - PROCESS | 29381 | __start_cc_report 07:23:18 INFO - PROCESS | 29381 | _x_x_mozilla_cycle_collect,2759 07:23:18 INFO - PROCESS | 29381 | __end_cc_report 07:23:18 INFO - PROCESS | 29381 | __startTimestamp1483975398159__endTimestamp 07:23:18 INFO - PROCESS | 29381 | 07:23:18 INFO - PROCESS | 29381 | ------- Summary: start ------- 07:23:18 INFO - PROCESS | 29381 | Number of tests: 6 07:23:18 INFO - PROCESS | 29381 | 07:23:18 INFO - PROCESS | 29381 | [#0] dojo.html Cycles:165 Average:4750.54 Median:4896.27 stddev:495.31 (10.1%) stddev-sans-first:468.16 07:23:18 INFO - PROCESS | 29381 | Values: 2633.6 2651.0 2685.1 2689.8 2692.9 4704.7 4752.4 4788.8 4835.9 4867.8 4802.7 4819.4 4821.3 4854.0 4899.8 4359.2 4377.1 4423.9 4466.7 4566.4 4094.9 4427.4 4491.4 4521.5 4567.9 4306.5 4347.8 4413.2 4414.3 4474.2 4349.1 4358.4 4405.2 4428.9 4487.6 4405.0 4408.4 4412.5 4426.0 4454.4 4771.4 4788.1 4804.8 4814.3 4835.8 5044.9 5045.3 5113.5 5142.8 5154.6 5198.3 5205.8 5219.0 5245.3 5261.0 4842.1 4850.9 4854.0 4867.6 4894.9 5186.5 5201.7 5233.0 5254.8 5315.5 5070.9 5074.8 5078.6 5123.4 5123.8 5039.5 5078.3 5159.6 5171.0 5207.5 5051.0 5101.0 5101.2 5101.2 5104.7 5089.3 5100.7 5102.1 5109.7 5113.4 4375.8 4392.2 4396.6 4429.8 4444.8 3809.3 3811.5 3816.9 3843.6 3852.2 4352.5 4383.8 4497.5 4500.8 4563.5 5083.5 5147.9 5150.4 5159.4 5213.8 4441.6 4443.1 4443.7 4448.8 4488.0 4543.7 4544.3 4616.8 4625.1 4668.1 4804.5 4804.8 4832.8 4844.8 4896.2 5173.2 5179.6 5180.2 5182.4 5186.4 4854.9 4859.6 4860.9 4896.3 4900.2 4968.5 4989.6 4992.2 5049.2 5060.5 5072.9 5122.7 5124.2 5124.4 5125.2 4919.2 4964.6 4965.0 4966.4 4968.0 4968.6 4969.3 4971.8 4973.3 4978.4 4915.7 4932.1 4933.2 4933.3 4944.4 5017.6 5020.7 5026.8 5031.7 5034.8 4910.7 4918.2 4924.9 4970.5 4970.8 07:23:18 INFO - PROCESS | 29381 | 07:23:18 INFO - PROCESS | 29381 | [#1] ext.html Cycles:180 Average:44573.52 Median:32975.67 stddev:80680.58 (244.7%) stddev-sans-first:80839.06 07:23:18 INFO - PROCESS | 29381 | Values: 501.6 510.8 515.1 529.3 546.1 31876.2 32965.7 32985.7 39157.0 40613.8 41848.4 42346.6 42388.0 42392.6 42453.2 7563.5 7724.3 7726.6 7733.0 7736.5 7492.0 7583.4 7690.4 7692.3 9703.2 9676.4 10052.9 10053.0 10056.8 10057.4 9940.1 10025.3 10026.2 10028.5 10030.8 9788.7 9847.4 9851.1 9859.3 9862.0 38150.2 38446.2 38463.4 38512.4 38563.6 3247.6 3290.2 3309.4 3338.0 3366.4 28215.0 28288.0 28968.4 28974.7 29089.3 3105.0 3136.7 3209.1 3257.6 3375.9 258765.0 258881.0 259035.0 259131.0 259383.0 53743.0 53981.7 54118.5 54227.0 54289.7 56494.7 56567.2 56696.4 56873.1 56876.0 12515.4 12927.7 12927.9 12934.9 12939.7 9675.9 9796.3 9799.8 9804.3 9805.6 14068.2 14429.2 14454.6 14950.6 14954.0 5870.3 6222.3 6271.5 6309.0 6315.4 764.8 776.9 788.7 805.5 806.7 25940.9 26160.0 26372.6 26430.3 26678.9 914.5 923.7 928.8 968.1 969.1 13085.1 13136.8 13188.4 13333.7 14354.2 348568.0 350814.0 353752.0 354794.0 356558.0 35752.1 35769.1 35801.6 35819.5 35865.5 1236.3 1250.0 1255.5 1259.3 1271.6 22170.2 24021.0 24034.5 25284.7 25382.6 36208.6 36314.6 36330.8 36404.6 36458.0 298982.0 299811.0 300912.0 301253.0 302860.0 22803.5 23121.2 23195.5 23221.0 23222.2 35629.8 36248.3 36303.5 36796.6 36883.0 29405.6 30624.2 30953.0 31049.0 31975.0 29946.9 30047.8 30382.2 30411.5 31756.5 30233.4 30657.7 30812.5 30967.2 31128.4 25810.0 27895.3 27953.0 27970.3 28185.4 21814.3 22020.3 22116.8 22156.7 22241.1 07:23:18 INFO - PROCESS | 29381 | 07:23:18 INFO - PROCESS | 29381 | [#2] jquery.html Cycles:180 Average:27991.86 Median:26402.53 stddev:83735.38 (317.1%) stddev-sans-first:83944.56 07:23:18 INFO - PROCESS | 29381 | Values: 353.2 358.0 364.2 367.4 386.7 13577.5 17018.6 17481.6 17823.4 17930.7 16965.2 17025.2 17059.3 17138.7 17212.6 4823.5 5165.8 5203.7 5205.2 5217.7 3875.5 4045.0 5034.5 5126.3 5802.5 6045.2 6118.1 6145.3 6154.1 6169.3 5914.4 5979.7 6012.7 6033.4 6128.4 5294.8 5296.0 5299.9 5300.7 5303.5 20775.8 21069.7 21192.6 21275.7 21375.1 2301.7 2349.0 2361.5 2364.9 2445.1 12831.6 13322.3 13424.7 13817.2 13964.4 1700.4 1739.4 1764.7 1765.1 1796.6 60823.7 72530.0 74029.6 74687.0 75468.2 9242.9 9580.4 9625.8 9762.5 9958.7 13072.7 13107.9 13109.3 13308.4 13422.3 6662.6 6842.6 6940.8 7016.2 7033.5 6420.9 6421.4 6503.3 6560.5 6616.2 6245.2 6297.9 6351.6 6376.9 6423.5 1677.8 1701.5 1717.1 1722.4 1723.2 903.7 916.3 929.5 930.3 932.7 16964.4 17607.0 17642.4 18091.9 18097.0 888.5 897.2 900.3 910.6 911.3 9470.4 10041.7 10185.5 10228.1 10283.8 500323.0 504803.0 507962.0 517913.0 521045.0 79302.2 80765.0 81276.0 83014.6 83983.0 939.3 945.0 966.4 967.4 976.6 15107.5 15107.7 15654.6 15713.5 15916.0 36351.6 36435.3 37535.4 37827.8 38076.4 47858.8 47913.5 47918.9 47981.5 50125.5 5677.7 7499.2 7509.1 7635.8 7796.0 12126.1 12290.6 12314.8 12374.4 12494.6 9435.2 10076.4 10350.4 10452.4 10869.4 10244.2 10706.3 10766.1 10795.9 10818.4 9808.0 9848.8 10090.5 10324.2 10714.1 7412.5 7428.8 7445.5 7485.8 7853.3 7961.3 10190.2 10196.8 10253.7 10469.6 07:23:18 INFO - PROCESS | 29381 | 07:23:18 INFO - PROCESS | 29381 | [#3] mootools.html Cycles:180 Average:4551.65 Median:2709.01 stddev:2421.56 (89.4%) stddev-sans-first:2414.79 07:23:18 INFO - PROCESS | 29381 | Values: 1141.7 1148.6 1153.5 1164.6 1197.4 5978.0 6582.0 6877.1 6892.1 6993.6 6054.3 6203.9 6276.2 6280.1 6559.8 2005.4 2066.1 2068.5 2074.3 2078.3 1993.8 2079.7 2080.0 2081.1 2085.9 1830.8 1904.6 2051.9 2071.6 2072.8 1891.2 1955.9 1964.7 1975.2 1978.0 2041.4 2078.4 2079.7 2079.7 2086.6 6880.1 7010.0 7010.6 7022.7 7028.1 4279.9 4372.5 4392.6 4398.6 4403.5 2573.3 2697.6 2746.1 2753.4 2755.6 926.4 969.1 1011.0 1017.8 1033.7 8778.1 8788.5 8837.8 8897.9 9007.9 3680.9 3825.3 3859.1 3936.9 3987.7 7843.3 7861.7 7897.6 7905.5 7943.5 4195.2 4263.2 4263.7 4263.8 4405.5 3804.2 3911.1 3916.1 3924.8 3933.7 3405.7 3422.7 3474.4 3481.2 3487.8 1094.9 1128.4 1133.4 1142.3 1145.2 659.6 697.7 803.9 840.1 842.0 4578.7 4627.0 4650.9 4771.5 4848.2 496.1 506.5 507.8 512.6 574.9 3334.4 3470.6 3482.7 3515.9 3526.4 8087.3 8143.3 8250.0 8258.7 8278.7 7800.5 8212.4 8214.3 8219.8 8232.9 6554.9 6588.1 6589.9 6591.8 6603.6 4853.0 4877.7 4964.1 4992.1 5166.0 7395.2 7521.2 7559.8 7564.4 7592.7 7574.6 7614.3 7625.5 7630.0 7653.9 6168.7 6234.8 6235.8 6238.4 6246.8 6574.6 6611.4 6666.6 6668.6 6670.3 4922.0 6023.3 6058.1 6104.6 6213.2 5886.6 5993.3 5999.3 6093.6 6128.7 5560.6 5565.1 5565.6 5579.1 5580.1 3903.7 4031.3 4108.4 4109.1 4283.8 4146.4 4250.6 4318.9 4367.3 4421.6 07:23:18 INFO - PROCESS | 29381 | 07:23:18 INFO - PROCESS | 29381 | [#4] prototype.html Cycles:180 Average:4230.65 Median:4764.94 stddev:1181.35 (24.8%) stddev-sans-first:1148.11 07:23:18 INFO - PROCESS | 29381 | Values: 346.0 349.8 354.7 355.4 356.1 4872.4 4879.4 4880.6 4892.9 4904.8 4815.0 4828.6 4833.8 4834.5 4850.7 3452.5 3719.6 3795.4 3901.2 3942.8 3877.3 3886.6 3890.0 3895.3 3899.8 3839.3 3868.7 3881.2 3890.1 3897.3 3688.3 3735.9 3776.0 3844.3 3879.6 3480.4 3494.9 3502.8 3502.8 3508.3 4746.3 4748.4 4755.6 4757.5 4773.9 4316.0 4446.6 4474.2 4481.3 4498.1 5045.5 5077.8 5079.6 5096.4 5102.7 3765.5 3770.3 3772.2 3780.9 3800.8 5084.3 5230.1 5345.3 5354.1 5354.2 3826.8 3888.3 3898.8 3918.2 3942.1 3963.5 3977.1 3985.4 3990.6 4011.5 4449.6 4456.8 4461.4 4464.1 4488.7 4919.8 5071.5 5072.6 5087.8 5095.2 1338.1 1343.8 1345.3 1357.4 1362.7 897.6 958.2 960.7 969.6 971.5 4320.9 4321.8 4357.4 4368.5 4373.3 5109.0 5133.9 5137.4 5141.4 5189.3 4183.6 4360.9 4389.6 4394.3 4423.0 2661.0 2687.7 2688.4 2709.5 2709.6 4757.4 4766.4 4777.9 4789.9 4797.8 5033.3 5113.0 5191.3 5202.6 5242.9 4668.0 4740.2 4749.3 4763.5 4783.0 5064.8 5087.3 5106.0 5124.8 5128.7 4870.3 5005.5 5010.5 5014.4 5039.9 4730.4 4730.5 4769.3 4793.9 4843.9 3899.3 3924.4 3980.2 3981.3 3989.7 5256.2 5262.0 5266.7 5269.7 5284.3 4888.5 5014.2 5049.5 5088.4 5091.0 5039.7 5045.1 5051.1 5066.3 5066.8 4989.9 5005.5 5009.1 5031.7 5031.9 4895.5 5068.9 5079.1 5081.5 5098.4 4943.7 4960.5 4964.8 4972.3 4975.8 07:23:18 INFO - PROCESS | 29381 | 07:23:18 INFO - PROCESS | 29381 | [#5] yui.html Cycles:180 Average:14887.83 Median:24829.26 stddev:18278.10 (73.6%) stddev-sans-first:18298.14 07:23:18 INFO - PROCESS | 29381 | Values: 658.8 675.4 694.7 699.3 706.1 12935.3 14133.4 14151.2 14157.1 14160.7 13246.9 13356.4 13365.7 13400.0 13474.5 658.1 679.6 781.5 789.7 798.9 809.9 810.3 810.5 811.3 813.9 857.2 865.1 866.3 866.5 866.6 692.9 710.1 823.5 843.6 862.7 623.0 623.5 623.9 624.0 624.5 13316.7 13578.9 13618.0 13619.5 13632.1 12849.4 13309.8 13319.9 13327.8 13355.2 11735.4 11806.4 11822.3 12047.9 12420.5 4075.9 4217.6 4311.1 4327.4 4331.2 59051.0 60076.4 60390.4 61179.4 62109.0 10471.2 10542.3 10567.4 10666.8 10876.1 20146.6 20164.3 20169.8 20185.6 20192.4 6520.4 6636.8 6670.8 6751.9 6870.8 3548.6 3647.4 3651.9 3670.2 3680.4 2798.1 2832.7 2846.6 2863.5 2886.9 477.4 488.7 529.0 558.9 570.6 637.1 658.2 664.6 664.9 672.2 9135.2 9515.3 9525.4 9597.7 9653.0 639.7 659.8 663.3 663.7 667.2 4331.8 4427.5 4607.0 4619.1 4625.7 64416.4 67855.7 69085.0 70032.6 70420.0 44964.8 53388.0 56593.0 58852.4 58913.0 51852.0 52854.2 53491.5 54323.2 54806.0 8457.3 8565.0 8651.4 8667.7 8849.8 35565.5 35685.3 36440.1 36729.4 36862.4 32895.5 44809.3 45051.5 46437.2 48056.5 10079.9 10323.7 10365.8 10543.7 10589.8 11626.2 11703.0 11735.0 11824.5 12038.6 10746.7 11052.4 11055.8 11086.9 11142.8 9599.6 9671.6 9862.4 10240.8 10624.5 11849.8 11996.4 12166.3 12299.4 12727.6 10018.5 10414.4 10422.9 10490.7 10838.7 9958.8 9958.8 10204.3 10305.8 10776.8 07:23:18 INFO - PROCESS | 29381 | -------- Summary: end -------- 07:23:18 INFO - PROCESS | 29381 | 07:23:18 INFO - TEST-INFO | 29381: exit 0 07:23:19 INFO - TEST-OK | dromaeo_css | took 1122257ms 07:23:19 INFO - TEST-START | kraken 07:23:19 INFO - operating with platform_type : linux_ 07:23:19 INFO - Initialising browser for kraken test... 07:23:19 INFO - TEST-INFO | started process 29681 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq9OC8i/profile http://localhost:45446/getInfo.html) 07:23:19 INFO - PROCESS | 29681 | 1483975399521 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:4906 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3761 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2794 < 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 07:23:23 INFO - PROCESS | 29681 | __metrics Screen width/height:1600/1200 07:23:23 INFO - PROCESS | 29681 | colorDepth:24 07:23:23 INFO - PROCESS | 29681 | Browser inner width/height: 1024/697 07:23:23 INFO - PROCESS | 29681 | __metrics 07:23:23 INFO - PROCESS | 29681 | 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" 07:23:23 INFO - PROCESS | 29681 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:23:24 INFO - PROCESS | 29681 | console.error: PushService: 07:23:24 INFO - PROCESS | 29681 | stateChangeProcessEnqueue: Error transitioning state 07:23:24 INFO - PROCESS | 29681 | UnknownError 07:23:25 INFO - TEST-INFO | 29681: exit 0 07:23:25 INFO - Browser initialized. 07:23:25 INFO - Running cycle 1/1 for kraken test... 07:23:25 INFO - TEST-INFO | started process 29761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq9OC8i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:23:37 INFO - PROCESS | 29761 | RSS: Main: 152207360 07:23:37 INFO - PROCESS | 29761 | 07:23:39 INFO - PROCESS | 29761 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45446/tests/kraken/driver.html?testName=audio-beat-detection) 07:23:40 INFO - PROCESS | 29761 | RSS: Main: 207257600 07:23:40 INFO - PROCESS | 29761 | 07:23:43 INFO - PROCESS | 29761 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45446/tests/kraken/driver.html?testName=audio-dft) 07:23:44 INFO - PROCESS | 29761 | RSS: Main: 186077184 07:23:44 INFO - PROCESS | 29761 | 07:23:47 INFO - PROCESS | 29761 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45446/tests/kraken/driver.html?testName=audio-fft) 07:23:47 INFO - PROCESS | 29761 | RSS: Main: 268967936 07:23:47 INFO - PROCESS | 29761 | 07:23:50 INFO - PROCESS | 29761 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45446/tests/kraken/driver.html?testName=audio-oscillator) 07:23:50 INFO - PROCESS | 29761 | RSS: Main: 178249728 07:23:50 INFO - PROCESS | 29761 | 07:23:52 INFO - PROCESS | 29761 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45446/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:23:53 INFO - PROCESS | 29761 | RSS: Main: 183640064 07:23:53 INFO - PROCESS | 29761 | 07:23:56 INFO - PROCESS | 29761 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45446/tests/kraken/driver.html?testName=imaging-darkroom) 07:23:57 INFO - PROCESS | 29761 | RSS: Main: 222625792 07:23:57 INFO - PROCESS | 29761 | 07:24:00 INFO - PROCESS | 29761 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45446/tests/kraken/driver.html?testName=imaging-desaturate) 07:24:01 INFO - PROCESS | 29761 | RSS: Main: 222064640 07:24:01 INFO - PROCESS | 29761 | 07:24:04 INFO - PROCESS | 29761 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45446/tests/kraken/driver.html?testName=json-parse-financial) 07:24:04 INFO - PROCESS | 29761 | RSS: Main: 220286976 07:24:04 INFO - PROCESS | 29761 | 07:24:06 INFO - PROCESS | 29761 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45446/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:24:07 INFO - PROCESS | 29761 | RSS: Main: 183095296 07:24:07 INFO - PROCESS | 29761 | 07:24:09 INFO - PROCESS | 29761 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45446/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:24:09 INFO - PROCESS | 29761 | RSS: Main: 191016960 07:24:09 INFO - PROCESS | 29761 | 07:24:11 INFO - PROCESS | 29761 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45446/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:24:12 INFO - PROCESS | 29761 | RSS: Main: 198623232 07:24:12 INFO - PROCESS | 29761 | 07:24:15 INFO - PROCESS | 29761 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45446/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:24:15 INFO - PROCESS | 29761 | RSS: Main: 208445440 07:24:15 INFO - PROCESS | 29761 | 07:24:18 INFO - PROCESS | 29761 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45446/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:24:19 INFO - PROCESS | 29761 | RSS: Main: 205205504 07:24:19 INFO - PROCESS | 29761 | 07:24:21 INFO - PROCESS | 29761 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45446/tests/kraken/driver.html?testName=ai-astar) 07:24:21 INFO - PROCESS | 29761 | RSS: Main: 255930368 07:24:21 INFO - PROCESS | 29761 | 07:24:21 INFO - PROCESS | 29761 | __start_tp_report 07:24:21 INFO - PROCESS | 29761 | _x_x_mozilla_page_load 07:24:21 INFO - PROCESS | 29761 | _x_x_mozilla_page_load_details 07:24:21 INFO - PROCESS | 29761 | |i|pagename|runs| 07:24:21 INFO - PROCESS | 29761 | |0;ai-astar;115;118;114;116;114;115;115;114;113;113 07:24:21 INFO - PROCESS | 29761 | |1;audio-beat-detection;146;127;131;168;131;129;126;127;153;123 07:24:21 INFO - PROCESS | 29761 | |2;audio-dft;161;161;162;162;163;162;162;162;161;162 07:24:21 INFO - PROCESS | 29761 | |3;audio-fft;76;76;76;111;76;76;77;75;93;77 07:24:21 INFO - PROCESS | 29761 | |4;audio-oscillator;84;85;121;84;85;86;113;86;95;119 07:24:21 INFO - PROCESS | 29761 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;118;117;117 07:24:21 INFO - PROCESS | 29761 | |6;imaging-darkroom;150;149;149;149;149;150;148;149;149;149 07:24:21 INFO - PROCESS | 29761 | |7;imaging-desaturate;95;95;95;96;95;96;95;96;95;96 07:24:21 INFO - PROCESS | 29761 | |8;json-parse-financial;58;67;58;59;66;59;59;61;58;61 07:24:21 INFO - PROCESS | 29761 | |9;json-stringify-tinderbox;67;67;71;67;67;67;66;68;66;67 07:24:21 INFO - PROCESS | 29761 | |10;stanford-crypto-aes;85;85;84;85;86;86;86;87;85;90 07:24:21 INFO - PROCESS | 29761 | |11;stanford-crypto-ccm;146;137;133;134;131;131;130;132;171;161 07:24:21 INFO - PROCESS | 29761 | |12;stanford-crypto-pbkdf2;178;175;175;186;177;183;174;178;176;183 07:24:21 INFO - PROCESS | 29761 | |13;stanford-crypto-sha256-iterative;69;68;68;69;70;69;68;68;67;69 07:24:21 INFO - PROCESS | 29761 | __end_tp_report 07:24:21 INFO - PROCESS | 29761 | __start_cc_report 07:24:21 INFO - PROCESS | 29761 | _x_x_mozilla_cycle_collect,1837 07:24:21 INFO - PROCESS | 29761 | __end_cc_report 07:24:21 INFO - PROCESS | 29761 | __startTimestamp1483975461596__endTimestamp 07:24:21 INFO - PROCESS | 29761 | 07:24:21 INFO - PROCESS | 29761 | ------- Summary: start ------- 07:24:21 INFO - PROCESS | 29761 | Number of tests: 14 07:24:21 INFO - PROCESS | 29761 | 07:24:21 INFO - PROCESS | 29761 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.00 stddev:1.49 (1.3%) stddev-sans-first:1.58 07:24:21 INFO - PROCESS | 29761 | Values: 115.0 118.0 114.0 116.0 114.0 115.0 115.0 114.0 113.0 113.0 07:24:21 INFO - PROCESS | 29761 | 07:24:21 INFO - PROCESS | 29761 | [#1] audio-beat-detection Cycles:10 Average:136.10 Median:131.00 stddev:14.69 (11.2%) stddev-sans-first:15.14 07:24:21 INFO - PROCESS | 29761 | Values: 146.0 127.0 131.0 168.0 131.0 129.0 126.0 127.0 153.0 123.0 07:24:21 INFO - PROCESS | 29761 | 07:24:21 INFO - PROCESS | 29761 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 07:24:21 INFO - PROCESS | 29761 | Values: 161.0 161.0 162.0 162.0 163.0 162.0 162.0 162.0 161.0 162.0 07:24:21 INFO - PROCESS | 29761 | 07:24:21 INFO - PROCESS | 29761 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:11.72 (15.4%) stddev-sans-first:12.27 07:24:21 INFO - PROCESS | 29761 | Values: 76.0 76.0 76.0 111.0 76.0 76.0 77.0 75.0 93.0 77.0 07:24:21 INFO - PROCESS | 29761 | 07:24:21 INFO - PROCESS | 29761 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:85.00 stddev:15.54 (18.3%) stddev-sans-first:15.89 07:24:21 INFO - PROCESS | 29761 | Values: 84.0 85.0 121.0 84.0 85.0 86.0 113.0 86.0 95.0 119.0 07:24:21 INFO - PROCESS | 29761 | 07:24:21 INFO - PROCESS | 29761 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 07:24:21 INFO - PROCESS | 29761 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 118.0 117.0 117.0 07:24:21 INFO - PROCESS | 29761 | 07:24:21 INFO - PROCESS | 29761 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 07:24:21 INFO - PROCESS | 29761 | Values: 150.0 149.0 149.0 149.0 149.0 150.0 148.0 149.0 149.0 149.0 07:24:21 INFO - PROCESS | 29761 | 07:24:21 INFO - PROCESS | 29761 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:24:21 INFO - PROCESS | 29761 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 07:24:21 INFO - PROCESS | 29761 | 07:24:21 INFO - PROCESS | 29761 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:60.00 stddev:3.31 (5.5%) stddev-sans-first:3.37 07:24:21 INFO - PROCESS | 29761 | Values: 58.0 67.0 58.0 59.0 66.0 59.0 59.0 61.0 58.0 61.0 07:24:21 INFO - PROCESS | 29761 | 07:24:21 INFO - PROCESS | 29761 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:1.42 (2.1%) stddev-sans-first:1.50 07:24:21 INFO - PROCESS | 29761 | Values: 67.0 67.0 71.0 67.0 67.0 67.0 66.0 68.0 66.0 67.0 07:24:21 INFO - PROCESS | 29761 | 07:24:21 INFO - PROCESS | 29761 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.00 stddev:1.66 (1.9%) stddev-sans-first:1.73 07:24:21 INFO - PROCESS | 29761 | Values: 85.0 85.0 84.0 85.0 86.0 86.0 86.0 87.0 85.0 90.0 07:24:21 INFO - PROCESS | 29761 | 07:24:21 INFO - PROCESS | 29761 | [#11] stanford-crypto-ccm Cycles:10 Average:140.60 Median:135.50 stddev:14.35 (10.6%) stddev-sans-first:15.09 07:24:21 INFO - PROCESS | 29761 | Values: 146.0 137.0 133.0 134.0 131.0 131.0 130.0 132.0 171.0 161.0 07:24:21 INFO - PROCESS | 29761 | 07:24:21 INFO - PROCESS | 29761 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.50 Median:178.00 stddev:4.09 (2.3%) stddev-sans-first:4.33 07:24:21 INFO - PROCESS | 29761 | Values: 178.0 175.0 175.0 186.0 177.0 183.0 174.0 178.0 176.0 183.0 07:24:21 INFO - PROCESS | 29761 | 07:24:21 INFO - PROCESS | 29761 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 07:24:21 INFO - PROCESS | 29761 | Values: 69.0 68.0 68.0 69.0 70.0 69.0 68.0 68.0 67.0 69.0 07:24:21 INFO - PROCESS | 29761 | -------- Summary: end -------- 07:24:21 INFO - PROCESS | 29761 | 07:24:22 INFO - TEST-INFO | 29761: exit 0 07:24:22 INFO - TEST-OK | kraken | took 63803ms 07:24:22 INFO - SUITE-END | took 1186s 07:24:23 INFO - Completed test suite (00:19:46) 07:24:23 INFO - javascript benchmark 07:24:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2633.6049592561117, 2651.0456235755137, 2685.1139124089054, 2689.7713694335966, 2692.919212423628, 4704.741239231841, 4752.358431611731, 4788.760561971896, 4835.854924352267, 4867.756612169391, 4802.663813533054, 4819.421669399668, 4821.325014497965, 4853.951460485394, 4899.779509922053, 4359.2371335016405, 4377.124575084979, 4423.911521769563, 4466.665000124987, 4566.429196350457, 4094.877153685394, 4427.358033085201, 4491.438570178728, 4521.457425108975, 4567.862964111082, 4306.5262821089655, 4347.7826108694435, 4413.227685155117, 4414.293713005935, 4474.217012022899, 4349.108432771274, 4358.433403657536, 4405.163019026407, 4428.933565996513, 4487.640988720895, 4404.955950440519, 4408.382826404306, 4412.470503539564, 4425.982024134467, 4454.398656181406, 4771.379720636295, 4788.11419887322, 4804.831830885937, 4814.3019262207135, 4835.830745923876, 5044.949550504484, 5045.268436076748, 5113.539781419653, 5142.845714628567, 5154.561862241714, 5198.324217851693, 5205.7917683293, 5219.0, 5245.26566280721, 5261.0, 4842.128416884994, 4850.902981940377, 4853.95146048542, 4867.61059115277, 4894.853154405374, 5186.481351864783, 5201.739913004335, 5233.0, 5254.842354729364, 5315.548178404879, 5070.923936140961, 5074.797008119634, 5078.619103567247, 5123.410807757081, 5123.820666276662, 5039.496050395004, 5078.339815823919, 5159.613029022838, 5171.043356978971, 5207.479252074838, 5050.974745126251, 5100.974495127501, 5101.158308879068, 5101.234814777738, 5104.719240441811, 5089.262057001714, 5100.719460429637, 5102.08162530748, 5109.6678715883345, 5113.411957624847, 4375.759333236639, 4392.1874453226255, 4396.648268138605, 4429.778511074498, 4444.799984000728, 3809.3143234218105, 3811.5045044144085, 3816.9427458588143, 3843.55799083109, 3852.2295540891932, 4352.499462561783, 4383.824647014084, 4497.539007233509, 4500.774961251925, 4563.498015218323, 5083.491650834887, 5147.948520514747, 5150.356205474316, 5159.355080614923, 5213.817516386908, 4441.622462090694, 4443.089166720814, 4443.666724995638, 4448.822047118144, 4487.955120448753, 4543.727376357429, 4544.295634176708, 4616.792244349012, 4625.121226966866, 4668.1130585189385, 4804.495527969513, 4804.8318308859025, 4832.782524786463, 4844.8304309349005, 4896.167651499182, 5173.1722924331925, 5179.637425380187, 5180.171172612364, 5182.404023537341, 5186.4035635902355, 4854.927176092432, 4859.611231101433, 4860.927086093782, 4896.265560165861, 4900.191468407673, 4968.503149685002, 4989.575886049726, 4992.201247800334, 5049.2426136079885, 5060.468650791614, 5072.923906141485, 5122.718250496258, 5124.180131178993, 5124.385073791169, 5125.205593133071, 4919.237518184687, 4964.553190212898, 4965.0, 4966.354373931365, 4967.975160124176, 4968.55283024515, 4969.3291405659775, 4971.776270067928, 4973.254011898244, 4978.4025916890205, 4915.729634870117, 4932.112219800327, 4933.186024305949, 4933.333999909966, 4944.381952255968, 5017.648764586444, 5020.673656212481, 5026.798928042837, 5031.6729412588065, 5034.823781167642, 4910.680805747615, 4918.2376731606655, 4924.901501970012, 4970.478099799614, 4970.751462426936], "value": 4718.890147793906, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.64383287865616, 510.8416390918815, 515.1165750737484, 529.3462573721455, 546.1398297681153, 31876.20309492264, 32965.67034329656, 32985.67014329853, 39157.0, 40613.796931015306, 41848.37227441583, 42346.57653423465, 42388.0, 42392.576074239245, 42453.15093698124, 7563.470557060994, 7724.266194711521, 7726.613669316512, 7733.0, 7736.535807851547, 7492.0, 7583.355414789749, 7690.423218258625, 7692.3076923076915, 9703.175230105415, 9676.371035882645, 10052.89947100527, 10053.0, 10056.849147262797, 10057.396556206615, 9940.105390514853, 10025.298229123964, 10026.197904167722, 10028.49857507129, 10030.799384012278, 9788.657396991071, 9847.359921605144, 9851.113399794052, 9859.30984831062, 9862.0, 38150.23699526022, 38446.23107537834, 38463.423048654295, 38512.422313665316, 38563.61436385656, 3247.561579186803, 3290.226796702773, 3309.3712194682935, 3337.9666203337897, 3366.3603915256267, 28215.0, 28288.0, 28968.42063158746, 28974.710252897414, 29089.272768180752, 3105.021918095815, 3136.7333776629016, 3209.1174926895055, 3257.641659417462, 3375.932481350384, 258765.0, 258881.0, 259035.0, 259131.0, 259383.0, 53743.0, 53981.73009135008, 54118.458815411344, 54227.0, 54289.72855135699, 56494.717526412926, 56567.151492727644, 56696.43303566994, 56873.14690279649, 56876.0, 12515.436805343781, 12927.741445171045, 12927.935360323327, 12934.935325323313, 12939.676508087185, 9675.90324096764, 9796.314258002014, 9799.804003919882, 9804.313698041211, 9805.607775689035, 14068.171137752232, 14429.20639364845, 14454.566363009126, 14950.626234344229, 14954.0, 5870.295564532198, 6222.253329600477, 6271.4669253114, 6308.968455157695, 6315.400036996478, 764.7743915544817, 776.9184235655288, 788.7239466186788, 805.5086397297644, 806.6571707024491, 25940.87029564878, 26160.0, 26372.60441093385, 26430.339241519116, 26678.866605666848, 914.5244472874068, 923.6628630549801, 928.7863791327898, 968.1431932739576, 969.0842154164388, 13085.149465284916, 13136.802947955788, 13188.406521706545, 13333.733325333438, 14354.210518421378, 348568.0, 350814.0, 353752.0, 354794.0, 356558.0, 35752.10619734476, 35769.1057723559, 35801.64198357983, 35819.4627080594, 35865.46201806923, 1236.3014896583402, 1249.9937500312622, 1255.4852510470846, 1259.3010878962264, 1271.5740227023866, 22170.224042158447, 24021.0, 24034.46714725687, 25284.747152528238, 25382.61926071147, 36208.63791362053, 36314.63685363113, 36330.818345908105, 36404.63595364012, 36458.0, 298982.0, 299811.0, 300912.0, 301253.0, 302860.0, 22803.54392912099, 23121.190758323377, 23195.53608927846, 23221.0, 23222.187223447097, 35629.82185089162, 36248.27503449969, 36303.455448168825, 36796.63203367932, 36883.0, 29405.558916616697, 30624.234394140323, 30953.0, 31049.0, 31975.0, 29946.850265748533, 30047.849760751058, 30382.240443988194, 30411.54382684217, 31756.523652145697, 30233.395332092794, 30657.693423066376, 30812.53781193239, 30967.225819353796, 31128.377432451678, 25810.0, 27895.302617434725, 27953.0, 27970.300742481602, 28185.43629127447, 21814.345569632937, 22020.33938981833, 22116.778832211472, 22156.667649985586, 22241.110355585595], "value": 16589.41762320093, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.2176229651322, 357.9821008949552, 364.2223852075818, 367.35686733949245, 386.7486134012891, 13577.52478663247, 17018.5745356366, 17481.562960925985, 17823.37618183364, 17930.731039034425, 16965.15174241289, 17025.233864476097, 17059.317627294924, 17138.742918856195, 17212.569685757862, 4823.541763532458, 5165.81919632813, 5203.739813009353, 5205.16717325228, 5217.686938783685, 3875.5155605549307, 4044.9797751011206, 5034.496550344955, 5126.333576635032, 5802.506786923117, 6045.214122164112, 6118.143459915593, 6145.2625684917875, 6154.076888466743, 6169.259688837324, 5914.378990206031, 5979.671118088503, 6012.669303188323, 6033.396660333975, 6128.448439640431, 5294.761735721863, 5296.020236256305, 5299.867503312448, 5300.708461034642, 5303.549198318147, 20775.79224207769, 21069.683954740693, 21192.576148476943, 21275.680864787042, 21375.144994200215, 2301.689271948299, 2349.036894873094, 2361.5276944610973, 2364.9408764780846, 2445.095314733542, 12831.550895718605, 13322.333883305893, 13424.731505369838, 13817.240051797147, 13964.371603277878, 1700.4388551777884, 1739.356438117892, 1764.7264673975426, 1765.1350838089372, 1796.616605213978, 60823.695881520754, 72530.0, 74029.62985185093, 74686.99999999946, 75468.24531754667, 9242.907570924339, 9580.425174489554, 9625.759356016155, 9762.46306453152, 9958.651447199458, 13072.673183170307, 13107.868921310665, 13109.27898965566, 13308.401121949535, 13422.328883555978, 6662.600243985376, 6842.623655698984, 6940.826479338057, 7016.228214896358, 7033.542819716702, 6420.903686444707, 6421.3899679531305, 6503.25212600557, 6560.540762146699, 6616.239132499728, 6245.156903818017, 6297.905531417033, 6351.618902865843, 6376.904346434807, 6423.454006409507, 1677.8406051425095, 1701.4555342290596, 1717.107104305754, 1722.422988298934, 1723.1901006526912, 903.6520939438232, 916.2944532709777, 929.5305870535336, 930.3069213436033, 932.7434955387187, 16964.406245781338, 17607.0, 17642.38251661186, 18091.909540452478, 18097.0, 888.4669198480989, 897.2059727141527, 900.3247564326755, 910.644848509082, 911.252772726358, 9470.384425012353, 10041.698749037541, 10185.541650625739, 10228.10414250669, 10283.794324113476, 500323.0, 504803.0, 507962.0, 517913.0, 521045.0, 79302.20697793063, 80765.0, 81276.0, 83014.58492707497, 83983.0, 939.3377668743519, 944.9811003780023, 966.4491239993278, 967.3857100740939, 976.584951395654, 15107.54677359681, 15107.697846043238, 15654.608634784221, 15713.528594142193, 15916.0450372978, 36351.63648363482, 36435.27129457449, 37535.43696844604, 37827.810860945516, 38076.428853566664, 47858.76070619764, 47913.52086479091, 47918.926891214636, 47981.52018479771, 50125.49874501208, 5677.68772717488, 7499.1750907399055, 7509.136449308399, 7635.847283054197, 7796.025496812898, 12126.090543209471, 12290.631281061582, 12314.753704925672, 12374.381280936097, 12494.625161245178, 9435.198008169382, 10076.445795481319, 10350.430726310125, 10452.425116618659, 10869.402182880018, 10244.180465562886, 10706.250562460553, 10766.138708903425, 10795.946020270163, 10818.404987725751, 9807.950960245438, 9848.753781155528, 10090.54592543352, 10324.174066074846, 10714.14286857034, 7412.481126321106, 7428.814279643052, 7445.478816482794, 7485.812854678677, 7853.332466740391, 7961.323287520626, 10190.235732319958, 10196.796064078528, 10253.743656408351, 10469.633562825264], "value": 8521.931739529511, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1141.7374003979085, 1148.609472779255, 1153.4521102476324, 1164.6156768266474, 1197.3893314409652, 5978.043513037915, 6582.0, 6877.105976223084, 6892.069570607967, 6993.580385176881, 6054.334023257438, 6203.906941395871, 6276.246850377961, 6280.120783090371, 6559.8360040999, 2005.4184286556917, 2066.0599427260636, 2068.4725395024248, 2074.2532688232222, 2078.3141563284157, 1993.7607487101568, 2079.688046792978, 2080.0, 2081.1363284237023, 2085.9269925552608, 1830.7894592121943, 1904.5714714189335, 2051.866628669132, 2071.6167509010806, 2072.8030837070455, 1891.1962415973226, 1955.892425916574, 1964.6856502959458, 1975.190172029461, 1978.0307649251906, 2041.428400047974, 2078.420400495619, 2079.6984437256665, 2079.7088407622946, 2086.613976414353, 6880.139982502187, 7009.983552384927, 7010.579365238051, 7022.683979220948, 7028.086348774677, 4279.87160385189, 4372.453443319585, 4392.648588112943, 4398.626116780046, 4403.53762854902, 2573.3437973316873, 2697.5549034409496, 2746.093789049609, 2753.3804893898914, 2755.5728862026417, 926.4117285523673, 969.1277849935044, 1011.0, 1017.7811770469384, 1033.6950599573145, 8778.078301778285, 8788.51663158526, 8837.779055523599, 8897.866532002025, 9007.909920900773, 3680.9079773005888, 3825.273198092409, 3859.054531639766, 3936.8622098226424, 3987.7407968481957, 7843.294103530596, 7861.685532578633, 7897.565633890191, 7905.525668459911, 7943.4836735612, 4195.202911446815, 4263.16868210696, 4263.722858014219, 4263.786810659454, 4405.493368262627, 3804.2011177653003, 3911.0808959894403, 3916.099297161612, 3924.823382947774, 3933.6853051755793, 3405.7105146062368, 3422.6748458896363, 3474.444088945807, 3481.1819222482695, 3487.7907325560545, 1094.9397783122006, 1128.418864284894, 1133.3539882267194, 1142.3374442823308, 1145.2441388683428, 659.5844617890698, 697.6755808549049, 803.9276465118168, 840.0759164918663, 842.0022273605797, 4578.748168850679, 4626.976865115653, 4650.86047418578, 4771.498992605796, 4848.188295444906, 496.07234471538453, 506.4656787089582, 507.7918053598007, 512.5566385076881, 574.8534123798405, 3334.416477116495, 3470.5661792275964, 3482.669146431085, 3515.8945231643092, 3526.4181410067563, 8087.3125784308995, 8143.267105960374, 8250.0, 8258.710945116893, 8278.71024514139, 7800.492967957065, 8212.384071194565, 8214.342852571779, 8219.8356032879, 8232.876506852403, 6554.901676474857, 6588.143541339595, 6589.86820263592, 6591.802245932726, 6603.603783772893, 4852.951470485391, 4877.731724755031, 4964.05682920244, 4992.126377883783, 5165.974170129125, 7395.18652948186, 7521.172671006294, 7559.773206803805, 7564.394848412004, 7592.696292148473, 7574.583397913168, 7614.314711675976, 7625.466217364731, 7629.961850190713, 7653.88519172224, 6168.691565421801, 6234.812955611339, 6235.75056997715, 6238.4073513018, 6246.750129994749, 6574.605523668595, 6611.438027767694, 6666.566673166229, 6668.566543174678, 6670.299618540177, 4921.9507804921495, 6023.3073196582955, 6058.0610005449225, 6104.603200791934, 6213.2233470816145, 5886.646801191942, 5993.280806303272, 5999.280086389661, 6093.6039157454625, 6128.66292353907, 5560.638558493685, 5565.0817615094675, 5565.55475561946, 5579.051561234681, 5580.135079062752, 3903.687704983651, 4031.2945234583244, 4108.424820525189, 4109.054917368962, 4283.828646854091, 4146.4036346006405, 4250.638695710899, 4318.913621727485, 4367.257566213815, 4421.579949904753], "value": 3697.5211272994375, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.9913502162446, 349.8062687661648, 354.6985062696708, 355.41001936784943, 356.11327793793464, 4872.3909511311085, 4879.3656824612835, 4880.560749532541, 4892.850180207653, 4904.817356276459, 4814.975925120379, 4828.637852161084, 4833.806647734086, 4834.540718631724, 4850.660453768229, 3452.482127680843, 3719.5822715235176, 3795.430685397185, 3901.210634396406, 3942.7831469269177, 3877.263319969197, 3886.5919078496777, 3889.9691581730863, 3895.2599006188875, 3899.824507897137, 3839.3281175794264, 3868.729188956774, 3881.1849511602454, 3890.144168282973, 3897.3179693553516, 3688.3176612326806, 3735.906602334936, 3775.962240377616, 3844.2503711776217, 3879.612038796126, 3480.3561341151717, 3494.877679281238, 3502.807345595991, 3502.8248587570774, 3508.2808024354945, 4746.335513028179, 4748.406449193851, 4755.619550435957, 4757.500462451462, 4773.856784296477, 4316.007318316773, 4446.644268458515, 4474.239379305526, 4481.274709236967, 4498.145352383037, 5045.495450454961, 5077.771500282496, 5079.615607456109, 5096.362954630671, 5102.744862756847, 3765.510483637137, 3770.3213421584105, 3772.2078363543687, 3780.865740277933, 3800.809959502014, 5084.288199652088, 5230.110881150214, 5345.251664766935, 5354.143337066051, 5354.223637572569, 3826.7563042011457, 3888.261230366278, 3898.8440462381186, 3918.1575961168487, 3942.1327307992196, 3963.4847469828737, 3977.1449138435373, 3985.4021896715726, 3990.5610382857863, 4011.478507793968, 4449.621782148553, 4456.774387043524, 4461.442319710036, 4464.1071785643, 4488.708233964782, 4919.77860996256, 5071.54356107952, 5072.568831649277, 5087.821926232564, 5095.1847704367865, 1338.0900987328516, 1343.8185844911006, 1345.2533843716635, 1357.4230951845623, 1362.7410791949499, 897.6364572348078, 958.1903291718487, 960.6877764726491, 969.5588507229194, 971.4656938683837, 4320.935185972213, 4321.762303073361, 4357.411749413852, 4368.475782906072, 4373.278409062533, 5109.0, 5133.922991155136, 5137.383513978347, 5141.357330333708, 5189.273501709764, 4183.644390226804, 4360.890977725582, 4389.62688171509, 4394.2749446340995, 4422.977885110554, 2661.0, 2687.6640419947507, 2688.4407043914484, 2709.5122877881777, 2709.6071069695176, 4757.3577567028005, 4766.428028636586, 4777.880552986134, 4789.928151077736, 4797.784099715521, 5033.295338652591, 5112.9744351278005, 5191.273221748958, 5202.635815492955, 5242.9213561796605, 4667.953320466752, 4740.155906456168, 4749.287606858929, 4763.4522029967, 4782.976085119552, 5064.797408103635, 5087.287779710769, 5106.0, 5124.846909445345, 5128.666636668605, 4870.293807397837, 5005.4744251853035, 5010.49895010496, 5014.4484106747495, 5039.924401134059, 4730.385049943623, 4730.503297153749, 4769.332293478985, 4793.880152996064, 4843.854684359475, 3899.3176194166476, 3924.430957511202, 3980.164165525272, 3981.3231750603045, 3989.660878825216, 5256.159014557652, 5262.0, 5266.73666316675, 5269.657472264291, 5284.309021113207, 4888.5111488850835, 5014.222795466709, 5049.480714760342, 5088.414832294334, 5090.974545127251, 5039.672421292605, 5045.142325804549, 5051.141305977919, 5066.31604733371, 5066.847994560169, 4989.850304490871, 5005.499450054966, 5009.073321435546, 5031.672941258953, 5031.949680503149, 4895.534924182197, 5068.923966140437, 5079.136546787129, 5081.517255860687, 5098.419489958125, 4943.703377797344, 4960.528749768766, 4964.808445972868, 4972.2790195422185, 4975.751212439436], "value": 3873.573623636377, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.7924803686841, 675.392147067639, 694.7394726977384, 699.2902204262671, 706.0961968680089, 12935.288559129243, 14133.434662613508, 14151.221682807454, 14157.079789813668, 14160.71678566428, 13246.867531324708, 13356.398962046707, 13365.665858353546, 13400.0, 13474.5283915063, 658.1049772309655, 679.6465837764359, 781.5467029123123, 789.7314912929588, 798.8641930871737, 809.9473534220257, 810.3395732478041, 810.5096416667919, 811.3387589114852, 813.8535063688533, 857.2242120880613, 865.0830120072711, 866.3199388480012, 866.4627930682985, 866.5753780647469, 692.9272426395231, 710.1159056974101, 823.4606332851992, 843.5824266987819, 862.7239283429305, 623.0311865049846, 623.507429130986, 623.9251289845248, 624.048326302388, 624.54720327762, 13316.667083322898, 13578.864211357859, 13618.046736728433, 13619.455221791117, 13632.113912595649, 12849.35753212345, 13309.800352994713, 13319.933400333033, 13327.800082998763, 13355.19868807865, 11735.413229338585, 11806.350650714206, 11822.290662560188, 12047.91568758807, 12420.503179872794, 4075.9388609170887, 4217.5993280638595, 4311.051568654891, 4327.37253098299, 4331.155424692186, 59051.0, 60076.39923600752, 60390.39609603935, 61179.38820611826, 62109.0, 10471.172783348453, 10542.314749541256, 10567.418791966516, 10666.839997400046, 10876.129909607213, 20146.597068058556, 20164.29424970119, 20169.798302017087, 20185.596288074157, 20192.39422817318, 6520.380563846427, 6636.83407914806, 6670.833229169212, 6751.864962700718, 6870.793876183722, 3548.609652938175, 3647.398179300386, 3651.94522082169, 3670.1742108026015, 3680.35593771089, 2798.0626490126037, 2832.702566230516, 2846.6157068795446, 2863.498887694645, 2886.870090845917, 477.36748807829764, 488.66282265236873, 528.9523942845085, 558.8826346467288, 570.597728601335, 637.1366797988751, 658.2495954611651, 664.6262344119817, 664.9035889796049, 672.2403683837233, 9135.223506001932, 9515.333926625208, 9525.380850244712, 9597.712068637951, 9653.0, 639.7345101782709, 659.8416380068749, 663.3234101216829, 663.717919884057, 667.2393471442559, 4331.7834108294455, 4427.512973572904, 4606.976965115153, 4619.076184762994, 4625.722456652545, 64416.35583644197, 67855.66072169706, 69085.0, 70032.6498367505, 70420.0, 44964.77517612391, 53388.0, 56593.0, 58852.41147588555, 58913.0, 51852.0, 52854.20718689223, 53491.465085348646, 54323.18515222354, 54806.0, 8457.281131103678, 8564.957175214084, 8651.394402391772, 8667.696630617898, 8849.823003540021, 35565.46651800173, 35685.28629427449, 36440.088997774204, 36729.44905826361, 36862.44706329353, 32895.506567401986, 44809.327860081474, 45051.549484504736, 46437.195350581176, 48056.5194348066, 10079.949600251952, 10323.690289291333, 10365.844512332473, 10543.736406589896, 10589.788204236027, 11626.186166968231, 11703.0, 11735.0, 11824.46789894474, 12038.638840834788, 10746.731331716457, 11052.447377631248, 11055.778884422105, 11086.889131108908, 11142.83285750698, 9599.568019439283, 9671.564779584794, 9862.408255504693, 10240.795184096127, 10624.521896514521, 11849.822252666045, 11996.400179990791, 12166.330851803235, 12299.44652490658, 12727.554535591209, 10018.499075046364, 10414.427206503715, 10422.947885260524, 10490.737731556772, 10838.729031774268, 9958.799410851514, 9958.800823983334, 10204.336718113298, 10305.845412318971, 10776.784464310827], "value": 6432.045654762798, "unit": "score"}], "name": "dromaeo_css", "value": 6282.107338195148, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 118.0, 114.0, 116.0, 114.0, 115.0, 115.0, 114.0, 113.0, 113.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 127.0, 131.0, 168.0, 131.0, 129.0, 126.0, 127.0, 153.0, 123.0], "value": 136.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 163.0, 162.0, 162.0, 162.0, 161.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 111.0, 76.0, 76.0, 77.0, 75.0, 93.0, 77.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 121.0, 84.0, 85.0, 86.0, 113.0, 86.0, 95.0, 119.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 149.0, 149.0, 149.0, 150.0, 148.0, 149.0, 149.0, 149.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 67.0, 58.0, 59.0, 66.0, 59.0, 59.0, 61.0, 58.0, 61.0], "value": 60.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 71.0, 67.0, 67.0, 67.0, 66.0, 68.0, 66.0, 67.0], "value": 67.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 86.0, 86.0, 86.0, 87.0, 85.0, 90.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 137.0, 133.0, 134.0, 131.0, 131.0, 130.0, 132.0, 171.0, 161.0], "value": 140.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 175.0, 175.0, 186.0, 177.0, 183.0, 174.0, 178.0, 176.0, 183.0], "value": 178.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 69.0, 70.0, 69.0, 68.0, 68.0, 67.0, 69.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1552.6000000000001, "alertThreshold": 2.0}]} 07:24:23 INFO - Return code: 0 07:24:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:24:23 INFO - # TBPL SUCCESS # 07:24:23 INFO - Running post-action listener: _resource_record_post_action 07:24:23 INFO - [mozharness: 2017-01-09 15:24:23.407799Z] Finished run-tests step (success) 07:24:23 INFO - Running post-run listener: _resource_record_post_run 07:24:23 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 382377984; Read time: 12; Write time: 273240 07:24:23 INFO - TinderboxPrint: CPU usage
13.1% 07:24:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:24:23 INFO - TinderboxPrint: I/O write bytes / time
382,377,984 / 273,240 07:24:23 INFO - TinderboxPrint: CPU idle
8,343.6 (86.9%) 07:24:23 INFO - TinderboxPrint: CPU user
1,213.1 (12.6%) 07:24:23 INFO - TinderboxPrint: Swap in / out
0 / 0 07:24:23 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99958784; Read time: 0; Write time: 79712 07:24:23 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 282419200; Read time: 0; Write time: 193528 07:24:24 INFO - Running post-run listener: _upload_blobber_files 07:24:24 INFO - Blob upload gear active. 07:24:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:24:24 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 07:24:24 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:24:24 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:24:24 INFO - (blobuploader) - INFO - Open directory for files ... 07:24:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:24:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:24:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:25 INFO - (blobuploader) - INFO - Done attempting. 07:24:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:24:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:24:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:25 INFO - (blobuploader) - INFO - Done attempting. 07:24:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:24:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:24:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:26 INFO - (blobuploader) - INFO - Done attempting. 07:24:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:24:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:24:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:31 INFO - (blobuploader) - INFO - Done attempting. 07:24:31 INFO - (blobuploader) - INFO - Iteration through files over. 07:24:31 INFO - Return code: 0 07:24:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:24:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:24:31 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/67d59f04e8764f230a826c135097d01b0eb1cde08a3174d8983f5bef994e5f066a028731f1eb980312f2d7322066edd9e23aab7948b943a176e42299b98fa9d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd89620a6ddb1b344a943d6133f7bd76bdd09ff616685253e50191c2e644f2feb746786aa69a906fea1e73e55ae188529421ff120d7809d8aea73d94eef22e09", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bec14038f213f68b4b316fe8192cb20a5c6b8c5314ef7e0f999a3d923378eced63ec0d7d58ba60fee372f9c8ac77faca4d35ab529c5b985fa87ba89dffbd1401", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f531f9aa8ba4b50db69812fdcaa9211117dec9a0b3086bdacb44342de22251e0dc3c786530c3c62d5bea6114ff2469231bf42d67036bedb64215d57ef51f740a"} 07:24:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:24:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:24:31 INFO - Contents: 07:24:31 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/67d59f04e8764f230a826c135097d01b0eb1cde08a3174d8983f5bef994e5f066a028731f1eb980312f2d7322066edd9e23aab7948b943a176e42299b98fa9d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd89620a6ddb1b344a943d6133f7bd76bdd09ff616685253e50191c2e644f2feb746786aa69a906fea1e73e55ae188529421ff120d7809d8aea73d94eef22e09", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bec14038f213f68b4b316fe8192cb20a5c6b8c5314ef7e0f999a3d923378eced63ec0d7d58ba60fee372f9c8ac77faca4d35ab529c5b985fa87ba89dffbd1401", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f531f9aa8ba4b50db69812fdcaa9211117dec9a0b3086bdacb44342de22251e0dc3c786530c3c62d5bea6114ff2469231bf42d67036bedb64215d57ef51f740a"} 07:24:31 INFO - Running post-run listener: copy_logs_to_upload_dir 07:24:31 INFO - Copying logs to upload dir... 07:24:31 INFO - mkdir: /builds/slave/test/build/upload/logs 07:24:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.940379 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-01-09 07:24:30.270757) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 07:24:30.274588) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/67d59f04e8764f230a826c135097d01b0eb1cde08a3174d8983f5bef994e5f066a028731f1eb980312f2d7322066edd9e23aab7948b943a176e42299b98fa9d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd89620a6ddb1b344a943d6133f7bd76bdd09ff616685253e50191c2e644f2feb746786aa69a906fea1e73e55ae188529421ff120d7809d8aea73d94eef22e09", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bec14038f213f68b4b316fe8192cb20a5c6b8c5314ef7e0f999a3d923378eced63ec0d7d58ba60fee372f9c8ac77faca4d35ab529c5b985fa87ba89dffbd1401", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f531f9aa8ba4b50db69812fdcaa9211117dec9a0b3086bdacb44342de22251e0dc3c786530c3c62d5bea6114ff2469231bf42d67036bedb64215d57ef51f740a"} build_url:https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011273 build_url: 'https://queue.taskcluster.net/v1/task/eBoj-SJiSrScToruqlPnAg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/67d59f04e8764f230a826c135097d01b0eb1cde08a3174d8983f5bef994e5f066a028731f1eb980312f2d7322066edd9e23aab7948b943a176e42299b98fa9d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd89620a6ddb1b344a943d6133f7bd76bdd09ff616685253e50191c2e644f2feb746786aa69a906fea1e73e55ae188529421ff120d7809d8aea73d94eef22e09", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bec14038f213f68b4b316fe8192cb20a5c6b8c5314ef7e0f999a3d923378eced63ec0d7d58ba60fee372f9c8ac77faca4d35ab529c5b985fa87ba89dffbd1401", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f531f9aa8ba4b50db69812fdcaa9211117dec9a0b3086bdacb44342de22251e0dc3c786530c3c62d5bea6114ff2469231bf42d67036bedb64215d57ef51f740a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 07:24:30.302751) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 07:24:30.303084) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1483969444.559605-215537638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 07:24:30.388092) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 07:24:30.388442) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 07:24:30.388751) ========= ========= Total master_lag: 0.18 =========