builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1491947099.83 results: success (0) revision: af42f039717e4b4ffe43d5a131b1daf1e00ef9e4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-11 14:44:59.828294) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-11 14:44:59.828780) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-11 14:44:59.829070) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-11 14:44:59.868691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 14:44:59.869132) ========= 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=ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-11 14:44:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2017-04-11 14:45:00 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146619 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 14:45:00.065121) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 14:45:00.065449) ========= 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=ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013789 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 14:45:00.091607) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-11 14:45:00.091920) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev af42f039717e4b4ffe43d5a131b1daf1e00ef9e4 --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 af42f039717e4b4ffe43d5a131b1daf1e00ef9e4 --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=ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-11 14:45:00,218 truncating revision to first 12 chars 2017-04-11 14:45:00,218 Setting DEBUG logging. 2017-04-11 14:45:00,218 attempt 1/10 2017-04-11 14:45:00,218 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/af42f039717e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-11 14:45:01,222 unpacking tar archive at: mozilla-aurora-af42f039717e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.546320 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-11 14:45:01.651807) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-11 14:45:01.652152) ========= script_repo_revision: af42f039717e4b4ffe43d5a131b1daf1e00ef9e4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-11 14:45:01.652568) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-11 14:45:01.652833) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-11 14:45:01.663241) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-04-11 14:45:01.663826) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:45:01 INFO - MultiFileLogger online at 20170411 14:45:01 in /builds/slave/test 14:45:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 14:45:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:45:01 INFO - {'append_to_log': False, 14:45:01 INFO - 'base_work_dir': '/builds/slave/test', 14:45:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 14:45:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:45:01 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 14:45:01 INFO - 'buildbot_json_path': 'buildprops.json', 14:45:01 INFO - 'config_files': ('talos/linux_config.py',), 14:45:01 INFO - 'default_actions': ('clobber', 14:45:01 INFO - 'read-buildbot-config', 14:45:01 INFO - 'download-and-extract', 14:45:01 INFO - 'populate-webroot', 14:45:01 INFO - 'create-virtualenv', 14:45:01 INFO - 'install', 14:45:01 INFO - 'run-tests'), 14:45:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:45:01 INFO - 'download_minidump_stackwalk': True, 14:45:01 INFO - 'download_symbols': 'ondemand', 14:45:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:45:01 INFO - 'tooltool.py': '/tools/tooltool.py', 14:45:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:45:01 INFO - '/tools/misc-python/virtualenv.py')}, 14:45:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:45:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:45:01 INFO - 'gecko_profile': False, 14:45:01 INFO - 'gecko_profile_interval': 0, 14:45:01 INFO - 'installer_path': 'installer.exe', 14:45:01 INFO - 'log_level': 'info', 14:45:01 INFO - 'log_name': 'talos', 14:45:01 INFO - 'log_to_console': True, 14:45:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:45:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:45:01 INFO - 'opt_config_files': (), 14:45:01 INFO - 'pip_index': False, 14:45:01 INFO - 'suite': 'dromaeojs', 14:45:01 INFO - 'system_bits': '32', 14:45:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:45:01 INFO - 'title': 'talos-linux64-ix-035', 14:45:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:45:01 INFO - 'use_talos_json': True, 14:45:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:45:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:45:01 INFO - 'work_dir': 'build'} 14:45:01 INFO - [mozharness: 2017-04-11 21:45:01.891215Z] Running clobber step. 14:45:01 INFO - Running pre-action listener: _resource_record_pre_action 14:45:01 INFO - Running main action method: clobber 14:45:01 INFO - rmtree: /builds/slave/test/build 14:45:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:45:02 INFO - Running post-action listener: _resource_record_post_action 14:45:02 INFO - [mozharness: 2017-04-11 21:45:02.837240Z] Finished clobber step (success) 14:45:02 INFO - [mozharness: 2017-04-11 21:45:02.837340Z] Running read-buildbot-config step. 14:45:02 INFO - Running pre-action listener: _resource_record_pre_action 14:45:02 INFO - Running main action method: read_buildbot_config 14:45:02 INFO - Using buildbot properties: 14:45:02 INFO - { 14:45:02 INFO - "project": "", 14:45:02 INFO - "product": "firefox", 14:45:02 INFO - "who": "ryanvm@gmail.com", 14:45:02 INFO - "installer_path": "public/build/target.tar.bz2", 14:45:02 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 14:45:02 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 14:45:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 14:45:02 INFO - "stage_platform": "linux64", 14:45:02 INFO - "basedir": "/builds/slave/test", 14:45:02 INFO - "buildnumber": 125, 14:45:02 INFO - "platform": "ubuntu64_hw", 14:45:02 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:45:02 INFO - "slavebuilddir": "test", 14:45:02 INFO - "taskId": "fURcDxMgQzuO_JabZdFqyQ", 14:45:02 INFO - "branch": "mozilla-aurora", 14:45:02 INFO - "script_repo_revision": "production", 14:45:02 INFO - "revision": "af42f039717e4b4ffe43d5a131b1daf1e00ef9e4", 14:45:02 INFO - "slavename": "talos-linux64-ix-035", 14:45:02 INFO - "repo_path": "releases/mozilla-aurora" 14:45:02 INFO - } 14:45:02 INFO - Finding installer, test and symbols from parent task. 14:45:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fURcDxMgQzuO_JabZdFqyQ'}, attempt #1 14:45:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fURcDxMgQzuO_JabZdFqyQ'}, attempt #1 14:45:03 INFO - Task dependencies: P26-C5B9TXKaSsc9yhW6Uw 14:45:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw'}, attempt #1 14:45:04 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/target.tar.bz2 14:45:04 INFO - Set test_url: https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/test_packages.json 14:45:04 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/target.crashreporter-symbols.zip 14:45:04 INFO - Running post-action listener: _resource_record_post_action 14:45:04 INFO - [mozharness: 2017-04-11 21:45:04.210685Z] Finished read-buildbot-config step (success) 14:45:04 INFO - [mozharness: 2017-04-11 21:45:04.210948Z] Running download-and-extract step. 14:45:04 INFO - Running pre-action listener: _resource_record_pre_action 14:45:04 INFO - Running main action method: download_and_extract 14:45:04 INFO - mkdir: /builds/slave/test/build/tests 14:45: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')]} 14:45:04 INFO - trying https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/target.test_packages.json 14:45:04 INFO - Downloading https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:45:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:45:04 INFO - Downloaded 896 bytes. 14:45:04 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:45:04 INFO - Using the following test package requirements: 14:45:04 INFO - {u'common': [u'target.common.tests.zip'], 14:45:04 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:45:04 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:45:04 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:45:04 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:45:04 INFO - u'mozbase': [u'target.common.tests.zip'], 14:45:04 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:45:04 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:45:04 INFO - u'web-platform': [u'target.common.tests.zip', 14:45:04 INFO - u'target.web-platform.tests.zip'], 14:45:04 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:45:04 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:45:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/target.common.tests.zip 14:45:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:45:04 INFO - Fetch https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/target.common.tests.zip into memory 14:45:05 INFO - Expected file size: 59543640 14:45:05 INFO - Obtained file size: 59543640 14:45:15 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:45:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/target.common.tests.zip 14:45:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:45:15 INFO - Fetch https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/target.common.tests.zip into memory 14:45:16 INFO - Expected file size: 59543640 14:45:16 INFO - Obtained file size: 59543640 14:45:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/target.talos.tests.zip 14:45:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:45:27 INFO - Fetch https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/target.talos.tests.zip into memory 14:45:28 INFO - Expected file size: 14404424 14:45:28 INFO - Obtained file size: 14404424 14:45:28 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')]} 14:45:28 INFO - trying https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/target.tar.bz2 14:45:28 INFO - Downloading https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:45:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:45:29 INFO - Downloaded 66714914 bytes. 14:45:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/target.tar.bz2 14:45:29 INFO - mkdir: /builds/slave/test/properties 14:45:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:45:29 INFO - Writing to file /builds/slave/test/properties/build_url 14:45:29 INFO - Contents: 14:45:29 INFO - build_url:https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/target.tar.bz2 14:45:29 INFO - Running post-action listener: _resource_record_post_action 14:45:29 INFO - Running post-action listener: set_extra_try_arguments 14:45:29 INFO - [mozharness: 2017-04-11 21:45:29.659878Z] Finished download-and-extract step (success) 14:45:29 INFO - [mozharness: 2017-04-11 21:45:29.659975Z] Running populate-webroot step. 14:45:29 INFO - Running pre-action listener: _resource_record_pre_action 14:45:29 INFO - Running main action method: populate_webroot 14:45:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:45:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:45:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:45:29 INFO - '--tppagecycles', 14:45:29 INFO - '7'], 14:45:29 INFO - 'tests': ['tsvgm']}}, 14:45:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:45:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:45:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:45:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:45:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:45:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:45:29 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:45:29 INFO - 'talos_options': ['--disable-e10s'], 14:45:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:45:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:45:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:45:29 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:45:29 INFO - 'talos_options': ['--disable-e10s'], 14:45:29 INFO - 'tests': ['damp', 'tps']}, 14:45:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:45:29 INFO - 'tests': ['damp', 'tps']}, 14:45:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:45:29 INFO - 'tests': ['dromaeo_dom']}, 14:45:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:45:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:45:29 INFO - 'tests': ['basic_compositor_video']}, 14:45:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:45:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:45:29 INFO - 'tests': ['a11yr', 14:45:29 INFO - 'ts_paint', 14:45:29 INFO - 'tpaint', 14:45:29 INFO - 'sessionrestore', 14:45:29 INFO - 'sessionrestore_no_auto_restore', 14:45:29 INFO - 'tabpaint']}, 14:45:29 INFO - 'other-e10s': {'tests': ['a11yr', 14:45:29 INFO - 'ts_paint', 14:45:29 INFO - 'tpaint', 14:45:29 INFO - 'sessionrestore', 14:45:29 INFO - 'sessionrestore_no_auto_restore', 14:45:29 INFO - 'tabpaint']}, 14:45:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:45:29 INFO - 'ts_paint', 14:45:29 INFO - 'tpaint', 14:45:29 INFO - 'sessionrestore', 14:45:29 INFO - 'sessionrestore_no_auto_restore', 14:45:29 INFO - 'tabpaint']}, 14:45:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:45:29 INFO - 'ts_paint', 14:45:29 INFO - 'tpaint', 14:45:29 INFO - 'sessionrestore', 14:45:29 INFO - 'sessionrestore_no_auto_restore', 14:45:29 INFO - 'tabpaint']}, 14:45:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:45:29 INFO - 'tests': ['a11yr', 14:45:29 INFO - 'ts_paint', 14:45:29 INFO - 'tpaint', 14:45:29 INFO - 'sessionrestore', 14:45:29 INFO - 'sessionrestore_no_auto_restore', 14:45:29 INFO - 'tabpaint']}, 14:45:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:45:29 INFO - 'tests': ['a11yr', 14:45:29 INFO - 'ts_paint', 14:45:29 INFO - 'tpaint', 14:45:29 INFO - 'sessionrestore', 14:45:29 INFO - 'sessionrestore_no_auto_restore', 14:45:29 INFO - 'tabpaint']}, 14:45:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:45:29 INFO - 'tests': ['tsvgx', 14:45:29 INFO - 'tsvgr_opacity', 14:45:29 INFO - 'tart', 14:45:29 INFO - 'tscrollx', 14:45:29 INFO - 'cart', 14:45:29 INFO - 'tsvg_static']}, 14:45:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:45:29 INFO - 'tsvgr_opacity', 14:45:29 INFO - 'tart', 14:45:29 INFO - 'tscrollx', 14:45:29 INFO - 'cart', 14:45:29 INFO - 'tsvg_static']}, 14:45:29 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:45:29 INFO - 'talos_options': ['--disable-e10s'], 14:45:29 INFO - 'tests': ['tp5o']}, 14:45:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:45:29 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:45:29 INFO - 'talos_options': ['--disable-e10s', 14:45:29 INFO - '--xperf_path', 14:45:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:45:29 INFO - 'tests': ['tp5n']}, 14:45:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:45:29 INFO - 'talos_options': ['--xperf_path', 14:45:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:45:29 INFO - 'tests': ['tp5n']}}, 14:45:29 INFO - 'talos.zip': {'path': '', 14:45:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:45:29 INFO - Running post-action listener: _resource_record_post_action 14:45:29 INFO - [mozharness: 2017-04-11 21:45:29.673186Z] Finished populate-webroot step (success) 14:45:29 INFO - [mozharness: 2017-04-11 21:45:29.673277Z] Running create-virtualenv step. 14:45:29 INFO - Running pre-action listener: _resource_record_pre_action 14:45:29 INFO - Running main action method: create_virtualenv 14:45:29 INFO - Creating virtualenv /builds/slave/test/build/venv 14:45:29 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 14:45:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:45:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:45:29 INFO - Using real prefix '/usr' 14:45:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:45:30 INFO - Installing distribute.............................................................................................................................................................................................done. 14:45:32 INFO - Installing pip.................done. 14:45:32 INFO - Return code: 0 14:45:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:45:32 INFO - Reading from file tmpfile_stdout 14:45:32 INFO - Output received: 14:45:32 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) 14:45:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:32 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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1902310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff400>, '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 0x19003b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900840>, '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': 'ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466', '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 14:45:32 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 14:45:32 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 14:45:32 INFO - Using env: {'DISPLAY': ':0', 14:45:32 INFO - 'HOME': '/home/cltbld', 14:45:32 INFO - 'LANG': 'en_US.UTF-8', 14:45:32 INFO - 'LANGUAGE': 'en_US:en', 14:45:32 INFO - 'LOGNAME': 'cltbld', 14:45:32 INFO - 'MAIL': '/var/mail/cltbld', 14:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:32 INFO - 'MOZ_NO_REMOTE': '1', 14:45:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:32 INFO - 'NO_EM_RESTART': '1', 14:45:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:32 INFO - 'PWD': '/builds/slave/test', 14:45:32 INFO - 'SHELL': '/bin/bash', 14:45:32 INFO - 'SHLVL': '1', 14:45:32 INFO - 'TERM': 'linux', 14:45:32 INFO - 'TMOUT': '86400', 14:45:32 INFO - 'USER': 'cltbld', 14:45:32 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466', 14:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:32 INFO - '_': '/tools/buildbot/bin/python'} 14:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:32 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 14:45:32 INFO - Cleaning up... 14:45:32 INFO - Return code: 0 14:45:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:32 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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1902310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff400>, '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 0x19003b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900840>, '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': 'ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466', '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 14:45:32 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 14:45:32 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 14:45:32 INFO - Using env: {'DISPLAY': ':0', 14:45:32 INFO - 'HOME': '/home/cltbld', 14:45:32 INFO - 'LANG': 'en_US.UTF-8', 14:45:32 INFO - 'LANGUAGE': 'en_US:en', 14:45:32 INFO - 'LOGNAME': 'cltbld', 14:45:32 INFO - 'MAIL': '/var/mail/cltbld', 14:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:32 INFO - 'MOZ_NO_REMOTE': '1', 14:45:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:32 INFO - 'NO_EM_RESTART': '1', 14:45:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:32 INFO - 'PWD': '/builds/slave/test', 14:45:32 INFO - 'SHELL': '/bin/bash', 14:45:32 INFO - 'SHLVL': '1', 14:45:32 INFO - 'TERM': 'linux', 14:45:32 INFO - 'TMOUT': '86400', 14:45:32 INFO - 'USER': 'cltbld', 14:45:32 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466', 14:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:32 INFO - '_': '/tools/buildbot/bin/python'} 14:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:32 INFO - Downloading/unpacking psutil>=3.1.1 14:45:32 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 14:45:32 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 14:45:32 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 14:45:32 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 14:45:32 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 14:45:32 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 14:45:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:45:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:45:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:45:35 INFO - Installing collected packages: psutil 14:45:35 INFO - Running setup.py install for psutil 14:45:35 INFO - building 'psutil._psutil_linux' extension 14:45:35 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 14:45: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 14:45:35 INFO - building 'psutil._psutil_posix' extension 14:45: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 14:45: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 14:45:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:45:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:45:35 INFO - Successfully installed psutil 14:45:35 INFO - Cleaning up... 14:45:35 INFO - Return code: 0 14:45:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:45: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')]} 14:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45: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')]} 14:45:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:35 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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1902310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff400>, '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 0x19003b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900840>, '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': 'ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466', '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 14:45:35 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 14:45:35 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 14:45:35 INFO - Using env: {'DISPLAY': ':0', 14:45:35 INFO - 'HOME': '/home/cltbld', 14:45:35 INFO - 'LANG': 'en_US.UTF-8', 14:45:35 INFO - 'LANGUAGE': 'en_US:en', 14:45:35 INFO - 'LOGNAME': 'cltbld', 14:45:35 INFO - 'MAIL': '/var/mail/cltbld', 14:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:35 INFO - 'MOZ_NO_REMOTE': '1', 14:45:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:35 INFO - 'NO_EM_RESTART': '1', 14:45:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:35 INFO - 'PWD': '/builds/slave/test', 14:45:35 INFO - 'SHELL': '/bin/bash', 14:45:35 INFO - 'SHLVL': '1', 14:45:35 INFO - 'TERM': 'linux', 14:45:35 INFO - 'TMOUT': '86400', 14:45:35 INFO - 'USER': 'cltbld', 14:45:35 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466', 14:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:35 INFO - '_': '/tools/buildbot/bin/python'} 14:45:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:45:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:45:37 INFO - Installing collected packages: mozsystemmonitor 14:45:37 INFO - Running setup.py install for mozsystemmonitor 14:45:37 INFO - Successfully installed mozsystemmonitor 14:45:37 INFO - Cleaning up... 14:45:38 INFO - Return code: 0 14:45:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:45:38 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')]} 14:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:38 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')]} 14:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:38 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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1902310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff400>, '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 0x19003b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900840>, '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': 'ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466', '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 14:45:38 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 14:45:38 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 14:45:38 INFO - Using env: {'DISPLAY': ':0', 14:45:38 INFO - 'HOME': '/home/cltbld', 14:45:38 INFO - 'LANG': 'en_US.UTF-8', 14:45:38 INFO - 'LANGUAGE': 'en_US:en', 14:45:38 INFO - 'LOGNAME': 'cltbld', 14:45:38 INFO - 'MAIL': '/var/mail/cltbld', 14:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:38 INFO - 'MOZ_NO_REMOTE': '1', 14:45:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:38 INFO - 'NO_EM_RESTART': '1', 14:45:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:38 INFO - 'PWD': '/builds/slave/test', 14:45:38 INFO - 'SHELL': '/bin/bash', 14:45:38 INFO - 'SHLVL': '1', 14:45:38 INFO - 'TERM': 'linux', 14:45:38 INFO - 'TMOUT': '86400', 14:45:38 INFO - 'USER': 'cltbld', 14:45:38 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466', 14:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:38 INFO - '_': '/tools/buildbot/bin/python'} 14:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:38 INFO - Downloading/unpacking jsonschema==2.5.1 14:45:38 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 14:45:38 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 14:45:38 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 14:45:38 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 14:45:38 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 14:45:38 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 14:45:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:45:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:45:40 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 14:45:40 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 14:45:40 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 14:45:40 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 14:45:40 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 14:45:40 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 14:45:40 INFO - Downloading functools32-3.2.3-2.tar.gz 14:45:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:45:40 INFO - warning: no files found matching '*.txt' 14:45:40 INFO - no previously-included directories found matching 'build' 14:45:40 INFO - no previously-included directories found matching 'dist' 14:45:40 INFO - no previously-included directories found matching '.git*' 14:45:40 INFO - Installing collected packages: jsonschema, functools32 14:45:40 INFO - Running setup.py install for functools32 14:45:40 INFO - warning: no files found matching '*.txt' 14:45:40 INFO - no previously-included directories found matching 'build' 14:45:40 INFO - no previously-included directories found matching 'dist' 14:45:40 INFO - no previously-included directories found matching '.git*' 14:45:40 INFO - Successfully installed jsonschema functools32 14:45:40 INFO - Cleaning up... 14:45:40 INFO - Return code: 0 14:45:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:45: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')]} 14:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45: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')]} 14:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:40 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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1902310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff400>, '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 0x19003b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900840>, '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': 'ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466', '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 14:45:40 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 14:45:40 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 14:45:40 INFO - Using env: {'DISPLAY': ':0', 14:45:40 INFO - 'HOME': '/home/cltbld', 14:45:40 INFO - 'LANG': 'en_US.UTF-8', 14:45:40 INFO - 'LANGUAGE': 'en_US:en', 14:45:40 INFO - 'LOGNAME': 'cltbld', 14:45:40 INFO - 'MAIL': '/var/mail/cltbld', 14:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:40 INFO - 'MOZ_NO_REMOTE': '1', 14:45:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:40 INFO - 'NO_EM_RESTART': '1', 14:45:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:40 INFO - 'PWD': '/builds/slave/test', 14:45:40 INFO - 'SHELL': '/bin/bash', 14:45:40 INFO - 'SHLVL': '1', 14:45:40 INFO - 'TERM': 'linux', 14:45:40 INFO - 'TMOUT': '86400', 14:45:40 INFO - 'USER': 'cltbld', 14:45:40 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466', 14:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:40 INFO - '_': '/tools/buildbot/bin/python'} 14:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:45:40 INFO - Cleaning up... 14:45:40 INFO - Return code: 0 14:45:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:45: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')]} 14:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45: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')]} 14:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:40 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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1902310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff400>, '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 0x19003b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900840>, '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': 'ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466', '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 14:45:40 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 14:45:40 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 14:45:40 INFO - Using env: {'DISPLAY': ':0', 14:45:40 INFO - 'HOME': '/home/cltbld', 14:45:40 INFO - 'LANG': 'en_US.UTF-8', 14:45:40 INFO - 'LANGUAGE': 'en_US:en', 14:45:40 INFO - 'LOGNAME': 'cltbld', 14:45:40 INFO - 'MAIL': '/var/mail/cltbld', 14:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:40 INFO - 'MOZ_NO_REMOTE': '1', 14:45:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:40 INFO - 'NO_EM_RESTART': '1', 14:45:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:40 INFO - 'PWD': '/builds/slave/test', 14:45:40 INFO - 'SHELL': '/bin/bash', 14:45:40 INFO - 'SHLVL': '1', 14:45:40 INFO - 'TERM': 'linux', 14:45:40 INFO - 'TMOUT': '86400', 14:45:40 INFO - 'USER': 'cltbld', 14:45:40 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466', 14:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:40 INFO - '_': '/tools/buildbot/bin/python'} 14:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:41 INFO - Downloading/unpacking blobuploader==1.2.4 14:45:41 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 14:45:41 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 14:45:41 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 14:45:41 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 14:45:41 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 14:45:41 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 14:45:43 INFO - Downloading blobuploader-1.2.4.tar.gz 14:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:45:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:45:43 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 14:45:43 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 14:45:43 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 14:45:43 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 14:45:43 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 14:45:43 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 14:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:45:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:45:43 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 14:45:43 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 14:45:43 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 14:45:43 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 14:45:43 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 14:45:43 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 14:45:44 INFO - Downloading docopt-0.6.1.tar.gz 14:45:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:45:44 INFO - Installing collected packages: blobuploader, requests, docopt 14:45:44 INFO - Running setup.py install for blobuploader 14:45:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:45:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:45:44 INFO - Running setup.py install for requests 14:45:44 INFO - Running setup.py install for docopt 14:45:44 INFO - Successfully installed blobuploader requests docopt 14:45:44 INFO - Cleaning up... 14:45:44 INFO - Return code: 0 14:45:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:45:44 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')]} 14:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:44 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')]} 14:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:44 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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1902310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff400>, '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 0x19003b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900840>, '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': 'ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466', '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 14:45:44 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 14:45:44 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 14:45:44 INFO - Using env: {'DISPLAY': ':0', 14:45:44 INFO - 'HOME': '/home/cltbld', 14:45:44 INFO - 'LANG': 'en_US.UTF-8', 14:45:44 INFO - 'LANGUAGE': 'en_US:en', 14:45:44 INFO - 'LOGNAME': 'cltbld', 14:45:44 INFO - 'MAIL': '/var/mail/cltbld', 14:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:44 INFO - 'MOZ_NO_REMOTE': '1', 14:45:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:44 INFO - 'NO_EM_RESTART': '1', 14:45:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:44 INFO - 'PWD': '/builds/slave/test', 14:45:44 INFO - 'SHELL': '/bin/bash', 14:45:44 INFO - 'SHLVL': '1', 14:45:44 INFO - 'TERM': 'linux', 14:45:44 INFO - 'TMOUT': '86400', 14:45:44 INFO - 'USER': 'cltbld', 14:45:44 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466', 14:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:44 INFO - '_': '/tools/buildbot/bin/python'} 14:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:45:45 INFO - Running setup.py (path:/tmp/pip-R0YYfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:45:45 INFO - Running setup.py (path:/tmp/pip-iy1X28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:45:45 INFO - Running setup.py (path:/tmp/pip-GH697c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:45:45 INFO - Running setup.py (path:/tmp/pip-_QOmQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:45:45 INFO - Running setup.py (path:/tmp/pip-9FGwJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:45:45 INFO - Running setup.py (path:/tmp/pip-tjsNRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:45:45 INFO - Running setup.py (path:/tmp/pip-clQ_gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:45:45 INFO - Running setup.py (path:/tmp/pip-yuWwLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:45:45 INFO - Running setup.py (path:/tmp/pip-NuFm2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:45:45 INFO - Running setup.py (path:/tmp/pip-VAcIBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:45:45 INFO - Running setup.py (path:/tmp/pip-bFs2xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:45:45 INFO - Running setup.py (path:/tmp/pip-baFRSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:45:45 INFO - Running setup.py (path:/tmp/pip-NkzsuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:45:45 INFO - Running setup.py (path:/tmp/pip-yNFLob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:45:46 INFO - Running setup.py (path:/tmp/pip-CvxPve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:45:46 INFO - Running setup.py (path:/tmp/pip-d_GHrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:45:46 INFO - Running setup.py (path:/tmp/pip-DHYzSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:45:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:45:46 INFO - Running setup.py install for manifestparser 14:45:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:45:46 INFO - Running setup.py install for mozcrash 14:45:46 INFO - Running setup.py install for mozdebug 14:45:46 INFO - Running setup.py install for mozdevice 14:45:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:45:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:45:46 INFO - Running setup.py install for mozfile 14:45:46 INFO - Running setup.py install for mozhttpd 14:45:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:45:46 INFO - Running setup.py install for mozinfo 14:45:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:45:46 INFO - Running setup.py install for mozInstall 14:45:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:45:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:45:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:45:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:45:47 INFO - Running setup.py install for mozleak 14:45:47 INFO - Running setup.py install for mozlog 14:45:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:45:47 INFO - Running setup.py install for moznetwork 14:45:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:45:47 INFO - Running setup.py install for mozprocess 14:45:47 INFO - Running setup.py install for mozprofile 14:45:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:45:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:45:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:45:47 INFO - Running setup.py install for mozrunner 14:45:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:45:47 INFO - Running setup.py install for mozscreenshot 14:45:47 INFO - Running setup.py install for moztest 14:45:47 INFO - Running setup.py install for mozversion 14:45:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:45:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:45:48 INFO - Cleaning up... 14:45:48 INFO - Return code: 0 14:45:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:45:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:48 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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1902310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff400>, '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 0x19003b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900840>, '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': 'ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466', '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 14:45:48 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 14:45:48 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 14:45:48 INFO - Using env: {'DISPLAY': ':0', 14:45:48 INFO - 'HOME': '/home/cltbld', 14:45:48 INFO - 'LANG': 'en_US.UTF-8', 14:45:48 INFO - 'LANGUAGE': 'en_US:en', 14:45:48 INFO - 'LOGNAME': 'cltbld', 14:45:48 INFO - 'MAIL': '/var/mail/cltbld', 14:45:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:48 INFO - 'MOZ_NO_REMOTE': '1', 14:45:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:48 INFO - 'NO_EM_RESTART': '1', 14:45:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:48 INFO - 'PWD': '/builds/slave/test', 14:45:48 INFO - 'SHELL': '/bin/bash', 14:45:48 INFO - 'SHLVL': '1', 14:45:48 INFO - 'TERM': 'linux', 14:45:48 INFO - 'TMOUT': '86400', 14:45:48 INFO - 'USER': 'cltbld', 14:45:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466', 14:45:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:48 INFO - '_': '/tools/buildbot/bin/python'} 14:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:45:48 INFO - Running setup.py (path:/tmp/pip-CN4PtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:45:48 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)) 14:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:45:48 INFO - Running setup.py (path:/tmp/pip-bfZbeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:45:48 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)) 14:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:45:48 INFO - Running setup.py (path:/tmp/pip-Y2CCXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:45:48 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)) 14:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:45:48 INFO - Running setup.py (path:/tmp/pip-YhgtyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:45:48 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)) 14:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:45:48 INFO - Running setup.py (path:/tmp/pip-iHQxpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:45:48 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)) 14:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:45:48 INFO - Running setup.py (path:/tmp/pip-LUSP4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:45:48 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)) 14:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:45:48 INFO - Running setup.py (path:/tmp/pip-7F_pjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:45:48 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)) 14:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:45:48 INFO - Running setup.py (path:/tmp/pip-qNqSr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:45:48 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)) 14:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:45:48 INFO - Running setup.py (path:/tmp/pip-vYNQcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:45:48 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)) 14:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:45:48 INFO - Running setup.py (path:/tmp/pip-AwDAFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:45:48 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)) 14:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:45:48 INFO - Running setup.py (path:/tmp/pip-hTk026-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:45:49 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)) 14:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:45:49 INFO - Running setup.py (path:/tmp/pip-0lmGHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:45:49 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)) 14:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:45:49 INFO - Running setup.py (path:/tmp/pip-PwEKse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:45:49 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)) 14:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:45:49 INFO - Running setup.py (path:/tmp/pip-nr7k2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:45:49 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)) 14:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:45:49 INFO - Running setup.py (path:/tmp/pip-bljOPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:45:49 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)) 14:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:45:49 INFO - Running setup.py (path:/tmp/pip-bSjVAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:45:49 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)) 14:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:45:49 INFO - Running setup.py (path:/tmp/pip-Gkimci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:45:49 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)) 14:45:49 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)) 14:45:49 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)) 14:45:49 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)) 14:45:49 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)) 14:45:49 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)) 14:45:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:45:49 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 14:45:49 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 14:45:49 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 14:45:49 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 14:45:49 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 14:45:49 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 14:45:51 INFO - Downloading blessings-1.6.tar.gz 14:45:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:45:51 INFO - Installing collected packages: blessings 14:45:51 INFO - Running setup.py install for blessings 14:45:51 INFO - Successfully installed blessings 14:45:51 INFO - Cleaning up... 14:45:51 INFO - Return code: 0 14:45:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:45:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:45:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:45:51 INFO - Reading from file tmpfile_stdout 14:45:51 INFO - Current package versions: 14:45:51 INFO - argparse == 1.2.1 14:45:51 INFO - blessings == 1.6 14:45:51 INFO - blobuploader == 1.2.4 14:45:51 INFO - docopt == 0.6.1 14:45:51 INFO - functools32 == 3.2.3-2 14:45:51 INFO - jsonschema == 2.5.1 14:45:51 INFO - manifestparser == 1.1 14:45:51 INFO - mozInstall == 1.12 14:45:51 INFO - mozcrash == 1.0 14:45:51 INFO - mozdebug == 0.1 14:45:51 INFO - mozdevice == 0.49 14:45:51 INFO - mozfile == 1.2 14:45:51 INFO - mozhttpd == 0.7 14:45:51 INFO - mozinfo == 0.9 14:45:51 INFO - mozleak == 0.1 14:45:51 INFO - mozlog == 3.4 14:45:51 INFO - moznetwork == 0.27 14:45:51 INFO - mozprocess == 0.25 14:45:51 INFO - mozprofile == 0.28 14:45:51 INFO - mozrunner == 6.13 14:45:51 INFO - mozscreenshot == 0.1 14:45:51 INFO - mozsystemmonitor == 0.3 14:45:51 INFO - moztest == 0.8 14:45:51 INFO - mozversion == 1.4 14:45:51 INFO - psutil == 3.1.1 14:45:51 INFO - requests == 1.2.3 14:45:51 INFO - wsgiref == 0.1.2 14:45:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:45:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:52 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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1902310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff400>, '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 0x19003b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900840>, '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': 'ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466', '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 14:45:52 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 14:45:52 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 14:45:52 INFO - Using env: {'DISPLAY': ':0', 14:45:52 INFO - 'HOME': '/home/cltbld', 14:45:52 INFO - 'LANG': 'en_US.UTF-8', 14:45:52 INFO - 'LANGUAGE': 'en_US:en', 14:45:52 INFO - 'LOGNAME': 'cltbld', 14:45:52 INFO - 'MAIL': '/var/mail/cltbld', 14:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:52 INFO - 'MOZ_NO_REMOTE': '1', 14:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:52 INFO - 'NO_EM_RESTART': '1', 14:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:52 INFO - 'PWD': '/builds/slave/test', 14:45:52 INFO - 'SHELL': '/bin/bash', 14:45:52 INFO - 'SHLVL': '1', 14:45:52 INFO - 'TERM': 'linux', 14:45:52 INFO - 'TMOUT': '86400', 14:45:52 INFO - 'USER': 'cltbld', 14:45:52 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466', 14:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:52 INFO - '_': '/tools/buildbot/bin/python'} 14:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:52 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)) 14:45:52 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)) 14:45:52 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)) 14:45:52 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)) 14:45:52 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)) 14:45:52 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)) 14:45:52 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)) 14:45:52 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)) 14:45:52 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)) 14:45:52 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)) 14:45:52 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)) 14:45:52 INFO - Cleaning up... 14:45:52 INFO - Return code: 0 14:45:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:45:52 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')]} 14:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:52 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')]} 14:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:52 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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1902310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff400>, '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 0x19003b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900840>, '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': 'ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466', '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 14:45:52 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 14:45:52 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 14:45:52 INFO - Using env: {'DISPLAY': ':0', 14:45:52 INFO - 'HOME': '/home/cltbld', 14:45:52 INFO - 'LANG': 'en_US.UTF-8', 14:45:52 INFO - 'LANGUAGE': 'en_US:en', 14:45:52 INFO - 'LOGNAME': 'cltbld', 14:45:52 INFO - 'MAIL': '/var/mail/cltbld', 14:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:52 INFO - 'MOZ_NO_REMOTE': '1', 14:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:52 INFO - 'NO_EM_RESTART': '1', 14:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:52 INFO - 'PWD': '/builds/slave/test', 14:45:52 INFO - 'SHELL': '/bin/bash', 14:45:52 INFO - 'SHLVL': '1', 14:45:52 INFO - 'TERM': 'linux', 14:45:52 INFO - 'TMOUT': '86400', 14:45:52 INFO - 'USER': 'cltbld', 14:45:52 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466', 14:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:52 INFO - '_': '/tools/buildbot/bin/python'} 14:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:45:52 INFO - Cleaning up... 14:45:52 INFO - Return code: 0 14:45:52 INFO - Running post-action listener: _resource_record_post_action 14:45:52 INFO - Running post-action listener: _start_resource_monitoring 14:45:52 INFO - Starting resource monitoring. 14:45:52 INFO - [mozharness: 2017-04-11 21:45:52.590488Z] Finished create-virtualenv step (success) 14:45:52 INFO - [mozharness: 2017-04-11 21:45:52.591032Z] Running install step. 14:45:52 INFO - Running pre-action listener: _resource_record_pre_action 14:45:52 INFO - Running main action method: install 14:45:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:45:52 INFO - Reading from file tmpfile_stdout 14:45:52 INFO - Detecting whether we're running mozinstall >=1.0... 14:45:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:45:52 INFO - Reading from file tmpfile_stdout 14:45:52 INFO - Output received: 14:45:52 INFO - Usage: mozinstall [options] installer 14:45:52 INFO - Options: 14:45:52 INFO - -h, --help show this help message and exit 14:45:52 INFO - -d DEST, --destination=DEST 14:45:52 INFO - Directory to install application into. [default: 14:45:52 INFO - "/builds/slave/test"] 14:45:52 INFO - --app=APP Application being installed. [default: firefox] 14:45:52 INFO - mkdir: /builds/slave/test/build/application 14:45:52 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'] 14:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:46:09 INFO - Reading from file tmpfile_stdout 14:46:09 INFO - Output received: 14:46:09 INFO - /builds/slave/test/build/application/firefox/firefox 14:46:09 INFO - Running post-action listener: _resource_record_post_action 14:46:09 INFO - [mozharness: 2017-04-11 21:46:09.447322Z] Finished install step (success) 14:46:09 INFO - [mozharness: 2017-04-11 21:46:09.447592Z] Running run-tests step. 14:46:09 INFO - Running pre-action listener: _resource_record_pre_action 14:46:09 INFO - Running main action method: run_tests 14:46:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:46:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:46:09 INFO - Python 2.7.3 14:46:09 INFO - Return code: 0 14:46:09 INFO - grabbing minidump binary from tooltool 14:46:09 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')]} 14:46:09 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 0x18ff400>, '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 0x19003b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:46:09 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 14:46:09 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 14:46:09 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 14:46:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:46:09 INFO - Return code: 0 14:46:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:46:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:46:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:46:09 INFO - ENV: RUST_BACKTRACE is now 1 14:46:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:46:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:46:09 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:46:09 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:46:09 INFO - Using env: {'DISPLAY': ':0', 14:46:09 INFO - 'HOME': '/home/cltbld', 14:46:09 INFO - 'LANG': 'en_US.UTF-8', 14:46:09 INFO - 'LANGUAGE': 'en_US:en', 14:46:09 INFO - 'LOGNAME': 'cltbld', 14:46:09 INFO - 'MAIL': '/var/mail/cltbld', 14:46:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:46:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:09 INFO - 'MOZ_NO_REMOTE': '1', 14:46:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:46:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:09 INFO - 'NO_EM_RESTART': '1', 14:46:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:09 INFO - 'PWD': '/builds/slave/test', 14:46:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:46:09 INFO - 'RUST_BACKTRACE': '1', 14:46:09 INFO - 'SHELL': '/bin/bash', 14:46:09 INFO - 'SHLVL': '1', 14:46:09 INFO - 'TERM': 'linux', 14:46:09 INFO - 'TMOUT': '86400', 14:46:09 INFO - 'USER': 'cltbld', 14:46:09 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466', 14:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:09 INFO - '_': '/tools/buildbot/bin/python'} 14:46:09 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:46:09 INFO - mozversion application_buildid: 20170411203059 14:46:09 INFO - mozversion application_changeset: af42f039717e4b4ffe43d5a131b1daf1e00ef9e4 14:46:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:46:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:46:09 INFO - mozversion application_name: Firefox 14:46:09 INFO - mozversion application_remotingname: firefox-dev 14:46:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:46:09 INFO - mozversion application_vendor: Mozilla 14:46:09 INFO - mozversion application_version: 54.0a2 14:46:09 INFO - mozversion platform_buildid: 20170411203059 14:46:09 INFO - mozversion platform_changeset: af42f039717e4b4ffe43d5a131b1daf1e00ef9e4 14:46:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:46:09 INFO - mozversion platform_version: 54.0a2 14:46:09 INFO - using testdate: 1491947169 14:46:09 INFO - actual date: 1491947169 14:46:09 INFO - starting webserver on 'localhost:38641' 14:46:09 INFO - SUITE-START | Running 2 tests 14:46:09 INFO - TEST-START | dromaeo_css 14:46:09 INFO - operating with platform_type : linux_ 14:46:09 INFO - Initialising browser for dromaeo_css test... 14:46:09 INFO - TEST-INFO | started process 24967 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZhZi_7/profile http://localhost:38641/getInfo.html) 14:46:13 INFO - PROCESS | 24967 | __metrics Screen width/height:1600/1200 14:46:13 INFO - PROCESS | 24967 | colorDepth:24 14:46:13 INFO - PROCESS | 24967 | Browser inner width/height: 1024/697 14:46:13 INFO - PROCESS | 24967 | __metrics 14:46:14 INFO - PROCESS | 24967 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:46:14 INFO - PROCESS | 24967 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:46:15 INFO - TEST-INFO | 24967: exit 0 14:46:15 INFO - Browser initialized. 14:46:15 INFO - Running cycle 1/1 for dromaeo_css test... 14:46:15 INFO - TEST-INFO | started process 25058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZhZi_7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:46:27 INFO - PROCESS | 25058 | RSS: Main: 139915264 14:46:27 INFO - PROCESS | 25058 | 14:49:27 INFO - PROCESS | 25058 | Cycle 1(1): loaded http://localhost:38641/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38641/tests/dromaeo/cssquery-ext.html) 14:49:29 INFO - PROCESS | 25058 | RSS: Main: 232030208 14:49:29 INFO - PROCESS | 25058 | 14:51:16 INFO - PROCESS | 25058 | ************************* 14:51:16 INFO - PROCESS | 25058 | A coding exception was thrown and uncaught in a Task. 14:51:16 INFO - PROCESS | 25058 | 14:51:16 ERROR - PROCESS | 25058 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:51:16 INFO - PROCESS | 25058 | Full stack: 14:51:16 INFO - PROCESS | 25058 | ************************* 14:51:16 INFO - PROCESS | 25058 | ************************* 14:51:16 INFO - PROCESS | 25058 | A coding exception was thrown and uncaught in a Task. 14:51:16 INFO - PROCESS | 25058 | 14:51:16 ERROR - PROCESS | 25058 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:51:16 INFO - PROCESS | 25058 | Full stack: 14:51:16 INFO - PROCESS | 25058 | ************************* 14:51:16 INFO - PROCESS | 25058 | ************************* 14:51:16 INFO - PROCESS | 25058 | A coding exception was thrown and uncaught in a Task. 14:51:16 INFO - PROCESS | 25058 | 14:51:16 ERROR - PROCESS | 25058 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:51:16 INFO - PROCESS | 25058 | Full stack: 14:51:16 INFO - PROCESS | 25058 | ************************* 14:51:16 INFO - PROCESS | 25058 | ************************* 14:51:16 INFO - PROCESS | 25058 | A coding exception was thrown and uncaught in a Task. 14:51:16 INFO - PROCESS | 25058 | 14:51:16 ERROR - PROCESS | 25058 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:51:16 INFO - PROCESS | 25058 | Full stack: 14:51:16 INFO - PROCESS | 25058 | ************************* 14:52:31 INFO - PROCESS | 25058 | Cycle 1(1): loaded http://localhost:38641/tests/dromaeo/cssquery-ext.html (next: http://localhost:38641/tests/dromaeo/cssquery-jquery.html) 14:52:32 INFO - PROCESS | 25058 | RSS: Main: 221052928 14:52:32 INFO - PROCESS | 25058 | 14:55:34 INFO - PROCESS | 25058 | Cycle 1(1): loaded http://localhost:38641/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38641/tests/dromaeo/cssquery-mootools.html) 14:55:34 INFO - PROCESS | 25058 | RSS: Main: 194473984 14:55:34 INFO - PROCESS | 25058 | 14:58:36 INFO - PROCESS | 25058 | Cycle 1(1): loaded http://localhost:38641/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38641/tests/dromaeo/cssquery-prototype.html) 14:58:37 INFO - PROCESS | 25058 | RSS: Main: 171778048 14:58:37 INFO - PROCESS | 25058 | 15:01:40 INFO - PROCESS | 25058 | Cycle 1(1): loaded http://localhost:38641/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38641/tests/dromaeo/cssquery-yui.html) 15:01:40 INFO - PROCESS | 25058 | RSS: Main: 178311168 15:01:40 INFO - PROCESS | 25058 | 15:04:43 INFO - PROCESS | 25058 | Cycle 1(1): loaded http://localhost:38641/tests/dromaeo/cssquery-yui.html (next: http://localhost:38641/tests/dromaeo/cssquery-dojo.html) 15:04:43 INFO - PROCESS | 25058 | RSS: Main: 257716224 15:04:43 INFO - PROCESS | 25058 | 15:04:43 INFO - PROCESS | 25058 | __start_tp_report 15:04:43 INFO - PROCESS | 25058 | _x_x_mozilla_page_load 15:04:43 INFO - PROCESS | 25058 | _x_x_mozilla_page_load_details 15:04:43 INFO - PROCESS | 25058 | |i|pagename|runs| 15:04:43 INFO - PROCESS | 25058 | |0;dojo.html;3364.966350336497;3402.285520040791;3405.7105146062577;3414.7097496712777;3461.5846098468187;5648.971755141224;5698.629589076718;5718.370979192291;5739.397363276858;5743.282089738783;5704.058830292996;5769.480746732793;5776.4223577642215;5776.451237132476;5786.247787787582;5125.46182650821;5150.098732721777;5176.042432150046;5181.559567436753;5212.4266330703595;5018.5985121190215;5050.570701490377;5227.08526007949;5238.738063096849;5268.104422248227;5080.263361812535;5133.076046311662;5201.167813149897;5208.687478751287;5213.947860521384;5224.242484839715;5235.528802407783;5235.764390602432;5239.580833533309;5262.342207224097;4903.950960490385;4995.100881841267;5106.310648062538;5134.614903882224;5210.6613070150315;5558.805441809517;5592.049351610236;5603.271574695264;5661.801836935729;5664.376918538957;6088.452039316483;6124.081387791823;6134.69326533676;6138.171346868205;6153.200083989098;5968.01527747921;6216;6229.781957631461;6239.157713708637;6240.906386404207;5684.261046063985;5697;5715.399883012307;5754.424557544296;5760.07838745807;6276;6305.8108256752375;6308.936910630927;6311.905321420182;6320;6033.185519954838;6076.817695469143;6087.908681369783;6091.329953705089;6093.695315234309;5937.703114844327;5985.281766187998;6069;6100.69496525172;6146.416090471398;6115.490521586124;6131.570790044654;6151.661658608819;6151.938480615226;6152.046432802923;5917.053271476543;5940.079287710412;5964.671943043088;5971;6143;4609.377734005933;4621.699589526737;4640.767961601974;4653.395058642423;4668.229742092584;3927.5286965564314;4084.509858816961;4113.03343714227;4119.876403707894;4182.226288136704;5952.940470595326;5969.104634304889;5969.641821490724;5979.521638268928;6010.9699451502465;6125.84685382869;6219.782307619212;6220;6227.688615569204;6230.844228894314;5750.827475175668;5794.739236734357;5871.4715675589405;5989.101634754822;5999.190109335271;5194.974025129925;5199.324087868553;5201.843944681666;5221.6083793715625;5226.790928362899;6410.326915673881;6420.807375778734;6437.25971513282;6466.5473416861305;6469.676516174079;5928.762849486145;6058.394160584083;6181.598196117238;6185.226846644169;6188.071789231652;6317.747290108528;6413.775517856852;6454.128692626436;6490.383413575702;6500.479961602966;6039.78860739872;6040.577159598962;6046.667433291212;6046.818595442144;6060.393960603904;5916.290045194604;6166.105914642441;6168.660723660242;6171.197744293213;6175.042868355412;5917.142014407973;5928.110783382527;5988.970055149696;6056.848578785565;6062.757489700539;5980.132880732356;6015.819525414245;6018.578699490994;6024.006039003515;6036.667983260787;5778.479936805707;5822.243108395882;6036.034234522455;6039.214902062879;6052.969735151296;5859.560532959959;5943.821685349447;5955.493783028318;5977.880442391215;6011.789587364421;5911.6748578826855;5931.9110213345975;5937.495312898452;5939;5941.197938278277 15:04:43 INFO - PROCESS | 25058 | |1;ext.html;780.4965797060896;818.2186012358198;838.8573942429788;904.6155383961815;907.8002839375335;30986.690133098662;44205.336919946225;44792;44922.77538612307;45009.7749511252;44880.3267950981;44941.10117797642;45210.54789452104;45213.32180017302;45229.54770452294;7713.845723085535;9266.90733092669;9406.52967351633;9410.43537387759;9419.24646028316;7786.688532458695;10773;10992.395418251994;10994.065504432132;10995.505202265877;11130.220884538045;11144.052755515791;11161.441927903614;11169.218154729173;11169.609063682772;11091.55633774648;11104.833427498594;11106.055985241264;11110.666679999573;11137.443127843575;10678.946605267001;10784.083352914933;10784.784304313947;10791.514381852836;10808.945955270252;42107.57892421067;42268;42290.78854605738;42574.78712606417;42624.147517049794;4198.32826747722;4238.3430568261965;4265.616094551474;4350.064736081726;4368.847090351823;30007.549886751716;30506.847465762752;30694.232644183852;31067.223319416968;32163.83918080418;4248.9150216995795;4347.391365208873;4371;4380.080183161508;4441.933370999438;239259;240377;241018;241165;241652;53834.30828458561;53877.46122538725;53919.73040134774;53962;53999.19001214985;56614;56628.71685641628;56729.71635141881;56756.71621641865;56799.14801277984;15472.226388680521;15612.3755049799;15655.843441565667;15658;15675.451359202601;11171.38557379352;11309.547618095185;13529.729405412034;13542.390592423364;13543.119697219649;13169.868301317056;13505.2572108533;13869.306534673226;13956;14049.22729249901;5314.243751842079;5327.973360133252;5367.543758780547;5428.5385742211565;5453.672779633155;1006.6074231049896;1009.4448053570507;1009.6163457885956;1011.3780025284398;1022.943738094412;28218.30690158597;28501.857490712413;28544.71455285462;30964.84517577398;31451.213719656735;1165.959191428296;1174.7826652069396;1185.2829038431796;1204.5496366955006;1216.9574064907686;13483.325833708472;13654.658633534042;13964.51124210668;14103.294835258195;14189.290535473185;356693;357625;357713;358631;358846;48300.758496207294;48385.7903552414;48427;48443;48555.75722121437;1432.2051261549939;1464.0191071981585;1476.143836574784;1485.9405623775144;1487.323267913097;24141.51716965686;25385.111521096675;25442.363940901625;25569.23292301234;25637;38287.42568861414;38314.80842595881;38338.23323533458;38445.61554384532;38475.2304953905;309628;310097;310140;310284;311533;24816.255512334657;28095.297617559725;28929.42141157123;29057.12828615145;29227.123186304445;37918.81040594779;37954;37959.81020094882;38677;38711;29298;29829.701702982693;30023.399532009673;30156.396872062876;30429;29371.265718357212;29422.852885735436;29525.557116642838;29625.555616665337;30009.249768755955;33613.15967100842;33877.83061084679;34116.829415852764;34394;34433.48349774806;28378.57432138478;28928.566071509365;28992.275193120342;29043.419131617673;29254.41491170207;22597;23221.251905978097;23459.88270058639;23816.16643417472;23918.76081239235 15:04:43 INFO - PROCESS | 25058 | |2;jquery.html;454.1666042811441;459.83445959454593;479.7745059821884;483.0411632908676;491.7098911642131;19859.900700496495;21735.13059477623;21998.560028799413;22063.889680551616;22541.436464088387;22130.336089917328;22279.220227292048;22775.20286789963;22777.772222277774;23052.88473557634;6382.361763823604;6475.740970361192;6572.309907459719;6624.503162262849;6640.800775976729;6607.933920660804;6628.867422651544;6676.966615166917;7264.963675181617;7572.167061623217;7530;7532.924670753305;7537.0201873756605;7580.128285247184;7581.962090189541;7389.2241314662;7561.395088392916;7595.050618672666;7604.733834315828;7612.3148916597775;7195.640217989132;7375.631218439056;7398.223186565387;7406.481546291761;7434.962825185894;25030.624540631907;25036.624450633255;25089.24732258035;25287.873560632263;25642.74357256422;3032.969670303291;3138.4978403455566;3248.350329933999;3438.2435864109857;3617.981910090433;15714.371425142981;15887.443939462179;16207.351705931867;16218.594535136597;16231.188440578042;2263.524659821423;2308.6421604651305;2311.8497297675767;2321.0947730385165;2392.114917480526;75188.62405687936;93859.53070234673;117232;118878.43364699073;120074.7992520081;17661.498772604216;17882.731759023623;18033.819661803478;18109.909450452928;18226.54433639143;31796;32089.518657219694;32241.193970150933;32257.51613725749;32262.83868580689;10036.899631003742;10103.646372376932;10218.18254539635;10311.07200351972;10329.638462653771;8492.193241642035;8503.1921967413;8515.276201522816;8705.956470217736;8721.60752766127;9048.185663290204;9124.800637958559;9213.81572368549;9365.672201473051;9567.473788941676;3483.686468217822;3667.156553992597;3684.8157592120288;3692.9261414771554;3772.6981841452616;975.1613612293422;975.2246963663904;980.0007983713145;984.0602224875227;990.5542505872386;21163.78836211618;21203.36389908305;21319.25382611601;21409.464763381042;21529.277657787654;987.0425687083517;988.421773262635;988.614440368257;1015.1472762879217;1020.7295066807302;10180.541875615616;11754.529818807323;11756.353400563052;11824.70438239051;11863.228890122115;643949;652396;654193;658102;690539;86974.56512717396;90211.99999999869;106332;109532;109889.45055274833;1297.1114786371177;1329.3419757220238;1348.3595292236305;1358.796180572922;1359.8436179839248;19269;19550.31573894907;19586.31447899317;19620;19705.211791528178;52509.474905250456;52709.47290527199;52904.20643690271;53201.7339913298;53372.73313633407;70375.64812175906;70983;71909.28090719026;71976.28023719696;72702;12134.393280336124;12624.87375126237;12913.935430322788;12953.352332383532;12994.675133121747;13622.93188534051;13778.793318100437;14009.929950350182;14157.575272741835;14478.638034049232;6434.303008581778;11850.466728997044;12403.379831008593;12438.129330946747;12610.810837837624;10527.94736026315;10840.728981775519;10857.077148442471;11015.559377625126;11265.605703800327;12050.939745301217;12358.876411235773;12523.686907827378;12619.621411357673;12687.302198379179;12217.633470995885;12266;12343.876561234632;12713.93643031779;12792.488300467878;11763.058955283386;11801.645950621494;11861.822072668745;11901.404929753304;12038.097142714156 15:04:43 INFO - PROCESS | 25058 | |3;mootools.html;1530.1354734574963;1560.8439156084387;1597.2333280025587;1601.9919900400496;1603.7915071040763;10619.73450663733;11308.717282067952;11312.321260724362;11315.321080735162;11323.20737548372;11338.546458141685;11694.883051169485;11705.53177872884;11712.882871171285;11724.23792453492;2432.3067925641194;2439.4145405102827;2451.4974430241846;2454.6686197363397;2467.6668649732237;2444.6180097804563;2459.0655550890638;2504.3864253257975;2507.8119141064403;2511.949761004779;2413.734489206186;2457.6682147910074;2469.259222233332;2493.8628375439343;2502.5995840665496;2397.137030668958;2422.188566830114;2423.4062654649724;2428.890699918499;2464.6549483072386;2365.077619728307;2394.2458125690528;2407.783299503036;2407.964575232649;2408.2895545814026;11116.49975751085;11201.103911687045;11228.101751859913;11235.269707468988;11255.887441125566;5792.68140252286;5936.22829032223;5944.583879128462;5945.048792193272;5948.97025514874;3596.8920932371807;3699.445083237536;3746.906327341811;3762.7930463824478;3774.9622503774885;1328.362386054699;1427.907186032915;1484.487851691165;2242.686023956647;2269;15303.15832629205;15588.532344029698;16953.83046169547;18159.727604085816;18301.7254741179;4798.616110711135;4861.927071093936;4916.262560615936;5020.924686129711;5024.6231532634465;12795.104342695922;12795.232286062866;12800.103992720606;12801.61595152147;12810.679733006564;6039.275286965592;6045.455908968214;6046.576739628272;6053.909191362133;6056.394360563909;5443.292371991616;5539.9169012464845;5579.218909352694;5596.58025648078;5612.214289999403;4107.230086792653;4130.979345103256;4155.218077033756;4198.9370159447635;4200.201961627281;1087.3856271206744;1088.7006073329899;1099.5925215723726;1103.1340397787699;1104.376027544435;1048.2086025051037;1052.9947350263353;1064.5156453813652;1066.157735389034;1076.2896488317672;7273.0908636420445;7310.122785265802;7432.182459929403;7467.178610352857;7585.772426827204;1003.894591067942;1010.545254635417;1033.9534720937577;1040.5951964847395;1059.7668512927298;4635.443746750411;4675.22858728306;4692;4950.108980383494;4950.554450099508;14419.711605768036;14543.854561454462;14964.326605302787;14989.175595342362;15084.170370629501;14430.639234019023;15121.924390378197;15126.168060756763;15222.467213647691;15242.466513671969;10658.360498370123;10702.571897124028;10862.891371086345;10906.400147991779;10929.344239345664;7220.74727384539;7500.737474188377;7515.473916825769;7604.2395760423515;7744.303012728881;13060.151090179108;13073.803892941423;13106.148100373444;13236.933815331247;13688.589342319747;13204.933975330061;13245.536406225736;13276.468941242241;13321.733565328834;13332.866671333162;11109;11290.322580645188;11412;11412.48643811014;11417.657470275573;11068.833967490655;11142.997130258316;11222.831657524981;11231.26996745209;11235.382053986783;9197.954010229905;9644.95177524108;9656.420614762856;9717.6598819041;9750.122488975743;9179.908200917906;9245.491497967676;9262.907370926205;9341.57962891685;9684.903150968401;7942.126366099609;8157.6736930524485;8313.251807337369;8322.791930201793;8405.159484051546;6134.509239260938;6183.165272688129;6196.504279657526;6313.589616674902;6324.588901721373;6329.240491141092;6432.067350234283;6505.251896032017;6606.372394622503;6640.501962352746 15:04:43 INFO - PROCESS | 25058 | |4;prototype.html;396.8015992003998;398.4143309335276;401.8995251187203;411.4178437510922;419.4295757769434;5286.682799032056;5325.440828712983;5332.600054995876;5366.382865970405;5374.865628359293;5067.391912970439;5178.896422071556;5190.143626301665;5198.906650542921;5262.263283140353;4143.979280103596;4145.880612234695;4152.190322887038;4153.397757325193;4155.916881662365;4121.9587804121875;4149.875503734877;4162.354835000579;4171.290880550298;4178.853740119096;4063.537126634409;4111.301078816593;4113.25961326961;4128.027819969617;4129.359949207877;4153.854615088488;4158.438610787565;4158.500979882403;4160.417541544186;4184.372344148372;3710.998030531768;3711.740178187528;3716.1824398632257;3729.3287208302495;3729.9440508392395;4866.038099664265;5047.7476126193915;5058.54473097423;5072.264521644341;5083.847484575469;4736.478987311393;4803.879903002418;4805.951940480585;4811.687240329367;4846.975765121187;5411.567074634059;5448.237246785453;5463.31708536433;5473.0969390050595;5477.890442191134;4024.6579040781567;4144.979275103636;4165.854584888784;4176.331786914109;4186.55563830478;5472.808451704211;5532.229686500322;5684.488396044376;5721.256236689203;5746.236215278999;4919.262110683426;5009.7495125243595;5046.722430266371;5061.44324124346;5067.391912970467;5080.415752188545;5146.614003949644;5174.758058066112;5195.870103247449;5240.410318931544;5157.6647517911215;5244.632875698664;5297.443768404339;5309.522143007148;5338.572914166857;5497.570631635804;5521.613487055867;5530.5022547970075;5530.917036244459;5547.667139971614;1752.9044347282947;1769.8761286582856;1771.247219931524;1791.6774980503374;1825.3976187857975;1456.0535651826185;1487.4793822162374;1498.9850101498846;1516.6360073582482;1529.3653133949285;5551.500364967092;5582.888342233214;5585.664860108406;5619.634723742944;5622.269105016404;5434.184872269191;5684.744186511617;5708.514776244066;5737.8565535861935;5745.35170166947;5475.7262136893;5500.834974950758;5506.430667259811;5511.751971161308;5533.833984980377;2954.7931644784658;2966.718161774628;2979.7765167612515;2985.9701402986125;2989.446952313829;5742.655440673573;5868.559858010666;5896.407969848117;5943.3462319144855;6045.093236014633;5733.799317023968;5773.913391299134;5808.651480911159;5856.916470452979;5874.530037596982;5702.918434771362;5949.851253718605;5964.522838172849;6007.249093863267;6022.427869352405;5682.289713785777;5696.658200507983;5706.77567174545;5717.256756621613;5718.25662663851;5357.732113394392;5637.998510528867;5662.310402558752;5687.715614219355;5693.583849690318;5810.970945145416;5897.734601942837;5912.46787789101;5948.5538584605465;5958.553108516965;4708.482066972561;4744.691595046449;4746.667733258639;4757.524247575215;4773.04539092176;5518.889622207614;5631.324241091095;5675.262215911905;5698.6580805151825;5735.627184233012;5470.452954704498;5487.286652735279;5492.80775172867;5524.640898341595;5531.529819965348;5438.592105592017;5483.890322193613;5503.504684578407;5554.361248456479;5574.414686458026;5263.763130659053;5453.40075550135;5484.478974497416;5488.780448782004;5490.423505532021;5541.750621221974;5543.750531226024;5545.833624991256;5558.304717061335;5566.944330556643;5290.867728306823;5389.2455056291365;5451.182322651634;5483.396826349178;5513.581579420785 15:04:43 INFO - PROCESS | 25058 | |5;yui.html;843.7890527368158;868.778461492319;895.1406649616368;904.3533873280608;928.67960553609;16866.66266674666;17318.480445586654;18188.181531831066;18216.635667286664;18239.54401139972;15946.28241729122;16082.59793505163;16088.919555402235;16108.275127619256;16110.436134735286;860.6342304520585;868.4355169140047;883.147762409275;893.066745251214;898.9146031127033;881.0000649263069;897.8294124116429;897.9820403591924;899.9100089990982;900.6082354175921;959.366817900186;959.395580784105;959.7696552827341;960.2078285414526;960.7502049467154;953.0802775321848;957.6456711016933;959.3668179001895;959.3955807841015;959.491469521155;702.1959855964942;702.2450865319751;704.0389867830374;704.0495331302751;705.1608585782902;17248.48254552353;17257.741133883002;17615.383461578913;18516.722249166272;18631.53421164468;14645.340959656842;15701.842981570266;15713.842861571353;15874.12692301923;16134.677306453805;14832.110073395523;14886;14891.70216595662;14947.775783363259;15211.619709507351;4695.5069717679835;4802.303665968415;4833.661643684944;4851.126797176542;4926.088673595396;45842.312365314545;54781.72609136929;69452.30547694508;79642.6017869907;90499;12128.393580320948;12561.937190313989;12569.434375453127;12578.622641320591;12704.682382940315;21049.263275785273;21321.040553175146;22539.0984360627;23177.88411057968;23420.88289558541;8827.470351778913;8964.775880603038;9160.45762390663;9194.862077068849;9195.172434480928;4762.404699412574;4908.975455122773;4963.379577552806;4994.80020799164;5044.142495775727;3686.4101743721412;3792.7345085844277;3793.8292776824555;3794.962050379516;3798.848046078126;667.4927055437902;670.8356452669127;672.4183581202225;673.5386260411535;684.616614695772;785.7292424892066;810.4245985350467;826.8139668574522;835.9414840961196;840.4663038970298;11542.653720388402;11778.823317650242;12032.759344813056;12301.44643491027;12628.873711262953;765.8506591214659;776.6349815586665;780.8750599903988;786.1244066750859;797.5374282915894;5411.161270003156;5678.233438485751;5802.738876750556;5827.59206855516;5845.970770146122;78147;80644.59677701574;81036.59481702554;82513;84334.15665843386;72095;72820;73801.6309918447;74020.62989685124;75053.62473187599;51434.74282628563;60233.69883150644;60253.39746602566;60830.39169608336;61003;11015.118790496901;11162.497687603915;11166.994970452699;11446.542138314375;11474.77050459003;44822.551774481835;45248.09503809839;45422.77288613536;45991.77004114958;46266.53733462622;51157.23264151115;51717.741411294206;51843.740781295855;51930;52132.47867521428;12402.25586464815;12617.621471355875;12795.232286062866;12838.871611283768;13045.412956417174;14532.709345813237;14741.408768776178;14833.629159271104;14919.403223870924;14927.253637317874;14535.345909434312;14712.852871471148;15378.384864605738;15417.845821541641;15473.148976806384;15625.84374156244;16190.757138642693;16428.425005125242;16621.168941553115;16797;15513.967454957672;15954.680906381574;15956.361745530048;16126.113063781604;16398.098104603883;10649.733756656145;11074.723131921766;11251.943740281245;11344;11428.2000259981;13166.539171128965;13689.97325200594;13691.520796772065;13774.65563360924;13848.169109853441 15:04:43 INFO - PROCESS | 25058 | __end_tp_report 15:04:43 INFO - PROCESS | 25058 | __start_cc_report 15:04:43 INFO - PROCESS | 25058 | _x_x_mozilla_cycle_collect,1275 15:04:43 INFO - PROCESS | 25058 | __end_cc_report 15:04:43 INFO - PROCESS | 25058 | __startTimestamp1491948283497__endTimestamp 15:04:43 INFO - PROCESS | 25058 | 15:04:43 INFO - PROCESS | 25058 | ------- Summary: start ------- 15:04:43 INFO - PROCESS | 25058 | Number of tests: 6 15:04:43 INFO - PROCESS | 25058 | 15:04:43 INFO - PROCESS | 25058 | [#0] dojo.html Cycles:165 Average:5693.04 Median:5941.20 stddev:662.87 (11.2%) stddev-sans-first:639.25 15:04:43 INFO - PROCESS | 25058 | Values: 3365.0 3402.3 3405.7 3414.7 3461.6 5649.0 5698.6 5718.4 5739.4 5743.3 5704.1 5769.5 5776.4 5776.5 5786.2 5125.5 5150.1 5176.0 5181.6 5212.4 5018.6 5050.6 5227.1 5238.7 5268.1 5080.3 5133.1 5201.2 5208.7 5213.9 5224.2 5235.5 5235.8 5239.6 5262.3 4904.0 4995.1 5106.3 5134.6 5210.7 5558.8 5592.0 5603.3 5661.8 5664.4 6088.5 6124.1 6134.7 6138.2 6153.2 5968.0 6216.0 6229.8 6239.2 6240.9 5684.3 5697.0 5715.4 5754.4 5760.1 6276.0 6305.8 6308.9 6311.9 6320.0 6033.2 6076.8 6087.9 6091.3 6093.7 5937.7 5985.3 6069.0 6100.7 6146.4 6115.5 6131.6 6151.7 6151.9 6152.0 5917.1 5940.1 5964.7 5971.0 6143.0 4609.4 4621.7 4640.8 4653.4 4668.2 3927.5 4084.5 4113.0 4119.9 4182.2 5952.9 5969.1 5969.6 5979.5 6011.0 6125.8 6219.8 6220.0 6227.7 6230.8 5750.8 5794.7 5871.5 5989.1 5999.2 5195.0 5199.3 5201.8 5221.6 5226.8 6410.3 6420.8 6437.3 6466.5 6469.7 5928.8 6058.4 6181.6 6185.2 6188.1 6317.7 6413.8 6454.1 6490.4 6500.5 6039.8 6040.6 6046.7 6046.8 6060.4 5916.3 6166.1 6168.7 6171.2 6175.0 5917.1 5928.1 5989.0 6056.8 6062.8 5980.1 6015.8 6018.6 6024.0 6036.7 5778.5 5822.2 6036.0 6039.2 6053.0 5859.6 5943.8 5955.5 5977.9 6011.8 5911.7 5931.9 5937.5 5939.0 5941.2 15:04:43 INFO - PROCESS | 25058 | 15:04:43 INFO - PROCESS | 25058 | [#1] ext.html Cycles:180 Average:46123.02 Median:30089.90 stddev:80459.94 (267.4%) stddev-sans-first:80613.63 15:04:43 INFO - PROCESS | 25058 | Values: 780.5 818.2 838.9 904.6 907.8 30986.7 44205.3 44792.0 44922.8 45009.8 44880.3 44941.1 45210.5 45213.3 45229.5 7713.8 9266.9 9406.5 9410.4 9419.2 7786.7 10773.0 10992.4 10994.1 10995.5 11130.2 11144.1 11161.4 11169.2 11169.6 11091.6 11104.8 11106.1 11110.7 11137.4 10678.9 10784.1 10784.8 10791.5 10808.9 42107.6 42268.0 42290.8 42574.8 42624.1 4198.3 4238.3 4265.6 4350.1 4368.8 30007.5 30506.8 30694.2 31067.2 32163.8 4248.9 4347.4 4371.0 4380.1 4441.9 239259.0 240377.0 241018.0 241165.0 241652.0 53834.3 53877.5 53919.7 53962.0 53999.2 56614.0 56628.7 56729.7 56756.7 56799.1 15472.2 15612.4 15655.8 15658.0 15675.5 11171.4 11309.5 13529.7 13542.4 13543.1 13169.9 13505.3 13869.3 13956.0 14049.2 5314.2 5328.0 5367.5 5428.5 5453.7 1006.6 1009.4 1009.6 1011.4 1022.9 28218.3 28501.9 28544.7 30964.8 31451.2 1166.0 1174.8 1185.3 1204.5 1217.0 13483.3 13654.7 13964.5 14103.3 14189.3 356693.0 357625.0 357713.0 358631.0 358846.0 48300.8 48385.8 48427.0 48443.0 48555.8 1432.2 1464.0 1476.1 1485.9 1487.3 24141.5 25385.1 25442.4 25569.2 25637.0 38287.4 38314.8 38338.2 38445.6 38475.2 309628.0 310097.0 310140.0 310284.0 311533.0 24816.3 28095.3 28929.4 29057.1 29227.1 37918.8 37954.0 37959.8 38677.0 38711.0 29298.0 29829.7 30023.4 30156.4 30429.0 29371.3 29422.9 29525.6 29625.6 30009.2 33613.2 33877.8 34116.8 34394.0 34433.5 28378.6 28928.6 28992.3 29043.4 29254.4 22597.0 23221.3 23459.9 23816.2 23918.8 15:04:43 INFO - PROCESS | 25058 | 15:04:43 INFO - PROCESS | 25058 | [#2] jquery.html Cycles:180 Average:37239.38 Median:2356.60 stddev:108445.94 (4601.8%) stddev-sans-first:108714.98 15:04:43 INFO - PROCESS | 25058 | Values: 454.2 459.8 479.8 483.0 491.7 19859.9 21735.1 21998.6 22063.9 22541.4 22130.3 22279.2 22775.2 22777.8 23052.9 6382.4 6475.7 6572.3 6624.5 6640.8 6607.9 6628.9 6677.0 7265.0 7572.2 7530.0 7532.9 7537.0 7580.1 7582.0 7389.2 7561.4 7595.1 7604.7 7612.3 7195.6 7375.6 7398.2 7406.5 7435.0 25030.6 25036.6 25089.2 25287.9 25642.7 3033.0 3138.5 3248.4 3438.2 3618.0 15714.4 15887.4 16207.4 16218.6 16231.2 2263.5 2308.6 2311.8 2321.1 2392.1 75188.6 93859.5 117232.0 118878.4 120074.8 17661.5 17882.7 18033.8 18109.9 18226.5 31796.0 32089.5 32241.2 32257.5 32262.8 10036.9 10103.6 10218.2 10311.1 10329.6 8492.2 8503.2 8515.3 8706.0 8721.6 9048.2 9124.8 9213.8 9365.7 9567.5 3483.7 3667.2 3684.8 3692.9 3772.7 975.2 975.2 980.0 984.1 990.6 21163.8 21203.4 21319.3 21409.5 21529.3 987.0 988.4 988.6 1015.1 1020.7 10180.5 11754.5 11756.4 11824.7 11863.2 643949.0 652396.0 654193.0 658102.0 690539.0 86974.6 90212.0 106332.0 109532.0 109889.5 1297.1 1329.3 1348.4 1358.8 1359.8 19269.0 19550.3 19586.3 19620.0 19705.2 52509.5 52709.5 52904.2 53201.7 53372.7 70375.6 70983.0 71909.3 71976.3 72702.0 12134.4 12624.9 12913.9 12953.4 12994.7 13622.9 13778.8 14009.9 14157.6 14478.6 6434.3 11850.5 12403.4 12438.1 12610.8 10527.9 10840.7 10857.1 11015.6 11265.6 12050.9 12358.9 12523.7 12619.6 12687.3 12217.6 12266.0 12343.9 12713.9 12792.5 11763.1 11801.6 11861.8 11901.4 12038.1 15:04:43 INFO - PROCESS | 25058 | 15:04:43 INFO - PROCESS | 25058 | [#3] mootools.html Cycles:180 Average:7277.97 Median:2411.01 stddev:4592.40 (190.5%) stddev-sans-first:4584.97 15:04:43 INFO - PROCESS | 25058 | Values: 1530.1 1560.8 1597.2 1602.0 1603.8 10619.7 11308.7 11312.3 11315.3 11323.2 11338.5 11694.9 11705.5 11712.9 11724.2 2432.3 2439.4 2451.5 2454.7 2467.7 2444.6 2459.1 2504.4 2507.8 2511.9 2413.7 2457.7 2469.3 2493.9 2502.6 2397.1 2422.2 2423.4 2428.9 2464.7 2365.1 2394.2 2407.8 2408.0 2408.3 11116.5 11201.1 11228.1 11235.3 11255.9 5792.7 5936.2 5944.6 5945.0 5949.0 3596.9 3699.4 3746.9 3762.8 3775.0 1328.4 1427.9 1484.5 2242.7 2269.0 15303.2 15588.5 16953.8 18159.7 18301.7 4798.6 4861.9 4916.3 5020.9 5024.6 12795.1 12795.2 12800.1 12801.6 12810.7 6039.3 6045.5 6046.6 6053.9 6056.4 5443.3 5539.9 5579.2 5596.6 5612.2 4107.2 4131.0 4155.2 4198.9 4200.2 1087.4 1088.7 1099.6 1103.1 1104.4 1048.2 1053.0 1064.5 1066.2 1076.3 7273.1 7310.1 7432.2 7467.2 7585.8 1003.9 1010.5 1034.0 1040.6 1059.8 4635.4 4675.2 4692.0 4950.1 4950.6 14419.7 14543.9 14964.3 14989.2 15084.2 14430.6 15121.9 15126.2 15222.5 15242.5 10658.4 10702.6 10862.9 10906.4 10929.3 7220.7 7500.7 7515.5 7604.2 7744.3 13060.2 13073.8 13106.1 13236.9 13688.6 13204.9 13245.5 13276.5 13321.7 13332.9 11109.0 11290.3 11412.0 11412.5 11417.7 11068.8 11143.0 11222.8 11231.3 11235.4 9198.0 9645.0 9656.4 9717.7 9750.1 9179.9 9245.5 9262.9 9341.6 9684.9 7942.1 8157.7 8313.3 8322.8 8405.2 6134.5 6183.2 6196.5 6313.6 6324.6 6329.2 6432.1 6505.3 6606.4 6640.5 15:04:43 INFO - PROCESS | 25058 | 15:04:43 INFO - PROCESS | 25058 | [#4] prototype.html Cycles:180 Average:4804.24 Median:5362.06 stddev:1292.26 (24.1%) stddev-sans-first:1252.83 15:04:43 INFO - PROCESS | 25058 | Values: 396.8 398.4 401.9 411.4 419.4 5286.7 5325.4 5332.6 5366.4 5374.9 5067.4 5178.9 5190.1 5198.9 5262.3 4144.0 4145.9 4152.2 4153.4 4155.9 4122.0 4149.9 4162.4 4171.3 4178.9 4063.5 4111.3 4113.3 4128.0 4129.4 4153.9 4158.4 4158.5 4160.4 4184.4 3711.0 3711.7 3716.2 3729.3 3729.9 4866.0 5047.7 5058.5 5072.3 5083.8 4736.5 4803.9 4806.0 4811.7 4847.0 5411.6 5448.2 5463.3 5473.1 5477.9 4024.7 4145.0 4165.9 4176.3 4186.6 5472.8 5532.2 5684.5 5721.3 5746.2 4919.3 5009.7 5046.7 5061.4 5067.4 5080.4 5146.6 5174.8 5195.9 5240.4 5157.7 5244.6 5297.4 5309.5 5338.6 5497.6 5521.6 5530.5 5530.9 5547.7 1752.9 1769.9 1771.2 1791.7 1825.4 1456.1 1487.5 1499.0 1516.6 1529.4 5551.5 5582.9 5585.7 5619.6 5622.3 5434.2 5684.7 5708.5 5737.9 5745.4 5475.7 5500.8 5506.4 5511.8 5533.8 2954.8 2966.7 2979.8 2986.0 2989.4 5742.7 5868.6 5896.4 5943.3 6045.1 5733.8 5773.9 5808.7 5856.9 5874.5 5702.9 5949.9 5964.5 6007.2 6022.4 5682.3 5696.7 5706.8 5717.3 5718.3 5357.7 5638.0 5662.3 5687.7 5693.6 5811.0 5897.7 5912.5 5948.6 5958.6 4708.5 4744.7 4746.7 4757.5 4773.0 5518.9 5631.3 5675.3 5698.7 5735.6 5470.5 5487.3 5492.8 5524.6 5531.5 5438.6 5483.9 5503.5 5554.4 5574.4 5263.8 5453.4 5484.5 5488.8 5490.4 5541.8 5543.8 5545.8 5558.3 5566.9 5290.9 5389.2 5451.2 5483.4 5513.6 15:04:43 INFO - PROCESS | 25058 | 15:04:43 INFO - PROCESS | 25058 | [#5] yui.html Cycles:180 Average:18193.96 Median:25481.02 stddev:21880.33 (85.9%) stddev-sans-first:21902.92 15:04:43 INFO - PROCESS | 25058 | Values: 843.8 868.8 895.1 904.4 928.7 16866.7 17318.5 18188.2 18216.6 18239.5 15946.3 16082.6 16088.9 16108.3 16110.4 860.6 868.4 883.1 893.1 898.9 881.0 897.8 898.0 899.9 900.6 959.4 959.4 959.8 960.2 960.8 953.1 957.6 959.4 959.4 959.5 702.2 702.2 704.0 704.0 705.2 17248.5 17257.7 17615.4 18516.7 18631.5 14645.3 15701.8 15713.8 15874.1 16134.7 14832.1 14886.0 14891.7 14947.8 15211.6 4695.5 4802.3 4833.7 4851.1 4926.1 45842.3 54781.7 69452.3 79642.6 90499.0 12128.4 12561.9 12569.4 12578.6 12704.7 21049.3 21321.0 22539.1 23177.9 23420.9 8827.5 8964.8 9160.5 9194.9 9195.2 4762.4 4909.0 4963.4 4994.8 5044.1 3686.4 3792.7 3793.8 3795.0 3798.8 667.5 670.8 672.4 673.5 684.6 785.7 810.4 826.8 835.9 840.5 11542.7 11778.8 12032.8 12301.4 12628.9 765.9 776.6 780.9 786.1 797.5 5411.2 5678.2 5802.7 5827.6 5846.0 78147.0 80644.6 81036.6 82513.0 84334.2 72095.0 72820.0 73801.6 74020.6 75053.6 51434.7 60233.7 60253.4 60830.4 61003.0 11015.1 11162.5 11167.0 11446.5 11474.8 44822.6 45248.1 45422.8 45991.8 46266.5 51157.2 51717.7 51843.7 51930.0 52132.5 12402.3 12617.6 12795.2 12838.9 13045.4 14532.7 14741.4 14833.6 14919.4 14927.3 14535.3 14712.9 15378.4 15417.8 15473.1 15625.8 16190.8 16428.4 16621.2 16797.0 15514.0 15954.7 15956.4 16126.1 16398.1 10649.7 11074.7 11251.9 11344.0 11428.2 13166.5 13690.0 13691.5 13774.7 13848.2 15:04:43 INFO - PROCESS | 25058 | -------- Summary: end -------- 15:04:43 INFO - PROCESS | 25058 | 15:04:44 INFO - TEST-INFO | 25058: exit 0 15:04:44 INFO - TEST-OK | dromaeo_css | took 1114567ms 15:04:44 INFO - TEST-START | kraken 15:04:44 INFO - operating with platform_type : linux_ 15:04:44 INFO - Initialising browser for kraken test... 15:04:44 INFO - TEST-INFO | started process 25378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzCrHiN/profile http://localhost:38641/getInfo.html) 15:04:48 INFO - PROCESS | 25378 | __metrics Screen width/height:1600/1200 15:04:48 INFO - PROCESS | 25378 | colorDepth:24 15:04:48 INFO - PROCESS | 25378 | Browser inner width/height: 1024/697 15:04:48 INFO - PROCESS | 25378 | __metrics 15:04:48 INFO - PROCESS | 25378 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:04:48 INFO - PROCESS | 25378 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:04:49 INFO - TEST-INFO | 25378: exit 0 15:04:49 INFO - Browser initialized. 15:04:49 INFO - Running cycle 1/1 for kraken test... 15:04:49 INFO - TEST-INFO | started process 25470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzCrHiN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:05:01 INFO - PROCESS | 25470 | RSS: Main: 140066816 15:05:01 INFO - PROCESS | 25470 | 15:05:04 INFO - PROCESS | 25470 | Cycle 1(1): loaded http://localhost:38641/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38641/tests/kraken/driver.html?testName=audio-beat-detection) 15:05:04 INFO - PROCESS | 25470 | RSS: Main: 183803904 15:05:04 INFO - PROCESS | 25470 | 15:05:07 INFO - PROCESS | 25470 | Cycle 1(1): loaded http://localhost:38641/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38641/tests/kraken/driver.html?testName=audio-dft) 15:05:08 INFO - PROCESS | 25470 | RSS: Main: 174718976 15:05:08 INFO - PROCESS | 25470 | 15:05:11 INFO - PROCESS | 25470 | Cycle 1(1): loaded http://localhost:38641/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38641/tests/kraken/driver.html?testName=audio-fft) 15:05:11 INFO - PROCESS | 25470 | RSS: Main: 266092544 15:05:11 INFO - PROCESS | 25470 | 15:05:13 INFO - PROCESS | 25470 | Cycle 1(1): loaded http://localhost:38641/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38641/tests/kraken/driver.html?testName=audio-oscillator) 15:05:14 INFO - PROCESS | 25470 | RSS: Main: 172302336 15:05:14 INFO - PROCESS | 25470 | 15:05:16 INFO - PROCESS | 25470 | Cycle 1(1): loaded http://localhost:38641/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38641/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:05:16 INFO - PROCESS | 25470 | RSS: Main: 174927872 15:05:16 INFO - PROCESS | 25470 | 15:05:19 INFO - PROCESS | 25470 | Cycle 1(1): loaded http://localhost:38641/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38641/tests/kraken/driver.html?testName=imaging-darkroom) 15:05:20 INFO - PROCESS | 25470 | RSS: Main: 213995520 15:05:20 INFO - PROCESS | 25470 | 15:05:23 INFO - PROCESS | 25470 | Cycle 1(1): loaded http://localhost:38641/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38641/tests/kraken/driver.html?testName=imaging-desaturate) 15:05:24 INFO - PROCESS | 25470 | RSS: Main: 213557248 15:05:24 INFO - PROCESS | 25470 | 15:05:27 INFO - PROCESS | 25470 | Cycle 1(1): loaded http://localhost:38641/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38641/tests/kraken/driver.html?testName=json-parse-financial) 15:05:27 INFO - PROCESS | 25470 | RSS: Main: 211202048 15:05:27 INFO - PROCESS | 25470 | 15:05:29 INFO - PROCESS | 25470 | Cycle 1(1): loaded http://localhost:38641/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38641/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:05:30 INFO - PROCESS | 25470 | RSS: Main: 173473792 15:05:30 INFO - PROCESS | 25470 | 15:05:31 INFO - PROCESS | 25470 | Cycle 1(1): loaded http://localhost:38641/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38641/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:05:32 INFO - PROCESS | 25470 | RSS: Main: 179634176 15:05:32 INFO - PROCESS | 25470 | 15:05:34 INFO - PROCESS | 25470 | Cycle 1(1): loaded http://localhost:38641/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38641/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:05:34 INFO - PROCESS | 25470 | RSS: Main: 190017536 15:05:34 INFO - PROCESS | 25470 | 15:05:37 INFO - PROCESS | 25470 | Cycle 1(1): loaded http://localhost:38641/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38641/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:05:38 INFO - PROCESS | 25470 | RSS: Main: 199081984 15:05:38 INFO - PROCESS | 25470 | 15:05:40 INFO - PROCESS | 25470 | Cycle 1(1): loaded http://localhost:38641/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38641/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:05:41 INFO - PROCESS | 25470 | RSS: Main: 195854336 15:05:41 INFO - PROCESS | 25470 | 15:05:43 INFO - PROCESS | 25470 | Cycle 1(1): loaded http://localhost:38641/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38641/tests/kraken/driver.html?testName=ai-astar) 15:05:43 INFO - PROCESS | 25470 | RSS: Main: 246628352 15:05:43 INFO - PROCESS | 25470 | 15:05:43 INFO - PROCESS | 25470 | __start_tp_report 15:05:43 INFO - PROCESS | 25470 | _x_x_mozilla_page_load 15:05:43 INFO - PROCESS | 25470 | _x_x_mozilla_page_load_details 15:05:43 INFO - PROCESS | 25470 | |i|pagename|runs| 15:05:43 INFO - PROCESS | 25470 | |0;ai-astar;102;112;111;111;113;112;111;113;111;112 15:05:43 INFO - PROCESS | 25470 | |1;audio-beat-detection;140;116;116;162;117;115;115;113;132;119 15:05:43 INFO - PROCESS | 25470 | |2;audio-dft;175;172;174;175;173;173;172;173;173;173 15:05:43 INFO - PROCESS | 25470 | |3;audio-fft;75;76;75;106;75;76;77;76;95;74 15:05:43 INFO - PROCESS | 25470 | |4;audio-oscillator;82;82;102;83;83;82;94;82;82;107 15:05:43 INFO - PROCESS | 25470 | |5;imaging-gaussian-blur;114;113;113;113;112;113;113;113;112;113 15:05:43 INFO - PROCESS | 25470 | |6;imaging-darkroom;147;147;147;147;147;146;146;146;148;146 15:05:43 INFO - PROCESS | 25470 | |7;imaging-desaturate;93;94;94;94;94;93;95;94;93;94 15:05:43 INFO - PROCESS | 25470 | |8;json-parse-financial;56;55;53;54;54;54;55;54;55;55 15:05:43 INFO - PROCESS | 25470 | |9;json-stringify-tinderbox;54;53;53;53;54;53;53;54;53;54 15:05:43 INFO - PROCESS | 25470 | |10;stanford-crypto-aes;79;86;77;82;79;76;75;81;76;79 15:05:43 INFO - PROCESS | 25470 | |11;stanford-crypto-ccm;122;122;120;128;118;143;118;120;165;142 15:05:43 INFO - PROCESS | 25470 | |12;stanford-crypto-pbkdf2;158;160;163;160;161;162;165;162;161;161 15:05:43 INFO - PROCESS | 25470 | |13;stanford-crypto-sha256-iterative;61;62;60;60;60;59;59;61;59;59 15:05:43 INFO - PROCESS | 25470 | __end_tp_report 15:05:43 INFO - PROCESS | 25470 | __start_cc_report 15:05:43 INFO - PROCESS | 25470 | _x_x_mozilla_cycle_collect,1673 15:05:43 INFO - PROCESS | 25470 | __end_cc_report 15:05:43 INFO - PROCESS | 25470 | __startTimestamp1491948343400__endTimestamp 15:05:43 INFO - PROCESS | 25470 | 15:05:43 INFO - PROCESS | 25470 | ------- Summary: start ------- 15:05:43 INFO - PROCESS | 25470 | Number of tests: 14 15:05:43 INFO - PROCESS | 25470 | 15:05:43 INFO - PROCESS | 25470 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:3.19 (2.8%) stddev-sans-first:0.83 15:05:43 INFO - PROCESS | 25470 | Values: 102.0 112.0 111.0 111.0 113.0 112.0 111.0 113.0 111.0 112.0 15:05:43 INFO - PROCESS | 25470 | 15:05:43 INFO - PROCESS | 25470 | [#1] audio-beat-detection Cycles:10 Average:124.50 Median:118.00 stddev:15.80 (13.4%) stddev-sans-first:15.73 15:05:43 INFO - PROCESS | 25470 | Values: 140.0 116.0 116.0 162.0 117.0 115.0 115.0 113.0 132.0 119.0 15:05:43 INFO - PROCESS | 25470 | 15:05:43 INFO - PROCESS | 25470 | [#2] audio-dft Cycles:10 Average:173.30 Median:173.00 stddev:1.06 (0.6%) stddev-sans-first:0.93 15:05:43 INFO - PROCESS | 25470 | Values: 175.0 172.0 174.0 175.0 173.0 173.0 172.0 173.0 173.0 173.0 15:05:43 INFO - PROCESS | 25470 | 15:05:43 INFO - PROCESS | 25470 | [#3] audio-fft Cycles:10 Average:80.50 Median:76.00 stddev:10.89 (14.3%) stddev-sans-first:11.36 15:05:43 INFO - PROCESS | 25470 | Values: 75.0 76.0 75.0 106.0 75.0 76.0 77.0 76.0 95.0 74.0 15:05:43 INFO - PROCESS | 25470 | 15:05:43 INFO - PROCESS | 25470 | [#4] audio-oscillator Cycles:10 Average:87.90 Median:82.00 stddev:9.56 (11.7%) stddev-sans-first:9.90 15:05:43 INFO - PROCESS | 25470 | Values: 82.0 82.0 102.0 83.0 83.0 82.0 94.0 82.0 82.0 107.0 15:05:43 INFO - PROCESS | 25470 | 15:05:43 INFO - PROCESS | 25470 | [#5] imaging-gaussian-blur Cycles:10 Average:112.90 Median:113.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 15:05:43 INFO - PROCESS | 25470 | Values: 114.0 113.0 113.0 113.0 112.0 113.0 113.0 113.0 112.0 113.0 15:05:43 INFO - PROCESS | 25470 | 15:05:43 INFO - PROCESS | 25470 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 15:05:43 INFO - PROCESS | 25470 | Values: 147.0 147.0 147.0 147.0 147.0 146.0 146.0 146.0 148.0 146.0 15:05:43 INFO - PROCESS | 25470 | 15:05:43 INFO - PROCESS | 25470 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 15:05:43 INFO - PROCESS | 25470 | Values: 93.0 94.0 94.0 94.0 94.0 93.0 95.0 94.0 93.0 94.0 15:05:43 INFO - PROCESS | 25470 | 15:05:43 INFO - PROCESS | 25470 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:0.85 (1.5%) stddev-sans-first:0.71 15:05:43 INFO - PROCESS | 25470 | Values: 56.0 55.0 53.0 54.0 54.0 54.0 55.0 54.0 55.0 55.0 15:05:43 INFO - PROCESS | 25470 | 15:05:43 INFO - PROCESS | 25470 | [#9] json-stringify-tinderbox Cycles:10 Average:53.40 Median:53.50 stddev:0.52 (1.0%) stddev-sans-first:0.50 15:05:43 INFO - PROCESS | 25470 | Values: 54.0 53.0 53.0 53.0 54.0 53.0 53.0 54.0 53.0 54.0 15:05:43 INFO - PROCESS | 25470 | 15:05:43 INFO - PROCESS | 25470 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.00 stddev:3.33 (4.2%) stddev-sans-first:3.54 15:05:43 INFO - PROCESS | 25470 | Values: 79.0 86.0 77.0 82.0 79.0 76.0 75.0 81.0 76.0 79.0 15:05:43 INFO - PROCESS | 25470 | 15:05:43 INFO - PROCESS | 25470 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:125.00 stddev:15.48 (12.4%) stddev-sans-first:16.16 15:05:43 INFO - PROCESS | 25470 | Values: 122.0 122.0 120.0 128.0 118.0 143.0 118.0 120.0 165.0 142.0 15:05:43 INFO - PROCESS | 25470 | 15:05:43 INFO - PROCESS | 25470 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:161.50 stddev:1.89 (1.2%) stddev-sans-first:1.58 15:05:43 INFO - PROCESS | 25470 | Values: 158.0 160.0 163.0 160.0 161.0 162.0 165.0 162.0 161.0 161.0 15:05:43 INFO - PROCESS | 25470 | 15:05:43 INFO - PROCESS | 25470 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.00 Median:60.00 stddev:1.05 (1.8%) stddev-sans-first:1.05 15:05:43 INFO - PROCESS | 25470 | Values: 61.0 62.0 60.0 60.0 60.0 59.0 59.0 61.0 59.0 59.0 15:05:43 INFO - PROCESS | 25470 | -------- Summary: end -------- 15:05:43 INFO - PROCESS | 25470 | 15:05:44 INFO - TEST-INFO | 25470: exit 0 15:05:44 INFO - TEST-OK | kraken | took 60148ms 15:05:44 INFO - SUITE-END | took 1174s 15:05:44 INFO - Completed test suite (00:19:34) 15:05:44 INFO - javascript benchmark 15:05:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7858.8528431093055, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3364.966350336497, 3402.285520040791, 3405.7105146062577, 3414.7097496712777, 3461.5846098468187, 5648.971755141224, 5698.629589076718, 5718.370979192291, 5739.397363276858, 5743.282089738783, 5704.058830292996, 5769.480746732793, 5776.4223577642215, 5776.451237132476, 5786.247787787582, 5125.46182650821, 5150.098732721777, 5176.042432150046, 5181.559567436753, 5212.4266330703595, 5018.5985121190215, 5050.570701490377, 5227.08526007949, 5238.738063096849, 5268.104422248227, 5080.263361812535, 5133.076046311662, 5201.167813149897, 5208.687478751287, 5213.947860521384, 5224.242484839715, 5235.528802407783, 5235.764390602432, 5239.580833533309, 5262.342207224097, 4903.950960490385, 4995.100881841267, 5106.310648062538, 5134.614903882224, 5210.6613070150315, 5558.805441809517, 5592.049351610236, 5603.271574695264, 5661.801836935729, 5664.376918538957, 6088.452039316483, 6124.081387791823, 6134.69326533676, 6138.171346868205, 6153.200083989098, 5968.01527747921, 6216.0, 6229.781957631461, 6239.157713708637, 6240.906386404207, 5684.261046063985, 5697.0, 5715.399883012307, 5754.424557544296, 5760.07838745807, 6276.0, 6305.8108256752375, 6308.936910630927, 6311.905321420182, 6320.0, 6033.185519954838, 6076.817695469143, 6087.908681369783, 6091.329953705089, 6093.695315234309, 5937.703114844327, 5985.281766187998, 6069.0, 6100.69496525172, 6146.416090471398, 6115.490521586124, 6131.570790044654, 6151.661658608819, 6151.938480615226, 6152.046432802923, 5917.053271476543, 5940.079287710412, 5964.671943043088, 5971.0, 6143.0, 4609.377734005933, 4621.699589526737, 4640.767961601974, 4653.395058642423, 4668.229742092584, 3927.5286965564314, 4084.509858816961, 4113.03343714227, 4119.876403707894, 4182.226288136704, 5952.940470595326, 5969.104634304889, 5969.641821490724, 5979.521638268928, 6010.9699451502465, 6125.84685382869, 6219.782307619212, 6220.0, 6227.688615569204, 6230.844228894314, 5750.827475175668, 5794.739236734357, 5871.4715675589405, 5989.101634754822, 5999.190109335271, 5194.974025129925, 5199.324087868553, 5201.843944681666, 5221.6083793715625, 5226.790928362899, 6410.326915673881, 6420.807375778734, 6437.25971513282, 6466.5473416861305, 6469.676516174079, 5928.762849486145, 6058.394160584083, 6181.598196117238, 6185.226846644169, 6188.071789231652, 6317.747290108528, 6413.775517856852, 6454.128692626436, 6490.383413575702, 6500.479961602966, 6039.78860739872, 6040.577159598962, 6046.667433291212, 6046.818595442144, 6060.393960603904, 5916.290045194604, 6166.105914642441, 6168.660723660242, 6171.197744293213, 6175.042868355412, 5917.142014407973, 5928.110783382527, 5988.970055149696, 6056.848578785565, 6062.757489700539, 5980.132880732356, 6015.819525414245, 6018.578699490994, 6024.006039003515, 6036.667983260787, 5778.479936805707, 5822.243108395882, 6036.034234522455, 6039.214902062879, 6052.969735151296, 5859.560532959959, 5943.821685349447, 5955.493783028318, 5977.880442391215, 6011.789587364421, 5911.6748578826855, 5931.9110213345975, 5937.495312898452, 5939.0, 5941.197938278277], "value": 5648.01770892737, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [780.4965797060896, 818.2186012358198, 838.8573942429788, 904.6155383961815, 907.8002839375335, 30986.690133098662, 44205.336919946225, 44792.0, 44922.77538612307, 45009.7749511252, 44880.3267950981, 44941.10117797642, 45210.54789452104, 45213.32180017302, 45229.54770452294, 7713.845723085535, 9266.90733092669, 9406.52967351633, 9410.43537387759, 9419.24646028316, 7786.688532458695, 10773.0, 10992.395418251994, 10994.065504432132, 10995.505202265877, 11130.220884538045, 11144.052755515791, 11161.441927903614, 11169.218154729173, 11169.609063682772, 11091.55633774648, 11104.833427498594, 11106.055985241264, 11110.666679999573, 11137.443127843575, 10678.946605267001, 10784.083352914933, 10784.784304313947, 10791.514381852836, 10808.945955270252, 42107.57892421067, 42268.0, 42290.78854605738, 42574.78712606417, 42624.147517049794, 4198.32826747722, 4238.3430568261965, 4265.616094551474, 4350.064736081726, 4368.847090351823, 30007.549886751716, 30506.847465762752, 30694.232644183852, 31067.223319416968, 32163.83918080418, 4248.9150216995795, 4347.391365208873, 4371.0, 4380.080183161508, 4441.933370999438, 239259.0, 240377.0, 241018.0, 241165.0, 241652.0, 53834.30828458561, 53877.46122538725, 53919.73040134774, 53962.0, 53999.19001214985, 56614.0, 56628.71685641628, 56729.71635141881, 56756.71621641865, 56799.14801277984, 15472.226388680521, 15612.3755049799, 15655.843441565667, 15658.0, 15675.451359202601, 11171.38557379352, 11309.547618095185, 13529.729405412034, 13542.390592423364, 13543.119697219649, 13169.868301317056, 13505.2572108533, 13869.306534673226, 13956.0, 14049.22729249901, 5314.243751842079, 5327.973360133252, 5367.543758780547, 5428.5385742211565, 5453.672779633155, 1006.6074231049896, 1009.4448053570507, 1009.6163457885956, 1011.3780025284398, 1022.943738094412, 28218.30690158597, 28501.857490712413, 28544.71455285462, 30964.84517577398, 31451.213719656735, 1165.959191428296, 1174.7826652069396, 1185.2829038431796, 1204.5496366955006, 1216.9574064907686, 13483.325833708472, 13654.658633534042, 13964.51124210668, 14103.294835258195, 14189.290535473185, 356693.0, 357625.0, 357713.0, 358631.0, 358846.0, 48300.758496207294, 48385.7903552414, 48427.0, 48443.0, 48555.75722121437, 1432.2051261549939, 1464.0191071981585, 1476.143836574784, 1485.9405623775144, 1487.323267913097, 24141.51716965686, 25385.111521096675, 25442.363940901625, 25569.23292301234, 25637.0, 38287.42568861414, 38314.80842595881, 38338.23323533458, 38445.61554384532, 38475.2304953905, 309628.0, 310097.0, 310140.0, 310284.0, 311533.0, 24816.255512334657, 28095.297617559725, 28929.42141157123, 29057.12828615145, 29227.123186304445, 37918.81040594779, 37954.0, 37959.81020094882, 38677.0, 38711.0, 29298.0, 29829.701702982693, 30023.399532009673, 30156.396872062876, 30429.0, 29371.265718357212, 29422.852885735436, 29525.557116642838, 29625.555616665337, 30009.249768755955, 33613.15967100842, 33877.83061084679, 34116.829415852764, 34394.0, 34433.48349774806, 28378.57432138478, 28928.566071509365, 28992.275193120342, 29043.419131617673, 29254.41491170207, 22597.0, 23221.251905978097, 23459.88270058639, 23816.16643417472, 23918.76081239235], "value": 18523.32995401737, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [454.1666042811441, 459.83445959454593, 479.7745059821884, 483.0411632908676, 491.7098911642131, 19859.900700496495, 21735.13059477623, 21998.560028799413, 22063.889680551616, 22541.436464088387, 22130.336089917328, 22279.220227292048, 22775.20286789963, 22777.772222277774, 23052.88473557634, 6382.361763823604, 6475.740970361192, 6572.309907459719, 6624.503162262849, 6640.800775976729, 6607.933920660804, 6628.867422651544, 6676.966615166917, 7264.963675181617, 7572.167061623217, 7530.0, 7532.924670753305, 7537.0201873756605, 7580.128285247184, 7581.962090189541, 7389.2241314662, 7561.395088392916, 7595.050618672666, 7604.733834315828, 7612.3148916597775, 7195.640217989132, 7375.631218439056, 7398.223186565387, 7406.481546291761, 7434.962825185894, 25030.624540631907, 25036.624450633255, 25089.24732258035, 25287.873560632263, 25642.74357256422, 3032.969670303291, 3138.4978403455566, 3248.350329933999, 3438.2435864109857, 3617.981910090433, 15714.371425142981, 15887.443939462179, 16207.351705931867, 16218.594535136597, 16231.188440578042, 2263.524659821423, 2308.6421604651305, 2311.8497297675767, 2321.0947730385165, 2392.114917480526, 75188.62405687936, 93859.53070234673, 117232.0, 118878.43364699073, 120074.7992520081, 17661.498772604216, 17882.731759023623, 18033.819661803478, 18109.909450452928, 18226.54433639143, 31796.0, 32089.518657219694, 32241.193970150933, 32257.51613725749, 32262.83868580689, 10036.899631003742, 10103.646372376932, 10218.18254539635, 10311.07200351972, 10329.638462653771, 8492.193241642035, 8503.1921967413, 8515.276201522816, 8705.956470217736, 8721.60752766127, 9048.185663290204, 9124.800637958559, 9213.81572368549, 9365.672201473051, 9567.473788941676, 3483.686468217822, 3667.156553992597, 3684.8157592120288, 3692.9261414771554, 3772.6981841452616, 975.1613612293422, 975.2246963663904, 980.0007983713145, 984.0602224875227, 990.5542505872386, 21163.78836211618, 21203.36389908305, 21319.25382611601, 21409.464763381042, 21529.277657787654, 987.0425687083517, 988.421773262635, 988.614440368257, 1015.1472762879217, 1020.7295066807302, 10180.541875615616, 11754.529818807323, 11756.353400563052, 11824.70438239051, 11863.228890122115, 643949.0, 652396.0, 654193.0, 658102.0, 690539.0, 86974.56512717396, 90211.99999999869, 106332.0, 109532.0, 109889.45055274833, 1297.1114786371177, 1329.3419757220238, 1348.3595292236305, 1358.796180572922, 1359.8436179839248, 19269.0, 19550.31573894907, 19586.31447899317, 19620.0, 19705.211791528178, 52509.474905250456, 52709.47290527199, 52904.20643690271, 53201.7339913298, 53372.73313633407, 70375.64812175906, 70983.0, 71909.28090719026, 71976.28023719696, 72702.0, 12134.393280336124, 12624.87375126237, 12913.935430322788, 12953.352332383532, 12994.675133121747, 13622.93188534051, 13778.793318100437, 14009.929950350182, 14157.575272741835, 14478.638034049232, 6434.303008581778, 11850.466728997044, 12403.379831008593, 12438.129330946747, 12610.810837837624, 10527.94736026315, 10840.728981775519, 10857.077148442471, 11015.559377625126, 11265.605703800327, 12050.939745301217, 12358.876411235773, 12523.686907827378, 12619.621411357673, 12687.302198379179, 12217.633470995885, 12266.0, 12343.876561234632, 12713.93643031779, 12792.488300467878, 11763.058955283386, 11801.645950621494, 11861.822072668745, 11901.404929753304, 12038.097142714156], "value": 11506.52484578397, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1530.1354734574963, 1560.8439156084387, 1597.2333280025587, 1601.9919900400496, 1603.7915071040763, 10619.73450663733, 11308.717282067952, 11312.321260724362, 11315.321080735162, 11323.20737548372, 11338.546458141685, 11694.883051169485, 11705.53177872884, 11712.882871171285, 11724.23792453492, 2432.3067925641194, 2439.4145405102827, 2451.4974430241846, 2454.6686197363397, 2467.6668649732237, 2444.6180097804563, 2459.0655550890638, 2504.3864253257975, 2507.8119141064403, 2511.949761004779, 2413.734489206186, 2457.6682147910074, 2469.259222233332, 2493.8628375439343, 2502.5995840665496, 2397.137030668958, 2422.188566830114, 2423.4062654649724, 2428.890699918499, 2464.6549483072386, 2365.077619728307, 2394.2458125690528, 2407.783299503036, 2407.964575232649, 2408.2895545814026, 11116.49975751085, 11201.103911687045, 11228.101751859913, 11235.269707468988, 11255.887441125566, 5792.68140252286, 5936.22829032223, 5944.583879128462, 5945.048792193272, 5948.97025514874, 3596.8920932371807, 3699.445083237536, 3746.906327341811, 3762.7930463824478, 3774.9622503774885, 1328.362386054699, 1427.907186032915, 1484.487851691165, 2242.686023956647, 2269.0, 15303.15832629205, 15588.532344029698, 16953.83046169547, 18159.727604085816, 18301.7254741179, 4798.616110711135, 4861.927071093936, 4916.262560615936, 5020.924686129711, 5024.6231532634465, 12795.104342695922, 12795.232286062866, 12800.103992720606, 12801.61595152147, 12810.679733006564, 6039.275286965592, 6045.455908968214, 6046.576739628272, 6053.909191362133, 6056.394360563909, 5443.292371991616, 5539.9169012464845, 5579.218909352694, 5596.58025648078, 5612.214289999403, 4107.230086792653, 4130.979345103256, 4155.218077033756, 4198.9370159447635, 4200.201961627281, 1087.3856271206744, 1088.7006073329899, 1099.5925215723726, 1103.1340397787699, 1104.376027544435, 1048.2086025051037, 1052.9947350263353, 1064.5156453813652, 1066.157735389034, 1076.2896488317672, 7273.0908636420445, 7310.122785265802, 7432.182459929403, 7467.178610352857, 7585.772426827204, 1003.894591067942, 1010.545254635417, 1033.9534720937577, 1040.5951964847395, 1059.7668512927298, 4635.443746750411, 4675.22858728306, 4692.0, 4950.108980383494, 4950.554450099508, 14419.711605768036, 14543.854561454462, 14964.326605302787, 14989.175595342362, 15084.170370629501, 14430.639234019023, 15121.924390378197, 15126.168060756763, 15222.467213647691, 15242.466513671969, 10658.360498370123, 10702.571897124028, 10862.891371086345, 10906.400147991779, 10929.344239345664, 7220.74727384539, 7500.737474188377, 7515.473916825769, 7604.2395760423515, 7744.303012728881, 13060.151090179108, 13073.803892941423, 13106.148100373444, 13236.933815331247, 13688.589342319747, 13204.933975330061, 13245.536406225736, 13276.468941242241, 13321.733565328834, 13332.866671333162, 11109.0, 11290.322580645188, 11412.0, 11412.48643811014, 11417.657470275573, 11068.833967490655, 11142.997130258316, 11222.831657524981, 11231.26996745209, 11235.382053986783, 9197.954010229905, 9644.95177524108, 9656.420614762856, 9717.6598819041, 9750.122488975743, 9179.908200917906, 9245.491497967676, 9262.907370926205, 9341.57962891685, 9684.903150968401, 7942.126366099609, 8157.6736930524485, 8313.251807337369, 8322.791930201793, 8405.159484051546, 6134.509239260938, 6183.165272688129, 6196.504279657526, 6313.589616674902, 6324.588901721373, 6329.240491141092, 6432.067350234283, 6505.251896032017, 6606.372394622503, 6640.501962352746], "value": 5541.113026707523, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.8015992003998, 398.4143309335276, 401.8995251187203, 411.4178437510922, 419.4295757769434, 5286.682799032056, 5325.440828712983, 5332.600054995876, 5366.382865970405, 5374.865628359293, 5067.391912970439, 5178.896422071556, 5190.143626301665, 5198.906650542921, 5262.263283140353, 4143.979280103596, 4145.880612234695, 4152.190322887038, 4153.397757325193, 4155.916881662365, 4121.9587804121875, 4149.875503734877, 4162.354835000579, 4171.290880550298, 4178.853740119096, 4063.537126634409, 4111.301078816593, 4113.25961326961, 4128.027819969617, 4129.359949207877, 4153.854615088488, 4158.438610787565, 4158.500979882403, 4160.417541544186, 4184.372344148372, 3710.998030531768, 3711.740178187528, 3716.1824398632257, 3729.3287208302495, 3729.9440508392395, 4866.038099664265, 5047.7476126193915, 5058.54473097423, 5072.264521644341, 5083.847484575469, 4736.478987311393, 4803.879903002418, 4805.951940480585, 4811.687240329367, 4846.975765121187, 5411.567074634059, 5448.237246785453, 5463.31708536433, 5473.0969390050595, 5477.890442191134, 4024.6579040781567, 4144.979275103636, 4165.854584888784, 4176.331786914109, 4186.55563830478, 5472.808451704211, 5532.229686500322, 5684.488396044376, 5721.256236689203, 5746.236215278999, 4919.262110683426, 5009.7495125243595, 5046.722430266371, 5061.44324124346, 5067.391912970467, 5080.415752188545, 5146.614003949644, 5174.758058066112, 5195.870103247449, 5240.410318931544, 5157.6647517911215, 5244.632875698664, 5297.443768404339, 5309.522143007148, 5338.572914166857, 5497.570631635804, 5521.613487055867, 5530.5022547970075, 5530.917036244459, 5547.667139971614, 1752.9044347282947, 1769.8761286582856, 1771.247219931524, 1791.6774980503374, 1825.3976187857975, 1456.0535651826185, 1487.4793822162374, 1498.9850101498846, 1516.6360073582482, 1529.3653133949285, 5551.500364967092, 5582.888342233214, 5585.664860108406, 5619.634723742944, 5622.269105016404, 5434.184872269191, 5684.744186511617, 5708.514776244066, 5737.8565535861935, 5745.35170166947, 5475.7262136893, 5500.834974950758, 5506.430667259811, 5511.751971161308, 5533.833984980377, 2954.7931644784658, 2966.718161774628, 2979.7765167612515, 2985.9701402986125, 2989.446952313829, 5742.655440673573, 5868.559858010666, 5896.407969848117, 5943.3462319144855, 6045.093236014633, 5733.799317023968, 5773.913391299134, 5808.651480911159, 5856.916470452979, 5874.530037596982, 5702.918434771362, 5949.851253718605, 5964.522838172849, 6007.249093863267, 6022.427869352405, 5682.289713785777, 5696.658200507983, 5706.77567174545, 5717.256756621613, 5718.25662663851, 5357.732113394392, 5637.998510528867, 5662.310402558752, 5687.715614219355, 5693.583849690318, 5810.970945145416, 5897.734601942837, 5912.46787789101, 5948.5538584605465, 5958.553108516965, 4708.482066972561, 4744.691595046449, 4746.667733258639, 4757.524247575215, 4773.04539092176, 5518.889622207614, 5631.324241091095, 5675.262215911905, 5698.6580805151825, 5735.627184233012, 5470.452954704498, 5487.286652735279, 5492.80775172867, 5524.640898341595, 5531.529819965348, 5438.592105592017, 5483.890322193613, 5503.504684578407, 5554.361248456479, 5574.414686458026, 5263.763130659053, 5453.40075550135, 5484.478974497416, 5488.780448782004, 5490.423505532021, 5541.750621221974, 5543.750531226024, 5545.833624991256, 5558.304717061335, 5566.944330556643, 5290.867728306823, 5389.2455056291365, 5451.182322651634, 5483.396826349178, 5513.581579420785], "value": 4440.107608539726, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [843.7890527368158, 868.778461492319, 895.1406649616368, 904.3533873280608, 928.67960553609, 16866.66266674666, 17318.480445586654, 18188.181531831066, 18216.635667286664, 18239.54401139972, 15946.28241729122, 16082.59793505163, 16088.919555402235, 16108.275127619256, 16110.436134735286, 860.6342304520585, 868.4355169140047, 883.147762409275, 893.066745251214, 898.9146031127033, 881.0000649263069, 897.8294124116429, 897.9820403591924, 899.9100089990982, 900.6082354175921, 959.366817900186, 959.395580784105, 959.7696552827341, 960.2078285414526, 960.7502049467154, 953.0802775321848, 957.6456711016933, 959.3668179001895, 959.3955807841015, 959.491469521155, 702.1959855964942, 702.2450865319751, 704.0389867830374, 704.0495331302751, 705.1608585782902, 17248.48254552353, 17257.741133883002, 17615.383461578913, 18516.722249166272, 18631.53421164468, 14645.340959656842, 15701.842981570266, 15713.842861571353, 15874.12692301923, 16134.677306453805, 14832.110073395523, 14886.0, 14891.70216595662, 14947.775783363259, 15211.619709507351, 4695.5069717679835, 4802.303665968415, 4833.661643684944, 4851.126797176542, 4926.088673595396, 45842.312365314545, 54781.72609136929, 69452.30547694508, 79642.6017869907, 90499.0, 12128.393580320948, 12561.937190313989, 12569.434375453127, 12578.622641320591, 12704.682382940315, 21049.263275785273, 21321.040553175146, 22539.0984360627, 23177.88411057968, 23420.88289558541, 8827.470351778913, 8964.775880603038, 9160.45762390663, 9194.862077068849, 9195.172434480928, 4762.404699412574, 4908.975455122773, 4963.379577552806, 4994.80020799164, 5044.142495775727, 3686.4101743721412, 3792.7345085844277, 3793.8292776824555, 3794.962050379516, 3798.848046078126, 667.4927055437902, 670.8356452669127, 672.4183581202225, 673.5386260411535, 684.616614695772, 785.7292424892066, 810.4245985350467, 826.8139668574522, 835.9414840961196, 840.4663038970298, 11542.653720388402, 11778.823317650242, 12032.759344813056, 12301.44643491027, 12628.873711262953, 765.8506591214659, 776.6349815586665, 780.8750599903988, 786.1244066750859, 797.5374282915894, 5411.161270003156, 5678.233438485751, 5802.738876750556, 5827.59206855516, 5845.970770146122, 78147.0, 80644.59677701574, 81036.59481702554, 82513.0, 84334.15665843386, 72095.0, 72820.0, 73801.6309918447, 74020.62989685124, 75053.62473187599, 51434.74282628563, 60233.69883150644, 60253.39746602566, 60830.39169608336, 61003.0, 11015.118790496901, 11162.497687603915, 11166.994970452699, 11446.542138314375, 11474.77050459003, 44822.551774481835, 45248.09503809839, 45422.77288613536, 45991.77004114958, 46266.53733462622, 51157.23264151115, 51717.741411294206, 51843.740781295855, 51930.0, 52132.47867521428, 12402.25586464815, 12617.621471355875, 12795.232286062866, 12838.871611283768, 13045.412956417174, 14532.709345813237, 14741.408768776178, 14833.629159271104, 14919.403223870924, 14927.253637317874, 14535.345909434312, 14712.852871471148, 15378.384864605738, 15417.845821541641, 15473.148976806384, 15625.84374156244, 16190.757138642693, 16428.425005125242, 16621.168941553115, 16797.0, 15513.967454957672, 15954.680906381574, 15956.361745530048, 16126.113063781604, 16398.098104603883, 10649.733756656145, 11074.723131921766, 11251.943740281245, 11344.0, 11428.2000259981, 13166.539171128965, 13689.97325200594, 13691.520796772065, 13774.65563360924, 13848.169109853441], "value": 7953.67516467515, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1468.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 111.0, 111.0, 113.0, 112.0, 111.0, 113.0, 111.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 116.0, 116.0, 162.0, 117.0, 115.0, 115.0, 113.0, 132.0, 119.0], "value": 124.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 172.0, 174.0, 175.0, 173.0, 173.0, 172.0, 173.0, 173.0, 173.0], "value": 173.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 106.0, 75.0, 76.0, 77.0, 76.0, 95.0, 74.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 102.0, 83.0, 83.0, 82.0, 94.0, 82.0, 82.0, 107.0], "value": 87.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 113.0, 112.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 148.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 93.0, 95.0, 94.0, 93.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 53.0, 54.0, 54.0, 54.0, 55.0, 54.0, 55.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 54.0, 53.0, 53.0, 54.0, 53.0, 54.0], "value": 53.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 86.0, 77.0, 82.0, 79.0, 76.0, 75.0, 81.0, 76.0, 79.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 122.0, 120.0, 128.0, 118.0, 143.0, 118.0, 120.0, 165.0, 142.0], "value": 129.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 160.0, 163.0, 160.0, 161.0, 162.0, 165.0, 162.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 60.0, 60.0, 60.0, 59.0, 59.0, 61.0, 59.0, 59.0], "value": 60.0, "unit": "score"}]}]} 15:05:44 INFO - Return code: 0 15:05:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:05:44 ERROR - # TBPL SUCCESS # 15:05:44 INFO - Running post-action listener: _resource_record_post_action 15:05:44 INFO - [mozharness: 2017-04-11 22:05:44.738499Z] Finished run-tests step (success) 15:05:44 INFO - Running post-run listener: _resource_record_post_run 15:05:44 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 270336; Write bytes: 373071872; Read time: 84; Write time: 276212 15:05:44 INFO - TinderboxPrint: CPU usage
13.1% 15:05:44 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 84 15:05:44 INFO - TinderboxPrint: I/O write bytes / time
373,071,872 / 276,212 15:05:44 INFO - TinderboxPrint: CPU idle
8,264.4 (86.9%) 15:05:44 INFO - TinderboxPrint: CPU user
1,202.8 (12.6%) 15:05:44 INFO - TinderboxPrint: Swap in / out
0 / 0 15:05:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118030336; Read time: 0; Write time: 114532 15:05:44 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 270336; Write bytes: 255041536; Read time: 84; Write time: 161680 15:05:45 INFO - Running post-run listener: _upload_blobber_files 15:05:45 INFO - Blob upload gear active. 15:05:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:05:45 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 15:05:45 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'] 15:05:45 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 15:05:45 INFO - (blobuploader) - INFO - Open directory for files ... 15:05:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:05:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:05:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:05:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:05:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:05:46 INFO - (blobuploader) - INFO - Done attempting. 15:05:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:05:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:05:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:05:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:05:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:05:49 INFO - (blobuploader) - INFO - Done attempting. 15:05:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:05:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:05:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:05:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:05:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:05:50 INFO - (blobuploader) - INFO - Done attempting. 15:05:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:05:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:05:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:05:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:05:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:05:51 INFO - (blobuploader) - INFO - Done attempting. 15:05:51 INFO - (blobuploader) - INFO - Iteration through files over. 15:05:51 INFO - Return code: 0 15:05:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:05:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:05:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/75bbdf09025955a136980723ebe53ad938d031fa732fe0498ae9f093c0551c889b77fcd17d6c66b4c2f6b9c70e7338ae38685c5062966ca8f6088a58e7afd859", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/2f563a74c3fd2342ddf9865218ad67f3d8d10e067f43fb302a41c88afbd4e750f1f6f1e5a5a802474a8746c9310fafd55c8fdbdf57b66cc955041c9db36aad20", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/c899c583fe3f2e0245757601466a3a19f29e943d4b936beda64dd1cdebbf149eb1d632f4637459c0fa5d526b3957a0f5a4d32821f2279874d057bb9b68476035", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f67a2a72b8a1ec18ccb264b42ba58318e73f4bf5ffb69239502820ceb10aa9a5b294cd8a4fc2bc8d369fe384bdce758b2a4e3be59a74041ffc70cb108a456652"} 15:05:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:05:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:05:51 INFO - Contents: 15:05:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/75bbdf09025955a136980723ebe53ad938d031fa732fe0498ae9f093c0551c889b77fcd17d6c66b4c2f6b9c70e7338ae38685c5062966ca8f6088a58e7afd859", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/2f563a74c3fd2342ddf9865218ad67f3d8d10e067f43fb302a41c88afbd4e750f1f6f1e5a5a802474a8746c9310fafd55c8fdbdf57b66cc955041c9db36aad20", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/c899c583fe3f2e0245757601466a3a19f29e943d4b936beda64dd1cdebbf149eb1d632f4637459c0fa5d526b3957a0f5a4d32821f2279874d057bb9b68476035", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f67a2a72b8a1ec18ccb264b42ba58318e73f4bf5ffb69239502820ceb10aa9a5b294cd8a4fc2bc8d369fe384bdce758b2a4e3be59a74041ffc70cb108a456652"} 15:05:51 INFO - Running post-run listener: copy_logs_to_upload_dir 15:05:51 INFO - Copying logs to upload dir... 15:05:51 INFO - mkdir: /builds/slave/test/build/upload/logs 15:05:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.653884 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-04-11 15:05:51.329047) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-11 15:05:51.332511) ========= 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=ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/75bbdf09025955a136980723ebe53ad938d031fa732fe0498ae9f093c0551c889b77fcd17d6c66b4c2f6b9c70e7338ae38685c5062966ca8f6088a58e7afd859", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/2f563a74c3fd2342ddf9865218ad67f3d8d10e067f43fb302a41c88afbd4e750f1f6f1e5a5a802474a8746c9310fafd55c8fdbdf57b66cc955041c9db36aad20", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/c899c583fe3f2e0245757601466a3a19f29e943d4b936beda64dd1cdebbf149eb1d632f4637459c0fa5d526b3957a0f5a4d32821f2279874d057bb9b68476035", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f67a2a72b8a1ec18ccb264b42ba58318e73f4bf5ffb69239502820ceb10aa9a5b294cd8a4fc2bc8d369fe384bdce758b2a4e3be59a74041ffc70cb108a456652"} build_url:https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011442 build_url: 'https://queue.taskcluster.net/v1/task/P26-C5B9TXKaSsc9yhW6Uw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/75bbdf09025955a136980723ebe53ad938d031fa732fe0498ae9f093c0551c889b77fcd17d6c66b4c2f6b9c70e7338ae38685c5062966ca8f6088a58e7afd859", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/2f563a74c3fd2342ddf9865218ad67f3d8d10e067f43fb302a41c88afbd4e750f1f6f1e5a5a802474a8746c9310fafd55c8fdbdf57b66cc955041c9db36aad20", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/c899c583fe3f2e0245757601466a3a19f29e943d4b936beda64dd1cdebbf149eb1d632f4637459c0fa5d526b3957a0f5a4d32821f2279874d057bb9b68476035", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f67a2a72b8a1ec18ccb264b42ba58318e73f4bf5ffb69239502820ceb10aa9a5b294cd8a4fc2bc8d369fe384bdce758b2a4e3be59a74041ffc70cb108a456652"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-11 15:05:51.358313) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 15:05:51.358637) ========= 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=ed14279e38b05397cf4aa391000001a4-1491947099.245705-1097269466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 15:05:51.451718) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-11 15:05:51.452058) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-11 15:05:51.452345) ========= ========= Total master_lag: 0.19 =========