builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-011 starttime: 1491815865.79 results: success (0) revision: ef9f29a17da06dda0a3a7660ea556ac068f16ad4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 02:17:45.787296) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 02:17:45.787776) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 02:17:45.788097) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 02:17:45.808625) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-10 02:17:45.808934) ========= 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=5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-10 02:17:45-- 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% 58.0M=0s 2017-04-10 02:17:47 (58.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.271332 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-10 02:17:47.094706) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 02:17:47.095092) ========= 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=5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018144 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 02:17:47.147788) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 19 secs) (at 2017-04-10 02:17:47.148585) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ef9f29a17da06dda0a3a7660ea556ac068f16ad4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ef9f29a17da06dda0a3a7660ea556ac068f16ad4 --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=5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-10 02:17:47,373 truncating revision to first 12 chars 2017-04-10 02:17:47,373 Setting DEBUG logging. 2017-04-10 02:17:47,373 attempt 1/10 2017-04-10 02:17:47,373 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ef9f29a17da0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-10 02:17:53,641 unpacking tar archive at: mozilla-aurora-ef9f29a17da0/testing/mozharness/ program finished with exit code 0 elapsedTime=19.296976 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 19 secs) (at 2017-04-10 02:18:06.461007) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 02:18:06.461434) ========= script_repo_revision: ef9f29a17da06dda0a3a7660ea556ac068f16ad4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 02:18:06.461931) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 02:18:06.462261) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 02:18:06.471877) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 37 secs) (at 2017-04-10 02:18:06.472253) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-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=5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:18:06 INFO - MultiFileLogger online at 20170410 02:18:06 in /builds/slave/test 02:18:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 02:18:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:18:06 INFO - {'append_to_log': False, 02:18:06 INFO - 'base_work_dir': '/builds/slave/test', 02:18:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 02:18:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:18:06 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 02:18:06 INFO - 'buildbot_json_path': 'buildprops.json', 02:18:06 INFO - 'config_files': ('talos/linux_config.py',), 02:18:06 INFO - 'default_actions': ('clobber', 02:18:06 INFO - 'read-buildbot-config', 02:18:06 INFO - 'download-and-extract', 02:18:06 INFO - 'populate-webroot', 02:18:06 INFO - 'create-virtualenv', 02:18:06 INFO - 'install', 02:18:06 INFO - 'run-tests'), 02:18:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:18:06 INFO - 'download_minidump_stackwalk': True, 02:18:06 INFO - 'download_symbols': 'ondemand', 02:18:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:18:06 INFO - 'tooltool.py': '/tools/tooltool.py', 02:18:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:18:06 INFO - '/tools/misc-python/virtualenv.py')}, 02:18:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:18:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:18:06 INFO - 'gecko_profile': False, 02:18:06 INFO - 'gecko_profile_interval': 0, 02:18:06 INFO - 'installer_path': 'installer.exe', 02:18:06 INFO - 'log_level': 'info', 02:18:06 INFO - 'log_name': 'talos', 02:18:06 INFO - 'log_to_console': True, 02:18:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:18:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:18:06 INFO - 'opt_config_files': (), 02:18:06 INFO - 'pip_index': False, 02:18:06 INFO - 'suite': 'dromaeojs-e10s', 02:18:06 INFO - 'system_bits': '32', 02:18:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:18:06 INFO - 'title': 'talos-linux64-ix-011', 02:18:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:18:06 INFO - 'use_talos_json': True, 02:18:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:18:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:18:06 INFO - 'work_dir': 'build'} 02:18:06 INFO - [mozharness: 2017-04-10 09:18:06.798266Z] Running clobber step. 02:18:06 INFO - Running pre-action listener: _resource_record_pre_action 02:18:06 INFO - Running main action method: clobber 02:18:06 INFO - rmtree: /builds/slave/test/build 02:18:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:18:08 INFO - Running post-action listener: _resource_record_post_action 02:18:08 INFO - [mozharness: 2017-04-10 09:18:08.245743Z] Finished clobber step (success) 02:18:08 INFO - [mozharness: 2017-04-10 09:18:08.245841Z] Running read-buildbot-config step. 02:18:08 INFO - Running pre-action listener: _resource_record_pre_action 02:18:08 INFO - Running main action method: read_buildbot_config 02:18:08 INFO - Using buildbot properties: 02:18:08 INFO - { 02:18:08 INFO - "project": "", 02:18:08 INFO - "product": "firefox", 02:18:08 INFO - "who": "jyavenard@mozilla.com", 02:18:08 INFO - "installer_path": "public/build/target.tar.bz2", 02:18:08 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 02:18:08 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 02:18:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs-e10s", 02:18:08 INFO - "stage_platform": "linux64", 02:18:08 INFO - "basedir": "/builds/slave/test", 02:18:08 INFO - "buildnumber": 107, 02:18:08 INFO - "platform": "ubuntu64_hw", 02:18:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:18:08 INFO - "slavebuilddir": "test", 02:18:08 INFO - "taskId": "dKibp9CpSO6k4aLQKgPEQQ", 02:18:08 INFO - "branch": "mozilla-aurora", 02:18:08 INFO - "script_repo_revision": "production", 02:18:08 INFO - "revision": "ef9f29a17da06dda0a3a7660ea556ac068f16ad4", 02:18:08 INFO - "slavename": "talos-linux64-ix-011", 02:18:08 INFO - "repo_path": "releases/mozilla-aurora" 02:18:08 INFO - } 02:18:08 INFO - Finding installer, test and symbols from parent task. 02:18:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dKibp9CpSO6k4aLQKgPEQQ'}, attempt #1 02:18:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dKibp9CpSO6k4aLQKgPEQQ'}, attempt #1 02:18:11 INFO - Task dependencies: A-PNzku5Szm4d5WhgYlXKQ 02:18:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ'}, attempt #1 02:18:12 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/target.tar.bz2 02:18:12 INFO - Set test_url: https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/test_packages.json 02:18:12 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/target.crashreporter-symbols.zip 02:18:12 INFO - Running post-action listener: _resource_record_post_action 02:18:12 INFO - [mozharness: 2017-04-10 09:18:12.226629Z] Finished read-buildbot-config step (success) 02:18:12 INFO - [mozharness: 2017-04-10 09:18:12.226848Z] Running download-and-extract step. 02:18:12 INFO - Running pre-action listener: _resource_record_pre_action 02:18:12 INFO - Running main action method: download_and_extract 02:18:12 INFO - mkdir: /builds/slave/test/build/tests 02:18: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')]} 02:18:12 INFO - trying https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/target.test_packages.json 02:18:12 INFO - Downloading https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:18:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:18:14 INFO - Downloaded 896 bytes. 02:18:14 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:18:14 INFO - Using the following test package requirements: 02:18:14 INFO - {u'common': [u'target.common.tests.zip'], 02:18:14 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:18:14 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:18:14 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:18:14 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:18:14 INFO - u'mozbase': [u'target.common.tests.zip'], 02:18:14 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:18:14 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:18:14 INFO - u'web-platform': [u'target.common.tests.zip', 02:18:14 INFO - u'target.web-platform.tests.zip'], 02:18:14 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:18:14 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:18:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/target.common.tests.zip 02:18:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:18:14 INFO - Fetch https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/target.common.tests.zip into memory 02:18:46 INFO - Expected file size: 59542117 02:18:46 INFO - Obtained file size: 59542117 02:18:55 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:18:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/target.common.tests.zip 02:18:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:18:55 INFO - Fetch https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/target.common.tests.zip into memory 02:19:00 INFO - Expected file size: 59542117 02:19:00 INFO - Obtained file size: 59542117 02:19:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/target.talos.tests.zip 02:19:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:19:11 INFO - Fetch https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/target.talos.tests.zip into memory 02:19:15 INFO - Expected file size: 14404424 02:19:15 INFO - Obtained file size: 14404424 02:19:16 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')]} 02:19:16 INFO - trying https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/target.tar.bz2 02:19:16 INFO - Downloading https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:19:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:19:20 INFO - Downloaded 66801542 bytes. 02:19:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/target.tar.bz2 02:19:20 INFO - mkdir: /builds/slave/test/properties 02:19:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:19:20 INFO - Writing to file /builds/slave/test/properties/build_url 02:19:20 INFO - Contents: 02:19:20 INFO - build_url:https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/target.tar.bz2 02:19:20 INFO - Running post-action listener: _resource_record_post_action 02:19:20 INFO - Running post-action listener: set_extra_try_arguments 02:19:20 INFO - [mozharness: 2017-04-10 09:19:20.021437Z] Finished download-and-extract step (success) 02:19:20 INFO - [mozharness: 2017-04-10 09:19:20.021534Z] Running populate-webroot step. 02:19:20 INFO - Running pre-action listener: _resource_record_pre_action 02:19:20 INFO - Running main action method: populate_webroot 02:19:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:19:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:19:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:19:20 INFO - '--tppagecycles', 02:19:20 INFO - '7'], 02:19:20 INFO - 'tests': ['tsvgm']}}, 02:19:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:19:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:19:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:19:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:19:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:19:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:19:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:19:20 INFO - 'talos_options': ['--disable-e10s'], 02:19:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:19:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:19:20 INFO - 'talos_options': ['--disable-e10s'], 02:19:20 INFO - 'tests': ['damp', 'tps']}, 02:19:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:19:20 INFO - 'tests': ['damp', 'tps']}, 02:19:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:19:20 INFO - 'tests': ['dromaeo_dom']}, 02:19:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:19:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:19:20 INFO - 'tests': ['basic_compositor_video']}, 02:19:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:19:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:19:20 INFO - 'tests': ['a11yr', 02:19:20 INFO - 'ts_paint', 02:19:20 INFO - 'tpaint', 02:19:20 INFO - 'sessionrestore', 02:19:20 INFO - 'sessionrestore_no_auto_restore', 02:19:20 INFO - 'tabpaint']}, 02:19:20 INFO - 'other-e10s': {'tests': ['a11yr', 02:19:20 INFO - 'ts_paint', 02:19:20 INFO - 'tpaint', 02:19:20 INFO - 'sessionrestore', 02:19:20 INFO - 'sessionrestore_no_auto_restore', 02:19:20 INFO - 'tabpaint']}, 02:19:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:19:20 INFO - 'ts_paint', 02:19:20 INFO - 'tpaint', 02:19:20 INFO - 'sessionrestore', 02:19:20 INFO - 'sessionrestore_no_auto_restore', 02:19:20 INFO - 'tabpaint']}, 02:19:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:19:20 INFO - 'ts_paint', 02:19:20 INFO - 'tpaint', 02:19:20 INFO - 'sessionrestore', 02:19:20 INFO - 'sessionrestore_no_auto_restore', 02:19:20 INFO - 'tabpaint']}, 02:19:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:19:20 INFO - 'tests': ['a11yr', 02:19:20 INFO - 'ts_paint', 02:19:20 INFO - 'tpaint', 02:19:20 INFO - 'sessionrestore', 02:19:20 INFO - 'sessionrestore_no_auto_restore', 02:19:20 INFO - 'tabpaint']}, 02:19:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:19:20 INFO - 'tests': ['a11yr', 02:19:20 INFO - 'ts_paint', 02:19:20 INFO - 'tpaint', 02:19:20 INFO - 'sessionrestore', 02:19:20 INFO - 'sessionrestore_no_auto_restore', 02:19:20 INFO - 'tabpaint']}, 02:19:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:19:20 INFO - 'tests': ['tsvgx', 02:19:20 INFO - 'tsvgr_opacity', 02:19:20 INFO - 'tart', 02:19:20 INFO - 'tscrollx', 02:19:20 INFO - 'cart', 02:19:20 INFO - 'tsvg_static']}, 02:19:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:19:20 INFO - 'tsvgr_opacity', 02:19:20 INFO - 'tart', 02:19:20 INFO - 'tscrollx', 02:19:20 INFO - 'cart', 02:19:20 INFO - 'tsvg_static']}, 02:19:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:19:20 INFO - 'talos_options': ['--disable-e10s'], 02:19:20 INFO - 'tests': ['tp5o']}, 02:19:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:19:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:19:20 INFO - 'talos_options': ['--disable-e10s', 02:19:20 INFO - '--xperf_path', 02:19:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:20 INFO - 'tests': ['tp5n']}, 02:19:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:19:20 INFO - 'talos_options': ['--xperf_path', 02:19:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:20 INFO - 'tests': ['tp5n']}}, 02:19:20 INFO - 'talos.zip': {'path': '', 02:19:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:19:20 INFO - Running post-action listener: _resource_record_post_action 02:19:20 INFO - [mozharness: 2017-04-10 09:19:20.034641Z] Finished populate-webroot step (success) 02:19:20 INFO - [mozharness: 2017-04-10 09:19:20.034731Z] Running create-virtualenv step. 02:19:20 INFO - Running pre-action listener: _resource_record_pre_action 02:19:20 INFO - Running main action method: create_virtualenv 02:19:20 INFO - Creating virtualenv /builds/slave/test/build/venv 02:19:20 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 02:19:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:19:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:19:20 INFO - Using real prefix '/usr' 02:19:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:19:20 INFO - Installing distribute.............................................................................................................................................................................................done. 02:19:22 INFO - Installing pip.................done. 02:19:22 INFO - Return code: 0 02:19:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:19:22 INFO - Reading from file tmpfile_stdout 02:19:22 INFO - Output received: 02:19:22 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) 02:19:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:26 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 0x1a821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1d290>, '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 0x1d1db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e040>, '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': '5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105', '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 02:19:26 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 02:19:26 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 02:19:26 INFO - Using env: {'DISPLAY': ':0', 02:19:26 INFO - 'HOME': '/home/cltbld', 02:19:26 INFO - 'LANG': 'en_US.UTF-8', 02:19:26 INFO - 'LANGUAGE': 'en_US:en', 02:19:26 INFO - 'LOGNAME': 'cltbld', 02:19:26 INFO - 'MAIL': '/var/mail/cltbld', 02:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:26 INFO - 'MOZ_NO_REMOTE': '1', 02:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:26 INFO - 'NO_EM_RESTART': '1', 02:19:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:26 INFO - 'PWD': '/builds/slave/test', 02:19:26 INFO - 'SHELL': '/bin/bash', 02:19:26 INFO - 'SHLVL': '1', 02:19:26 INFO - 'TERM': 'linux', 02:19:26 INFO - 'TMOUT': '86400', 02:19:26 INFO - 'USER': 'cltbld', 02:19:26 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105', 02:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:26 INFO - '_': '/tools/buildbot/bin/python'} 02:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:26 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 02:19:26 INFO - Cleaning up... 02:19:26 INFO - Return code: 0 02:19:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:19:26 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')]} 02:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:26 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')]} 02:19:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:28 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 0x1a821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1d290>, '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 0x1d1db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e040>, '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': '5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105', '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 02:19:28 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 02:19:28 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 02:19:28 INFO - Using env: {'DISPLAY': ':0', 02:19:28 INFO - 'HOME': '/home/cltbld', 02:19:28 INFO - 'LANG': 'en_US.UTF-8', 02:19:28 INFO - 'LANGUAGE': 'en_US:en', 02:19:28 INFO - 'LOGNAME': 'cltbld', 02:19:28 INFO - 'MAIL': '/var/mail/cltbld', 02:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:28 INFO - 'MOZ_NO_REMOTE': '1', 02:19:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:28 INFO - 'NO_EM_RESTART': '1', 02:19:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:28 INFO - 'PWD': '/builds/slave/test', 02:19:28 INFO - 'SHELL': '/bin/bash', 02:19:28 INFO - 'SHLVL': '1', 02:19:28 INFO - 'TERM': 'linux', 02:19:28 INFO - 'TMOUT': '86400', 02:19:28 INFO - 'USER': 'cltbld', 02:19:28 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105', 02:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:28 INFO - '_': '/tools/buildbot/bin/python'} 02:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:29 INFO - Downloading/unpacking psutil>=3.1.1 02:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:19:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:19:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:19:34 INFO - Installing collected packages: psutil 02:19:34 INFO - Running setup.py install for psutil 02:19:34 INFO - building 'psutil._psutil_linux' extension 02:19:34 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 02:19:35 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 02:19:35 INFO - building 'psutil._psutil_posix' extension 02:19:35 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 02:19:35 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 02:19:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:19:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:19:35 INFO - Successfully installed psutil 02:19:35 INFO - Cleaning up... 02:19:35 INFO - Return code: 0 02:19:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:19:35 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')]} 02:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:35 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')]} 02:19:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:37 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 0x1a821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1d290>, '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 0x1d1db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e040>, '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': '5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105', '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 02:19:37 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 02:19:37 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 02:19:37 INFO - Using env: {'DISPLAY': ':0', 02:19:37 INFO - 'HOME': '/home/cltbld', 02:19:37 INFO - 'LANG': 'en_US.UTF-8', 02:19:37 INFO - 'LANGUAGE': 'en_US:en', 02:19:37 INFO - 'LOGNAME': 'cltbld', 02:19:37 INFO - 'MAIL': '/var/mail/cltbld', 02:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:37 INFO - 'MOZ_NO_REMOTE': '1', 02:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:37 INFO - 'NO_EM_RESTART': '1', 02:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:37 INFO - 'PWD': '/builds/slave/test', 02:19:37 INFO - 'SHELL': '/bin/bash', 02:19:37 INFO - 'SHLVL': '1', 02:19:37 INFO - 'TERM': 'linux', 02:19:37 INFO - 'TMOUT': '86400', 02:19:37 INFO - 'USER': 'cltbld', 02:19:37 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105', 02:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:37 INFO - '_': '/tools/buildbot/bin/python'} 02:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:19:37 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 02:19:37 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 02:19:37 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 02:19:37 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 02:19:37 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 02:19:37 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 02:19:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:19:43 INFO - Installing collected packages: mozsystemmonitor 02:19:43 INFO - Running setup.py install for mozsystemmonitor 02:19:43 INFO - Successfully installed mozsystemmonitor 02:19:43 INFO - Cleaning up... 02:19:43 INFO - Return code: 0 02:19:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1d290>, '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 0x1d1db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e040>, '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': '5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105', '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 02:19:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:19:46 INFO - Using env: {'DISPLAY': ':0', 02:19:46 INFO - 'HOME': '/home/cltbld', 02:19:46 INFO - 'LANG': 'en_US.UTF-8', 02:19:46 INFO - 'LANGUAGE': 'en_US:en', 02:19:46 INFO - 'LOGNAME': 'cltbld', 02:19:46 INFO - 'MAIL': '/var/mail/cltbld', 02:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:46 INFO - 'MOZ_NO_REMOTE': '1', 02:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:46 INFO - 'NO_EM_RESTART': '1', 02:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:46 INFO - 'PWD': '/builds/slave/test', 02:19:46 INFO - 'SHELL': '/bin/bash', 02:19:46 INFO - 'SHLVL': '1', 02:19:46 INFO - 'TERM': 'linux', 02:19:46 INFO - 'TMOUT': '86400', 02:19:46 INFO - 'USER': 'cltbld', 02:19:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105', 02:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:46 INFO - '_': '/tools/buildbot/bin/python'} 02:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:47 INFO - Downloading/unpacking jsonschema==2.5.1 02:19:47 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 02:19:47 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 02:19:47 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 02:19:47 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 02:19:47 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 02:19:47 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 02:20:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:20:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:20:02 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 02:20:02 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 02:20:02 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 02:20:02 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 02:20:02 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 02:20:02 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 02:20:03 INFO - Downloading functools32-3.2.3-2.tar.gz 02:20:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:20:03 INFO - warning: no files found matching '*.txt' 02:20:03 INFO - no previously-included directories found matching 'build' 02:20:03 INFO - no previously-included directories found matching 'dist' 02:20:03 INFO - no previously-included directories found matching '.git*' 02:20:03 INFO - Installing collected packages: jsonschema, functools32 02:20:03 INFO - Running setup.py install for functools32 02:20:03 INFO - warning: no files found matching '*.txt' 02:20:03 INFO - no previously-included directories found matching 'build' 02:20:03 INFO - no previously-included directories found matching 'dist' 02:20:03 INFO - no previously-included directories found matching '.git*' 02:20:04 INFO - Successfully installed jsonschema functools32 02:20:04 INFO - Cleaning up... 02:20:04 INFO - Return code: 0 02:20:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:20:04 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')]} 02:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:04 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')]} 02:20:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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 0x1a821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1d290>, '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 0x1d1db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e040>, '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': '5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105', '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 02:20: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 02:20: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 02:20:08 INFO - Using env: {'DISPLAY': ':0', 02:20:08 INFO - 'HOME': '/home/cltbld', 02:20:08 INFO - 'LANG': 'en_US.UTF-8', 02:20:08 INFO - 'LANGUAGE': 'en_US:en', 02:20:08 INFO - 'LOGNAME': 'cltbld', 02:20:08 INFO - 'MAIL': '/var/mail/cltbld', 02:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:08 INFO - 'MOZ_NO_REMOTE': '1', 02:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:08 INFO - 'NO_EM_RESTART': '1', 02:20:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:08 INFO - 'PWD': '/builds/slave/test', 02:20:08 INFO - 'SHELL': '/bin/bash', 02:20:08 INFO - 'SHLVL': '1', 02:20:08 INFO - 'TERM': 'linux', 02:20:08 INFO - 'TMOUT': '86400', 02:20:08 INFO - 'USER': 'cltbld', 02:20:08 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105', 02:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:08 INFO - '_': '/tools/buildbot/bin/python'} 02:20:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:20:08 INFO - Cleaning up... 02:20:08 INFO - Return code: 0 02:20:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:20: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')]} 02:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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')]} 02:20:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1d290>, '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 0x1d1db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e040>, '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': '5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105', '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 02:20:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:20:11 INFO - Using env: {'DISPLAY': ':0', 02:20:11 INFO - 'HOME': '/home/cltbld', 02:20:11 INFO - 'LANG': 'en_US.UTF-8', 02:20:11 INFO - 'LANGUAGE': 'en_US:en', 02:20:11 INFO - 'LOGNAME': 'cltbld', 02:20:11 INFO - 'MAIL': '/var/mail/cltbld', 02:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:11 INFO - 'MOZ_NO_REMOTE': '1', 02:20:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:11 INFO - 'NO_EM_RESTART': '1', 02:20:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:11 INFO - 'PWD': '/builds/slave/test', 02:20:11 INFO - 'SHELL': '/bin/bash', 02:20:11 INFO - 'SHLVL': '1', 02:20:11 INFO - 'TERM': 'linux', 02:20:11 INFO - 'TMOUT': '86400', 02:20:11 INFO - 'USER': 'cltbld', 02:20:11 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105', 02:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:11 INFO - '_': '/tools/buildbot/bin/python'} 02:20:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:11 INFO - Downloading/unpacking blobuploader==1.2.4 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20:18 INFO - Downloading blobuploader-1.2.4.tar.gz 02:20:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:20:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:20:18 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 02:20:18 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 02:20:18 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 02:20:18 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 02:20:18 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 02:20:18 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 02:20:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:20:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:20:18 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 02:20:18 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 02:20:18 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 02:20:18 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 02:20:18 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 02:20:18 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 02:20:19 INFO - Downloading docopt-0.6.1.tar.gz 02:20:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:20:19 INFO - Installing collected packages: blobuploader, requests, docopt 02:20:19 INFO - Running setup.py install for blobuploader 02:20:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:20:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:20:19 INFO - Running setup.py install for requests 02:20:19 INFO - Running setup.py install for docopt 02:20:19 INFO - Successfully installed blobuploader requests docopt 02:20:19 INFO - Cleaning up... 02:20:19 INFO - Return code: 0 02:20:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20: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')]} 02:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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')]} 02:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:22 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 0x1a821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1d290>, '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 0x1d1db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e040>, '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': '5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105', '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 02:20:22 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 02:20:22 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 02:20:22 INFO - Using env: {'DISPLAY': ':0', 02:20:22 INFO - 'HOME': '/home/cltbld', 02:20:22 INFO - 'LANG': 'en_US.UTF-8', 02:20:22 INFO - 'LANGUAGE': 'en_US:en', 02:20:22 INFO - 'LOGNAME': 'cltbld', 02:20:22 INFO - 'MAIL': '/var/mail/cltbld', 02:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:22 INFO - 'MOZ_NO_REMOTE': '1', 02:20:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:22 INFO - 'NO_EM_RESTART': '1', 02:20:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:22 INFO - 'PWD': '/builds/slave/test', 02:20:22 INFO - 'SHELL': '/bin/bash', 02:20:22 INFO - 'SHLVL': '1', 02:20:22 INFO - 'TERM': 'linux', 02:20:22 INFO - 'TMOUT': '86400', 02:20:22 INFO - 'USER': 'cltbld', 02:20:22 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105', 02:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:22 INFO - '_': '/tools/buildbot/bin/python'} 02:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:20:22 INFO - Running setup.py (path:/tmp/pip-u44VyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:20:22 INFO - Running setup.py (path:/tmp/pip-pJ7PpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:20:22 INFO - Running setup.py (path:/tmp/pip-aJKq4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:20:22 INFO - Running setup.py (path:/tmp/pip-olWYmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:20:22 INFO - Running setup.py (path:/tmp/pip-Sw2Sif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:20:22 INFO - Running setup.py (path:/tmp/pip-UT2N2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:22 INFO - Running setup.py (path:/tmp/pip-2hMePg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:22 INFO - Running setup.py (path:/tmp/pip-1_FOIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:22 INFO - Running setup.py (path:/tmp/pip-WvoWnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:22 INFO - Running setup.py (path:/tmp/pip-nDzSgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:23 INFO - Running setup.py (path:/tmp/pip-aZtlJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:23 INFO - Running setup.py (path:/tmp/pip-jH87KK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:23 INFO - Running setup.py (path:/tmp/pip-z8AehS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:23 INFO - Running setup.py (path:/tmp/pip-eWgpID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:23 INFO - Running setup.py (path:/tmp/pip-OpS6gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:23 INFO - Running setup.py (path:/tmp/pip-ML5W6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:23 INFO - Running setup.py (path:/tmp/pip-xr5J06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:20:23 INFO - Running setup.py install for manifestparser 02:20:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:20:23 INFO - Running setup.py install for mozcrash 02:20:23 INFO - Running setup.py install for mozdebug 02:20:23 INFO - Running setup.py install for mozdevice 02:20:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:20:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:20:24 INFO - Running setup.py install for mozfile 02:20:24 INFO - Running setup.py install for mozhttpd 02:20:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:20:24 INFO - Running setup.py install for mozinfo 02:20:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:20:24 INFO - Running setup.py install for mozInstall 02:20:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:20:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:20:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:20:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:20:24 INFO - Running setup.py install for mozleak 02:20:24 INFO - Running setup.py install for mozlog 02:20:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:20:24 INFO - Running setup.py install for moznetwork 02:20:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:20:24 INFO - Running setup.py install for mozprocess 02:20:24 INFO - Running setup.py install for mozprofile 02:20:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:20:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:20:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:20:24 INFO - Running setup.py install for mozrunner 02:20:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:20:25 INFO - Running setup.py install for mozscreenshot 02:20:25 INFO - Running setup.py install for moztest 02:20:25 INFO - Running setup.py install for mozversion 02:20:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:20:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:20:25 INFO - Cleaning up... 02:20:25 INFO - Return code: 0 02:20:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:25 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')]} 02:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:25 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')]} 02:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:28 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 0x1a821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1d290>, '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 0x1d1db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e040>, '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': '5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105', '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 02:20:28 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 02:20:28 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 02:20:28 INFO - Using env: {'DISPLAY': ':0', 02:20:28 INFO - 'HOME': '/home/cltbld', 02:20:28 INFO - 'LANG': 'en_US.UTF-8', 02:20:28 INFO - 'LANGUAGE': 'en_US:en', 02:20:28 INFO - 'LOGNAME': 'cltbld', 02:20:28 INFO - 'MAIL': '/var/mail/cltbld', 02:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:28 INFO - 'MOZ_NO_REMOTE': '1', 02:20:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:28 INFO - 'NO_EM_RESTART': '1', 02:20:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:28 INFO - 'PWD': '/builds/slave/test', 02:20:28 INFO - 'SHELL': '/bin/bash', 02:20:28 INFO - 'SHLVL': '1', 02:20:28 INFO - 'TERM': 'linux', 02:20:28 INFO - 'TMOUT': '86400', 02:20:28 INFO - 'USER': 'cltbld', 02:20:28 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105', 02:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:28 INFO - '_': '/tools/buildbot/bin/python'} 02:20:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:20:28 INFO - Running setup.py (path:/tmp/pip-DRPDqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:20:28 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)) 02:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:20:28 INFO - Running setup.py (path:/tmp/pip-iLJGj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:20:28 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)) 02:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:20:28 INFO - Running setup.py (path:/tmp/pip-WF0ee4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:20:28 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)) 02:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:20:28 INFO - Running setup.py (path:/tmp/pip-HtcDfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:20:28 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)) 02:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:20:28 INFO - Running setup.py (path:/tmp/pip-g1H43m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:20:28 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)) 02:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:20:28 INFO - Running setup.py (path:/tmp/pip-_9IRUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:28 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)) 02:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:28 INFO - Running setup.py (path:/tmp/pip-t7s6Ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:28 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)) 02:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:28 INFO - Running setup.py (path:/tmp/pip-CuLd6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:28 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)) 02:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:28 INFO - Running setup.py (path:/tmp/pip-6eqToJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:28 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)) 02:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:28 INFO - Running setup.py (path:/tmp/pip-1cT2uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:29 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)) 02:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:29 INFO - Running setup.py (path:/tmp/pip-Cc8whH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:29 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)) 02:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:29 INFO - Running setup.py (path:/tmp/pip-XpHRl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 02:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:29 INFO - Running setup.py (path:/tmp/pip-ZK9rBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:29 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)) 02:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:29 INFO - Running setup.py (path:/tmp/pip-mRw6f4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:29 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)) 02:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:29 INFO - Running setup.py (path:/tmp/pip-6IorPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:29 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)) 02:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:29 INFO - Running setup.py (path:/tmp/pip-8DJ2EP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:29 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)) 02:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:29 INFO - Running setup.py (path:/tmp/pip-5Q7RWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:29 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)) 02:20:29 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)) 02:20:29 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)) 02:20:29 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)) 02:20:29 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)) 02:20:29 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)) 02:20:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:37 INFO - Downloading blessings-1.6.tar.gz 02:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:20:37 INFO - Installing collected packages: blessings 02:20:37 INFO - Running setup.py install for blessings 02:20:37 INFO - Successfully installed blessings 02:20:37 INFO - Cleaning up... 02:20:37 INFO - Return code: 0 02:20:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:20:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:37 INFO - Reading from file tmpfile_stdout 02:20:37 INFO - Current package versions: 02:20:37 INFO - argparse == 1.2.1 02:20:37 INFO - blessings == 1.6 02:20:37 INFO - blobuploader == 1.2.4 02:20:37 INFO - docopt == 0.6.1 02:20:37 INFO - functools32 == 3.2.3-2 02:20:37 INFO - jsonschema == 2.5.1 02:20:37 INFO - manifestparser == 1.1 02:20:37 INFO - mozInstall == 1.12 02:20:37 INFO - mozcrash == 1.0 02:20:37 INFO - mozdebug == 0.1 02:20:37 INFO - mozdevice == 0.49 02:20:37 INFO - mozfile == 1.2 02:20:37 INFO - mozhttpd == 0.7 02:20:37 INFO - mozinfo == 0.9 02:20:37 INFO - mozleak == 0.1 02:20:37 INFO - mozlog == 3.4 02:20:37 INFO - moznetwork == 0.27 02:20:37 INFO - mozprocess == 0.25 02:20:37 INFO - mozprofile == 0.28 02:20:37 INFO - mozrunner == 6.13 02:20:37 INFO - mozscreenshot == 0.1 02:20:37 INFO - mozsystemmonitor == 0.3 02:20:37 INFO - moztest == 0.8 02:20:37 INFO - mozversion == 1.4 02:20:37 INFO - psutil == 3.1.1 02:20:37 INFO - requests == 1.2.3 02:20:37 INFO - wsgiref == 0.1.2 02:20:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:40 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 0x1a821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1d290>, '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 0x1d1db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e040>, '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': '5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105', '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 02:20:40 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 02:20:40 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 02:20:40 INFO - Using env: {'DISPLAY': ':0', 02:20:40 INFO - 'HOME': '/home/cltbld', 02:20:40 INFO - 'LANG': 'en_US.UTF-8', 02:20:40 INFO - 'LANGUAGE': 'en_US:en', 02:20:40 INFO - 'LOGNAME': 'cltbld', 02:20:40 INFO - 'MAIL': '/var/mail/cltbld', 02:20:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:40 INFO - 'MOZ_NO_REMOTE': '1', 02:20:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:40 INFO - 'NO_EM_RESTART': '1', 02:20:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:40 INFO - 'PWD': '/builds/slave/test', 02:20:40 INFO - 'SHELL': '/bin/bash', 02:20:40 INFO - 'SHLVL': '1', 02:20:40 INFO - 'TERM': 'linux', 02:20:40 INFO - 'TMOUT': '86400', 02:20:40 INFO - 'USER': 'cltbld', 02:20:40 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105', 02:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:40 INFO - '_': '/tools/buildbot/bin/python'} 02:20:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:40 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)) 02:20:40 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)) 02:20:40 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)) 02:20:40 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)) 02:20:40 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)) 02:20:40 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)) 02:20:40 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)) 02:20:40 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)) 02:20:40 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)) 02:20:40 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)) 02:20:40 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)) 02:20:40 INFO - Cleaning up... 02:20:40 INFO - Return code: 0 02:20:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:20:40 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')]} 02:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:40 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')]} 02:20:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:43 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 0x1a821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1d290>, '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 0x1d1db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e040>, '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': '5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105', '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 02:20:43 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 02:20:43 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 02:20:43 INFO - Using env: {'DISPLAY': ':0', 02:20:43 INFO - 'HOME': '/home/cltbld', 02:20:43 INFO - 'LANG': 'en_US.UTF-8', 02:20:43 INFO - 'LANGUAGE': 'en_US:en', 02:20:43 INFO - 'LOGNAME': 'cltbld', 02:20:43 INFO - 'MAIL': '/var/mail/cltbld', 02:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:43 INFO - 'MOZ_NO_REMOTE': '1', 02:20:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:43 INFO - 'NO_EM_RESTART': '1', 02:20:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:43 INFO - 'PWD': '/builds/slave/test', 02:20:43 INFO - 'SHELL': '/bin/bash', 02:20:43 INFO - 'SHLVL': '1', 02:20:43 INFO - 'TERM': 'linux', 02:20:43 INFO - 'TMOUT': '86400', 02:20:43 INFO - 'USER': 'cltbld', 02:20:43 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105', 02:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:43 INFO - '_': '/tools/buildbot/bin/python'} 02:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:20:44 INFO - Cleaning up... 02:20:44 INFO - Return code: 0 02:20:44 INFO - Running post-action listener: _resource_record_post_action 02:20:44 INFO - Running post-action listener: _start_resource_monitoring 02:20:44 INFO - Starting resource monitoring. 02:20:44 INFO - [mozharness: 2017-04-10 09:20:44.195640Z] Finished create-virtualenv step (success) 02:20:44 INFO - [mozharness: 2017-04-10 09:20:44.196192Z] Running install step. 02:20:44 INFO - Running pre-action listener: _resource_record_pre_action 02:20:44 INFO - Running main action method: install 02:20:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:44 INFO - Reading from file tmpfile_stdout 02:20:44 INFO - Detecting whether we're running mozinstall >=1.0... 02:20:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:20:44 INFO - Reading from file tmpfile_stdout 02:20:44 INFO - Output received: 02:20:44 INFO - Usage: mozinstall [options] installer 02:20:44 INFO - Options: 02:20:44 INFO - -h, --help show this help message and exit 02:20:44 INFO - -d DEST, --destination=DEST 02:20:44 INFO - Directory to install application into. [default: 02:20:44 INFO - "/builds/slave/test"] 02:20:44 INFO - --app=APP Application being installed. [default: firefox] 02:20:44 INFO - mkdir: /builds/slave/test/build/application 02:20:44 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'] 02:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:21:01 INFO - Reading from file tmpfile_stdout 02:21:01 INFO - Output received: 02:21:01 INFO - /builds/slave/test/build/application/firefox/firefox 02:21:01 INFO - Running post-action listener: _resource_record_post_action 02:21:01 INFO - [mozharness: 2017-04-10 09:21:01.057950Z] Finished install step (success) 02:21:01 INFO - [mozharness: 2017-04-10 09:21:01.058224Z] Running run-tests step. 02:21:01 INFO - Running pre-action listener: _resource_record_pre_action 02:21:01 INFO - Running main action method: run_tests 02:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:21:01 INFO - Python 2.7.3 02:21:01 INFO - Return code: 0 02:21:01 INFO - grabbing minidump binary from tooltool 02:21:01 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')]} 02:21:01 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 0x1d1d290>, '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 0x1d1db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:21:01 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 02:21:01 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 02:21:01 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 02:21:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:21:01 INFO - Return code: 0 02:21:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:21:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:21:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:21:01 INFO - ENV: RUST_BACKTRACE is now 1 02:21:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:21:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:21:01 INFO - Using env: {'DISPLAY': ':0', 02:21:01 INFO - 'HOME': '/home/cltbld', 02:21:01 INFO - 'LANG': 'en_US.UTF-8', 02:21:01 INFO - 'LANGUAGE': 'en_US:en', 02:21:01 INFO - 'LOGNAME': 'cltbld', 02:21:01 INFO - 'MAIL': '/var/mail/cltbld', 02:21:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:21:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:01 INFO - 'MOZ_NO_REMOTE': '1', 02:21:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:01 INFO - 'NO_EM_RESTART': '1', 02:21:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:01 INFO - 'PWD': '/builds/slave/test', 02:21:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:21:01 INFO - 'RUST_BACKTRACE': '1', 02:21:01 INFO - 'SHELL': '/bin/bash', 02:21:01 INFO - 'SHLVL': '1', 02:21:01 INFO - 'TERM': 'linux', 02:21:01 INFO - 'TMOUT': '86400', 02:21:01 INFO - 'USER': 'cltbld', 02:21:01 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105', 02:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:01 INFO - '_': '/tools/buildbot/bin/python'} 02:21:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:21:01 INFO - mozversion application_buildid: 20170410080454 02:21:01 INFO - mozversion application_changeset: ef9f29a17da06dda0a3a7660ea556ac068f16ad4 02:21:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:21:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:21:01 INFO - mozversion application_name: Firefox 02:21:01 INFO - mozversion application_remotingname: firefox-dev 02:21:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:21:01 INFO - mozversion application_vendor: Mozilla 02:21:01 INFO - mozversion application_version: 54.0a2 02:21:01 INFO - mozversion platform_buildid: 20170410080454 02:21:01 INFO - mozversion platform_changeset: ef9f29a17da06dda0a3a7660ea556ac068f16ad4 02:21:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:21:01 INFO - mozversion platform_version: 54.0a2 02:21:01 INFO - using testdate: 1491816061 02:21:01 INFO - actual date: 1491816061 02:21:01 INFO - starting webserver on 'localhost:41047' 02:21:01 INFO - SUITE-START | Running 2 tests 02:21:01 INFO - TEST-START | dromaeo_css 02:21:01 INFO - operating with platform_type : linux_ 02:21:01 INFO - Initialising browser for dromaeo_css test... 02:21:01 INFO - TEST-INFO | started process 19278 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaJeAAu/profile http://localhost:41047/getInfo.html) 02:21:05 INFO - PROCESS | 19278 | __metrics Screen width/height:1600/1200 02:21:05 INFO - PROCESS | 19278 | colorDepth:24 02:21:05 INFO - PROCESS | 19278 | Browser inner width/height: 1024/697 02:21:05 INFO - PROCESS | 19278 | __metrics 02:21:06 ERROR - PROCESS | 19278 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 02:21:07 INFO - TEST-INFO | 19278: exit 0 02:21:07 INFO - Browser initialized. 02:21:07 INFO - Running cycle 1/1 for dromaeo_css test... 02:21:07 INFO - TEST-INFO | started process 19412 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaJeAAu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:21:19 INFO - PROCESS | 19412 | RSS: Main: 146993152 02:21:19 INFO - PROCESS | 19412 | 02:24:19 INFO - PROCESS | 19412 | Cycle 1(1): loaded http://localhost:41047/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41047/tests/dromaeo/cssquery-ext.html) 02:24:20 INFO - PROCESS | 19412 | RSS: Main: 157192192 02:24:20 INFO - PROCESS | 19412 | 02:26:07 INFO - PROCESS | 19412 | ************************* 02:26:07 INFO - PROCESS | 19412 | A coding exception was thrown and uncaught in a Task. 02:26:07 INFO - PROCESS | 19412 | 02:26:07 ERROR - PROCESS | 19412 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:26:07 INFO - PROCESS | 19412 | Full stack: 02:26:07 INFO - PROCESS | 19412 | ************************* 02:26:07 INFO - PROCESS | 19412 | ************************* 02:26:07 INFO - PROCESS | 19412 | A coding exception was thrown and uncaught in a Task. 02:26:07 INFO - PROCESS | 19412 | 02:26:07 ERROR - PROCESS | 19412 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:26:07 INFO - PROCESS | 19412 | Full stack: 02:26:07 INFO - PROCESS | 19412 | ************************* 02:26:07 INFO - PROCESS | 19412 | ************************* 02:26:07 INFO - PROCESS | 19412 | A coding exception was thrown and uncaught in a Task. 02:26:07 INFO - PROCESS | 19412 | 02:26:07 ERROR - PROCESS | 19412 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:26:07 INFO - PROCESS | 19412 | Full stack: 02:26:07 INFO - PROCESS | 19412 | ************************* 02:26:07 INFO - PROCESS | 19412 | ************************* 02:26:07 INFO - PROCESS | 19412 | A coding exception was thrown and uncaught in a Task. 02:26:07 INFO - PROCESS | 19412 | 02:26:07 ERROR - PROCESS | 19412 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:26:07 INFO - PROCESS | 19412 | Full stack: 02:26:07 INFO - PROCESS | 19412 | ************************* 02:27:22 INFO - PROCESS | 19412 | Cycle 1(1): loaded http://localhost:41047/tests/dromaeo/cssquery-ext.html (next: http://localhost:41047/tests/dromaeo/cssquery-jquery.html) 02:27:23 INFO - PROCESS | 19412 | RSS: Main: 154157056 02:27:23 INFO - PROCESS | 19412 | 02:30:25 INFO - PROCESS | 19412 | Cycle 1(1): loaded http://localhost:41047/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41047/tests/dromaeo/cssquery-mootools.html) 02:30:25 INFO - PROCESS | 19412 | RSS: Main: 154193920 02:30:25 INFO - PROCESS | 19412 | 02:33:27 INFO - PROCESS | 19412 | Cycle 1(1): loaded http://localhost:41047/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41047/tests/dromaeo/cssquery-prototype.html) 02:33:28 INFO - PROCESS | 19412 | RSS: Main: 152154112 02:33:28 INFO - PROCESS | 19412 | 02:36:30 INFO - PROCESS | 19412 | Cycle 1(1): loaded http://localhost:41047/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41047/tests/dromaeo/cssquery-yui.html) 02:36:31 INFO - PROCESS | 19412 | RSS: Main: 158785536 02:36:31 INFO - PROCESS | 19412 | 02:39:33 INFO - PROCESS | 19412 | Cycle 1(1): loaded http://localhost:41047/tests/dromaeo/cssquery-yui.html (next: http://localhost:41047/tests/dromaeo/cssquery-dojo.html) 02:39:34 INFO - PROCESS | 19412 | RSS: Main: 158056448 02:39:34 INFO - PROCESS | 19412 | 02:39:34 INFO - PROCESS | 19412 | __start_tp_report 02:39:34 INFO - PROCESS | 19412 | _x_x_mozilla_page_load 02:39:34 INFO - PROCESS | 19412 | _x_x_mozilla_page_load_details 02:39:34 INFO - PROCESS | 19412 | |i|pagename|runs| 02:39:34 INFO - PROCESS | 19412 | |0;dojo.html;3435.5190273361727;3460.117669994152;3472.305538892222;3486.0239133042724;3502;5834.124881267812;5858.589898707092;5879.353271140171;5950.613210141343;5955.404459554043;5914.526837852972;5957.463828255456;5963.105534169877;5971.910421343672;5975.133605627181;5321.4412486688825;5442.374126975389;5445.156000819879;5460.2464500409515;5508.283923089993;5490.56075513958;5494.560435165177;5496.532794712454;5512.6968016759065;5515.972420137894;5291.550218231436;5311.9468805312035;5440.537554307889;5488.615796894219;5522.22688823565;5321.52106310432;5343.572514198855;5365.812196573102;5383.219433182206;5404.5676345892625;5297.629165958385;5369.0604144274985;5376.838694839161;5395.10980688186;5414.43148469409;5565.0817615093465;5898.056310990264;5910.527157827363;5936.228290322274;5975.701214939236;6101.481374083208;6128.044828652048;6155.784547540815;6168.19813424252;6228.377162283736;6327.8734425311695;6337.588056776295;6341.112244285804;6350.872982540323;6354;5853.795117170921;5869.295684517842;5875;5875.970620146872;5916.26046744157;6121.056693972082;6148.661823599745;6223;6231.657258850716;6273.780417685451;6143.204841796972;6170.382961703794;6191.442770150708;6203.96898015516;6206.875862482815;6274.811755647338;6275.874482510416;6287;6306.936930630727;6309.179806625109;6016.488598469092;6079.8480037998515;6139.907901381483;6145.385461453819;6149.41580549847;6287.842803929939;6296.5592408530965;6298.307186209513;6311.684415779193;6316.05259211122;4657.953420465752;4692.967547139624;4694.319323698045;4723.645726570521;4830.9275360869615;4249.086446414036;4256.638185754246;4261.936070958938;4283.336082907154;4304.031592891574;5906.7637294508595;5967.224260846062;6070.605410648382;6113.877722445526;6131.14164017038;6252.906206406908;6307.526935479766;6352.0789485525265;6359.268684101295;6369.5541312108635;6108.297545782292;6112.449879510866;6125.203723515914;6125.816225513242;6150.7847225346895;5156.664816786897;5164.896702066013;5317.54800841925;5320.893582128336;5338.759755810997;6378.84052898672;6423.839404014937;6513.804585862432;6520.347965203537;6527.379898909691;6241.469475094668;6242.344553821783;6246.500279977682;6248.156498872776;6266.68666566679;6330.145430367026;6440.806775796734;6467.417932386108;6498.415142637185;6512.185976752906;6113.266408031065;6121.05669397217;6132.172156758959;6187.597806142587;6232.719527621177;6310.148130002391;6312.053192021233;6321.1782468278825;6342.112104305309;6346.746130154742;6115.235595550556;6177.444030037139;6181.876362472815;6190.628562286277;6191.380861913773;5968.791092311922;5987.31145918225;6090.573659843769;6105.877882442415;6124.969375153096;6181.907271391023;6195.2875419325555;6217.409346112112;6221.377862213742;6239.5008399327035;5936.168936349001;6205.968970155121;6270.655113968775;6271.686415679289;6277.96861015692;5869.090291004901;5903.734331954986;5922.437368449991;5929.851753706192;5974.61165024272 02:39:34 INFO - PROCESS | 19412 | |1;ext.html;744.9404047676184;803.1446509467418;816.4570560577215;879.6745204274415;880.2913654508119;42345;43541.129177416435;43570;43602;47722.28416573745;44347.33478997809;44358.778206108924;44602.33096503555;44649.77675111628;44768.10463790722;9071.22894553962;9209.677661281856;10183.236257280696;10448.58205671776;10697.144228461744;10295.22785791065;10389.636362727306;10398.532066057007;10401.37591744494;10405.323653962469;10446.32098913572;10473.528691208914;10480.895191048068;10504.107150892183;10504.894951050506;10373.948130259376;10391.688249352532;10441.216908731838;10443.477826108665;10458;10166.288359814816;10179.949100254451;10205.081542661123;10261.07650311468;10277.48612569376;36838.07904802375;36849.44725829115;37025.629743702484;37085.81457092724;37258.81370593157;4046.4132700758223;4068.6134817192615;4127.050778320973;4134.131832315217;4155.044339801862;27566.862165689243;27782.166535003984;27941.096398960526;28101.29746756327;28272.43455130886;4267.359896015591;4286.935695964563;4290.0561876387455;4329.7618630975285;4363.607275345203;235369;237878;242654;247583;248027;45672.3149152763;45777.771111144895;46105;46105;46145.53854461479;47079.29381059287;47088.05823883503;47088.764556177;47097.76451117722;47150.292745608844;15524.456644017631;15601.297941592655;15735.606609834846;15741.134237616812;15743.448979285899;13682.657933551742;13683.31583420825;13706.314684265746;13708.52020179309;13721.039527233197;12842.165259258118;12938.223706577635;12961.611151665466;12966.351682415841;13023.413946372437;5254.868628284247;5319.69105024931;5350.197470379397;5419.539339156216;5441.510264076173;1232.679503329141;1235.116891422637;1283.646997075793;1284.278015423237;1293.2369901758009;27004;27218.183454496397;27260.31849203786;27497.31256718598;28134.85932570365;1385.736710025092;1389.8749112579917;1398.2309729648653;1412.1244828206577;1419.9929000354932;14283.64290892736;14356.860043904933;14662.853371466363;14708.632284192981;14737;345628;346283;347049;347580;348000;59508.70245648744;59533.70233148893;59865.700671496365;59893;60083.39916600778;1478.0909740509724;1505.1044628446057;1544.4208421841809;1549.2718422341482;1561.125769569045;26713;26911.86544067267;27721.861390692917;27898.30254243579;28260.85869570639;44408.33387499126;44490.332645010996;44531;44593.331100032876;44723.77638111789;322676;322807;323511.3824430863;324893;326270;29866.402671946005;30521.694783051884;33131.50302745509;33157;33269.83365083256;39503.407448888865;39735.602643974344;39802;40033.199336012534;40492.595074048884;31173.376532469676;31205.37589248157;31485.842570787914;31591.526127107652;31593.81090648697;30781.614827333273;30986.535201972438;31366;31491.84254078715;31813.36373272568;35136.47295290521;35160.82419587988;35419.468707969914;35434.822825885705;35540.822295888356;30181.547276791305;30265.092047238617;30357.24106897257;30487.695123049372;30799;23856.88071559631;25234.62148067817;25761.454312741294;25859.482810344063;26108.73891261063 02:39:34 INFO - PROCESS | 19412 | |2;jquery.html;466.1841776890442;469.3429199121232;477.90441911617677;481.1051444313576;492.42878261217;19948.40154795355;21589.352319430403;22221.888890555525;22242.110315587397;22398.21606243782;22224.333270001884;22383.55232895341;22521.54956900861;23027.539449211006;23291.534169316605;6611.6694165291665;6647.867042659144;6831.419329357011;6855.383015528601;6855.760048398307;6643.966780166116;6781.898271525906;7076.929230707704;7363.631818409085;7543.396528277752;7311.744088956888;7524.811879703024;7550.6979720811105;7551;7557.508761930484;7631.542107473541;7712.3444507216955;7714.614269286513;7720.498167619115;7731.922680773177;7270.818229544304;7409.407247420193;7434.145073316529;7464.477486575942;7468.2531746825425;24920.626190607156;25085.122020729188;25159;25555.61666575003;25711;3095.349976504937;3157.905262842118;3180.8250546219947;3212.6626704195955;3238.4656531672244;15791.605209869846;15975.760363594556;16223.351065957466;16501.257443415074;16801.747973780402;2225.9666105008437;2263.875486848223;2274.636058230675;2286.0627142871344;2294.1855641247453;113498.43250783776;115239.42380288128;115850.42074789657;116103;117987;17836.9108154461;18272.817271827378;18311.52081104586;18312.626553008577;18484.445466635752;30965.69034309628;31004.29476378776;31053.534196987064;31268.218294542818;31556.526652100238;10702.785944281226;10747.462626868626;10835.51240194193;10879.12966962641;11101.722456938642;9105.863412048824;9129.406588571854;9199.816003680024;9281.535923203814;9311.90688093124;9113.908860911439;9412.05879412067;9475.099865512766;9580.56887440067;9702.70891873245;3535.9292814144087;3797.936577758232;3824.560175579844;3927.783971881574;3978.4285207342937;909.0999910088964;919.2554031234721;921.3044151665583;922.7693076730817;930.6975233049286;21010.894945525175;21159.25942592002;21292.787072129082;21395.572088558143;21422.821744803874;1042.9478526073665;1104.2380757277454;1112.0825319111766;1123.5505797680994;1134.4044376702298;11142;11350.318980861175;11504.309741415542;11541.672707638561;11618.360990145624;647212;651158;654068;660145;667600;90068.5496572526;97915.51042244743;98915;110936;120079;1350.3113412159673;1351.7769568021363;1375.559820857316;1386.6741315790782;1390.4855203574741;18817;19324.71012934779;19458.221671132997;19522.121504532046;19567;37792.43311350277;45453.77273113613;47652.80867978328;53076.73461632667;53386;63600.36399635945;66724;77688;77698.6115069421;77941;12771.042171837335;12961.481540738265;13295.534656286984;13351.198928064347;13517.121387110199;14189;14406.279686015449;14542.41830326775;14722.705545889237;14997.400103995718;12508.749825003631;12910.548130815376;12966.481340746264;13144.474221031052;13146.73706525845;12091.214071085351;12299.631011069681;12330.876691232972;12428.440720167795;12548.30984295836;13092.80360794608;13224.801627975396;13412.915029543065;13613.931930340681;13635.795463067863;12993.480260789462;13016.088873778745;13152.342382881008;13294.667633309246;13295.468181272641;12794.104412691022;12835.101542892282;12860.164089334163;12931.288779116863;12932.224066556037 02:39:34 INFO - PROCESS | 19412 | |3;mootools.html;1560.695664345453;1574.3859894641091;1581.9683606327872;1592.0447731361185;1599.6160921378864;9629.277804164698;9884.802303953917;10804.783904321908;11525.654230373082;11542.24975376601;11057.06014988725;11428.771424571503;11760.941195294012;11772.823407648872;11795.70510737232;2414.782669559739;2451.080844683244;2452.1907770435714;2452.3869032741813;2453.6074228123503;2406.747291534381;2452.362385779701;2461.6184491403774;2466.0628960994795;2471.1721573272885;2411.40920474484;2413.9758602414013;2418.5404773093146;2420.540097381501;2434.610462326028;2287.3938406322336;2325.6046472099783;2333.5216280662426;2338.251759436981;2348.342464110052;2247.5280191159877;2257.4694946687514;2291.7937385635205;2298.7241531016384;2315.23597212921;11452.541898324058;11688.94155529217;11729.941350293278;11729.941350293278;11742.647720568397;5818.970905145447;5981.431763982415;5988.251468566429;5993.430624090704;6007.15899774032;3398.8640454381793;3491.336646037245;3528.223790766053;3530.6116327203986;3558.430651095838;1274.7323062156865;1291.5737806523825;1292.5088466382715;1359.2320339008527;1365.4196966289287;17529.298828046863;17564.736528952075;17565.385211517536;17585.56036099095;17635.294588216457;4860.1737704590305;5147.716875571879;5156.690598564098;5173.1464308388695;5203.7918483261;13245.536406225929;13250.271235082164;13272.469101235842;13300.3349832508;13301.40143693536;5993.220881285492;6000.369961154016;6020.668863212565;6022.909656355158;6027.367126451747;5520.641158324696;5524.392316845144;5527.778888844482;5565.471280228372;5631.380548139701;4101.200265948111;4150.418941348154;4173.686973476941;4190.5180904195795;4212.789360532022;1062.946852657364;1067.9893201068046;1069.8769641491172;1085.766560189563;1086.7228856641507;1075.4568942683895;1101.0971003776986;1109.5395410904384;1115.7489564847845;1116.330201878866;7467.962660186773;7487.775366739006;7506.737264195836;7533.773986780406;7732.8453430932195;1071.5338827610015;1107.1585594947899;1111.6887271563976;1137.0789660374958;1143.2625956258166;4666.2067448533835;4671.159191345522;4702.130105930414;4712.552307530847;4773.737444440589;14239.35922883452;14684.486042988658;14893.70212595742;14988.40046398132;14997.850021499646;14619.85380146185;14671.77992330116;14913.70172596542;14925.179115148554;14927.253637318308;10043.146332561813;10143.08712215904;10167.898321016695;10203.28576999603;10274.691759247235;7251.673674684546;7277.454190935807;7495.737649182252;7540.811479713051;7659.731909383145;13455.259960702255;13569.864301357255;13625.31873406306;13716.65708357299;13750.518731844337;11602.5358985643;12904.677383065124;13594.660133496742;13793.86206137966;13991.370388332753;9318.301127415336;9418.434893906388;9423.434593924387;9470.668526601536;9471.289653275893;10998.395088270221;11010.449477526252;11235.101191904792;11321.603743868925;11383.829242561535;9368.718938431857;9369.859452108087;9422.104900034486;9481.241500680067;9719.951400242953;8904.421212621419;9014.729558113268;9095.545222738969;9227.400218985744;9256.07439256069;8096.5546894921345;8224.424290299621;8228.753137405887;8306.335493160654;8307.792305192419;6157.84605384869;6329.430351268408;6336.1446204763615;6358.523110766619;6386.361363863763;6403.199600049994;6458.483321334376;6506.089147519257;6531.673416329069;6662.034005069335 02:39:34 INFO - PROCESS | 19412 | |4;prototype.html;413.7476139554873;439.14586129977187;441.19702142101386;443.79807187729574;445.83058437793636;5363.704996225206;5407.188921661753;5424.213489044087;5426.701531415771;5444;5263.34208223972;5381.67709937404;5387;5400.381744231365;5422.9728851355785;4456.910861782771;4524.886877828048;4533.659975501834;4543.636509079282;4553.5901768840795;4536.412255710491;4551.180787458256;4555.794989225493;4557.908841823161;4581.244094724367;4374.737515749065;4524.072565124142;4525.298578720303;4527.4114365132655;4545.409096817409;4482.327650852399;4491.505934347219;4504.28837041922;4531.410916580857;4566.429196350457;4217.304144816102;4222.493300803892;4226.513950895655;4237;4281.678874084456;5147.588192944556;5263.867863726994;5269.314989051399;5293.497117773805;5320.51025712801;5215.791368345262;5237.895242095175;5249.4488078751565;5283.55089817366;5307.177387504943;5618.415528856731;5621.184928185431;5622.48192987891;5627;5640.715510218368;4609.654275929285;4640.67515273931;4679.719216847;4703.718696432227;4742.146413645542;5552.472515111058;5603.047481928082;5749;5834.708264586754;5844.503217226541;4807.351007613997;4807.471178170398;4813.566778989908;4846.321514987904;4852.369192005087;4877.439094504107;4901.745197209252;4911.631627627942;4914.33656456381;4971.328870602422;5065.670731402521;5171.069986810052;5182.896342073137;5291.3700512051955;5321.840344789663;5594.412586678422;5648.780195288646;5686.914696279559;5703.914441283384;5723.513501352431;1691.5114699064745;1701.591618011693;1715.7769489966224;1716.5794380376637;1723.284836792742;1233.8334324866028;1326.2639235224542;1329.8404191497082;1332.9469718922137;1356.7015256643522;5349.919751203735;5508.256385388001;5527.806526771544;5541.307336582927;5618.887622247532;5790.652560846278;5799.797007104816;5838.38696936824;5861.3552509223955;5874.970625146932;5250.527452529291;5466.633341664584;5536.916946245809;5543.889122217533;5561.6095976006;2999.6250468691414;3079.0147152910854;3091.520814273791;3095.520194369876;3098.659147493774;6018.488428483628;6036.909446358308;6043.582566973158;6054.8183554493435;6080.69596520181;5756.02147634903;5851.64890106595;5891.823245302648;5913.556483263773;5930.733117009745;5937.435943585352;5968.522518198533;5974.462298393166;5981.850453738692;6005.759769609167;5535.916961245665;5705.258316418839;5708.743106560131;5726.885462290814;5753.309602847517;5625.8593535161945;5647.232855900661;5678.801241956512;5719.799807006735;5733.340665823317;6024.698765061817;6030.3668114847305;6031.276246850231;6046.516278697605;6058.818235452944;4802.351682522814;4850.660453768202;4902.578252306791;4934.827281045146;4946.901061978812;5560.888782224414;5783.368567301952;5808.332041815245;5819.476247137778;5920.348761636303;5661.688607126647;5667.404922483245;5675;5682.374938756816;5732.398098199629;5573.944260557505;5696.832149409278;5707.258056452634;5722.456366645162;5745.368009519033;5621.229312766465;5691.930269857072;5708.942910570841;5711.657300561979;5765.682887441231;5698.686572238566;5709.34342550612;5744.281964754406;5761.39505351932;5765.8558536036935;5385.6768593882925;5560.805371811967;5603.439656034364;5605.24329215567;5635.6618602883955 02:39:34 INFO - PROCESS | 19412 | |5;yui.html;858.0689951402728;867.6486023160622;938.5306901513616;945.7588314979679;947.1570302430838;16178.352865885365;18383.44849654511;18581.44255672332;18588.814111858876;18699.532511687215;16510.83489165108;17325.133743312814;17439.564010899732;17488.38790642328;17503.82496175038;879.9208071273584;883.924866386358;893.4728510178993;902.3908861518448;911.0570559470949;888.9911100889005;889.0353965946955;893.7229458867772;894.9552522373888;895.3642913531401;918.8529835226365;923.852183650616;924.6763632728558;925.8055808280269;930.5533343994887;921.5852866210232;923.0308176414771;924.5007695844236;927.3276874266103;928.967486137982;679.4428568573722;679.894616334469;685.9691313890887;686.0772261308532;688.3323176518819;18157.182926768328;18214.998175100365;18242.361517346963;18754.249830006782;18977.335793247308;14819.925900370537;16331.673366532603;16424.1787910604;16429.424970125987;16751.497455076365;15014.849851501454;15199.392024319124;15203.315850786741;15284.694306113926;15518.612034699223;4081.6122468365456;4149.730267532631;4163.812628431698;4177.728447650893;4236.766977816219;80592.59703701503;81416;82627.17372826315;83325.16674833234;84814;12663.36683165838;12929.418176182095;12990.805137922938;13075.803862942064;13241.271730054747;23597.882010589838;23700;23944.40138996504;24209.39476513066;24406.51186976286;8741.694040708544;9137.725868223964;9160.725178244664;9417.576209070472;9470.242380609534;4930.556249937523;5053.898922021539;5082.364704411949;5106.872328191751;5167.121589329823;3775.5846856845724;3856.151646637735;3880.476135721698;3882.398228274622;3889.533256009297;638.4381744065192;639.8752243312509;639.9744010239539;648.5427773419727;651.5146216069058;668.7600612119188;672.3780503034674;694.6040756768695;700.3066963705894;860.4665107633182;11128.383275435515;11920.642380728592;12704.80942785859;13036.217826930415;13260.557713166198;611.7430679114782;620.1813606040074;632.1907957814005;668.5787953589207;870.7953630896734;5473.890522189534;5821.941780582225;5911.261092363455;5919.792807251725;5957.106434034843;66523;77093.61453192699;77947.83078253831;80741;81041.59479202566;43220.56779432228;56221.43778562244;66893.33106668969;69796.6510167446;70298.64850675817;49992.0001599966;56699.71650141723;61082.69458652767;61193.38806611966;61261.77476450446;10240.53917573696;10402.531886064993;10551.314164579278;10641.946790266;10661;43508.477203297734;43605.345919811865;44069.33895991499;44487.77756111199;45054;51769;51856.222156666925;52747.47252527426;52945.4705452956;56725;13473.730525389241;13652.522161724291;14295.714085718435;14322.856771432569;14379.784303235669;16127.354905804106;16760.916195418944;16934.74780422853;17139.485815425556;17261.39585114515;16342.673146536765;16512.66974660524;16833.91583042077;16866.578335541708;17682.82317176812;13393.330333483482;15970.840291596935;16124.355025798837;16161.353545858034;16630.75053874217;14860.702785944004;15362.846371536141;15669.45156919548;15867.206639668202;16203.351865925231;10644.20168487382;10674.62638807638;10728.73178170552;10994.670159895217;11065.391403472886;11353.489092991;12410.193337433038;12561.685957851127;13002.479900803863;13287.534936277183 02:39:34 INFO - PROCESS | 19412 | __end_tp_report 02:39:34 INFO - PROCESS | 19412 | __start_cc_report 02:39:34 INFO - PROCESS | 19412 | _x_x_mozilla_cycle_collect,336 02:39:34 INFO - PROCESS | 19412 | __end_cc_report 02:39:34 INFO - PROCESS | 19412 | __startTimestamp1491817174111__endTimestamp 02:39:34 INFO - PROCESS | 19412 | 02:39:34 INFO - PROCESS | 19412 | ------- Summary: start ------- 02:39:34 INFO - PROCESS | 19412 | Number of tests: 6 02:39:34 INFO - PROCESS | 19412 | 02:39:34 INFO - PROCESS | 19412 | [#0] dojo.html Cycles:165 Average:5838.46 Median:6112.45 stddev:649.63 (10.6%) stddev-sans-first:623.67 02:39:34 INFO - PROCESS | 19412 | Values: 3435.5 3460.1 3472.3 3486.0 3502.0 5834.1 5858.6 5879.4 5950.6 5955.4 5914.5 5957.5 5963.1 5971.9 5975.1 5321.4 5442.4 5445.2 5460.2 5508.3 5490.6 5494.6 5496.5 5512.7 5516.0 5291.6 5311.9 5440.5 5488.6 5522.2 5321.5 5343.6 5365.8 5383.2 5404.6 5297.6 5369.1 5376.8 5395.1 5414.4 5565.1 5898.1 5910.5 5936.2 5975.7 6101.5 6128.0 6155.8 6168.2 6228.4 6327.9 6337.6 6341.1 6350.9 6354.0 5853.8 5869.3 5875.0 5876.0 5916.3 6121.1 6148.7 6223.0 6231.7 6273.8 6143.2 6170.4 6191.4 6204.0 6206.9 6274.8 6275.9 6287.0 6306.9 6309.2 6016.5 6079.8 6139.9 6145.4 6149.4 6287.8 6296.6 6298.3 6311.7 6316.1 4658.0 4693.0 4694.3 4723.6 4830.9 4249.1 4256.6 4261.9 4283.3 4304.0 5906.8 5967.2 6070.6 6113.9 6131.1 6252.9 6307.5 6352.1 6359.3 6369.6 6108.3 6112.4 6125.2 6125.8 6150.8 5156.7 5164.9 5317.5 5320.9 5338.8 6378.8 6423.8 6513.8 6520.3 6527.4 6241.5 6242.3 6246.5 6248.2 6266.7 6330.1 6440.8 6467.4 6498.4 6512.2 6113.3 6121.1 6132.2 6187.6 6232.7 6310.1 6312.1 6321.2 6342.1 6346.7 6115.2 6177.4 6181.9 6190.6 6191.4 5968.8 5987.3 6090.6 6105.9 6125.0 6181.9 6195.3 6217.4 6221.4 6239.5 5936.2 6206.0 6270.7 6271.7 6278.0 5869.1 5903.7 5922.4 5929.9 5974.6 02:39:34 INFO - PROCESS | 19412 | 02:39:34 INFO - PROCESS | 19412 | [#1] ext.html Cycles:180 Average:46444.41 Median:30892.77 stddev:80627.07 (261.0%) stddev-sans-first:80780.24 02:39:34 INFO - PROCESS | 19412 | Values: 744.9 803.1 816.5 879.7 880.3 42345.0 43541.1 43570.0 43602.0 47722.3 44347.3 44358.8 44602.3 44649.8 44768.1 9071.2 9209.7 10183.2 10448.6 10697.1 10295.2 10389.6 10398.5 10401.4 10405.3 10446.3 10473.5 10480.9 10504.1 10504.9 10373.9 10391.7 10441.2 10443.5 10458.0 10166.3 10179.9 10205.1 10261.1 10277.5 36838.1 36849.4 37025.6 37085.8 37258.8 4046.4 4068.6 4127.1 4134.1 4155.0 27566.9 27782.2 27941.1 28101.3 28272.4 4267.4 4286.9 4290.1 4329.8 4363.6 235369.0 237878.0 242654.0 247583.0 248027.0 45672.3 45777.8 46105.0 46105.0 46145.5 47079.3 47088.1 47088.8 47097.8 47150.3 15524.5 15601.3 15735.6 15741.1 15743.4 13682.7 13683.3 13706.3 13708.5 13721.0 12842.2 12938.2 12961.6 12966.4 13023.4 5254.9 5319.7 5350.2 5419.5 5441.5 1232.7 1235.1 1283.6 1284.3 1293.2 27004.0 27218.2 27260.3 27497.3 28134.9 1385.7 1389.9 1398.2 1412.1 1420.0 14283.6 14356.9 14662.9 14708.6 14737.0 345628.0 346283.0 347049.0 347580.0 348000.0 59508.7 59533.7 59865.7 59893.0 60083.4 1478.1 1505.1 1544.4 1549.3 1561.1 26713.0 26911.9 27721.9 27898.3 28260.9 44408.3 44490.3 44531.0 44593.3 44723.8 322676.0 322807.0 323511.4 324893.0 326270.0 29866.4 30521.7 33131.5 33157.0 33269.8 39503.4 39735.6 39802.0 40033.2 40492.6 31173.4 31205.4 31485.8 31591.5 31593.8 30781.6 30986.5 31366.0 31491.8 31813.4 35136.5 35160.8 35419.5 35434.8 35540.8 30181.5 30265.1 30357.2 30487.7 30799.0 23856.9 25234.6 25761.5 25859.5 26108.7 02:39:34 INFO - PROCESS | 19412 | 02:39:34 INFO - PROCESS | 19412 | [#2] jquery.html Cycles:180 Average:37623.74 Median:12392.71 stddev:107964.54 (871.2%) stddev-sans-first:108231.35 02:39:34 INFO - PROCESS | 19412 | Values: 466.2 469.3 477.9 481.1 492.4 19948.4 21589.4 22221.9 22242.1 22398.2 22224.3 22383.6 22521.5 23027.5 23291.5 6611.7 6647.9 6831.4 6855.4 6855.8 6644.0 6781.9 7076.9 7363.6 7543.4 7311.7 7524.8 7550.7 7551.0 7557.5 7631.5 7712.3 7714.6 7720.5 7731.9 7270.8 7409.4 7434.1 7464.5 7468.3 24920.6 25085.1 25159.0 25555.6 25711.0 3095.3 3157.9 3180.8 3212.7 3238.5 15791.6 15975.8 16223.4 16501.3 16801.7 2226.0 2263.9 2274.6 2286.1 2294.2 113498.4 115239.4 115850.4 116103.0 117987.0 17836.9 18272.8 18311.5 18312.6 18484.4 30965.7 31004.3 31053.5 31268.2 31556.5 10702.8 10747.5 10835.5 10879.1 11101.7 9105.9 9129.4 9199.8 9281.5 9311.9 9113.9 9412.1 9475.1 9580.6 9702.7 3535.9 3797.9 3824.6 3927.8 3978.4 909.1 919.3 921.3 922.8 930.7 21010.9 21159.3 21292.8 21395.6 21422.8 1042.9 1104.2 1112.1 1123.6 1134.4 11142.0 11350.3 11504.3 11541.7 11618.4 647212.0 651158.0 654068.0 660145.0 667600.0 90068.5 97915.5 98915.0 110936.0 120079.0 1350.3 1351.8 1375.6 1386.7 1390.5 18817.0 19324.7 19458.2 19522.1 19567.0 37792.4 45453.8 47652.8 53076.7 53386.0 63600.4 66724.0 77688.0 77698.6 77941.0 12771.0 12961.5 13295.5 13351.2 13517.1 14189.0 14406.3 14542.4 14722.7 14997.4 12508.7 12910.5 12966.5 13144.5 13146.7 12091.2 12299.6 12330.9 12428.4 12548.3 13092.8 13224.8 13412.9 13613.9 13635.8 12993.5 13016.1 13152.3 13294.7 13295.5 12794.1 12835.1 12860.2 12931.3 12932.2 02:39:34 INFO - PROCESS | 19412 | 02:39:34 INFO - PROCESS | 19412 | [#3] mootools.html Cycles:180 Average:7212.56 Median:2414.38 stddev:4617.85 (191.3%) stddev-sans-first:4611.28 02:39:34 INFO - PROCESS | 19412 | Values: 1560.7 1574.4 1582.0 1592.0 1599.6 9629.3 9884.8 10804.8 11525.7 11542.2 11057.1 11428.8 11760.9 11772.8 11795.7 2414.8 2451.1 2452.2 2452.4 2453.6 2406.7 2452.4 2461.6 2466.1 2471.2 2411.4 2414.0 2418.5 2420.5 2434.6 2287.4 2325.6 2333.5 2338.3 2348.3 2247.5 2257.5 2291.8 2298.7 2315.2 11452.5 11688.9 11729.9 11729.9 11742.6 5819.0 5981.4 5988.3 5993.4 6007.2 3398.9 3491.3 3528.2 3530.6 3558.4 1274.7 1291.6 1292.5 1359.2 1365.4 17529.3 17564.7 17565.4 17585.6 17635.3 4860.2 5147.7 5156.7 5173.1 5203.8 13245.5 13250.3 13272.5 13300.3 13301.4 5993.2 6000.4 6020.7 6022.9 6027.4 5520.6 5524.4 5527.8 5565.5 5631.4 4101.2 4150.4 4173.7 4190.5 4212.8 1062.9 1068.0 1069.9 1085.8 1086.7 1075.5 1101.1 1109.5 1115.7 1116.3 7468.0 7487.8 7506.7 7533.8 7732.8 1071.5 1107.2 1111.7 1137.1 1143.3 4666.2 4671.2 4702.1 4712.6 4773.7 14239.4 14684.5 14893.7 14988.4 14997.9 14619.9 14671.8 14913.7 14925.2 14927.3 10043.1 10143.1 10167.9 10203.3 10274.7 7251.7 7277.5 7495.7 7540.8 7659.7 13455.3 13569.9 13625.3 13716.7 13750.5 11602.5 12904.7 13594.7 13793.9 13991.4 9318.3 9418.4 9423.4 9470.7 9471.3 10998.4 11010.4 11235.1 11321.6 11383.8 9368.7 9369.9 9422.1 9481.2 9720.0 8904.4 9014.7 9095.5 9227.4 9256.1 8096.6 8224.4 8228.8 8306.3 8307.8 6157.8 6329.4 6336.1 6358.5 6386.4 6403.2 6458.5 6506.1 6531.7 6662.0 02:39:34 INFO - PROCESS | 19412 | 02:39:34 INFO - PROCESS | 19412 | [#4] prototype.html Cycles:180 Average:4942.95 Median:5425.46 stddev:1308.55 (24.1%) stddev-sans-first:1267.29 02:39:34 INFO - PROCESS | 19412 | Values: 413.7 439.1 441.2 443.8 445.8 5363.7 5407.2 5424.2 5426.7 5444.0 5263.3 5381.7 5387.0 5400.4 5423.0 4456.9 4524.9 4533.7 4543.6 4553.6 4536.4 4551.2 4555.8 4557.9 4581.2 4374.7 4524.1 4525.3 4527.4 4545.4 4482.3 4491.5 4504.3 4531.4 4566.4 4217.3 4222.5 4226.5 4237.0 4281.7 5147.6 5263.9 5269.3 5293.5 5320.5 5215.8 5237.9 5249.4 5283.6 5307.2 5618.4 5621.2 5622.5 5627.0 5640.7 4609.7 4640.7 4679.7 4703.7 4742.1 5552.5 5603.0 5749.0 5834.7 5844.5 4807.4 4807.5 4813.6 4846.3 4852.4 4877.4 4901.7 4911.6 4914.3 4971.3 5065.7 5171.1 5182.9 5291.4 5321.8 5594.4 5648.8 5686.9 5703.9 5723.5 1691.5 1701.6 1715.8 1716.6 1723.3 1233.8 1326.3 1329.8 1332.9 1356.7 5349.9 5508.3 5527.8 5541.3 5618.9 5790.7 5799.8 5838.4 5861.4 5875.0 5250.5 5466.6 5536.9 5543.9 5561.6 2999.6 3079.0 3091.5 3095.5 3098.7 6018.5 6036.9 6043.6 6054.8 6080.7 5756.0 5851.6 5891.8 5913.6 5930.7 5937.4 5968.5 5974.5 5981.9 6005.8 5535.9 5705.3 5708.7 5726.9 5753.3 5625.9 5647.2 5678.8 5719.8 5733.3 6024.7 6030.4 6031.3 6046.5 6058.8 4802.4 4850.7 4902.6 4934.8 4946.9 5560.9 5783.4 5808.3 5819.5 5920.3 5661.7 5667.4 5675.0 5682.4 5732.4 5573.9 5696.8 5707.3 5722.5 5745.4 5621.2 5691.9 5708.9 5711.7 5765.7 5698.7 5709.3 5744.3 5761.4 5765.9 5385.7 5560.8 5603.4 5605.2 5635.7 02:39:34 INFO - PROCESS | 19412 | 02:39:34 INFO - PROCESS | 19412 | [#5] yui.html Cycles:180 Average:18295.88 Median:43364.52 stddev:21719.97 (50.1%) stddev-sans-first:21741.43 02:39:34 INFO - PROCESS | 19412 | Values: 858.1 867.6 938.5 945.8 947.2 16178.4 18383.4 18581.4 18588.8 18699.5 16510.8 17325.1 17439.6 17488.4 17503.8 879.9 883.9 893.5 902.4 911.1 889.0 889.0 893.7 895.0 895.4 918.9 923.9 924.7 925.8 930.6 921.6 923.0 924.5 927.3 929.0 679.4 679.9 686.0 686.1 688.3 18157.2 18215.0 18242.4 18754.2 18977.3 14819.9 16331.7 16424.2 16429.4 16751.5 15014.8 15199.4 15203.3 15284.7 15518.6 4081.6 4149.7 4163.8 4177.7 4236.8 80592.6 81416.0 82627.2 83325.2 84814.0 12663.4 12929.4 12990.8 13075.8 13241.3 23597.9 23700.0 23944.4 24209.4 24406.5 8741.7 9137.7 9160.7 9417.6 9470.2 4930.6 5053.9 5082.4 5106.9 5167.1 3775.6 3856.2 3880.5 3882.4 3889.5 638.4 639.9 640.0 648.5 651.5 668.8 672.4 694.6 700.3 860.5 11128.4 11920.6 12704.8 13036.2 13260.6 611.7 620.2 632.2 668.6 870.8 5473.9 5821.9 5911.3 5919.8 5957.1 66523.0 77093.6 77947.8 80741.0 81041.6 43220.6 56221.4 66893.3 69796.7 70298.6 49992.0 56699.7 61082.7 61193.4 61261.8 10240.5 10402.5 10551.3 10641.9 10661.0 43508.5 43605.3 44069.3 44487.8 45054.0 51769.0 51856.2 52747.5 52945.5 56725.0 13473.7 13652.5 14295.7 14322.9 14379.8 16127.4 16760.9 16934.7 17139.5 17261.4 16342.7 16512.7 16833.9 16866.6 17682.8 13393.3 15970.8 16124.4 16161.4 16630.8 14860.7 15362.8 15669.5 15867.2 16203.4 10644.2 10674.6 10728.7 10994.7 11065.4 11353.5 12410.2 12561.7 13002.5 13287.5 02:39:34 INFO - PROCESS | 19412 | -------- Summary: end -------- 02:39:34 INFO - PROCESS | 19412 | 02:39:34 INFO - TEST-INFO | 19412: exit 0 02:39:34 INFO - TEST-OK | dromaeo_css | took 1113524ms 02:39:34 INFO - TEST-START | kraken 02:39:34 INFO - operating with platform_type : linux_ 02:39:34 INFO - Initialising browser for kraken test... 02:39:34 INFO - TEST-INFO | started process 19786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOQHUeM/profile http://localhost:41047/getInfo.html) 02:39:39 INFO - PROCESS | 19786 | __metrics Screen width/height:1600/1200 02:39:39 INFO - PROCESS | 19786 | colorDepth:24 02:39:39 INFO - PROCESS | 19786 | Browser inner width/height: 1024/697 02:39:39 INFO - PROCESS | 19786 | __metrics 02:39:40 ERROR - PROCESS | 19786 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 02:39:41 INFO - TEST-INFO | 19786: exit 0 02:39:41 INFO - Browser initialized. 02:39:41 INFO - Running cycle 1/1 for kraken test... 02:39:41 INFO - TEST-INFO | started process 19917 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOQHUeM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:39:52 INFO - PROCESS | 19917 | RSS: Main: 146829312 02:39:52 INFO - PROCESS | 19917 | 02:39:55 INFO - PROCESS | 19917 | Cycle 1(1): loaded http://localhost:41047/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41047/tests/kraken/driver.html?testName=audio-beat-detection) 02:39:56 INFO - PROCESS | 19917 | RSS: Main: 153227264 02:39:56 INFO - PROCESS | 19917 | 02:39:58 INFO - PROCESS | 19917 | Cycle 1(1): loaded http://localhost:41047/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41047/tests/kraken/driver.html?testName=audio-dft) 02:39:59 INFO - PROCESS | 19917 | RSS: Main: 152014848 02:39:59 INFO - PROCESS | 19917 | 02:40:02 INFO - PROCESS | 19917 | Cycle 1(1): loaded http://localhost:41047/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41047/tests/kraken/driver.html?testName=audio-fft) 02:40:03 INFO - PROCESS | 19917 | RSS: Main: 152805376 02:40:03 INFO - PROCESS | 19917 | 02:40:05 INFO - PROCESS | 19917 | Cycle 1(1): loaded http://localhost:41047/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41047/tests/kraken/driver.html?testName=audio-oscillator) 02:40:05 INFO - PROCESS | 19917 | RSS: Main: 152170496 02:40:05 INFO - PROCESS | 19917 | 02:40:07 INFO - PROCESS | 19917 | Cycle 1(1): loaded http://localhost:41047/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41047/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:40:08 INFO - PROCESS | 19917 | RSS: Main: 152252416 02:40:08 INFO - PROCESS | 19917 | 02:40:11 INFO - PROCESS | 19917 | Cycle 1(1): loaded http://localhost:41047/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41047/tests/kraken/driver.html?testName=imaging-darkroom) 02:40:12 INFO - PROCESS | 19917 | RSS: Main: 155303936 02:40:12 INFO - PROCESS | 19917 | 02:40:15 INFO - PROCESS | 19917 | Cycle 1(1): loaded http://localhost:41047/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41047/tests/kraken/driver.html?testName=imaging-desaturate) 02:40:16 INFO - PROCESS | 19917 | RSS: Main: 153006080 02:40:16 INFO - PROCESS | 19917 | 02:40:19 INFO - PROCESS | 19917 | Cycle 1(1): loaded http://localhost:41047/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41047/tests/kraken/driver.html?testName=json-parse-financial) 02:40:19 INFO - PROCESS | 19917 | RSS: Main: 153788416 02:40:19 INFO - PROCESS | 19917 | 02:40:21 INFO - PROCESS | 19917 | Cycle 1(1): loaded http://localhost:41047/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41047/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:40:21 INFO - PROCESS | 19917 | RSS: Main: 153817088 02:40:21 INFO - PROCESS | 19917 | 02:40:23 INFO - PROCESS | 19917 | Cycle 1(1): loaded http://localhost:41047/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41047/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:40:24 INFO - PROCESS | 19917 | RSS: Main: 153862144 02:40:24 INFO - PROCESS | 19917 | 02:40:26 INFO - PROCESS | 19917 | Cycle 1(1): loaded http://localhost:41047/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41047/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:40:26 INFO - PROCESS | 19917 | RSS: Main: 153976832 02:40:26 INFO - PROCESS | 19917 | 02:40:29 INFO - PROCESS | 19917 | Cycle 1(1): loaded http://localhost:41047/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41047/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:40:30 INFO - PROCESS | 19917 | RSS: Main: 153903104 02:40:30 INFO - PROCESS | 19917 | 02:40:32 INFO - PROCESS | 19917 | Cycle 1(1): loaded http://localhost:41047/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41047/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:40:33 INFO - PROCESS | 19917 | RSS: Main: 154353664 02:40:33 INFO - PROCESS | 19917 | 02:40:35 INFO - PROCESS | 19917 | Cycle 1(1): loaded http://localhost:41047/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41047/tests/kraken/driver.html?testName=ai-astar) 02:40:35 INFO - PROCESS | 19917 | RSS: Main: 156319744 02:40:35 INFO - PROCESS | 19917 | 02:40:35 INFO - PROCESS | 19917 | __start_tp_report 02:40:35 INFO - PROCESS | 19917 | _x_x_mozilla_page_load 02:40:35 INFO - PROCESS | 19917 | _x_x_mozilla_page_load_details 02:40:35 INFO - PROCESS | 19917 | |i|pagename|runs| 02:40:35 INFO - PROCESS | 19917 | |0;ai-astar;105;115;115;114;113;112;114;114;113;112 02:40:35 INFO - PROCESS | 19917 | |1;audio-beat-detection;151;118;122;164;117;119;118;115;143;119 02:40:35 INFO - PROCESS | 19917 | |2;audio-dft;162;162;167;162;163;162;162;162;164;161 02:40:35 INFO - PROCESS | 19917 | |3;audio-fft;76;76;76;106;79;79;81;78;94;76 02:40:35 INFO - PROCESS | 19917 | |4;audio-oscillator;83;82;103;83;83;83;95;83;83;104 02:40:35 INFO - PROCESS | 19917 | |5;imaging-gaussian-blur;114;114;114;114;114;113;113;116;116;114 02:40:35 INFO - PROCESS | 19917 | |6;imaging-darkroom;148;148;152;149;149;148;147;148;148;149 02:40:35 INFO - PROCESS | 19917 | |7;imaging-desaturate;94;94;95;95;95;94;94;95;95;94 02:40:35 INFO - PROCESS | 19917 | |8;json-parse-financial;60;69;59;60;60;59;61;58;58;71 02:40:35 INFO - PROCESS | 19917 | |9;json-stringify-tinderbox;54;54;53;53;52;53;53;53;53;53 02:40:35 INFO - PROCESS | 19917 | |10;stanford-crypto-aes;81;78;80;81;81;75;85;75;76;78 02:40:35 INFO - PROCESS | 19917 | |11;stanford-crypto-ccm;124;127;123;137;122;138;120;119;173;122 02:40:35 INFO - PROCESS | 19917 | |12;stanford-crypto-pbkdf2;165;161;164;159;163;165;161;163;162;159 02:40:35 INFO - PROCESS | 19917 | |13;stanford-crypto-sha256-iterative;64;61;61;60;60;65;60;60;64;60 02:40:35 INFO - PROCESS | 19917 | __end_tp_report 02:40:35 INFO - PROCESS | 19917 | __start_cc_report 02:40:35 INFO - PROCESS | 19917 | _x_x_mozilla_cycle_collect,781 02:40:35 INFO - PROCESS | 19917 | __end_cc_report 02:40:35 INFO - PROCESS | 19917 | __startTimestamp1491817235533__endTimestamp 02:40:35 INFO - PROCESS | 19917 | 02:40:35 INFO - PROCESS | 19917 | ------- Summary: start ------- 02:40:35 INFO - PROCESS | 19917 | Number of tests: 14 02:40:35 INFO - PROCESS | 19917 | 02:40:35 INFO - PROCESS | 19917 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:2.91 (2.6%) stddev-sans-first:1.13 02:40:35 INFO - PROCESS | 19917 | Values: 105.0 115.0 115.0 114.0 113.0 112.0 114.0 114.0 113.0 112.0 02:40:35 INFO - PROCESS | 19917 | 02:40:35 INFO - PROCESS | 19917 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:120.50 stddev:17.43 (14.5%) stddev-sans-first:16.50 02:40:35 INFO - PROCESS | 19917 | Values: 151.0 118.0 122.0 164.0 117.0 119.0 118.0 115.0 143.0 119.0 02:40:35 INFO - PROCESS | 19917 | 02:40:35 INFO - PROCESS | 19917 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.00 stddev:1.70 (1.1%) stddev-sans-first:1.79 02:40:35 INFO - PROCESS | 19917 | Values: 162.0 162.0 167.0 162.0 163.0 162.0 162.0 162.0 164.0 161.0 02:40:35 INFO - PROCESS | 19917 | 02:40:35 INFO - PROCESS | 19917 | [#3] audio-fft Cycles:10 Average:82.10 Median:78.50 stddev:9.99 (12.7%) stddev-sans-first:10.35 02:40:35 INFO - PROCESS | 19917 | Values: 76.0 76.0 76.0 106.0 79.0 79.0 81.0 78.0 94.0 76.0 02:40:35 INFO - PROCESS | 19917 | 02:40:35 INFO - PROCESS | 19917 | [#4] audio-oscillator Cycles:10 Average:88.20 Median:83.00 stddev:8.92 (10.7%) stddev-sans-first:9.26 02:40:35 INFO - PROCESS | 19917 | Values: 83.0 82.0 103.0 83.0 83.0 83.0 95.0 83.0 83.0 104.0 02:40:35 INFO - PROCESS | 19917 | 02:40:35 INFO - PROCESS | 19917 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:1.03 (0.9%) stddev-sans-first:1.09 02:40:35 INFO - PROCESS | 19917 | Values: 114.0 114.0 114.0 114.0 114.0 113.0 113.0 116.0 116.0 114.0 02:40:35 INFO - PROCESS | 19917 | 02:40:35 INFO - PROCESS | 19917 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.50 stddev:1.35 (0.9%) stddev-sans-first:1.41 02:40:35 INFO - PROCESS | 19917 | Values: 148.0 148.0 152.0 149.0 149.0 148.0 147.0 148.0 148.0 149.0 02:40:35 INFO - PROCESS | 19917 | 02:40:35 INFO - PROCESS | 19917 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 02:40:35 INFO - PROCESS | 19917 | Values: 94.0 94.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 94.0 02:40:35 INFO - PROCESS | 19917 | 02:40:35 INFO - PROCESS | 19917 | [#8] json-parse-financial Cycles:10 Average:61.50 Median:60.00 stddev:4.60 (7.7%) stddev-sans-first:4.85 02:40:35 INFO - PROCESS | 19917 | Values: 60.0 69.0 59.0 60.0 60.0 59.0 61.0 58.0 58.0 71.0 02:40:35 INFO - PROCESS | 19917 | 02:40:35 INFO - PROCESS | 19917 | [#9] json-stringify-tinderbox Cycles:10 Average:53.10 Median:53.00 stddev:0.57 (1.1%) stddev-sans-first:0.50 02:40:35 INFO - PROCESS | 19917 | Values: 54.0 54.0 53.0 53.0 52.0 53.0 53.0 53.0 53.0 53.0 02:40:35 INFO - PROCESS | 19917 | 02:40:35 INFO - PROCESS | 19917 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:80.50 stddev:3.20 (4.0%) stddev-sans-first:3.31 02:40:35 INFO - PROCESS | 19917 | Values: 81.0 78.0 80.0 81.0 81.0 75.0 85.0 75.0 76.0 78.0 02:40:35 INFO - PROCESS | 19917 | 02:40:35 INFO - PROCESS | 19917 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:125.50 stddev:16.34 (13.0%) stddev-sans-first:17.16 02:40:35 INFO - PROCESS | 19917 | Values: 124.0 127.0 123.0 137.0 122.0 138.0 120.0 119.0 173.0 122.0 02:40:35 INFO - PROCESS | 19917 | 02:40:35 INFO - PROCESS | 19917 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:163.00 stddev:2.20 (1.4%) stddev-sans-first:2.09 02:40:35 INFO - PROCESS | 19917 | Values: 165.0 161.0 164.0 159.0 163.0 165.0 161.0 163.0 162.0 159.0 02:40:35 INFO - PROCESS | 19917 | 02:40:35 INFO - PROCESS | 19917 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:61.00 stddev:2.01 (3.3%) stddev-sans-first:1.92 02:40:35 INFO - PROCESS | 19917 | Values: 64.0 61.0 61.0 60.0 60.0 65.0 60.0 60.0 64.0 60.0 02:40:35 INFO - PROCESS | 19917 | -------- Summary: end -------- 02:40:35 INFO - PROCESS | 19917 | 02:40:36 INFO - TEST-INFO | 19917: exit 0 02:40:36 INFO - TEST-OK | kraken | took 61665ms 02:40:36 INFO - SUITE-END | took 1175s 02:40:36 INFO - Completed test suite (00:19:35) 02:40:36 INFO - javascript benchmark 02:40:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7959.388334207849, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3435.5190273361727, 3460.117669994152, 3472.305538892222, 3486.0239133042724, 3502.0, 5834.124881267812, 5858.589898707092, 5879.353271140171, 5950.613210141343, 5955.404459554043, 5914.526837852972, 5957.463828255456, 5963.105534169877, 5971.910421343672, 5975.133605627181, 5321.4412486688825, 5442.374126975389, 5445.156000819879, 5460.2464500409515, 5508.283923089993, 5490.56075513958, 5494.560435165177, 5496.532794712454, 5512.6968016759065, 5515.972420137894, 5291.550218231436, 5311.9468805312035, 5440.537554307889, 5488.615796894219, 5522.22688823565, 5321.52106310432, 5343.572514198855, 5365.812196573102, 5383.219433182206, 5404.5676345892625, 5297.629165958385, 5369.0604144274985, 5376.838694839161, 5395.10980688186, 5414.43148469409, 5565.0817615093465, 5898.056310990264, 5910.527157827363, 5936.228290322274, 5975.701214939236, 6101.481374083208, 6128.044828652048, 6155.784547540815, 6168.19813424252, 6228.377162283736, 6327.8734425311695, 6337.588056776295, 6341.112244285804, 6350.872982540323, 6354.0, 5853.795117170921, 5869.295684517842, 5875.0, 5875.970620146872, 5916.26046744157, 6121.056693972082, 6148.661823599745, 6223.0, 6231.657258850716, 6273.780417685451, 6143.204841796972, 6170.382961703794, 6191.442770150708, 6203.96898015516, 6206.875862482815, 6274.811755647338, 6275.874482510416, 6287.0, 6306.936930630727, 6309.179806625109, 6016.488598469092, 6079.8480037998515, 6139.907901381483, 6145.385461453819, 6149.41580549847, 6287.842803929939, 6296.5592408530965, 6298.307186209513, 6311.684415779193, 6316.05259211122, 4657.953420465752, 4692.967547139624, 4694.319323698045, 4723.645726570521, 4830.9275360869615, 4249.086446414036, 4256.638185754246, 4261.936070958938, 4283.336082907154, 4304.031592891574, 5906.7637294508595, 5967.224260846062, 6070.605410648382, 6113.877722445526, 6131.14164017038, 6252.906206406908, 6307.526935479766, 6352.0789485525265, 6359.268684101295, 6369.5541312108635, 6108.297545782292, 6112.449879510866, 6125.203723515914, 6125.816225513242, 6150.7847225346895, 5156.664816786897, 5164.896702066013, 5317.54800841925, 5320.893582128336, 5338.759755810997, 6378.84052898672, 6423.839404014937, 6513.804585862432, 6520.347965203537, 6527.379898909691, 6241.469475094668, 6242.344553821783, 6246.500279977682, 6248.156498872776, 6266.68666566679, 6330.145430367026, 6440.806775796734, 6467.417932386108, 6498.415142637185, 6512.185976752906, 6113.266408031065, 6121.05669397217, 6132.172156758959, 6187.597806142587, 6232.719527621177, 6310.148130002391, 6312.053192021233, 6321.1782468278825, 6342.112104305309, 6346.746130154742, 6115.235595550556, 6177.444030037139, 6181.876362472815, 6190.628562286277, 6191.380861913773, 5968.791092311922, 5987.31145918225, 6090.573659843769, 6105.877882442415, 6124.969375153096, 6181.907271391023, 6195.2875419325555, 6217.409346112112, 6221.377862213742, 6239.5008399327035, 5936.168936349001, 6205.968970155121, 6270.655113968775, 6271.686415679289, 6277.96861015692, 5869.090291004901, 5903.734331954986, 5922.437368449991, 5929.851753706192, 5974.61165024272], "value": 5795.55674910441, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.9404047676184, 803.1446509467418, 816.4570560577215, 879.6745204274415, 880.2913654508119, 42345.0, 43541.129177416435, 43570.0, 43602.0, 47722.28416573745, 44347.33478997809, 44358.778206108924, 44602.33096503555, 44649.77675111628, 44768.10463790722, 9071.22894553962, 9209.677661281856, 10183.236257280696, 10448.58205671776, 10697.144228461744, 10295.22785791065, 10389.636362727306, 10398.532066057007, 10401.37591744494, 10405.323653962469, 10446.32098913572, 10473.528691208914, 10480.895191048068, 10504.107150892183, 10504.894951050506, 10373.948130259376, 10391.688249352532, 10441.216908731838, 10443.477826108665, 10458.0, 10166.288359814816, 10179.949100254451, 10205.081542661123, 10261.07650311468, 10277.48612569376, 36838.07904802375, 36849.44725829115, 37025.629743702484, 37085.81457092724, 37258.81370593157, 4046.4132700758223, 4068.6134817192615, 4127.050778320973, 4134.131832315217, 4155.044339801862, 27566.862165689243, 27782.166535003984, 27941.096398960526, 28101.29746756327, 28272.43455130886, 4267.359896015591, 4286.935695964563, 4290.0561876387455, 4329.7618630975285, 4363.607275345203, 235369.0, 237878.0, 242654.0, 247583.0, 248027.0, 45672.3149152763, 45777.771111144895, 46105.0, 46105.0, 46145.53854461479, 47079.29381059287, 47088.05823883503, 47088.764556177, 47097.76451117722, 47150.292745608844, 15524.456644017631, 15601.297941592655, 15735.606609834846, 15741.134237616812, 15743.448979285899, 13682.657933551742, 13683.31583420825, 13706.314684265746, 13708.52020179309, 13721.039527233197, 12842.165259258118, 12938.223706577635, 12961.611151665466, 12966.351682415841, 13023.413946372437, 5254.868628284247, 5319.69105024931, 5350.197470379397, 5419.539339156216, 5441.510264076173, 1232.679503329141, 1235.116891422637, 1283.646997075793, 1284.278015423237, 1293.2369901758009, 27004.0, 27218.183454496397, 27260.31849203786, 27497.31256718598, 28134.85932570365, 1385.736710025092, 1389.8749112579917, 1398.2309729648653, 1412.1244828206577, 1419.9929000354932, 14283.64290892736, 14356.860043904933, 14662.853371466363, 14708.632284192981, 14737.0, 345628.0, 346283.0, 347049.0, 347580.0, 348000.0, 59508.70245648744, 59533.70233148893, 59865.700671496365, 59893.0, 60083.39916600778, 1478.0909740509724, 1505.1044628446057, 1544.4208421841809, 1549.2718422341482, 1561.125769569045, 26713.0, 26911.86544067267, 27721.861390692917, 27898.30254243579, 28260.85869570639, 44408.33387499126, 44490.332645010996, 44531.0, 44593.331100032876, 44723.77638111789, 322676.0, 322807.0, 323511.3824430863, 324893.0, 326270.0, 29866.402671946005, 30521.694783051884, 33131.50302745509, 33157.0, 33269.83365083256, 39503.407448888865, 39735.602643974344, 39802.0, 40033.199336012534, 40492.595074048884, 31173.376532469676, 31205.37589248157, 31485.842570787914, 31591.526127107652, 31593.81090648697, 30781.614827333273, 30986.535201972438, 31366.0, 31491.84254078715, 31813.36373272568, 35136.47295290521, 35160.82419587988, 35419.468707969914, 35434.822825885705, 35540.822295888356, 30181.547276791305, 30265.092047238617, 30357.24106897257, 30487.695123049372, 30799.0, 23856.88071559631, 25234.62148067817, 25761.454312741294, 25859.482810344063, 26108.73891261063], "value": 18849.051780816102, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.1841776890442, 469.3429199121232, 477.90441911617677, 481.1051444313576, 492.42878261217, 19948.40154795355, 21589.352319430403, 22221.888890555525, 22242.110315587397, 22398.21606243782, 22224.333270001884, 22383.55232895341, 22521.54956900861, 23027.539449211006, 23291.534169316605, 6611.6694165291665, 6647.867042659144, 6831.419329357011, 6855.383015528601, 6855.760048398307, 6643.966780166116, 6781.898271525906, 7076.929230707704, 7363.631818409085, 7543.396528277752, 7311.744088956888, 7524.811879703024, 7550.6979720811105, 7551.0, 7557.508761930484, 7631.542107473541, 7712.3444507216955, 7714.614269286513, 7720.498167619115, 7731.922680773177, 7270.818229544304, 7409.407247420193, 7434.145073316529, 7464.477486575942, 7468.2531746825425, 24920.626190607156, 25085.122020729188, 25159.0, 25555.61666575003, 25711.0, 3095.349976504937, 3157.905262842118, 3180.8250546219947, 3212.6626704195955, 3238.4656531672244, 15791.605209869846, 15975.760363594556, 16223.351065957466, 16501.257443415074, 16801.747973780402, 2225.9666105008437, 2263.875486848223, 2274.636058230675, 2286.0627142871344, 2294.1855641247453, 113498.43250783776, 115239.42380288128, 115850.42074789657, 116103.0, 117987.0, 17836.9108154461, 18272.817271827378, 18311.52081104586, 18312.626553008577, 18484.445466635752, 30965.69034309628, 31004.29476378776, 31053.534196987064, 31268.218294542818, 31556.526652100238, 10702.785944281226, 10747.462626868626, 10835.51240194193, 10879.12966962641, 11101.722456938642, 9105.863412048824, 9129.406588571854, 9199.816003680024, 9281.535923203814, 9311.90688093124, 9113.908860911439, 9412.05879412067, 9475.099865512766, 9580.56887440067, 9702.70891873245, 3535.9292814144087, 3797.936577758232, 3824.560175579844, 3927.783971881574, 3978.4285207342937, 909.0999910088964, 919.2554031234721, 921.3044151665583, 922.7693076730817, 930.6975233049286, 21010.894945525175, 21159.25942592002, 21292.787072129082, 21395.572088558143, 21422.821744803874, 1042.9478526073665, 1104.2380757277454, 1112.0825319111766, 1123.5505797680994, 1134.4044376702298, 11142.0, 11350.318980861175, 11504.309741415542, 11541.672707638561, 11618.360990145624, 647212.0, 651158.0, 654068.0, 660145.0, 667600.0, 90068.5496572526, 97915.51042244743, 98915.0, 110936.0, 120079.0, 1350.3113412159673, 1351.7769568021363, 1375.559820857316, 1386.6741315790782, 1390.4855203574741, 18817.0, 19324.71012934779, 19458.221671132997, 19522.121504532046, 19567.0, 37792.43311350277, 45453.77273113613, 47652.80867978328, 53076.73461632667, 53386.0, 63600.36399635945, 66724.0, 77688.0, 77698.6115069421, 77941.0, 12771.042171837335, 12961.481540738265, 13295.534656286984, 13351.198928064347, 13517.121387110199, 14189.0, 14406.279686015449, 14542.41830326775, 14722.705545889237, 14997.400103995718, 12508.749825003631, 12910.548130815376, 12966.481340746264, 13144.474221031052, 13146.73706525845, 12091.214071085351, 12299.631011069681, 12330.876691232972, 12428.440720167795, 12548.30984295836, 13092.80360794608, 13224.801627975396, 13412.915029543065, 13613.931930340681, 13635.795463067863, 12993.480260789462, 13016.088873778745, 13152.342382881008, 13294.667633309246, 13295.468181272641, 12794.104412691022, 12835.101542892282, 12860.164089334163, 12931.288779116863, 12932.224066556037], "value": 11778.597060006472, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1560.695664345453, 1574.3859894641091, 1581.9683606327872, 1592.0447731361185, 1599.6160921378864, 9629.277804164698, 9884.802303953917, 10804.783904321908, 11525.654230373082, 11542.24975376601, 11057.06014988725, 11428.771424571503, 11760.941195294012, 11772.823407648872, 11795.70510737232, 2414.782669559739, 2451.080844683244, 2452.1907770435714, 2452.3869032741813, 2453.6074228123503, 2406.747291534381, 2452.362385779701, 2461.6184491403774, 2466.0628960994795, 2471.1721573272885, 2411.40920474484, 2413.9758602414013, 2418.5404773093146, 2420.540097381501, 2434.610462326028, 2287.3938406322336, 2325.6046472099783, 2333.5216280662426, 2338.251759436981, 2348.342464110052, 2247.5280191159877, 2257.4694946687514, 2291.7937385635205, 2298.7241531016384, 2315.23597212921, 11452.541898324058, 11688.94155529217, 11729.941350293278, 11729.941350293278, 11742.647720568397, 5818.970905145447, 5981.431763982415, 5988.251468566429, 5993.430624090704, 6007.15899774032, 3398.8640454381793, 3491.336646037245, 3528.223790766053, 3530.6116327203986, 3558.430651095838, 1274.7323062156865, 1291.5737806523825, 1292.5088466382715, 1359.2320339008527, 1365.4196966289287, 17529.298828046863, 17564.736528952075, 17565.385211517536, 17585.56036099095, 17635.294588216457, 4860.1737704590305, 5147.716875571879, 5156.690598564098, 5173.1464308388695, 5203.7918483261, 13245.536406225929, 13250.271235082164, 13272.469101235842, 13300.3349832508, 13301.40143693536, 5993.220881285492, 6000.369961154016, 6020.668863212565, 6022.909656355158, 6027.367126451747, 5520.641158324696, 5524.392316845144, 5527.778888844482, 5565.471280228372, 5631.380548139701, 4101.200265948111, 4150.418941348154, 4173.686973476941, 4190.5180904195795, 4212.789360532022, 1062.946852657364, 1067.9893201068046, 1069.8769641491172, 1085.766560189563, 1086.7228856641507, 1075.4568942683895, 1101.0971003776986, 1109.5395410904384, 1115.7489564847845, 1116.330201878866, 7467.962660186773, 7487.775366739006, 7506.737264195836, 7533.773986780406, 7732.8453430932195, 1071.5338827610015, 1107.1585594947899, 1111.6887271563976, 1137.0789660374958, 1143.2625956258166, 4666.2067448533835, 4671.159191345522, 4702.130105930414, 4712.552307530847, 4773.737444440589, 14239.35922883452, 14684.486042988658, 14893.70212595742, 14988.40046398132, 14997.850021499646, 14619.85380146185, 14671.77992330116, 14913.70172596542, 14925.179115148554, 14927.253637318308, 10043.146332561813, 10143.08712215904, 10167.898321016695, 10203.28576999603, 10274.691759247235, 7251.673674684546, 7277.454190935807, 7495.737649182252, 7540.811479713051, 7659.731909383145, 13455.259960702255, 13569.864301357255, 13625.31873406306, 13716.65708357299, 13750.518731844337, 11602.5358985643, 12904.677383065124, 13594.660133496742, 13793.86206137966, 13991.370388332753, 9318.301127415336, 9418.434893906388, 9423.434593924387, 9470.668526601536, 9471.289653275893, 10998.395088270221, 11010.449477526252, 11235.101191904792, 11321.603743868925, 11383.829242561535, 9368.718938431857, 9369.859452108087, 9422.104900034486, 9481.241500680067, 9719.951400242953, 8904.421212621419, 9014.729558113268, 9095.545222738969, 9227.400218985744, 9256.07439256069, 8096.5546894921345, 8224.424290299621, 8228.753137405887, 8306.335493160654, 8307.792305192419, 6157.84605384869, 6329.430351268408, 6336.1446204763615, 6358.523110766619, 6386.361363863763, 6403.199600049994, 6458.483321334376, 6506.089147519257, 6531.673416329069, 6662.034005069335], "value": 5458.996598031844, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.7476139554873, 439.14586129977187, 441.19702142101386, 443.79807187729574, 445.83058437793636, 5363.704996225206, 5407.188921661753, 5424.213489044087, 5426.701531415771, 5444.0, 5263.34208223972, 5381.67709937404, 5387.0, 5400.381744231365, 5422.9728851355785, 4456.910861782771, 4524.886877828048, 4533.659975501834, 4543.636509079282, 4553.5901768840795, 4536.412255710491, 4551.180787458256, 4555.794989225493, 4557.908841823161, 4581.244094724367, 4374.737515749065, 4524.072565124142, 4525.298578720303, 4527.4114365132655, 4545.409096817409, 4482.327650852399, 4491.505934347219, 4504.28837041922, 4531.410916580857, 4566.429196350457, 4217.304144816102, 4222.493300803892, 4226.513950895655, 4237.0, 4281.678874084456, 5147.588192944556, 5263.867863726994, 5269.314989051399, 5293.497117773805, 5320.51025712801, 5215.791368345262, 5237.895242095175, 5249.4488078751565, 5283.55089817366, 5307.177387504943, 5618.415528856731, 5621.184928185431, 5622.48192987891, 5627.0, 5640.715510218368, 4609.654275929285, 4640.67515273931, 4679.719216847, 4703.718696432227, 4742.146413645542, 5552.472515111058, 5603.047481928082, 5749.0, 5834.708264586754, 5844.503217226541, 4807.351007613997, 4807.471178170398, 4813.566778989908, 4846.321514987904, 4852.369192005087, 4877.439094504107, 4901.745197209252, 4911.631627627942, 4914.33656456381, 4971.328870602422, 5065.670731402521, 5171.069986810052, 5182.896342073137, 5291.3700512051955, 5321.840344789663, 5594.412586678422, 5648.780195288646, 5686.914696279559, 5703.914441283384, 5723.513501352431, 1691.5114699064745, 1701.591618011693, 1715.7769489966224, 1716.5794380376637, 1723.284836792742, 1233.8334324866028, 1326.2639235224542, 1329.8404191497082, 1332.9469718922137, 1356.7015256643522, 5349.919751203735, 5508.256385388001, 5527.806526771544, 5541.307336582927, 5618.887622247532, 5790.652560846278, 5799.797007104816, 5838.38696936824, 5861.3552509223955, 5874.970625146932, 5250.527452529291, 5466.633341664584, 5536.916946245809, 5543.889122217533, 5561.6095976006, 2999.6250468691414, 3079.0147152910854, 3091.520814273791, 3095.520194369876, 3098.659147493774, 6018.488428483628, 6036.909446358308, 6043.582566973158, 6054.8183554493435, 6080.69596520181, 5756.02147634903, 5851.64890106595, 5891.823245302648, 5913.556483263773, 5930.733117009745, 5937.435943585352, 5968.522518198533, 5974.462298393166, 5981.850453738692, 6005.759769609167, 5535.916961245665, 5705.258316418839, 5708.743106560131, 5726.885462290814, 5753.309602847517, 5625.8593535161945, 5647.232855900661, 5678.801241956512, 5719.799807006735, 5733.340665823317, 6024.698765061817, 6030.3668114847305, 6031.276246850231, 6046.516278697605, 6058.818235452944, 4802.351682522814, 4850.660453768202, 4902.578252306791, 4934.827281045146, 4946.901061978812, 5560.888782224414, 5783.368567301952, 5808.332041815245, 5819.476247137778, 5920.348761636303, 5661.688607126647, 5667.404922483245, 5675.0, 5682.374938756816, 5732.398098199629, 5573.944260557505, 5696.832149409278, 5707.258056452634, 5722.456366645162, 5745.368009519033, 5621.229312766465, 5691.930269857072, 5708.942910570841, 5711.657300561979, 5765.682887441231, 5698.686572238566, 5709.34342550612, 5744.281964754406, 5761.39505351932, 5765.8558536036935, 5385.6768593882925, 5560.805371811967, 5603.439656034364, 5605.24329215567, 5635.6618602883955], "value": 4564.774854115013, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [858.0689951402728, 867.6486023160622, 938.5306901513616, 945.7588314979679, 947.1570302430838, 16178.352865885365, 18383.44849654511, 18581.44255672332, 18588.814111858876, 18699.532511687215, 16510.83489165108, 17325.133743312814, 17439.564010899732, 17488.38790642328, 17503.82496175038, 879.9208071273584, 883.924866386358, 893.4728510178993, 902.3908861518448, 911.0570559470949, 888.9911100889005, 889.0353965946955, 893.7229458867772, 894.9552522373888, 895.3642913531401, 918.8529835226365, 923.852183650616, 924.6763632728558, 925.8055808280269, 930.5533343994887, 921.5852866210232, 923.0308176414771, 924.5007695844236, 927.3276874266103, 928.967486137982, 679.4428568573722, 679.894616334469, 685.9691313890887, 686.0772261308532, 688.3323176518819, 18157.182926768328, 18214.998175100365, 18242.361517346963, 18754.249830006782, 18977.335793247308, 14819.925900370537, 16331.673366532603, 16424.1787910604, 16429.424970125987, 16751.497455076365, 15014.849851501454, 15199.392024319124, 15203.315850786741, 15284.694306113926, 15518.612034699223, 4081.6122468365456, 4149.730267532631, 4163.812628431698, 4177.728447650893, 4236.766977816219, 80592.59703701503, 81416.0, 82627.17372826315, 83325.16674833234, 84814.0, 12663.36683165838, 12929.418176182095, 12990.805137922938, 13075.803862942064, 13241.271730054747, 23597.882010589838, 23700.0, 23944.40138996504, 24209.39476513066, 24406.51186976286, 8741.694040708544, 9137.725868223964, 9160.725178244664, 9417.576209070472, 9470.242380609534, 4930.556249937523, 5053.898922021539, 5082.364704411949, 5106.872328191751, 5167.121589329823, 3775.5846856845724, 3856.151646637735, 3880.476135721698, 3882.398228274622, 3889.533256009297, 638.4381744065192, 639.8752243312509, 639.9744010239539, 648.5427773419727, 651.5146216069058, 668.7600612119188, 672.3780503034674, 694.6040756768695, 700.3066963705894, 860.4665107633182, 11128.383275435515, 11920.642380728592, 12704.80942785859, 13036.217826930415, 13260.557713166198, 611.7430679114782, 620.1813606040074, 632.1907957814005, 668.5787953589207, 870.7953630896734, 5473.890522189534, 5821.941780582225, 5911.261092363455, 5919.792807251725, 5957.106434034843, 66523.0, 77093.61453192699, 77947.83078253831, 80741.0, 81041.59479202566, 43220.56779432228, 56221.43778562244, 66893.33106668969, 69796.6510167446, 70298.64850675817, 49992.0001599966, 56699.71650141723, 61082.69458652767, 61193.38806611966, 61261.77476450446, 10240.53917573696, 10402.531886064993, 10551.314164579278, 10641.946790266, 10661.0, 43508.477203297734, 43605.345919811865, 44069.33895991499, 44487.77756111199, 45054.0, 51769.0, 51856.222156666925, 52747.47252527426, 52945.4705452956, 56725.0, 13473.730525389241, 13652.522161724291, 14295.714085718435, 14322.856771432569, 14379.784303235669, 16127.354905804106, 16760.916195418944, 16934.74780422853, 17139.485815425556, 17261.39585114515, 16342.673146536765, 16512.66974660524, 16833.91583042077, 16866.578335541708, 17682.82317176812, 13393.330333483482, 15970.840291596935, 16124.355025798837, 16161.353545858034, 16630.75053874217, 14860.702785944004, 15362.846371536141, 15669.45156919548, 15867.206639668202, 16203.351865925231, 10644.20168487382, 10674.62638807638, 10728.73178170552, 10994.670159895217, 11065.391403472886, 11353.489092991, 12410.193337433038, 12561.685957851127, 13002.479900803863, 13287.534936277183], "value": 7929.226450821861, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1479.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 115.0, 114.0, 113.0, 112.0, 114.0, 114.0, 113.0, 112.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 118.0, 122.0, 164.0, 117.0, 119.0, 118.0, 115.0, 143.0, 119.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 167.0, 162.0, 163.0, 162.0, 162.0, 162.0, 164.0, 161.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 106.0, 79.0, 79.0, 81.0, 78.0, 94.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 103.0, 83.0, 83.0, 83.0, 95.0, 83.0, 83.0, 104.0], "value": 88.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 116.0, 116.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 152.0, 149.0, 149.0, 148.0, 147.0, 148.0, 148.0, 149.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 69.0, 59.0, 60.0, 60.0, 59.0, 61.0, 58.0, 58.0, 71.0], "value": 61.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 53.0, 52.0, 53.0, 53.0, 53.0, 53.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 80.0, 81.0, 81.0, 75.0, 85.0, 75.0, 76.0, 78.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 127.0, 123.0, 137.0, 122.0, 138.0, 120.0, 119.0, 173.0, 122.0], "value": 130.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 161.0, 164.0, 159.0, 163.0, 165.0, 161.0, 163.0, 162.0, 159.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 61.0, 60.0, 60.0, 65.0, 60.0, 60.0, 64.0, 60.0], "value": 61.5, "unit": "score"}]}]} 02:40:36 INFO - Return code: 0 02:40:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:40:36 ERROR - # TBPL SUCCESS # 02:40:36 INFO - Running post-action listener: _resource_record_post_action 02:40:36 INFO - [mozharness: 2017-04-10 09:40:36.848506Z] Finished run-tests step (success) 02:40:36 INFO - Running post-run listener: _resource_record_post_run 02:40:36 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 251629568; Read time: 12; Write time: 239052 02:40:36 INFO - TinderboxPrint: CPU usage
13.4% 02:40:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 02:40:36 INFO - TinderboxPrint: I/O write bytes / time
251,629,568 / 239,052 02:40:36 INFO - TinderboxPrint: CPU idle
8,232.2 (86.6%) 02:40:36 INFO - TinderboxPrint: CPU user
1,218.1 (12.8%) 02:40:36 INFO - TinderboxPrint: Swap in / out
0 / 0 02:40:36 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 6275072; Read time: 0; Write time: 3320 02:40:36 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 245354496; Read time: 12; Write time: 235732 02:40:37 INFO - Running post-run listener: _upload_blobber_files 02:40:37 INFO - Blob upload gear active. 02:40:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:40:37 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 02:40:37 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', 'Mozilla-Aurora-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:40:37 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 Mozilla-Aurora-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:40:37 INFO - (blobuploader) - INFO - Open directory for files ... 02:40:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:40:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:40:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:38 INFO - (blobuploader) - INFO - Done attempting. 02:40:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:40:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:40:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:40 INFO - (blobuploader) - INFO - Done attempting. 02:40:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:40:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:40:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:43 INFO - (blobuploader) - INFO - Done attempting. 02:40:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:40:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:40:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:44 INFO - (blobuploader) - INFO - Done attempting. 02:40:44 INFO - (blobuploader) - INFO - Iteration through files over. 02:40:44 INFO - Return code: 0 02:40:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:40:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:40:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/691a555f7d17e3c47db55319ebdd11c8300c26d3953face0967ca1f481ac6e888573bade1cb71cd5fbee6389afdbf4c199bbc3b665f15ac21818de5ee6c91729", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/093e12c3fd26eca339c98799f653f3423656405b9825619eac81ee5b9ff674da9d4ddd432f4a0072f5682d718b6f9f686f006e8fe5fb8088e9fed34c81d25224", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/af1923c0fbc7d16c83f03ed8012d9a4dac6155fd4ae9a622c7f601c8a11467c4c6e3059b8b7137f9e56fbdac54307b584e548a9bbe82475428017841571fbeac", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/7871fc7d62f22c2d908be4945b4c8b35f261f66f9d6e85f75cde2c314292052429e51d64ad0d9cd403e73ce00917152c6fa65eac07ca31bf28bebbb8acbedfdd"} 02:40:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:40:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:40:44 INFO - Contents: 02:40:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/691a555f7d17e3c47db55319ebdd11c8300c26d3953face0967ca1f481ac6e888573bade1cb71cd5fbee6389afdbf4c199bbc3b665f15ac21818de5ee6c91729", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/093e12c3fd26eca339c98799f653f3423656405b9825619eac81ee5b9ff674da9d4ddd432f4a0072f5682d718b6f9f686f006e8fe5fb8088e9fed34c81d25224", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/af1923c0fbc7d16c83f03ed8012d9a4dac6155fd4ae9a622c7f601c8a11467c4c6e3059b8b7137f9e56fbdac54307b584e548a9bbe82475428017841571fbeac", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/7871fc7d62f22c2d908be4945b4c8b35f261f66f9d6e85f75cde2c314292052429e51d64ad0d9cd403e73ce00917152c6fa65eac07ca31bf28bebbb8acbedfdd"} 02:40:44 INFO - Running post-run listener: copy_logs_to_upload_dir 02:40:44 INFO - Copying logs to upload dir... 02:40:44 INFO - mkdir: /builds/slave/test/build/upload/logs 02:40:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1357.617080 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 37 secs) (at 2017-04-10 02:40:44.101550) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 02:40:44.105647) ========= 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=5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/691a555f7d17e3c47db55319ebdd11c8300c26d3953face0967ca1f481ac6e888573bade1cb71cd5fbee6389afdbf4c199bbc3b665f15ac21818de5ee6c91729", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/093e12c3fd26eca339c98799f653f3423656405b9825619eac81ee5b9ff674da9d4ddd432f4a0072f5682d718b6f9f686f006e8fe5fb8088e9fed34c81d25224", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/af1923c0fbc7d16c83f03ed8012d9a4dac6155fd4ae9a622c7f601c8a11467c4c6e3059b8b7137f9e56fbdac54307b584e548a9bbe82475428017841571fbeac", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/7871fc7d62f22c2d908be4945b4c8b35f261f66f9d6e85f75cde2c314292052429e51d64ad0d9cd403e73ce00917152c6fa65eac07ca31bf28bebbb8acbedfdd"} build_url:https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011216 build_url: 'https://queue.taskcluster.net/v1/task/A-PNzku5Szm4d5WhgYlXKQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/691a555f7d17e3c47db55319ebdd11c8300c26d3953face0967ca1f481ac6e888573bade1cb71cd5fbee6389afdbf4c199bbc3b665f15ac21818de5ee6c91729", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/093e12c3fd26eca339c98799f653f3423656405b9825619eac81ee5b9ff674da9d4ddd432f4a0072f5682d718b6f9f686f006e8fe5fb8088e9fed34c81d25224", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/af1923c0fbc7d16c83f03ed8012d9a4dac6155fd4ae9a622c7f601c8a11467c4c6e3059b8b7137f9e56fbdac54307b584e548a9bbe82475428017841571fbeac", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/7871fc7d62f22c2d908be4945b4c8b35f261f66f9d6e85f75cde2c314292052429e51d64ad0d9cd403e73ce00917152c6fa65eac07ca31bf28bebbb8acbedfdd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 02:40:44.131260) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 02:40:44.131585) ========= 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=5cf47e208febbcd81da23b2e0000026f-1491815861.78675-1429120105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 02:40:44.217105) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 02:40:44.217429) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 02:40:44.217782) ========= ========= Total master_lag: 0.17 =========