builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-051 starttime: 1486137240.06 results: success (0) revision: c02020dd7e6e190b046e0bdc992a75b647c4cffa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 07:54:00.062559) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 07:54:00.063098) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 07:54:00.063490) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 07:54:00.080192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 07:54:00.080561) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-03 07:54:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-02-03 07:54:00 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.328729 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 07:54:00.423232) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 07:54:00.423632) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018657 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 07:54:00.473105) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-03 07:54:00.473445) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c02020dd7e6e190b046e0bdc992a75b647c4cffa --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 c02020dd7e6e190b046e0bdc992a75b647c4cffa --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=5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-03 07:54:00,738 truncating revision to first 12 chars 2017-02-03 07:54:00,738 Setting DEBUG logging. 2017-02-03 07:54:00,738 attempt 1/10 2017-02-03 07:54:00,738 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c02020dd7e6e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-03 07:54:01,699 unpacking tar archive at: mozilla-aurora-c02020dd7e6e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.326221 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-03 07:54:01.812516) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 07:54:01.812833) ========= script_repo_revision: c02020dd7e6e190b046e0bdc992a75b647c4cffa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 07:54:01.816316) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 07:54:01.816625) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 07:54:01.825969) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-02-03 07:54:01.826366) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:54:02 INFO - MultiFileLogger online at 20170203 07:54:02 in /builds/slave/test 07:54:02 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 07:54:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:54:02 INFO - {'append_to_log': False, 07:54:02 INFO - 'base_work_dir': '/builds/slave/test', 07:54:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 07:54:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:54:02 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 07:54:02 INFO - 'buildbot_json_path': 'buildprops.json', 07:54:02 INFO - 'config_files': ('talos/linux_config.py',), 07:54:02 INFO - 'default_actions': ('clobber', 07:54:02 INFO - 'read-buildbot-config', 07:54:02 INFO - 'download-and-extract', 07:54:02 INFO - 'populate-webroot', 07:54:02 INFO - 'create-virtualenv', 07:54:02 INFO - 'install', 07:54:02 INFO - 'run-tests'), 07:54:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:54:02 INFO - 'download_minidump_stackwalk': True, 07:54:02 INFO - 'download_symbols': 'ondemand', 07:54:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:54:02 INFO - 'tooltool.py': '/tools/tooltool.py', 07:54:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:54:02 INFO - '/tools/misc-python/virtualenv.py')}, 07:54:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:54:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:54:02 INFO - 'installer_path': 'installer.exe', 07:54:02 INFO - 'log_level': 'info', 07:54:02 INFO - 'log_name': 'talos', 07:54:02 INFO - 'log_to_console': True, 07:54:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:54:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:54:02 INFO - 'opt_config_files': (), 07:54:02 INFO - 'pip_index': False, 07:54:02 INFO - 'sps_profile': False, 07:54:02 INFO - 'sps_profile_interval': 0, 07:54:02 INFO - 'suite': 'dromaeojs', 07:54:02 INFO - 'system_bits': '32', 07:54:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:54:02 INFO - 'title': 'talos-linux64-ix-051', 07:54:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:54:02 INFO - 'use_talos_json': True, 07:54:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:54:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:54:02 INFO - 'work_dir': 'build'} 07:54:02 INFO - [mozharness: 2017-02-03 15:54:02.192013Z] Running clobber step. 07:54:02 INFO - Running pre-action listener: _resource_record_pre_action 07:54:02 INFO - Running main action method: clobber 07:54:02 INFO - rmtree: /builds/slave/test/build 07:54:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:54:02 INFO - Running post-action listener: _resource_record_post_action 07:54:02 INFO - [mozharness: 2017-02-03 15:54:02.657884Z] Finished clobber step (success) 07:54:02 INFO - [mozharness: 2017-02-03 15:54:02.657986Z] Running read-buildbot-config step. 07:54:02 INFO - Running pre-action listener: _resource_record_pre_action 07:54:02 INFO - Running main action method: read_buildbot_config 07:54:02 INFO - Using buildbot properties: 07:54:02 INFO - { 07:54:02 INFO - "project": "", 07:54:02 INFO - "product": "firefox", 07:54:02 INFO - "who": "ryanvm@gmail.com", 07:54:02 INFO - "installer_path": "public/build/target.tar.bz2", 07:54:02 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 07:54:02 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 07:54:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 07:54:02 INFO - "stage_platform": "linux64", 07:54:02 INFO - "basedir": "/builds/slave/test", 07:54:02 INFO - "buildnumber": 16, 07:54:02 INFO - "platform": "ubuntu64_hw", 07:54:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:54:02 INFO - "slavebuilddir": "test", 07:54:02 INFO - "taskId": "T6a3T8MSQSmNWW7YinL1SQ", 07:54:02 INFO - "branch": "mozilla-aurora", 07:54:02 INFO - "script_repo_revision": "production", 07:54:02 INFO - "revision": "c02020dd7e6e190b046e0bdc992a75b647c4cffa", 07:54:02 INFO - "slavename": "talos-linux64-ix-051", 07:54:02 INFO - "repo_path": "releases/mozilla-aurora" 07:54:02 INFO - } 07:54:02 INFO - Finding installer, test and symbols from parent task. 07:54:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T6a3T8MSQSmNWW7YinL1SQ'}, attempt #1 07:54:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T6a3T8MSQSmNWW7YinL1SQ'}, attempt #1 07:54:03 INFO - Task dependencies: CINvy-kLQkuv8tzcXGiYSA 07:54:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CINvy-kLQkuv8tzcXGiYSA'}, attempt #1 07:54:04 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/target.tar.bz2 07:54:04 INFO - Set test_url: https://queue.taskcluster.net/v1/task/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/test_packages.json 07:54:04 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/target.crashreporter-symbols.zip 07:54:04 INFO - Running post-action listener: _resource_record_post_action 07:54:04 INFO - [mozharness: 2017-02-03 15:54:04.086688Z] Finished read-buildbot-config step (success) 07:54:04 INFO - [mozharness: 2017-02-03 15:54:04.086905Z] Running download-and-extract step. 07:54:04 INFO - Running pre-action listener: _resource_record_pre_action 07:54:04 INFO - Running main action method: download_and_extract 07:54:04 INFO - mkdir: /builds/slave/test/build/tests 07:54: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')]} 07:54:04 INFO - trying https://queue.taskcluster.net/v1/task/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/target.test_packages.json 07:54:04 INFO - Downloading https://queue.taskcluster.net/v1/task/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:54:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:54:04 INFO - Downloaded 896 bytes. 07:54:04 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:54:04 INFO - Using the following test package requirements: 07:54:04 INFO - {u'common': [u'target.common.tests.zip'], 07:54:04 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:54:04 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:54:04 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:54:04 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:54:04 INFO - u'mozbase': [u'target.common.tests.zip'], 07:54:04 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:54:04 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:54:04 INFO - u'web-platform': [u'target.common.tests.zip', 07:54:04 INFO - u'target.web-platform.tests.zip'], 07:54:04 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:54:04 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:54:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/target.common.tests.zip 07:54:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:54:04 INFO - Fetch https://queue.taskcluster.net/v1/task/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/target.common.tests.zip into memory 07:54:05 INFO - Expected file size: 21854409 07:54:05 INFO - Obtained file size: 21854409 07:54:09 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:54:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/target.common.tests.zip 07:54:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:54:09 INFO - Fetch https://queue.taskcluster.net/v1/task/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/target.common.tests.zip into memory 07:54:10 INFO - Expected file size: 21854409 07:54:10 INFO - Obtained file size: 21854409 07:54:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/target.talos.tests.zip 07:54:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:54:14 INFO - Fetch https://queue.taskcluster.net/v1/task/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/target.talos.tests.zip into memory 07:54:15 INFO - Expected file size: 14403485 07:54:15 INFO - Obtained file size: 14403485 07:54:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:15 INFO - trying https://queue.taskcluster.net/v1/task/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/target.tar.bz2 07:54:15 INFO - Downloading https://queue.taskcluster.net/v1/task/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:54:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:54:17 INFO - Downloaded 66117951 bytes. 07:54:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/target.tar.bz2 07:54:17 INFO - mkdir: /builds/slave/test/properties 07:54:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:54:17 INFO - Writing to file /builds/slave/test/properties/build_url 07:54:17 INFO - Contents: 07:54:17 INFO - build_url:https://queue.taskcluster.net/v1/task/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/target.tar.bz2 07:54:17 INFO - Running post-action listener: _resource_record_post_action 07:54:17 INFO - Running post-action listener: set_extra_try_arguments 07:54:17 INFO - [mozharness: 2017-02-03 15:54:17.095135Z] Finished download-and-extract step (success) 07:54:17 INFO - [mozharness: 2017-02-03 15:54:17.095232Z] Running populate-webroot step. 07:54:17 INFO - Running pre-action listener: _resource_record_pre_action 07:54:17 INFO - Running main action method: populate_webroot 07:54:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:54:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:54:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:54:17 INFO - '--tppagecycles', 07:54:17 INFO - '7'], 07:54:17 INFO - 'tests': ['tsvgm']}}, 07:54:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:54:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:54:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:54:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:54:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:54:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:54:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:54:17 INFO - 'talos_options': ['--disable-e10s'], 07:54:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:54:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:54:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:54:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:54:17 INFO - 'talos_options': ['--disable-e10s'], 07:54:17 INFO - 'tests': ['damp', 'tps']}, 07:54:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:54:17 INFO - 'tests': ['damp', 'tps']}, 07:54:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:54:17 INFO - 'tests': ['dromaeo_dom']}, 07:54:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:54:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:54:17 INFO - 'tests': ['basic_compositor_video']}, 07:54:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:54:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:54:17 INFO - 'tests': ['a11yr', 07:54:17 INFO - 'ts_paint', 07:54:17 INFO - 'tpaint', 07:54:17 INFO - 'sessionrestore', 07:54:17 INFO - 'sessionrestore_no_auto_restore', 07:54:17 INFO - 'tabpaint']}, 07:54:17 INFO - 'other-e10s': {'tests': ['a11yr', 07:54:17 INFO - 'ts_paint', 07:54:17 INFO - 'tpaint', 07:54:17 INFO - 'sessionrestore', 07:54:17 INFO - 'sessionrestore_no_auto_restore', 07:54:17 INFO - 'tabpaint']}, 07:54:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:54:17 INFO - 'ts_paint', 07:54:17 INFO - 'tpaint', 07:54:17 INFO - 'sessionrestore', 07:54:17 INFO - 'sessionrestore_no_auto_restore', 07:54:17 INFO - 'tabpaint']}, 07:54:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:54:17 INFO - 'ts_paint', 07:54:17 INFO - 'tpaint', 07:54:17 INFO - 'sessionrestore', 07:54:17 INFO - 'sessionrestore_no_auto_restore', 07:54:17 INFO - 'tabpaint']}, 07:54:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:54:17 INFO - 'tests': ['a11yr', 07:54:17 INFO - 'ts_paint', 07:54:17 INFO - 'tpaint', 07:54:17 INFO - 'sessionrestore', 07:54:17 INFO - 'sessionrestore_no_auto_restore', 07:54:17 INFO - 'tabpaint']}, 07:54:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:54:17 INFO - 'tests': ['a11yr', 07:54:17 INFO - 'ts_paint', 07:54:17 INFO - 'tpaint', 07:54:17 INFO - 'sessionrestore', 07:54:17 INFO - 'sessionrestore_no_auto_restore', 07:54:17 INFO - 'tabpaint']}, 07:54:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:54:17 INFO - 'tests': ['tsvgx', 07:54:17 INFO - 'tsvgr_opacity', 07:54:17 INFO - 'tart', 07:54:17 INFO - 'tscrollx', 07:54:17 INFO - 'cart', 07:54:17 INFO - 'tsvg_static']}, 07:54:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:54:17 INFO - 'tsvgr_opacity', 07:54:17 INFO - 'tart', 07:54:17 INFO - 'tscrollx', 07:54:17 INFO - 'cart', 07:54:17 INFO - 'tsvg_static']}, 07:54:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:54:17 INFO - 'talos_options': ['--disable-e10s'], 07:54:17 INFO - 'tests': ['tp5o']}, 07:54:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:54:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:54:17 INFO - 'talos_options': ['--disable-e10s', 07:54:17 INFO - '--xperf_path', 07:54:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:54:17 INFO - 'tests': ['tp5n']}, 07:54:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:54:17 INFO - 'talos_options': ['--xperf_path', 07:54:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:54:17 INFO - 'tests': ['tp5n']}}, 07:54:17 INFO - 'talos.zip': {'path': '', 07:54:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:54:17 INFO - Running post-action listener: _resource_record_post_action 07:54:17 INFO - [mozharness: 2017-02-03 15:54:17.108318Z] Finished populate-webroot step (success) 07:54:17 INFO - [mozharness: 2017-02-03 15:54:17.108408Z] Running create-virtualenv step. 07:54:17 INFO - Running pre-action listener: _resource_record_pre_action 07:54:17 INFO - Running main action method: create_virtualenv 07:54:17 INFO - Creating virtualenv /builds/slave/test/build/venv 07:54:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:54:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:54:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:54:17 INFO - Using real prefix '/usr' 07:54:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:54:17 INFO - Installing distribute.............................................................................................................................................................................................done. 07:54:19 INFO - Installing pip.................done. 07:54:19 INFO - Return code: 0 07:54:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:54:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:54:19 INFO - Reading from file tmpfile_stdout 07:54:19 INFO - Output received: 07:54:19 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:54:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xab01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe22980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1fd00>, '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 0xe20a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe20eb0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:54:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:54:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:54:19 INFO - Using env: {'DISPLAY': ':0', 07:54:19 INFO - 'HOME': '/home/cltbld', 07:54:19 INFO - 'LANG': 'en_US.UTF-8', 07:54:19 INFO - 'LANGUAGE': 'en_US:en', 07:54:19 INFO - 'LOGNAME': 'cltbld', 07:54:19 INFO - 'MAIL': '/var/mail/cltbld', 07:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:19 INFO - 'MOZ_NO_REMOTE': '1', 07:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:19 INFO - 'NO_EM_RESTART': '1', 07:54:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:19 INFO - 'PWD': '/builds/slave/test', 07:54:19 INFO - 'SHELL': '/bin/bash', 07:54:19 INFO - 'SHLVL': '1', 07:54:19 INFO - 'TERM': 'linux', 07:54:19 INFO - 'TMOUT': '86400', 07:54:19 INFO - 'USER': 'cltbld', 07:54:19 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570', 07:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:19 INFO - '_': '/tools/buildbot/bin/python'} 07:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:54:20 INFO - Cleaning up... 07:54:20 INFO - Return code: 0 07:54:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:20 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 0xab01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe22980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1fd00>, '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 0xe20a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe20eb0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:54:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:54:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:54:20 INFO - Using env: {'DISPLAY': ':0', 07:54:20 INFO - 'HOME': '/home/cltbld', 07:54:20 INFO - 'LANG': 'en_US.UTF-8', 07:54:20 INFO - 'LANGUAGE': 'en_US:en', 07:54:20 INFO - 'LOGNAME': 'cltbld', 07:54:20 INFO - 'MAIL': '/var/mail/cltbld', 07:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:20 INFO - 'MOZ_NO_REMOTE': '1', 07:54:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:20 INFO - 'NO_EM_RESTART': '1', 07:54:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:20 INFO - 'PWD': '/builds/slave/test', 07:54:20 INFO - 'SHELL': '/bin/bash', 07:54:20 INFO - 'SHLVL': '1', 07:54:20 INFO - 'TERM': 'linux', 07:54:20 INFO - 'TMOUT': '86400', 07:54:20 INFO - 'USER': 'cltbld', 07:54:20 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570', 07:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:20 INFO - '_': '/tools/buildbot/bin/python'} 07:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:20 INFO - Downloading/unpacking psutil>=3.1.1 07:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:54:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:54:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:54:22 INFO - Installing collected packages: psutil 07:54:22 INFO - Running setup.py install for psutil 07:54:22 INFO - building 'psutil._psutil_linux' extension 07:54:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:54:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:54:22 INFO - building 'psutil._psutil_posix' extension 07:54:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:54:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:54:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:54:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:54:22 INFO - Successfully installed psutil 07:54:22 INFO - Cleaning up... 07:54:23 INFO - Return code: 0 07:54:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:54:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:23 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 0xab01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe22980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1fd00>, '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 0xe20a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe20eb0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:54:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:54:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:54:23 INFO - Using env: {'DISPLAY': ':0', 07:54:23 INFO - 'HOME': '/home/cltbld', 07:54:23 INFO - 'LANG': 'en_US.UTF-8', 07:54:23 INFO - 'LANGUAGE': 'en_US:en', 07:54:23 INFO - 'LOGNAME': 'cltbld', 07:54:23 INFO - 'MAIL': '/var/mail/cltbld', 07:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:23 INFO - 'MOZ_NO_REMOTE': '1', 07:54:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:23 INFO - 'NO_EM_RESTART': '1', 07:54:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:23 INFO - 'PWD': '/builds/slave/test', 07:54:23 INFO - 'SHELL': '/bin/bash', 07:54:23 INFO - 'SHLVL': '1', 07:54:23 INFO - 'TERM': 'linux', 07:54:23 INFO - 'TMOUT': '86400', 07:54:23 INFO - 'USER': 'cltbld', 07:54:23 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570', 07:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:23 INFO - '_': '/tools/buildbot/bin/python'} 07:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:54:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:54:25 INFO - Installing collected packages: mozsystemmonitor 07:54:25 INFO - Running setup.py install for mozsystemmonitor 07:54:25 INFO - Successfully installed mozsystemmonitor 07:54:25 INFO - Cleaning up... 07:54:25 INFO - Return code: 0 07:54:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:25 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 0xab01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe22980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1fd00>, '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 0xe20a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe20eb0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:54:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:54:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:54:25 INFO - Using env: {'DISPLAY': ':0', 07:54:25 INFO - 'HOME': '/home/cltbld', 07:54:25 INFO - 'LANG': 'en_US.UTF-8', 07:54:25 INFO - 'LANGUAGE': 'en_US:en', 07:54:25 INFO - 'LOGNAME': 'cltbld', 07:54:25 INFO - 'MAIL': '/var/mail/cltbld', 07:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:25 INFO - 'MOZ_NO_REMOTE': '1', 07:54:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:25 INFO - 'NO_EM_RESTART': '1', 07:54:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:25 INFO - 'PWD': '/builds/slave/test', 07:54:25 INFO - 'SHELL': '/bin/bash', 07:54:25 INFO - 'SHLVL': '1', 07:54:25 INFO - 'TERM': 'linux', 07:54:25 INFO - 'TMOUT': '86400', 07:54:25 INFO - 'USER': 'cltbld', 07:54:25 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570', 07:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:25 INFO - '_': '/tools/buildbot/bin/python'} 07:54:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:25 INFO - Downloading/unpacking jsonschema==2.5.1 07:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:54:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:27 INFO - Downloading functools32-3.2.3-2.tar.gz 07:54:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:54:27 INFO - warning: no files found matching '*.txt' 07:54:27 INFO - no previously-included directories found matching 'build' 07:54:27 INFO - no previously-included directories found matching 'dist' 07:54:27 INFO - no previously-included directories found matching '.git*' 07:54:27 INFO - Installing collected packages: jsonschema, functools32 07:54:28 INFO - Running setup.py install for functools32 07:54:28 INFO - warning: no files found matching '*.txt' 07:54:28 INFO - no previously-included directories found matching 'build' 07:54:28 INFO - no previously-included directories found matching 'dist' 07:54:28 INFO - no previously-included directories found matching '.git*' 07:54:28 INFO - Successfully installed jsonschema functools32 07:54:28 INFO - Cleaning up... 07:54:28 INFO - Return code: 0 07:54:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:54: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')]} 07:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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')]} 07:54:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xab01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe22980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1fd00>, '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 0xe20a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe20eb0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:54:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:54:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:54:28 INFO - Using env: {'DISPLAY': ':0', 07:54:28 INFO - 'HOME': '/home/cltbld', 07:54:28 INFO - 'LANG': 'en_US.UTF-8', 07:54:28 INFO - 'LANGUAGE': 'en_US:en', 07:54:28 INFO - 'LOGNAME': 'cltbld', 07:54:28 INFO - 'MAIL': '/var/mail/cltbld', 07:54:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:28 INFO - 'MOZ_NO_REMOTE': '1', 07:54:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:28 INFO - 'NO_EM_RESTART': '1', 07:54:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:28 INFO - 'PWD': '/builds/slave/test', 07:54:28 INFO - 'SHELL': '/bin/bash', 07:54:28 INFO - 'SHLVL': '1', 07:54:28 INFO - 'TERM': 'linux', 07:54:28 INFO - 'TMOUT': '86400', 07:54:28 INFO - 'USER': 'cltbld', 07:54:28 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570', 07:54:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:28 INFO - '_': '/tools/buildbot/bin/python'} 07:54:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:54:28 INFO - Cleaning up... 07:54:28 INFO - Return code: 0 07:54:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:54: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')]} 07:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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')]} 07:54:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xab01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe22980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1fd00>, '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 0xe20a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe20eb0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:54:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:54:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:54:28 INFO - Using env: {'DISPLAY': ':0', 07:54:28 INFO - 'HOME': '/home/cltbld', 07:54:28 INFO - 'LANG': 'en_US.UTF-8', 07:54:28 INFO - 'LANGUAGE': 'en_US:en', 07:54:28 INFO - 'LOGNAME': 'cltbld', 07:54:28 INFO - 'MAIL': '/var/mail/cltbld', 07:54:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:28 INFO - 'MOZ_NO_REMOTE': '1', 07:54:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:28 INFO - 'NO_EM_RESTART': '1', 07:54:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:28 INFO - 'PWD': '/builds/slave/test', 07:54:28 INFO - 'SHELL': '/bin/bash', 07:54:28 INFO - 'SHLVL': '1', 07:54:28 INFO - 'TERM': 'linux', 07:54:28 INFO - 'TMOUT': '86400', 07:54:28 INFO - 'USER': 'cltbld', 07:54:28 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570', 07:54:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:28 INFO - '_': '/tools/buildbot/bin/python'} 07:54:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:28 INFO - Downloading/unpacking blobuploader==1.2.4 07:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:30 INFO - Downloading blobuploader-1.2.4.tar.gz 07:54:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:54:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:54:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:31 INFO - Downloading docopt-0.6.1.tar.gz 07:54:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:54:31 INFO - Installing collected packages: blobuploader, requests, docopt 07:54:31 INFO - Running setup.py install for blobuploader 07:54:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:54:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:54:31 INFO - Running setup.py install for requests 07:54:31 INFO - Running setup.py install for docopt 07:54:31 INFO - Successfully installed blobuploader requests docopt 07:54:31 INFO - Cleaning up... 07:54:32 INFO - Return code: 0 07:54:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:54: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')]} 07:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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')]} 07:54:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:32 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 0xab01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe22980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1fd00>, '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 0xe20a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe20eb0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:54:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:54:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:54:32 INFO - Using env: {'DISPLAY': ':0', 07:54:32 INFO - 'HOME': '/home/cltbld', 07:54:32 INFO - 'LANG': 'en_US.UTF-8', 07:54:32 INFO - 'LANGUAGE': 'en_US:en', 07:54:32 INFO - 'LOGNAME': 'cltbld', 07:54:32 INFO - 'MAIL': '/var/mail/cltbld', 07:54:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:32 INFO - 'MOZ_NO_REMOTE': '1', 07:54:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:32 INFO - 'NO_EM_RESTART': '1', 07:54:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:32 INFO - 'PWD': '/builds/slave/test', 07:54:32 INFO - 'SHELL': '/bin/bash', 07:54:32 INFO - 'SHLVL': '1', 07:54:32 INFO - 'TERM': 'linux', 07:54:32 INFO - 'TMOUT': '86400', 07:54:32 INFO - 'USER': 'cltbld', 07:54:32 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570', 07:54:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:32 INFO - '_': '/tools/buildbot/bin/python'} 07:54:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:54:32 INFO - Running setup.py (path:/tmp/pip-6RZD4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:54:32 INFO - Running setup.py (path:/tmp/pip-Y9BBEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:54:32 INFO - Running setup.py (path:/tmp/pip-2fFcAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:54:32 INFO - Running setup.py (path:/tmp/pip-ikn1eN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:54:32 INFO - Running setup.py (path:/tmp/pip-Q9WgJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:54:32 INFO - Running setup.py (path:/tmp/pip-50gtzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:54:32 INFO - Running setup.py (path:/tmp/pip-P7AF41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:54:32 INFO - Running setup.py (path:/tmp/pip-PKw9my-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:54:32 INFO - Running setup.py (path:/tmp/pip-Lg5961-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:54:32 INFO - Running setup.py (path:/tmp/pip-UTK7aL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:54:32 INFO - Running setup.py (path:/tmp/pip-BLFHcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:54:33 INFO - Running setup.py (path:/tmp/pip-MbvIVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:54:33 INFO - Running setup.py (path:/tmp/pip-YgCJIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:54:33 INFO - Running setup.py (path:/tmp/pip-QIqaOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:33 INFO - Running setup.py (path:/tmp/pip-PDuHNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:54:33 INFO - Running setup.py (path:/tmp/pip-AkSs08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:54:33 INFO - Running setup.py (path:/tmp/pip-D4YvW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:54:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:54:33 INFO - Running setup.py install for manifestparser 07:54:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:54:33 INFO - Running setup.py install for mozcrash 07:54:33 INFO - Running setup.py install for mozdebug 07:54:33 INFO - Running setup.py install for mozdevice 07:54:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:54:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:54:33 INFO - Running setup.py install for mozfile 07:54:33 INFO - Running setup.py install for mozhttpd 07:54:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:54:34 INFO - Running setup.py install for mozinfo 07:54:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:54:34 INFO - Running setup.py install for mozInstall 07:54:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:54:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:54:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:54:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:54:34 INFO - Running setup.py install for mozleak 07:54:34 INFO - Running setup.py install for mozlog 07:54:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:54:34 INFO - Running setup.py install for moznetwork 07:54:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:54:34 INFO - Running setup.py install for mozprocess 07:54:34 INFO - Running setup.py install for mozprofile 07:54:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:54:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:54:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:54:34 INFO - Running setup.py install for mozrunner 07:54:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:54:34 INFO - Running setup.py install for mozscreenshot 07:54:35 INFO - Running setup.py install for moztest 07:54:35 INFO - Running setup.py install for mozversion 07:54:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:54:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:54:35 INFO - Cleaning up... 07:54:35 INFO - Return code: 0 07:54:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:54: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')]} 07:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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')]} 07:54:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:35 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 0xab01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe22980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1fd00>, '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 0xe20a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe20eb0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:54:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:54:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:54:35 INFO - Using env: {'DISPLAY': ':0', 07:54:35 INFO - 'HOME': '/home/cltbld', 07:54:35 INFO - 'LANG': 'en_US.UTF-8', 07:54:35 INFO - 'LANGUAGE': 'en_US:en', 07:54:35 INFO - 'LOGNAME': 'cltbld', 07:54:35 INFO - 'MAIL': '/var/mail/cltbld', 07:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:35 INFO - 'MOZ_NO_REMOTE': '1', 07:54:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:35 INFO - 'NO_EM_RESTART': '1', 07:54:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:35 INFO - 'PWD': '/builds/slave/test', 07:54:35 INFO - 'SHELL': '/bin/bash', 07:54:35 INFO - 'SHLVL': '1', 07:54:35 INFO - 'TERM': 'linux', 07:54:35 INFO - 'TMOUT': '86400', 07:54:35 INFO - 'USER': 'cltbld', 07:54:35 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570', 07:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:35 INFO - '_': '/tools/buildbot/bin/python'} 07:54:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:54:35 INFO - Running setup.py (path:/tmp/pip-mReWe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:54:35 INFO - Running setup.py (path:/tmp/pip-wHttNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:54:35 INFO - Running setup.py (path:/tmp/pip-5v26By-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:54:35 INFO - Running setup.py (path:/tmp/pip-kC6eM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:54:35 INFO - Running setup.py (path:/tmp/pip-h2foCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:54:35 INFO - Running setup.py (path:/tmp/pip-0ZNPKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:54:35 INFO - Running setup.py (path:/tmp/pip-ahelig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:54:36 INFO - Running setup.py (path:/tmp/pip-H9BmJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:54:36 INFO - Running setup.py (path:/tmp/pip-nqd91l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:54:36 INFO - Running setup.py (path:/tmp/pip-Wm20M8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:54:36 INFO - Running setup.py (path:/tmp/pip-uDMuvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:54:36 INFO - Running setup.py (path:/tmp/pip-EbfWw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:54:36 INFO - Running setup.py (path:/tmp/pip-357eOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:54:36 INFO - Running setup.py (path:/tmp/pip-oDi6en-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:36 INFO - Running setup.py (path:/tmp/pip-gpKbAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:54:36 INFO - Running setup.py (path:/tmp/pip-NfMszf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:54:36 INFO - Running setup.py (path:/tmp/pip-ERxqSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:54:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:38 INFO - Downloading blessings-1.6.tar.gz 07:54:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:54:38 INFO - Installing collected packages: blessings 07:54:38 INFO - Running setup.py install for blessings 07:54:38 INFO - Successfully installed blessings 07:54:38 INFO - Cleaning up... 07:54:38 INFO - Return code: 0 07:54:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:54:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:54:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:54:39 INFO - Reading from file tmpfile_stdout 07:54:39 INFO - Current package versions: 07:54:39 INFO - argparse == 1.2.1 07:54:39 INFO - blessings == 1.6 07:54:39 INFO - blobuploader == 1.2.4 07:54:39 INFO - docopt == 0.6.1 07:54:39 INFO - functools32 == 3.2.3-2 07:54:39 INFO - jsonschema == 2.5.1 07:54:39 INFO - manifestparser == 1.1 07:54:39 INFO - mozInstall == 1.12 07:54:39 INFO - mozcrash == 1.0 07:54:39 INFO - mozdebug == 0.1 07:54:39 INFO - mozdevice == 0.49 07:54:39 INFO - mozfile == 1.2 07:54:39 INFO - mozhttpd == 0.7 07:54:39 INFO - mozinfo == 0.9 07:54:39 INFO - mozleak == 0.1 07:54:39 INFO - mozlog == 3.4 07:54:39 INFO - moznetwork == 0.27 07:54:39 INFO - mozprocess == 0.24 07:54:39 INFO - mozprofile == 0.28 07:54:39 INFO - mozrunner == 6.13 07:54:39 INFO - mozscreenshot == 0.1 07:54:39 INFO - mozsystemmonitor == 0.3 07:54:39 INFO - moztest == 0.8 07:54:39 INFO - mozversion == 1.4 07:54:39 INFO - psutil == 3.1.1 07:54:39 INFO - requests == 1.2.3 07:54:39 INFO - wsgiref == 0.1.2 07:54:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xab01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe22980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1fd00>, '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 0xe20a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe20eb0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:54:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:54:39 INFO - Using env: {'DISPLAY': ':0', 07:54:39 INFO - 'HOME': '/home/cltbld', 07:54:39 INFO - 'LANG': 'en_US.UTF-8', 07:54:39 INFO - 'LANGUAGE': 'en_US:en', 07:54:39 INFO - 'LOGNAME': 'cltbld', 07:54:39 INFO - 'MAIL': '/var/mail/cltbld', 07:54:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:39 INFO - 'MOZ_NO_REMOTE': '1', 07:54:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:39 INFO - 'NO_EM_RESTART': '1', 07:54:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:39 INFO - 'PWD': '/builds/slave/test', 07:54:39 INFO - 'SHELL': '/bin/bash', 07:54:39 INFO - 'SHLVL': '1', 07:54:39 INFO - 'TERM': 'linux', 07:54:39 INFO - 'TMOUT': '86400', 07:54:39 INFO - 'USER': 'cltbld', 07:54:39 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570', 07:54:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:39 INFO - '_': '/tools/buildbot/bin/python'} 07:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:54:39 INFO - Cleaning up... 07:54:39 INFO - Return code: 0 07:54:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xab01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe22980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1fd00>, '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 0xe20a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe20eb0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:54:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:54:39 INFO - Using env: {'DISPLAY': ':0', 07:54:39 INFO - 'HOME': '/home/cltbld', 07:54:39 INFO - 'LANG': 'en_US.UTF-8', 07:54:39 INFO - 'LANGUAGE': 'en_US:en', 07:54:39 INFO - 'LOGNAME': 'cltbld', 07:54:39 INFO - 'MAIL': '/var/mail/cltbld', 07:54:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:39 INFO - 'MOZ_NO_REMOTE': '1', 07:54:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:39 INFO - 'NO_EM_RESTART': '1', 07:54:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:39 INFO - 'PWD': '/builds/slave/test', 07:54:39 INFO - 'SHELL': '/bin/bash', 07:54:39 INFO - 'SHLVL': '1', 07:54:39 INFO - 'TERM': 'linux', 07:54:39 INFO - 'TMOUT': '86400', 07:54:39 INFO - 'USER': 'cltbld', 07:54:39 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570', 07:54:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:39 INFO - '_': '/tools/buildbot/bin/python'} 07:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:54:39 INFO - Cleaning up... 07:54:39 INFO - Return code: 0 07:54:39 INFO - Running post-action listener: _resource_record_post_action 07:54:39 INFO - Running post-action listener: _start_resource_monitoring 07:54:39 INFO - Starting resource monitoring. 07:54:39 INFO - [mozharness: 2017-02-03 15:54:39.675052Z] Finished create-virtualenv step (success) 07:54:39 INFO - [mozharness: 2017-02-03 15:54:39.675511Z] Running install step. 07:54:39 INFO - Running pre-action listener: _resource_record_pre_action 07:54:39 INFO - Running main action method: install 07:54:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:54:39 INFO - Reading from file tmpfile_stdout 07:54:39 INFO - Detecting whether we're running mozinstall >=1.0... 07:54:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:54:39 INFO - Reading from file tmpfile_stdout 07:54:39 INFO - Output received: 07:54:39 INFO - Usage: mozinstall [options] installer 07:54:39 INFO - Options: 07:54:39 INFO - -h, --help show this help message and exit 07:54:39 INFO - -d DEST, --destination=DEST 07:54:39 INFO - Directory to install application into. [default: 07:54:39 INFO - "/builds/slave/test"] 07:54:39 INFO - --app=APP Application being installed. [default: firefox] 07:54:39 INFO - mkdir: /builds/slave/test/build/application 07:54:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:54:56 INFO - Reading from file tmpfile_stdout 07:54:56 INFO - Output received: 07:54:56 INFO - /builds/slave/test/build/application/firefox/firefox 07:54:56 INFO - Running post-action listener: _resource_record_post_action 07:54:56 INFO - [mozharness: 2017-02-03 15:54:56.414215Z] Finished install step (success) 07:54:56 INFO - [mozharness: 2017-02-03 15:54:56.414487Z] Running run-tests step. 07:54:56 INFO - Running pre-action listener: _resource_record_pre_action 07:54:56 INFO - Running main action method: run_tests 07:54:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:54:56 INFO - Python 2.7.3 07:54:56 INFO - Return code: 0 07:54:56 INFO - grabbing minidump binary from tooltool 07:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:56 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1fd00>, '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 0xe20a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe20eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:54:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:54:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:54:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:54:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:54:56 INFO - Return code: 0 07:54:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:54:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:54:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:54:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:54:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:54:56 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/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:54:56 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/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:54:56 INFO - Using env: {'DISPLAY': ':0', 07:54:56 INFO - 'HOME': '/home/cltbld', 07:54:56 INFO - 'LANG': 'en_US.UTF-8', 07:54:56 INFO - 'LANGUAGE': 'en_US:en', 07:54:56 INFO - 'LOGNAME': 'cltbld', 07:54:56 INFO - 'MAIL': '/var/mail/cltbld', 07:54:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:54:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:56 INFO - 'MOZ_NO_REMOTE': '1', 07:54:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:56 INFO - 'NO_EM_RESTART': '1', 07:54:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:56 INFO - 'PWD': '/builds/slave/test', 07:54:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:54:56 INFO - 'SHELL': '/bin/bash', 07:54:56 INFO - 'SHLVL': '1', 07:54:56 INFO - 'TERM': 'linux', 07:54:56 INFO - 'TMOUT': '86400', 07:54:56 INFO - 'USER': 'cltbld', 07:54:56 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570', 07:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:56 INFO - '_': '/tools/buildbot/bin/python'} 07:54:56 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/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:54:56 INFO - mozversion application_buildid: 20170203145631 07:54:56 INFO - mozversion application_changeset: c02020dd7e6e190b046e0bdc992a75b647c4cffa 07:54:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:54:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:54:56 INFO - mozversion application_name: Firefox 07:54:56 INFO - mozversion application_remotingname: firefox-dev 07:54:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:54:56 INFO - mozversion application_vendor: Mozilla 07:54:56 INFO - mozversion application_version: 53.0a2 07:54:56 INFO - mozversion platform_buildid: 20170203145631 07:54:56 INFO - mozversion platform_changeset: c02020dd7e6e190b046e0bdc992a75b647c4cffa 07:54:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:54:56 INFO - mozversion platform_version: 53.0a2 07:54:56 INFO - using testdate: 1486137296 07:54:56 INFO - actual date: 1486137296 07:54:56 INFO - starting webserver on 'localhost:35066' 07:54:56 INFO - SUITE-START | Running 2 tests 07:54:56 INFO - TEST-START | dromaeo_css 07:54:56 INFO - operating with platform_type : linux_ 07:54:56 INFO - Initialising browser for dromaeo_css test... 07:54:56 INFO - TEST-INFO | started process 10555 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRklfRb/profile http://localhost:35066/getInfo.html) 07:55:00 INFO - PROCESS | 10555 | __metrics Screen width/height:1600/1200 07:55:00 INFO - PROCESS | 10555 | colorDepth:24 07:55:00 INFO - PROCESS | 10555 | Browser inner width/height: 1024/697 07:55:00 INFO - PROCESS | 10555 | __metrics 07:55:01 INFO - PROCESS | 10555 | 1486137301044 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 07:55:01 INFO - PROCESS | 10555 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:55:01 INFO - PROCESS | 10555 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:55:01 INFO - PROCESS | 10555 | console.error: PushService: 07:55:01 INFO - PROCESS | 10555 | stateChangeProcessEnqueue: Error transitioning state 07:55:01 INFO - PROCESS | 10555 | UnknownError 07:55:02 INFO - TEST-INFO | 10555: exit 0 07:55:02 INFO - Browser initialized. 07:55:02 INFO - Running cycle 1/1 for dromaeo_css test... 07:55:02 INFO - TEST-INFO | started process 10648 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRklfRb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:14 INFO - PROCESS | 10648 | RSS: Main: 138338304 07:55:14 INFO - PROCESS | 10648 | 07:58:13 INFO - PROCESS | 10648 | Cycle 1(1): loaded http://localhost:35066/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35066/tests/dromaeo/cssquery-ext.html) 07:58:15 INFO - PROCESS | 10648 | RSS: Main: 238305280 07:58:15 INFO - PROCESS | 10648 | 08:00:03 INFO - PROCESS | 10648 | ************************* 08:00:03 INFO - PROCESS | 10648 | A coding exception was thrown and uncaught in a Task. 08:00:03 INFO - PROCESS | 10648 | 08:00:03 ERROR - PROCESS | 10648 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:00:03 INFO - PROCESS | 10648 | Full stack: 08:00:03 INFO - PROCESS | 10648 | ************************* 08:01:17 INFO - PROCESS | 10648 | Cycle 1(1): loaded http://localhost:35066/tests/dromaeo/cssquery-ext.html (next: http://localhost:35066/tests/dromaeo/cssquery-jquery.html) 08:01:18 INFO - PROCESS | 10648 | RSS: Main: 226340864 08:01:18 INFO - PROCESS | 10648 | 08:04:19 INFO - PROCESS | 10648 | Cycle 1(1): loaded http://localhost:35066/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35066/tests/dromaeo/cssquery-mootools.html) 08:04:20 INFO - PROCESS | 10648 | RSS: Main: 196993024 08:04:20 INFO - PROCESS | 10648 | 08:07:22 INFO - PROCESS | 10648 | Cycle 1(1): loaded http://localhost:35066/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35066/tests/dromaeo/cssquery-prototype.html) 08:07:22 INFO - PROCESS | 10648 | RSS: Main: 193437696 08:07:22 INFO - PROCESS | 10648 | 08:10:25 INFO - PROCESS | 10648 | Cycle 1(1): loaded http://localhost:35066/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35066/tests/dromaeo/cssquery-yui.html) 08:10:26 INFO - PROCESS | 10648 | RSS: Main: 175083520 08:10:26 INFO - PROCESS | 10648 | 08:13:28 INFO - PROCESS | 10648 | Cycle 1(1): loaded http://localhost:35066/tests/dromaeo/cssquery-yui.html (next: http://localhost:35066/tests/dromaeo/cssquery-dojo.html) 08:13:28 INFO - PROCESS | 10648 | RSS: Main: 265596928 08:13:28 INFO - PROCESS | 10648 | 08:13:28 INFO - PROCESS | 10648 | __start_tp_report 08:13:28 INFO - PROCESS | 10648 | _x_x_mozilla_page_load 08:13:28 INFO - PROCESS | 10648 | _x_x_mozilla_page_load_details 08:13:28 INFO - PROCESS | 10648 | |i|pagename|runs| 08:13:28 INFO - PROCESS | 10648 | |0;dojo.html;3203.695648913353;3244.2213868671524;3256.592925884264;3278.491833765764;3292.9176770580734;5412.485813847688;5475.151351540512;5476.644018138818;5476.890462190754;5484.287042684446;5446.782128714856;5479.123340265548;5505.559555235582;5510.421405752389;5523.806666766664;4988.3515143031445;5008.098542262392;5041.344625198719;5043.268726034723;5108.233764935252;4945.282933974571;4958.082754690376;5030.924536131961;5079.466656001122;5086.440491545927;4971.080350135218;4999.450060493361;5019.673721208128;5050.116229659813;5076.416212135597;5090.083784918713;5091.592672586185;5092.9745351273;5094.2103973884105;5123.795048198068;4738.147133515966;4990.550850423443;5003.2995380646735;5055.165897626887;5067.467915868818;5302.1781623848365;5323.254744335796;5414.91877621836;5434.972825135888;5501.724913754297;5846.123081537803;5887.381824908366;5892.646441213541;5893.116032595102;5915.201447804534;5833.949889019975;5849.415058494159;5853.88292234153;5856.531477481792;5856.970715146397;5290.603204759658;5295.708736019517;5313.123334649817;5389.703566303812;5474.507294343488;5848.181254624356;5848.4151584841175;5848.707564621837;5883.470487656132;5888.793892213752;5604.887902241932;5650.180723795027;5659.179418984224;5663.858403539944;5665;5602.327720673546;5638.436156384329;5713.828665123639;5757.568182386338;5768.7692492300675;5686.976344257991;5745.741441635137;5792.391798861143;5825.563082768809;5827.504662103684;5801.82594522165;5805.709714514257;5811.738471768781;5813.273340832396;5814.680192589448;3979.064919743858;4017.216642754693;4108.897277568085;4108.91782164361;4142.378643203544;3629.4374371972385;3640.8725694601094;3684.5578530576504;3694.7413681042067;3729.8321575529167;5620.100783874561;5622.325320961429;5626.718664066781;5649.4915457608195;5664.320281566238;5764.769409223584;5770.307563092456;5827.1841942127285;5834.970825145847;5848.502877255481;5666.575006874501;5724.79963201286;5725.083986562214;5740.483356497852;5758.337791153987;5049.82325618609;5060.063888180698;5060.671056381323;5063.569596584258;5099.796008159707;5893.882122357529;5933.851653708605;6128.601640893327;6179.3820617937845;6206.162168107338;5761.107028410603;5818.6217895836635;5851.239338885917;5926.081457374114;5942.316633587193;6133.6319820810895;6135.386461353829;6140.048292514667;6140.416660417253;6150.538709596709;5816.73824677882;5819;5820.1560773688425;5820.592558520862;5821.621594596338;5635.895799257864;5735.8566035849435;5794.275715535558;5843.824685259449;5853.1220316952795;5715.114157305624;5768;5770.336411312753;5772.422757724194;5795.1017592273265;5757.021306377842;5762.94237057624;5764.423557644202;5765.682887441231;5771.769129234784;5533.861653458695;5629.690367029689;5698.943010569841;5733.082706766897;5746.626469279484;5761.452661997104;5762.971185144047;5770.192173095854;5774.740136693775;5776.191333213437;5667.971660141673;5670.319561652628;5673.943260567342;5675.432456754456;5681.517071049007 08:13:28 INFO - PROCESS | 10648 | |1;ext.html;568.3776264989835;604.6613896218118;618.2241287184582;620.3052581109156;662.9867402651947;36743.632563674386;41098;41126.79436602813;41195.38206926895;46636;50769.23846142302;51925;51935;51963.48036519634;52055.73972130134;9344.953275233614;9601.80796384072;9616.759581010461;9619.80760384792;9620.18228450579;8719.651213951434;9001.369904106683;9228.538573071353;9334;9340.15938565529;11233.213675042709;11471.426428678575;11479.483423245974;11930.522779088826;11935.820962685524;11484.827727584052;11536.76926461466;11539.538418463251;11550.480228389742;11578.363190024504;11428.257163284443;11492.655220343404;11514.251573647685;11515.654530364103;11520.078393728565;47629.28556071662;48106.518934810556;48254.7587262065;48272.27591586129;48273;4290.678199135077;4358.87217296006;4468.932966005513;4525.932111018337;4546.499885012646;34909.65090349115;34964.65035349639;34968.825155874314;35147.4727879082;36785.08037299062;4568.291914753218;4597.494275629678;4634.21218392874;4665.393498845162;4682.556632214695;372582;372630;374745;375621;375865;68341.65829170922;68571.65714171497;68869.31130688729;69062;69136;70317.64841175762;70794;70934.2906570938;70976.64511677512;71064.64467677732;19693.40919772409;20478.897605511876;20497;20512;20512.487187820425;15964.201789910458;16023.599410014844;16085.517434476984;16089;16090.597735056483;16806.495805125865;17125.91437042807;18256.634867302844;18735.90632046831;18934.621307574045;6635.270120286765;6658.167729033871;6695.832604184934;6703.698333574904;6925.272846351161;987.8765154355706;994.1599348550463;1006.4263369879245;1018.7402212435782;1035.3322107240788;32881;33039.50440743391;33202.33595328128;33366.666333336354;33591;1165.2891736041008;1179.4161889864401;1194.952201911931;1208.2991864718442;1282.6472720002075;17397.47807565775;17754.733678994824;17846.375376862008;17908.46274611764;18123.72814407785;499825;502505;504057;504540;506936.86126278003;57599;57720.71139644275;57896.421035789106;57964.71017644969;57977.42022579804;1557.5950252934092;1561.453491278021;1580.6364536156748;1588.2058970514743;1592.3391792406253;31337.686623133475;32705.18237044093;33328.33343333168;33339.66660333463;33555.161120972174;55119.448805513035;56009.15986260291;56102;56204.15693764679;56278.71860640834;409305;411042;411065;412118;414129;30814.845925770227;30821.537676934415;31309.686903130678;31314.530282045333;31426.52860207053;40984.79507602443;44709.776451117534;51185.23222151745;52542.474575255284;56333.71833140808;42746;43634.781826090664;44983.77508112438;45936.770316149545;46672.29991550062;43585.56414435815;43633;44227.778861105486;44735.328970066126;45043.54956450524;43020.35469467898;43094.35358469688;43485.130297394506;43542;44497.55502444934;36292.637073628925;37049.44425833561;39676.40485392664;40059.59940400559;40296.597034029284;27147.457050859266;27274.863625681744;27481.31296717598;27554.5866811994;27595.44809103847 08:13:28 INFO - PROCESS | 10648 | |2;jquery.html;440.78181300256375;444.4333474819605;450.42345797379363;455.29429384454096;455.856405232352;20685.896570517147;20999.265025724104;21702.565948681055;21827.01778419971;22429.887850560746;13110.475580976774;17878.91060544699;18164.545886352847;20628.8968555157;21403.67894481584;5637.238972738669;5750.654960702351;5791.044477661202;5824.417558244163;5844.883102337951;5477.534409575191;5603.80386686466;5607;5617.466340697627;5703.429657034284;5672.319321681404;5697.259356283698;5700.600957932947;5704.8859022819515;5706.087026075828;5521.723913804314;5723.771049158028;5741.569382296303;5741.770329186848;5747.396523365028;5436.293281873371;5647.689377084259;5647.774089036434;5655.519280861132;5661.179129026268;25425.364365890815;25489.872550637127;25799.226023219333;25901.870490647616;26619.866900665565;2853.4150499147627;2858.656961164653;2882.9711702882914;2955.351097303544;2966.9406611867857;10832.133429325635;10971.122310215163;11300.491477883515;11625.76748465026;11650.475728592233;1978.436145698469;2008.086320724067;2049.764277108122;2081.0531208300185;2107.694384314266;93405;96210.51894740481;96502;96615.03384966131;97364;12136.15046946723;12287.262764234174;12333.136680432284;12502.249865008129;12539;18068;18116.09419529018;18124.63750724978;18147.909260453613;18157.09214539268;9071.410358326688;9134.497602631918;9168.954155229181;9317.248203416171;9330.30022748283;8716.084811094745;8740.737777866674;8749.687546868021;8877.778055548662;8955.462672239686;4763.428388593391;4890.682105663192;5060.367454068241;5324.201369794484;5488.945110548923;2165.5993641176433;2184.5084855907294;2212.1814928476247;2220.489287463892;2246.2699622622713;1137.4710759496875;1152.4065106470175;1154.6189757380043;1163.7265242667966;1177.6231605886035;20269.08789104494;20409.69385459219;20417.285395011102;20461;20470.692939605917;1131.0442675938818;1135.6990397544657;1169.9649010529697;1179.6991767099507;1186.8635106962638;10738.677839664822;11168.888311116947;11258.493367798468;11417.543298268143;11497.597584084517;688051;692646;702481;706001;719026;105278.47360763147;106270;106374;110060;111854.44072779584;476.46397802472217;493.6692416081234;907.0657223060258;924.1267002682534;942.9858552121724;11768;12169.878301216875;12217.205881617667;12548.184368016415;12662;41025;44727.77636111798;45834;46715.29927051029;46889.296660550805;59202.703986481516;64200.678996604714;64673.35326646861;64939;65605.67197163984;9074.31942604294;9138.68014619485;9229.123233292827;9472.336936414385;9819.85270220933;10252.282340236112;13125.212487250796;13134.343282836011;13135.277559734306;13201.405936732677;11550.133739969368;11556;11735.647930562096;11863.288202707865;11903.583374581847;11788.823167652321;12167.2699638022;12205.450754716237;12249.938750306548;12393.132480726263;11942.940285298519;12363.75272494563;12376.62870113898;12385.566505172636;12581.245125292511;9308.767280818034;9335.890290554218;9448.527573621428;9666;9692.951535242279;9571.521423928914;12020.278783273032;12280.140390172603;12390.132690711564;12609 08:13:28 INFO - PROCESS | 10648 | |3;mootools.html;1237.573037302131;1253.166644181619;1271.4786937355686;1310.6985393359528;1317.8748018938197;7502.099748030238;8314.210150035744;8521.701740439086;8541.572921353938;8760.78098047549;8566.65733370666;8636.69771557994;8637.524936128526;8642.395032347738;8645.265152462049;2123.203798575534;2187.6937228787983;2390.629452434867;2440.2923152285816;2442.792362649168;2408.1089996701244;2462.66753988212;2473.6042233242683;2474.64117702933;2484.7266800651914;2392.294273189413;2401.4716762312264;2409.542186984467;2419.63705444183;2423.042898055276;2403.831731778776;2412.07135252928;2427.7693619106158;2436.9147079852296;2438.7683170098812;2320.4082958845556;2360.1857359211044;2360.3037104054347;2367.00585753982;2367.0295178976708;8688.348373871922;8699.782505437352;8714.215720585114;8737.344699147588;8791.868121978176;5138.58891288696;5273.630845840793;5277.366715994067;5277.525022747971;5335.466453354672;3338.2655815720505;3367.2928684976187;3433.613638521229;3498.5801703795455;3620.6922411595046;1381.3852835488212;1439.92080435576;1461.5396150212648;1489.6424858033993;1537.423466200175;11772.058235341152;11796.882031179664;11806.291622502591;11879.643610691694;11881.524739010343;4630.374899388539;4793.520647935178;4799.088173247072;4850.393700787402;4875.9512404875495;9527.761805954906;9597.90402095984;9615.471149086727;9615.951920240494;9661.227101831837;5349.037173308841;5350.357957045179;5355.839324820262;5362;5364.946350536445;4462.888427789267;4611.7232966021475;4833.05755377705;4863.7324947128245;4890.608751299887;3778.886633401002;3789.962100379016;3879.2047630235734;3906.199229158016;3915.393114067267;1206.0652993929775;1207.2454715802623;1219.9817002744967;1223.2354778263584;1226.2029680707612;928.6285485805597;944.3719926248967;956.2445667922402;957.2055194188806;969.3699095587783;5393.919091213635;5455.699936503531;5456.317960254968;5547.55619550435;5625.578081643893;1010.434156872154;1040.2354269611828;1050.7740835720356;1082.6697857153486;1102.0467295789085;3634.6547078027547;3763.9059023524633;3766.8116594170183;3787.5265591801026;3840.558335791364;10156.949215253877;10426.426546539862;10432.895671043192;10454.268201225994;10497.055265026183;10231;10272.897271027343;10374.740631484274;10388.272820902615;10407.115395191342;7414.740484083139;7414.962925185448;7471;7502.549847009088;7542.245775422414;4969.602431805374;5042.4705405931845;5106.591472682251;5237.895242095213;5369.248305237192;8866.202041816268;9103.544822758968;9110.36227464071;9178.770530736518;9262.536873156181;9241.260699144186;9349.57926893305;9438;9455.290853186176;9516.524173791144;6950.06174166481;7167.784966451015;7316.085489313836;7618.69525218985;7735.6905723770415;7888.960555197187;8112.391570632109;8133.227343402367;8148.388870834592;8158.3473322132895;7275.417966562768;7336.303051210127;7383.889241661487;7423.443241756781;7533.886991695019;7305.744298949511;7371.59456229891;7384.446166537638;7454.701811927679;7468.066491688539;6040.75836966534;6133.294671112701;6145;6145.631262124287;6146.907796382969;4637.234856248681;4654.604358629555;4729.243321068612;4757.881052973703;4778.928316075331;4728.361671174347;4820.132376172322;4877.000214955855;4884.0476107158765;4886.584640305614 08:13:28 INFO - PROCESS | 10648 | |4;prototype.html;400.31068889287235;408.7935592525774;412.36293900506263;419.7334692470282;426.9146170765846;5243.483128098515;5307.628466007381;5313.335833020872;5316.441773613768;5368.651037682553;4998.575406009279;5120.769565369558;5159.948400515994;5207.505286997729;5238.554722848562;4284.892877678052;4299.247631664462;4304.7946574958905;4320.135972805444;4321.308590625501;4295.377170310303;4310.288802347609;4312.741235525878;4314.633256173229;4316.740995540262;4013.8394464221396;4059.918801623966;4281.35779633056;4298.9785051074705;4322.04914918719;4280.6789490788005;4304.827806887721;4314.697971142022;4318.395424640553;4323.524412314643;3882.1265215326325;3886.514185726784;3891.9416208756893;3897.6747905712195;3899.707521935866;5039.697618142924;5056.772445239973;5126.820561280375;5140.665856719302;5167.586593072545;4891.510848915115;4891.755412229374;4896.4858689837765;4900.255856720248;4911.852644420673;5512.5589952803675;5520.171974203861;5527.143292789624;5531.723413829292;5548.334199895998;4128;4277.1873344064525;4283.164782867342;4292.699511034229;4307.224699554079;5689.203511508392;5691.857703557403;5697.857553561153;5699;5700.401457846908;4408.801603927831;4410.933835992462;4422.380866678667;4424.911501769947;4436.292027569409;4364.934525982049;4438.7114837535455;4462.397576327219;4475.932861007088;4477.485089214782;4906.215005599087;4921.26181072842;4930.433000204951;4937.308776771255;4953.529414705597;5558.277423934944;5579.832605021856;5590.372524913366;5598.720063996784;5603.971980140154;1428.2073449235775;1428.5000249912448;1476.8892333075062;1477.8300495442948;1499.8500149985132;997.9401235925868;1012.3470361616716;1061.0026575019458;1085.5169449595012;1086.1962148010416;5264.499872512105;5270.92093618596;5303.204519322133;5314.468553144655;5353.598480113929;5392.56859451243;5510.256115424367;5539.2522009529;5561.555075593943;5564;5283.498067683564;5288.656237344637;5290.470952904679;5292.629515933848;5329.493698098674;2864.3125649843887;2901.4632293025857;2904.3425265881906;2906.956395654067;2929.091981485746;5506.889862202734;5599.272094627754;5656.4060773619;5700.636624391629;5712.228849105318;5545.364117585322;5576.637518561281;5581.916271255853;5582.218489411485;5608.411116832755;5671.262735844314;5679.551714312824;5688.48803607669;5689.061304884648;5698.515626171739;5288.9471105289995;5409.350877894678;5455.890142618669;5459.317585301837;5479.972600136974;5387.168362756682;5393.244945707683;5398.514133727984;5402.243685883901;5426.240326354235;5401.594880384066;5575.303087114111;5590.580706447114;5675;5678.318601767649;4229.851955181553;4234.809433575435;4251;4276;4278.379634952977;5446.1558458439;5467.844438227055;5545.445455454423;5545.584081194007;5548.334199896039;5186.325777648882;5376.7580458878665;5413.296271484682;5428.891422171613;5514.841883204572;5543.77824887;5547.918155959549;5548.472895074961;5548.889022219614;5551.722413879371;5317.893642127213;5488.615796894179;5497.422770609189;5532.5020748132865;5549.223108764695;5226.398964119175;5419.972900135474;5469.589780766538;5476.780928762964;5489.917651235314;5298.841034768963;5330;5346.1713434417725;5374.193870919394;5408.621396502207 08:13:28 INFO - PROCESS | 10648 | |5;yui.html;824.7690646618948;827.2843989948697;837.6774941647468;885.7254251182133;901.0448924140411;16110.677786444265;17100.486985390442;17353.219105140266;17361.7395739064;17370.56573585661;14808.407663693466;14834.406623735038;14902.627434314121;14935.701285974274;14962;704.0319560604182;712.7434123715458;805.5327909812324;813.5769399912042;820.3970081989762;827.234807802783;836.8577341851869;837.1042984007115;837.2841220756258;837.3134030095293;881.9382643214977;883.801144742431;885.4731434796286;885.6059053721096;886.0342226972599;743.2196193996282;754.0310700749566;881.6649673124236;881.964721411146;882.2765332427412;627.4791922704145;637.7927173668576;639.9296077431479;644.5230529408204;645.2901808011151;16085;16347.019178849307;16388.590285242964;16416.917915410468;16420.1789910504;13820.170789752647;14210.076345037643;14239.216843073627;14416.92791536046;14477.927610361987;11984.340861252627;12269.877301227052;12278.938605307005;14271.14373137615;14532.346044428026;4721.409823772028;4780.737059461728;4796.424429068499;4888.315635810954;4965.106280869442;84813.57593212118;85256;85781.14218857794;86718.56640716756;86913.56543217243;11979.640610781691;12191.32947687868;12238.571649992207;12297.954673852822;12353.32056736888;21503.784962150177;21522.784772152077;21561.02975366112;22098.779012209994;22880.542389152455;8321.708740194064;8535.658573657109;8565.743027709179;8780;8793.428427152343;4766.332713420124;4776.713397196179;4823.445303790038;4888.853334399973;4892.633052521075;3370.5618269624792;3452.4648679454726;3456.75802693809;3460.9134771630406;3462.6537346265172;590.6338070396296;609.7530500147448;617.527591392585;617.7745123030062;619.0373968479058;652.1815122021927;657.2277573850706;661.8186141438983;670.0485310858593;698.1064237775655;9926.404415735078;10104.393736375841;10487.37075775456;10575.101116405192;10594.682159535227;670.2727540618483;687.0861753867345;690.5235387582552;695.7147569496482;696.7839969609336;5060.5951523878;5198.2722418861385;5238.476152384731;5239.345081864767;5248.527632513092;73390;73987.63006184934;87139;87519;92300.53849730709;73882;74908;75095.24904750992;76875.61562192265;77960.61019694865;67301.66349168222;68493;68588.6570567154;69239.3076069253;70650;9351.719448416557;9774.85337719949;9791.608335666493;9811.509424528887;9827;36196.45705314475;38997.41503877387;39272.41091383689;41857.37213941854;48333.75833120812;56218.43781562132;57182.42817571771;57618.7119064402;57792.71103644455;57827;14336.494653188736;14550.199739014455;14583.197924114276;14626.85972634356;14722.779158312847;15551.455699050932;15824.287907043981;15838.9208053959;15917.124558149413;15970.441034563735;13607.387667554785;15110.622234444227;15362.539123826304;15424.922875385551;16041.759373609639;14784.63038424048;15054.623634409227;15117.470888518848;15263;15265.23673816327;15165;15208.391664333745;15354.923225383802;15919.602009949844;15964.361425542847;11560.710982225512;11838;11842.57227268425;11917.582884598998;12195.878041219474;11089.556417743523;11444.313341199555;11485.19603627738;11722.062235021349;11735.354555499529 08:13:28 INFO - PROCESS | 10648 | __end_tp_report 08:13:28 INFO - PROCESS | 10648 | __start_cc_report 08:13:28 INFO - PROCESS | 10648 | _x_x_mozilla_cycle_collect,1094 08:13:28 INFO - PROCESS | 10648 | __end_cc_report 08:13:28 INFO - PROCESS | 10648 | __startTimestamp1486138408789__endTimestamp 08:13:28 INFO - PROCESS | 10648 | 08:13:28 INFO - PROCESS | 10648 | ------- Summary: start ------- 08:13:28 INFO - PROCESS | 10648 | Number of tests: 6 08:13:28 INFO - PROCESS | 10648 | 08:13:28 INFO - PROCESS | 10648 | [#0] dojo.html Cycles:165 Average:5422.00 Median:5670.32 stddev:647.13 (11.4%) stddev-sans-first:625.28 08:13:28 INFO - PROCESS | 10648 | Values: 3203.7 3244.2 3256.6 3278.5 3292.9 5412.5 5475.2 5476.6 5476.9 5484.3 5446.8 5479.1 5505.6 5510.4 5523.8 4988.4 5008.1 5041.3 5043.3 5108.2 4945.3 4958.1 5030.9 5079.5 5086.4 4971.1 4999.5 5019.7 5050.1 5076.4 5090.1 5091.6 5093.0 5094.2 5123.8 4738.1 4990.6 5003.3 5055.2 5067.5 5302.2 5323.3 5414.9 5435.0 5501.7 5846.1 5887.4 5892.6 5893.1 5915.2 5833.9 5849.4 5853.9 5856.5 5857.0 5290.6 5295.7 5313.1 5389.7 5474.5 5848.2 5848.4 5848.7 5883.5 5888.8 5604.9 5650.2 5659.2 5663.9 5665.0 5602.3 5638.4 5713.8 5757.6 5768.8 5687.0 5745.7 5792.4 5825.6 5827.5 5801.8 5805.7 5811.7 5813.3 5814.7 3979.1 4017.2 4108.9 4108.9 4142.4 3629.4 3640.9 3684.6 3694.7 3729.8 5620.1 5622.3 5626.7 5649.5 5664.3 5764.8 5770.3 5827.2 5835.0 5848.5 5666.6 5724.8 5725.1 5740.5 5758.3 5049.8 5060.1 5060.7 5063.6 5099.8 5893.9 5933.9 6128.6 6179.4 6206.2 5761.1 5818.6 5851.2 5926.1 5942.3 6133.6 6135.4 6140.0 6140.4 6150.5 5816.7 5819.0 5820.2 5820.6 5821.6 5635.9 5735.9 5794.3 5843.8 5853.1 5715.1 5768.0 5770.3 5772.4 5795.1 5757.0 5762.9 5764.4 5765.7 5771.8 5533.9 5629.7 5698.9 5733.1 5746.6 5761.5 5763.0 5770.2 5774.7 5776.2 5668.0 5670.3 5673.9 5675.4 5681.5 08:13:28 INFO - PROCESS | 10648 | 08:13:28 INFO - PROCESS | 10648 | [#1] ext.html Cycles:180 Average:61389.90 Median:226656.69 stddev:114243.43 (50.4%) stddev-sans-first:114472.64 08:13:28 INFO - PROCESS | 10648 | Values: 568.4 604.7 618.2 620.3 663.0 36743.6 41098.0 41126.8 41195.4 46636.0 50769.2 51925.0 51935.0 51963.5 52055.7 9345.0 9601.8 9616.8 9619.8 9620.2 8719.7 9001.4 9228.5 9334.0 9340.2 11233.2 11471.4 11479.5 11930.5 11935.8 11484.8 11536.8 11539.5 11550.5 11578.4 11428.3 11492.7 11514.3 11515.7 11520.1 47629.3 48106.5 48254.8 48272.3 48273.0 4290.7 4358.9 4468.9 4525.9 4546.5 34909.7 34964.7 34968.8 35147.5 36785.1 4568.3 4597.5 4634.2 4665.4 4682.6 372582.0 372630.0 374745.0 375621.0 375865.0 68341.7 68571.7 68869.3 69062.0 69136.0 70317.6 70794.0 70934.3 70976.6 71064.6 19693.4 20478.9 20497.0 20512.0 20512.5 15964.2 16023.6 16085.5 16089.0 16090.6 16806.5 17125.9 18256.6 18735.9 18934.6 6635.3 6658.2 6695.8 6703.7 6925.3 987.9 994.2 1006.4 1018.7 1035.3 32881.0 33039.5 33202.3 33366.7 33591.0 1165.3 1179.4 1195.0 1208.3 1282.6 17397.5 17754.7 17846.4 17908.5 18123.7 499825.0 502505.0 504057.0 504540.0 506936.9 57599.0 57720.7 57896.4 57964.7 57977.4 1557.6 1561.5 1580.6 1588.2 1592.3 31337.7 32705.2 33328.3 33339.7 33555.2 55119.4 56009.2 56102.0 56204.2 56278.7 409305.0 411042.0 411065.0 412118.0 414129.0 30814.8 30821.5 31309.7 31314.5 31426.5 40984.8 44709.8 51185.2 52542.5 56333.7 42746.0 43634.8 44983.8 45936.8 46672.3 43585.6 43633.0 44227.8 44735.3 45043.5 43020.4 43094.4 43485.1 43542.0 44497.6 36292.6 37049.4 39676.4 40059.6 40296.6 27147.5 27274.9 27481.3 27554.6 27595.4 08:13:28 INFO - PROCESS | 10648 | 08:13:28 INFO - PROCESS | 10648 | [#2] jquery.html Cycles:180 Average:36311.44 Median:25644.55 stddev:115307.98 (449.6%) stddev-sans-first:115599.99 08:13:28 INFO - PROCESS | 10648 | Values: 440.8 444.4 450.4 455.3 455.9 20685.9 20999.3 21702.6 21827.0 22429.9 13110.5 17878.9 18164.5 20628.9 21403.7 5637.2 5750.7 5791.0 5824.4 5844.9 5477.5 5603.8 5607.0 5617.5 5703.4 5672.3 5697.3 5700.6 5704.9 5706.1 5521.7 5723.8 5741.6 5741.8 5747.4 5436.3 5647.7 5647.8 5655.5 5661.2 25425.4 25489.9 25799.2 25901.9 26619.9 2853.4 2858.7 2883.0 2955.4 2966.9 10832.1 10971.1 11300.5 11625.8 11650.5 1978.4 2008.1 2049.8 2081.1 2107.7 93405.0 96210.5 96502.0 96615.0 97364.0 12136.2 12287.3 12333.1 12502.2 12539.0 18068.0 18116.1 18124.6 18147.9 18157.1 9071.4 9134.5 9169.0 9317.2 9330.3 8716.1 8740.7 8749.7 8877.8 8955.5 4763.4 4890.7 5060.4 5324.2 5488.9 2165.6 2184.5 2212.2 2220.5 2246.3 1137.5 1152.4 1154.6 1163.7 1177.6 20269.1 20409.7 20417.3 20461.0 20470.7 1131.0 1135.7 1170.0 1179.7 1186.9 10738.7 11168.9 11258.5 11417.5 11497.6 688051.0 692646.0 702481.0 706001.0 719026.0 105278.5 106270.0 106374.0 110060.0 111854.4 476.5 493.7 907.1 924.1 943.0 11768.0 12169.9 12217.2 12548.2 12662.0 41025.0 44727.8 45834.0 46715.3 46889.3 59202.7 64200.7 64673.4 64939.0 65605.7 9074.3 9138.7 9229.1 9472.3 9819.9 10252.3 13125.2 13134.3 13135.3 13201.4 11550.1 11556.0 11735.6 11863.3 11903.6 11788.8 12167.3 12205.5 12249.9 12393.1 11942.9 12363.8 12376.6 12385.6 12581.2 9308.8 9335.9 9448.5 9666.0 9693.0 9571.5 12020.3 12280.1 12390.1 12609.0 08:13:28 INFO - PROCESS | 10648 | 08:13:28 INFO - PROCESS | 10648 | [#3] mootools.html Cycles:180 Average:5541.52 Median:4876.48 stddev:3063.77 (62.8%) stddev-sans-first:3055.29 08:13:28 INFO - PROCESS | 10648 | Values: 1237.6 1253.2 1271.5 1310.7 1317.9 7502.1 8314.2 8521.7 8541.6 8760.8 8566.7 8636.7 8637.5 8642.4 8645.3 2123.2 2187.7 2390.6 2440.3 2442.8 2408.1 2462.7 2473.6 2474.6 2484.7 2392.3 2401.5 2409.5 2419.6 2423.0 2403.8 2412.1 2427.8 2436.9 2438.8 2320.4 2360.2 2360.3 2367.0 2367.0 8688.3 8699.8 8714.2 8737.3 8791.9 5138.6 5273.6 5277.4 5277.5 5335.5 3338.3 3367.3 3433.6 3498.6 3620.7 1381.4 1439.9 1461.5 1489.6 1537.4 11772.1 11796.9 11806.3 11879.6 11881.5 4630.4 4793.5 4799.1 4850.4 4876.0 9527.8 9597.9 9615.5 9616.0 9661.2 5349.0 5350.4 5355.8 5362.0 5364.9 4462.9 4611.7 4833.1 4863.7 4890.6 3778.9 3790.0 3879.2 3906.2 3915.4 1206.1 1207.2 1220.0 1223.2 1226.2 928.6 944.4 956.2 957.2 969.4 5393.9 5455.7 5456.3 5547.6 5625.6 1010.4 1040.2 1050.8 1082.7 1102.0 3634.7 3763.9 3766.8 3787.5 3840.6 10156.9 10426.4 10432.9 10454.3 10497.1 10231.0 10272.9 10374.7 10388.3 10407.1 7414.7 7415.0 7471.0 7502.5 7542.2 4969.6 5042.5 5106.6 5237.9 5369.2 8866.2 9103.5 9110.4 9178.8 9262.5 9241.3 9349.6 9438.0 9455.3 9516.5 6950.1 7167.8 7316.1 7618.7 7735.7 7889.0 8112.4 8133.2 8148.4 8158.3 7275.4 7336.3 7383.9 7423.4 7533.9 7305.7 7371.6 7384.4 7454.7 7468.1 6040.8 6133.3 6145.0 6145.6 6146.9 4637.2 4654.6 4729.2 4757.9 4778.9 4728.4 4820.1 4877.0 4884.0 4886.6 08:13:28 INFO - PROCESS | 10648 | 08:13:28 INFO - PROCESS | 10648 | [#4] prototype.html Cycles:180 Average:4681.00 Median:5288.80 stddev:1293.29 (24.5%) stddev-sans-first:1256.38 08:13:28 INFO - PROCESS | 10648 | Values: 400.3 408.8 412.4 419.7 426.9 5243.5 5307.6 5313.3 5316.4 5368.7 4998.6 5120.8 5159.9 5207.5 5238.6 4284.9 4299.2 4304.8 4320.1 4321.3 4295.4 4310.3 4312.7 4314.6 4316.7 4013.8 4059.9 4281.4 4299.0 4322.0 4280.7 4304.8 4314.7 4318.4 4323.5 3882.1 3886.5 3891.9 3897.7 3899.7 5039.7 5056.8 5126.8 5140.7 5167.6 4891.5 4891.8 4896.5 4900.3 4911.9 5512.6 5520.2 5527.1 5531.7 5548.3 4128.0 4277.2 4283.2 4292.7 4307.2 5689.2 5691.9 5697.9 5699.0 5700.4 4408.8 4410.9 4422.4 4424.9 4436.3 4364.9 4438.7 4462.4 4475.9 4477.5 4906.2 4921.3 4930.4 4937.3 4953.5 5558.3 5579.8 5590.4 5598.7 5604.0 1428.2 1428.5 1476.9 1477.8 1499.9 997.9 1012.3 1061.0 1085.5 1086.2 5264.5 5270.9 5303.2 5314.5 5353.6 5392.6 5510.3 5539.3 5561.6 5564.0 5283.5 5288.7 5290.5 5292.6 5329.5 2864.3 2901.5 2904.3 2907.0 2929.1 5506.9 5599.3 5656.4 5700.6 5712.2 5545.4 5576.6 5581.9 5582.2 5608.4 5671.3 5679.6 5688.5 5689.1 5698.5 5288.9 5409.4 5455.9 5459.3 5480.0 5387.2 5393.2 5398.5 5402.2 5426.2 5401.6 5575.3 5590.6 5675.0 5678.3 4229.9 4234.8 4251.0 4276.0 4278.4 5446.2 5467.8 5545.4 5545.6 5548.3 5186.3 5376.8 5413.3 5428.9 5514.8 5543.8 5547.9 5548.5 5548.9 5551.7 5317.9 5488.6 5497.4 5532.5 5549.2 5226.4 5420.0 5469.6 5476.8 5489.9 5298.8 5330.0 5346.2 5374.2 5408.6 08:13:28 INFO - PROCESS | 10648 | 08:13:28 INFO - PROCESS | 10648 | [#5] yui.html Cycles:180 Average:18737.04 Median:4888.58 stddev:24052.25 (492.0%) stddev-sans-first:24082.11 08:13:28 INFO - PROCESS | 10648 | Values: 824.8 827.3 837.7 885.7 901.0 16110.7 17100.5 17353.2 17361.7 17370.6 14808.4 14834.4 14902.6 14935.7 14962.0 704.0 712.7 805.5 813.6 820.4 827.2 836.9 837.1 837.3 837.3 881.9 883.8 885.5 885.6 886.0 743.2 754.0 881.7 882.0 882.3 627.5 637.8 639.9 644.5 645.3 16085.0 16347.0 16388.6 16416.9 16420.2 13820.2 14210.1 14239.2 14416.9 14477.9 11984.3 12269.9 12278.9 14271.1 14532.3 4721.4 4780.7 4796.4 4888.3 4965.1 84813.6 85256.0 85781.1 86718.6 86913.6 11979.6 12191.3 12238.6 12298.0 12353.3 21503.8 21522.8 21561.0 22098.8 22880.5 8321.7 8535.7 8565.7 8780.0 8793.4 4766.3 4776.7 4823.4 4888.9 4892.6 3370.6 3452.5 3456.8 3460.9 3462.7 590.6 609.8 617.5 617.8 619.0 652.2 657.2 661.8 670.0 698.1 9926.4 10104.4 10487.4 10575.1 10594.7 670.3 687.1 690.5 695.7 696.8 5060.6 5198.3 5238.5 5239.3 5248.5 73390.0 73987.6 87139.0 87519.0 92300.5 73882.0 74908.0 75095.2 76875.6 77960.6 67301.7 68493.0 68588.7 69239.3 70650.0 9351.7 9774.9 9791.6 9811.5 9827.0 36196.5 38997.4 39272.4 41857.4 48333.8 56218.4 57182.4 57618.7 57792.7 57827.0 14336.5 14550.2 14583.2 14626.9 14722.8 15551.5 15824.3 15838.9 15917.1 15970.4 13607.4 15110.6 15362.5 15424.9 16041.8 14784.6 15054.6 15117.5 15263.0 15265.2 15165.0 15208.4 15354.9 15919.6 15964.4 11560.7 11838.0 11842.6 11917.6 12195.9 11089.6 11444.3 11485.2 11722.1 11735.4 08:13:28 INFO - PROCESS | 10648 | -------- Summary: end -------- 08:13:28 INFO - PROCESS | 10648 | 08:13:29 INFO - TEST-INFO | 10648: exit 0 08:13:29 INFO - TEST-OK | dromaeo_css | took 1112820ms 08:13:29 INFO - TEST-START | kraken 08:13:29 INFO - operating with platform_type : linux_ 08:13:29 INFO - Initialising browser for kraken test... 08:13:29 INFO - TEST-INFO | started process 10959 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCZhXKV/profile http://localhost:35066/getInfo.html) 08:13:33 INFO - PROCESS | 10959 | __metrics Screen width/height:1600/1200 08:13:33 INFO - PROCESS | 10959 | colorDepth:24 08:13:33 INFO - PROCESS | 10959 | Browser inner width/height: 1024/697 08:13:33 INFO - PROCESS | 10959 | __metrics 08:13:33 INFO - PROCESS | 10959 | 1486138413727 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 08:13:33 INFO - PROCESS | 10959 | 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" 08:13:33 INFO - PROCESS | 10959 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:13:34 INFO - PROCESS | 10959 | console.error: PushService: 08:13:34 INFO - PROCESS | 10959 | stateChangeProcessEnqueue: Error transitioning state 08:13:34 INFO - PROCESS | 10959 | UnknownError 08:13:34 INFO - TEST-INFO | 10959: exit 0 08:13:34 INFO - Browser initialized. 08:13:34 INFO - Running cycle 1/1 for kraken test... 08:13:34 INFO - TEST-INFO | started process 11049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCZhXKV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:13:46 INFO - PROCESS | 11049 | RSS: Main: 138534912 08:13:46 INFO - PROCESS | 11049 | 08:13:49 INFO - PROCESS | 11049 | Cycle 1(1): loaded http://localhost:35066/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35066/tests/kraken/driver.html?testName=audio-beat-detection) 08:13:50 INFO - PROCESS | 11049 | RSS: Main: 182812672 08:13:50 INFO - PROCESS | 11049 | 08:13:52 INFO - PROCESS | 11049 | Cycle 1(1): loaded http://localhost:35066/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35066/tests/kraken/driver.html?testName=audio-dft) 08:13:53 INFO - PROCESS | 11049 | RSS: Main: 172326912 08:13:53 INFO - PROCESS | 11049 | 08:13:55 INFO - PROCESS | 11049 | Cycle 1(1): loaded http://localhost:35066/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35066/tests/kraken/driver.html?testName=audio-fft) 08:13:56 INFO - PROCESS | 11049 | RSS: Main: 263778304 08:13:56 INFO - PROCESS | 11049 | 08:13:58 INFO - PROCESS | 11049 | Cycle 1(1): loaded http://localhost:35066/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35066/tests/kraken/driver.html?testName=audio-oscillator) 08:13:59 INFO - PROCESS | 11049 | RSS: Main: 170414080 08:13:59 INFO - PROCESS | 11049 | 08:14:01 INFO - PROCESS | 11049 | Cycle 1(1): loaded http://localhost:35066/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35066/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:14:01 INFO - PROCESS | 11049 | RSS: Main: 172232704 08:14:01 INFO - PROCESS | 11049 | 08:14:04 INFO - PROCESS | 11049 | Cycle 1(1): loaded http://localhost:35066/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35066/tests/kraken/driver.html?testName=imaging-darkroom) 08:14:05 INFO - PROCESS | 11049 | RSS: Main: 212189184 08:14:05 INFO - PROCESS | 11049 | 08:14:08 INFO - PROCESS | 11049 | Cycle 1(1): loaded http://localhost:35066/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35066/tests/kraken/driver.html?testName=imaging-desaturate) 08:14:09 INFO - PROCESS | 11049 | RSS: Main: 210710528 08:14:09 INFO - PROCESS | 11049 | 08:14:12 INFO - PROCESS | 11049 | Cycle 1(1): loaded http://localhost:35066/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35066/tests/kraken/driver.html?testName=json-parse-financial) 08:14:12 INFO - PROCESS | 11049 | RSS: Main: 209051648 08:14:12 INFO - PROCESS | 11049 | 08:14:14 INFO - PROCESS | 11049 | Cycle 1(1): loaded http://localhost:35066/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35066/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:14:14 INFO - PROCESS | 11049 | RSS: Main: 170844160 08:14:14 INFO - PROCESS | 11049 | 08:14:16 INFO - PROCESS | 11049 | Cycle 1(1): loaded http://localhost:35066/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35066/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:14:17 INFO - PROCESS | 11049 | RSS: Main: 177733632 08:14:17 INFO - PROCESS | 11049 | 08:14:19 INFO - PROCESS | 11049 | Cycle 1(1): loaded http://localhost:35066/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35066/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:14:19 INFO - PROCESS | 11049 | RSS: Main: 187064320 08:14:19 INFO - PROCESS | 11049 | 08:14:22 INFO - PROCESS | 11049 | Cycle 1(1): loaded http://localhost:35066/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35066/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:14:22 INFO - PROCESS | 11049 | RSS: Main: 197963776 08:14:22 INFO - PROCESS | 11049 | 08:14:25 INFO - PROCESS | 11049 | Cycle 1(1): loaded http://localhost:35066/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35066/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:14:26 INFO - PROCESS | 11049 | RSS: Main: 193396736 08:14:26 INFO - PROCESS | 11049 | 08:14:27 INFO - PROCESS | 11049 | Cycle 1(1): loaded http://localhost:35066/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35066/tests/kraken/driver.html?testName=ai-astar) 08:14:28 INFO - PROCESS | 11049 | RSS: Main: 246128640 08:14:28 INFO - PROCESS | 11049 | 08:14:28 INFO - PROCESS | 11049 | __start_tp_report 08:14:28 INFO - PROCESS | 11049 | _x_x_mozilla_page_load 08:14:28 INFO - PROCESS | 11049 | _x_x_mozilla_page_load_details 08:14:28 INFO - PROCESS | 11049 | |i|pagename|runs| 08:14:28 INFO - PROCESS | 11049 | |0;ai-astar;109;111;111;111;112;112;111;113;112;112 08:14:28 INFO - PROCESS | 11049 | |1;audio-beat-detection;138;118;116;154;119;118;117;119;136;118 08:14:28 INFO - PROCESS | 11049 | |2;audio-dft;161;160;160;160;159;163;161;159;159;158 08:14:28 INFO - PROCESS | 11049 | |3;audio-fft;74;76;76;115;75;77;76;76;89;77 08:14:28 INFO - PROCESS | 11049 | |4;audio-oscillator;83;82;101;83;83;82;97;84;82;111 08:14:28 INFO - PROCESS | 11049 | |5;imaging-gaussian-blur;116;117;116;117;117;117;117;117;116;116 08:14:28 INFO - PROCESS | 11049 | |6;imaging-darkroom;147;148;147;148;148;147;146;146;147;146 08:14:28 INFO - PROCESS | 11049 | |7;imaging-desaturate;96;96;97;96;95;95;96;97;95;96 08:14:28 INFO - PROCESS | 11049 | |8;json-parse-financial;51;48;48;48;49;49;50;48;49;48 08:14:28 INFO - PROCESS | 11049 | |9;json-stringify-tinderbox;64;65;64;64;64;64;64;64;64;64 08:14:28 INFO - PROCESS | 11049 | |10;stanford-crypto-aes;76;76;75;76;76;75;76;81;77;75 08:14:28 INFO - PROCESS | 11049 | |11;stanford-crypto-ccm;122;120;121;121;120;126;119;121;158;121 08:14:28 INFO - PROCESS | 11049 | |12;stanford-crypto-pbkdf2;158;161;161;156;162;161;158;156;155;158 08:14:28 INFO - PROCESS | 11049 | |13;stanford-crypto-sha256-iterative;61;71;60;61;69;60;61;59;60;59 08:14:28 INFO - PROCESS | 11049 | __end_tp_report 08:14:28 INFO - PROCESS | 11049 | __start_cc_report 08:14:28 INFO - PROCESS | 11049 | _x_x_mozilla_cycle_collect,1550 08:14:28 INFO - PROCESS | 11049 | __end_cc_report 08:14:28 INFO - PROCESS | 11049 | __startTimestamp1486138468105__endTimestamp 08:14:28 INFO - PROCESS | 11049 | 08:14:28 INFO - PROCESS | 11049 | ------- Summary: start ------- 08:14:28 INFO - PROCESS | 11049 | Number of tests: 14 08:14:28 INFO - PROCESS | 11049 | 08:14:28 INFO - PROCESS | 11049 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:1.07 (1.0%) stddev-sans-first:0.71 08:14:28 INFO - PROCESS | 11049 | Values: 109.0 111.0 111.0 111.0 112.0 112.0 111.0 113.0 112.0 112.0 08:14:28 INFO - PROCESS | 11049 | 08:14:28 INFO - PROCESS | 11049 | [#1] audio-beat-detection Cycles:10 Average:125.30 Median:119.00 stddev:12.88 (10.8%) stddev-sans-first:12.82 08:14:28 INFO - PROCESS | 11049 | Values: 138.0 118.0 116.0 154.0 119.0 118.0 117.0 119.0 136.0 118.0 08:14:28 INFO - PROCESS | 11049 | 08:14:28 INFO - PROCESS | 11049 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:1.41 (0.9%) stddev-sans-first:1.45 08:14:28 INFO - PROCESS | 11049 | Values: 161.0 160.0 160.0 160.0 159.0 163.0 161.0 159.0 159.0 158.0 08:14:28 INFO - PROCESS | 11049 | 08:14:28 INFO - PROCESS | 11049 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:12.64 (16.6%) stddev-sans-first:13.14 08:14:28 INFO - PROCESS | 11049 | Values: 74.0 76.0 76.0 115.0 75.0 77.0 76.0 76.0 89.0 77.0 08:14:28 INFO - PROCESS | 11049 | 08:14:28 INFO - PROCESS | 11049 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:83.00 stddev:10.39 (12.5%) stddev-sans-first:10.81 08:14:28 INFO - PROCESS | 11049 | Values: 83.0 82.0 101.0 83.0 83.0 82.0 97.0 84.0 82.0 111.0 08:14:28 INFO - PROCESS | 11049 | 08:14:28 INFO - PROCESS | 11049 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 08:14:28 INFO - PROCESS | 11049 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 08:14:28 INFO - PROCESS | 11049 | 08:14:28 INFO - PROCESS | 11049 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 08:14:28 INFO - PROCESS | 11049 | Values: 147.0 148.0 147.0 148.0 148.0 147.0 146.0 146.0 147.0 146.0 08:14:28 INFO - PROCESS | 11049 | 08:14:28 INFO - PROCESS | 11049 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 08:14:28 INFO - PROCESS | 11049 | Values: 96.0 96.0 97.0 96.0 95.0 95.0 96.0 97.0 95.0 96.0 08:14:28 INFO - PROCESS | 11049 | 08:14:28 INFO - PROCESS | 11049 | [#8] json-parse-financial Cycles:10 Average:48.80 Median:49.00 stddev:1.03 (2.1%) stddev-sans-first:0.73 08:14:28 INFO - PROCESS | 11049 | Values: 51.0 48.0 48.0 48.0 49.0 49.0 50.0 48.0 49.0 48.0 08:14:28 INFO - PROCESS | 11049 | 08:14:28 INFO - PROCESS | 11049 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 08:14:28 INFO - PROCESS | 11049 | Values: 64.0 65.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 08:14:28 INFO - PROCESS | 11049 | 08:14:28 INFO - PROCESS | 11049 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.00 stddev:1.77 (2.3%) stddev-sans-first:1.87 08:14:28 INFO - PROCESS | 11049 | Values: 76.0 76.0 75.0 76.0 76.0 75.0 76.0 81.0 77.0 75.0 08:14:28 INFO - PROCESS | 11049 | 08:14:28 INFO - PROCESS | 11049 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:121.00 stddev:11.78 (9.7%) stddev-sans-first:12.45 08:14:28 INFO - PROCESS | 11049 | Values: 122.0 120.0 121.0 121.0 120.0 126.0 119.0 121.0 158.0 121.0 08:14:28 INFO - PROCESS | 11049 | 08:14:28 INFO - PROCESS | 11049 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.60 Median:159.50 stddev:2.50 (1.6%) stddev-sans-first:2.65 08:14:28 INFO - PROCESS | 11049 | Values: 158.0 161.0 161.0 156.0 162.0 161.0 158.0 156.0 155.0 158.0 08:14:28 INFO - PROCESS | 11049 | 08:14:28 INFO - PROCESS | 11049 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:61.00 stddev:4.25 (7.0%) stddev-sans-first:4.49 08:14:28 INFO - PROCESS | 11049 | Values: 61.0 71.0 60.0 61.0 69.0 60.0 61.0 59.0 60.0 59.0 08:14:28 INFO - PROCESS | 11049 | -------- Summary: end -------- 08:14:28 INFO - PROCESS | 11049 | 08:14:29 INFO - TEST-INFO | 11049: exit 0 08:14:29 INFO - TEST-OK | kraken | took 59609ms 08:14:29 INFO - SUITE-END | took 1172s 08:14:29 INFO - Completed test suite (00:19:32) 08:14:29 INFO - javascript benchmark 08:14:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3203.695648913353, 3244.2213868671524, 3256.592925884264, 3278.491833765764, 3292.9176770580734, 5412.485813847688, 5475.151351540512, 5476.644018138818, 5476.890462190754, 5484.287042684446, 5446.782128714856, 5479.123340265548, 5505.559555235582, 5510.421405752389, 5523.806666766664, 4988.3515143031445, 5008.098542262392, 5041.344625198719, 5043.268726034723, 5108.233764935252, 4945.282933974571, 4958.082754690376, 5030.924536131961, 5079.466656001122, 5086.440491545927, 4971.080350135218, 4999.450060493361, 5019.673721208128, 5050.116229659813, 5076.416212135597, 5090.083784918713, 5091.592672586185, 5092.9745351273, 5094.2103973884105, 5123.795048198068, 4738.147133515966, 4990.550850423443, 5003.2995380646735, 5055.165897626887, 5067.467915868818, 5302.1781623848365, 5323.254744335796, 5414.91877621836, 5434.972825135888, 5501.724913754297, 5846.123081537803, 5887.381824908366, 5892.646441213541, 5893.116032595102, 5915.201447804534, 5833.949889019975, 5849.415058494159, 5853.88292234153, 5856.531477481792, 5856.970715146397, 5290.603204759658, 5295.708736019517, 5313.123334649817, 5389.703566303812, 5474.507294343488, 5848.181254624356, 5848.4151584841175, 5848.707564621837, 5883.470487656132, 5888.793892213752, 5604.887902241932, 5650.180723795027, 5659.179418984224, 5663.858403539944, 5665.0, 5602.327720673546, 5638.436156384329, 5713.828665123639, 5757.568182386338, 5768.7692492300675, 5686.976344257991, 5745.741441635137, 5792.391798861143, 5825.563082768809, 5827.504662103684, 5801.82594522165, 5805.709714514257, 5811.738471768781, 5813.273340832396, 5814.680192589448, 3979.064919743858, 4017.216642754693, 4108.897277568085, 4108.91782164361, 4142.378643203544, 3629.4374371972385, 3640.8725694601094, 3684.5578530576504, 3694.7413681042067, 3729.8321575529167, 5620.100783874561, 5622.325320961429, 5626.718664066781, 5649.4915457608195, 5664.320281566238, 5764.769409223584, 5770.307563092456, 5827.1841942127285, 5834.970825145847, 5848.502877255481, 5666.575006874501, 5724.79963201286, 5725.083986562214, 5740.483356497852, 5758.337791153987, 5049.82325618609, 5060.063888180698, 5060.671056381323, 5063.569596584258, 5099.796008159707, 5893.882122357529, 5933.851653708605, 6128.601640893327, 6179.3820617937845, 6206.162168107338, 5761.107028410603, 5818.6217895836635, 5851.239338885917, 5926.081457374114, 5942.316633587193, 6133.6319820810895, 6135.386461353829, 6140.048292514667, 6140.416660417253, 6150.538709596709, 5816.73824677882, 5819.0, 5820.1560773688425, 5820.592558520862, 5821.621594596338, 5635.895799257864, 5735.8566035849435, 5794.275715535558, 5843.824685259449, 5853.1220316952795, 5715.114157305624, 5768.0, 5770.336411312753, 5772.422757724194, 5795.1017592273265, 5757.021306377842, 5762.94237057624, 5764.423557644202, 5765.682887441231, 5771.769129234784, 5533.861653458695, 5629.690367029689, 5698.943010569841, 5733.082706766897, 5746.626469279484, 5761.452661997104, 5762.971185144047, 5770.192173095854, 5774.740136693775, 5776.191333213437, 5667.971660141673, 5670.319561652628, 5673.943260567342, 5675.432456754456, 5681.517071049007], "value": 5375.882173727382, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.3776264989835, 604.6613896218118, 618.2241287184582, 620.3052581109156, 662.9867402651947, 36743.632563674386, 41098.0, 41126.79436602813, 41195.38206926895, 46636.0, 50769.23846142302, 51925.0, 51935.0, 51963.48036519634, 52055.73972130134, 9344.953275233614, 9601.80796384072, 9616.759581010461, 9619.80760384792, 9620.18228450579, 8719.651213951434, 9001.369904106683, 9228.538573071353, 9334.0, 9340.15938565529, 11233.213675042709, 11471.426428678575, 11479.483423245974, 11930.522779088826, 11935.820962685524, 11484.827727584052, 11536.76926461466, 11539.538418463251, 11550.480228389742, 11578.363190024504, 11428.257163284443, 11492.655220343404, 11514.251573647685, 11515.654530364103, 11520.078393728565, 47629.28556071662, 48106.518934810556, 48254.7587262065, 48272.27591586129, 48273.0, 4290.678199135077, 4358.87217296006, 4468.932966005513, 4525.932111018337, 4546.499885012646, 34909.65090349115, 34964.65035349639, 34968.825155874314, 35147.4727879082, 36785.08037299062, 4568.291914753218, 4597.494275629678, 4634.21218392874, 4665.393498845162, 4682.556632214695, 372582.0, 372630.0, 374745.0, 375621.0, 375865.0, 68341.65829170922, 68571.65714171497, 68869.31130688729, 69062.0, 69136.0, 70317.64841175762, 70794.0, 70934.2906570938, 70976.64511677512, 71064.64467677732, 19693.40919772409, 20478.897605511876, 20497.0, 20512.0, 20512.487187820425, 15964.201789910458, 16023.599410014844, 16085.517434476984, 16089.0, 16090.597735056483, 16806.495805125865, 17125.91437042807, 18256.634867302844, 18735.90632046831, 18934.621307574045, 6635.270120286765, 6658.167729033871, 6695.832604184934, 6703.698333574904, 6925.272846351161, 987.8765154355706, 994.1599348550463, 1006.4263369879245, 1018.7402212435782, 1035.3322107240788, 32881.0, 33039.50440743391, 33202.33595328128, 33366.666333336354, 33591.0, 1165.2891736041008, 1179.4161889864401, 1194.952201911931, 1208.2991864718442, 1282.6472720002075, 17397.47807565775, 17754.733678994824, 17846.375376862008, 17908.46274611764, 18123.72814407785, 499825.0, 502505.0, 504057.0, 504540.0, 506936.86126278003, 57599.0, 57720.71139644275, 57896.421035789106, 57964.71017644969, 57977.42022579804, 1557.5950252934092, 1561.453491278021, 1580.6364536156748, 1588.2058970514743, 1592.3391792406253, 31337.686623133475, 32705.18237044093, 33328.33343333168, 33339.66660333463, 33555.161120972174, 55119.448805513035, 56009.15986260291, 56102.0, 56204.15693764679, 56278.71860640834, 409305.0, 411042.0, 411065.0, 412118.0, 414129.0, 30814.845925770227, 30821.537676934415, 31309.686903130678, 31314.530282045333, 31426.52860207053, 40984.79507602443, 44709.776451117534, 51185.23222151745, 52542.474575255284, 56333.71833140808, 42746.0, 43634.781826090664, 44983.77508112438, 45936.770316149545, 46672.29991550062, 43585.56414435815, 43633.0, 44227.778861105486, 44735.328970066126, 45043.54956450524, 43020.35469467898, 43094.35358469688, 43485.130297394506, 43542.0, 44497.55502444934, 36292.637073628925, 37049.44425833561, 39676.40485392664, 40059.59940400559, 40296.597034029284, 27147.457050859266, 27274.863625681744, 27481.31296717598, 27554.5866811994, 27595.44809103847], "value": 21811.875918583777, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [440.78181300256375, 444.4333474819605, 450.42345797379363, 455.29429384454096, 455.856405232352, 20685.896570517147, 20999.265025724104, 21702.565948681055, 21827.01778419971, 22429.887850560746, 13110.475580976774, 17878.91060544699, 18164.545886352847, 20628.8968555157, 21403.67894481584, 5637.238972738669, 5750.654960702351, 5791.044477661202, 5824.417558244163, 5844.883102337951, 5477.534409575191, 5603.80386686466, 5607.0, 5617.466340697627, 5703.429657034284, 5672.319321681404, 5697.259356283698, 5700.600957932947, 5704.8859022819515, 5706.087026075828, 5521.723913804314, 5723.771049158028, 5741.569382296303, 5741.770329186848, 5747.396523365028, 5436.293281873371, 5647.689377084259, 5647.774089036434, 5655.519280861132, 5661.179129026268, 25425.364365890815, 25489.872550637127, 25799.226023219333, 25901.870490647616, 26619.866900665565, 2853.4150499147627, 2858.656961164653, 2882.9711702882914, 2955.351097303544, 2966.9406611867857, 10832.133429325635, 10971.122310215163, 11300.491477883515, 11625.76748465026, 11650.475728592233, 1978.436145698469, 2008.086320724067, 2049.764277108122, 2081.0531208300185, 2107.694384314266, 93405.0, 96210.51894740481, 96502.0, 96615.03384966131, 97364.0, 12136.15046946723, 12287.262764234174, 12333.136680432284, 12502.249865008129, 12539.0, 18068.0, 18116.09419529018, 18124.63750724978, 18147.909260453613, 18157.09214539268, 9071.410358326688, 9134.497602631918, 9168.954155229181, 9317.248203416171, 9330.30022748283, 8716.084811094745, 8740.737777866674, 8749.687546868021, 8877.778055548662, 8955.462672239686, 4763.428388593391, 4890.682105663192, 5060.367454068241, 5324.201369794484, 5488.945110548923, 2165.5993641176433, 2184.5084855907294, 2212.1814928476247, 2220.489287463892, 2246.2699622622713, 1137.4710759496875, 1152.4065106470175, 1154.6189757380043, 1163.7265242667966, 1177.6231605886035, 20269.08789104494, 20409.69385459219, 20417.285395011102, 20461.0, 20470.692939605917, 1131.0442675938818, 1135.6990397544657, 1169.9649010529697, 1179.6991767099507, 1186.8635106962638, 10738.677839664822, 11168.888311116947, 11258.493367798468, 11417.543298268143, 11497.597584084517, 688051.0, 692646.0, 702481.0, 706001.0, 719026.0, 105278.47360763147, 106270.0, 106374.0, 110060.0, 111854.44072779584, 476.46397802472217, 493.6692416081234, 907.0657223060258, 924.1267002682534, 942.9858552121724, 11768.0, 12169.878301216875, 12217.205881617667, 12548.184368016415, 12662.0, 41025.0, 44727.77636111798, 45834.0, 46715.29927051029, 46889.296660550805, 59202.703986481516, 64200.678996604714, 64673.35326646861, 64939.0, 65605.67197163984, 9074.31942604294, 9138.68014619485, 9229.123233292827, 9472.336936414385, 9819.85270220933, 10252.282340236112, 13125.212487250796, 13134.343282836011, 13135.277559734306, 13201.405936732677, 11550.133739969368, 11556.0, 11735.647930562096, 11863.288202707865, 11903.583374581847, 11788.823167652321, 12167.2699638022, 12205.450754716237, 12249.938750306548, 12393.132480726263, 11942.940285298519, 12363.75272494563, 12376.62870113898, 12385.566505172636, 12581.245125292511, 9308.767280818034, 9335.890290554218, 9448.527573621428, 9666.0, 9692.951535242279, 9571.521423928914, 12020.278783273032, 12280.140390172603, 12390.132690711564, 12609.0], "value": 9810.696084264515, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1237.573037302131, 1253.166644181619, 1271.4786937355686, 1310.6985393359528, 1317.8748018938197, 7502.099748030238, 8314.210150035744, 8521.701740439086, 8541.572921353938, 8760.78098047549, 8566.65733370666, 8636.69771557994, 8637.524936128526, 8642.395032347738, 8645.265152462049, 2123.203798575534, 2187.6937228787983, 2390.629452434867, 2440.2923152285816, 2442.792362649168, 2408.1089996701244, 2462.66753988212, 2473.6042233242683, 2474.64117702933, 2484.7266800651914, 2392.294273189413, 2401.4716762312264, 2409.542186984467, 2419.63705444183, 2423.042898055276, 2403.831731778776, 2412.07135252928, 2427.7693619106158, 2436.9147079852296, 2438.7683170098812, 2320.4082958845556, 2360.1857359211044, 2360.3037104054347, 2367.00585753982, 2367.0295178976708, 8688.348373871922, 8699.782505437352, 8714.215720585114, 8737.344699147588, 8791.868121978176, 5138.58891288696, 5273.630845840793, 5277.366715994067, 5277.525022747971, 5335.466453354672, 3338.2655815720505, 3367.2928684976187, 3433.613638521229, 3498.5801703795455, 3620.6922411595046, 1381.3852835488212, 1439.92080435576, 1461.5396150212648, 1489.6424858033993, 1537.423466200175, 11772.058235341152, 11796.882031179664, 11806.291622502591, 11879.643610691694, 11881.524739010343, 4630.374899388539, 4793.520647935178, 4799.088173247072, 4850.393700787402, 4875.9512404875495, 9527.761805954906, 9597.90402095984, 9615.471149086727, 9615.951920240494, 9661.227101831837, 5349.037173308841, 5350.357957045179, 5355.839324820262, 5362.0, 5364.946350536445, 4462.888427789267, 4611.7232966021475, 4833.05755377705, 4863.7324947128245, 4890.608751299887, 3778.886633401002, 3789.962100379016, 3879.2047630235734, 3906.199229158016, 3915.393114067267, 1206.0652993929775, 1207.2454715802623, 1219.9817002744967, 1223.2354778263584, 1226.2029680707612, 928.6285485805597, 944.3719926248967, 956.2445667922402, 957.2055194188806, 969.3699095587783, 5393.919091213635, 5455.699936503531, 5456.317960254968, 5547.55619550435, 5625.578081643893, 1010.434156872154, 1040.2354269611828, 1050.7740835720356, 1082.6697857153486, 1102.0467295789085, 3634.6547078027547, 3763.9059023524633, 3766.8116594170183, 3787.5265591801026, 3840.558335791364, 10156.949215253877, 10426.426546539862, 10432.895671043192, 10454.268201225994, 10497.055265026183, 10231.0, 10272.897271027343, 10374.740631484274, 10388.272820902615, 10407.115395191342, 7414.740484083139, 7414.962925185448, 7471.0, 7502.549847009088, 7542.245775422414, 4969.602431805374, 5042.4705405931845, 5106.591472682251, 5237.895242095213, 5369.248305237192, 8866.202041816268, 9103.544822758968, 9110.36227464071, 9178.770530736518, 9262.536873156181, 9241.260699144186, 9349.57926893305, 9438.0, 9455.290853186176, 9516.524173791144, 6950.06174166481, 7167.784966451015, 7316.085489313836, 7618.69525218985, 7735.6905723770415, 7888.960555197187, 8112.391570632109, 8133.227343402367, 8148.388870834592, 8158.3473322132895, 7275.417966562768, 7336.303051210127, 7383.889241661487, 7423.443241756781, 7533.886991695019, 7305.744298949511, 7371.59456229891, 7384.446166537638, 7454.701811927679, 7468.066491688539, 6040.75836966534, 6133.294671112701, 6145.0, 6145.631262124287, 6146.907796382969, 4637.234856248681, 4654.604358629555, 4729.243321068612, 4757.881052973703, 4778.928316075331, 4728.361671174347, 4820.132376172322, 4877.000214955855, 4884.0476107158765, 4886.584640305614], "value": 4511.816044218639, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.31068889287235, 408.7935592525774, 412.36293900506263, 419.7334692470282, 426.9146170765846, 5243.483128098515, 5307.628466007381, 5313.335833020872, 5316.441773613768, 5368.651037682553, 4998.575406009279, 5120.769565369558, 5159.948400515994, 5207.505286997729, 5238.554722848562, 4284.892877678052, 4299.247631664462, 4304.7946574958905, 4320.135972805444, 4321.308590625501, 4295.377170310303, 4310.288802347609, 4312.741235525878, 4314.633256173229, 4316.740995540262, 4013.8394464221396, 4059.918801623966, 4281.35779633056, 4298.9785051074705, 4322.04914918719, 4280.6789490788005, 4304.827806887721, 4314.697971142022, 4318.395424640553, 4323.524412314643, 3882.1265215326325, 3886.514185726784, 3891.9416208756893, 3897.6747905712195, 3899.707521935866, 5039.697618142924, 5056.772445239973, 5126.820561280375, 5140.665856719302, 5167.586593072545, 4891.510848915115, 4891.755412229374, 4896.4858689837765, 4900.255856720248, 4911.852644420673, 5512.5589952803675, 5520.171974203861, 5527.143292789624, 5531.723413829292, 5548.334199895998, 4128.0, 4277.1873344064525, 4283.164782867342, 4292.699511034229, 4307.224699554079, 5689.203511508392, 5691.857703557403, 5697.857553561153, 5699.0, 5700.401457846908, 4408.801603927831, 4410.933835992462, 4422.380866678667, 4424.911501769947, 4436.292027569409, 4364.934525982049, 4438.7114837535455, 4462.397576327219, 4475.932861007088, 4477.485089214782, 4906.215005599087, 4921.26181072842, 4930.433000204951, 4937.308776771255, 4953.529414705597, 5558.277423934944, 5579.832605021856, 5590.372524913366, 5598.720063996784, 5603.971980140154, 1428.2073449235775, 1428.5000249912448, 1476.8892333075062, 1477.8300495442948, 1499.8500149985132, 997.9401235925868, 1012.3470361616716, 1061.0026575019458, 1085.5169449595012, 1086.1962148010416, 5264.499872512105, 5270.92093618596, 5303.204519322133, 5314.468553144655, 5353.598480113929, 5392.56859451243, 5510.256115424367, 5539.2522009529, 5561.555075593943, 5564.0, 5283.498067683564, 5288.656237344637, 5290.470952904679, 5292.629515933848, 5329.493698098674, 2864.3125649843887, 2901.4632293025857, 2904.3425265881906, 2906.956395654067, 2929.091981485746, 5506.889862202734, 5599.272094627754, 5656.4060773619, 5700.636624391629, 5712.228849105318, 5545.364117585322, 5576.637518561281, 5581.916271255853, 5582.218489411485, 5608.411116832755, 5671.262735844314, 5679.551714312824, 5688.48803607669, 5689.061304884648, 5698.515626171739, 5288.9471105289995, 5409.350877894678, 5455.890142618669, 5459.317585301837, 5479.972600136974, 5387.168362756682, 5393.244945707683, 5398.514133727984, 5402.243685883901, 5426.240326354235, 5401.594880384066, 5575.303087114111, 5590.580706447114, 5675.0, 5678.318601767649, 4229.851955181553, 4234.809433575435, 4251.0, 4276.0, 4278.379634952977, 5446.1558458439, 5467.844438227055, 5545.445455454423, 5545.584081194007, 5548.334199896039, 5186.325777648882, 5376.7580458878665, 5413.296271484682, 5428.891422171613, 5514.841883204572, 5543.77824887, 5547.918155959549, 5548.472895074961, 5548.889022219614, 5551.722413879371, 5317.893642127213, 5488.615796894179, 5497.422770609189, 5532.5020748132865, 5549.223108764695, 5226.398964119175, 5419.972900135474, 5469.589780766538, 5476.780928762964, 5489.917651235314, 5298.841034768963, 5330.0, 5346.1713434417725, 5374.193870919394, 5408.621396502207], "value": 4292.660716945632, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [824.7690646618948, 827.2843989948697, 837.6774941647468, 885.7254251182133, 901.0448924140411, 16110.677786444265, 17100.486985390442, 17353.219105140266, 17361.7395739064, 17370.56573585661, 14808.407663693466, 14834.406623735038, 14902.627434314121, 14935.701285974274, 14962.0, 704.0319560604182, 712.7434123715458, 805.5327909812324, 813.5769399912042, 820.3970081989762, 827.234807802783, 836.8577341851869, 837.1042984007115, 837.2841220756258, 837.3134030095293, 881.9382643214977, 883.801144742431, 885.4731434796286, 885.6059053721096, 886.0342226972599, 743.2196193996282, 754.0310700749566, 881.6649673124236, 881.964721411146, 882.2765332427412, 627.4791922704145, 637.7927173668576, 639.9296077431479, 644.5230529408204, 645.2901808011151, 16085.0, 16347.019178849307, 16388.590285242964, 16416.917915410468, 16420.1789910504, 13820.170789752647, 14210.076345037643, 14239.216843073627, 14416.92791536046, 14477.927610361987, 11984.340861252627, 12269.877301227052, 12278.938605307005, 14271.14373137615, 14532.346044428026, 4721.409823772028, 4780.737059461728, 4796.424429068499, 4888.315635810954, 4965.106280869442, 84813.57593212118, 85256.0, 85781.14218857794, 86718.56640716756, 86913.56543217243, 11979.640610781691, 12191.32947687868, 12238.571649992207, 12297.954673852822, 12353.32056736888, 21503.784962150177, 21522.784772152077, 21561.02975366112, 22098.779012209994, 22880.542389152455, 8321.708740194064, 8535.658573657109, 8565.743027709179, 8780.0, 8793.428427152343, 4766.332713420124, 4776.713397196179, 4823.445303790038, 4888.853334399973, 4892.633052521075, 3370.5618269624792, 3452.4648679454726, 3456.75802693809, 3460.9134771630406, 3462.6537346265172, 590.6338070396296, 609.7530500147448, 617.527591392585, 617.7745123030062, 619.0373968479058, 652.1815122021927, 657.2277573850706, 661.8186141438983, 670.0485310858593, 698.1064237775655, 9926.404415735078, 10104.393736375841, 10487.37075775456, 10575.101116405192, 10594.682159535227, 670.2727540618483, 687.0861753867345, 690.5235387582552, 695.7147569496482, 696.7839969609336, 5060.5951523878, 5198.2722418861385, 5238.476152384731, 5239.345081864767, 5248.527632513092, 73390.0, 73987.63006184934, 87139.0, 87519.0, 92300.53849730709, 73882.0, 74908.0, 75095.24904750992, 76875.61562192265, 77960.61019694865, 67301.66349168222, 68493.0, 68588.6570567154, 69239.3076069253, 70650.0, 9351.719448416557, 9774.85337719949, 9791.608335666493, 9811.509424528887, 9827.0, 36196.45705314475, 38997.41503877387, 39272.41091383689, 41857.37213941854, 48333.75833120812, 56218.43781562132, 57182.42817571771, 57618.7119064402, 57792.71103644455, 57827.0, 14336.494653188736, 14550.199739014455, 14583.197924114276, 14626.85972634356, 14722.779158312847, 15551.455699050932, 15824.287907043981, 15838.9208053959, 15917.124558149413, 15970.441034563735, 13607.387667554785, 15110.622234444227, 15362.539123826304, 15424.922875385551, 16041.759373609639, 14784.63038424048, 15054.623634409227, 15117.470888518848, 15263.0, 15265.23673816327, 15165.0, 15208.391664333745, 15354.923225383802, 15919.602009949844, 15964.361425542847, 11560.710982225512, 11838.0, 11842.57227268425, 11917.582884598998, 12195.878041219474, 11089.556417743523, 11444.313341199555, 11485.19603627738, 11722.062235021349, 11735.354555499529], "value": 7606.262986913771, "unit": "score"}], "name": "dromaeo_css", "value": 7439.153347808349, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 111.0, 111.0, 112.0, 112.0, 111.0, 113.0, 112.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 118.0, 116.0, 154.0, 119.0, 118.0, 117.0, 119.0, 136.0, 118.0], "value": 125.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 160.0, 159.0, 163.0, 161.0, 159.0, 159.0, 158.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 115.0, 75.0, 77.0, 76.0, 76.0, 89.0, 77.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 101.0, 83.0, 83.0, 82.0, 97.0, 84.0, 82.0, 111.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 148.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 96.0, 95.0, 95.0, 96.0, 97.0, 95.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 48.0, 48.0, 48.0, 49.0, 49.0, 50.0, 48.0, 49.0, 48.0], "value": 48.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 76.0, 76.0, 75.0, 76.0, 81.0, 77.0, 75.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 120.0, 121.0, 121.0, 120.0, 126.0, 119.0, 121.0, 158.0, 121.0], "value": 124.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 161.0, 161.0, 156.0, 162.0, 161.0, 158.0, 156.0, 155.0, 158.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 71.0, 60.0, 61.0, 69.0, 60.0, 61.0, 59.0, 60.0, 59.0], "value": 62.1, "unit": "score"}], "name": "kraken", "value": 1460.8999999999996, "alertThreshold": 2.0}]} 08:14:29 INFO - Return code: 0 08:14:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:14:29 ERROR - # TBPL SUCCESS # 08:14:29 INFO - Running post-action listener: _resource_record_post_action 08:14:29 INFO - [mozharness: 2017-02-03 16:14:29.414564Z] Finished run-tests step (success) 08:14:29 INFO - Running post-run listener: _resource_record_post_run 08:14:29 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 12288; Write bytes: 365367296; Read time: 252; Write time: 239268 08:14:29 INFO - TinderboxPrint: CPU usage
13.0% 08:14:29 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 252 08:14:29 INFO - TinderboxPrint: I/O write bytes / time
365,367,296 / 239,268 08:14:29 INFO - TinderboxPrint: CPU idle
8,251.8 (87.0%) 08:14:29 INFO - TinderboxPrint: CPU user
1,193.3 (12.6%) 08:14:29 INFO - TinderboxPrint: Swap in / out
0 / 0 08:14:29 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 110219264; Read time: 64; Write time: 101720 08:14:29 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 255148032; Read time: 188; Write time: 137548 08:14:30 INFO - Running post-run listener: _upload_blobber_files 08:14:30 INFO - Blob upload gear active. 08:14:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:14:30 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 08:14:30 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'] 08:14:30 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 08:14:30 INFO - (blobuploader) - INFO - Open directory for files ... 08:14:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:14:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:14:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:31 INFO - (blobuploader) - INFO - Done attempting. 08:14:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:14:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:14:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:32 INFO - (blobuploader) - INFO - Done attempting. 08:14:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:14:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:14:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:32 INFO - (blobuploader) - INFO - Done attempting. 08:14:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:14:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:14:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:36 INFO - (blobuploader) - INFO - Done attempting. 08:14:36 INFO - (blobuploader) - INFO - Iteration through files over. 08:14:36 INFO - Return code: 0 08:14:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:14:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:14:36 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4944e7e6a3021b4e2b7d3e85b89df8620d9e6df58a2008fe4abb8ef5b01eea94b4db89110ff156791b4bf83b6a602c21908b7822c29bafd5a9192dd9195c1e82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8402e0f900f101eff2b4d0090db0b19286ec6f886517620f5be2fb2cf9fefe25c32dd81b7a11081b9354aa0f7d05000d8f09ffbad6c11807624b4580f3690588", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/7f449cb6c45a5e922558792b754af04877e5e7b54ea9b844dbc372aaecaa2f3b0dbb74700321454cb6b96aa64fa35d6b8c9edddd5070c47142b1eed135da18d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/27f5c22053a33bd790575c06c8a9076bb3714195cda255d09f6337289aafd4fc354c70600a8053a33656f6ba9621cf5d49559634c7845dc174af0261c93e5284"} 08:14:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:14:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:14:36 INFO - Contents: 08:14:36 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4944e7e6a3021b4e2b7d3e85b89df8620d9e6df58a2008fe4abb8ef5b01eea94b4db89110ff156791b4bf83b6a602c21908b7822c29bafd5a9192dd9195c1e82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8402e0f900f101eff2b4d0090db0b19286ec6f886517620f5be2fb2cf9fefe25c32dd81b7a11081b9354aa0f7d05000d8f09ffbad6c11807624b4580f3690588", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/7f449cb6c45a5e922558792b754af04877e5e7b54ea9b844dbc372aaecaa2f3b0dbb74700321454cb6b96aa64fa35d6b8c9edddd5070c47142b1eed135da18d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/27f5c22053a33bd790575c06c8a9076bb3714195cda255d09f6337289aafd4fc354c70600a8053a33656f6ba9621cf5d49559634c7845dc174af0261c93e5284"} 08:14:36 INFO - Running post-run listener: copy_logs_to_upload_dir 08:14:36 INFO - Copying logs to upload dir... 08:14:36 INFO - mkdir: /builds/slave/test/build/upload/logs 08:14:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.065512 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-02-03 08:14:35.906534) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 08:14:35.910632) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4944e7e6a3021b4e2b7d3e85b89df8620d9e6df58a2008fe4abb8ef5b01eea94b4db89110ff156791b4bf83b6a602c21908b7822c29bafd5a9192dd9195c1e82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8402e0f900f101eff2b4d0090db0b19286ec6f886517620f5be2fb2cf9fefe25c32dd81b7a11081b9354aa0f7d05000d8f09ffbad6c11807624b4580f3690588", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/7f449cb6c45a5e922558792b754af04877e5e7b54ea9b844dbc372aaecaa2f3b0dbb74700321454cb6b96aa64fa35d6b8c9edddd5070c47142b1eed135da18d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/27f5c22053a33bd790575c06c8a9076bb3714195cda255d09f6337289aafd4fc354c70600a8053a33656f6ba9621cf5d49559634c7845dc174af0261c93e5284"} build_url:https://queue.taskcluster.net/v1/task/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011591 build_url: 'https://queue.taskcluster.net/v1/task/CINvy-kLQkuv8tzcXGiYSA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4944e7e6a3021b4e2b7d3e85b89df8620d9e6df58a2008fe4abb8ef5b01eea94b4db89110ff156791b4bf83b6a602c21908b7822c29bafd5a9192dd9195c1e82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8402e0f900f101eff2b4d0090db0b19286ec6f886517620f5be2fb2cf9fefe25c32dd81b7a11081b9354aa0f7d05000d8f09ffbad6c11807624b4580f3690588", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/7f449cb6c45a5e922558792b754af04877e5e7b54ea9b844dbc372aaecaa2f3b0dbb74700321454cb6b96aa64fa35d6b8c9edddd5070c47142b1eed135da18d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/27f5c22053a33bd790575c06c8a9076bb3714195cda255d09f6337289aafd4fc354c70600a8053a33656f6ba9621cf5d49559634c7845dc174af0261c93e5284"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 08:14:35.936282) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 08:14:35.936610) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1486137239.744793-1864900570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004397 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 08:14:36.020024) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 08:14:36.020351) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 08:14:36.020652) ========= ========= Total master_lag: 0.17 =========