builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-021 starttime: 1484860367.62 results: success (0) revision: a3978751f45108ff1ae002ecebdc0fa23fc52b84 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 13:12:47.625270) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 13:12:47.625826) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 13:12:47.626140) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 13:12:47.640538) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 13:12:47.640826) ========= 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=df17445c3590ff7897617a0e00000225-1484860367.21562-932785477 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-19 13:12: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2017-01-19 13:12:47 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092891 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 13:12:47.747410) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 13:12:47.747738) ========= 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=df17445c3590ff7897617a0e00000225-1484860367.21562-932785477 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020185 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 13:12:47.796954) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-19 13:12:47.797309) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a3978751f45108ff1ae002ecebdc0fa23fc52b84 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev a3978751f45108ff1ae002ecebdc0fa23fc52b84 --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=df17445c3590ff7897617a0e00000225-1484860367.21562-932785477 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-19 13:12:47,803 truncating revision to first 12 chars 2017-01-19 13:12:47,803 Setting DEBUG logging. 2017-01-19 13:12:47,803 attempt 1/10 2017-01-19 13:12:47,803 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a3978751f451?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-19 13:12:48,875 unpacking tar archive at: mozilla-central-a3978751f451/testing/mozharness/ program finished with exit code 0 elapsedTime=1.399076 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-19 13:12:49.209739) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 13:12:49.210102) ========= script_repo_revision: a3978751f45108ff1ae002ecebdc0fa23fc52b84 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 13:12:49.210545) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 13:12:49.210839) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 13:12:49.219618) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-01-19 13:12:49.219938) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1484860367.21562-932785477 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:12:49 INFO - MultiFileLogger online at 20170119 13:12:49 in /builds/slave/test 13:12:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 13:12:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:12:49 INFO - {'append_to_log': False, 13:12:49 INFO - 'base_work_dir': '/builds/slave/test', 13:12:49 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 13:12:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:12:49 INFO - 'branch': 'Firefox-Non-PGO', 13:12:49 INFO - 'buildbot_json_path': 'buildprops.json', 13:12:49 INFO - 'config_files': ('talos/linux_config.py',), 13:12:49 INFO - 'default_actions': ('clobber', 13:12:49 INFO - 'read-buildbot-config', 13:12:49 INFO - 'download-and-extract', 13:12:49 INFO - 'populate-webroot', 13:12:49 INFO - 'create-virtualenv', 13:12:49 INFO - 'install', 13:12:49 INFO - 'run-tests'), 13:12:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:12:49 INFO - 'download_minidump_stackwalk': True, 13:12:49 INFO - 'download_symbols': 'ondemand', 13:12:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:12:49 INFO - 'tooltool.py': '/tools/tooltool.py', 13:12:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:12:49 INFO - '/tools/misc-python/virtualenv.py')}, 13:12:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:12:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:12:49 INFO - 'installer_path': 'installer.exe', 13:12:49 INFO - 'log_level': 'info', 13:12:49 INFO - 'log_name': 'talos', 13:12:49 INFO - 'log_to_console': True, 13:12:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:12:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:12:49 INFO - 'opt_config_files': (), 13:12:49 INFO - 'pip_index': False, 13:12:49 INFO - 'sps_profile': False, 13:12:49 INFO - 'sps_profile_interval': 0, 13:12:49 INFO - 'suite': 'dromaeojs', 13:12:49 INFO - 'system_bits': '32', 13:12:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:12:49 INFO - 'title': 'talos-linux64-ix-021', 13:12:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:12:49 INFO - 'use_talos_json': True, 13:12:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:12:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:12:49 INFO - 'work_dir': 'build'} 13:12:49 INFO - [mozharness: 2017-01-19 21:12:49.321735Z] Running clobber step. 13:12:49 INFO - Running pre-action listener: _resource_record_pre_action 13:12:49 INFO - Running main action method: clobber 13:12:49 INFO - rmtree: /builds/slave/test/build 13:12:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:12:49 INFO - Running post-action listener: _resource_record_post_action 13:12:49 INFO - [mozharness: 2017-01-19 21:12:49.773265Z] Finished clobber step (success) 13:12:49 INFO - [mozharness: 2017-01-19 21:12:49.773367Z] Running read-buildbot-config step. 13:12:49 INFO - Running pre-action listener: _resource_record_pre_action 13:12:49 INFO - Running main action method: read_buildbot_config 13:12:49 INFO - Using buildbot properties: 13:12:49 INFO - { 13:12:49 INFO - "project": "", 13:12:49 INFO - "product": "firefox", 13:12:49 INFO - "who": "cbook@mozilla.com", 13:12:49 INFO - "installer_path": "public/build/target.tar.bz2", 13:12:49 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 13:12:49 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 13:12:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 13:12:49 INFO - "stage_platform": "linux64", 13:12:49 INFO - "basedir": "/builds/slave/test", 13:12:49 INFO - "buildnumber": 791, 13:12:49 INFO - "platform": "ubuntu64_hw", 13:12:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:12:49 INFO - "slavebuilddir": "test", 13:12:49 INFO - "taskId": "SUmy6aPtQQuiZTqTRs6E7g", 13:12:49 INFO - "branch": "mozilla-central", 13:12:49 INFO - "script_repo_revision": "production", 13:12:49 INFO - "revision": "a3978751f45108ff1ae002ecebdc0fa23fc52b84", 13:12:49 INFO - "slavename": "talos-linux64-ix-021", 13:12:49 INFO - "repo_path": "mozilla-central" 13:12:49 INFO - } 13:12:49 INFO - Finding installer, test and symbols from parent task. 13:12:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SUmy6aPtQQuiZTqTRs6E7g'}, attempt #1 13:12:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SUmy6aPtQQuiZTqTRs6E7g'}, attempt #1 13:12:50 INFO - Task dependencies: GZLy8lu3SYGrOd7qXwAlNg 13:12:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg'}, attempt #1 13:12:51 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/target.tar.bz2 13:12:51 INFO - Set test_url: https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/test_packages.json 13:12:51 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/target.crashreporter-symbols.zip 13:12:51 INFO - Running post-action listener: _resource_record_post_action 13:12:51 INFO - [mozharness: 2017-01-19 21:12:51.173834Z] Finished read-buildbot-config step (success) 13:12:51 INFO - [mozharness: 2017-01-19 21:12:51.174051Z] Running download-and-extract step. 13:12:51 INFO - Running pre-action listener: _resource_record_pre_action 13:12:51 INFO - Running main action method: download_and_extract 13:12:51 INFO - mkdir: /builds/slave/test/build/tests 13:12: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')]} 13:12:51 INFO - trying https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/target.test_packages.json 13:12:51 INFO - Downloading https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:12:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:12:51 INFO - Downloaded 896 bytes. 13:12:51 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:12:51 INFO - Using the following test package requirements: 13:12:51 INFO - {u'common': [u'target.common.tests.zip'], 13:12:51 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:12:51 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:12:51 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:12:51 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:12:51 INFO - u'mozbase': [u'target.common.tests.zip'], 13:12:51 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:12:51 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:12:51 INFO - u'web-platform': [u'target.common.tests.zip', 13:12:51 INFO - u'target.web-platform.tests.zip'], 13:12:51 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:12:51 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 13:12:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/target.common.tests.zip 13:12:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:12:51 INFO - Fetch https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/target.common.tests.zip into memory 13:12:52 INFO - Expected file size: 20313714 13:12:52 INFO - Obtained file size: 20313714 13:12:56 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 13:12:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/target.common.tests.zip 13:12:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:12:56 INFO - Fetch https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/target.common.tests.zip into memory 13:12:57 INFO - Expected file size: 20313714 13:12:57 INFO - Obtained file size: 20313714 13:13:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/target.talos.tests.zip 13:13:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:13:01 INFO - Fetch https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/target.talos.tests.zip into memory 13:13:02 INFO - Expected file size: 14403463 13:13:02 INFO - Obtained file size: 14403463 13:13:02 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')]} 13:13:02 INFO - trying https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/target.tar.bz2 13:13:02 INFO - Downloading https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:13:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:13:03 INFO - Downloaded 55842176 bytes. 13:13:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/target.tar.bz2 13:13:03 INFO - mkdir: /builds/slave/test/properties 13:13:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:13:03 INFO - Writing to file /builds/slave/test/properties/build_url 13:13:03 INFO - Contents: 13:13:03 INFO - build_url:https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/target.tar.bz2 13:13:03 INFO - Running post-action listener: _resource_record_post_action 13:13:03 INFO - Running post-action listener: set_extra_try_arguments 13:13:03 INFO - [mozharness: 2017-01-19 21:13:03.822638Z] Finished download-and-extract step (success) 13:13:03 INFO - [mozharness: 2017-01-19 21:13:03.822733Z] Running populate-webroot step. 13:13:03 INFO - Running pre-action listener: _resource_record_pre_action 13:13:03 INFO - Running main action method: populate_webroot 13:13:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:13:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:13:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:13:03 INFO - '--tppagecycles', 13:13:03 INFO - '7'], 13:13:03 INFO - 'tests': ['tsvgm']}}, 13:13:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:13:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:13:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:13:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:13:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:13:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:13:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:13:03 INFO - 'talos_options': ['--disable-e10s'], 13:13:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:13:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:13:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:13:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:13:03 INFO - 'talos_options': ['--disable-e10s'], 13:13:03 INFO - 'tests': ['damp', 'tps']}, 13:13:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:13:03 INFO - 'tests': ['damp', 'tps']}, 13:13:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:13:03 INFO - 'tests': ['dromaeo_dom']}, 13:13:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:13:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:13:03 INFO - 'tests': ['basic_compositor_video']}, 13:13:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:13:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:13:03 INFO - 'tests': ['a11yr', 13:13:03 INFO - 'ts_paint', 13:13:03 INFO - 'tpaint', 13:13:03 INFO - 'sessionrestore', 13:13:03 INFO - 'sessionrestore_no_auto_restore', 13:13:03 INFO - 'tabpaint']}, 13:13:03 INFO - 'other-e10s': {'tests': ['a11yr', 13:13:03 INFO - 'ts_paint', 13:13:03 INFO - 'tpaint', 13:13:03 INFO - 'sessionrestore', 13:13:03 INFO - 'sessionrestore_no_auto_restore', 13:13:03 INFO - 'tabpaint']}, 13:13:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:13:03 INFO - 'ts_paint', 13:13:03 INFO - 'tpaint', 13:13:03 INFO - 'sessionrestore', 13:13:03 INFO - 'sessionrestore_no_auto_restore', 13:13:03 INFO - 'tabpaint']}, 13:13:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:13:03 INFO - 'ts_paint', 13:13:03 INFO - 'tpaint', 13:13:03 INFO - 'sessionrestore', 13:13:03 INFO - 'sessionrestore_no_auto_restore', 13:13:03 INFO - 'tabpaint']}, 13:13:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:13:03 INFO - 'tests': ['a11yr', 13:13:03 INFO - 'ts_paint', 13:13:03 INFO - 'tpaint', 13:13:03 INFO - 'sessionrestore', 13:13:03 INFO - 'sessionrestore_no_auto_restore', 13:13:03 INFO - 'tabpaint']}, 13:13:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:13:03 INFO - 'tests': ['a11yr', 13:13:03 INFO - 'ts_paint', 13:13:03 INFO - 'tpaint', 13:13:03 INFO - 'sessionrestore', 13:13:03 INFO - 'sessionrestore_no_auto_restore', 13:13:03 INFO - 'tabpaint']}, 13:13:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:13:03 INFO - 'tests': ['tsvgx', 13:13:03 INFO - 'tsvgr_opacity', 13:13:03 INFO - 'tart', 13:13:03 INFO - 'tscrollx', 13:13:03 INFO - 'cart', 13:13:03 INFO - 'tsvg_static']}, 13:13:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:13:03 INFO - 'tsvgr_opacity', 13:13:03 INFO - 'tart', 13:13:03 INFO - 'tscrollx', 13:13:03 INFO - 'cart', 13:13:03 INFO - 'tsvg_static']}, 13:13:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:13:03 INFO - 'talos_options': ['--disable-e10s'], 13:13:03 INFO - 'tests': ['tp5o']}, 13:13:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:13:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:13:03 INFO - 'talos_options': ['--disable-e10s', 13:13:03 INFO - '--xperf_path', 13:13:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:13:03 INFO - 'tests': ['tp5n']}, 13:13:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:13:03 INFO - 'talos_options': ['--xperf_path', 13:13:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:13:03 INFO - 'tests': ['tp5n']}}, 13:13:03 INFO - 'talos.zip': {'path': '', 13:13:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:13:03 INFO - Running post-action listener: _resource_record_post_action 13:13:03 INFO - [mozharness: 2017-01-19 21:13:03.835721Z] Finished populate-webroot step (success) 13:13:03 INFO - [mozharness: 2017-01-19 21:13:03.835814Z] Running create-virtualenv step. 13:13:03 INFO - Running pre-action listener: _resource_record_pre_action 13:13:03 INFO - Running main action method: create_virtualenv 13:13:03 INFO - Creating virtualenv /builds/slave/test/build/venv 13:13:03 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 13:13:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:13:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:13:03 INFO - Using real prefix '/usr' 13:13:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:13:04 INFO - Installing distribute.............................................................................................................................................................................................done. 13:13:06 INFO - Installing pip.................done. 13:13:06 INFO - Return code: 0 13:13:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:13:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:13:06 INFO - Reading from file tmpfile_stdout 13:13:06 INFO - Output received: 13:13:06 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) 13:13:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:13:06 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')]} 13:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:06 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')]} 13:13:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:06 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 0xed31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1245630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce850>, '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 0x12436d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1243b60>, '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': 'df17445c3590ff7897617a0e00000225-1484860367.21562-932785477', '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 13:13:06 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 13:13:06 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 13:13:06 INFO - Using env: {'DISPLAY': ':0', 13:13:06 INFO - 'HOME': '/home/cltbld', 13:13:06 INFO - 'LANG': 'en_US.UTF-8', 13:13:06 INFO - 'LANGUAGE': 'en_US:en', 13:13:06 INFO - 'LOGNAME': 'cltbld', 13:13:06 INFO - 'MAIL': '/var/mail/cltbld', 13:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:06 INFO - 'MOZ_NO_REMOTE': '1', 13:13:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:06 INFO - 'NO_EM_RESTART': '1', 13:13:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:06 INFO - 'PWD': '/builds/slave/test', 13:13:06 INFO - 'SHELL': '/bin/bash', 13:13:06 INFO - 'SHLVL': '1', 13:13:06 INFO - 'TERM': 'linux', 13:13:06 INFO - 'TMOUT': '86400', 13:13:06 INFO - 'USER': 'cltbld', 13:13:06 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1484860367.21562-932785477', 13:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:06 INFO - '_': '/tools/buildbot/bin/python'} 13:13:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:06 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 13:13:06 INFO - Cleaning up... 13:13:06 INFO - Return code: 0 13:13:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:13:06 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')]} 13:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:06 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')]} 13:13:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:06 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 0xed31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1245630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce850>, '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 0x12436d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1243b60>, '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': 'df17445c3590ff7897617a0e00000225-1484860367.21562-932785477', '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 13:13:06 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 13:13:06 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 13:13:06 INFO - Using env: {'DISPLAY': ':0', 13:13:06 INFO - 'HOME': '/home/cltbld', 13:13:06 INFO - 'LANG': 'en_US.UTF-8', 13:13:06 INFO - 'LANGUAGE': 'en_US:en', 13:13:06 INFO - 'LOGNAME': 'cltbld', 13:13:06 INFO - 'MAIL': '/var/mail/cltbld', 13:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:06 INFO - 'MOZ_NO_REMOTE': '1', 13:13:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:06 INFO - 'NO_EM_RESTART': '1', 13:13:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:06 INFO - 'PWD': '/builds/slave/test', 13:13:06 INFO - 'SHELL': '/bin/bash', 13:13:06 INFO - 'SHLVL': '1', 13:13:06 INFO - 'TERM': 'linux', 13:13:06 INFO - 'TMOUT': '86400', 13:13:06 INFO - 'USER': 'cltbld', 13:13:06 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1484860367.21562-932785477', 13:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:06 INFO - '_': '/tools/buildbot/bin/python'} 13:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:07 INFO - Downloading/unpacking psutil>=3.1.1 13:13:07 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 13:13:07 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 13:13:07 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 13:13:07 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 13:13:07 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 13:13:07 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 13:13:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:13:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:13:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:13:09 INFO - Installing collected packages: psutil 13:13:09 INFO - Running setup.py install for psutil 13:13:09 INFO - building 'psutil._psutil_linux' extension 13:13:09 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 13:13:09 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 13:13:09 INFO - building 'psutil._psutil_posix' extension 13:13:09 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 13:13:09 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 13:13:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:13:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:13:09 INFO - Successfully installed psutil 13:13:09 INFO - Cleaning up... 13:13:09 INFO - Return code: 0 13:13:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:09 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 0xed31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1245630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce850>, '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 0x12436d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1243b60>, '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': 'df17445c3590ff7897617a0e00000225-1484860367.21562-932785477', '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 13:13:09 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 13:13:09 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 13:13:09 INFO - Using env: {'DISPLAY': ':0', 13:13:09 INFO - 'HOME': '/home/cltbld', 13:13:09 INFO - 'LANG': 'en_US.UTF-8', 13:13:09 INFO - 'LANGUAGE': 'en_US:en', 13:13:09 INFO - 'LOGNAME': 'cltbld', 13:13:09 INFO - 'MAIL': '/var/mail/cltbld', 13:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:09 INFO - 'MOZ_NO_REMOTE': '1', 13:13:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:09 INFO - 'NO_EM_RESTART': '1', 13:13:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:09 INFO - 'PWD': '/builds/slave/test', 13:13:09 INFO - 'SHELL': '/bin/bash', 13:13:09 INFO - 'SHLVL': '1', 13:13:09 INFO - 'TERM': 'linux', 13:13:09 INFO - 'TMOUT': '86400', 13:13:09 INFO - 'USER': 'cltbld', 13:13:09 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1484860367.21562-932785477', 13:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:09 INFO - '_': '/tools/buildbot/bin/python'} 13:13:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:13:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:13:12 INFO - Installing collected packages: mozsystemmonitor 13:13:12 INFO - Running setup.py install for mozsystemmonitor 13:13:12 INFO - Successfully installed mozsystemmonitor 13:13:12 INFO - Cleaning up... 13:13:12 INFO - Return code: 0 13:13:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:12 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 0xed31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1245630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce850>, '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 0x12436d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1243b60>, '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': 'df17445c3590ff7897617a0e00000225-1484860367.21562-932785477', '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 13:13:12 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 13:13:12 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 13:13:12 INFO - Using env: {'DISPLAY': ':0', 13:13:12 INFO - 'HOME': '/home/cltbld', 13:13:12 INFO - 'LANG': 'en_US.UTF-8', 13:13:12 INFO - 'LANGUAGE': 'en_US:en', 13:13:12 INFO - 'LOGNAME': 'cltbld', 13:13:12 INFO - 'MAIL': '/var/mail/cltbld', 13:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:12 INFO - 'MOZ_NO_REMOTE': '1', 13:13:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:12 INFO - 'NO_EM_RESTART': '1', 13:13:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:12 INFO - 'PWD': '/builds/slave/test', 13:13:12 INFO - 'SHELL': '/bin/bash', 13:13:12 INFO - 'SHLVL': '1', 13:13:12 INFO - 'TERM': 'linux', 13:13:12 INFO - 'TMOUT': '86400', 13:13:12 INFO - 'USER': 'cltbld', 13:13:12 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1484860367.21562-932785477', 13:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:12 INFO - '_': '/tools/buildbot/bin/python'} 13:13:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:12 INFO - Downloading/unpacking jsonschema==2.5.1 13:13:12 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 13:13:12 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 13:13:12 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 13:13:12 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 13:13:12 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 13:13:12 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 13:13:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:13:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:13:14 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 13:13:14 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 13:13:14 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 13:13:14 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 13:13:14 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 13:13:14 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 13:13:14 INFO - Downloading functools32-3.2.3-2.tar.gz 13:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:13:14 INFO - warning: no files found matching '*.txt' 13:13:14 INFO - no previously-included directories found matching 'build' 13:13:14 INFO - no previously-included directories found matching 'dist' 13:13:14 INFO - no previously-included directories found matching '.git*' 13:13:14 INFO - Installing collected packages: jsonschema, functools32 13:13:14 INFO - Running setup.py install for functools32 13:13:14 INFO - warning: no files found matching '*.txt' 13:13:14 INFO - no previously-included directories found matching 'build' 13:13:14 INFO - no previously-included directories found matching 'dist' 13:13:14 INFO - no previously-included directories found matching '.git*' 13:13:14 INFO - Successfully installed jsonschema functools32 13:13:14 INFO - Cleaning up... 13:13:14 INFO - Return code: 0 13:13:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:13:14 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')]} 13:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:14 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')]} 13:13:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:14 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 0xed31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1245630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce850>, '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 0x12436d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1243b60>, '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': 'df17445c3590ff7897617a0e00000225-1484860367.21562-932785477', '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 13:13:14 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 13:13:14 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 13:13:14 INFO - Using env: {'DISPLAY': ':0', 13:13:14 INFO - 'HOME': '/home/cltbld', 13:13:14 INFO - 'LANG': 'en_US.UTF-8', 13:13:14 INFO - 'LANGUAGE': 'en_US:en', 13:13:14 INFO - 'LOGNAME': 'cltbld', 13:13:14 INFO - 'MAIL': '/var/mail/cltbld', 13:13:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:14 INFO - 'MOZ_NO_REMOTE': '1', 13:13:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:14 INFO - 'NO_EM_RESTART': '1', 13:13:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:14 INFO - 'PWD': '/builds/slave/test', 13:13:14 INFO - 'SHELL': '/bin/bash', 13:13:14 INFO - 'SHLVL': '1', 13:13:14 INFO - 'TERM': 'linux', 13:13:14 INFO - 'TMOUT': '86400', 13:13:14 INFO - 'USER': 'cltbld', 13:13:14 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1484860367.21562-932785477', 13:13:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:14 INFO - '_': '/tools/buildbot/bin/python'} 13:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:13:15 INFO - Cleaning up... 13:13:15 INFO - Return code: 0 13:13:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:15 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 0xed31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1245630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce850>, '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 0x12436d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1243b60>, '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': 'df17445c3590ff7897617a0e00000225-1484860367.21562-932785477', '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 13:13:15 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 13:13:15 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 13:13:15 INFO - Using env: {'DISPLAY': ':0', 13:13:15 INFO - 'HOME': '/home/cltbld', 13:13:15 INFO - 'LANG': 'en_US.UTF-8', 13:13:15 INFO - 'LANGUAGE': 'en_US:en', 13:13:15 INFO - 'LOGNAME': 'cltbld', 13:13:15 INFO - 'MAIL': '/var/mail/cltbld', 13:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:15 INFO - 'MOZ_NO_REMOTE': '1', 13:13:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:15 INFO - 'NO_EM_RESTART': '1', 13:13:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:15 INFO - 'PWD': '/builds/slave/test', 13:13:15 INFO - 'SHELL': '/bin/bash', 13:13:15 INFO - 'SHLVL': '1', 13:13:15 INFO - 'TERM': 'linux', 13:13:15 INFO - 'TMOUT': '86400', 13:13:15 INFO - 'USER': 'cltbld', 13:13:15 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1484860367.21562-932785477', 13:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:15 INFO - '_': '/tools/buildbot/bin/python'} 13:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:15 INFO - Downloading/unpacking blobuploader==1.2.4 13:13:15 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 13:13:15 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 13:13:15 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 13:13:15 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 13:13:15 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 13:13:15 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 13:13:17 INFO - Downloading blobuploader-1.2.4.tar.gz 13:13:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:13:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:13:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:18 INFO - Downloading docopt-0.6.1.tar.gz 13:13:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:13:18 INFO - Installing collected packages: blobuploader, requests, docopt 13:13:18 INFO - Running setup.py install for blobuploader 13:13:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:13:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:13:18 INFO - Running setup.py install for requests 13:13:18 INFO - Running setup.py install for docopt 13:13:18 INFO - Successfully installed blobuploader requests docopt 13:13:18 INFO - Cleaning up... 13:13:18 INFO - Return code: 0 13:13:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:13:18 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')]} 13:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:18 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')]} 13:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:18 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 0xed31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1245630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce850>, '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 0x12436d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1243b60>, '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': 'df17445c3590ff7897617a0e00000225-1484860367.21562-932785477', '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 13:13:18 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 13:13:18 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 13:13:18 INFO - Using env: {'DISPLAY': ':0', 13:13:18 INFO - 'HOME': '/home/cltbld', 13:13:18 INFO - 'LANG': 'en_US.UTF-8', 13:13:18 INFO - 'LANGUAGE': 'en_US:en', 13:13:18 INFO - 'LOGNAME': 'cltbld', 13:13:18 INFO - 'MAIL': '/var/mail/cltbld', 13:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:18 INFO - 'MOZ_NO_REMOTE': '1', 13:13:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:18 INFO - 'NO_EM_RESTART': '1', 13:13:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:18 INFO - 'PWD': '/builds/slave/test', 13:13:18 INFO - 'SHELL': '/bin/bash', 13:13:18 INFO - 'SHLVL': '1', 13:13:18 INFO - 'TERM': 'linux', 13:13:18 INFO - 'TMOUT': '86400', 13:13:18 INFO - 'USER': 'cltbld', 13:13:18 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1484860367.21562-932785477', 13:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:18 INFO - '_': '/tools/buildbot/bin/python'} 13:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:13:18 INFO - Running setup.py (path:/tmp/pip-vZO8gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:13:19 INFO - Running setup.py (path:/tmp/pip-RMkQyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:13:19 INFO - Running setup.py (path:/tmp/pip-cE587U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:13:19 INFO - Running setup.py (path:/tmp/pip-niIZev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:13:19 INFO - Running setup.py (path:/tmp/pip-hN8uOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:13:19 INFO - Running setup.py (path:/tmp/pip-_FazOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:13:19 INFO - Running setup.py (path:/tmp/pip-lN5x6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:13:19 INFO - Running setup.py (path:/tmp/pip-z3T9Qj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:13:19 INFO - Running setup.py (path:/tmp/pip-OPtWQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:13:19 INFO - Running setup.py (path:/tmp/pip-_j_cgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:13:19 INFO - Running setup.py (path:/tmp/pip-x3t70I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:13:19 INFO - Running setup.py (path:/tmp/pip-7g1KoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:13:19 INFO - Running setup.py (path:/tmp/pip-30yam_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:13:19 INFO - Running setup.py (path:/tmp/pip-2WcYas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:13:19 INFO - Running setup.py (path:/tmp/pip-vVJKr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:13:20 INFO - Running setup.py (path:/tmp/pip-zbEYrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:13:20 INFO - Running setup.py (path:/tmp/pip-00I09I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:13:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:13:20 INFO - Running setup.py install for manifestparser 13:13:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:13:20 INFO - Running setup.py install for mozcrash 13:13:20 INFO - Running setup.py install for mozdebug 13:13:20 INFO - Running setup.py install for mozdevice 13:13:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:13:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:13:20 INFO - Running setup.py install for mozfile 13:13:20 INFO - Running setup.py install for mozhttpd 13:13:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:13:20 INFO - Running setup.py install for mozinfo 13:13:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:13:20 INFO - Running setup.py install for mozInstall 13:13:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:13:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:13:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:13:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:13:20 INFO - Running setup.py install for mozleak 13:13:21 INFO - Running setup.py install for mozlog 13:13:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:13:21 INFO - Running setup.py install for moznetwork 13:13:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:13:21 INFO - Running setup.py install for mozprocess 13:13:21 INFO - Running setup.py install for mozprofile 13:13:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:13:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:13:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:13:21 INFO - Running setup.py install for mozrunner 13:13:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:13:21 INFO - Running setup.py install for mozscreenshot 13:13:21 INFO - Running setup.py install for moztest 13:13:21 INFO - Running setup.py install for mozversion 13:13:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:13:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:13:21 INFO - Cleaning up... 13:13:21 INFO - Return code: 0 13:13:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:13: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')]} 13:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13: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')]} 13:13:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:21 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 0xed31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1245630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce850>, '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 0x12436d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1243b60>, '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': 'df17445c3590ff7897617a0e00000225-1484860367.21562-932785477', '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 13:13:21 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 13:13:21 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 13:13:21 INFO - Using env: {'DISPLAY': ':0', 13:13:21 INFO - 'HOME': '/home/cltbld', 13:13:21 INFO - 'LANG': 'en_US.UTF-8', 13:13:21 INFO - 'LANGUAGE': 'en_US:en', 13:13:21 INFO - 'LOGNAME': 'cltbld', 13:13:21 INFO - 'MAIL': '/var/mail/cltbld', 13:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:21 INFO - 'MOZ_NO_REMOTE': '1', 13:13:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:21 INFO - 'NO_EM_RESTART': '1', 13:13:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:21 INFO - 'PWD': '/builds/slave/test', 13:13:21 INFO - 'SHELL': '/bin/bash', 13:13:21 INFO - 'SHLVL': '1', 13:13:21 INFO - 'TERM': 'linux', 13:13:21 INFO - 'TMOUT': '86400', 13:13:21 INFO - 'USER': 'cltbld', 13:13:21 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1484860367.21562-932785477', 13:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:21 INFO - '_': '/tools/buildbot/bin/python'} 13:13:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:13:22 INFO - Running setup.py (path:/tmp/pip-g2f4oF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:13:22 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)) 13:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:13:22 INFO - Running setup.py (path:/tmp/pip-hR_wvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:13:22 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)) 13:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:13:22 INFO - Running setup.py (path:/tmp/pip-yogJ_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:13:22 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)) 13:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:13:22 INFO - Running setup.py (path:/tmp/pip-9JKESq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:13:22 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)) 13:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:13:22 INFO - Running setup.py (path:/tmp/pip-QHEfQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:13:22 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)) 13:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:13:22 INFO - Running setup.py (path:/tmp/pip-FokwWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:13:22 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)) 13:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:13:22 INFO - Running setup.py (path:/tmp/pip-_Qq2i2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:13:22 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)) 13:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:13:22 INFO - Running setup.py (path:/tmp/pip-bY7erU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:13:22 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)) 13:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:13:22 INFO - Running setup.py (path:/tmp/pip-WN9OPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:13:22 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)) 13:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:13:22 INFO - Running setup.py (path:/tmp/pip-N5FFd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:13:22 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)) 13:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:13:22 INFO - Running setup.py (path:/tmp/pip-FL6JZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:13:23 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)) 13:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:13:23 INFO - Running setup.py (path:/tmp/pip-FWMosE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:13:23 INFO - Running setup.py (path:/tmp/pip-7GXuxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:13:23 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)) 13:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:13:23 INFO - Running setup.py (path:/tmp/pip-K5cLPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:13:23 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)) 13:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:13:23 INFO - Running setup.py (path:/tmp/pip-30M_3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:13:23 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)) 13:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:13:23 INFO - Running setup.py (path:/tmp/pip-HoRSpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:13:23 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)) 13:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:13:23 INFO - Running setup.py (path:/tmp/pip-JHZJ6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:13:23 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)) 13:13:23 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)) 13:13:23 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)) 13:13:23 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)) 13:13:23 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)) 13:13:23 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)) 13:13:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:25 INFO - Downloading blessings-1.6.tar.gz 13:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:13:25 INFO - Installing collected packages: blessings 13:13:25 INFO - Running setup.py install for blessings 13:13:25 INFO - Successfully installed blessings 13:13:25 INFO - Cleaning up... 13:13:25 INFO - Return code: 0 13:13:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:13:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:13:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:13:25 INFO - Reading from file tmpfile_stdout 13:13:25 INFO - Current package versions: 13:13:25 INFO - argparse == 1.2.1 13:13:25 INFO - blessings == 1.6 13:13:25 INFO - blobuploader == 1.2.4 13:13:25 INFO - docopt == 0.6.1 13:13:25 INFO - functools32 == 3.2.3-2 13:13:25 INFO - jsonschema == 2.5.1 13:13:25 INFO - manifestparser == 1.1 13:13:25 INFO - mozInstall == 1.12 13:13:25 INFO - mozcrash == 1.0 13:13:25 INFO - mozdebug == 0.1 13:13:25 INFO - mozdevice == 0.49 13:13:25 INFO - mozfile == 1.2 13:13:25 INFO - mozhttpd == 0.7 13:13:25 INFO - mozinfo == 0.9 13:13:25 INFO - mozleak == 0.1 13:13:25 INFO - mozlog == 3.4 13:13:25 INFO - moznetwork == 0.27 13:13:25 INFO - mozprocess == 0.24 13:13:25 INFO - mozprofile == 0.28 13:13:25 INFO - mozrunner == 6.13 13:13:25 INFO - mozscreenshot == 0.1 13:13:25 INFO - mozsystemmonitor == 0.3 13:13:25 INFO - moztest == 0.8 13:13:25 INFO - mozversion == 1.4 13:13:25 INFO - psutil == 3.1.1 13:13:25 INFO - requests == 1.2.3 13:13:25 INFO - wsgiref == 0.1.2 13:13:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:25 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 0xed31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1245630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce850>, '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 0x12436d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1243b60>, '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': 'df17445c3590ff7897617a0e00000225-1484860367.21562-932785477', '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 13:13:25 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 13:13:25 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 13:13:25 INFO - Using env: {'DISPLAY': ':0', 13:13:25 INFO - 'HOME': '/home/cltbld', 13:13:25 INFO - 'LANG': 'en_US.UTF-8', 13:13:25 INFO - 'LANGUAGE': 'en_US:en', 13:13:25 INFO - 'LOGNAME': 'cltbld', 13:13:25 INFO - 'MAIL': '/var/mail/cltbld', 13:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:25 INFO - 'MOZ_NO_REMOTE': '1', 13:13:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:25 INFO - 'NO_EM_RESTART': '1', 13:13:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:25 INFO - 'PWD': '/builds/slave/test', 13:13:25 INFO - 'SHELL': '/bin/bash', 13:13:25 INFO - 'SHLVL': '1', 13:13:25 INFO - 'TERM': 'linux', 13:13:25 INFO - 'TMOUT': '86400', 13:13:25 INFO - 'USER': 'cltbld', 13:13:25 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1484860367.21562-932785477', 13:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:25 INFO - '_': '/tools/buildbot/bin/python'} 13:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:26 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)) 13:13:26 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)) 13:13:26 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)) 13:13:26 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)) 13:13:26 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)) 13:13:26 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)) 13:13:26 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)) 13:13:26 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)) 13:13:26 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)) 13:13:26 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)) 13:13:26 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)) 13:13:26 INFO - Cleaning up... 13:13:26 INFO - Return code: 0 13:13:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1245630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce850>, '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 0x12436d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1243b60>, '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': 'df17445c3590ff7897617a0e00000225-1484860367.21562-932785477', '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 13:13:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:13:26 INFO - Using env: {'DISPLAY': ':0', 13:13:26 INFO - 'HOME': '/home/cltbld', 13:13:26 INFO - 'LANG': 'en_US.UTF-8', 13:13:26 INFO - 'LANGUAGE': 'en_US:en', 13:13:26 INFO - 'LOGNAME': 'cltbld', 13:13:26 INFO - 'MAIL': '/var/mail/cltbld', 13:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:26 INFO - 'MOZ_NO_REMOTE': '1', 13:13:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:26 INFO - 'NO_EM_RESTART': '1', 13:13:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:26 INFO - 'PWD': '/builds/slave/test', 13:13:26 INFO - 'SHELL': '/bin/bash', 13:13:26 INFO - 'SHLVL': '1', 13:13:26 INFO - 'TERM': 'linux', 13:13:26 INFO - 'TMOUT': '86400', 13:13:26 INFO - 'USER': 'cltbld', 13:13:26 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1484860367.21562-932785477', 13:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:26 INFO - '_': '/tools/buildbot/bin/python'} 13:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:13:26 INFO - Cleaning up... 13:13:26 INFO - Return code: 0 13:13:26 INFO - Running post-action listener: _resource_record_post_action 13:13:26 INFO - Running post-action listener: _start_resource_monitoring 13:13:26 INFO - Starting resource monitoring. 13:13:26 INFO - [mozharness: 2017-01-19 21:13:26.474022Z] Finished create-virtualenv step (success) 13:13:26 INFO - [mozharness: 2017-01-19 21:13:26.474527Z] Running install step. 13:13:26 INFO - Running pre-action listener: _resource_record_pre_action 13:13:26 INFO - Running main action method: install 13:13:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:13:26 INFO - Reading from file tmpfile_stdout 13:13:26 INFO - Detecting whether we're running mozinstall >=1.0... 13:13:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:13:26 INFO - Reading from file tmpfile_stdout 13:13:26 INFO - Output received: 13:13:26 INFO - Usage: mozinstall [options] installer 13:13:26 INFO - Options: 13:13:26 INFO - -h, --help show this help message and exit 13:13:26 INFO - -d DEST, --destination=DEST 13:13:26 INFO - Directory to install application into. [default: 13:13:26 INFO - "/builds/slave/test"] 13:13:26 INFO - --app=APP Application being installed. [default: firefox] 13:13:26 INFO - mkdir: /builds/slave/test/build/application 13:13:26 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'] 13:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:13:42 INFO - Reading from file tmpfile_stdout 13:13:42 INFO - Output received: 13:13:42 INFO - /builds/slave/test/build/application/firefox/firefox 13:13:42 INFO - Running post-action listener: _resource_record_post_action 13:13:42 INFO - [mozharness: 2017-01-19 21:13:42.870720Z] Finished install step (success) 13:13:42 INFO - [mozharness: 2017-01-19 21:13:42.870991Z] Running run-tests step. 13:13:42 INFO - Running pre-action listener: _resource_record_pre_action 13:13:42 INFO - Running main action method: run_tests 13:13:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:13:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:13:42 INFO - Python 2.7.3 13:13:42 INFO - Return code: 0 13:13:42 INFO - grabbing minidump binary from tooltool 13:13:42 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')]} 13:13:42 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 0x12ce850>, '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 0x12436d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1243b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:13:42 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 13:13:42 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 13:13:42 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 13:13:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:13:42 INFO - Return code: 0 13:13:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:13:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:13:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:13:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:13:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:13:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 13:13:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 13:13:42 INFO - Using env: {'DISPLAY': ':0', 13:13:42 INFO - 'HOME': '/home/cltbld', 13:13:42 INFO - 'LANG': 'en_US.UTF-8', 13:13:42 INFO - 'LANGUAGE': 'en_US:en', 13:13:42 INFO - 'LOGNAME': 'cltbld', 13:13:42 INFO - 'MAIL': '/var/mail/cltbld', 13:13:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:13:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:13:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:42 INFO - 'MOZ_NO_REMOTE': '1', 13:13:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:13:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:42 INFO - 'NO_EM_RESTART': '1', 13:13:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:42 INFO - 'PWD': '/builds/slave/test', 13:13:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:13:42 INFO - 'SHELL': '/bin/bash', 13:13:42 INFO - 'SHLVL': '1', 13:13:42 INFO - 'TERM': 'linux', 13:13:42 INFO - 'TMOUT': '86400', 13:13:42 INFO - 'USER': 'cltbld', 13:13:42 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1484860367.21562-932785477', 13:13:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:42 INFO - '_': '/tools/buildbot/bin/python'} 13:13:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 13:13:43 INFO - mozversion application_buildid: 20170119151050 13:13:43 INFO - mozversion application_changeset: a3978751f45108ff1ae002ecebdc0fa23fc52b84 13:13:43 INFO - mozversion application_display_name: Nightly 13:13:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:13:43 INFO - mozversion application_name: Firefox 13:13:43 INFO - mozversion application_remotingname: firefox 13:13:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:13:43 INFO - mozversion application_vendor: Mozilla 13:13:43 INFO - mozversion application_version: 53.0a1 13:13:43 INFO - mozversion platform_buildid: 20170119151050 13:13:43 INFO - mozversion platform_changeset: a3978751f45108ff1ae002ecebdc0fa23fc52b84 13:13:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:13:43 INFO - mozversion platform_version: 53.0a1 13:13:43 INFO - using testdate: 1484860423 13:13:43 INFO - actual date: 1484860423 13:13:43 INFO - starting webserver on 'localhost:33357' 13:13:43 INFO - SUITE-START | Running 2 tests 13:13:43 INFO - TEST-START | dromaeo_css 13:13:43 INFO - operating with platform_type : linux_ 13:13:43 INFO - Initialising browser for dromaeo_css test... 13:13:43 INFO - TEST-INFO | started process 9433 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjKEcIq/profile http://localhost:33357/getInfo.html) 13:13:48 INFO - PROCESS | 9433 | __metrics Screen width/height:1600/1200 13:13:48 INFO - PROCESS | 9433 | colorDepth:24 13:13:48 INFO - PROCESS | 9433 | Browser inner width/height: 1024/697 13:13:48 INFO - PROCESS | 9433 | __metrics 13:13:49 INFO - PROCESS | 9433 | 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" 13:13:49 INFO - PROCESS | 9433 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:13:50 INFO - PROCESS | 9433 | console.error: PushService: 13:13:50 INFO - PROCESS | 9433 | stateChangeProcessEnqueue: Error transitioning state 13:13:50 INFO - PROCESS | 9433 | UnknownError 13:13:50 INFO - TEST-INFO | 9433: exit 0 13:13:50 INFO - Browser initialized. 13:13:50 INFO - Running cycle 1/1 for dromaeo_css test... 13:13:50 INFO - TEST-INFO | started process 9516 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjKEcIq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:14:02 INFO - PROCESS | 9516 | RSS: Main: 152223744 13:14:02 INFO - PROCESS | 9516 | 13:17:08 INFO - PROCESS | 9516 | Cycle 1(1): loaded http://localhost:33357/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33357/tests/dromaeo/cssquery-ext.html) 13:17:09 INFO - PROCESS | 9516 | RSS: Main: 280915968 13:17:09 INFO - PROCESS | 9516 | 13:18:52 INFO - PROCESS | 9516 | ************************* 13:18:52 INFO - PROCESS | 9516 | A coding exception was thrown and uncaught in a Task. 13:18:52 INFO - PROCESS | 9516 | 13:18:52 ERROR - PROCESS | 9516 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:18:52 INFO - PROCESS | 9516 | Full stack: 13:18:52 INFO - PROCESS | 9516 | ************************* 13:20:12 INFO - PROCESS | 9516 | Cycle 1(1): loaded http://localhost:33357/tests/dromaeo/cssquery-ext.html (next: http://localhost:33357/tests/dromaeo/cssquery-jquery.html) 13:20:12 INFO - PROCESS | 9516 | RSS: Main: 236584960 13:20:12 INFO - PROCESS | 9516 | 13:23:15 INFO - PROCESS | 9516 | Cycle 1(1): loaded http://localhost:33357/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33357/tests/dromaeo/cssquery-mootools.html) 13:23:15 INFO - PROCESS | 9516 | RSS: Main: 246542336 13:23:15 INFO - PROCESS | 9516 | 13:26:18 INFO - PROCESS | 9516 | Cycle 1(1): loaded http://localhost:33357/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33357/tests/dromaeo/cssquery-prototype.html) 13:26:18 INFO - PROCESS | 9516 | RSS: Main: 197222400 13:26:18 INFO - PROCESS | 9516 | 13:29:21 INFO - PROCESS | 9516 | Cycle 1(1): loaded http://localhost:33357/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33357/tests/dromaeo/cssquery-yui.html) 13:29:22 INFO - PROCESS | 9516 | RSS: Main: 186343424 13:29:22 INFO - PROCESS | 9516 | 13:32:25 INFO - PROCESS | 9516 | Cycle 1(1): loaded http://localhost:33357/tests/dromaeo/cssquery-yui.html (next: http://localhost:33357/tests/dromaeo/cssquery-dojo.html) 13:32:25 INFO - PROCESS | 9516 | RSS: Main: 278949888 13:32:25 INFO - PROCESS | 9516 | 13:32:25 INFO - PROCESS | 9516 | __start_tp_report 13:32:25 INFO - PROCESS | 9516 | _x_x_mozilla_page_load 13:32:25 INFO - PROCESS | 9516 | _x_x_mozilla_page_load_details 13:32:25 INFO - PROCESS | 9516 | |i|pagename|runs| 13:32:25 INFO - PROCESS | 9516 | |0;dojo.html;2612.9216123516294;2632.6972398174216;2652.933676658083;2667.5198464276436;2679.866006699666;4733.171694953387;4784.90430191396;4816.446108697501;4888.217885138379;4918.311436398907;4819.421669399677;4821.614270858332;4877;4934.58056065234;4959.305697202394;4426.933595996063;4437.245668236407;4493.438320209973;4528.818847246106;4529.433820772403;4251.893702657428;4562.703424277428;4575;4628.074385122972;4659.231226847566;4372.060007098489;4478.977605111986;4506.52681468446;4510.616597589176;4586;4408.625266852321;4462.509123996358;4499.842505512324;4501.977490112561;4576.725396476222;4478.843240486567;4485.372047913294;4502.527234640348;4503.527129651405;4533.569310915458;4862.7785605143545;4888.975555122237;4917.459079501252;4919.0899683558655;4964.87587810304;5073.188289873602;5109.284700141983;5141.562967147797;5174.327337446108;5186.844394668166;5237.685738855643;5239.73801309933;5246.658967167122;5262.315898933152;5288.206768984644;4887.36464259644;4895.632827537949;4900.09348270564;4911.263310503382;4948.950510494921;5146.202338637517;5197.298364720715;5238.68567885928;5255.527002569787;5349.22436246742;5076.959223359277;5079.288899554065;5081.441041485434;5101.107306221396;5131.281620573122;5058.873528161826;5098.260752190911;5153.922691159635;5209.218617207449;5271.65734227274;5038.345015148007;5051.06555287273;5132.820351287762;5135.075686376414;5140.1004824155625;5079.568236699848;5082.440931497532;5085.364329458817;5140.563052140536;5144.768485418165;4301.397804307399;4301.526832048472;4305.31115021595;4308.418363520947;4345.044090300129;3726.7391282609956;3749.1751814600743;3751.0622344413896;3793.79134147619;3815.389537673959;4480.305552639346;4518.525554816762;4529;4541.409616749801;4585.335126406652;5279.656822306538;5287.576993840484;5291.894162116736;5307.681539107666;5336.866578335573;4407.316865885793;4493.662975276802;4542.863714088583;4543.318502224627;4584.404027476407;4632.374629424984;4643.814247430132;4657.650676199299;4661.463931647836;4734;4880.633952453509;4902.975485122552;4907;4919.0407870464915;4953.108440480748;5233.371995360581;5244.501772331622;5259.658122222043;5266.89466210666;5267.367915850123;4746.9525304747895;4786.688865223749;4828.589569886599;4869.683470574401;4882.414110306786;5103.209002604603;5105.33630628016;5121.718305493234;5124.538791508633;5154.381474223117;5165.431802501797;5197.792088316425;5198.584113271005;5198.870028249324;5233.162693968947;4932.580730637793;4989.825356112518;4995.300657907823;5005.6996580205305;5100.107481190703;5058;5065.746712664426;5081.11080560893;5112.3865136183895;5123.052235336475;4887.144749668722;4913.28757330178;4984.37695288089;4993.700377977333;5015.473375295687;5064.088464076502;5073.086844368049;5105.183170692671;5109.7189654567865;5178.0679477694375;4936.901261974668;4962.181240095344;4966.404031516096;4974.452810190948;5026.296318515484 13:32:25 INFO - PROCESS | 9516 | |1;ext.html;527.9049771041214;538.3244028743926;546.5409056392631;550.1555112901697;562.0922210629834;29320.135972805445;39792.60207397925;41643.79178104105;41890;45704.54295457045;41867.58132418675;42425.78787106068;42461.57538424615;42519.36220956688;42526.362104568456;7610.467267291278;7779.9611001945195;7784.883226751604;7785.532868027908;7787.883181752279;7393.852122957537;7538.849223015536;9668.516574171299;9949.75125621858;9968.6510972116;10074.546645400938;10132.189424845994;10142.188624910026;10142.695719128438;10143.442110683909;10060.39637621745;10080.64717734883;10104.747381315452;10123.696289111338;10125.088742013255;9959.55182016811;10002.049805268487;10020.59917603295;10032.297739158263;10035.548400322003;39103.60896391028;39388.21223575541;39417.211655766725;39436.802815986026;39456;3575.213453040327;3671.706263498914;3687.723420743455;3700.1674623209833;3708.9258214835822;28727.71272287271;28813.42373152525;28949.276268093254;28969.130926072252;30364.089077327717;3191.872325106993;3198.696123868229;3220.5974253218346;3230.176305042199;3247;237187;238115;238284;238820;239375;52273.47726522762;52523.21215181775;52658.736706316224;52719.736401318514;52733.7363313181;55286;55333.72333138389;55335.723321383135;55356.44643553594;55362.72318638381;14102.858971410154;14735.852641473663;14798.852011479747;14821;14824.851751482347;9035.50304733246;10660.307080039773;10660.41367724767;10670.253082284165;10676.733081673021;13682.179069255877;14872.70254594902;15440.150791706565;15708.293126809092;15929.522114336589;5785.855353616109;5803.20100768763;5877.353491115974;5910.615809972338;5981.641101533834;804.6861723927673;823.6375994562374;836.6695155413578;837.3636036612219;847.2332539052168;26505.734942650713;27701.77533556975;27916.72083279182;28011.299717507227;28060.579091313648;930.8324501589778;941.7786820097272;963.5904740485265;974.8732664753678;974.9268804839666;12338.136330456782;12774.361281935866;12943.158694684815;13011.414486348138;13026.674333141747;329245;329740;330362;331515;332977;40522.797386012884;40525.39211911824;40545;40628.18743625111;40741;1232.5008371609513;1242.9316387598587;1254.4543123741203;1258.7230809221955;1264.9367531623382;22301.888490558093;22383.77616223817;23476.530469390174;23534.882325588263;23573.17493887706;34294;34408.65591344055;34409.311813764085;34437;34569;265000;270131;270299;270723;271032;21112.68330975006;21395.893020534797;21413.678794817777;22084.88957555202;23186;34496.827515862264;34624.65375346315;34919.82540087283;35001.8249908759;35474;30369.84815075999;30696.386072278878;31132.688673112978;31169.68830311668;31345.216369590944;30530.847345764018;30531.847340763154;30540.84729576338;30853.537196942514;31747.682523174473;30401;30791.2302192447;30863.69136308698;31124.533132002583;31197.8440107798;25950.740492594832;37333.43999840059;39882;40330.59669403268;43367.56632433635;28066.158015259574;30485;31013;31073.223169420944;31622.841885790425 13:32:25 INFO - PROCESS | 9516 | |2;jquery.html;362.37128581910366;383.438262944786;394.10341473148594;395.44834955237445;420.4114240063912;12840.678983025417;13962.860371396295;15625.843741562596;18162.45512634623;18257.087145642698;17287.74068388975;17840.718227625373;18049.90975045126;18205.362812301573;18243.543911402223;4565.65757568182;4792.137415265251;4806.687565308262;4809;4813.061453016663;4634;4715.339852420664;4760.143174228638;4783.162946484369;4799.7360145192;4774.785134668931;4782.163121453732;4782.450018247911;4783.61731061516;4786.736729479877;4596.471405788344;4707.999999999965;4775.785089670973;4779.976100119495;4782.234842425195;4655.11552804966;4666.440027196724;4668.6731928765;4670.252759558488;4671.6262698984;13227.140235884637;13320.134191277535;20383.286584969603;22061;22177.445563861034;2168.8683058772904;2179.869207847534;2365.8817059147145;2477.4301910560494;2501.0746023971064;9075.18323350895;9571.234301255883;9741.31810773246;9949.850752238723;9992.600295988152;1719.4325872462057;1747.8339557741995;1749.737539369092;1755.8946463212249;1780.1633232380889;75338.24661753367;76666.84999725064;77103;78361.60819195924;79758.60120699418;10058.396496210104;10342.913994030669;10453.634122805664;10511.789764204826;10528.842067368996;15065.472708455152;15103.47137850192;15123.470678526199;15132;15132.848671513364;6765.661716914135;6926.099607051051;7044.894326585106;7060.894086588705;7108.857822843514;6313.43179113882;6338.683065846782;6468.353164683588;6491.480681545465;6493.090967264587;4495.617872480811;4579.4046773919845;4587.151376995266;4677.649176311722;4687.179743544866;1854.3509771579838;1898.7721473423278;1922.8270754839536;1928.7878333383317;1931.8261356477985;793.2939683681528;830.8878301429351;835.9874601880977;839.7984483723862;846.7756044648173;16633.667326653398;16659.379533755804;17256;17623.911880440515;17721.7341739874;812.0945146161987;819.4796304346783;831.2103501673434;833.5665453963904;846.1792061700141;9058;9388.436693798258;9682.56428460721;9729.367591106555;9844.50777461124;321984;421076;456577;484567;489494;67917.48380210034;97047.51476242574;97575;101095.49452252692;102315;941.5433514745343;957.7366224288377;989.8218320702199;990.9702708918744;997.8004399120205;15782.421359368018;16055.116968566841;16098.678026439171;16957.321707131578;17033.063181525136;40810;40908.386374203816;41397.79301103475;41479;42602.57397425986;55699.16451253153;56441.717791412426;56798;57510.712446439175;57603;7818.218178182136;7851.646675899484;7958.562279074475;8139.877901831595;8244.793880153044;10482.63310784119;12239.632811015685;12508.998560230319;12736;12893.613191604267;10055.095041446304;10151.137153341753;10266.58933642646;10732.624358147428;11032.227744057838;8695.173958473935;9040.457572545669;10119.645812396531;10234.590616375262;10907;10962.616308429167;11213.831792522955;11252.26860254081;11300.43497825089;11613.941930290295;8148.918510815053;8191.303739182236;8254.339652827879;8485.151484851465;8489.283429302564;11087.501062452047;11328.886711132784;11331.546738130382;11432.82850757256;11495.655130346104 13:32:25 INFO - PROCESS | 9516 | |3;mootools.html;1372.0875617714219;1372.2864110662456;1383.979240311395;1393.2406838273134;1403.4877269796525;6620.6027638341675;6988.405985491239;7017.578945263288;7026.789196324105;7036.085308909847;5923.911141332873;6086.695665216744;6648.667566621673;6781.898271525919;6863.142107236596;2090.707300977864;2121.586290673319;2127.4468638154112;2127.946801329964;2130.2970019893396;2071.1301253473575;2107.5258066934894;2110.219218889013;2113.704081428601;2116.5872654832315;1798.514401111699;1861.5346163459135;2065.0087957780274;2134.4450442884886;2139.6469582518866;2132.509522809755;2136.508603021314;2137;2138.176801931252;2140.165335519149;2049.4978730211046;2070.6893965905083;2073.212179371829;2082.864613800113;2110.1137522240697;6973.407260382823;7015.649217539102;7016.859662806715;7023.719051237945;7028.578285302899;4172.666186705087;4287.721298115613;4294.634956028742;4308.67684923632;4309.5690430956965;2647.457271259387;2817.3660926291627;2832.985835070832;2886.235147685865;2902.721363729462;1067.5196161727254;1096.8354746787966;1112.821948488246;1155.474259212065;1172.9882701172965;8914.86627700585;8944.10558944107;8958.910410895938;8964.820703585892;8972.371933964625;3797.6012518685693;3999.5400528938962;4054.8580799671868;4075.3275709507598;4077.7553346798695;8019.238172373615;8028.036635603765;8030.879536806952;8032.236937490929;8034.638441270157;4479.350494178326;4480.820767169277;4484.641228701696;4487.685861989695;4490.236659767847;3462.151772815626;3596.2447885944243;3862.3820188769664;4011.117554138085;4085.20338533983;3426.691597756164;3455.4644030175364;3566.821658917044;3583.8566457341935;3597.406427939413;1160.158884808524;1170.9578475157116;1180.7048237940514;1187.6912002879142;1192.3978390912707;699.7900629811037;715.2239819795581;806.2622700229225;825.3892119831402;835.5362773660677;4954.232094025432;4970.527799859007;5011.273365362002;5132.307138536325;5185.196294574347;896.6771962093641;917.454114801692;917.7934964633038;920.9171174594319;965.0638880286111;3449.292894956528;3458.342914846171;3465.341585098823;3542.787432754043;3616.909577260537;8173.305269052197;8388.538630375388;8437.704680336159;8471.745847624581;8485.830283394298;8365.958170209231;8375.790605234917;8376.32989360862;8384;8396.580170991549;6471.352864713491;6662.43369313604;6677.499187560952;6690.330966903271;6690.531662783558;4653.092646933951;4890.7554622268035;4892.877678058077;5045.949540504548;5082.872928176826;7397.371223446067;7442.292982166686;7474.887876681963;7615.619219038915;7684.846303073796;7028.332308430691;7202.53183543068;7509.399248060251;7540.208278130936;7560;5193.091209038327;5344.4121146674615;5809.680467574155;5984.9401505986125;5993.130996005468;6493.188351456068;6676.232233293039;6693.330666933462;6876.243613202444;6893.138357705287;5846.970765146147;6019.398060193946;6024.1265016573225;6043.576949613484;6076.331603523698;5893.263342082239;5927.614705044159;5947.791827286197;5960;5982.042873140276;5503.449655034465;5531.2532808072;5545.528630066489;5569.637973531708;5590.021746194318;4064.4512990747053;4066.3087275163884;4110.773907435;4398.340248962553;4494.685372024058;4170.249355116108;4180.644645205191;4183.372494125905;4250.383694364238;4256.212600668886 13:32:25 INFO - PROCESS | 9516 | |4;prototype.html;361.5318162978942;364.37327796190544;364.5752698106706;368.9557253129624;374.52996489405825;4628.514006029369;4846.2972868934075;4847.36984192055;4925.8029678812845;4934.840312526553;4692.788824502897;4832.4442689090765;4857.368542089533;4859.396399188268;4866.683665561744;3933.213357328546;3948.6643635291034;3949.1311911379453;3952.7825969571663;3956.5054368203973;3857.8071096445065;3958.802059897008;3958.851932939444;3959.7624142551394;3966.5636779954184;3900.7074469414906;3912.158885839544;3912.5109361329833;3921;3921.0981474260793;3886.727929044968;3900.7074469414765;3903.2583809076186;3903.863364782233;3924.529056513237;3511.2977404519197;3522.2603253316834;3532.894013179609;3547.3614749345106;3588.282343531278;4588.954110458886;4662.790174442158;4702.27114797207;4737.857864264078;4769;4425.225585522553;4435.135148646015;4441.533638967894;4446.888827779299;4458.487273963503;5063.126708068331;5064.594832413398;5070.6957582545165;5074.3657042869645;5077.339945807022;3448.913777155566;3849.6727778138893;3860.208657225262;3861.613838616144;3863.690904727615;5273.182656688219;5309.362876454811;5320.388155362106;5324.227986941872;5340.385855626614;3710.3692372296773;3717.4795528626014;3717.5501554393268;3727.813609319523;3738.532683414573;3754.7371683982406;3776.4146557283116;3778.074371778932;3804.334241507725;3804.885853424402;4171.436856024458;4244.405783190356;4292.647815937969;4294.763787991628;4363.647269346513;5050.696958182521;5053.422754395211;5063.164577844688;5064.164412871834;5073.010762901273;1179.8171283450906;1213.5449206547544;1227.9447424865903;1259.974800504003;1269.2130878854985;852.4672079950032;862.2756884217288;865.0052439694276;869.8347314010318;870.1516021878617;4285.571442855752;4287.442632457823;4310.568943105664;4311.202427550913;4320.2655548556195;5026.824061157842;5041.243813427942;5041.521055499722;5046.637407899846;5051.419086804991;4295.72077814941;4325.956740432618;4334.544872788375;4349.695521313478;4352.238358287287;2601.8829152688177;2622.462395208978;2657.946841063168;2662.5473669476237;2688.8386696798257;4665.803924311857;4669.132347061202;4727.267273572602;4731.4795372509;4770.332153498513;5142.125838607446;5152.742362881841;5169.353830771153;5181.740912954338;5206.427292997767;4471.821127154943;4685.5782979532005;4694.765261736899;4706;4714.269288260325;4939.382577177853;5007.649464537448;5019.924701129559;5037.647364684437;5062.468440813662;4992.80028798844;4998.150684246852;5003.799848006039;5008.824691135793;5020.87447813793;4637.304404339241;4890.975545122252;4907.2393778964315;4919.966806970577;4921.876953076202;3698.1494256320657;3710.4805327253666;3710.8515659373325;3720.3489389357296;3720.404735242348;5249.291345668286;5254.448282930237;5271.314729085195;5278.788848446173;5289.18017707256;4646.37376918076;4790.233562629963;4989.725565093955;5019.548240658358;5042.319286896222;4990.6506544541535;5006.949930500794;5009.7244651544515;5013.197888337994;5016.648834581544;4838.419389673121;4964.652474326763;4981.978694367718;4987.900241995212;4998;4992.825251116194;5041.067402530543;5050.595952323732;5056.241563765465;5066.316047333563;4890.486498917705;4919.778609962489;4920.434150072644;4934.827281045146;4949.752512374295 13:32:25 INFO - PROCESS | 9516 | |5;yui.html;656.8489247473078;663.6449499517759;732.3847967707125;769.1039938471681;781.6599779096092;12679.936600317009;13617.863821361783;13619.114757540752;13635.795463068038;13640.045196836225;13098.214107153577;13170.407331670074;13175.868241317585;13210.207387556753;13254.801177982337;659.0707102984792;680.5916450129907;796.8366484870587;797.1988151907325;818.1041759273616;823.6664151018817;825.4345773145385;825.6614787936948;825.8678611422174;825.8678611422174;875.1511034296722;876.6931573949131;876.8640860666575;877.0878286581947;877.2236570634971;685.6400389795373;710.6659869861157;713.3971793834202;713.8144082538525;872.7730789994583;610.8106486989047;625.9280182778948;627.9089532017832;631.425402883374;631.8136149835809;12578.81131783024;12593.622191334274;12603.36983150848;12637.557685481055;12644.557440489538;12823.935880320632;13040.673983150402;13058.608241752763;13071.281079540622;13105.541306054338;11833.644990650295;11912.404379780975;11961.64115076549;12101.576444824388;12175;4101.712880098395;4119.196756632457;4202.432671589327;4205.306124489486;4208.72643278189;59921.7003914982;61899.69050154765;62295.37704622986;62734.058989115656;63218.683906580634;10563.683089507327;10579.259451838298;10718.571257149626;10731.946340268249;10808.351498910091;18168.273269069352;18213.63572728538;18224.36214732478;18336.358227461973;18419;6433.678316084177;6542.967285163544;6575.473962083021;6653.9667301663185;6752.493562982698;3294.1435226840713;3294.5387645729616;3295.3738789629892;3349.531065650811;3380.6619338066;2672.1315572439034;2745.958810617842;2784.1230012545984;2784.1230012545984;2787.080263513036;459.68281885498897;460.37389150754944;461.4808340616806;465.9254519276967;470.7410923991791;590.8755746685658;591.8964181268261;608.6652341212316;608.9604175728564;610.4170517156106;8175.264226219669;8205.466644668077;8498.66005359791;8897.288216942628;9116.772080697903;519.9688018718813;529.7748456905799;537.4786457136571;592.0793166625853;634.5558109323492;3685.207680348738;3791;3810.2950954073585;3886.397608370707;3997.320455522568;55131;63182.36817631857;64462.355376446576;64896;65122;58030.678772848616;58208;58259;59993.40006599878;60171.69914150401;48388.516114839105;51947;52329.215061774106;52693.736531317096;52880.47119528832;7529.887051694339;7575.373827366479;7821.491603045783;8012.118666946515;8080.83838323242;36537.81731091328;37683;37911;38512;39538.209235814546;45694.771526143486;46050.30924536067;46118;46611.300830488246;48700.26949595688;9878.753031174278;10039;10079.848802267825;10091.19270458347;10119.291649584458;11110.777784444104;11152.776944460904;11181.496832642388;11339.829902551633;11449.771004580029;9865.605375784888;10094.091531762177;10151.187904967732;10358;10661.89338106609;9905.257105716955;9966.252531060345;9984.500774961369;10016.39901605906;10091.142252908585;10279;10308.742281443025;10411.687649370531;10467.214958877963;10609.681709548726;8382.958085209535;8586.785330366542;8647.178518040777;8720.215180633773;8854.955725221333;8635.654573817228;8713.825723485621;8737.169968852948;8763.780905477413;8922.811548106329 13:32:25 INFO - PROCESS | 9516 | __end_tp_report 13:32:25 INFO - PROCESS | 9516 | __start_cc_report 13:32:25 INFO - PROCESS | 9516 | _x_x_mozilla_cycle_collect,1261 13:32:25 INFO - PROCESS | 9516 | __end_cc_report 13:32:25 INFO - PROCESS | 9516 | __startTimestamp1484861545362__endTimestamp 13:32:25 INFO - PROCESS | 9516 | 13:32:25 INFO - PROCESS | 9516 | ------- Summary: start ------- 13:32:25 INFO - PROCESS | 9516 | Number of tests: 6 13:32:25 INFO - PROCESS | 9516 | 13:32:25 INFO - PROCESS | 9516 | [#0] dojo.html Cycles:165 Average:4796.96 Median:4932.58 stddev:511.46 (10.4%) stddev-sans-first:483.48 13:32:25 INFO - PROCESS | 9516 | Values: 2612.9 2632.7 2652.9 2667.5 2679.9 4733.2 4784.9 4816.4 4888.2 4918.3 4819.4 4821.6 4877.0 4934.6 4959.3 4426.9 4437.2 4493.4 4528.8 4529.4 4251.9 4562.7 4575.0 4628.1 4659.2 4372.1 4479.0 4506.5 4510.6 4586.0 4408.6 4462.5 4499.8 4502.0 4576.7 4478.8 4485.4 4502.5 4503.5 4533.6 4862.8 4889.0 4917.5 4919.1 4964.9 5073.2 5109.3 5141.6 5174.3 5186.8 5237.7 5239.7 5246.7 5262.3 5288.2 4887.4 4895.6 4900.1 4911.3 4949.0 5146.2 5197.3 5238.7 5255.5 5349.2 5077.0 5079.3 5081.4 5101.1 5131.3 5058.9 5098.3 5153.9 5209.2 5271.7 5038.3 5051.1 5132.8 5135.1 5140.1 5079.6 5082.4 5085.4 5140.6 5144.8 4301.4 4301.5 4305.3 4308.4 4345.0 3726.7 3749.2 3751.1 3793.8 3815.4 4480.3 4518.5 4529.0 4541.4 4585.3 5279.7 5287.6 5291.9 5307.7 5336.9 4407.3 4493.7 4542.9 4543.3 4584.4 4632.4 4643.8 4657.7 4661.5 4734.0 4880.6 4903.0 4907.0 4919.0 4953.1 5233.4 5244.5 5259.7 5266.9 5267.4 4747.0 4786.7 4828.6 4869.7 4882.4 5103.2 5105.3 5121.7 5124.5 5154.4 5165.4 5197.8 5198.6 5198.9 5233.2 4932.6 4989.8 4995.3 5005.7 5100.1 5058.0 5065.7 5081.1 5112.4 5123.1 4887.1 4913.3 4984.4 4993.7 5015.5 5064.1 5073.1 5105.2 5109.7 5178.1 4936.9 4962.2 4966.4 4974.5 5026.3 13:32:25 INFO - PROCESS | 9516 | 13:32:25 INFO - PROCESS | 9516 | [#1] ext.html Cycles:180 Average:43226.17 Median:3195.28 stddev:73889.65 (2312.5%) stddev-sans-first:74027.38 13:32:25 INFO - PROCESS | 9516 | Values: 527.9 538.3 546.5 550.2 562.1 29320.1 39792.6 41643.8 41890.0 45704.5 41867.6 42425.8 42461.6 42519.4 42526.4 7610.5 7780.0 7784.9 7785.5 7787.9 7393.9 7538.8 9668.5 9949.8 9968.7 10074.5 10132.2 10142.2 10142.7 10143.4 10060.4 10080.6 10104.7 10123.7 10125.1 9959.6 10002.0 10020.6 10032.3 10035.5 39103.6 39388.2 39417.2 39436.8 39456.0 3575.2 3671.7 3687.7 3700.2 3708.9 28727.7 28813.4 28949.3 28969.1 30364.1 3191.9 3198.7 3220.6 3230.2 3247.0 237187.0 238115.0 238284.0 238820.0 239375.0 52273.5 52523.2 52658.7 52719.7 52733.7 55286.0 55333.7 55335.7 55356.4 55362.7 14102.9 14735.9 14798.9 14821.0 14824.9 9035.5 10660.3 10660.4 10670.3 10676.7 13682.2 14872.7 15440.2 15708.3 15929.5 5785.9 5803.2 5877.4 5910.6 5981.6 804.7 823.6 836.7 837.4 847.2 26505.7 27701.8 27916.7 28011.3 28060.6 930.8 941.8 963.6 974.9 974.9 12338.1 12774.4 12943.2 13011.4 13026.7 329245.0 329740.0 330362.0 331515.0 332977.0 40522.8 40525.4 40545.0 40628.2 40741.0 1232.5 1242.9 1254.5 1258.7 1264.9 22301.9 22383.8 23476.5 23534.9 23573.2 34294.0 34408.7 34409.3 34437.0 34569.0 265000.0 270131.0 270299.0 270723.0 271032.0 21112.7 21395.9 21413.7 22084.9 23186.0 34496.8 34624.7 34919.8 35001.8 35474.0 30369.8 30696.4 31132.7 31169.7 31345.2 30530.8 30531.8 30540.8 30853.5 31747.7 30401.0 30791.2 30863.7 31124.5 31197.8 25950.7 37333.4 39882.0 40330.6 43367.6 28066.2 30485.0 31013.0 31073.2 31622.8 13:32:25 INFO - PROCESS | 9516 | 13:32:25 INFO - PROCESS | 9516 | [#2] jquery.html Cycles:180 Average:26551.58 Median:4583.28 stddev:72884.51 (1590.2%) stddev-sans-first:73062.45 13:32:25 INFO - PROCESS | 9516 | Values: 362.4 383.4 394.1 395.4 420.4 12840.7 13962.9 15625.8 18162.5 18257.1 17287.7 17840.7 18049.9 18205.4 18243.5 4565.7 4792.1 4806.7 4809.0 4813.1 4634.0 4715.3 4760.1 4783.2 4799.7 4774.8 4782.2 4782.5 4783.6 4786.7 4596.5 4708.0 4775.8 4780.0 4782.2 4655.1 4666.4 4668.7 4670.3 4671.6 13227.1 13320.1 20383.3 22061.0 22177.4 2168.9 2179.9 2365.9 2477.4 2501.1 9075.2 9571.2 9741.3 9949.9 9992.6 1719.4 1747.8 1749.7 1755.9 1780.2 75338.2 76666.8 77103.0 78361.6 79758.6 10058.4 10342.9 10453.6 10511.8 10528.8 15065.5 15103.5 15123.5 15132.0 15132.8 6765.7 6926.1 7044.9 7060.9 7108.9 6313.4 6338.7 6468.4 6491.5 6493.1 4495.6 4579.4 4587.2 4677.6 4687.2 1854.4 1898.8 1922.8 1928.8 1931.8 793.3 830.9 836.0 839.8 846.8 16633.7 16659.4 17256.0 17623.9 17721.7 812.1 819.5 831.2 833.6 846.2 9058.0 9388.4 9682.6 9729.4 9844.5 321984.0 421076.0 456577.0 484567.0 489494.0 67917.5 97047.5 97575.0 101095.5 102315.0 941.5 957.7 989.8 991.0 997.8 15782.4 16055.1 16098.7 16957.3 17033.1 40810.0 40908.4 41397.8 41479.0 42602.6 55699.2 56441.7 56798.0 57510.7 57603.0 7818.2 7851.6 7958.6 8139.9 8244.8 10482.6 12239.6 12509.0 12736.0 12893.6 10055.1 10151.1 10266.6 10732.6 11032.2 8695.2 9040.5 10119.6 10234.6 10907.0 10962.6 11213.8 11252.3 11300.4 11613.9 8148.9 8191.3 8254.3 8485.2 8489.3 11087.5 11328.9 11331.5 11432.8 11495.7 13:32:25 INFO - PROCESS | 9516 | 13:32:25 INFO - PROCESS | 9516 | [#3] mootools.html Cycles:180 Average:4616.92 Median:5028.61 stddev:2401.30 (47.8%) stddev-sans-first:2395.65 13:32:25 INFO - PROCESS | 9516 | Values: 1372.1 1372.3 1384.0 1393.2 1403.5 6620.6 6988.4 7017.6 7026.8 7036.1 5923.9 6086.7 6648.7 6781.9 6863.1 2090.7 2121.6 2127.4 2127.9 2130.3 2071.1 2107.5 2110.2 2113.7 2116.6 1798.5 1861.5 2065.0 2134.4 2139.6 2132.5 2136.5 2137.0 2138.2 2140.2 2049.5 2070.7 2073.2 2082.9 2110.1 6973.4 7015.6 7016.9 7023.7 7028.6 4172.7 4287.7 4294.6 4308.7 4309.6 2647.5 2817.4 2833.0 2886.2 2902.7 1067.5 1096.8 1112.8 1155.5 1173.0 8914.9 8944.1 8958.9 8964.8 8972.4 3797.6 3999.5 4054.9 4075.3 4077.8 8019.2 8028.0 8030.9 8032.2 8034.6 4479.4 4480.8 4484.6 4487.7 4490.2 3462.2 3596.2 3862.4 4011.1 4085.2 3426.7 3455.5 3566.8 3583.9 3597.4 1160.2 1171.0 1180.7 1187.7 1192.4 699.8 715.2 806.3 825.4 835.5 4954.2 4970.5 5011.3 5132.3 5185.2 896.7 917.5 917.8 920.9 965.1 3449.3 3458.3 3465.3 3542.8 3616.9 8173.3 8388.5 8437.7 8471.7 8485.8 8366.0 8375.8 8376.3 8384.0 8396.6 6471.4 6662.4 6677.5 6690.3 6690.5 4653.1 4890.8 4892.9 5045.9 5082.9 7397.4 7442.3 7474.9 7615.6 7684.8 7028.3 7202.5 7509.4 7540.2 7560.0 5193.1 5344.4 5809.7 5984.9 5993.1 6493.2 6676.2 6693.3 6876.2 6893.1 5847.0 6019.4 6024.1 6043.6 6076.3 5893.3 5927.6 5947.8 5960.0 5982.0 5503.4 5531.3 5545.5 5569.6 5590.0 4064.5 4066.3 4110.8 4398.3 4494.7 4170.2 4180.6 4183.4 4250.4 4256.2 13:32:25 INFO - PROCESS | 9516 | 13:32:25 INFO - PROCESS | 9516 | [#4] prototype.html Cycles:180 Average:4195.51 Median:4698.52 stddev:1187.96 (25.3%) stddev-sans-first:1155.91 13:32:25 INFO - PROCESS | 9516 | Values: 361.5 364.4 364.6 369.0 374.5 4628.5 4846.3 4847.4 4925.8 4934.8 4692.8 4832.4 4857.4 4859.4 4866.7 3933.2 3948.7 3949.1 3952.8 3956.5 3857.8 3958.8 3958.9 3959.8 3966.6 3900.7 3912.2 3912.5 3921.0 3921.1 3886.7 3900.7 3903.3 3903.9 3924.5 3511.3 3522.3 3532.9 3547.4 3588.3 4589.0 4662.8 4702.3 4737.9 4769.0 4425.2 4435.1 4441.5 4446.9 4458.5 5063.1 5064.6 5070.7 5074.4 5077.3 3448.9 3849.7 3860.2 3861.6 3863.7 5273.2 5309.4 5320.4 5324.2 5340.4 3710.4 3717.5 3717.6 3727.8 3738.5 3754.7 3776.4 3778.1 3804.3 3804.9 4171.4 4244.4 4292.6 4294.8 4363.6 5050.7 5053.4 5063.2 5064.2 5073.0 1179.8 1213.5 1227.9 1260.0 1269.2 852.5 862.3 865.0 869.8 870.2 4285.6 4287.4 4310.6 4311.2 4320.3 5026.8 5041.2 5041.5 5046.6 5051.4 4295.7 4326.0 4334.5 4349.7 4352.2 2601.9 2622.5 2657.9 2662.5 2688.8 4665.8 4669.1 4727.3 4731.5 4770.3 5142.1 5152.7 5169.4 5181.7 5206.4 4471.8 4685.6 4694.8 4706.0 4714.3 4939.4 5007.6 5019.9 5037.6 5062.5 4992.8 4998.2 5003.8 5008.8 5020.9 4637.3 4891.0 4907.2 4920.0 4921.9 3698.1 3710.5 3710.9 3720.3 3720.4 5249.3 5254.4 5271.3 5278.8 5289.2 4646.4 4790.2 4989.7 5019.5 5042.3 4990.7 5006.9 5009.7 5013.2 5016.6 4838.4 4964.7 4982.0 4987.9 4998.0 4992.8 5041.1 5050.6 5056.2 5066.3 4890.5 4919.8 4920.4 4934.8 4949.8 13:32:25 INFO - PROCESS | 9516 | 13:32:25 INFO - PROCESS | 9516 | [#5] yui.html Cycles:180 Average:14598.93 Median:24610.12 stddev:18361.66 (74.6%) stddev-sans-first:18383.33 13:32:25 INFO - PROCESS | 9516 | Values: 656.8 663.6 732.4 769.1 781.7 12679.9 13617.9 13619.1 13635.8 13640.0 13098.2 13170.4 13175.9 13210.2 13254.8 659.1 680.6 796.8 797.2 818.1 823.7 825.4 825.7 825.9 825.9 875.2 876.7 876.9 877.1 877.2 685.6 710.7 713.4 713.8 872.8 610.8 625.9 627.9 631.4 631.8 12578.8 12593.6 12603.4 12637.6 12644.6 12823.9 13040.7 13058.6 13071.3 13105.5 11833.6 11912.4 11961.6 12101.6 12175.0 4101.7 4119.2 4202.4 4205.3 4208.7 59921.7 61899.7 62295.4 62734.1 63218.7 10563.7 10579.3 10718.6 10731.9 10808.4 18168.3 18213.6 18224.4 18336.4 18419.0 6433.7 6543.0 6575.5 6654.0 6752.5 3294.1 3294.5 3295.4 3349.5 3380.7 2672.1 2746.0 2784.1 2784.1 2787.1 459.7 460.4 461.5 465.9 470.7 590.9 591.9 608.7 609.0 610.4 8175.3 8205.5 8498.7 8897.3 9116.8 520.0 529.8 537.5 592.1 634.6 3685.2 3791.0 3810.3 3886.4 3997.3 55131.0 63182.4 64462.4 64896.0 65122.0 58030.7 58208.0 58259.0 59993.4 60171.7 48388.5 51947.0 52329.2 52693.7 52880.5 7529.9 7575.4 7821.5 8012.1 8080.8 36537.8 37683.0 37911.0 38512.0 39538.2 45694.8 46050.3 46118.0 46611.3 48700.3 9878.8 10039.0 10079.8 10091.2 10119.3 11110.8 11152.8 11181.5 11339.8 11449.8 9865.6 10094.1 10151.2 10358.0 10661.9 9905.3 9966.3 9984.5 10016.4 10091.1 10279.0 10308.7 10411.7 10467.2 10609.7 8383.0 8586.8 8647.2 8720.2 8855.0 8635.7 8713.8 8737.2 8763.8 8922.8 13:32:25 INFO - PROCESS | 9516 | -------- Summary: end -------- 13:32:25 INFO - PROCESS | 9516 | 13:32:26 INFO - TEST-INFO | 9516: exit 0 13:32:26 INFO - TEST-OK | dromaeo_css | took 1123088ms 13:32:26 INFO - TEST-START | kraken 13:32:26 INFO - operating with platform_type : linux_ 13:32:26 INFO - Initialising browser for kraken test... 13:32:26 INFO - TEST-INFO | started process 9820 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5Nn1xl/profile http://localhost:33357/getInfo.html) 13:32:30 INFO - PROCESS | 9820 | __metrics Screen width/height:1600/1200 13:32:30 INFO - PROCESS | 9820 | colorDepth:24 13:32:30 INFO - PROCESS | 9820 | Browser inner width/height: 1024/697 13:32:30 INFO - PROCESS | 9820 | __metrics 13:32:31 INFO - PROCESS | 9820 | 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" 13:32:31 INFO - PROCESS | 9820 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:32:32 INFO - PROCESS | 9820 | console.error: 13:32:32 INFO - PROCESS | 9820 | Message: Error: Connection closed before committing the transaction. 13:32:32 INFO - PROCESS | 9820 | Stack: 13:32:32 INFO - PROCESS | 9820 | executeTransaction/promise resource://gre/modules/Promise-backend.js:917:23 13:32:32 INFO - PROCESS | 9820 | walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:801:7 13:32:32 INFO - PROCESS | 9820 | Promise*scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:734:11 13:32:32 INFO - PROCESS | 9820 | schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:765:7 13:32:32 INFO - PROCESS | 9820 | completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:702:7 13:32:32 INFO - PROCESS | 9820 | TaskImpl_run@resource://gre/modules/Task.jsm:324:15 13:32:32 INFO - PROCESS | 9820 | observe@resource://gre/modules/AsyncShutdown.jsm:550:9 13:32:32 INFO - PROCESS | 9820 | addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 13:32:32 INFO - PROCESS | 9820 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:385:5 13:32:32 INFO - PROCESS | 9820 | moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 13:32:32 INFO - PROCESS | 9820 | trigger@resource://gre/modules/AsyncShutdown.jsm:719:23 13:32:32 INFO - PROCESS | 9820 | _wait@resource://gre/modules/AsyncShutdown.jsm:866:7 13:32:32 INFO - PROCESS | 9820 | wait@resource://gre/modules/AsyncShutdown.jsm:850:28 13:32:32 INFO - PROCESS | 9820 | observe@resource://gre/modules/AsyncShutdown.jsm:533:17 13:32:32 INFO - PROCESS | 9820 | 13:32:32 INFO - PROCESS | 9820 | console.error: PushService: 13:32:32 INFO - PROCESS | 9820 | stateChangeProcessEnqueue: Error transitioning state 13:32:32 INFO - PROCESS | 9820 | UnknownError 13:32:33 INFO - TEST-INFO | 9820: exit 0 13:32:33 INFO - Browser initialized. 13:32:33 INFO - Running cycle 1/1 for kraken test... 13:32:33 INFO - TEST-INFO | started process 9901 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5Nn1xl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:32:45 INFO - PROCESS | 9901 | RSS: Main: 152526848 13:32:45 INFO - PROCESS | 9901 | 13:32:48 INFO - PROCESS | 9901 | Cycle 1(1): loaded http://localhost:33357/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33357/tests/kraken/driver.html?testName=audio-beat-detection) 13:32:49 INFO - PROCESS | 9901 | RSS: Main: 207335424 13:32:49 INFO - PROCESS | 9901 | 13:32:51 INFO - PROCESS | 9901 | Cycle 1(1): loaded http://localhost:33357/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33357/tests/kraken/driver.html?testName=audio-dft) 13:32:52 INFO - PROCESS | 9901 | RSS: Main: 185552896 13:32:52 INFO - PROCESS | 9901 | 13:32:55 INFO - PROCESS | 9901 | Cycle 1(1): loaded http://localhost:33357/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33357/tests/kraken/driver.html?testName=audio-fft) 13:32:56 INFO - PROCESS | 9901 | RSS: Main: 268374016 13:32:56 INFO - PROCESS | 9901 | 13:32:58 INFO - PROCESS | 9901 | Cycle 1(1): loaded http://localhost:33357/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33357/tests/kraken/driver.html?testName=audio-oscillator) 13:32:58 INFO - PROCESS | 9901 | RSS: Main: 179728384 13:32:58 INFO - PROCESS | 9901 | 13:33:01 INFO - PROCESS | 9901 | Cycle 1(1): loaded http://localhost:33357/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33357/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:33:01 INFO - PROCESS | 9901 | RSS: Main: 183795712 13:33:01 INFO - PROCESS | 9901 | 13:33:04 INFO - PROCESS | 9901 | Cycle 1(1): loaded http://localhost:33357/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33357/tests/kraken/driver.html?testName=imaging-darkroom) 13:33:05 INFO - PROCESS | 9901 | RSS: Main: 223457280 13:33:05 INFO - PROCESS | 9901 | 13:33:09 INFO - PROCESS | 9901 | Cycle 1(1): loaded http://localhost:33357/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33357/tests/kraken/driver.html?testName=imaging-desaturate) 13:33:09 INFO - PROCESS | 9901 | RSS: Main: 216215552 13:33:09 INFO - PROCESS | 9901 | 13:33:12 INFO - PROCESS | 9901 | Cycle 1(1): loaded http://localhost:33357/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33357/tests/kraken/driver.html?testName=json-parse-financial) 13:33:13 INFO - PROCESS | 9901 | RSS: Main: 217985024 13:33:13 INFO - PROCESS | 9901 | 13:33:14 INFO - PROCESS | 9901 | Cycle 1(1): loaded http://localhost:33357/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33357/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:33:15 INFO - PROCESS | 9901 | RSS: Main: 181747712 13:33:15 INFO - PROCESS | 9901 | 13:33:17 INFO - PROCESS | 9901 | Cycle 1(1): loaded http://localhost:33357/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33357/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:33:17 INFO - PROCESS | 9901 | RSS: Main: 189710336 13:33:17 INFO - PROCESS | 9901 | 13:33:20 INFO - PROCESS | 9901 | Cycle 1(1): loaded http://localhost:33357/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33357/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:33:20 INFO - PROCESS | 9901 | RSS: Main: 198078464 13:33:20 INFO - PROCESS | 9901 | 13:33:23 INFO - PROCESS | 9901 | Cycle 1(1): loaded http://localhost:33357/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33357/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:33:24 INFO - PROCESS | 9901 | RSS: Main: 206954496 13:33:24 INFO - PROCESS | 9901 | 13:33:27 INFO - PROCESS | 9901 | Cycle 1(1): loaded http://localhost:33357/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33357/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:33:27 INFO - PROCESS | 9901 | RSS: Main: 203722752 13:33:27 INFO - PROCESS | 9901 | 13:33:29 INFO - PROCESS | 9901 | Cycle 1(1): loaded http://localhost:33357/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33357/tests/kraken/driver.html?testName=ai-astar) 13:33:29 INFO - PROCESS | 9901 | RSS: Main: 253792256 13:33:29 INFO - PROCESS | 9901 | 13:33:29 INFO - PROCESS | 9901 | __start_tp_report 13:33:29 INFO - PROCESS | 9901 | _x_x_mozilla_page_load 13:33:29 INFO - PROCESS | 9901 | _x_x_mozilla_page_load_details 13:33:29 INFO - PROCESS | 9901 | |i|pagename|runs| 13:33:29 INFO - PROCESS | 9901 | |0;ai-astar;117;116;116;118;116;116;115;115;115;115 13:33:29 INFO - PROCESS | 9901 | |1;audio-beat-detection;152;129;126;165;127;126;125;131;156;127 13:33:29 INFO - PROCESS | 9901 | |2;audio-dft;161;160;161;160;160;163;162;161;161;160 13:33:29 INFO - PROCESS | 9901 | |3;audio-fft;74;76;76;112;79;77;76;75;91;80 13:33:29 INFO - PROCESS | 9901 | |4;audio-oscillator;85;84;107;84;84;84;102;83;84;105 13:33:29 INFO - PROCESS | 9901 | |5;imaging-gaussian-blur;117;117;116;117;117;117;118;117;118;118 13:33:29 INFO - PROCESS | 9901 | |6;imaging-darkroom;149;149;148;149;149;149;148;149;148;150 13:33:29 INFO - PROCESS | 9901 | |7;imaging-desaturate;95;95;95;95;95;96;96;96;95;96 13:33:29 INFO - PROCESS | 9901 | |8;json-parse-financial;59;59;59;59;60;59;60;61;61;62 13:33:29 INFO - PROCESS | 9901 | |9;json-stringify-tinderbox;67;67;67;67;67;66;66;67;67;67 13:33:29 INFO - PROCESS | 9901 | |10;stanford-crypto-aes;86;87;87;85;85;86;94;84;90;86 13:33:29 INFO - PROCESS | 9901 | |11;stanford-crypto-ccm;140;135;134;137;136;141;131;135;193;135 13:33:29 INFO - PROCESS | 9901 | |12;stanford-crypto-pbkdf2;174;175;180;173;174;176;175;174;173;176 13:33:29 INFO - PROCESS | 9901 | |13;stanford-crypto-sha256-iterative;67;69;68;68;69;68;67;69;66;77 13:33:29 INFO - PROCESS | 9901 | __end_tp_report 13:33:29 INFO - PROCESS | 9901 | __start_cc_report 13:33:29 INFO - PROCESS | 9901 | _x_x_mozilla_cycle_collect,1828 13:33:29 INFO - PROCESS | 9901 | __end_cc_report 13:33:29 INFO - PROCESS | 9901 | __startTimestamp1484861609875__endTimestamp 13:33:29 INFO - PROCESS | 9901 | 13:33:29 INFO - PROCESS | 9901 | ------- Summary: start ------- 13:33:29 INFO - PROCESS | 9901 | Number of tests: 14 13:33:29 INFO - PROCESS | 9901 | 13:33:29 INFO - PROCESS | 9901 | [#0] ai-astar Cycles:10 Average:115.90 Median:116.00 stddev:0.99 (0.9%) stddev-sans-first:0.97 13:33:29 INFO - PROCESS | 9901 | Values: 117.0 116.0 116.0 118.0 116.0 116.0 115.0 115.0 115.0 115.0 13:33:29 INFO - PROCESS | 9901 | 13:33:29 INFO - PROCESS | 9901 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:130.00 stddev:15.10 (11.6%) stddev-sans-first:14.92 13:33:29 INFO - PROCESS | 9901 | Values: 152.0 129.0 126.0 165.0 127.0 126.0 125.0 131.0 156.0 127.0 13:33:29 INFO - PROCESS | 9901 | 13:33:29 INFO - PROCESS | 9901 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 13:33:29 INFO - PROCESS | 9901 | Values: 161.0 160.0 161.0 160.0 160.0 163.0 162.0 161.0 161.0 160.0 13:33:29 INFO - PROCESS | 9901 | 13:33:29 INFO - PROCESS | 9901 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.50 stddev:11.73 (15.3%) stddev-sans-first:12.12 13:33:29 INFO - PROCESS | 9901 | Values: 74.0 76.0 76.0 112.0 79.0 77.0 76.0 75.0 91.0 80.0 13:33:29 INFO - PROCESS | 9901 | 13:33:29 INFO - PROCESS | 9901 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:84.00 stddev:10.06 (12.0%) stddev-sans-first:10.50 13:33:29 INFO - PROCESS | 9901 | Values: 85.0 84.0 107.0 84.0 84.0 84.0 102.0 83.0 84.0 105.0 13:33:29 INFO - PROCESS | 9901 | 13:33:29 INFO - PROCESS | 9901 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 13:33:29 INFO - PROCESS | 9901 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 13:33:29 INFO - PROCESS | 9901 | 13:33:29 INFO - PROCESS | 9901 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 13:33:29 INFO - PROCESS | 9901 | Values: 149.0 149.0 148.0 149.0 149.0 149.0 148.0 149.0 148.0 150.0 13:33:29 INFO - PROCESS | 9901 | 13:33:29 INFO - PROCESS | 9901 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 13:33:29 INFO - PROCESS | 9901 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 13:33:29 INFO - PROCESS | 9901 | 13:33:29 INFO - PROCESS | 9901 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:60.00 stddev:1.10 (1.8%) stddev-sans-first:1.12 13:33:29 INFO - PROCESS | 9901 | Values: 59.0 59.0 59.0 59.0 60.0 59.0 60.0 61.0 61.0 62.0 13:33:29 INFO - PROCESS | 9901 | 13:33:29 INFO - PROCESS | 9901 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 13:33:29 INFO - PROCESS | 9901 | Values: 67.0 67.0 67.0 67.0 67.0 66.0 66.0 67.0 67.0 67.0 13:33:29 INFO - PROCESS | 9901 | 13:33:29 INFO - PROCESS | 9901 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:86.50 stddev:2.94 (3.4%) stddev-sans-first:3.10 13:33:29 INFO - PROCESS | 9901 | Values: 86.0 87.0 87.0 85.0 85.0 86.0 94.0 84.0 90.0 86.0 13:33:29 INFO - PROCESS | 9901 | 13:33:29 INFO - PROCESS | 9901 | [#11] stanford-crypto-ccm Cycles:10 Average:141.70 Median:136.50 stddev:18.25 (13.4%) stddev-sans-first:19.35 13:33:29 INFO - PROCESS | 9901 | Values: 140.0 135.0 134.0 137.0 136.0 141.0 131.0 135.0 193.0 135.0 13:33:29 INFO - PROCESS | 9901 | 13:33:29 INFO - PROCESS | 9901 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:175.00 stddev:2.05 (1.2%) stddev-sans-first:2.15 13:33:29 INFO - PROCESS | 9901 | Values: 174.0 175.0 180.0 173.0 174.0 176.0 175.0 174.0 173.0 176.0 13:33:29 INFO - PROCESS | 9901 | 13:33:29 INFO - PROCESS | 9901 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.50 stddev:3.05 (4.4%) stddev-sans-first:3.16 13:33:29 INFO - PROCESS | 9901 | Values: 67.0 69.0 68.0 68.0 69.0 68.0 67.0 69.0 66.0 77.0 13:33:29 INFO - PROCESS | 9901 | -------- Summary: end -------- 13:33:29 INFO - PROCESS | 9901 | 13:33:31 INFO - TEST-INFO | 9901: exit 0 13:33:31 INFO - TEST-OK | kraken | took 65086ms 13:33:31 INFO - SUITE-END | took 1188s 13:33:31 INFO - Completed test suite (00:19:48) 13:33:31 INFO - javascript benchmark 13:33:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2612.9216123516294, 2632.6972398174216, 2652.933676658083, 2667.5198464276436, 2679.866006699666, 4733.171694953387, 4784.90430191396, 4816.446108697501, 4888.217885138379, 4918.311436398907, 4819.421669399677, 4821.614270858332, 4877.0, 4934.58056065234, 4959.305697202394, 4426.933595996063, 4437.245668236407, 4493.438320209973, 4528.818847246106, 4529.433820772403, 4251.893702657428, 4562.703424277428, 4575.0, 4628.074385122972, 4659.231226847566, 4372.060007098489, 4478.977605111986, 4506.52681468446, 4510.616597589176, 4586.0, 4408.625266852321, 4462.509123996358, 4499.842505512324, 4501.977490112561, 4576.725396476222, 4478.843240486567, 4485.372047913294, 4502.527234640348, 4503.527129651405, 4533.569310915458, 4862.7785605143545, 4888.975555122237, 4917.459079501252, 4919.0899683558655, 4964.87587810304, 5073.188289873602, 5109.284700141983, 5141.562967147797, 5174.327337446108, 5186.844394668166, 5237.685738855643, 5239.73801309933, 5246.658967167122, 5262.315898933152, 5288.206768984644, 4887.36464259644, 4895.632827537949, 4900.09348270564, 4911.263310503382, 4948.950510494921, 5146.202338637517, 5197.298364720715, 5238.68567885928, 5255.527002569787, 5349.22436246742, 5076.959223359277, 5079.288899554065, 5081.441041485434, 5101.107306221396, 5131.281620573122, 5058.873528161826, 5098.260752190911, 5153.922691159635, 5209.218617207449, 5271.65734227274, 5038.345015148007, 5051.06555287273, 5132.820351287762, 5135.075686376414, 5140.1004824155625, 5079.568236699848, 5082.440931497532, 5085.364329458817, 5140.563052140536, 5144.768485418165, 4301.397804307399, 4301.526832048472, 4305.31115021595, 4308.418363520947, 4345.044090300129, 3726.7391282609956, 3749.1751814600743, 3751.0622344413896, 3793.79134147619, 3815.389537673959, 4480.305552639346, 4518.525554816762, 4529.0, 4541.409616749801, 4585.335126406652, 5279.656822306538, 5287.576993840484, 5291.894162116736, 5307.681539107666, 5336.866578335573, 4407.316865885793, 4493.662975276802, 4542.863714088583, 4543.318502224627, 4584.404027476407, 4632.374629424984, 4643.814247430132, 4657.650676199299, 4661.463931647836, 4734.0, 4880.633952453509, 4902.975485122552, 4907.0, 4919.0407870464915, 4953.108440480748, 5233.371995360581, 5244.501772331622, 5259.658122222043, 5266.89466210666, 5267.367915850123, 4746.9525304747895, 4786.688865223749, 4828.589569886599, 4869.683470574401, 4882.414110306786, 5103.209002604603, 5105.33630628016, 5121.718305493234, 5124.538791508633, 5154.381474223117, 5165.431802501797, 5197.792088316425, 5198.584113271005, 5198.870028249324, 5233.162693968947, 4932.580730637793, 4989.825356112518, 4995.300657907823, 5005.6996580205305, 5100.107481190703, 5058.0, 5065.746712664426, 5081.11080560893, 5112.3865136183895, 5123.052235336475, 4887.144749668722, 4913.28757330178, 4984.37695288089, 4993.700377977333, 5015.473375295687, 5064.088464076502, 5073.086844368049, 5105.183170692671, 5109.7189654567865, 5178.0679477694375, 4936.901261974668, 4962.181240095344, 4966.404031516096, 4974.452810190948, 5026.296318515484], "value": 4763.180659451483, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [527.9049771041214, 538.3244028743926, 546.5409056392631, 550.1555112901697, 562.0922210629834, 29320.135972805445, 39792.60207397925, 41643.79178104105, 41890.0, 45704.54295457045, 41867.58132418675, 42425.78787106068, 42461.57538424615, 42519.36220956688, 42526.362104568456, 7610.467267291278, 7779.9611001945195, 7784.883226751604, 7785.532868027908, 7787.883181752279, 7393.852122957537, 7538.849223015536, 9668.516574171299, 9949.75125621858, 9968.6510972116, 10074.546645400938, 10132.189424845994, 10142.188624910026, 10142.695719128438, 10143.442110683909, 10060.39637621745, 10080.64717734883, 10104.747381315452, 10123.696289111338, 10125.088742013255, 9959.55182016811, 10002.049805268487, 10020.59917603295, 10032.297739158263, 10035.548400322003, 39103.60896391028, 39388.21223575541, 39417.211655766725, 39436.802815986026, 39456.0, 3575.213453040327, 3671.706263498914, 3687.723420743455, 3700.1674623209833, 3708.9258214835822, 28727.71272287271, 28813.42373152525, 28949.276268093254, 28969.130926072252, 30364.089077327717, 3191.872325106993, 3198.696123868229, 3220.5974253218346, 3230.176305042199, 3247.0, 237187.0, 238115.0, 238284.0, 238820.0, 239375.0, 52273.47726522762, 52523.21215181775, 52658.736706316224, 52719.736401318514, 52733.7363313181, 55286.0, 55333.72333138389, 55335.723321383135, 55356.44643553594, 55362.72318638381, 14102.858971410154, 14735.852641473663, 14798.852011479747, 14821.0, 14824.851751482347, 9035.50304733246, 10660.307080039773, 10660.41367724767, 10670.253082284165, 10676.733081673021, 13682.179069255877, 14872.70254594902, 15440.150791706565, 15708.293126809092, 15929.522114336589, 5785.855353616109, 5803.20100768763, 5877.353491115974, 5910.615809972338, 5981.641101533834, 804.6861723927673, 823.6375994562374, 836.6695155413578, 837.3636036612219, 847.2332539052168, 26505.734942650713, 27701.77533556975, 27916.72083279182, 28011.299717507227, 28060.579091313648, 930.8324501589778, 941.7786820097272, 963.5904740485265, 974.8732664753678, 974.9268804839666, 12338.136330456782, 12774.361281935866, 12943.158694684815, 13011.414486348138, 13026.674333141747, 329245.0, 329740.0, 330362.0, 331515.0, 332977.0, 40522.797386012884, 40525.39211911824, 40545.0, 40628.18743625111, 40741.0, 1232.5008371609513, 1242.9316387598587, 1254.4543123741203, 1258.7230809221955, 1264.9367531623382, 22301.888490558093, 22383.77616223817, 23476.530469390174, 23534.882325588263, 23573.17493887706, 34294.0, 34408.65591344055, 34409.311813764085, 34437.0, 34569.0, 265000.0, 270131.0, 270299.0, 270723.0, 271032.0, 21112.68330975006, 21395.893020534797, 21413.678794817777, 22084.88957555202, 23186.0, 34496.827515862264, 34624.65375346315, 34919.82540087283, 35001.8249908759, 35474.0, 30369.84815075999, 30696.386072278878, 31132.688673112978, 31169.68830311668, 31345.216369590944, 30530.847345764018, 30531.847340763154, 30540.84729576338, 30853.537196942514, 31747.682523174473, 30401.0, 30791.2302192447, 30863.69136308698, 31124.533132002583, 31197.8440107798, 25950.740492594832, 37333.43999840059, 39882.0, 40330.59669403268, 43367.56632433635, 28066.158015259574, 30485.0, 31013.0, 31073.223169420944, 31622.841885790425], "value": 17033.887978572624, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.37128581910366, 383.438262944786, 394.10341473148594, 395.44834955237445, 420.4114240063912, 12840.678983025417, 13962.860371396295, 15625.843741562596, 18162.45512634623, 18257.087145642698, 17287.74068388975, 17840.718227625373, 18049.90975045126, 18205.362812301573, 18243.543911402223, 4565.65757568182, 4792.137415265251, 4806.687565308262, 4809.0, 4813.061453016663, 4634.0, 4715.339852420664, 4760.143174228638, 4783.162946484369, 4799.7360145192, 4774.785134668931, 4782.163121453732, 4782.450018247911, 4783.61731061516, 4786.736729479877, 4596.471405788344, 4707.999999999965, 4775.785089670973, 4779.976100119495, 4782.234842425195, 4655.11552804966, 4666.440027196724, 4668.6731928765, 4670.252759558488, 4671.6262698984, 13227.140235884637, 13320.134191277535, 20383.286584969603, 22061.0, 22177.445563861034, 2168.8683058772904, 2179.869207847534, 2365.8817059147145, 2477.4301910560494, 2501.0746023971064, 9075.18323350895, 9571.234301255883, 9741.31810773246, 9949.850752238723, 9992.600295988152, 1719.4325872462057, 1747.8339557741995, 1749.737539369092, 1755.8946463212249, 1780.1633232380889, 75338.24661753367, 76666.84999725064, 77103.0, 78361.60819195924, 79758.60120699418, 10058.396496210104, 10342.913994030669, 10453.634122805664, 10511.789764204826, 10528.842067368996, 15065.472708455152, 15103.47137850192, 15123.470678526199, 15132.0, 15132.848671513364, 6765.661716914135, 6926.099607051051, 7044.894326585106, 7060.894086588705, 7108.857822843514, 6313.43179113882, 6338.683065846782, 6468.353164683588, 6491.480681545465, 6493.090967264587, 4495.617872480811, 4579.4046773919845, 4587.151376995266, 4677.649176311722, 4687.179743544866, 1854.3509771579838, 1898.7721473423278, 1922.8270754839536, 1928.7878333383317, 1931.8261356477985, 793.2939683681528, 830.8878301429351, 835.9874601880977, 839.7984483723862, 846.7756044648173, 16633.667326653398, 16659.379533755804, 17256.0, 17623.911880440515, 17721.7341739874, 812.0945146161987, 819.4796304346783, 831.2103501673434, 833.5665453963904, 846.1792061700141, 9058.0, 9388.436693798258, 9682.56428460721, 9729.367591106555, 9844.50777461124, 321984.0, 421076.0, 456577.0, 484567.0, 489494.0, 67917.48380210034, 97047.51476242574, 97575.0, 101095.49452252692, 102315.0, 941.5433514745343, 957.7366224288377, 989.8218320702199, 990.9702708918744, 997.8004399120205, 15782.421359368018, 16055.116968566841, 16098.678026439171, 16957.321707131578, 17033.063181525136, 40810.0, 40908.386374203816, 41397.79301103475, 41479.0, 42602.57397425986, 55699.16451253153, 56441.717791412426, 56798.0, 57510.712446439175, 57603.0, 7818.218178182136, 7851.646675899484, 7958.562279074475, 8139.877901831595, 8244.793880153044, 10482.63310784119, 12239.632811015685, 12508.998560230319, 12736.0, 12893.613191604267, 10055.095041446304, 10151.137153341753, 10266.58933642646, 10732.624358147428, 11032.227744057838, 8695.173958473935, 9040.457572545669, 10119.645812396531, 10234.590616375262, 10907.0, 10962.616308429167, 11213.831792522955, 11252.26860254081, 11300.43497825089, 11613.941930290295, 8148.918510815053, 8191.303739182236, 8254.339652827879, 8485.151484851465, 8489.283429302564, 11087.501062452047, 11328.886711132784, 11331.546738130382, 11432.82850757256, 11495.655130346104], "value": 8371.169602674108, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1372.0875617714219, 1372.2864110662456, 1383.979240311395, 1393.2406838273134, 1403.4877269796525, 6620.6027638341675, 6988.405985491239, 7017.578945263288, 7026.789196324105, 7036.085308909847, 5923.911141332873, 6086.695665216744, 6648.667566621673, 6781.898271525919, 6863.142107236596, 2090.707300977864, 2121.586290673319, 2127.4468638154112, 2127.946801329964, 2130.2970019893396, 2071.1301253473575, 2107.5258066934894, 2110.219218889013, 2113.704081428601, 2116.5872654832315, 1798.514401111699, 1861.5346163459135, 2065.0087957780274, 2134.4450442884886, 2139.6469582518866, 2132.509522809755, 2136.508603021314, 2137.0, 2138.176801931252, 2140.165335519149, 2049.4978730211046, 2070.6893965905083, 2073.212179371829, 2082.864613800113, 2110.1137522240697, 6973.407260382823, 7015.649217539102, 7016.859662806715, 7023.719051237945, 7028.578285302899, 4172.666186705087, 4287.721298115613, 4294.634956028742, 4308.67684923632, 4309.5690430956965, 2647.457271259387, 2817.3660926291627, 2832.985835070832, 2886.235147685865, 2902.721363729462, 1067.5196161727254, 1096.8354746787966, 1112.821948488246, 1155.474259212065, 1172.9882701172965, 8914.86627700585, 8944.10558944107, 8958.910410895938, 8964.820703585892, 8972.371933964625, 3797.6012518685693, 3999.5400528938962, 4054.8580799671868, 4075.3275709507598, 4077.7553346798695, 8019.238172373615, 8028.036635603765, 8030.879536806952, 8032.236937490929, 8034.638441270157, 4479.350494178326, 4480.820767169277, 4484.641228701696, 4487.685861989695, 4490.236659767847, 3462.151772815626, 3596.2447885944243, 3862.3820188769664, 4011.117554138085, 4085.20338533983, 3426.691597756164, 3455.4644030175364, 3566.821658917044, 3583.8566457341935, 3597.406427939413, 1160.158884808524, 1170.9578475157116, 1180.7048237940514, 1187.6912002879142, 1192.3978390912707, 699.7900629811037, 715.2239819795581, 806.2622700229225, 825.3892119831402, 835.5362773660677, 4954.232094025432, 4970.527799859007, 5011.273365362002, 5132.307138536325, 5185.196294574347, 896.6771962093641, 917.454114801692, 917.7934964633038, 920.9171174594319, 965.0638880286111, 3449.292894956528, 3458.342914846171, 3465.341585098823, 3542.787432754043, 3616.909577260537, 8173.305269052197, 8388.538630375388, 8437.704680336159, 8471.745847624581, 8485.830283394298, 8365.958170209231, 8375.790605234917, 8376.32989360862, 8384.0, 8396.580170991549, 6471.352864713491, 6662.43369313604, 6677.499187560952, 6690.330966903271, 6690.531662783558, 4653.092646933951, 4890.7554622268035, 4892.877678058077, 5045.949540504548, 5082.872928176826, 7397.371223446067, 7442.292982166686, 7474.887876681963, 7615.619219038915, 7684.846303073796, 7028.332308430691, 7202.53183543068, 7509.399248060251, 7540.208278130936, 7560.0, 5193.091209038327, 5344.4121146674615, 5809.680467574155, 5984.9401505986125, 5993.130996005468, 6493.188351456068, 6676.232233293039, 6693.330666933462, 6876.243613202444, 6893.138357705287, 5846.970765146147, 6019.398060193946, 6024.1265016573225, 6043.576949613484, 6076.331603523698, 5893.263342082239, 5927.614705044159, 5947.791827286197, 5960.0, 5982.042873140276, 5503.449655034465, 5531.2532808072, 5545.528630066489, 5569.637973531708, 5590.021746194318, 4064.4512990747053, 4066.3087275163884, 4110.773907435, 4398.340248962553, 4494.685372024058, 4170.249355116108, 4180.644645205191, 4183.372494125905, 4250.383694364238, 4256.212600668886], "value": 3834.2838247228055, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.5318162978942, 364.37327796190544, 364.5752698106706, 368.9557253129624, 374.52996489405825, 4628.514006029369, 4846.2972868934075, 4847.36984192055, 4925.8029678812845, 4934.840312526553, 4692.788824502897, 4832.4442689090765, 4857.368542089533, 4859.396399188268, 4866.683665561744, 3933.213357328546, 3948.6643635291034, 3949.1311911379453, 3952.7825969571663, 3956.5054368203973, 3857.8071096445065, 3958.802059897008, 3958.851932939444, 3959.7624142551394, 3966.5636779954184, 3900.7074469414906, 3912.158885839544, 3912.5109361329833, 3921.0, 3921.0981474260793, 3886.727929044968, 3900.7074469414765, 3903.2583809076186, 3903.863364782233, 3924.529056513237, 3511.2977404519197, 3522.2603253316834, 3532.894013179609, 3547.3614749345106, 3588.282343531278, 4588.954110458886, 4662.790174442158, 4702.27114797207, 4737.857864264078, 4769.0, 4425.225585522553, 4435.135148646015, 4441.533638967894, 4446.888827779299, 4458.487273963503, 5063.126708068331, 5064.594832413398, 5070.6957582545165, 5074.3657042869645, 5077.339945807022, 3448.913777155566, 3849.6727778138893, 3860.208657225262, 3861.613838616144, 3863.690904727615, 5273.182656688219, 5309.362876454811, 5320.388155362106, 5324.227986941872, 5340.385855626614, 3710.3692372296773, 3717.4795528626014, 3717.5501554393268, 3727.813609319523, 3738.532683414573, 3754.7371683982406, 3776.4146557283116, 3778.074371778932, 3804.334241507725, 3804.885853424402, 4171.436856024458, 4244.405783190356, 4292.647815937969, 4294.763787991628, 4363.647269346513, 5050.696958182521, 5053.422754395211, 5063.164577844688, 5064.164412871834, 5073.010762901273, 1179.8171283450906, 1213.5449206547544, 1227.9447424865903, 1259.974800504003, 1269.2130878854985, 852.4672079950032, 862.2756884217288, 865.0052439694276, 869.8347314010318, 870.1516021878617, 4285.571442855752, 4287.442632457823, 4310.568943105664, 4311.202427550913, 4320.2655548556195, 5026.824061157842, 5041.243813427942, 5041.521055499722, 5046.637407899846, 5051.419086804991, 4295.72077814941, 4325.956740432618, 4334.544872788375, 4349.695521313478, 4352.238358287287, 2601.8829152688177, 2622.462395208978, 2657.946841063168, 2662.5473669476237, 2688.8386696798257, 4665.803924311857, 4669.132347061202, 4727.267273572602, 4731.4795372509, 4770.332153498513, 5142.125838607446, 5152.742362881841, 5169.353830771153, 5181.740912954338, 5206.427292997767, 4471.821127154943, 4685.5782979532005, 4694.765261736899, 4706.0, 4714.269288260325, 4939.382577177853, 5007.649464537448, 5019.924701129559, 5037.647364684437, 5062.468440813662, 4992.80028798844, 4998.150684246852, 5003.799848006039, 5008.824691135793, 5020.87447813793, 4637.304404339241, 4890.975545122252, 4907.2393778964315, 4919.966806970577, 4921.876953076202, 3698.1494256320657, 3710.4805327253666, 3710.8515659373325, 3720.3489389357296, 3720.404735242348, 5249.291345668286, 5254.448282930237, 5271.314729085195, 5278.788848446173, 5289.18017707256, 4646.37376918076, 4790.233562629963, 4989.725565093955, 5019.548240658358, 5042.319286896222, 4990.6506544541535, 5006.949930500794, 5009.7244651544515, 5013.197888337994, 5016.648834581544, 4838.419389673121, 4964.652474326763, 4981.978694367718, 4987.900241995212, 4998.0, 4992.825251116194, 5041.067402530543, 5050.595952323732, 5056.241563765465, 5066.316047333563, 4890.486498917705, 4919.778609962489, 4920.434150072644, 4934.827281045146, 4949.752512374295], "value": 3831.625214339684, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.8489247473078, 663.6449499517759, 732.3847967707125, 769.1039938471681, 781.6599779096092, 12679.936600317009, 13617.863821361783, 13619.114757540752, 13635.795463068038, 13640.045196836225, 13098.214107153577, 13170.407331670074, 13175.868241317585, 13210.207387556753, 13254.801177982337, 659.0707102984792, 680.5916450129907, 796.8366484870587, 797.1988151907325, 818.1041759273616, 823.6664151018817, 825.4345773145385, 825.6614787936948, 825.8678611422174, 825.8678611422174, 875.1511034296722, 876.6931573949131, 876.8640860666575, 877.0878286581947, 877.2236570634971, 685.6400389795373, 710.6659869861157, 713.3971793834202, 713.8144082538525, 872.7730789994583, 610.8106486989047, 625.9280182778948, 627.9089532017832, 631.425402883374, 631.8136149835809, 12578.81131783024, 12593.622191334274, 12603.36983150848, 12637.557685481055, 12644.557440489538, 12823.935880320632, 13040.673983150402, 13058.608241752763, 13071.281079540622, 13105.541306054338, 11833.644990650295, 11912.404379780975, 11961.64115076549, 12101.576444824388, 12175.0, 4101.712880098395, 4119.196756632457, 4202.432671589327, 4205.306124489486, 4208.72643278189, 59921.7003914982, 61899.69050154765, 62295.37704622986, 62734.058989115656, 63218.683906580634, 10563.683089507327, 10579.259451838298, 10718.571257149626, 10731.946340268249, 10808.351498910091, 18168.273269069352, 18213.63572728538, 18224.36214732478, 18336.358227461973, 18419.0, 6433.678316084177, 6542.967285163544, 6575.473962083021, 6653.9667301663185, 6752.493562982698, 3294.1435226840713, 3294.5387645729616, 3295.3738789629892, 3349.531065650811, 3380.6619338066, 2672.1315572439034, 2745.958810617842, 2784.1230012545984, 2784.1230012545984, 2787.080263513036, 459.68281885498897, 460.37389150754944, 461.4808340616806, 465.9254519276967, 470.7410923991791, 590.8755746685658, 591.8964181268261, 608.6652341212316, 608.9604175728564, 610.4170517156106, 8175.264226219669, 8205.466644668077, 8498.66005359791, 8897.288216942628, 9116.772080697903, 519.9688018718813, 529.7748456905799, 537.4786457136571, 592.0793166625853, 634.5558109323492, 3685.207680348738, 3791.0, 3810.2950954073585, 3886.397608370707, 3997.320455522568, 55131.0, 63182.36817631857, 64462.355376446576, 64896.0, 65122.0, 58030.678772848616, 58208.0, 58259.0, 59993.40006599878, 60171.69914150401, 48388.516114839105, 51947.0, 52329.215061774106, 52693.736531317096, 52880.47119528832, 7529.887051694339, 7575.373827366479, 7821.491603045783, 8012.118666946515, 8080.83838323242, 36537.81731091328, 37683.0, 37911.0, 38512.0, 39538.209235814546, 45694.771526143486, 46050.30924536067, 46118.0, 46611.300830488246, 48700.26949595688, 9878.753031174278, 10039.0, 10079.848802267825, 10091.19270458347, 10119.291649584458, 11110.777784444104, 11152.776944460904, 11181.496832642388, 11339.829902551633, 11449.771004580029, 9865.605375784888, 10094.091531762177, 10151.187904967732, 10358.0, 10661.89338106609, 9905.257105716955, 9966.252531060345, 9984.500774961369, 10016.39901605906, 10091.142252908585, 10279.0, 10308.742281443025, 10411.687649370531, 10467.214958877963, 10609.681709548726, 8382.958085209535, 8586.785330366542, 8647.178518040777, 8720.215180633773, 8854.955725221333, 8635.654573817228, 8713.825723485621, 8737.169968852948, 8763.780905477413, 8922.811548106329], "value": 6142.754514988095, "unit": "score"}], "name": "dromaeo_css", "value": 6279.326266417442, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 118.0, 116.0, 116.0, 115.0, 115.0, 115.0, 115.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 129.0, 126.0, 165.0, 127.0, 126.0, 125.0, 131.0, 156.0, 127.0], "value": 136.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 160.0, 163.0, 162.0, 161.0, 161.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 112.0, 79.0, 77.0, 76.0, 75.0, 91.0, 80.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 107.0, 84.0, 84.0, 84.0, 102.0, 83.0, 84.0, 105.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 149.0, 149.0, 149.0, 148.0, 149.0, 148.0, 150.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 60.0, 59.0, 60.0, 61.0, 61.0, 62.0], "value": 59.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0, 67.0, 67.0, 67.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 87.0, 85.0, 85.0, 86.0, 94.0, 84.0, 90.0, 86.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 135.0, 134.0, 137.0, 136.0, 141.0, 131.0, 135.0, 193.0, 135.0], "value": 141.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 175.0, 180.0, 173.0, 174.0, 176.0, 175.0, 174.0, 173.0, 176.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 68.0, 69.0, 68.0, 67.0, 69.0, 66.0, 77.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1545.6000000000001, "alertThreshold": 2.0}]} 13:33:31 INFO - Return code: 0 13:33:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:33:31 ERROR - # TBPL SUCCESS # 13:33:31 INFO - Running post-action listener: _resource_record_post_action 13:33:31 INFO - [mozharness: 2017-01-19 21:33:31.668501Z] Finished run-tests step (success) 13:33:31 INFO - Running post-run listener: _resource_record_post_run 13:33:31 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 397312; Write bytes: 406155264; Read time: 840; Write time: 859216 13:33:31 INFO - TinderboxPrint: CPU usage
13.1% 13:33:31 INFO - TinderboxPrint: I/O read bytes / time
397,312 / 840 13:33:31 INFO - TinderboxPrint: I/O write bytes / time
406,155,264 / 859,216 13:33:31 INFO - TinderboxPrint: CPU idle
8,353.4 (86.8%) 13:33:31 INFO - TinderboxPrint: CPU user
1,211.3 (12.6%) 13:33:31 INFO - TinderboxPrint: Swap in / out
0 / 0 13:33:31 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 4096; Write bytes: 100126720; Read time: 292; Write time: 333920 13:33:31 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 393216; Write bytes: 293191680; Read time: 548; Write time: 508672 13:33:32 INFO - Running post-run listener: _upload_blobber_files 13:33:32 INFO - Blob upload gear active. 13:33:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:33:32 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 13:33:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:33:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:33:32 INFO - (blobuploader) - INFO - Open directory for files ... 13:33:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:33:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:33:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:33:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:33:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:33:33 INFO - (blobuploader) - INFO - Done attempting. 13:33:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:33:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:33:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:33:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:33:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:33:38 INFO - (blobuploader) - INFO - Done attempting. 13:33:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:33:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:33:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:33:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:33:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:33:39 INFO - (blobuploader) - INFO - Done attempting. 13:33:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:33:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:33:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:33:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:33:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:33:40 INFO - (blobuploader) - INFO - Done attempting. 13:33:40 INFO - (blobuploader) - INFO - Iteration through files over. 13:33:40 INFO - Return code: 0 13:33:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:33:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:33:40 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/343de10171224cbb62dcaa9862a517ee26fa4b11cc4383042411b570bfe481b288d2ec3d2dd1d7092056974027742792850900765a57783455eb9c9e2a4f431e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/983184a74124f5c9af01726558fd4416b7fd605069c37a903655fb7738fcc4eae2197a8eb8a6a04af31f70ae2d5d962fb12ef00056f1dc63adb1e391ee66ddc4", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0a9f81c7dfe50bf48da28a90d17923201194b9e1529fc5f914af58b193cc4c80890c55b2f33689ae1ad7580a987ab4bb3376b79648de417d5a06d9f778ef6abb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b8266c7ee479e7828b0b662ab589f54f250ee72269434beb9a95c9221a38db8a1d897f6a978ecf80d81ef054a2237cef5f9aff7fa0ad083b59a0881f9f6dc2e3"} 13:33:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:33:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:33:40 INFO - Contents: 13:33:40 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/343de10171224cbb62dcaa9862a517ee26fa4b11cc4383042411b570bfe481b288d2ec3d2dd1d7092056974027742792850900765a57783455eb9c9e2a4f431e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/983184a74124f5c9af01726558fd4416b7fd605069c37a903655fb7738fcc4eae2197a8eb8a6a04af31f70ae2d5d962fb12ef00056f1dc63adb1e391ee66ddc4", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0a9f81c7dfe50bf48da28a90d17923201194b9e1529fc5f914af58b193cc4c80890c55b2f33689ae1ad7580a987ab4bb3376b79648de417d5a06d9f778ef6abb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b8266c7ee479e7828b0b662ab589f54f250ee72269434beb9a95c9221a38db8a1d897f6a978ecf80d81ef054a2237cef5f9aff7fa0ad083b59a0881f9f6dc2e3"} 13:33:40 INFO - Running post-run listener: copy_logs_to_upload_dir 13:33:40 INFO - Copying logs to upload dir... 13:33:40 INFO - mkdir: /builds/slave/test/build/upload/logs 13:33:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.002680 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-01-19 13:33:40.237348) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 13:33:40.243356) ========= 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=df17445c3590ff7897617a0e00000225-1484860367.21562-932785477 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/343de10171224cbb62dcaa9862a517ee26fa4b11cc4383042411b570bfe481b288d2ec3d2dd1d7092056974027742792850900765a57783455eb9c9e2a4f431e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/983184a74124f5c9af01726558fd4416b7fd605069c37a903655fb7738fcc4eae2197a8eb8a6a04af31f70ae2d5d962fb12ef00056f1dc63adb1e391ee66ddc4", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0a9f81c7dfe50bf48da28a90d17923201194b9e1529fc5f914af58b193cc4c80890c55b2f33689ae1ad7580a987ab4bb3376b79648de417d5a06d9f778ef6abb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b8266c7ee479e7828b0b662ab589f54f250ee72269434beb9a95c9221a38db8a1d897f6a978ecf80d81ef054a2237cef5f9aff7fa0ad083b59a0881f9f6dc2e3"} build_url:https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011243 build_url: 'https://queue.taskcluster.net/v1/task/GZLy8lu3SYGrOd7qXwAlNg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/343de10171224cbb62dcaa9862a517ee26fa4b11cc4383042411b570bfe481b288d2ec3d2dd1d7092056974027742792850900765a57783455eb9c9e2a4f431e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/983184a74124f5c9af01726558fd4416b7fd605069c37a903655fb7738fcc4eae2197a8eb8a6a04af31f70ae2d5d962fb12ef00056f1dc63adb1e391ee66ddc4", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0a9f81c7dfe50bf48da28a90d17923201194b9e1529fc5f914af58b193cc4c80890c55b2f33689ae1ad7580a987ab4bb3376b79648de417d5a06d9f778ef6abb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b8266c7ee479e7828b0b662ab589f54f250ee72269434beb9a95c9221a38db8a1d897f6a978ecf80d81ef054a2237cef5f9aff7fa0ad083b59a0881f9f6dc2e3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 13:33:40.267719) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 13:33:40.268028) ========= 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=df17445c3590ff7897617a0e00000225-1484860367.21562-932785477 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 13:33:40.353596) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 13:33:40.354033) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 13:33:40.354303) ========= ========= Total master_lag: 0.16 =========