builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1491657526.49 results: success (0) revision: f6712e7858f391923006b174d27cb919c454a9ce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-08 06:18:46.488920) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-08 06:18:46.489390) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-08 06:18:46.489672) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-08 06:18:46.504250) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 06:18:46.504619) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-08 06:18:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.4M=0s 2017-04-08 06:18:47 (23.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094814 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 06:18:46.613530) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 06:18:46.613808) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013701 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 06:18:46.663649) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 06:18:46.663992) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f6712e7858f391923006b174d27cb919c454a9ce --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 f6712e7858f391923006b174d27cb919c454a9ce --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=74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-08 06:18:47,687 truncating revision to first 12 chars 2017-04-08 06:18:47,687 Setting DEBUG logging. 2017-04-08 06:18:47,687 attempt 1/10 2017-04-08 06:18:47,687 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f6712e7858f3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-08 06:18:48,129 unpacking tar archive at: mozilla-aurora-f6712e7858f3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.718338 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 06:18:47.396281) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-08 06:18:47.396596) ========= script_repo_revision: f6712e7858f391923006b174d27cb919c454a9ce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-08 06:18:47.396988) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-08 06:18:47.397280) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-08 06:18:47.406996) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-04-08 06:18:47.407320) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:18:48 INFO - MultiFileLogger online at 20170408 06:18:48 in /builds/slave/test 06:18:48 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 06:18:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:18:48 INFO - {'append_to_log': False, 06:18:48 INFO - 'base_work_dir': '/builds/slave/test', 06:18:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 06:18:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:18:48 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 06:18:48 INFO - 'buildbot_json_path': 'buildprops.json', 06:18:48 INFO - 'config_files': ('talos/linux_config.py',), 06:18:48 INFO - 'default_actions': ('clobber', 06:18:48 INFO - 'read-buildbot-config', 06:18:48 INFO - 'download-and-extract', 06:18:48 INFO - 'populate-webroot', 06:18:48 INFO - 'create-virtualenv', 06:18:48 INFO - 'install', 06:18:48 INFO - 'run-tests'), 06:18:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:18:48 INFO - 'download_minidump_stackwalk': True, 06:18:48 INFO - 'download_symbols': 'ondemand', 06:18:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:18:48 INFO - 'tooltool.py': '/tools/tooltool.py', 06:18:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:18:48 INFO - '/tools/misc-python/virtualenv.py')}, 06:18:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:18:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:18:48 INFO - 'gecko_profile': False, 06:18:48 INFO - 'gecko_profile_interval': 0, 06:18:48 INFO - 'installer_path': 'installer.exe', 06:18:48 INFO - 'log_level': 'info', 06:18:48 INFO - 'log_name': 'talos', 06:18:48 INFO - 'log_to_console': True, 06:18:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:18:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:18:48 INFO - 'opt_config_files': (), 06:18:48 INFO - 'pip_index': False, 06:18:48 INFO - 'suite': 'dromaeojs', 06:18:48 INFO - 'system_bits': '32', 06:18:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:18:48 INFO - 'title': 'talos-linux64-ix-042', 06:18:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:18:48 INFO - 'use_talos_json': True, 06:18:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:18:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:18:48 INFO - 'work_dir': 'build'} 06:18:48 INFO - [mozharness: 2017-04-08 13:18:48.526702Z] Running clobber step. 06:18:48 INFO - Running pre-action listener: _resource_record_pre_action 06:18:48 INFO - Running main action method: clobber 06:18:48 INFO - rmtree: /builds/slave/test/build 06:18:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:18:49 INFO - Running post-action listener: _resource_record_post_action 06:18:49 INFO - [mozharness: 2017-04-08 13:18:49.982164Z] Finished clobber step (success) 06:18:49 INFO - [mozharness: 2017-04-08 13:18:49.982263Z] Running read-buildbot-config step. 06:18:49 INFO - Running pre-action listener: _resource_record_pre_action 06:18:49 INFO - Running main action method: read_buildbot_config 06:18:49 INFO - Using buildbot properties: 06:18:49 INFO - { 06:18:49 INFO - "project": "", 06:18:49 INFO - "product": "firefox", 06:18:49 INFO - "who": "nobody@mozilla.org", 06:18:49 INFO - "installer_path": "public/build/target.tar.bz2", 06:18:49 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 06:18:49 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora", 06:18:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 06:18:49 INFO - "stage_platform": "linux64", 06:18:49 INFO - "basedir": "/builds/slave/test", 06:18:49 INFO - "buildnumber": 122, 06:18:49 INFO - "platform": "ubuntu64_hw", 06:18:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:18:49 INFO - "slavebuilddir": "test", 06:18:49 INFO - "taskId": "ccO5jo2WQQydBGtB0ytdig", 06:18:49 INFO - "branch": "mozilla-aurora", 06:18:49 INFO - "script_repo_revision": "production", 06:18:49 INFO - "revision": "f6712e7858f391923006b174d27cb919c454a9ce", 06:18:49 INFO - "slavename": "talos-linux64-ix-042", 06:18:49 INFO - "repo_path": "releases/mozilla-aurora" 06:18:49 INFO - } 06:18:49 INFO - Finding installer, test and symbols from parent task. 06:18:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ccO5jo2WQQydBGtB0ytdig'}, attempt #1 06:18:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ccO5jo2WQQydBGtB0ytdig'}, attempt #1 06:18:50 INFO - Task dependencies: CkyA-gFERPq-BjOWqNysUA 06:18:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CkyA-gFERPq-BjOWqNysUA'}, attempt #1 06:18:51 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/target.tar.bz2 06:18:51 INFO - Set test_url: https://queue.taskcluster.net/v1/task/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/test_packages.json 06:18:51 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/target.crashreporter-symbols.zip 06:18:51 INFO - Running post-action listener: _resource_record_post_action 06:18:51 INFO - [mozharness: 2017-04-08 13:18:51.329357Z] Finished read-buildbot-config step (success) 06:18:51 INFO - [mozharness: 2017-04-08 13:18:51.329574Z] Running download-and-extract step. 06:18:51 INFO - Running pre-action listener: _resource_record_pre_action 06:18:51 INFO - Running main action method: download_and_extract 06:18:51 INFO - mkdir: /builds/slave/test/build/tests 06:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:51 INFO - trying https://queue.taskcluster.net/v1/task/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/target.test_packages.json 06:18:51 INFO - Downloading https://queue.taskcluster.net/v1/task/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:18:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:18:51 INFO - Downloaded 896 bytes. 06:18:51 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:18:51 INFO - Using the following test package requirements: 06:18:51 INFO - {u'common': [u'target.common.tests.zip'], 06:18:51 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:18:51 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:18:51 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:18:51 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:18:51 INFO - u'mozbase': [u'target.common.tests.zip'], 06:18:51 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:18:51 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:18:51 INFO - u'web-platform': [u'target.common.tests.zip', 06:18:51 INFO - u'target.web-platform.tests.zip'], 06:18:51 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:18:51 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:18:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/target.common.tests.zip 06:18:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:18:51 INFO - Fetch https://queue.taskcluster.net/v1/task/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/target.common.tests.zip into memory 06:18:53 INFO - Expected file size: 59542941 06:18:53 INFO - Obtained file size: 59542941 06:19:03 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:19:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/target.common.tests.zip 06:19:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:19:03 INFO - Fetch https://queue.taskcluster.net/v1/task/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/target.common.tests.zip into memory 06:19:04 INFO - Expected file size: 59542941 06:19:04 INFO - Obtained file size: 59542941 06:19:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/target.talos.tests.zip 06:19:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:19:15 INFO - Fetch https://queue.taskcluster.net/v1/task/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/target.talos.tests.zip into memory 06:19:16 INFO - Expected file size: 14404424 06:19:16 INFO - Obtained file size: 14404424 06:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:16 INFO - trying https://queue.taskcluster.net/v1/task/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/target.tar.bz2 06:19:16 INFO - Downloading https://queue.taskcluster.net/v1/task/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:19:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:19:18 INFO - Downloaded 66719323 bytes. 06:19:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/target.tar.bz2 06:19:18 INFO - mkdir: /builds/slave/test/properties 06:19:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:19:18 INFO - Writing to file /builds/slave/test/properties/build_url 06:19:18 INFO - Contents: 06:19:18 INFO - build_url:https://queue.taskcluster.net/v1/task/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/target.tar.bz2 06:19:18 INFO - Running post-action listener: _resource_record_post_action 06:19:18 INFO - Running post-action listener: set_extra_try_arguments 06:19:18 INFO - [mozharness: 2017-04-08 13:19:18.938946Z] Finished download-and-extract step (success) 06:19:18 INFO - [mozharness: 2017-04-08 13:19:18.939195Z] Running populate-webroot step. 06:19:18 INFO - Running pre-action listener: _resource_record_pre_action 06:19:18 INFO - Running main action method: populate_webroot 06:19:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:19:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:19:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:19:18 INFO - '--tppagecycles', 06:19:18 INFO - '7'], 06:19:18 INFO - 'tests': ['tsvgm']}}, 06:19:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:19:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:19:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:19:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:19:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:19:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:19:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:19:18 INFO - 'talos_options': ['--disable-e10s'], 06:19:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:19:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:19:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:19:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:19:18 INFO - 'talos_options': ['--disable-e10s'], 06:19:18 INFO - 'tests': ['damp', 'tps']}, 06:19:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:19:18 INFO - 'tests': ['damp', 'tps']}, 06:19:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:19:18 INFO - 'tests': ['dromaeo_dom']}, 06:19:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:19:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:19:18 INFO - 'tests': ['basic_compositor_video']}, 06:19:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:19:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:19:18 INFO - 'tests': ['a11yr', 06:19:18 INFO - 'ts_paint', 06:19:18 INFO - 'tpaint', 06:19:18 INFO - 'sessionrestore', 06:19:18 INFO - 'sessionrestore_no_auto_restore', 06:19:18 INFO - 'tabpaint']}, 06:19:18 INFO - 'other-e10s': {'tests': ['a11yr', 06:19:18 INFO - 'ts_paint', 06:19:18 INFO - 'tpaint', 06:19:18 INFO - 'sessionrestore', 06:19:18 INFO - 'sessionrestore_no_auto_restore', 06:19:18 INFO - 'tabpaint']}, 06:19:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:19:18 INFO - 'ts_paint', 06:19:18 INFO - 'tpaint', 06:19:18 INFO - 'sessionrestore', 06:19:18 INFO - 'sessionrestore_no_auto_restore', 06:19:18 INFO - 'tabpaint']}, 06:19:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:19:18 INFO - 'ts_paint', 06:19:18 INFO - 'tpaint', 06:19:18 INFO - 'sessionrestore', 06:19:18 INFO - 'sessionrestore_no_auto_restore', 06:19:18 INFO - 'tabpaint']}, 06:19:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:19:18 INFO - 'tests': ['a11yr', 06:19:18 INFO - 'ts_paint', 06:19:18 INFO - 'tpaint', 06:19:18 INFO - 'sessionrestore', 06:19:18 INFO - 'sessionrestore_no_auto_restore', 06:19:18 INFO - 'tabpaint']}, 06:19:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:19:18 INFO - 'tests': ['a11yr', 06:19:18 INFO - 'ts_paint', 06:19:18 INFO - 'tpaint', 06:19:18 INFO - 'sessionrestore', 06:19:18 INFO - 'sessionrestore_no_auto_restore', 06:19:18 INFO - 'tabpaint']}, 06:19:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:19:18 INFO - 'tests': ['tsvgx', 06:19:18 INFO - 'tsvgr_opacity', 06:19:18 INFO - 'tart', 06:19:18 INFO - 'tscrollx', 06:19:18 INFO - 'cart', 06:19:18 INFO - 'tsvg_static']}, 06:19:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:19:18 INFO - 'tsvgr_opacity', 06:19:18 INFO - 'tart', 06:19:18 INFO - 'tscrollx', 06:19:18 INFO - 'cart', 06:19:18 INFO - 'tsvg_static']}, 06:19:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:19:18 INFO - 'talos_options': ['--disable-e10s'], 06:19:18 INFO - 'tests': ['tp5o']}, 06:19:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:19:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:19:18 INFO - 'talos_options': ['--disable-e10s', 06:19:18 INFO - '--xperf_path', 06:19:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:19:18 INFO - 'tests': ['tp5n']}, 06:19:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:19:18 INFO - 'talos_options': ['--xperf_path', 06:19:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:19:18 INFO - 'tests': ['tp5n']}}, 06:19:18 INFO - 'talos.zip': {'path': '', 06:19:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:19:18 INFO - Running post-action listener: _resource_record_post_action 06:19:18 INFO - [mozharness: 2017-04-08 13:19:18.962178Z] Finished populate-webroot step (success) 06:19:18 INFO - [mozharness: 2017-04-08 13:19:18.962268Z] Running create-virtualenv step. 06:19:18 INFO - Running pre-action listener: _resource_record_pre_action 06:19:18 INFO - Running main action method: create_virtualenv 06:19:18 INFO - Creating virtualenv /builds/slave/test/build/venv 06:19:18 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 06:19:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:19:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:19:19 INFO - Using real prefix '/usr' 06:19:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:19:19 INFO - Installing distribute.............................................................................................................................................................................................done. 06:19:21 INFO - Installing pip.................done. 06:19:21 INFO - Return code: 0 06:19:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:19:21 INFO - Reading from file tmpfile_stdout 06:19:21 INFO - Output received: 06:19:21 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) 06:19:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:19:21 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')]} 06:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:21 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')]} 06:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:21 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 0x11721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1410310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140d400>, '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 0x140e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140e840>, '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': '74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991', '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 06:19:21 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 06:19:21 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 06:19:21 INFO - Using env: {'DISPLAY': ':0', 06:19:21 INFO - 'HOME': '/home/cltbld', 06:19:21 INFO - 'LANG': 'en_US.UTF-8', 06:19:21 INFO - 'LANGUAGE': 'en_US:en', 06:19:21 INFO - 'LOGNAME': 'cltbld', 06:19:21 INFO - 'MAIL': '/var/mail/cltbld', 06:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:21 INFO - 'MOZ_NO_REMOTE': '1', 06:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:21 INFO - 'NO_EM_RESTART': '1', 06:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:21 INFO - 'PWD': '/builds/slave/test', 06:19:21 INFO - 'SHELL': '/bin/bash', 06:19:21 INFO - 'SHLVL': '1', 06:19:21 INFO - 'TERM': 'linux', 06:19:21 INFO - 'TMOUT': '86400', 06:19:21 INFO - 'USER': 'cltbld', 06:19:21 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991', 06:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:21 INFO - '_': '/tools/buildbot/bin/python'} 06:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:21 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 06:19:21 INFO - Cleaning up... 06:19:21 INFO - Return code: 0 06:19:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:19:21 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')]} 06:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:21 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')]} 06:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1410310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140d400>, '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 0x140e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140e840>, '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': '74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991', '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 06:19:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:19:22 INFO - Using env: {'DISPLAY': ':0', 06:19:22 INFO - 'HOME': '/home/cltbld', 06:19:22 INFO - 'LANG': 'en_US.UTF-8', 06:19:22 INFO - 'LANGUAGE': 'en_US:en', 06:19:22 INFO - 'LOGNAME': 'cltbld', 06:19:22 INFO - 'MAIL': '/var/mail/cltbld', 06:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:22 INFO - 'MOZ_NO_REMOTE': '1', 06:19:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:22 INFO - 'NO_EM_RESTART': '1', 06:19:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:22 INFO - 'PWD': '/builds/slave/test', 06:19:22 INFO - 'SHELL': '/bin/bash', 06:19:22 INFO - 'SHLVL': '1', 06:19:22 INFO - 'TERM': 'linux', 06:19:22 INFO - 'TMOUT': '86400', 06:19:22 INFO - 'USER': 'cltbld', 06:19:22 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991', 06:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:22 INFO - '_': '/tools/buildbot/bin/python'} 06:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:22 INFO - Downloading/unpacking psutil>=3.1.1 06:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:19:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:19:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:19:24 INFO - Installing collected packages: psutil 06:19:24 INFO - Running setup.py install for psutil 06:19:24 INFO - building 'psutil._psutil_linux' extension 06:19:24 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 06:19:24 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 06:19:24 INFO - building 'psutil._psutil_posix' extension 06:19:24 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 06:19:24 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 06:19:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:19:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:19:24 INFO - Successfully installed psutil 06:19:24 INFO - Cleaning up... 06:19:24 INFO - Return code: 0 06:19:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1410310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140d400>, '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 0x140e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140e840>, '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': '74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991', '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 06:19:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:19:24 INFO - Using env: {'DISPLAY': ':0', 06:19:24 INFO - 'HOME': '/home/cltbld', 06:19:24 INFO - 'LANG': 'en_US.UTF-8', 06:19:24 INFO - 'LANGUAGE': 'en_US:en', 06:19:24 INFO - 'LOGNAME': 'cltbld', 06:19:24 INFO - 'MAIL': '/var/mail/cltbld', 06:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:24 INFO - 'MOZ_NO_REMOTE': '1', 06:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:24 INFO - 'NO_EM_RESTART': '1', 06:19:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:24 INFO - 'PWD': '/builds/slave/test', 06:19:24 INFO - 'SHELL': '/bin/bash', 06:19:24 INFO - 'SHLVL': '1', 06:19:24 INFO - 'TERM': 'linux', 06:19:24 INFO - 'TMOUT': '86400', 06:19:24 INFO - 'USER': 'cltbld', 06:19:24 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991', 06:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:24 INFO - '_': '/tools/buildbot/bin/python'} 06:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:19: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 06:19: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 06:19: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 06:19: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 06:19: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 06:19: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 06:19:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:19:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:19:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:19:27 INFO - Installing collected packages: mozsystemmonitor 06:19:27 INFO - Running setup.py install for mozsystemmonitor 06:19:27 INFO - Successfully installed mozsystemmonitor 06:19:27 INFO - Cleaning up... 06:19:27 INFO - Return code: 0 06:19:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1410310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140d400>, '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 0x140e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140e840>, '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': '74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991', '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 06:19:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:19:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:19:27 INFO - Using env: {'DISPLAY': ':0', 06:19:27 INFO - 'HOME': '/home/cltbld', 06:19:27 INFO - 'LANG': 'en_US.UTF-8', 06:19:27 INFO - 'LANGUAGE': 'en_US:en', 06:19:27 INFO - 'LOGNAME': 'cltbld', 06:19:27 INFO - 'MAIL': '/var/mail/cltbld', 06:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:27 INFO - 'MOZ_NO_REMOTE': '1', 06:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:27 INFO - 'NO_EM_RESTART': '1', 06:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:27 INFO - 'PWD': '/builds/slave/test', 06:19:27 INFO - 'SHELL': '/bin/bash', 06:19:27 INFO - 'SHLVL': '1', 06:19:27 INFO - 'TERM': 'linux', 06:19:27 INFO - 'TMOUT': '86400', 06:19:27 INFO - 'USER': 'cltbld', 06:19:27 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991', 06:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:27 INFO - '_': '/tools/buildbot/bin/python'} 06:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:27 INFO - Downloading/unpacking jsonschema==2.5.1 06:19: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 06:19: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 06:19: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 06:19: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 06:19: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 06:19: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 06:19:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:19:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:29 INFO - Downloading functools32-3.2.3-2.tar.gz 06:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:19:29 INFO - warning: no files found matching '*.txt' 06:19:29 INFO - no previously-included directories found matching 'build' 06:19:29 INFO - no previously-included directories found matching 'dist' 06:19:29 INFO - no previously-included directories found matching '.git*' 06:19:29 INFO - Installing collected packages: jsonschema, functools32 06:19:29 INFO - Running setup.py install for functools32 06:19:29 INFO - warning: no files found matching '*.txt' 06:19:29 INFO - no previously-included directories found matching 'build' 06:19:29 INFO - no previously-included directories found matching 'dist' 06:19:29 INFO - no previously-included directories found matching '.git*' 06:19:29 INFO - Successfully installed jsonschema functools32 06:19:29 INFO - Cleaning up... 06:19:30 INFO - Return code: 0 06:19:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:19:30 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')]} 06:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:30 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')]} 06:19:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:30 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 0x11721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1410310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140d400>, '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 0x140e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140e840>, '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': '74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991', '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 06:19:30 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 06:19:30 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 06:19:30 INFO - Using env: {'DISPLAY': ':0', 06:19:30 INFO - 'HOME': '/home/cltbld', 06:19:30 INFO - 'LANG': 'en_US.UTF-8', 06:19:30 INFO - 'LANGUAGE': 'en_US:en', 06:19:30 INFO - 'LOGNAME': 'cltbld', 06:19:30 INFO - 'MAIL': '/var/mail/cltbld', 06:19:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:30 INFO - 'MOZ_NO_REMOTE': '1', 06:19:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:30 INFO - 'NO_EM_RESTART': '1', 06:19:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:30 INFO - 'PWD': '/builds/slave/test', 06:19:30 INFO - 'SHELL': '/bin/bash', 06:19:30 INFO - 'SHLVL': '1', 06:19:30 INFO - 'TERM': 'linux', 06:19:30 INFO - 'TMOUT': '86400', 06:19:30 INFO - 'USER': 'cltbld', 06:19:30 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991', 06:19:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:30 INFO - '_': '/tools/buildbot/bin/python'} 06:19:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:19:30 INFO - Cleaning up... 06:19:30 INFO - Return code: 0 06:19:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:19:30 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')]} 06:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:30 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')]} 06:19:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:30 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 0x11721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1410310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140d400>, '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 0x140e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140e840>, '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': '74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991', '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 06:19:30 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 06:19:30 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 06:19:30 INFO - Using env: {'DISPLAY': ':0', 06:19:30 INFO - 'HOME': '/home/cltbld', 06:19:30 INFO - 'LANG': 'en_US.UTF-8', 06:19:30 INFO - 'LANGUAGE': 'en_US:en', 06:19:30 INFO - 'LOGNAME': 'cltbld', 06:19:30 INFO - 'MAIL': '/var/mail/cltbld', 06:19:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:30 INFO - 'MOZ_NO_REMOTE': '1', 06:19:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:30 INFO - 'NO_EM_RESTART': '1', 06:19:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:30 INFO - 'PWD': '/builds/slave/test', 06:19:30 INFO - 'SHELL': '/bin/bash', 06:19:30 INFO - 'SHLVL': '1', 06:19:30 INFO - 'TERM': 'linux', 06:19:30 INFO - 'TMOUT': '86400', 06:19:30 INFO - 'USER': 'cltbld', 06:19:30 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991', 06:19:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:30 INFO - '_': '/tools/buildbot/bin/python'} 06:19:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:30 INFO - Downloading/unpacking blobuploader==1.2.4 06:19: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 06:19: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 06:19: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 06:19: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 06:19: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 06:19: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 06:19:32 INFO - Downloading blobuploader-1.2.4.tar.gz 06:19:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:19:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:19:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:19:33 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 06:19:33 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 06:19:33 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 06:19:33 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 06:19:33 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 06:19:33 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 06:19:33 INFO - Downloading docopt-0.6.1.tar.gz 06:19:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:19:33 INFO - Installing collected packages: blobuploader, requests, docopt 06:19:33 INFO - Running setup.py install for blobuploader 06:19:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:19:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:19:33 INFO - Running setup.py install for requests 06:19:33 INFO - Running setup.py install for docopt 06:19:33 INFO - Successfully installed blobuploader requests docopt 06:19:33 INFO - Cleaning up... 06:19:33 INFO - Return code: 0 06:19:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:19:33 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')]} 06:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:33 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')]} 06:19:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:33 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 0x11721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1410310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140d400>, '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 0x140e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140e840>, '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': '74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991', '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 06:19:33 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 06:19:33 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 06:19:33 INFO - Using env: {'DISPLAY': ':0', 06:19:33 INFO - 'HOME': '/home/cltbld', 06:19:33 INFO - 'LANG': 'en_US.UTF-8', 06:19:33 INFO - 'LANGUAGE': 'en_US:en', 06:19:33 INFO - 'LOGNAME': 'cltbld', 06:19:33 INFO - 'MAIL': '/var/mail/cltbld', 06:19:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:33 INFO - 'MOZ_NO_REMOTE': '1', 06:19:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:33 INFO - 'NO_EM_RESTART': '1', 06:19:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:33 INFO - 'PWD': '/builds/slave/test', 06:19:33 INFO - 'SHELL': '/bin/bash', 06:19:33 INFO - 'SHLVL': '1', 06:19:33 INFO - 'TERM': 'linux', 06:19:33 INFO - 'TMOUT': '86400', 06:19:33 INFO - 'USER': 'cltbld', 06:19:33 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991', 06:19:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:33 INFO - '_': '/tools/buildbot/bin/python'} 06:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:19:34 INFO - Running setup.py (path:/tmp/pip-Z71guc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:19:34 INFO - Running setup.py (path:/tmp/pip-wTHDXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:19:34 INFO - Running setup.py (path:/tmp/pip-pJBq4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:19:34 INFO - Running setup.py (path:/tmp/pip-BxhOY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:19:34 INFO - Running setup.py (path:/tmp/pip-0nNHnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:19:34 INFO - Running setup.py (path:/tmp/pip-rJeVgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:19:34 INFO - Running setup.py (path:/tmp/pip-7PAf8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:19:34 INFO - Running setup.py (path:/tmp/pip-pYs3xA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:19:34 INFO - Running setup.py (path:/tmp/pip-_vNG9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:19:34 INFO - Running setup.py (path:/tmp/pip-Y_bdFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:19:34 INFO - Running setup.py (path:/tmp/pip-SS9yIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:19:34 INFO - Running setup.py (path:/tmp/pip-iIj04E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:19:35 INFO - Running setup.py (path:/tmp/pip-PxdKfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:19:35 INFO - Running setup.py (path:/tmp/pip-gqKYrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:19:35 INFO - Running setup.py (path:/tmp/pip-4Q3OjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:19:35 INFO - Running setup.py (path:/tmp/pip-JFtIcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:19:35 INFO - Running setup.py (path:/tmp/pip-Llb96w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:19:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:19:35 INFO - Running setup.py install for manifestparser 06:19:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:19:35 INFO - Running setup.py install for mozcrash 06:19:35 INFO - Running setup.py install for mozdebug 06:19:35 INFO - Running setup.py install for mozdevice 06:19:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:19:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:19:35 INFO - Running setup.py install for mozfile 06:19:35 INFO - Running setup.py install for mozhttpd 06:19:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:19:36 INFO - Running setup.py install for mozinfo 06:19:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:19:36 INFO - Running setup.py install for mozInstall 06:19:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:19:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:19:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:19:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:19:36 INFO - Running setup.py install for mozleak 06:19:36 INFO - Running setup.py install for mozlog 06:19:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:19:36 INFO - Running setup.py install for moznetwork 06:19:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:19:36 INFO - Running setup.py install for mozprocess 06:19:36 INFO - Running setup.py install for mozprofile 06:19:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:19:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:19:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:19:36 INFO - Running setup.py install for mozrunner 06:19:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:19:36 INFO - Running setup.py install for mozscreenshot 06:19:37 INFO - Running setup.py install for moztest 06:19:37 INFO - Running setup.py install for mozversion 06:19:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:19:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:19:37 INFO - Cleaning up... 06:19:37 INFO - Return code: 0 06:19:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:37 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 0x11721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1410310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140d400>, '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 0x140e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140e840>, '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': '74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991', '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 06:19:37 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 06:19:37 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 06:19:37 INFO - Using env: {'DISPLAY': ':0', 06:19:37 INFO - 'HOME': '/home/cltbld', 06:19:37 INFO - 'LANG': 'en_US.UTF-8', 06:19:37 INFO - 'LANGUAGE': 'en_US:en', 06:19:37 INFO - 'LOGNAME': 'cltbld', 06:19:37 INFO - 'MAIL': '/var/mail/cltbld', 06:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:37 INFO - 'MOZ_NO_REMOTE': '1', 06:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:37 INFO - 'NO_EM_RESTART': '1', 06:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:37 INFO - 'PWD': '/builds/slave/test', 06:19:37 INFO - 'SHELL': '/bin/bash', 06:19:37 INFO - 'SHLVL': '1', 06:19:37 INFO - 'TERM': 'linux', 06:19:37 INFO - 'TMOUT': '86400', 06:19:37 INFO - 'USER': 'cltbld', 06:19:37 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991', 06:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:37 INFO - '_': '/tools/buildbot/bin/python'} 06:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:19:37 INFO - Running setup.py (path:/tmp/pip-EIChoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:19:37 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)) 06:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:19:37 INFO - Running setup.py (path:/tmp/pip-t7HIfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:19:37 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)) 06:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:19:37 INFO - Running setup.py (path:/tmp/pip-g09RZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:19:37 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)) 06:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:19:37 INFO - Running setup.py (path:/tmp/pip-l6q0_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:19:37 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)) 06:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:19:37 INFO - Running setup.py (path:/tmp/pip-tuRNxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:19:37 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)) 06:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:19:37 INFO - Running setup.py (path:/tmp/pip-amr93p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:19:37 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)) 06:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:19:37 INFO - Running setup.py (path:/tmp/pip-MvagTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:19:37 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)) 06:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:19:37 INFO - Running setup.py (path:/tmp/pip-VoEqW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:19:38 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)) 06:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:19:38 INFO - Running setup.py (path:/tmp/pip-J7vrRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:19:38 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)) 06:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:19:38 INFO - Running setup.py (path:/tmp/pip-X28doZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:19:38 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)) 06:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:19:38 INFO - Running setup.py (path:/tmp/pip-Aw8ALC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:19:38 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)) 06:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:19:38 INFO - Running setup.py (path:/tmp/pip-AcR4Ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:19:38 INFO - Running setup.py (path:/tmp/pip-zrCSyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:19:38 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)) 06:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:19:38 INFO - Running setup.py (path:/tmp/pip-Vnchcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:19:38 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)) 06:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:19:38 INFO - Running setup.py (path:/tmp/pip-PcNgfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:19:38 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)) 06:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:19:38 INFO - Running setup.py (path:/tmp/pip-sAlBO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:19:38 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)) 06:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:19:38 INFO - Running setup.py (path:/tmp/pip-ueILwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:19:38 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)) 06:19:38 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)) 06:19:38 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)) 06:19:38 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)) 06:19:38 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)) 06:19:38 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)) 06:19:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:40 INFO - Downloading blessings-1.6.tar.gz 06:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:19:40 INFO - Installing collected packages: blessings 06:19:40 INFO - Running setup.py install for blessings 06:19:40 INFO - Successfully installed blessings 06:19:40 INFO - Cleaning up... 06:19:40 INFO - Return code: 0 06:19:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:19:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:19:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:19:41 INFO - Reading from file tmpfile_stdout 06:19:41 INFO - Current package versions: 06:19:41 INFO - argparse == 1.2.1 06:19:41 INFO - blessings == 1.6 06:19:41 INFO - blobuploader == 1.2.4 06:19:41 INFO - docopt == 0.6.1 06:19:41 INFO - functools32 == 3.2.3-2 06:19:41 INFO - jsonschema == 2.5.1 06:19:41 INFO - manifestparser == 1.1 06:19:41 INFO - mozInstall == 1.12 06:19:41 INFO - mozcrash == 1.0 06:19:41 INFO - mozdebug == 0.1 06:19:41 INFO - mozdevice == 0.49 06:19:41 INFO - mozfile == 1.2 06:19:41 INFO - mozhttpd == 0.7 06:19:41 INFO - mozinfo == 0.9 06:19:41 INFO - mozleak == 0.1 06:19:41 INFO - mozlog == 3.4 06:19:41 INFO - moznetwork == 0.27 06:19:41 INFO - mozprocess == 0.25 06:19:41 INFO - mozprofile == 0.28 06:19:41 INFO - mozrunner == 6.13 06:19:41 INFO - mozscreenshot == 0.1 06:19:41 INFO - mozsystemmonitor == 0.3 06:19:41 INFO - moztest == 0.8 06:19:41 INFO - mozversion == 1.4 06:19:41 INFO - psutil == 3.1.1 06:19:41 INFO - requests == 1.2.3 06:19:41 INFO - wsgiref == 0.1.2 06:19:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:41 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 0x11721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1410310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140d400>, '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 0x140e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140e840>, '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': '74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991', '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 06:19:41 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 06:19:41 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 06:19:41 INFO - Using env: {'DISPLAY': ':0', 06:19:41 INFO - 'HOME': '/home/cltbld', 06:19:41 INFO - 'LANG': 'en_US.UTF-8', 06:19:41 INFO - 'LANGUAGE': 'en_US:en', 06:19:41 INFO - 'LOGNAME': 'cltbld', 06:19:41 INFO - 'MAIL': '/var/mail/cltbld', 06:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:41 INFO - 'MOZ_NO_REMOTE': '1', 06:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:41 INFO - 'NO_EM_RESTART': '1', 06:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:41 INFO - 'PWD': '/builds/slave/test', 06:19:41 INFO - 'SHELL': '/bin/bash', 06:19:41 INFO - 'SHLVL': '1', 06:19:41 INFO - 'TERM': 'linux', 06:19:41 INFO - 'TMOUT': '86400', 06:19:41 INFO - 'USER': 'cltbld', 06:19:41 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991', 06:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:41 INFO - '_': '/tools/buildbot/bin/python'} 06:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:41 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)) 06:19:41 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)) 06:19:41 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)) 06:19:41 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)) 06:19:41 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)) 06:19:41 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)) 06:19:41 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)) 06:19:41 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)) 06:19:41 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)) 06:19:41 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)) 06:19:41 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)) 06:19:41 INFO - Cleaning up... 06:19:41 INFO - Return code: 0 06:19:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:41 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 0x11721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1410310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140d400>, '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 0x140e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140e840>, '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': '74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991', '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 06:19:41 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 06:19:41 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 06:19:41 INFO - Using env: {'DISPLAY': ':0', 06:19:41 INFO - 'HOME': '/home/cltbld', 06:19:41 INFO - 'LANG': 'en_US.UTF-8', 06:19:41 INFO - 'LANGUAGE': 'en_US:en', 06:19:41 INFO - 'LOGNAME': 'cltbld', 06:19:41 INFO - 'MAIL': '/var/mail/cltbld', 06:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:41 INFO - 'MOZ_NO_REMOTE': '1', 06:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:41 INFO - 'NO_EM_RESTART': '1', 06:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:41 INFO - 'PWD': '/builds/slave/test', 06:19:41 INFO - 'SHELL': '/bin/bash', 06:19:41 INFO - 'SHLVL': '1', 06:19:41 INFO - 'TERM': 'linux', 06:19:41 INFO - 'TMOUT': '86400', 06:19:41 INFO - 'USER': 'cltbld', 06:19:41 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991', 06:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:41 INFO - '_': '/tools/buildbot/bin/python'} 06:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:19:41 INFO - Cleaning up... 06:19:41 INFO - Return code: 0 06:19:41 INFO - Running post-action listener: _resource_record_post_action 06:19:41 INFO - Running post-action listener: _start_resource_monitoring 06:19:41 INFO - Starting resource monitoring. 06:19:41 INFO - [mozharness: 2017-04-08 13:19:41.684887Z] Finished create-virtualenv step (success) 06:19:41 INFO - [mozharness: 2017-04-08 13:19:41.685401Z] Running install step. 06:19:41 INFO - Running pre-action listener: _resource_record_pre_action 06:19:41 INFO - Running main action method: install 06:19:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:19:41 INFO - Reading from file tmpfile_stdout 06:19:41 INFO - Detecting whether we're running mozinstall >=1.0... 06:19:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:19:41 INFO - Reading from file tmpfile_stdout 06:19:41 INFO - Output received: 06:19:41 INFO - Usage: mozinstall [options] installer 06:19:41 INFO - Options: 06:19:41 INFO - -h, --help show this help message and exit 06:19:41 INFO - -d DEST, --destination=DEST 06:19:41 INFO - Directory to install application into. [default: 06:19:41 INFO - "/builds/slave/test"] 06:19:41 INFO - --app=APP Application being installed. [default: firefox] 06:19:41 INFO - mkdir: /builds/slave/test/build/application 06:19:41 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'] 06:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:19:58 INFO - Reading from file tmpfile_stdout 06:19:58 INFO - Output received: 06:19:58 INFO - /builds/slave/test/build/application/firefox/firefox 06:19:58 INFO - Running post-action listener: _resource_record_post_action 06:19:58 INFO - [mozharness: 2017-04-08 13:19:58.548611Z] Finished install step (success) 06:19:58 INFO - [mozharness: 2017-04-08 13:19:58.548756Z] Running run-tests step. 06:19:58 INFO - Running pre-action listener: _resource_record_pre_action 06:19:58 INFO - Running main action method: run_tests 06:19:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:19:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:19:58 INFO - Python 2.7.3 06:19:58 INFO - Return code: 0 06:19:58 INFO - grabbing minidump binary from tooltool 06:19:58 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')]} 06:19:58 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 0x140d400>, '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 0x140e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140e840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:19:58 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 06:19:58 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 06:19:58 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 06:19:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:19:58 INFO - Return code: 0 06:19:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:19:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:19:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:19:58 INFO - ENV: RUST_BACKTRACE is now 1 06:19:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:19:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:19:58 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/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 06:19:58 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/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 06:19:58 INFO - Using env: {'DISPLAY': ':0', 06:19:58 INFO - 'HOME': '/home/cltbld', 06:19:58 INFO - 'LANG': 'en_US.UTF-8', 06:19:58 INFO - 'LANGUAGE': 'en_US:en', 06:19:58 INFO - 'LOGNAME': 'cltbld', 06:19:58 INFO - 'MAIL': '/var/mail/cltbld', 06:19:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:19:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:58 INFO - 'MOZ_NO_REMOTE': '1', 06:19:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:19:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:58 INFO - 'NO_EM_RESTART': '1', 06:19:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:58 INFO - 'PWD': '/builds/slave/test', 06:19:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:19:58 INFO - 'RUST_BACKTRACE': '1', 06:19:58 INFO - 'SHELL': '/bin/bash', 06:19:58 INFO - 'SHLVL': '1', 06:19:58 INFO - 'TERM': 'linux', 06:19:58 INFO - 'TMOUT': '86400', 06:19:58 INFO - 'USER': 'cltbld', 06:19:58 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991', 06:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:58 INFO - '_': '/tools/buildbot/bin/python'} 06:19:58 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/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 06:19:58 INFO - mozversion application_buildid: 20170408074747 06:19:58 INFO - mozversion application_changeset: f6712e7858f391923006b174d27cb919c454a9ce 06:19:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:19:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:19:58 INFO - mozversion application_name: Firefox 06:19:58 INFO - mozversion application_remotingname: firefox-dev 06:19:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:19:58 INFO - mozversion application_vendor: Mozilla 06:19:58 INFO - mozversion application_version: 54.0a2 06:19:58 INFO - mozversion platform_buildid: 20170408074747 06:19:58 INFO - mozversion platform_changeset: f6712e7858f391923006b174d27cb919c454a9ce 06:19:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:19:58 INFO - mozversion platform_version: 54.0a2 06:19:58 INFO - using testdate: 1491657598 06:19:58 INFO - actual date: 1491657598 06:19:58 INFO - starting webserver on 'localhost:37826' 06:19:58 INFO - SUITE-START | Running 2 tests 06:19:58 INFO - TEST-START | dromaeo_css 06:19:58 INFO - operating with platform_type : linux_ 06:19:58 INFO - Initialising browser for dromaeo_css test... 06:19:58 INFO - TEST-INFO | started process 4414 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyS90gT/profile http://localhost:37826/getInfo.html) 06:20:02 INFO - PROCESS | 4414 | __metrics Screen width/height:1600/1200 06:20:02 INFO - PROCESS | 4414 | colorDepth:24 06:20:02 INFO - PROCESS | 4414 | Browser inner width/height: 1024/697 06:20:02 INFO - PROCESS | 4414 | __metrics 06:20:03 INFO - PROCESS | 4414 | 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" 06:20:03 INFO - PROCESS | 4414 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:20:04 INFO - TEST-INFO | 4414: exit 0 06:20:04 INFO - Browser initialized. 06:20:04 INFO - Running cycle 1/1 for dromaeo_css test... 06:20:04 INFO - TEST-INFO | started process 4508 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyS90gT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:20:16 INFO - PROCESS | 4508 | RSS: Main: 139907072 06:20:16 INFO - PROCESS | 4508 | 06:23:18 INFO - PROCESS | 4508 | Cycle 1(1): loaded http://localhost:37826/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37826/tests/dromaeo/cssquery-ext.html) 06:23:20 INFO - PROCESS | 4508 | RSS: Main: 273018880 06:23:20 INFO - PROCESS | 4508 | 06:25:06 INFO - PROCESS | 4508 | ************************* 06:25:06 INFO - PROCESS | 4508 | A coding exception was thrown and uncaught in a Task. 06:25:06 INFO - PROCESS | 4508 | 06:25:06 ERROR - PROCESS | 4508 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:25:06 INFO - PROCESS | 4508 | Full stack: 06:25:06 INFO - PROCESS | 4508 | ************************* 06:25:06 INFO - PROCESS | 4508 | ************************* 06:25:06 INFO - PROCESS | 4508 | A coding exception was thrown and uncaught in a Task. 06:25:06 INFO - PROCESS | 4508 | 06:25:06 ERROR - PROCESS | 4508 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:25:06 INFO - PROCESS | 4508 | Full stack: 06:25:06 INFO - PROCESS | 4508 | ************************* 06:25:06 INFO - PROCESS | 4508 | ************************* 06:25:06 INFO - PROCESS | 4508 | A coding exception was thrown and uncaught in a Task. 06:25:06 INFO - PROCESS | 4508 | 06:25:06 ERROR - PROCESS | 4508 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:25:06 INFO - PROCESS | 4508 | Full stack: 06:25:06 INFO - PROCESS | 4508 | ************************* 06:25:06 INFO - PROCESS | 4508 | ************************* 06:25:06 INFO - PROCESS | 4508 | A coding exception was thrown and uncaught in a Task. 06:25:06 INFO - PROCESS | 4508 | 06:25:06 ERROR - PROCESS | 4508 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:25:06 INFO - PROCESS | 4508 | Full stack: 06:25:06 INFO - PROCESS | 4508 | ************************* 06:26:22 INFO - PROCESS | 4508 | Cycle 1(1): loaded http://localhost:37826/tests/dromaeo/cssquery-ext.html (next: http://localhost:37826/tests/dromaeo/cssquery-jquery.html) 06:26:22 INFO - PROCESS | 4508 | RSS: Main: 219222016 06:26:22 INFO - PROCESS | 4508 | 06:29:24 INFO - PROCESS | 4508 | Cycle 1(1): loaded http://localhost:37826/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37826/tests/dromaeo/cssquery-mootools.html) 06:29:25 INFO - PROCESS | 4508 | RSS: Main: 211410944 06:29:25 INFO - PROCESS | 4508 | 06:32:27 INFO - PROCESS | 4508 | Cycle 1(1): loaded http://localhost:37826/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37826/tests/dromaeo/cssquery-prototype.html) 06:32:28 INFO - PROCESS | 4508 | RSS: Main: 170725376 06:32:28 INFO - PROCESS | 4508 | 06:35:30 INFO - PROCESS | 4508 | Cycle 1(1): loaded http://localhost:37826/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37826/tests/dromaeo/cssquery-yui.html) 06:35:31 INFO - PROCESS | 4508 | RSS: Main: 177364992 06:35:31 INFO - PROCESS | 4508 | 06:38:33 INFO - PROCESS | 4508 | Cycle 1(1): loaded http://localhost:37826/tests/dromaeo/cssquery-yui.html (next: http://localhost:37826/tests/dromaeo/cssquery-dojo.html) 06:38:34 INFO - PROCESS | 4508 | RSS: Main: 258347008 06:38:34 INFO - PROCESS | 4508 | 06:38:34 INFO - PROCESS | 4508 | __start_tp_report 06:38:34 INFO - PROCESS | 4508 | _x_x_mozilla_page_load 06:38:34 INFO - PROCESS | 4508 | _x_x_mozilla_page_load_details 06:38:34 INFO - PROCESS | 4508 | |i|pagename|runs| 06:38:34 INFO - PROCESS | 4508 | |0;dojo.html;3398.0315610051157;3415.112070861576;3436.7594268401213;3467.531883195771;3493.598236202836;5710.114932185513;5715.3998830122755;5723.341815691197;5784.103463963082;5804.0423330150525;5721.170430287616;5766.625169363989;5784.132380142981;5791.913121303173;5801.129830525413;5187.118189907725;5203.713795741232;5226.608004399666;5235.973820130894;5237.580993520528;4996.375453068366;5023.346964894558;5044.545990860822;5238.68567885928;5252.606054545905;5132.358455193101;5152.922706159392;5155.9484405155845;5174.094533456649;5238.764255608507;5227.503387178212;5227.895442091175;5231.398389185235;5235.267062611199;5251.422343542207;4924.138275801756;5005.399352077774;5137;5143.897122057538;5214.270002199695;5631.211630371751;5634.971825140889;5661.34894487131;5699.2306038684665;5710.600257981943;6126.417990290915;6160.260768707739;6171.660558669271;6175;6178.5366097542865;5922.141289512996;6204.255489341263;6224.221972253468;6225.595336303126;6232.501399887998;5649.378568357477;5722.313322401338;5760.2511673482595;5762.567807414461;5770.336411312669;6289.7484100636375;6319.8104056878365;6326.177596912372;6328.810135695844;6330.651814150266;6048.9697551512845;6099.542534309944;6115.449609535163;6115.571909966348;6117.327094019654;5942.970285148546;5963.910541341883;6090.056041313604;6117.632942023492;6127.172831667668;6131.6213479391645;6187.597806142587;6189.04069869171;6190.535709821781;6198.721057552421;5973.522118230531;6001.5198784097165;6011.699415029231;6047.667378294148;6051.062085376773;4662.230731929261;4700.600448961876;4721.95278047222;4725.480197178307;4726.1492931272705;4197.9370309445385;4205.411242426063;4218.029853133735;4231.513375961804;4258.829646814154;5712.485876271156;5752.36723960364;5880.206172166788;5921.496672782776;5999.220101386792;6275.3724627536885;6278.6546739929745;6287.937120628827;6290;6300.464460520815;5971.0744834550715;5994.790182343684;5997.100434934708;5999.430054144849;6026.879462410728;5100.056489549445;5118.923216151761;5189;5227.738613069331;5278.788848446096;6440.871182576416;6469.061986012002;6484.416402523795;6486.44865186455;6489.091527186198;6195;6216.751329946932;6231.781887633911;6232.283287421823;6235.563510554218;6145.723442445012;6209.844753881189;6336.9049464259;6494.805155845333;6507.707153178024;6119.258838874149;6155.384461553988;6169.84575385619;6170.53720970938;6175.104609831639;6243;6244.5316601256;6250.156228909039;6251.812445626639;6257.43683068526;5764.221830052889;5867.911981320198;6102.694865256631;6108.908366374597;6110.991686371876;5975.671338076274;5983.341832398346;6076.848078798065;6087.36082711309;6127.3566275540425;6023.66869822164;6072.635641861502;6072.878542429038;6074.1799857020505;6075.210222671025;5827.4172582741385;5859.150423188528;5895.469407753323;5897.734601942837;6116.113163591165;5871.823845284648;5903.704814759159;5999.370066142992;6000.519958403404;6007.098935159761 06:38:34 INFO - PROCESS | 4508 | |1;ext.html;732.1982429239984;803.6905791270361;818.181818181818;897.058089006543;906.1889608800128;31907;44689.77655111724;45702.08595828081;45733.77133114338;45752.33981281498;45972;46181.30728039082;46221.76889115558;46265.76867115668;46269.76865115669;7672.578008209546;7871.252231038071;8981.146791054856;9145.954270228673;9153.08469153086;10777.515011824447;11051.502682379272;11292.943535282353;11325.603603873866;11328.49021794017;11010.174236932222;11041.83437248442;11052.557897684082;11064.05955493784;11064.391458469781;10894.727631809188;10898.346099234072;10986.560537578487;11000.339979601249;11004.944975275112;10073.093421592092;10088.596456141746;10136.949315253376;10141.949290253575;10184;42800;42971.570284297384;43248.783756081335;43308;43367.783161084306;4272.188284225987;4303.203907277132;4324.35134729793;4397.956020439787;4452.265376212921;29685.851570742223;30337.241568960733;30539;31014.84492577545;31334.843325783455;4403.713758605681;4408.20652282589;4466.486354069291;4527.7056991295785;4634.420697412824;225400.99999999837;226048;226057;226456;228090;54006;54101.72949135308;54124.188137177975;54215.45784542183;54241.45758542364;55992.44007559954;56132.71933640305;56166;56203;56221.43778562162;16332.918335408247;16595.253213605418;16665.750013749803;16666.749998750027;16668.249928753234;13079.738405231841;13170.670733231746;14631.195284259467;14647.340869660678;14658.340374683165;13037.608871733863;13457;13783.793243101361;13795.586132416043;13928.164310141425;5400.21696853954;5463.426340234298;5491.670499770026;5516.558675305966;5619.072852979212;1012.3318609717551;1016.5832008876325;1020.6325722739808;1029.1869423155624;1030.0935177044153;28448.857755711502;28499.430011399654;28617.713822861504;28989.56515652267;29061.85469072641;1059.5338051257422;1073.5491093740648;1095.6767753512734;1098.3464838421128;1102.47081400928;14386.28068596566;15245.847541524443;15268.816129467583;15426.84573154254;15531.456399026205;284904;285364.14635853376;286134;286397;286715;57017.14474282889;57036;57089.42910570841;57159.428405716244;57274.42725572691;1498.4605542005088;1498.5504348695347;1505.631120375493;1531.4180611367608;1551.937922483088;25670.61494077628;26850.731492684823;26853.328666783487;26987.460250795266;27091.864540677172;25507.872460638322;25544.23367298984;25544.489110218063;25553.744462555136;25564.74435255698;258686;259705;259922;259995;260539;29974;30657.54013689841;33731.32537349288;35620;35742.821285893406;44802.55197447984;44831.551684482736;45112.77443612761;45405.77297113493;46027.3095903555;34011.31977360488;34123.65876341304;34151;34191.31617367688;34371.828140859136;33748.662513374555;34059.65940340565;34143.317133657685;34359.31281374308;34420.96737097891;37075;37524.812375937945;38219.23561528698;38768;39110.41334379929;30614.84692576523;30757.23106922345;31043.379132416772;31089.37821243517;31894.52158217582;23956.88021559881;24482.877585611957;25034;25361.746382536676;25445.491090178464 06:38:34 INFO - PROCESS | 4508 | |2;jquery.html;458.31939569738955;463.4253525628222;480.0878331170773;485.16309366343063;498.46166140568187;19646.312379066734;21313.254036108738;21825.454363640918;22208.00063997122;22476.43808904778;22556.32331030072;22729.431764205903;22786.31641050767;22948.196813111543;23028.19401320954;6637.336266373361;6681.766138185165;6834.897476537856;6844.041834143224;6851.794446166623;6780;6889.345512176335;6895.620740859251;7039.472039597025;7344.8898266525775;7519.097708274987;7521.398288136963;7527.2849079337375;7533.510321829091;7540.622968851563;7294.234105418935;7404.518706284101;7443.962780186119;7448.36688881443;7452.993845830798;7083.256258092878;7255.2744725527555;7340.339369456775;7381.926180738231;7397.963010184914;25378.619320710204;25492.36269093269;25559.48881022369;25887.0939517116;26068.73931260682;3041.5437684347303;3195.2810617610853;3379.915502112467;3472.4791281308007;3572.4462708280257;16293.51119466418;16323.51029469106;16448.588785280343;16455.09496977666;16973.811833171683;2200.0979598364593;2217.5675743230076;2227.955440891173;2252.954940901173;2267.5238199978025;111592;115987.42006290083;117278;121869.39065304617;126416;17694.823051769574;18176.364427157987;18464.261429542938;18527.907360463112;18667.439976800717;32510.024699259062;32526.83736581302;32537.674623253937;32540.186495337806;32587;10149.289549731448;10237.334573252714;10401.635942741968;10425.843612345821;10661.466926653637;8705.782355441039;8762.737117886474;8833.823323533494;9040.8643870342;9078.182963533314;9244.630214791467;9342.859857102148;9398.90601093994;9491.532201627626;9534.332596718163;3271.9509207361907;3335.6664333566932;3552.87564935226;3600.9099772505374;3723.8130408312218;933.2580598424133;946.3612061858356;951.1439704266215;953.7329547726648;962.4946902876046;19744.70382944257;21038;21134.260300889397;21247;21407.124402725243;955.0926619711302;1060.6022741471947;1115.6318414923219;1120.9607663731892;1144.101880024177;7033;7119.181294151239;7326.3406293433845;7365.968764372992;7477.401807855358;573934;578009;593750;616763;625749;84237;84883.90664616991;92923.53538232266;119781;124013;1315.6776589735575;1351.1015174908773;1367.2958426410407;1369.7260547890462;1380.0132904972993;17662.911685442006;18273;18803.751177851722;19074.237030518623;19357.03214839224;48663.756681216364;50560;51530;51946.740266298424;52363.47636523738;66723.66638166778;66835.66582167058;67157.3284267151;68363.3163668357;68658.65670671615;12423.813642795547;12636.494540218288;12641.178323408949;12651.114421990373;12757.425915833996;12823.679408014501;13000;13004.674883127618;13205.735885282049;13295.933520332337;11596.88403115958;11609.825852612048;11616.12879034059;11754.11844111678;12017.218880772722;10816.296940698829;10867.782644346911;10908.509117089909;11046.723831904266;11406.201565890307;11608.129390295593;11611.361375124448;11716;11739.354335511629;11789.469473873867;12808.103432759617;12873.163244389085;12991.675208119872;13052.15161014569;13312.400941957441;11108.44457777124;11341.773164536828;11762.941185294361;11786.705332366417;11885.76228475443 06:38:34 INFO - PROCESS | 4508 | |3;mootools.html;1557.9922100389497;1568.5764843492257;1574.110627495465;1584.0970646731353;1589.6741168060548;10861.619843305485;11402.087832973342;11409.885901140997;11507;11518.942405287962;11349.20555561111;11447.198696091276;11641.650750477478;11644.883551164507;11770.588029418972;2505.348609361561;2539.999999999991;2542.4915016996583;2543.224316583441;2544.402065514603;2456.5946618807875;2508.347829564317;2551.4769472258236;2562.397836508419;2567.1271767599014;2421.7093948726088;2491.476789874129;2529.519391315653;2531.8101142414394;2537.619357096432;2345.5543446745064;2390.7370189279254;2398.70016247969;2418.250342393846;2449.9265022049367;2334.101370972171;2374.8456350337174;2379.1553998330514;2397.496525729599;2398.6641870138196;11257.605983790529;11541.365224912626;11546.653600391917;11555.711107222303;11556.479958401893;5788.334341550733;5964.284285885678;5972.761089556412;5974.193483879664;5979.910301345483;3417.4532074868152;3485.3900567400856;3485.89542313731;3533.169705119295;3549.982250088759;1347.2994043097535;1355.6068740065368;1358.830146231721;1398.8878841321175;1398.930053497321;17117.058561779097;17525;17874.46376608704;18117.18472668733;18349.449516514527;4837.733924634179;4842.080004799077;4883.731394773251;4885.022995400863;5013.774380152902;12803.551875684307;12872.16330938486;12883.420246088948;12888.548900788615;12900.548480803127;5965.194698715704;5968.522518198533;5970.582059255898;5972.611780234271;5987.2815262168815;5393.865153371197;5409.486098820606;5434.972825135849;5452.236686863842;5502.202180683778;4077.348673787121;4133.958660413417;4169.862631615606;4196.664266858644;4214.7471151731;1071.2822408985999;1078.6440474643348;1079.8866119057543;1088.7768007558432;1090.9127269818396;1060.671191930504;1066.8186408310605;1075;1076.1283360478037;1083.5719890643309;7163.713451461883;7179.569225846466;7207.1891962134805;7210.67551960163;7293.927060729431;1013.506773337583;1016.6086056868011;1028.6502589119734;1033.1528146919454;1055.1875056206677;4519.254323036662;4734;4912.533309335608;4962.280469331927;5060.468650791614;14495.782563261559;14903.776443353358;14929.552113436614;14943.476978305707;15054.473093441677;13558.186508809504;13925.651858703412;14760;14792.11247325164;14799.926000370144;9125.589348479334;9373.62505499786;10335.328203666888;10512.264141510173;10579.259451838298;6972.616506092214;7097.609631470319;7268.636568171464;7386.852262954818;7409.851802964018;13183.472661093449;13354.399052042487;13427.731445371233;13563.457461701422;13617.79573306421;13450.192988420335;13577.049606527844;13628.454861805416;13808.585742427744;13819.79270310926;9728.416295022322;9881.851772223567;10039.34744241622;10045.598176073168;10051;10659.733506662396;10709.625163119254;10857.185711071543;10864.945675271572;10872.021518063413;8975.596098175467;9132.726018219464;9252.398594091363;9301.581428835854;9417.387869788441;8932.732018039469;9097.954510227406;9177.587008584764;9251.213646840093;9383.296252781205;8461.661533538836;8523.48859068458;8669.349798764992;8669.783255418664;8672.176143266379;6351.2060992375955;6430.549861509649;6442.226932768098;6491;6598.241202261801;6285;6289.276733175743;6289.40250676185;6382;6449.258335291502 06:38:34 INFO - PROCESS | 4508 | |4;prototype.html;411.8187005383414;416.0493272871489;422.79494445194075;425.19850082594337;428.6977680735082;5400.648957817739;5407.891842163154;5428.674279543226;5429.669730915931;5443.842571308636;5109.591232701384;5238.423773384925;5246.7901283948595;5255.632105752599;5287.603429742765;4248.214080395129;4256.723312984662;4261.019965407958;4267.231898258312;4276.935845962313;4222.345536441841;4241;4251.659867210616;4273.7008409411355;4275.722078064916;4091.2226676931286;4205.747655140686;4214.789260536961;4222.894427639319;4257.659387249028;4222.831086756526;4237.660987121023;4245.745255284693;4252.170826688797;4255.936160957557;3880.428426487277;3891.754638515676;3898.064464528493;3900.1224724437056;3911.550171730259;5012.824551140692;5140.897182056338;5182.5594824439595;5226.830865190941;5246.37043554772;4952.217201807346;4960.603151747851;4965.255211718271;4970.676906001098;4986.40163180417;5564.248826408423;5580.497755202011;5594.664320140804;5597.244372009767;5599.104143337087;4102.46677421448;4229.577042295777;4308.82764689412;4317;4317.179735850178;5482.780688772445;5674.602777805555;5783.942160578383;5796.449337312949;5837.270341207349;4819.807207711722;4842.176829938919;4842.927356089662;4860.6111511079025;4999.700017998932;5037.949620503821;5064.82273120439;5079.831638723114;5098.50173415024;5099.745012749348;5083.61872859537;5201.895962080737;5245.816396426107;5301.496357845998;5350.438203988603;5542.612017158841;5545.72271386429;5550.528205102531;5565.497315724812;5576.191452239403;1760.4542591796328;1763.9470815875545;1765.4993255732525;1771.8671099667577;1787.2672204396135;1234.7839128152536;1275.6109386636979;1288.0339745191106;1306.5231190615548;1435.9210243436503;5278.31094049908;5299.947000529945;5328.893422131536;5427.402985671573;5432.239486471897;5635;5690.573207009408;5724.0538217006415;5791.913121303184;5801.8549536261935;5138.922916156261;5327.227552005015;5359.464053594687;5377.005254028018;5398.217258497496;2998.7151220634005;3013.7246378983727;3036.952251473238;3037.164779685604;3044.8477576121104;5690.943090569124;5834.766609335664;5957.314908785545;5988.9401105989255;5994.580379373402;5864.70676466175;5868.677222752704;5878.853028674317;5884.264466941632;5900.822975310747;5997.760089596454;6003.399660034049;6010.579259451796;6017.578769486094;6022;5515.255440515479;5688.288963879515;5702;5726.627769194989;5743.3395159557185;5462.371827239918;5624.437556244343;5659.915101273402;5671.922334756383;5706.8573285666525;5841.4450627190345;5939.91090133657;5960.672163030901;5979.252593425822;5999.860026594933;4696.131215725101;4723.173444647105;4736.526347365374;4739.431268247832;4772.95227047739;5470.808521701881;5607.691576963306;5653.925754106706;5727.308165162367;5750.597458177887;5565.693886836101;5576.91634625489;5583.581231407579;5588.580856435702;5597.188407680945;5580.586830774143;5583.218349431002;5606.074997625346;5618.747156377891;5619.634723742944;5284.286621306074;5451.672899626035;5564.527015203753;5574.498295153294;5578.748956297058;5515.09001014828;5527.336719593674;5590.5248053915875;5597.244372009726;5619.80330688424;5328.70692111922;5457.890842183214;5493.7802487900035;5520.91718624229;5533.253010843646 06:38:34 INFO - PROCESS | 4508 | |5;yui.html;830.6635812495938;839.2530647723531;910.3400034974643;915.4187091197088;942.7501712046309;16053.117078560674;16351.754723679154;16387.344506219735;16421.67156656866;16514;12999.285039322833;16036.679266414665;16163.111028893407;16168.676626467464;16185;676.056900623631;845.222395396237;866.8049688820028;871.5511511571514;872.2760109109424;882.7704796752827;887.5163036145316;891.888513935758;892.1524551675901;892.6027917576681;952.5332587032339;954.4082668745388;957.2007373842849;959.9184069354113;960.5053397500293;954.2080073538946;956.5599824080931;956.8899576548681;957.1098878043451;957.5595226195958;691.8581690753383;695.9930400695979;698.0471656189266;698.4168219536693;698.5703792167831;16839.07385093819;16877.746833797504;16894.915525422417;16904.40834570784;16955.660886782196;15131.621709457242;15400.768988465183;15442.227888605525;16651.6669666606;17091.14544272794;13793.379297931617;13909.304534773322;14195.645108872257;14386.640333991734;14641.853581464156;4046.858359957387;4117.485314335708;4133.256013917494;4205.158968206371;4283.571642835723;85564.57217713934;85706;86057.99999999937;87522.5623871883;89102.55448722714;12929.54746583865;13051.477940882449;13145.21128732279;13481.932590337181;13560.728785424433;23849.284521464382;24592.631110533355;24620.630690539656;24690.13584524533;25052.498950020898;9108.772280693036;9137.223336016381;9152.176304132527;9415.90584094164;9428.198603118675;5062.569681577107;5070.6957582545165;5126.948730512721;5243.580513558906;5304.708241046702;3484.233468636896;3589.587197472272;3614.331348700499;3618.511500947391;3638.7634803737674;597.6243688026232;600.2466904035408;603.667982609563;604.5647134063468;613.5980932489226;847.6143354773563;860.6665439512027;877.4866702978701;891.8216356728681;899.0425197164998;11482.88517114835;11782.175247732577;11957.940210298893;12254.877451225551;12505.43725532335;754.6302311867255;755.2749360613873;765.3723946363928;766.8673468879689;777.7161336112279;5539.335279766454;5555.999281164459;5681.57388195887;5711.228984087178;5724.914126288109;79287.60356198298;82208.58895705483;83307;84519;84923;43221.27114915368;43964.340534892;72627;73901.6304918472;74759.50480990458;46064;55245.44754552483;58659;61371.07943380764;61551;11714.88285117172;11780.352080635646;11872.525098995944;12047.819282710941;12162.695932601755;39520.604793951694;40346.79826600848;40748.79625601853;41073.794631026656;41175.17649646931;45733.54266457426;47529;47766.52233477621;47829;48035.75982120067;12447.128700990843;12464.314462704639;12558.874411256136;12693.80959285593;12738.490460381481;16321.836781632031;16937.745933810755;17180.742288865426;17301.56746081358;17444.91277543655;16348.67302653964;16799.664006720042;16838.158092095102;17044;17074.14629268507;14878.256087195814;14919.627009324853;15071.11611048619;15379.923100384427;15781.132037737576;14728.410863565767;15067.4726384576;15323.770143447635;15807.604809879846;15823.920880395985;10726.356418614909;11049.226554141133;11245.156613253876;11342.773144536897;11612.179232541605;11688.590899318484;11729.882701172879;12025.278483291031;12072.45673944657;12149.939250303692 06:38:34 INFO - PROCESS | 4508 | __end_tp_report 06:38:34 INFO - PROCESS | 4508 | __start_cc_report 06:38:34 INFO - PROCESS | 4508 | _x_x_mozilla_cycle_collect,1402 06:38:34 INFO - PROCESS | 4508 | __end_cc_report 06:38:34 INFO - PROCESS | 4508 | __startTimestamp1491658714193__endTimestamp 06:38:34 INFO - PROCESS | 4508 | 06:38:34 INFO - PROCESS | 4508 | ------- Summary: start ------- 06:38:34 INFO - PROCESS | 4508 | Number of tests: 6 06:38:34 INFO - PROCESS | 4508 | 06:38:34 INFO - PROCESS | 4508 | [#0] dojo.html Cycles:165 Average:5722.53 Median:5975.67 stddev:658.83 (11.0%) stddev-sans-first:635.12 06:38:34 INFO - PROCESS | 4508 | Values: 3398.0 3415.1 3436.8 3467.5 3493.6 5710.1 5715.4 5723.3 5784.1 5804.0 5721.2 5766.6 5784.1 5791.9 5801.1 5187.1 5203.7 5226.6 5236.0 5237.6 4996.4 5023.3 5044.5 5238.7 5252.6 5132.4 5152.9 5155.9 5174.1 5238.8 5227.5 5227.9 5231.4 5235.3 5251.4 4924.1 5005.4 5137.0 5143.9 5214.3 5631.2 5635.0 5661.3 5699.2 5710.6 6126.4 6160.3 6171.7 6175.0 6178.5 5922.1 6204.3 6224.2 6225.6 6232.5 5649.4 5722.3 5760.3 5762.6 5770.3 6289.7 6319.8 6326.2 6328.8 6330.7 6049.0 6099.5 6115.4 6115.6 6117.3 5943.0 5963.9 6090.1 6117.6 6127.2 6131.6 6187.6 6189.0 6190.5 6198.7 5973.5 6001.5 6011.7 6047.7 6051.1 4662.2 4700.6 4722.0 4725.5 4726.1 4197.9 4205.4 4218.0 4231.5 4258.8 5712.5 5752.4 5880.2 5921.5 5999.2 6275.4 6278.7 6287.9 6290.0 6300.5 5971.1 5994.8 5997.1 5999.4 6026.9 5100.1 5118.9 5189.0 5227.7 5278.8 6440.9 6469.1 6484.4 6486.4 6489.1 6195.0 6216.8 6231.8 6232.3 6235.6 6145.7 6209.8 6336.9 6494.8 6507.7 6119.3 6155.4 6169.8 6170.5 6175.1 6243.0 6244.5 6250.2 6251.8 6257.4 5764.2 5867.9 6102.7 6108.9 6111.0 5975.7 5983.3 6076.8 6087.4 6127.4 6023.7 6072.6 6072.9 6074.2 6075.2 5827.4 5859.2 5895.5 5897.7 6116.1 5871.8 5903.7 5999.4 6000.5 6007.1 06:38:34 INFO - PROCESS | 4508 | 06:38:34 INFO - PROCESS | 4508 | [#1] ext.html Cycles:180 Average:43164.07 Median:29829.93 stddev:67219.96 (225.3%) stddev-sans-first:67333.03 06:38:34 INFO - PROCESS | 4508 | Values: 732.2 803.7 818.2 897.1 906.2 31907.0 44689.8 45702.1 45733.8 45752.3 45972.0 46181.3 46221.8 46265.8 46269.8 7672.6 7871.3 8981.1 9146.0 9153.1 10777.5 11051.5 11292.9 11325.6 11328.5 11010.2 11041.8 11052.6 11064.1 11064.4 10894.7 10898.3 10986.6 11000.3 11004.9 10073.1 10088.6 10136.9 10141.9 10184.0 42800.0 42971.6 43248.8 43308.0 43367.8 4272.2 4303.2 4324.4 4398.0 4452.3 29685.9 30337.2 30539.0 31014.8 31334.8 4403.7 4408.2 4466.5 4527.7 4634.4 225401.0 226048.0 226057.0 226456.0 228090.0 54006.0 54101.7 54124.2 54215.5 54241.5 55992.4 56132.7 56166.0 56203.0 56221.4 16332.9 16595.3 16665.8 16666.7 16668.2 13079.7 13170.7 14631.2 14647.3 14658.3 13037.6 13457.0 13783.8 13795.6 13928.2 5400.2 5463.4 5491.7 5516.6 5619.1 1012.3 1016.6 1020.6 1029.2 1030.1 28448.9 28499.4 28617.7 28989.6 29061.9 1059.5 1073.5 1095.7 1098.3 1102.5 14386.3 15245.8 15268.8 15426.8 15531.5 284904.0 285364.1 286134.0 286397.0 286715.0 57017.1 57036.0 57089.4 57159.4 57274.4 1498.5 1498.6 1505.6 1531.4 1551.9 25670.6 26850.7 26853.3 26987.5 27091.9 25507.9 25544.2 25544.5 25553.7 25564.7 258686.0 259705.0 259922.0 259995.0 260539.0 29974.0 30657.5 33731.3 35620.0 35742.8 44802.6 44831.6 45112.8 45405.8 46027.3 34011.3 34123.7 34151.0 34191.3 34371.8 33748.7 34059.7 34143.3 34359.3 34421.0 37075.0 37524.8 38219.2 38768.0 39110.4 30614.8 30757.2 31043.4 31089.4 31894.5 23956.9 24482.9 25034.0 25361.7 25445.5 06:38:34 INFO - PROCESS | 4508 | 06:38:34 INFO - PROCESS | 4508 | [#2] jquery.html Cycles:180 Average:35622.39 Median:24203.41 stddev:98799.73 (408.2%) stddev-sans-first:99041.61 06:38:34 INFO - PROCESS | 4508 | Values: 458.3 463.4 480.1 485.2 498.5 19646.3 21313.3 21825.5 22208.0 22476.4 22556.3 22729.4 22786.3 22948.2 23028.2 6637.3 6681.8 6834.9 6844.0 6851.8 6780.0 6889.3 6895.6 7039.5 7344.9 7519.1 7521.4 7527.3 7533.5 7540.6 7294.2 7404.5 7444.0 7448.4 7453.0 7083.3 7255.3 7340.3 7381.9 7398.0 25378.6 25492.4 25559.5 25887.1 26068.7 3041.5 3195.3 3379.9 3472.5 3572.4 16293.5 16323.5 16448.6 16455.1 16973.8 2200.1 2217.6 2228.0 2253.0 2267.5 111592.0 115987.4 117278.0 121869.4 126416.0 17694.8 18176.4 18464.3 18527.9 18667.4 32510.0 32526.8 32537.7 32540.2 32587.0 10149.3 10237.3 10401.6 10425.8 10661.5 8705.8 8762.7 8833.8 9040.9 9078.2 9244.6 9342.9 9398.9 9491.5 9534.3 3272.0 3335.7 3552.9 3600.9 3723.8 933.3 946.4 951.1 953.7 962.5 19744.7 21038.0 21134.3 21247.0 21407.1 955.1 1060.6 1115.6 1121.0 1144.1 7033.0 7119.2 7326.3 7366.0 7477.4 573934.0 578009.0 593750.0 616763.0 625749.0 84237.0 84883.9 92923.5 119781.0 124013.0 1315.7 1351.1 1367.3 1369.7 1380.0 17662.9 18273.0 18803.8 19074.2 19357.0 48663.8 50560.0 51530.0 51946.7 52363.5 66723.7 66835.7 67157.3 68363.3 68658.7 12423.8 12636.5 12641.2 12651.1 12757.4 12823.7 13000.0 13004.7 13205.7 13295.9 11596.9 11609.8 11616.1 11754.1 12017.2 10816.3 10867.8 10908.5 11046.7 11406.2 11608.1 11611.4 11716.0 11739.4 11789.5 12808.1 12873.2 12991.7 13052.2 13312.4 11108.4 11341.8 11762.9 11786.7 11885.8 06:38:34 INFO - PROCESS | 4508 | 06:38:34 INFO - PROCESS | 4508 | [#3] mootools.html Cycles:180 Average:7209.53 Median:2435.82 stddev:4610.56 (189.3%) stddev-sans-first:4603.94 06:38:34 INFO - PROCESS | 4508 | Values: 1558.0 1568.6 1574.1 1584.1 1589.7 10861.6 11402.1 11409.9 11507.0 11518.9 11349.2 11447.2 11641.7 11644.9 11770.6 2505.3 2540.0 2542.5 2543.2 2544.4 2456.6 2508.3 2551.5 2562.4 2567.1 2421.7 2491.5 2529.5 2531.8 2537.6 2345.6 2390.7 2398.7 2418.3 2449.9 2334.1 2374.8 2379.2 2397.5 2398.7 11257.6 11541.4 11546.7 11555.7 11556.5 5788.3 5964.3 5972.8 5974.2 5979.9 3417.5 3485.4 3485.9 3533.2 3550.0 1347.3 1355.6 1358.8 1398.9 1398.9 17117.1 17525.0 17874.5 18117.2 18349.4 4837.7 4842.1 4883.7 4885.0 5013.8 12803.6 12872.2 12883.4 12888.5 12900.5 5965.2 5968.5 5970.6 5972.6 5987.3 5393.9 5409.5 5435.0 5452.2 5502.2 4077.3 4134.0 4169.9 4196.7 4214.7 1071.3 1078.6 1079.9 1088.8 1090.9 1060.7 1066.8 1075.0 1076.1 1083.6 7163.7 7179.6 7207.2 7210.7 7293.9 1013.5 1016.6 1028.7 1033.2 1055.2 4519.3 4734.0 4912.5 4962.3 5060.5 14495.8 14903.8 14929.6 14943.5 15054.5 13558.2 13925.7 14760.0 14792.1 14799.9 9125.6 9373.6 10335.3 10512.3 10579.3 6972.6 7097.6 7268.6 7386.9 7409.9 13183.5 13354.4 13427.7 13563.5 13617.8 13450.2 13577.0 13628.5 13808.6 13819.8 9728.4 9881.9 10039.3 10045.6 10051.0 10659.7 10709.6 10857.2 10864.9 10872.0 8975.6 9132.7 9252.4 9301.6 9417.4 8932.7 9098.0 9177.6 9251.2 9383.3 8461.7 8523.5 8669.3 8669.8 8672.2 6351.2 6430.5 6442.2 6491.0 6598.2 6285.0 6289.3 6289.4 6382.0 6449.3 06:38:34 INFO - PROCESS | 4508 | 06:38:34 INFO - PROCESS | 4508 | [#4] prototype.html Cycles:180 Average:4832.58 Median:5339.67 stddev:1302.15 (24.4%) stddev-sans-first:1262.82 06:38:34 INFO - PROCESS | 4508 | Values: 411.8 416.0 422.8 425.2 428.7 5400.6 5407.9 5428.7 5429.7 5443.8 5109.6 5238.4 5246.8 5255.6 5287.6 4248.2 4256.7 4261.0 4267.2 4276.9 4222.3 4241.0 4251.7 4273.7 4275.7 4091.2 4205.7 4214.8 4222.9 4257.7 4222.8 4237.7 4245.7 4252.2 4255.9 3880.4 3891.8 3898.1 3900.1 3911.6 5012.8 5140.9 5182.6 5226.8 5246.4 4952.2 4960.6 4965.3 4970.7 4986.4 5564.2 5580.5 5594.7 5597.2 5599.1 4102.5 4229.6 4308.8 4317.0 4317.2 5482.8 5674.6 5783.9 5796.4 5837.3 4819.8 4842.2 4842.9 4860.6 4999.7 5037.9 5064.8 5079.8 5098.5 5099.7 5083.6 5201.9 5245.8 5301.5 5350.4 5542.6 5545.7 5550.5 5565.5 5576.2 1760.5 1763.9 1765.5 1771.9 1787.3 1234.8 1275.6 1288.0 1306.5 1435.9 5278.3 5299.9 5328.9 5427.4 5432.2 5635.0 5690.6 5724.1 5791.9 5801.9 5138.9 5327.2 5359.5 5377.0 5398.2 2998.7 3013.7 3037.0 3037.2 3044.8 5690.9 5834.8 5957.3 5988.9 5994.6 5864.7 5868.7 5878.9 5884.3 5900.8 5997.8 6003.4 6010.6 6017.6 6022.0 5515.3 5688.3 5702.0 5726.6 5743.3 5462.4 5624.4 5659.9 5671.9 5706.9 5841.4 5939.9 5960.7 5979.3 5999.9 4696.1 4723.2 4736.5 4739.4 4773.0 5470.8 5607.7 5653.9 5727.3 5750.6 5565.7 5576.9 5583.6 5588.6 5597.2 5580.6 5583.2 5606.1 5618.7 5619.6 5284.3 5451.7 5564.5 5574.5 5578.7 5515.1 5527.3 5590.5 5597.2 5619.8 5328.7 5457.9 5493.8 5520.9 5533.3 06:38:34 INFO - PROCESS | 4508 | 06:38:34 INFO - PROCESS | 4508 | [#5] yui.html Cycles:180 Average:18106.39 Median:22646.33 stddev:22244.29 (98.2%) stddev-sans-first:22268.87 06:38:34 INFO - PROCESS | 4508 | Values: 830.7 839.3 910.3 915.4 942.8 16053.1 16351.8 16387.3 16421.7 16514.0 12999.3 16036.7 16163.1 16168.7 16185.0 676.1 845.2 866.8 871.6 872.3 882.8 887.5 891.9 892.2 892.6 952.5 954.4 957.2 959.9 960.5 954.2 956.6 956.9 957.1 957.6 691.9 696.0 698.0 698.4 698.6 16839.1 16877.7 16894.9 16904.4 16955.7 15131.6 15400.8 15442.2 16651.7 17091.1 13793.4 13909.3 14195.6 14386.6 14641.9 4046.9 4117.5 4133.3 4205.2 4283.6 85564.6 85706.0 86058.0 87522.6 89102.6 12929.5 13051.5 13145.2 13481.9 13560.7 23849.3 24592.6 24620.6 24690.1 25052.5 9108.8 9137.2 9152.2 9415.9 9428.2 5062.6 5070.7 5126.9 5243.6 5304.7 3484.2 3589.6 3614.3 3618.5 3638.8 597.6 600.2 603.7 604.6 613.6 847.6 860.7 877.5 891.8 899.0 11482.9 11782.2 11957.9 12254.9 12505.4 754.6 755.3 765.4 766.9 777.7 5539.3 5556.0 5681.6 5711.2 5724.9 79287.6 82208.6 83307.0 84519.0 84923.0 43221.3 43964.3 72627.0 73901.6 74759.5 46064.0 55245.4 58659.0 61371.1 61551.0 11714.9 11780.4 11872.5 12047.8 12162.7 39520.6 40346.8 40748.8 41073.8 41175.2 45733.5 47529.0 47766.5 47829.0 48035.8 12447.1 12464.3 12558.9 12693.8 12738.5 16321.8 16937.7 17180.7 17301.6 17444.9 16348.7 16799.7 16838.2 17044.0 17074.1 14878.3 14919.6 15071.1 15379.9 15781.1 14728.4 15067.5 15323.8 15807.6 15823.9 10726.4 11049.2 11245.2 11342.8 11612.2 11688.6 11729.9 12025.3 12072.5 12149.9 06:38:34 INFO - PROCESS | 4508 | -------- Summary: end -------- 06:38:34 INFO - PROCESS | 4508 | 06:38:35 INFO - TEST-INFO | 4508: exit 0 06:38:35 INFO - TEST-OK | dromaeo_css | took 1116246ms 06:38:35 INFO - TEST-START | kraken 06:38:35 INFO - operating with platform_type : linux_ 06:38:35 INFO - Initialising browser for kraken test... 06:38:35 INFO - TEST-INFO | started process 4833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNbTRoU/profile http://localhost:37826/getInfo.html) 06:38:39 INFO - PROCESS | 4833 | __metrics Screen width/height:1600/1200 06:38:39 INFO - PROCESS | 4833 | colorDepth:24 06:38:39 INFO - PROCESS | 4833 | Browser inner width/height: 1024/697 06:38:39 INFO - PROCESS | 4833 | __metrics 06:38:40 INFO - PROCESS | 4833 | 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" 06:38:40 INFO - PROCESS | 4833 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:38:41 INFO - TEST-INFO | 4833: exit 0 06:38:41 INFO - Browser initialized. 06:38:41 INFO - Running cycle 1/1 for kraken test... 06:38:41 INFO - TEST-INFO | started process 4925 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNbTRoU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:38:52 INFO - PROCESS | 4925 | RSS: Main: 140197888 06:38:52 INFO - PROCESS | 4925 | 06:38:55 INFO - PROCESS | 4925 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37826/tests/kraken/driver.html?testName=audio-beat-detection) 06:38:56 INFO - PROCESS | 4925 | RSS: Main: 183549952 06:38:56 INFO - PROCESS | 4925 | 06:38:58 INFO - PROCESS | 4925 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37826/tests/kraken/driver.html?testName=audio-dft) 06:38:59 INFO - PROCESS | 4925 | RSS: Main: 173621248 06:38:59 INFO - PROCESS | 4925 | 06:39:02 INFO - PROCESS | 4925 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37826/tests/kraken/driver.html?testName=audio-fft) 06:39:02 INFO - PROCESS | 4925 | RSS: Main: 265646080 06:39:02 INFO - PROCESS | 4925 | 06:39:04 INFO - PROCESS | 4925 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37826/tests/kraken/driver.html?testName=audio-oscillator) 06:39:05 INFO - PROCESS | 4925 | RSS: Main: 171978752 06:39:05 INFO - PROCESS | 4925 | 06:39:07 INFO - PROCESS | 4925 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37826/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:39:08 INFO - PROCESS | 4925 | RSS: Main: 174571520 06:39:08 INFO - PROCESS | 4925 | 06:39:11 INFO - PROCESS | 4925 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37826/tests/kraken/driver.html?testName=imaging-darkroom) 06:39:11 INFO - PROCESS | 4925 | RSS: Main: 213647360 06:39:11 INFO - PROCESS | 4925 | 06:39:15 INFO - PROCESS | 4925 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37826/tests/kraken/driver.html?testName=imaging-desaturate) 06:39:15 INFO - PROCESS | 4925 | RSS: Main: 211636224 06:39:15 INFO - PROCESS | 4925 | 06:39:18 INFO - PROCESS | 4925 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37826/tests/kraken/driver.html?testName=json-parse-financial) 06:39:19 INFO - PROCESS | 4925 | RSS: Main: 211345408 06:39:19 INFO - PROCESS | 4925 | 06:39:20 INFO - PROCESS | 4925 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37826/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:39:21 INFO - PROCESS | 4925 | RSS: Main: 173170688 06:39:21 INFO - PROCESS | 4925 | 06:39:22 INFO - PROCESS | 4925 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37826/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:39:23 INFO - PROCESS | 4925 | RSS: Main: 180633600 06:39:23 INFO - PROCESS | 4925 | 06:39:25 INFO - PROCESS | 4925 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37826/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:39:26 INFO - PROCESS | 4925 | RSS: Main: 189906944 06:39:26 INFO - PROCESS | 4925 | 06:39:28 INFO - PROCESS | 4925 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:39:29 INFO - PROCESS | 4925 | RSS: Main: 197906432 06:39:29 INFO - PROCESS | 4925 | 06:39:32 INFO - PROCESS | 4925 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:39:32 INFO - PROCESS | 4925 | RSS: Main: 195260416 06:39:32 INFO - PROCESS | 4925 | 06:39:34 INFO - PROCESS | 4925 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37826/tests/kraken/driver.html?testName=ai-astar) 06:39:34 INFO - PROCESS | 4925 | RSS: Main: 245039104 06:39:34 INFO - PROCESS | 4925 | 06:39:34 INFO - PROCESS | 4925 | __start_tp_report 06:39:34 INFO - PROCESS | 4925 | _x_x_mozilla_page_load 06:39:34 INFO - PROCESS | 4925 | _x_x_mozilla_page_load_details 06:39:34 INFO - PROCESS | 4925 | |i|pagename|runs| 06:39:34 INFO - PROCESS | 4925 | |0;ai-astar;103;113;112;112;112;111;113;114;112;111 06:39:34 INFO - PROCESS | 4925 | |1;audio-beat-detection;146;116;115;155;116;120;118;116;139;118 06:39:34 INFO - PROCESS | 4925 | |2;audio-dft;161;161;163;161;160;164;160;162;162;169 06:39:34 INFO - PROCESS | 4925 | |3;audio-fft;76;76;77;110;77;76;75;75;95;75 06:39:34 INFO - PROCESS | 4925 | |4;audio-oscillator;84;83;121;83;83;82;96;82;83;100 06:39:34 INFO - PROCESS | 4925 | |5;imaging-gaussian-blur;112;113;112;113;113;113;113;113;113;113 06:39:34 INFO - PROCESS | 4925 | |6;imaging-darkroom;147;147;147;146;147;147;153;147;147;148 06:39:34 INFO - PROCESS | 4925 | |7;imaging-desaturate;94;94;94;94;94;94;95;96;94;93 06:39:34 INFO - PROCESS | 4925 | |8;json-parse-financial;55;53;56;55;55;53;55;54;54;54 06:39:34 INFO - PROCESS | 4925 | |9;json-stringify-tinderbox;53;54;53;53;53;53;53;53;53;53 06:39:34 INFO - PROCESS | 4925 | |10;stanford-crypto-aes;78;75;79;75;77;79;75;75;84;79 06:39:34 INFO - PROCESS | 4925 | |11;stanford-crypto-ccm;121;122;130;128;120;127;131;118;167;122 06:39:34 INFO - PROCESS | 4925 | |12;stanford-crypto-pbkdf2;165;160;174;167;160;162;158;161;165;163 06:39:34 INFO - PROCESS | 4925 | |13;stanford-crypto-sha256-iterative;65;60;60;64;60;60;61;62;58;58 06:39:34 INFO - PROCESS | 4925 | __end_tp_report 06:39:34 INFO - PROCESS | 4925 | __start_cc_report 06:39:34 INFO - PROCESS | 4925 | _x_x_mozilla_cycle_collect,1650 06:39:34 INFO - PROCESS | 4925 | __end_cc_report 06:39:34 INFO - PROCESS | 4925 | __startTimestamp1491658774581__endTimestamp 06:39:34 INFO - PROCESS | 4925 | 06:39:34 INFO - PROCESS | 4925 | ------- Summary: start ------- 06:39:34 INFO - PROCESS | 4925 | Number of tests: 14 06:39:34 INFO - PROCESS | 4925 | 06:39:34 INFO - PROCESS | 4925 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:3.06 (2.7%) stddev-sans-first:0.97 06:39:34 INFO - PROCESS | 4925 | Values: 103.0 113.0 112.0 112.0 112.0 111.0 113.0 114.0 112.0 111.0 06:39:34 INFO - PROCESS | 4925 | 06:39:34 INFO - PROCESS | 4925 | [#1] audio-beat-detection Cycles:10 Average:125.90 Median:119.00 stddev:14.89 (12.5%) stddev-sans-first:13.90 06:39:34 INFO - PROCESS | 4925 | Values: 146.0 116.0 115.0 155.0 116.0 120.0 118.0 116.0 139.0 118.0 06:39:34 INFO - PROCESS | 4925 | 06:39:34 INFO - PROCESS | 4925 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:2.67 (1.6%) stddev-sans-first:2.79 06:39:34 INFO - PROCESS | 4925 | Values: 161.0 161.0 163.0 161.0 160.0 164.0 160.0 162.0 162.0 169.0 06:39:34 INFO - PROCESS | 4925 | 06:39:34 INFO - PROCESS | 4925 | [#3] audio-fft Cycles:10 Average:81.20 Median:76.00 stddev:11.79 (15.5%) stddev-sans-first:12.36 06:39:34 INFO - PROCESS | 4925 | Values: 76.0 76.0 77.0 110.0 77.0 76.0 75.0 75.0 95.0 75.0 06:39:34 INFO - PROCESS | 4925 | 06:39:34 INFO - PROCESS | 4925 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:83.00 stddev:12.72 (15.3%) stddev-sans-first:13.32 06:39:34 INFO - PROCESS | 4925 | Values: 84.0 83.0 121.0 83.0 83.0 82.0 96.0 82.0 83.0 100.0 06:39:34 INFO - PROCESS | 4925 | 06:39:34 INFO - PROCESS | 4925 | [#5] imaging-gaussian-blur Cycles:10 Average:112.80 Median:113.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 06:39:34 INFO - PROCESS | 4925 | Values: 112.0 113.0 112.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 06:39:34 INFO - PROCESS | 4925 | 06:39:34 INFO - PROCESS | 4925 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.00 stddev:1.96 (1.3%) stddev-sans-first:2.06 06:39:34 INFO - PROCESS | 4925 | Values: 147.0 147.0 147.0 146.0 147.0 147.0 153.0 147.0 147.0 148.0 06:39:34 INFO - PROCESS | 4925 | 06:39:34 INFO - PROCESS | 4925 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 06:39:34 INFO - PROCESS | 4925 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 95.0 96.0 94.0 93.0 06:39:34 INFO - PROCESS | 4925 | 06:39:34 INFO - PROCESS | 4925 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:1.00 06:39:34 INFO - PROCESS | 4925 | Values: 55.0 53.0 56.0 55.0 55.0 53.0 55.0 54.0 54.0 54.0 06:39:34 INFO - PROCESS | 4925 | 06:39:34 INFO - PROCESS | 4925 | [#9] json-stringify-tinderbox Cycles:10 Average:53.10 Median:53.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 06:39:34 INFO - PROCESS | 4925 | Values: 53.0 54.0 53.0 53.0 53.0 53.0 53.0 53.0 53.0 53.0 06:39:34 INFO - PROCESS | 4925 | 06:39:34 INFO - PROCESS | 4925 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:78.50 stddev:2.88 (3.7%) stddev-sans-first:3.05 06:39:34 INFO - PROCESS | 4925 | Values: 78.0 75.0 79.0 75.0 77.0 79.0 75.0 75.0 84.0 79.0 06:39:34 INFO - PROCESS | 4925 | 06:39:34 INFO - PROCESS | 4925 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:127.50 stddev:14.21 (11.1%) stddev-sans-first:14.80 06:39:34 INFO - PROCESS | 4925 | Values: 121.0 122.0 130.0 128.0 120.0 127.0 131.0 118.0 167.0 122.0 06:39:34 INFO - PROCESS | 4925 | 06:39:34 INFO - PROCESS | 4925 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.50 Median:164.00 stddev:4.60 (2.8%) stddev-sans-first:4.85 06:39:34 INFO - PROCESS | 4925 | Values: 165.0 160.0 174.0 167.0 160.0 162.0 158.0 161.0 165.0 163.0 06:39:34 INFO - PROCESS | 4925 | 06:39:34 INFO - PROCESS | 4925 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.80 Median:60.50 stddev:2.30 (3.8%) stddev-sans-first:1.87 06:39:34 INFO - PROCESS | 4925 | Values: 65.0 60.0 60.0 64.0 60.0 60.0 61.0 62.0 58.0 58.0 06:39:34 INFO - PROCESS | 4925 | -------- Summary: end -------- 06:39:34 INFO - PROCESS | 4925 | 06:39:35 INFO - TEST-INFO | 4925: exit 0 06:39:35 INFO - TEST-OK | kraken | took 60499ms 06:39:35 INFO - SUITE-END | took 1176s 06:39:35 INFO - Completed test suite (00:19:36) 06:39:35 INFO - javascript benchmark 06:39:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7832.778751513177, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3398.0315610051157, 3415.112070861576, 3436.7594268401213, 3467.531883195771, 3493.598236202836, 5710.114932185513, 5715.3998830122755, 5723.341815691197, 5784.103463963082, 5804.0423330150525, 5721.170430287616, 5766.625169363989, 5784.132380142981, 5791.913121303173, 5801.129830525413, 5187.118189907725, 5203.713795741232, 5226.608004399666, 5235.973820130894, 5237.580993520528, 4996.375453068366, 5023.346964894558, 5044.545990860822, 5238.68567885928, 5252.606054545905, 5132.358455193101, 5152.922706159392, 5155.9484405155845, 5174.094533456649, 5238.764255608507, 5227.503387178212, 5227.895442091175, 5231.398389185235, 5235.267062611199, 5251.422343542207, 4924.138275801756, 5005.399352077774, 5137.0, 5143.897122057538, 5214.270002199695, 5631.211630371751, 5634.971825140889, 5661.34894487131, 5699.2306038684665, 5710.600257981943, 6126.417990290915, 6160.260768707739, 6171.660558669271, 6175.0, 6178.5366097542865, 5922.141289512996, 6204.255489341263, 6224.221972253468, 6225.595336303126, 6232.501399887998, 5649.378568357477, 5722.313322401338, 5760.2511673482595, 5762.567807414461, 5770.336411312669, 6289.7484100636375, 6319.8104056878365, 6326.177596912372, 6328.810135695844, 6330.651814150266, 6048.9697551512845, 6099.542534309944, 6115.449609535163, 6115.571909966348, 6117.327094019654, 5942.970285148546, 5963.910541341883, 6090.056041313604, 6117.632942023492, 6127.172831667668, 6131.6213479391645, 6187.597806142587, 6189.04069869171, 6190.535709821781, 6198.721057552421, 5973.522118230531, 6001.5198784097165, 6011.699415029231, 6047.667378294148, 6051.062085376773, 4662.230731929261, 4700.600448961876, 4721.95278047222, 4725.480197178307, 4726.1492931272705, 4197.9370309445385, 4205.411242426063, 4218.029853133735, 4231.513375961804, 4258.829646814154, 5712.485876271156, 5752.36723960364, 5880.206172166788, 5921.496672782776, 5999.220101386792, 6275.3724627536885, 6278.6546739929745, 6287.937120628827, 6290.0, 6300.464460520815, 5971.0744834550715, 5994.790182343684, 5997.100434934708, 5999.430054144849, 6026.879462410728, 5100.056489549445, 5118.923216151761, 5189.0, 5227.738613069331, 5278.788848446096, 6440.871182576416, 6469.061986012002, 6484.416402523795, 6486.44865186455, 6489.091527186198, 6195.0, 6216.751329946932, 6231.781887633911, 6232.283287421823, 6235.563510554218, 6145.723442445012, 6209.844753881189, 6336.9049464259, 6494.805155845333, 6507.707153178024, 6119.258838874149, 6155.384461553988, 6169.84575385619, 6170.53720970938, 6175.104609831639, 6243.0, 6244.5316601256, 6250.156228909039, 6251.812445626639, 6257.43683068526, 5764.221830052889, 5867.911981320198, 6102.694865256631, 6108.908366374597, 6110.991686371876, 5975.671338076274, 5983.341832398346, 6076.848078798065, 6087.36082711309, 6127.3566275540425, 6023.66869822164, 6072.635641861502, 6072.878542429038, 6074.1799857020505, 6075.210222671025, 5827.4172582741385, 5859.150423188528, 5895.469407753323, 5897.734601942837, 6116.113163591165, 5871.823845284648, 5903.704814759159, 5999.370066142992, 6000.519958403404, 6007.098935159761], "value": 5678.61548215242, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.1982429239984, 803.6905791270361, 818.181818181818, 897.058089006543, 906.1889608800128, 31907.0, 44689.77655111724, 45702.08595828081, 45733.77133114338, 45752.33981281498, 45972.0, 46181.30728039082, 46221.76889115558, 46265.76867115668, 46269.76865115669, 7672.578008209546, 7871.252231038071, 8981.146791054856, 9145.954270228673, 9153.08469153086, 10777.515011824447, 11051.502682379272, 11292.943535282353, 11325.603603873866, 11328.49021794017, 11010.174236932222, 11041.83437248442, 11052.557897684082, 11064.05955493784, 11064.391458469781, 10894.727631809188, 10898.346099234072, 10986.560537578487, 11000.339979601249, 11004.944975275112, 10073.093421592092, 10088.596456141746, 10136.949315253376, 10141.949290253575, 10184.0, 42800.0, 42971.570284297384, 43248.783756081335, 43308.0, 43367.783161084306, 4272.188284225987, 4303.203907277132, 4324.35134729793, 4397.956020439787, 4452.265376212921, 29685.851570742223, 30337.241568960733, 30539.0, 31014.84492577545, 31334.843325783455, 4403.713758605681, 4408.20652282589, 4466.486354069291, 4527.7056991295785, 4634.420697412824, 225400.99999999837, 226048.0, 226057.0, 226456.0, 228090.0, 54006.0, 54101.72949135308, 54124.188137177975, 54215.45784542183, 54241.45758542364, 55992.44007559954, 56132.71933640305, 56166.0, 56203.0, 56221.43778562162, 16332.918335408247, 16595.253213605418, 16665.750013749803, 16666.749998750027, 16668.249928753234, 13079.738405231841, 13170.670733231746, 14631.195284259467, 14647.340869660678, 14658.340374683165, 13037.608871733863, 13457.0, 13783.793243101361, 13795.586132416043, 13928.164310141425, 5400.21696853954, 5463.426340234298, 5491.670499770026, 5516.558675305966, 5619.072852979212, 1012.3318609717551, 1016.5832008876325, 1020.6325722739808, 1029.1869423155624, 1030.0935177044153, 28448.857755711502, 28499.430011399654, 28617.713822861504, 28989.56515652267, 29061.85469072641, 1059.5338051257422, 1073.5491093740648, 1095.6767753512734, 1098.3464838421128, 1102.47081400928, 14386.28068596566, 15245.847541524443, 15268.816129467583, 15426.84573154254, 15531.456399026205, 284904.0, 285364.14635853376, 286134.0, 286397.0, 286715.0, 57017.14474282889, 57036.0, 57089.42910570841, 57159.428405716244, 57274.42725572691, 1498.4605542005088, 1498.5504348695347, 1505.631120375493, 1531.4180611367608, 1551.937922483088, 25670.61494077628, 26850.731492684823, 26853.328666783487, 26987.460250795266, 27091.864540677172, 25507.872460638322, 25544.23367298984, 25544.489110218063, 25553.744462555136, 25564.74435255698, 258686.0, 259705.0, 259922.0, 259995.0, 260539.0, 29974.0, 30657.54013689841, 33731.32537349288, 35620.0, 35742.821285893406, 44802.55197447984, 44831.551684482736, 45112.77443612761, 45405.77297113493, 46027.3095903555, 34011.31977360488, 34123.65876341304, 34151.0, 34191.31617367688, 34371.828140859136, 33748.662513374555, 34059.65940340565, 34143.317133657685, 34359.31281374308, 34420.96737097891, 37075.0, 37524.812375937945, 38219.23561528698, 38768.0, 39110.41334379929, 30614.84692576523, 30757.23106922345, 31043.379132416772, 31089.37821243517, 31894.52158217582, 23956.88021559881, 24482.877585611957, 25034.0, 25361.746382536676, 25445.491090178464], "value": 18732.766117420462, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [458.31939569738955, 463.4253525628222, 480.0878331170773, 485.16309366343063, 498.46166140568187, 19646.312379066734, 21313.254036108738, 21825.454363640918, 22208.00063997122, 22476.43808904778, 22556.32331030072, 22729.431764205903, 22786.31641050767, 22948.196813111543, 23028.19401320954, 6637.336266373361, 6681.766138185165, 6834.897476537856, 6844.041834143224, 6851.794446166623, 6780.0, 6889.345512176335, 6895.620740859251, 7039.472039597025, 7344.8898266525775, 7519.097708274987, 7521.398288136963, 7527.2849079337375, 7533.510321829091, 7540.622968851563, 7294.234105418935, 7404.518706284101, 7443.962780186119, 7448.36688881443, 7452.993845830798, 7083.256258092878, 7255.2744725527555, 7340.339369456775, 7381.926180738231, 7397.963010184914, 25378.619320710204, 25492.36269093269, 25559.48881022369, 25887.0939517116, 26068.73931260682, 3041.5437684347303, 3195.2810617610853, 3379.915502112467, 3472.4791281308007, 3572.4462708280257, 16293.51119466418, 16323.51029469106, 16448.588785280343, 16455.09496977666, 16973.811833171683, 2200.0979598364593, 2217.5675743230076, 2227.955440891173, 2252.954940901173, 2267.5238199978025, 111592.0, 115987.42006290083, 117278.0, 121869.39065304617, 126416.0, 17694.823051769574, 18176.364427157987, 18464.261429542938, 18527.907360463112, 18667.439976800717, 32510.024699259062, 32526.83736581302, 32537.674623253937, 32540.186495337806, 32587.0, 10149.289549731448, 10237.334573252714, 10401.635942741968, 10425.843612345821, 10661.466926653637, 8705.782355441039, 8762.737117886474, 8833.823323533494, 9040.8643870342, 9078.182963533314, 9244.630214791467, 9342.859857102148, 9398.90601093994, 9491.532201627626, 9534.332596718163, 3271.9509207361907, 3335.6664333566932, 3552.87564935226, 3600.9099772505374, 3723.8130408312218, 933.2580598424133, 946.3612061858356, 951.1439704266215, 953.7329547726648, 962.4946902876046, 19744.70382944257, 21038.0, 21134.260300889397, 21247.0, 21407.124402725243, 955.0926619711302, 1060.6022741471947, 1115.6318414923219, 1120.9607663731892, 1144.101880024177, 7033.0, 7119.181294151239, 7326.3406293433845, 7365.968764372992, 7477.401807855358, 573934.0, 578009.0, 593750.0, 616763.0, 625749.0, 84237.0, 84883.90664616991, 92923.53538232266, 119781.0, 124013.0, 1315.6776589735575, 1351.1015174908773, 1367.2958426410407, 1369.7260547890462, 1380.0132904972993, 17662.911685442006, 18273.0, 18803.751177851722, 19074.237030518623, 19357.03214839224, 48663.756681216364, 50560.0, 51530.0, 51946.740266298424, 52363.47636523738, 66723.66638166778, 66835.66582167058, 67157.3284267151, 68363.3163668357, 68658.65670671615, 12423.813642795547, 12636.494540218288, 12641.178323408949, 12651.114421990373, 12757.425915833996, 12823.679408014501, 13000.0, 13004.674883127618, 13205.735885282049, 13295.933520332337, 11596.88403115958, 11609.825852612048, 11616.12879034059, 11754.11844111678, 12017.218880772722, 10816.296940698829, 10867.782644346911, 10908.509117089909, 11046.723831904266, 11406.201565890307, 11608.129390295593, 11611.361375124448, 11716.0, 11739.354335511629, 11789.469473873867, 12808.103432759617, 12873.163244389085, 12991.675208119872, 13052.15161014569, 13312.400941957441, 11108.44457777124, 11341.773164536828, 11762.941185294361, 11786.705332366417, 11885.76228475443], "value": 11344.55759294037, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1557.9922100389497, 1568.5764843492257, 1574.110627495465, 1584.0970646731353, 1589.6741168060548, 10861.619843305485, 11402.087832973342, 11409.885901140997, 11507.0, 11518.942405287962, 11349.20555561111, 11447.198696091276, 11641.650750477478, 11644.883551164507, 11770.588029418972, 2505.348609361561, 2539.999999999991, 2542.4915016996583, 2543.224316583441, 2544.402065514603, 2456.5946618807875, 2508.347829564317, 2551.4769472258236, 2562.397836508419, 2567.1271767599014, 2421.7093948726088, 2491.476789874129, 2529.519391315653, 2531.8101142414394, 2537.619357096432, 2345.5543446745064, 2390.7370189279254, 2398.70016247969, 2418.250342393846, 2449.9265022049367, 2334.101370972171, 2374.8456350337174, 2379.1553998330514, 2397.496525729599, 2398.6641870138196, 11257.605983790529, 11541.365224912626, 11546.653600391917, 11555.711107222303, 11556.479958401893, 5788.334341550733, 5964.284285885678, 5972.761089556412, 5974.193483879664, 5979.910301345483, 3417.4532074868152, 3485.3900567400856, 3485.89542313731, 3533.169705119295, 3549.982250088759, 1347.2994043097535, 1355.6068740065368, 1358.830146231721, 1398.8878841321175, 1398.930053497321, 17117.058561779097, 17525.0, 17874.46376608704, 18117.18472668733, 18349.449516514527, 4837.733924634179, 4842.080004799077, 4883.731394773251, 4885.022995400863, 5013.774380152902, 12803.551875684307, 12872.16330938486, 12883.420246088948, 12888.548900788615, 12900.548480803127, 5965.194698715704, 5968.522518198533, 5970.582059255898, 5972.611780234271, 5987.2815262168815, 5393.865153371197, 5409.486098820606, 5434.972825135849, 5452.236686863842, 5502.202180683778, 4077.348673787121, 4133.958660413417, 4169.862631615606, 4196.664266858644, 4214.7471151731, 1071.2822408985999, 1078.6440474643348, 1079.8866119057543, 1088.7768007558432, 1090.9127269818396, 1060.671191930504, 1066.8186408310605, 1075.0, 1076.1283360478037, 1083.5719890643309, 7163.713451461883, 7179.569225846466, 7207.1891962134805, 7210.67551960163, 7293.927060729431, 1013.506773337583, 1016.6086056868011, 1028.6502589119734, 1033.1528146919454, 1055.1875056206677, 4519.254323036662, 4734.0, 4912.533309335608, 4962.280469331927, 5060.468650791614, 14495.782563261559, 14903.776443353358, 14929.552113436614, 14943.476978305707, 15054.473093441677, 13558.186508809504, 13925.651858703412, 14760.0, 14792.11247325164, 14799.926000370144, 9125.589348479334, 9373.62505499786, 10335.328203666888, 10512.264141510173, 10579.259451838298, 6972.616506092214, 7097.609631470319, 7268.636568171464, 7386.852262954818, 7409.851802964018, 13183.472661093449, 13354.399052042487, 13427.731445371233, 13563.457461701422, 13617.79573306421, 13450.192988420335, 13577.049606527844, 13628.454861805416, 13808.585742427744, 13819.79270310926, 9728.416295022322, 9881.851772223567, 10039.34744241622, 10045.598176073168, 10051.0, 10659.733506662396, 10709.625163119254, 10857.185711071543, 10864.945675271572, 10872.021518063413, 8975.596098175467, 9132.726018219464, 9252.398594091363, 9301.581428835854, 9417.387869788441, 8932.732018039469, 9097.954510227406, 9177.587008584764, 9251.213646840093, 9383.296252781205, 8461.661533538836, 8523.48859068458, 8669.349798764992, 8669.783255418664, 8672.176143266379, 6351.2060992375955, 6430.549861509649, 6442.226932768098, 6491.0, 6598.241202261801, 6285.0, 6289.276733175743, 6289.40250676185, 6382.0, 6449.258335291502], "value": 5463.339039162064, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.8187005383414, 416.0493272871489, 422.79494445194075, 425.19850082594337, 428.6977680735082, 5400.648957817739, 5407.891842163154, 5428.674279543226, 5429.669730915931, 5443.842571308636, 5109.591232701384, 5238.423773384925, 5246.7901283948595, 5255.632105752599, 5287.603429742765, 4248.214080395129, 4256.723312984662, 4261.019965407958, 4267.231898258312, 4276.935845962313, 4222.345536441841, 4241.0, 4251.659867210616, 4273.7008409411355, 4275.722078064916, 4091.2226676931286, 4205.747655140686, 4214.789260536961, 4222.894427639319, 4257.659387249028, 4222.831086756526, 4237.660987121023, 4245.745255284693, 4252.170826688797, 4255.936160957557, 3880.428426487277, 3891.754638515676, 3898.064464528493, 3900.1224724437056, 3911.550171730259, 5012.824551140692, 5140.897182056338, 5182.5594824439595, 5226.830865190941, 5246.37043554772, 4952.217201807346, 4960.603151747851, 4965.255211718271, 4970.676906001098, 4986.40163180417, 5564.248826408423, 5580.497755202011, 5594.664320140804, 5597.244372009767, 5599.104143337087, 4102.46677421448, 4229.577042295777, 4308.82764689412, 4317.0, 4317.179735850178, 5482.780688772445, 5674.602777805555, 5783.942160578383, 5796.449337312949, 5837.270341207349, 4819.807207711722, 4842.176829938919, 4842.927356089662, 4860.6111511079025, 4999.700017998932, 5037.949620503821, 5064.82273120439, 5079.831638723114, 5098.50173415024, 5099.745012749348, 5083.61872859537, 5201.895962080737, 5245.816396426107, 5301.496357845998, 5350.438203988603, 5542.612017158841, 5545.72271386429, 5550.528205102531, 5565.497315724812, 5576.191452239403, 1760.4542591796328, 1763.9470815875545, 1765.4993255732525, 1771.8671099667577, 1787.2672204396135, 1234.7839128152536, 1275.6109386636979, 1288.0339745191106, 1306.5231190615548, 1435.9210243436503, 5278.31094049908, 5299.947000529945, 5328.893422131536, 5427.402985671573, 5432.239486471897, 5635.0, 5690.573207009408, 5724.0538217006415, 5791.913121303184, 5801.8549536261935, 5138.922916156261, 5327.227552005015, 5359.464053594687, 5377.005254028018, 5398.217258497496, 2998.7151220634005, 3013.7246378983727, 3036.952251473238, 3037.164779685604, 3044.8477576121104, 5690.943090569124, 5834.766609335664, 5957.314908785545, 5988.9401105989255, 5994.580379373402, 5864.70676466175, 5868.677222752704, 5878.853028674317, 5884.264466941632, 5900.822975310747, 5997.760089596454, 6003.399660034049, 6010.579259451796, 6017.578769486094, 6022.0, 5515.255440515479, 5688.288963879515, 5702.0, 5726.627769194989, 5743.3395159557185, 5462.371827239918, 5624.437556244343, 5659.915101273402, 5671.922334756383, 5706.8573285666525, 5841.4450627190345, 5939.91090133657, 5960.672163030901, 5979.252593425822, 5999.860026594933, 4696.131215725101, 4723.173444647105, 4736.526347365374, 4739.431268247832, 4772.95227047739, 5470.808521701881, 5607.691576963306, 5653.925754106706, 5727.308165162367, 5750.597458177887, 5565.693886836101, 5576.91634625489, 5583.581231407579, 5588.580856435702, 5597.188407680945, 5580.586830774143, 5583.218349431002, 5606.074997625346, 5618.747156377891, 5619.634723742944, 5284.286621306074, 5451.672899626035, 5564.527015203753, 5574.498295153294, 5578.748956297058, 5515.09001014828, 5527.336719593674, 5590.5248053915875, 5597.244372009726, 5619.80330688424, 5328.70692111922, 5457.890842183214, 5493.7802487900035, 5520.91718624229, 5533.253010843646], "value": 4460.0947326486685, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [830.6635812495938, 839.2530647723531, 910.3400034974643, 915.4187091197088, 942.7501712046309, 16053.117078560674, 16351.754723679154, 16387.344506219735, 16421.67156656866, 16514.0, 12999.285039322833, 16036.679266414665, 16163.111028893407, 16168.676626467464, 16185.0, 676.056900623631, 845.222395396237, 866.8049688820028, 871.5511511571514, 872.2760109109424, 882.7704796752827, 887.5163036145316, 891.888513935758, 892.1524551675901, 892.6027917576681, 952.5332587032339, 954.4082668745388, 957.2007373842849, 959.9184069354113, 960.5053397500293, 954.2080073538946, 956.5599824080931, 956.8899576548681, 957.1098878043451, 957.5595226195958, 691.8581690753383, 695.9930400695979, 698.0471656189266, 698.4168219536693, 698.5703792167831, 16839.07385093819, 16877.746833797504, 16894.915525422417, 16904.40834570784, 16955.660886782196, 15131.621709457242, 15400.768988465183, 15442.227888605525, 16651.6669666606, 17091.14544272794, 13793.379297931617, 13909.304534773322, 14195.645108872257, 14386.640333991734, 14641.853581464156, 4046.858359957387, 4117.485314335708, 4133.256013917494, 4205.158968206371, 4283.571642835723, 85564.57217713934, 85706.0, 86057.99999999937, 87522.5623871883, 89102.55448722714, 12929.54746583865, 13051.477940882449, 13145.21128732279, 13481.932590337181, 13560.728785424433, 23849.284521464382, 24592.631110533355, 24620.630690539656, 24690.13584524533, 25052.498950020898, 9108.772280693036, 9137.223336016381, 9152.176304132527, 9415.90584094164, 9428.198603118675, 5062.569681577107, 5070.6957582545165, 5126.948730512721, 5243.580513558906, 5304.708241046702, 3484.233468636896, 3589.587197472272, 3614.331348700499, 3618.511500947391, 3638.7634803737674, 597.6243688026232, 600.2466904035408, 603.667982609563, 604.5647134063468, 613.5980932489226, 847.6143354773563, 860.6665439512027, 877.4866702978701, 891.8216356728681, 899.0425197164998, 11482.88517114835, 11782.175247732577, 11957.940210298893, 12254.877451225551, 12505.43725532335, 754.6302311867255, 755.2749360613873, 765.3723946363928, 766.8673468879689, 777.7161336112279, 5539.335279766454, 5555.999281164459, 5681.57388195887, 5711.228984087178, 5724.914126288109, 79287.60356198298, 82208.58895705483, 83307.0, 84519.0, 84923.0, 43221.27114915368, 43964.340534892, 72627.0, 73901.6304918472, 74759.50480990458, 46064.0, 55245.44754552483, 58659.0, 61371.07943380764, 61551.0, 11714.88285117172, 11780.352080635646, 11872.525098995944, 12047.819282710941, 12162.695932601755, 39520.604793951694, 40346.79826600848, 40748.79625601853, 41073.794631026656, 41175.17649646931, 45733.54266457426, 47529.0, 47766.52233477621, 47829.0, 48035.75982120067, 12447.128700990843, 12464.314462704639, 12558.874411256136, 12693.80959285593, 12738.490460381481, 16321.836781632031, 16937.745933810755, 17180.742288865426, 17301.56746081358, 17444.91277543655, 16348.67302653964, 16799.664006720042, 16838.158092095102, 17044.0, 17074.14629268507, 14878.256087195814, 14919.627009324853, 15071.11611048619, 15379.923100384427, 15781.132037737576, 14728.410863565767, 15067.4726384576, 15323.770143447635, 15807.604809879846, 15823.920880395985, 10726.356418614909, 11049.226554141133, 11245.156613253876, 11342.773144536897, 11612.179232541605, 11688.590899318484, 11729.882701172879, 12025.278483291031, 12072.45673944657, 12149.939250303692], "value": 7852.782203842462, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1462.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 112.0, 112.0, 111.0, 113.0, 114.0, 112.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 116.0, 115.0, 155.0, 116.0, 120.0, 118.0, 116.0, 139.0, 118.0], "value": 125.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 161.0, 160.0, 164.0, 160.0, 162.0, 162.0, 169.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 110.0, 77.0, 76.0, 75.0, 75.0, 95.0, 75.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 121.0, 83.0, 83.0, 82.0, 96.0, 82.0, 83.0, 100.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 112.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 153.0, 147.0, 147.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 96.0, 94.0, 93.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 56.0, 55.0, 55.0, 53.0, 55.0, 54.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 79.0, 75.0, 77.0, 79.0, 75.0, 75.0, 84.0, 79.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 122.0, 130.0, 128.0, 120.0, 127.0, 131.0, 118.0, 167.0, 122.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 160.0, 174.0, 167.0, 160.0, 162.0, 158.0, 161.0, 165.0, 163.0], "value": 163.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 60.0, 60.0, 64.0, 60.0, 60.0, 61.0, 62.0, 58.0, 58.0], "value": 60.8, "unit": "score"}]}]} 06:39:35 INFO - Return code: 0 06:39:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:39:35 ERROR - # TBPL SUCCESS # 06:39:35 INFO - Running post-action listener: _resource_record_post_action 06:39:35 INFO - [mozharness: 2017-04-08 13:39:35.885270Z] Finished run-tests step (success) 06:39:35 INFO - Running post-run listener: _resource_record_post_run 06:39:35 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 364359680; Read time: 8; Write time: 268748 06:39:35 INFO - TinderboxPrint: CPU usage
13.1% 06:39:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 06:39:35 INFO - TinderboxPrint: I/O write bytes / time
364,359,680 / 268,748 06:39:35 INFO - TinderboxPrint: CPU idle
8,278.4 (86.9%) 06:39:35 INFO - TinderboxPrint: CPU user
1,202.3 (12.6%) 06:39:35 INFO - TinderboxPrint: Swap in / out
0 / 0 06:39:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110329856; Read time: 0; Write time: 99540 06:39:35 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 253255680; Read time: 8; Write time: 169180 06:39:36 INFO - Running post-run listener: _upload_blobber_files 06:39:36 INFO - Blob upload gear active. 06:39:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:39:36 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 06:39:36 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'] 06:39:36 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 06:39:36 INFO - (blobuploader) - INFO - Open directory for files ... 06:39:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:39:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:39:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:39:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:39:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:39:37 INFO - (blobuploader) - INFO - Done attempting. 06:39:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:39:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:39:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:39:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:39:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:39:38 INFO - (blobuploader) - INFO - Done attempting. 06:39:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:39:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:39:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:39:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:39:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:39:39 INFO - (blobuploader) - INFO - Done attempting. 06:39:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:39:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:39:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:39:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:39:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:39:42 INFO - (blobuploader) - INFO - Done attempting. 06:39:42 INFO - (blobuploader) - INFO - Iteration through files over. 06:39:42 INFO - Return code: 0 06:39:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:39:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:39:42 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/d44d53fe406b60c36fff374a8b536812d7a35ba3195dd590f0673619b7d7d28bd582f690e02aa462934fc7f82d0920ab0c5420ef2765808077bb2549224e83d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/fd2e923892d85dccf4147fa77700488e0503df4a72364ecb197c3f2af4c797e3b11be3c29122386752097dac96ef6b6c61132544a28a06accdd50ca11c93f888", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/c7997a74d1b6044b2d9cdd89c40788af945e8584cac48240e594ceb0214e79533bad04cc635420f68e59faa52fcb92116398e09e3232973a7436395ca96f1007", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/e9045d94ec1d5445da8e316da9d9052ad498d110176c30c879b8a2ff7ac953a97a8358f9a2eeb848aae8bd0767ca10a2cd8eb0f597151a6870fe458ba2eec5f9"} 06:39:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:39:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:39:42 INFO - Contents: 06:39:42 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/d44d53fe406b60c36fff374a8b536812d7a35ba3195dd590f0673619b7d7d28bd582f690e02aa462934fc7f82d0920ab0c5420ef2765808077bb2549224e83d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/fd2e923892d85dccf4147fa77700488e0503df4a72364ecb197c3f2af4c797e3b11be3c29122386752097dac96ef6b6c61132544a28a06accdd50ca11c93f888", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/c7997a74d1b6044b2d9cdd89c40788af945e8584cac48240e594ceb0214e79533bad04cc635420f68e59faa52fcb92116398e09e3232973a7436395ca96f1007", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/e9045d94ec1d5445da8e316da9d9052ad498d110176c30c879b8a2ff7ac953a97a8358f9a2eeb848aae8bd0767ca10a2cd8eb0f597151a6870fe458ba2eec5f9"} 06:39:42 INFO - Running post-run listener: copy_logs_to_upload_dir 06:39:42 INFO - Copying logs to upload dir... 06:39:42 INFO - mkdir: /builds/slave/test/build/upload/logs 06:39:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.445274 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-04-08 06:39:41.853467) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-08 06:39:41.857659) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991 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/d44d53fe406b60c36fff374a8b536812d7a35ba3195dd590f0673619b7d7d28bd582f690e02aa462934fc7f82d0920ab0c5420ef2765808077bb2549224e83d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/fd2e923892d85dccf4147fa77700488e0503df4a72364ecb197c3f2af4c797e3b11be3c29122386752097dac96ef6b6c61132544a28a06accdd50ca11c93f888", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/c7997a74d1b6044b2d9cdd89c40788af945e8584cac48240e594ceb0214e79533bad04cc635420f68e59faa52fcb92116398e09e3232973a7436395ca96f1007", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/e9045d94ec1d5445da8e316da9d9052ad498d110176c30c879b8a2ff7ac953a97a8358f9a2eeb848aae8bd0767ca10a2cd8eb0f597151a6870fe458ba2eec5f9"} build_url:https://queue.taskcluster.net/v1/task/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011346 build_url: 'https://queue.taskcluster.net/v1/task/CkyA-gFERPq-BjOWqNysUA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/d44d53fe406b60c36fff374a8b536812d7a35ba3195dd590f0673619b7d7d28bd582f690e02aa462934fc7f82d0920ab0c5420ef2765808077bb2549224e83d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/fd2e923892d85dccf4147fa77700488e0503df4a72364ecb197c3f2af4c797e3b11be3c29122386752097dac96ef6b6c61132544a28a06accdd50ca11c93f888", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/c7997a74d1b6044b2d9cdd89c40788af945e8584cac48240e594ceb0214e79533bad04cc635420f68e59faa52fcb92116398e09e3232973a7436395ca96f1007", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/e9045d94ec1d5445da8e316da9d9052ad498d110176c30c879b8a2ff7ac953a97a8358f9a2eeb848aae8bd0767ca10a2cd8eb0f597151a6870fe458ba2eec5f9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-08 06:39:41.886426) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 06:39:41.886756) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1491653386.125970-1226070991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004380 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 06:39:41.968609) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-08 06:39:41.968913) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-08 06:39:41.969281) ========= ========= Total master_lag: 0.16 =========