builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-024 starttime: 1494759202.56 results: success (0) revision: 73b3fc64525b6816842c737e104ef2ac5482d217 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-14 03:53:22.565138) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-14 03:53:22.565529) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-14 03:53:22.565802) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-14 03:53:22.584678) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 03:53:22.584936) ========= 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=41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-14 03:53:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-05-14 03:53:23 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.151763 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 03:53:22.750087) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 03:53:22.750372) ========= 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=41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016649 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 03:53:22.802581) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 03:53:22.802867) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 73b3fc64525b6816842c737e104ef2ac5482d217 --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 73b3fc64525b6816842c737e104ef2ac5482d217 --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=41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-14 03:53:23,202 truncating revision to first 12 chars 2017-05-14 03:53:23,202 Setting DEBUG logging. 2017-05-14 03:53:23,203 attempt 1/10 2017-05-14 03:53:23,203 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/73b3fc64525b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-14 03:53:23,733 unpacking tar archive at: mozilla-central-73b3fc64525b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.894893 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 03:53:23.714782) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-14 03:53:23.715090) ========= script_repo_revision: 73b3fc64525b6816842c737e104ef2ac5482d217 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-14 03:53:23.715482) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-14 03:53:23.715760) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-14 03:53:23.733649) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-05-14 03:53:23.733909) ========= /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=41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:53:24 INFO - MultiFileLogger online at 20170514 03:53:24 in /builds/slave/test 03:53:24 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 03:53:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:53:24 INFO - {'append_to_log': False, 03:53:24 INFO - 'base_work_dir': '/builds/slave/test', 03:53:24 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:53:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:53:24 INFO - 'branch': 'Firefox-Non-PGO', 03:53:24 INFO - 'buildbot_json_path': 'buildprops.json', 03:53:24 INFO - 'config_files': ('talos/linux_config.py',), 03:53:24 INFO - 'default_actions': ('clobber', 03:53:24 INFO - 'read-buildbot-config', 03:53:24 INFO - 'download-and-extract', 03:53:24 INFO - 'populate-webroot', 03:53:24 INFO - 'create-virtualenv', 03:53:24 INFO - 'install', 03:53:24 INFO - 'run-tests'), 03:53:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:53:24 INFO - 'download_minidump_stackwalk': True, 03:53:24 INFO - 'download_symbols': 'ondemand', 03:53:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:53:24 INFO - 'tooltool.py': '/tools/tooltool.py', 03:53:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:53:24 INFO - '/tools/misc-python/virtualenv.py')}, 03:53:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:53:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:53:24 INFO - 'gecko_profile': False, 03:53:24 INFO - 'gecko_profile_interval': 0, 03:53:24 INFO - 'installer_path': 'installer.exe', 03:53:24 INFO - 'log_level': 'info', 03:53:24 INFO - 'log_name': 'talos', 03:53:24 INFO - 'log_to_console': True, 03:53:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:53:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:53:24 INFO - 'opt_config_files': (), 03:53:24 INFO - 'pip_index': False, 03:53:24 INFO - 'suite': 'dromaeojs', 03:53:24 INFO - 'system_bits': '32', 03:53:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:53:24 INFO - 'title': 'talos-linux64-ix-024', 03:53:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:53:24 INFO - 'use_talos_json': True, 03:53:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:53:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:53:24 INFO - 'work_dir': 'build'} 03:53:24 INFO - [mozharness: 2017-05-14 10:53:24.230011Z] Running clobber step. 03:53:24 INFO - Running pre-action listener: _resource_record_pre_action 03:53:24 INFO - Running main action method: clobber 03:53:24 INFO - rmtree: /builds/slave/test/build 03:53:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:53:25 INFO - Running post-action listener: _resource_record_post_action 03:53:25 INFO - [mozharness: 2017-05-14 10:53:25.784960Z] Finished clobber step (success) 03:53:25 INFO - [mozharness: 2017-05-14 10:53:25.785061Z] Running read-buildbot-config step. 03:53:25 INFO - Running pre-action listener: _resource_record_pre_action 03:53:25 INFO - Running main action method: read_buildbot_config 03:53:25 INFO - Using buildbot properties: 03:53:25 INFO - { 03:53:25 INFO - "project": "", 03:53:25 INFO - "product": "firefox", 03:53:25 INFO - "who": "nobody@mozilla.org", 03:53:25 INFO - "installer_path": "public/build/target.tar.bz2", 03:53:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:53:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:53:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 03:53:25 INFO - "stage_platform": "linux64", 03:53:25 INFO - "basedir": "/builds/slave/test", 03:53:25 INFO - "buildnumber": 992, 03:53:25 INFO - "platform": "ubuntu64_hw", 03:53:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:53:25 INFO - "slavebuilddir": "test", 03:53:25 INFO - "taskId": "IpIHAQApRS-IHAHiC8zH1A", 03:53:25 INFO - "branch": "mozilla-central", 03:53:25 INFO - "script_repo_revision": "production", 03:53:25 INFO - "revision": "73b3fc64525b6816842c737e104ef2ac5482d217", 03:53:25 INFO - "slavename": "talos-linux64-ix-024", 03:53:25 INFO - "repo_path": "mozilla-central" 03:53:25 INFO - } 03:53:25 INFO - Finding installer, test and symbols from parent task. 03:53:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IpIHAQApRS-IHAHiC8zH1A'}, attempt #1 03:53:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IpIHAQApRS-IHAHiC8zH1A'}, attempt #1 03:53:26 INFO - Task dependencies: QB0hmINOSoazUWUA3T3ZdA 03:53:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QB0hmINOSoazUWUA3T3ZdA'}, attempt #1 03:53:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/target.tar.bz2 03:53:27 INFO - Set test_url: https://queue.taskcluster.net/v1/task/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/test_packages.json 03:53:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/target.crashreporter-symbols.zip 03:53:27 INFO - Running post-action listener: _resource_record_post_action 03:53:27 INFO - [mozharness: 2017-05-14 10:53:27.151365Z] Finished read-buildbot-config step (success) 03:53:27 INFO - [mozharness: 2017-05-14 10:53:27.151583Z] Running download-and-extract step. 03:53:27 INFO - Running pre-action listener: _resource_record_pre_action 03:53:27 INFO - Running main action method: download_and_extract 03:53:27 INFO - mkdir: /builds/slave/test/build/tests 03:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:53:27 INFO - trying https://queue.taskcluster.net/v1/task/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/target.test_packages.json 03:53:27 INFO - Downloading https://queue.taskcluster.net/v1/task/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:53:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:53:27 INFO - Downloaded 986 bytes. 03:53:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:53:27 INFO - Using the following test package requirements: 03:53:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:53:27 INFO - u'common': [u'target.common.tests.zip'], 03:53:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:53:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:53:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:53:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:53:27 INFO - u'mozbase': [u'target.common.tests.zip'], 03:53:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:53:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:53:27 INFO - u'web-platform': [u'target.common.tests.zip', 03:53:27 INFO - u'target.web-platform.tests.zip'], 03:53:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:53:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:53:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/target.common.tests.zip 03:53:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:53:27 INFO - Fetch https://queue.taskcluster.net/v1/task/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/target.common.tests.zip into memory 03:53:28 INFO - Content-Length response header: 64598316 03:53:28 INFO - Bytes received: 64598316 03:53:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:53:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/target.common.tests.zip 03:53:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:53:39 INFO - Fetch https://queue.taskcluster.net/v1/task/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/target.common.tests.zip into memory 03:53:40 INFO - Content-Length response header: 64598316 03:53:40 INFO - Bytes received: 64598316 03:53:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/target.talos.tests.zip 03:53:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:53:52 INFO - Fetch https://queue.taskcluster.net/v1/task/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/target.talos.tests.zip into memory 03:53:53 INFO - Content-Length response header: 14409411 03:53:53 INFO - Bytes received: 14409411 03:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:53:53 INFO - trying https://queue.taskcluster.net/v1/task/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/target.tar.bz2 03:53:53 INFO - Downloading https://queue.taskcluster.net/v1/task/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:53:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:53:54 INFO - Downloaded 68642947 bytes. 03:53:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/target.tar.bz2 03:53:54 INFO - mkdir: /builds/slave/test/properties 03:53:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:53:54 INFO - Writing to file /builds/slave/test/properties/build_url 03:53:54 INFO - Contents: 03:53:54 INFO - build_url:https://queue.taskcluster.net/v1/task/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/target.tar.bz2 03:53:54 INFO - Running post-action listener: _resource_record_post_action 03:53:54 INFO - Running post-action listener: set_extra_try_arguments 03:53:54 INFO - [mozharness: 2017-05-14 10:53:54.682442Z] Finished download-and-extract step (success) 03:53:54 INFO - [mozharness: 2017-05-14 10:53:54.682540Z] Running populate-webroot step. 03:53:54 INFO - Running pre-action listener: _resource_record_pre_action 03:53:54 INFO - Running main action method: populate_webroot 03:53:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:53:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:53:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:53:54 INFO - '--tppagecycles', 03:53:54 INFO - '7'], 03:53:54 INFO - 'tests': ['tsvgm']}}, 03:53:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:53:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:53:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:53:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:53:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:53:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:53:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:53:54 INFO - 'talos_options': ['--disable-e10s'], 03:53:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:53:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:53:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:53:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:53:54 INFO - 'talos_options': ['--disable-e10s'], 03:53:54 INFO - 'tests': ['damp', 'tps']}, 03:53:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:53:54 INFO - 'tests': ['damp', 'tps']}, 03:53:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:53:54 INFO - 'tests': ['dromaeo_dom']}, 03:53:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:53:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:53:54 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:53:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:53:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:53:54 INFO - 'tests': ['a11yr', 03:53:54 INFO - 'ts_paint', 03:53:54 INFO - 'tpaint', 03:53:54 INFO - 'sessionrestore', 03:53:54 INFO - 'sessionrestore_no_auto_restore', 03:53:54 INFO - 'tabpaint']}, 03:53:54 INFO - 'other-e10s': {'tests': ['a11yr', 03:53:54 INFO - 'ts_paint', 03:53:54 INFO - 'tpaint', 03:53:54 INFO - 'sessionrestore', 03:53:54 INFO - 'sessionrestore_no_auto_restore', 03:53:54 INFO - 'tabpaint']}, 03:53:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:53:54 INFO - 'ts_paint', 03:53:54 INFO - 'tpaint', 03:53:54 INFO - 'sessionrestore', 03:53:54 INFO - 'sessionrestore_no_auto_restore', 03:53:54 INFO - 'tabpaint']}, 03:53:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:53:54 INFO - 'ts_paint', 03:53:54 INFO - 'tpaint', 03:53:54 INFO - 'sessionrestore', 03:53:54 INFO - 'sessionrestore_no_auto_restore', 03:53:54 INFO - 'tabpaint']}, 03:53:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:53:54 INFO - 'tests': ['a11yr', 03:53:54 INFO - 'ts_paint', 03:53:54 INFO - 'tpaint', 03:53:54 INFO - 'sessionrestore', 03:53:54 INFO - 'sessionrestore_no_auto_restore', 03:53:54 INFO - 'tabpaint']}, 03:53:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:53:54 INFO - 'tests': ['a11yr', 03:53:54 INFO - 'ts_paint', 03:53:54 INFO - 'tpaint', 03:53:54 INFO - 'sessionrestore', 03:53:54 INFO - 'sessionrestore_no_auto_restore', 03:53:54 INFO - 'tabpaint']}, 03:53:54 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:53:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:53:54 INFO - 'bloom_basic_ref']}, 03:53:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:53:54 INFO - 'tests': ['tsvgx', 03:53:54 INFO - 'tsvgr_opacity', 03:53:54 INFO - 'tart', 03:53:54 INFO - 'tscrollx', 03:53:54 INFO - 'cart', 03:53:54 INFO - 'tsvg_static']}, 03:53:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:53:54 INFO - 'tsvgr_opacity', 03:53:54 INFO - 'tart', 03:53:54 INFO - 'tscrollx', 03:53:54 INFO - 'cart', 03:53:54 INFO - 'tsvg_static']}, 03:53:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:53:54 INFO - 'talos_options': ['--disable-e10s'], 03:53:54 INFO - 'tests': ['tp5o']}, 03:53:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:53:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:53:54 INFO - 'talos_options': ['--disable-e10s', 03:53:54 INFO - '--xperf_path', 03:53:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:53:54 INFO - 'tests': ['tp5n']}, 03:53:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:53:54 INFO - 'talos_options': ['--xperf_path', 03:53:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:53:54 INFO - 'tests': ['tp5n']}}, 03:53:54 INFO - 'talos.zip': {'path': '', 03:53:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:53:54 INFO - Running post-action listener: _resource_record_post_action 03:53:54 INFO - [mozharness: 2017-05-14 10:53:54.696138Z] Finished populate-webroot step (success) 03:53:54 INFO - [mozharness: 2017-05-14 10:53:54.696227Z] Running create-virtualenv step. 03:53:54 INFO - Running pre-action listener: _resource_record_pre_action 03:53:54 INFO - Running main action method: create_virtualenv 03:53:54 INFO - Creating virtualenv /builds/slave/test/build/venv 03:53:54 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 03:53:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:53:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:53:54 INFO - Using real prefix '/usr' 03:53:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:53:55 INFO - Installing distribute.............................................................................................................................................................................................done. 03:53:57 INFO - Installing pip.................done. 03:53:57 INFO - Return code: 0 03:53:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:53:57 INFO - Reading from file tmpfile_stdout 03:53:57 INFO - Output received: 03:53:57 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) 03:53:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:57 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/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 0x17741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1940a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae3a30>, '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 0x1ae47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae4ca0>, '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': '41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349', '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 03:53:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:53:57 INFO - Using env: {'DISPLAY': ':0', 03:53:57 INFO - 'HOME': '/home/cltbld', 03:53:57 INFO - 'LANG': 'en_US.UTF-8', 03:53:57 INFO - 'LANGUAGE': 'en_US:en', 03:53:57 INFO - 'LOGNAME': 'cltbld', 03:53:57 INFO - 'MAIL': '/var/mail/cltbld', 03:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:57 INFO - 'MOZ_NO_REMOTE': '1', 03:53:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:57 INFO - 'NO_EM_RESTART': '1', 03:53:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:57 INFO - 'PWD': '/builds/slave/test', 03:53:57 INFO - 'SHELL': '/bin/bash', 03:53:57 INFO - 'SHLVL': '1', 03:53:57 INFO - 'TERM': 'linux', 03:53:57 INFO - 'TMOUT': '86400', 03:53:57 INFO - 'USER': 'cltbld', 03:53:57 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349', 03:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:57 INFO - '_': '/tools/buildbot/bin/python'} 03:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:57 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 03:53:57 INFO - Cleaning up... 03:53:57 INFO - Return code: 0 03:53:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:57 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/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 0x17741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1940a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae3a30>, '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 0x1ae47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae4ca0>, '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': '41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349', '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 03:53:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:53:57 INFO - Using env: {'DISPLAY': ':0', 03:53:57 INFO - 'HOME': '/home/cltbld', 03:53:57 INFO - 'LANG': 'en_US.UTF-8', 03:53:57 INFO - 'LANGUAGE': 'en_US:en', 03:53:57 INFO - 'LOGNAME': 'cltbld', 03:53:57 INFO - 'MAIL': '/var/mail/cltbld', 03:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:57 INFO - 'MOZ_NO_REMOTE': '1', 03:53:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:57 INFO - 'NO_EM_RESTART': '1', 03:53:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:57 INFO - 'PWD': '/builds/slave/test', 03:53:57 INFO - 'SHELL': '/bin/bash', 03:53:57 INFO - 'SHLVL': '1', 03:53:57 INFO - 'TERM': 'linux', 03:53:57 INFO - 'TMOUT': '86400', 03:53:57 INFO - 'USER': 'cltbld', 03:53:57 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349', 03:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:57 INFO - '_': '/tools/buildbot/bin/python'} 03:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:57 INFO - Downloading/unpacking psutil>=3.1.1 03:53:57 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 03:53:57 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 03:53:57 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 03:53:57 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 03:53:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:53:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:53:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:53:59 INFO - Installing collected packages: psutil 03:53:59 INFO - Running setup.py install for psutil 03:53:59 INFO - building 'psutil._psutil_linux' extension 03:53:59 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 03:53:59 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 03:53:59 INFO - building 'psutil._psutil_posix' extension 03:53:59 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 03:53:59 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 03:53:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:53:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:53:59 INFO - Successfully installed psutil 03:53:59 INFO - Cleaning up... 03:53:59 INFO - Return code: 0 03:53:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:59 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/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 0x17741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1940a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae3a30>, '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 0x1ae47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae4ca0>, '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': '41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349', '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 03:53:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:53:59 INFO - Using env: {'DISPLAY': ':0', 03:53:59 INFO - 'HOME': '/home/cltbld', 03:53:59 INFO - 'LANG': 'en_US.UTF-8', 03:53:59 INFO - 'LANGUAGE': 'en_US:en', 03:53:59 INFO - 'LOGNAME': 'cltbld', 03:53:59 INFO - 'MAIL': '/var/mail/cltbld', 03:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:59 INFO - 'MOZ_NO_REMOTE': '1', 03:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:59 INFO - 'NO_EM_RESTART': '1', 03:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:59 INFO - 'PWD': '/builds/slave/test', 03:53:59 INFO - 'SHELL': '/bin/bash', 03:53:59 INFO - 'SHLVL': '1', 03:53:59 INFO - 'TERM': 'linux', 03:53:59 INFO - 'TMOUT': '86400', 03:53:59 INFO - 'USER': 'cltbld', 03:53:59 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349', 03:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:59 INFO - '_': '/tools/buildbot/bin/python'} 03:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:53:59 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 03:53:59 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 03:53:59 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 03:53:59 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 03:54:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:54:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:54:00 INFO - Installing collected packages: mozsystemmonitor 03:54:00 INFO - Running setup.py install for mozsystemmonitor 03:54:01 INFO - Successfully installed mozsystemmonitor 03:54:01 INFO - Cleaning up... 03:54:01 INFO - Return code: 0 03:54:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:01 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/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 0x17741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1940a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae3a30>, '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 0x1ae47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae4ca0>, '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': '41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349', '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 03:54:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:54:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:54:01 INFO - Using env: {'DISPLAY': ':0', 03:54:01 INFO - 'HOME': '/home/cltbld', 03:54:01 INFO - 'LANG': 'en_US.UTF-8', 03:54:01 INFO - 'LANGUAGE': 'en_US:en', 03:54:01 INFO - 'LOGNAME': 'cltbld', 03:54:01 INFO - 'MAIL': '/var/mail/cltbld', 03:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:01 INFO - 'MOZ_NO_REMOTE': '1', 03:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:01 INFO - 'NO_EM_RESTART': '1', 03:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:01 INFO - 'PWD': '/builds/slave/test', 03:54:01 INFO - 'SHELL': '/bin/bash', 03:54:01 INFO - 'SHLVL': '1', 03:54:01 INFO - 'TERM': 'linux', 03:54:01 INFO - 'TMOUT': '86400', 03:54:01 INFO - 'USER': 'cltbld', 03:54:01 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349', 03:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:01 INFO - '_': '/tools/buildbot/bin/python'} 03:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:01 INFO - Downloading/unpacking jsonschema==2.5.1 03:54:01 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 03:54:01 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 03:54:01 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 03:54:01 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 03:54:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:54:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:02 INFO - Downloading functools32-3.2.3-2.tar.gz 03:54:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:54:02 INFO - warning: no files found matching '*.txt' 03:54:02 INFO - no previously-included directories found matching 'build' 03:54:02 INFO - no previously-included directories found matching 'dist' 03:54:02 INFO - no previously-included directories found matching '.git*' 03:54:02 INFO - Installing collected packages: jsonschema, functools32 03:54:02 INFO - Running setup.py install for functools32 03:54:02 INFO - warning: no files found matching '*.txt' 03:54:02 INFO - no previously-included directories found matching 'build' 03:54:02 INFO - no previously-included directories found matching 'dist' 03:54:02 INFO - no previously-included directories found matching '.git*' 03:54:02 INFO - Successfully installed jsonschema functools32 03:54:02 INFO - Cleaning up... 03:54:02 INFO - Return code: 0 03:54:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:02 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/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 0x17741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1940a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae3a30>, '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 0x1ae47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae4ca0>, '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': '41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349', '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 03:54:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:54:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:54:02 INFO - Using env: {'DISPLAY': ':0', 03:54:02 INFO - 'HOME': '/home/cltbld', 03:54:02 INFO - 'LANG': 'en_US.UTF-8', 03:54:02 INFO - 'LANGUAGE': 'en_US:en', 03:54:02 INFO - 'LOGNAME': 'cltbld', 03:54:02 INFO - 'MAIL': '/var/mail/cltbld', 03:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:02 INFO - 'MOZ_NO_REMOTE': '1', 03:54:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:02 INFO - 'NO_EM_RESTART': '1', 03:54:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:02 INFO - 'PWD': '/builds/slave/test', 03:54:02 INFO - 'SHELL': '/bin/bash', 03:54:02 INFO - 'SHLVL': '1', 03:54:02 INFO - 'TERM': 'linux', 03:54:02 INFO - 'TMOUT': '86400', 03:54:02 INFO - 'USER': 'cltbld', 03:54:02 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349', 03:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:02 INFO - '_': '/tools/buildbot/bin/python'} 03:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:54:03 INFO - Cleaning up... 03:54:03 INFO - Return code: 0 03:54:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:03 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/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 0x17741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1940a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae3a30>, '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 0x1ae47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae4ca0>, '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': '41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349', '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 03:54:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:54:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:54:03 INFO - Using env: {'DISPLAY': ':0', 03:54:03 INFO - 'HOME': '/home/cltbld', 03:54:03 INFO - 'LANG': 'en_US.UTF-8', 03:54:03 INFO - 'LANGUAGE': 'en_US:en', 03:54:03 INFO - 'LOGNAME': 'cltbld', 03:54:03 INFO - 'MAIL': '/var/mail/cltbld', 03:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:03 INFO - 'MOZ_NO_REMOTE': '1', 03:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:03 INFO - 'NO_EM_RESTART': '1', 03:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:03 INFO - 'PWD': '/builds/slave/test', 03:54:03 INFO - 'SHELL': '/bin/bash', 03:54:03 INFO - 'SHLVL': '1', 03:54:03 INFO - 'TERM': 'linux', 03:54:03 INFO - 'TMOUT': '86400', 03:54:03 INFO - 'USER': 'cltbld', 03:54:03 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349', 03:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:03 INFO - '_': '/tools/buildbot/bin/python'} 03:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:03 INFO - Downloading/unpacking blobuploader==1.2.4 03:54:03 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 03:54:03 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 03:54:03 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 03:54:03 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 03:54:04 INFO - Downloading blobuploader-1.2.4.tar.gz 03:54:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:54:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:54:04 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 03:54:04 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 03:54:04 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 03:54:04 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 03:54:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:54:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:54:04 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 03:54:04 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 03:54:04 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 03:54:04 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 03:54:04 INFO - Downloading docopt-0.6.1.tar.gz 03:54:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:54:04 INFO - Installing collected packages: blobuploader, requests, docopt 03:54:04 INFO - Running setup.py install for blobuploader 03:54:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:54:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:54:05 INFO - Running setup.py install for requests 03:54:05 INFO - Running setup.py install for docopt 03:54:05 INFO - Successfully installed blobuploader requests docopt 03:54:05 INFO - Cleaning up... 03:54:05 INFO - Return code: 0 03:54:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:54:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:05 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/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 0x17741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1940a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae3a30>, '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 0x1ae47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae4ca0>, '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': '41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349', '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 03:54:05 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:54:05 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:54:05 INFO - Using env: {'DISPLAY': ':0', 03:54:05 INFO - 'HOME': '/home/cltbld', 03:54:05 INFO - 'LANG': 'en_US.UTF-8', 03:54:05 INFO - 'LANGUAGE': 'en_US:en', 03:54:05 INFO - 'LOGNAME': 'cltbld', 03:54:05 INFO - 'MAIL': '/var/mail/cltbld', 03:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:05 INFO - 'MOZ_NO_REMOTE': '1', 03:54:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:05 INFO - 'NO_EM_RESTART': '1', 03:54:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:05 INFO - 'PWD': '/builds/slave/test', 03:54:05 INFO - 'SHELL': '/bin/bash', 03:54:05 INFO - 'SHLVL': '1', 03:54:05 INFO - 'TERM': 'linux', 03:54:05 INFO - 'TMOUT': '86400', 03:54:05 INFO - 'USER': 'cltbld', 03:54:05 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349', 03:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:05 INFO - '_': '/tools/buildbot/bin/python'} 03:54:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:54:05 INFO - Running setup.py (path:/tmp/pip-acKiTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:54:05 INFO - Running setup.py (path:/tmp/pip-bbebzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:54:05 INFO - Running setup.py (path:/tmp/pip-GfpUzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:54:05 INFO - Running setup.py (path:/tmp/pip-je6T4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:54:06 INFO - Running setup.py (path:/tmp/pip-pErNvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:54:06 INFO - Running setup.py (path:/tmp/pip-oLzEhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:54:06 INFO - Running setup.py (path:/tmp/pip-NKGJlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:54:06 INFO - Running setup.py (path:/tmp/pip-oKzmzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:54:06 INFO - Running setup.py (path:/tmp/pip-VXsKJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:54:06 INFO - Running setup.py (path:/tmp/pip-HTXIN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:54:06 INFO - Running setup.py (path:/tmp/pip-0XoLxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:54:06 INFO - Running setup.py (path:/tmp/pip-myLLBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:54:06 INFO - Running setup.py (path:/tmp/pip-cNrisb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:54:06 INFO - Running setup.py (path:/tmp/pip-qrPL7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:54:06 INFO - Running setup.py (path:/tmp/pip-YKOzz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:54:06 INFO - Running setup.py (path:/tmp/pip-RtY8Nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:54:06 INFO - Running setup.py (path:/tmp/pip-sYhJQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:54:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:54:06 INFO - Running setup.py install for manifestparser 03:54:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:54:07 INFO - Running setup.py install for mozcrash 03:54:07 INFO - Running setup.py install for mozdebug 03:54:07 INFO - Running setup.py install for mozdevice 03:54:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:54:07 INFO - Running setup.py install for mozfile 03:54:07 INFO - Running setup.py install for mozhttpd 03:54:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:54:07 INFO - Running setup.py install for mozinfo 03:54:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:54:07 INFO - Running setup.py install for mozInstall 03:54:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:54:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:54:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:54:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:54:07 INFO - Running setup.py install for mozleak 03:54:07 INFO - Running setup.py install for mozlog 03:54:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:54:07 INFO - Running setup.py install for moznetwork 03:54:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:54:08 INFO - Running setup.py install for mozprocess 03:54:08 INFO - Running setup.py install for mozprofile 03:54:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:54:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:54:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:54:08 INFO - Running setup.py install for mozrunner 03:54:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:54:08 INFO - Running setup.py install for mozscreenshot 03:54:08 INFO - Running setup.py install for moztest 03:54:08 INFO - Running setup.py install for mozversion 03:54:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:54:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:54:08 INFO - Cleaning up... 03:54:08 INFO - Return code: 0 03:54:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:08 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/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 0x17741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1940a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae3a30>, '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 0x1ae47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae4ca0>, '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': '41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349', '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 03:54:08 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:54:08 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:54:08 INFO - Using env: {'DISPLAY': ':0', 03:54:08 INFO - 'HOME': '/home/cltbld', 03:54:08 INFO - 'LANG': 'en_US.UTF-8', 03:54:08 INFO - 'LANGUAGE': 'en_US:en', 03:54:08 INFO - 'LOGNAME': 'cltbld', 03:54:08 INFO - 'MAIL': '/var/mail/cltbld', 03:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:08 INFO - 'MOZ_NO_REMOTE': '1', 03:54:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:08 INFO - 'NO_EM_RESTART': '1', 03:54:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:08 INFO - 'PWD': '/builds/slave/test', 03:54:08 INFO - 'SHELL': '/bin/bash', 03:54:08 INFO - 'SHLVL': '1', 03:54:08 INFO - 'TERM': 'linux', 03:54:08 INFO - 'TMOUT': '86400', 03:54:08 INFO - 'USER': 'cltbld', 03:54:08 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349', 03:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:08 INFO - '_': '/tools/buildbot/bin/python'} 03:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:54:08 INFO - Running setup.py (path:/tmp/pip-kNQBua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:54:09 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)) 03:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:54:09 INFO - Running setup.py (path:/tmp/pip-iC8gwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:54:09 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)) 03:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:54:09 INFO - Running setup.py (path:/tmp/pip-4O8Ity-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:54:09 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)) 03:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:54:09 INFO - Running setup.py (path:/tmp/pip-jKNm2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:54:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 03:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:54:09 INFO - Running setup.py (path:/tmp/pip-y3NND1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:54:09 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)) 03:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:54:09 INFO - Running setup.py (path:/tmp/pip-RT7SKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:54:09 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)) 03:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:54:09 INFO - Running setup.py (path:/tmp/pip-VhFFVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:54:09 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)) 03:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:54:09 INFO - Running setup.py (path:/tmp/pip-CqB7vB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:54:09 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)) 03:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:54:09 INFO - Running setup.py (path:/tmp/pip-tzxZa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:54:09 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)) 03:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:54:09 INFO - Running setup.py (path:/tmp/pip-bGA_yS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:54:09 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)) 03:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:54:09 INFO - Running setup.py (path:/tmp/pip-XbUTsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:54:09 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)) 03:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:54:09 INFO - Running setup.py (path:/tmp/pip-5NLXck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:54:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:54:09 INFO - Running setup.py (path:/tmp/pip-Z1_B_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:54:09 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)) 03:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:54:09 INFO - Running setup.py (path:/tmp/pip-tgGHhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:54:09 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)) 03:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:54:09 INFO - Running setup.py (path:/tmp/pip-88Qyxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:54:10 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)) 03:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:54:10 INFO - Running setup.py (path:/tmp/pip-BEn5LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:54:10 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)) 03:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:54:10 INFO - Running setup.py (path:/tmp/pip-VqXfz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:54:10 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)) 03:54:10 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)) 03:54:10 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)) 03:54:10 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)) 03:54:10 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:54:10 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:54:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:54:10 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 03:54:10 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 03:54:10 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 03:54:10 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 03:54:11 INFO - Downloading blessings-1.6.tar.gz 03:54:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:54:11 INFO - Installing collected packages: blessings 03:54:11 INFO - Running setup.py install for blessings 03:54:11 INFO - Successfully installed blessings 03:54:11 INFO - Cleaning up... 03:54:11 INFO - Return code: 0 03:54:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:54:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:54:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:54:11 INFO - Reading from file tmpfile_stdout 03:54:11 INFO - Current package versions: 03:54:11 INFO - argparse == 1.2.1 03:54:11 INFO - blessings == 1.6 03:54:11 INFO - blobuploader == 1.2.4 03:54:11 INFO - docopt == 0.6.1 03:54:11 INFO - functools32 == 3.2.3-2 03:54:11 INFO - jsonschema == 2.5.1 03:54:11 INFO - manifestparser == 1.1 03:54:11 INFO - mozInstall == 1.12 03:54:11 INFO - mozcrash == 1.0 03:54:11 INFO - mozdebug == 0.1 03:54:11 INFO - mozdevice == 0.50 03:54:11 INFO - mozfile == 1.2 03:54:11 INFO - mozhttpd == 0.7 03:54:11 INFO - mozinfo == 0.9 03:54:11 INFO - mozleak == 0.1 03:54:11 INFO - mozlog == 3.4 03:54:11 INFO - moznetwork == 0.27 03:54:11 INFO - mozprocess == 0.25 03:54:11 INFO - mozprofile == 0.28 03:54:11 INFO - mozrunner == 6.13 03:54:11 INFO - mozscreenshot == 0.1 03:54:11 INFO - mozsystemmonitor == 0.3 03:54:11 INFO - moztest == 0.8 03:54:11 INFO - mozversion == 1.4 03:54:11 INFO - psutil == 3.1.1 03:54:11 INFO - requests == 1.2.3 03:54:11 INFO - wsgiref == 0.1.2 03:54:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:54:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:11 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/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 0x17741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1940a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae3a30>, '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 0x1ae47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae4ca0>, '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': '41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349', '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 03:54:11 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:54:11 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:54:11 INFO - Using env: {'DISPLAY': ':0', 03:54:11 INFO - 'HOME': '/home/cltbld', 03:54:11 INFO - 'LANG': 'en_US.UTF-8', 03:54:11 INFO - 'LANGUAGE': 'en_US:en', 03:54:11 INFO - 'LOGNAME': 'cltbld', 03:54:11 INFO - 'MAIL': '/var/mail/cltbld', 03:54:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:11 INFO - 'MOZ_NO_REMOTE': '1', 03:54:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:11 INFO - 'NO_EM_RESTART': '1', 03:54:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:11 INFO - 'PWD': '/builds/slave/test', 03:54:11 INFO - 'SHELL': '/bin/bash', 03:54:11 INFO - 'SHLVL': '1', 03:54:11 INFO - 'TERM': 'linux', 03:54:11 INFO - 'TMOUT': '86400', 03:54:11 INFO - 'USER': 'cltbld', 03:54:11 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349', 03:54:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:11 INFO - '_': '/tools/buildbot/bin/python'} 03:54:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:11 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)) 03:54:11 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)) 03:54:11 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)) 03:54:11 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)) 03:54:11 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)) 03:54:11 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)) 03:54:11 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)) 03:54:11 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)) 03:54:11 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)) 03:54:11 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)) 03:54:11 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)) 03:54:11 INFO - Cleaning up... 03:54:11 INFO - Return code: 0 03:54:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:54:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x17741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1940a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae3a30>, '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 0x1ae47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae4ca0>, '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': '41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349', '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 03:54:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:54:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:54:11 INFO - Using env: {'DISPLAY': ':0', 03:54:11 INFO - 'HOME': '/home/cltbld', 03:54:11 INFO - 'LANG': 'en_US.UTF-8', 03:54:11 INFO - 'LANGUAGE': 'en_US:en', 03:54:11 INFO - 'LOGNAME': 'cltbld', 03:54:11 INFO - 'MAIL': '/var/mail/cltbld', 03:54:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:11 INFO - 'MOZ_NO_REMOTE': '1', 03:54:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:11 INFO - 'NO_EM_RESTART': '1', 03:54:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:11 INFO - 'PWD': '/builds/slave/test', 03:54:11 INFO - 'SHELL': '/bin/bash', 03:54:11 INFO - 'SHLVL': '1', 03:54:11 INFO - 'TERM': 'linux', 03:54:11 INFO - 'TMOUT': '86400', 03:54:11 INFO - 'USER': 'cltbld', 03:54:11 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349', 03:54:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:11 INFO - '_': '/tools/buildbot/bin/python'} 03:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:54:12 INFO - Cleaning up... 03:54:12 INFO - Return code: 0 03:54:12 INFO - Running post-action listener: _resource_record_post_action 03:54:12 INFO - Running post-action listener: _start_resource_monitoring 03:54:12 INFO - Starting resource monitoring. 03:54:12 INFO - [mozharness: 2017-05-14 10:54:12.231111Z] Finished create-virtualenv step (success) 03:54:12 INFO - [mozharness: 2017-05-14 10:54:12.231581Z] Running install step. 03:54:12 INFO - Running pre-action listener: _resource_record_pre_action 03:54:12 INFO - Running main action method: install 03:54:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:54:12 INFO - Reading from file tmpfile_stdout 03:54:12 INFO - Detecting whether we're running mozinstall >=1.0... 03:54:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:54:12 INFO - Reading from file tmpfile_stdout 03:54:12 INFO - Output received: 03:54:12 INFO - Usage: mozinstall [options] installer 03:54:12 INFO - Options: 03:54:12 INFO - -h, --help show this help message and exit 03:54:12 INFO - -d DEST, --destination=DEST 03:54:12 INFO - Directory to install application into. [default: 03:54:12 INFO - "/builds/slave/test"] 03:54:12 INFO - --app=APP Application being installed. [default: firefox] 03:54:12 INFO - mkdir: /builds/slave/test/build/application 03:54:12 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'] 03:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:54:29 INFO - Reading from file tmpfile_stdout 03:54:29 INFO - Output received: 03:54:29 INFO - /builds/slave/test/build/application/firefox/firefox 03:54:29 INFO - Running post-action listener: _resource_record_post_action 03:54:29 INFO - [mozharness: 2017-05-14 10:54:29.652327Z] Finished install step (success) 03:54:29 INFO - [mozharness: 2017-05-14 10:54:29.652573Z] Running run-tests step. 03:54:29 INFO - Running pre-action listener: _resource_record_pre_action 03:54:29 INFO - Running main action method: run_tests 03:54:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:54:29 INFO - Python 2.7.3 03:54:29 INFO - Return code: 0 03:54:29 INFO - grabbing minidump binary from tooltool 03:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:54:29 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 0x1ae3a30>, '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 0x1ae47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae4ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:54:29 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 03:54:29 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 03:54:29 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 03:54:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:54:29 INFO - Return code: 0 03:54:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:54:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:54:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:54:29 INFO - ENV: RUST_BACKTRACE is now 1 03:54:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:54:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:54:29 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/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 03:54:29 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/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 03:54:29 INFO - Using env: {'DISPLAY': ':0', 03:54:29 INFO - 'HOME': '/home/cltbld', 03:54:29 INFO - 'LANG': 'en_US.UTF-8', 03:54:29 INFO - 'LANGUAGE': 'en_US:en', 03:54:29 INFO - 'LOGNAME': 'cltbld', 03:54:29 INFO - 'MAIL': '/var/mail/cltbld', 03:54:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:54:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:29 INFO - 'MOZ_NO_REMOTE': '1', 03:54:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:54:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:29 INFO - 'NO_EM_RESTART': '1', 03:54:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:29 INFO - 'PWD': '/builds/slave/test', 03:54:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:54:29 INFO - 'RUST_BACKTRACE': '1', 03:54:29 INFO - 'SHELL': '/bin/bash', 03:54:29 INFO - 'SHLVL': '1', 03:54:29 INFO - 'TERM': 'linux', 03:54:29 INFO - 'TMOUT': '86400', 03:54:29 INFO - 'USER': 'cltbld', 03:54:29 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349', 03:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:29 INFO - '_': '/tools/buildbot/bin/python'} 03:54:29 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/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 03:54:29 INFO - mozversion application_buildid: 20170514100406 03:54:29 INFO - mozversion application_changeset: 73b3fc64525b6816842c737e104ef2ac5482d217 03:54:29 INFO - mozversion application_display_name: Nightly 03:54:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:54:29 INFO - mozversion application_name: Firefox 03:54:29 INFO - mozversion application_remotingname: firefox 03:54:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:54:29 INFO - mozversion application_vendor: Mozilla 03:54:29 INFO - mozversion application_version: 55.0a1 03:54:29 INFO - mozversion platform_buildid: 20170514100406 03:54:29 INFO - mozversion platform_changeset: 73b3fc64525b6816842c737e104ef2ac5482d217 03:54:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:54:29 INFO - mozversion platform_version: 55.0a1 03:54:29 INFO - using testdate: 1494759269 03:54:29 INFO - actual date: 1494759269 03:54:29 INFO - starting webserver on 'localhost:57001' 03:54:29 INFO - SUITE-START | Running 2 tests 03:54:29 INFO - TEST-START | dromaeo_css 03:54:29 INFO - operating with platform_type : linux_ 03:54:29 INFO - Initialising browser for dromaeo_css test... 03:54:29 INFO - TEST-INFO | started process 8752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4jtGSI/profile http://localhost:57001/getInfo.html) 03:54:33 INFO - PID 8752 | __metrics Screen width/height:1600/1200 03:54:33 INFO - PID 8752 | colorDepth:24 03:54:33 INFO - PID 8752 | Browser inner width/height: 1024/695 03:54:33 INFO - PID 8752 | __metrics 03:54:34 INFO - PID 8752 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:54:34 INFO - PID 8752 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:54:35 INFO - TEST-INFO | 8752: exit 0 03:54:35 INFO - Browser initialized. 03:54:35 INFO - Running cycle 1/1 for dromaeo_css test... 03:54:35 INFO - TEST-INFO | started process 8852 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4jtGSI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:54:47 INFO - PID 8852 | RSS: Main: 144494592 03:54:47 INFO - PID 8852 | 03:57:49 INFO - PID 8852 | Cycle 1(1): loaded http://localhost:57001/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57001/tests/dromaeo/cssquery-ext.html) 03:57:51 INFO - PID 8852 | RSS: Main: 341254144 03:57:51 INFO - PID 8852 | 04:00:53 INFO - PID 8852 | Cycle 1(1): loaded http://localhost:57001/tests/dromaeo/cssquery-ext.html (next: http://localhost:57001/tests/dromaeo/cssquery-jquery.html) 04:00:54 INFO - PID 8852 | RSS: Main: 227663872 04:00:54 INFO - PID 8852 | 04:03:56 INFO - PID 8852 | Cycle 1(1): loaded http://localhost:57001/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57001/tests/dromaeo/cssquery-mootools.html) 04:03:56 INFO - PID 8852 | RSS: Main: 220442624 04:03:56 INFO - PID 8852 | 04:06:58 INFO - PID 8852 | Cycle 1(1): loaded http://localhost:57001/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57001/tests/dromaeo/cssquery-prototype.html) 04:06:58 INFO - PID 8852 | RSS: Main: 176177152 04:06:58 INFO - PID 8852 | 04:10:01 INFO - PID 8852 | Cycle 1(1): loaded http://localhost:57001/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57001/tests/dromaeo/cssquery-yui.html) 04:10:02 INFO - PID 8852 | RSS: Main: 178139136 04:10:02 INFO - PID 8852 | 04:13:03 INFO - PID 8852 | Cycle 1(1): loaded http://localhost:57001/tests/dromaeo/cssquery-yui.html (next: http://localhost:57001/tests/dromaeo/cssquery-dojo.html) 04:13:04 INFO - PID 8852 | RSS: Main: 266194944 04:13:04 INFO - PID 8852 | 04:13:04 INFO - PID 8852 | __start_tp_report 04:13:04 INFO - PID 8852 | _x_x_mozilla_page_load 04:13:04 INFO - PID 8852 | _x_x_mozilla_page_load_details 04:13:04 INFO - PID 8852 | |i|pagename|runs| 04:13:04 INFO - PID 8852 | |0;dojo.html;3206.839658017099;3330.6336303006665;3360.0423879194427;3372.7976321420733;3384.560007199064;5723.942760572393;5827.329857066438;5889.705514724268;5898.410158984105;5905.645661260327;5777.855553611152;5806.883862322761;5808.622439541437;5808.941910580893;5818;5122.974385128069;5129.6409251352425;5143.254228136918;5152.227165925123;5175.327207463043;5196.324477817879;5225.529702326789;5248.422673505911;5264.105102132647;5309.203619457093;5249.160134378481;5272.181740248614;5283.207518872162;5285.418603953562;5291.391489978644;790.7290198210175;5100.974410526425;5144.459831717653;5151.098557752378;5249.028929648028;5176.818811341585;5181.974090129563;5183.5853131749745;5185.118529849935;5187.662801917863;5710.543156547507;5796.797112101099;5841.269841269841;5843.18195452637;5878.941210587882;6143.508519318444;6177.2587289525545;6264.342244064399;6322;6360.872782544369;6354.173957385557;6365.458935990447;6377.553571250014;6389.4568961638315;6390.904136437957;5914.9112763308585;5917.171595976567;5923.348431672513;5925.822225333247;5977.193078934375;6343.777967771106;6402.711877965503;6420.775272865428;6422.967885160638;6481.935180648227;6221.06683997395;6263.091851681481;6264.749410023548;6266.373362663697;6267.373262673787;6268;6312.179416675895;6351.110844481776;6376.266729326187;6377.7448902044325;6122.265955856691;6193.473554747897;6215.9378406215355;6318.526110541728;6336.081268216083;6321.65230912295;6330.525210609223;6333.334999825044;6336.081268216083;6337.9366206337345;4764.14245435818;4777.163996300634;4782.115308667908;4786.44955830077;4806;4212.936805947913;4235.745855248695;4268.146370725867;4270.807813648394;4291.0130669945465;5895.882082358329;6001.669908155093;6003.609765365237;6006.159137720722;6011.368806275365;6347.55567110307;6347.650879201688;6365.904511432333;6375.171227740364;6388.39310265524;5974.103884417285;5985.610935289193;5986.580939334205;5987.2815262168815;6028.57799953999;5356.625036247503;5368.3826359968325;5374.328208973879;5381.9461805382225;5381.9461805382225;6308.621482711052;6409;6484.870302594016;6534.771283005072;6620.304867988792;6392.4246817786625;6410.166678331787;6412.422881940461;6414.358564143548;6427.55007149495;6553.901691474536;6627.801165965029;6629.337066293525;6634.701438435185;6642.734290628514;6106.460667179974;6160;6191.84520386994;6246.625202487865;6277.5605707600025;6344.555881088279;6379.681015949277;6400.167978162809;6408.775692850914;6409.35906409374;6126.693665316806;6179.84550386244;6191.1641928339095;6193.566450348432;6193.81418557444;6083.908741368795;6099.176611157614;6177.660228687465;6194.0708893666315;6198.6280823150755;6026.216591843032;6101.633901965896;6110.297315808739;6119.4798442132915;6143.232095988002;6162.825501346973;6215.254169499689;6216.53375996793;6222.875542489215;6233.625982441068;5883.294004719461;5905.940940590711;5988.131720900358;5992.580519363602;5996.490298324691 04:13:04 INFO - PID 8852 | |1;ext.html;792.8969233999582;820.7332616899507;1132.7621199548094;1158.536585365854;1160.025578514048;35373.82313088434;35997;37939;38030.42954355687;38152.23695526088;39886.40170397439;40360.39459408104;40439.59560404395;40452.19095618086;40454.19091618166;7094.184168820574;7175.856482870339;7186.425085993134;7190.209077001526;7190.388816950565;5632.464915833009;5772.336181339137;7275.381592564639;7463.290987356192;7471.215522370155;7551.584662843569;7578.734744283951;7586.924130758704;7587.4688771785995;7597.620118994056;7472.140703819076;7536.321731044178;7537.623118844036;7540.283673051024;7546.584937828417;7401.740939067161;7438.628068596603;7441.66512506933;7446.032015837961;7454.2173071827765;35122.824385878164;35208.295834083176;35509.644903551154;35519.467207991904;35531;3467.219875528011;3524.2422879080864;3524.7004004659634;3529.3823580873245;3529.541159649255;28664.713352866413;28768.424631507463;28800.135995920155;28805.423891522263;28872;3753.9061523462133;3765.7928813915223;3784.3188226119287;3795.4876091727538;3806.2197249563774;189457;189589;189636;189639;190120;38836.41745373821;48376;48389;48424;48495.5150448498;41375.379369309485;49015.509844901804;49397.789143706264;49596;49672.751636241584;13328.200307981551;13400.93299533496;13427.462901483832;13432.656734326685;13434.664133396547;10469.162467002621;10514.264001519974;10523.315984460985;10532.420716860493;10538.73653158662;13507;13542.729145417234;13595.252261125535;13647.658808529668;13795.862041379658;5402.702851343135;5429.972850135803;5436.945630543723;5466.671999680032;5475.342958844964;1083.34999000599;1112.3548341961643;1114.3759494683004;1126.4142645824124;1130.3218069158438;25984.220473385827;26082;26157.215283541525;26303.868480657857;26399.604005939927;1192.1833544022372;1194.8446701928694;1201.7175963648535;1216.2641601830765;1232.2975903734784;13454.529091481947;13602.93198534001;13719.176849389069;13868.445262189602;13890;222874;223210;223308;223341;223780;47715;47733.522664773605;47814.28278575824;47823.76088119537;47874.76062619734;1465.919374434395;1514.9621259468602;1518.7190369781626;1531.2956040221623;1541.2216830500524;24335.14826981047;25523.48953020892;25784.742152578234;26007.609885852107;26057.218283451526;39008.804955975036;39021.41467877927;39037.414438784006;39070.80464597659;39078.6092139075;142600;142683;142875;143085;143658;29330.413391732473;29811.18681857017;32456;33157.17107072342;34849.65150348566;39138.2172356557;39988.40017399683;40641.59358406496;40719.389209161294;41151.38272925968;30146.24634384158;30618.387632247675;30871.382572348877;31073.8446307767;32305.51541726923;30557.694423055484;30680.539791902695;30914.381712365175;32307.838460807547;32469.675303246666;35978.88358979032;36238.63761362458;36259.45610815893;36543.81728091343;36657.083572909825;31433.8428307857;31637.683623163473;32079.839600801846;33905.66094339124;34304.313913722086;24240.272791816275;26753.464930701666;27066.458670826865;27082;27206.134317314292 04:13:04 INFO - PID 8852 | |2;jquery.html;433.42138245442334;443.7182389182869;449.09731439806;452.7736131934035;459.34313931078555;18757.15592798322;19809.40571782847;20430.69353959688;20564.794352056473;20578.89710551449;21536.246231381905;22039.779602203973;22282.220122295723;22299.888500557474;22545;5606.747696353664;5712.800051998181;5716.799912003081;5721.799737009205;5725.6278341907855;5562.582806289524;5608.9439105609035;5625.240592519998;5653.886922261552;5658.462446067638;5606.607537472379;5622.184783206432;5635.267415236013;5638.718064096779;5639.097744360903;5462.071447853855;5586.944130558703;5620.325560932673;5634.211210430543;5634.3520495143175;4984.775685094143;5123.2827404163445;5130.256112863651;5131.4098878629065;5138.023775482647;24703.382415439577;24941.87529062361;25451.745482545124;26210.60684089721;26647.600285995726;2142.1966762464076;2150.35489353195;2152.0530966374745;2169.2082389927564;2171.1206961180746;16309.51071467858;16880.155992200464;16945.91527042369;17139.657206855794;17208.483745487654;2153.3001774423374;2207.9116835326568;2226.654868495386;2226.654868495386;2236.519148383089;106700;122149.99999999911;122418.2065434763;126695;126770.36614816959;12244.448999795031;12348.259104453762;12415.379231038412;12526.37368131608;12648.810267845989;17667.38164164248;17732.645347092985;17749.378771743184;17767;17775.288988440578;8756.605952732143;8987.865182022275;9082;9160.633574657073;9172.541372931326;8265.793355166168;8363.581820909052;8445;8552.358573107042;8603.870941935877;7716.498427602188;7896;8022.957015587936;8028;8079.959600201962;2202.4714068623416;2222.2666520048347;2223.677566752812;2259.3109101723803;2359.091749676387;1036.1348274191134;1051.5057922776282;1074.333912973961;1079.0019232210175;1083.2200815412891;23095.769042309697;25433.10984115547;25549.3612659685;25880.22359329223;25902.35244118912;1078.245228340165;1078.568572570978;1080.3679847289266;1082.4533610526635;1085.5386460754148;10591.258611897094;11324.207305488537;11391.145664075228;11411.48648310828;11444.656660300205;478313;484875;490777;492127;492161;98595;98993.50503247438;104559;104962.4751876251;105204.47397762962;1224.3939250071094;1260.9117361784588;1277.0422183362477;1280.3342262023696;1281.5194302136513;18001.819981800014;18232.81767182311;18579.90710046441;18685.15916783775;18853.717194241824;47383.76308118575;47621;48084.39367047416;48381.27428088511;48701.512984871115;60431;60567.39432605617;60647;62403.375966241576;62606;9754.707358779247;9869.654562090293;9950.950245248727;10009.799804003733;10215.7446063849;15641.296141673425;15709.371625134867;15784.13187274711;16258.349666013228;16630.66738665244;13154.750298721607;13225.537106201236;13432.19406835593;13476.460941562227;13833.377498012413;12722.300273485047;12852.357382131044;12893.93553032229;13021.609351719464;13616.523421680193;13890.236037017658;13949.860501394856;14136.363863625957;14248.643783905485;14501.854981450051;9892.752681183028;10009.299349045497;10026.448545330077;10079.596816127272;10222.335548189343;13658.931705341409;13719.45122195101;13786.310684465938;13922.791158132839;13971.231582263074 04:13:04 INFO - PID 8852 | |3;mootools.html;1120.495776900395;1390.798334241535;1420.6448387903024;1429.4139402844835;1441.488271663559;9705.17506011989;11075.889241107587;11681.941590292046;11747.412629368519;11760.059195264379;11404.258723182988;11514.424278786048;11528.193026488148;11541.596044138458;11543.307401555912;2092.6756352765346;2434.42790944128;2474.134053081425;2474.7772700456953;2478.764517370847;2144.603248399051;2168.772278910715;2170.316350349635;2385.7733515316104;2478.938026549333;2072.616565935299;2074.3569493457003;2084.0413409831494;2085.614161380142;2092.7070210170587;2321.5124823787023;2362.2204672458047;2380.8690522021284;2383.0825132324007;2383.988080059589;2313.2597568777996;2359.1035406545575;2359.1507057459303;2359.539889721505;2360.8819559022154;11052.171087168414;11150.553977840877;11179.888201117967;11180.720481987933;11189.888101118966;6536;6769.458443324572;6776.8305792355095;6778.762743303961;6780.084688567079;3978.124812541236;4184.225918205142;4234.1108367242605;4241.597048280409;4253.404523366731;1375.7317323121995;1430.7353139669194;1476.6898951220257;1488.9851101489064;1495.6634757179656;17244.655106897917;17283.135843207914;17306.740398894028;17314.04772737499;17314.56713582158;5521.503064724194;5649.406812284733;5946.70266486674;5977.432143946318;6002.54980876436;14487.78268325976;14498.782518262235;14500.419983200765;14511.952489977011;14512.492062777963;6452.9997850333275;6796.76211332601;6814.625195614289;6833.248342682301;6843.657817109125;6017.428344307284;6047.334793172748;6101.450869421685;6107.328193898667;6117.480014198843;4552.453705555355;4576.656750743641;4639.257718764981;4731.834385796549;4768.499307572724;1417.0788987158223;1430.4993252361799;1457.7376072307086;1460.4304321314696;1481.2075539586485;828.2545708862073;828.45736042892;851.6721062391024;867.5748883047262;892.9910700893038;6550;6958.443324534025;6971.65141742921;6976.5465244758925;7042.471814613925;608.1759216261989;617.1206031405229;618.5639124417276;620.8696173803462;627.6610630259609;3694.371956767356;3726.31063253299;3755.4179102239195;3771.396576547739;3887.747296425723;14659.34032968519;15489;15490.07059576429;15522.146281954376;15528.84471155274;14707.632309192355;15063.849361506245;15219.239038048054;15227.238638068275;15246.3901443941;8979.506127162938;9229.463171036205;9236.907630923604;9301.209397201179;9305.627774888928;7007.474439416962;7034.261402552863;7054.294570542905;7085;7160.10498687664;13217.471301147847;13292.136011159631;13602.455901764215;13626.727465450436;13626.727465450835;13672.316384180553;13803.79294310566;13872.098313609584;13988.510402135877;14053.437862485795;9251.444913305224;9438.57526411327;9518;9585.472798996123;9607.423554586747;11270.887291126985;11346.205765596329;11349.773004539698;11382.658520244406;11388.259763115371;9348;9372.578233979624;9490.952545237229;9534.09426104519;9713.12581867607;9257.907420925974;9304.255659547085;9415.811683766424;9480.762980925532;9629.662961796303;7871.84256314882;7999.240072193133;8001.679932802856;8004.279614834692;8010.479318844256;5932.970335148297;5941.287045554388;5963.970180149245;5998.820035398945;6124.8775024500155;6030.246219222598;6070.848228794315;6116.633002019893;6148.78479253224;6273 04:13:04 INFO - PID 8852 | |4;prototype.html;418.8178142508009;421.6268602286975;426.4583978347501;433.42138245442334;435.5231022030877;5700.572457065727;5826.359100498947;5852.122181672751;5855.355910849803;5904.143899134629;5648.124540696188;5683.5169010634145;5726.1697053927155;5744.931824543161;5759.091658712345;4291.098869237456;4408.779561021952;4422.159789639974;4443.577860103285;4444;4418.094290670405;4430.401895744066;4433.401490798749;4438.334249862514;4446.555344465543;4397.472303323606;4400.7579583122915;4403.493598236212;4405.118976204756;4414.646828253732;4324.913501729963;4344.066025804467;4380.34294855771;4393.121375724868;4405.933910991338;3856.6914646828186;3858.2862170498547;3875.1280961783373;3878;3883.4951456310782;5566.137248726453;5623.465770751772;5627.943720562783;5655.1517272409055;5667.659940403589;5060.165072762989;5129.6409251352425;5149.76826042829;5164.122099243138;5165.173572228426;6075.908861367083;6124.663143527104;6127.908081378783;6151.507879369639;6158.8152355428965;4212.326027835532;4310.4396428464415;4321.956780432219;4330.718503297276;4336.783160841946;6052.182955301022;6220.315765265772;6237.875242495124;6353.745850165988;6393.200849893763;4331.155424692155;4411.360352748833;4412.0955204183065;4412.3160910059;4437.622802061796;4466.151431228056;4469.910601787946;4471.441069866267;4478.753668548196;4488.820447182142;4898.069366820293;5000.699958002531;5028.949710502921;5112.974435127875;5131.230315452637;6067.271927368655;6104.664243466563;6119.408953672078;6121.296050954108;6123.081537769282;1500.677354368816;1534.0642208252957;1543.202169472552;1548.2258870564717;1549.605355180324;1002.904724051214;1021.5862575656871;1032.2670903658336;1039.7036844499432;1040.0223789637867;5839.452545075558;5851.034579294369;5861.589688721749;5912.881742365129;5928.258967629046;6278.717457714414;6290.728821013047;6295.370462953668;6311.463525600284;6339;5739.311282646109;5784.248047753765;5864.824055278348;5869.794557190563;5893.116032595145;3309.3546758381885;3326.600807903067;3342.147752323142;3350.698437140669;3352.832358382071;6231.753649270074;6436.420722135031;6464.095026696266;6485.643289619022;6534.509911756637;6469.838254043687;6487.545871789024;6487.799757044962;6500.447461965691;6527.738890444424;6360.855046091748;6592.30780768022;6597.406233438917;6612.471002319803;6624.238212605612;6252.718627661857;6305.873882522415;6353.8729225416155;6371.585846919936;6380.170577824853;6315.242170939517;6316.494680425463;6336.619802811846;6339.619622822645;6349.301576826453;6413.262474815269;6546.738130474918;6588.637624930675;6594.967025164843;6622.867542649216;4417.349590245827;4424.933625995677;4435.534268901719;4435.578620031092;4443.666724995703;6158.815235542941;6283.560150789401;6339.1125242467015;6358.364163583605;6372.267189273293;6181.474574661024;6184.505239580732;6194.194754681863;6201.224846894138;6201.395413926071;6074.51403887679;6134.723937422737;6155.538334624832;6180.783672571439;6180.938190618216;6115.877682446415;6127.234095738033;6148.9692551536955;6152;6165.352637972948;6131.509479241561;6138.140660307471;6140.478059365004;6163.506919446344;6177.104319873503;5834.679092649945;5958.225430693982;6021.126936594082;6026;6044.969775151096 04:13:04 INFO - PID 8852 | |5;yui.html;853.1766844994579;861.2593169873908;866.8353012927545;868.1665601023013;882.6425297754407;15581.688366232669;15955.840441595581;15965.521034368972;17218.96686198829;17340.219690113943;14742.926285368585;14743.705125897475;14745;14756.926215368909;14830.184339861304;970.3644113105927;986.7977064701719;989.3272574649236;992.3500107429645;992.4789485520088;1003.5935446144323;1003.7189586915675;1003.8544411060392;1006.5671761142705;1006.6023920551378;1012.3217444312291;1053.3206082077095;1057.4501259345136;1058.878229003663;1065.0521036277719;1057.1542765787378;1057.8466122412285;1059.179136169471;1059.5496913811598;1060.5280650110703;777.5140537164273;777.6500574741389;777.8910952466659;778.1984555907425;778.8714862047811;15495.147766872817;15537.689246215126;15573.610659733484;17401.738973915402;18005.909970450062;17817.554561135945;18189.7271540927;18238.726419103725;18681.813181868143;18889.905550472296;14932.32804523799;15142.318595663111;15211.61970950724;15342;15362.923185384001;3460.377132116218;3461.5153878456786;3465.151037995682;3472.1146107742366;3473.89578312651;95268;95734.52132739431;96164.42191358945;96402.51798741032;96699;14598.489052883311;14763.261836908327;14797.630059248604;14808;14966.850331496764;27252.182434526996;27497;27821;28015.579766303523;28386.290342741595;8085.636146373427;8102.230288122619;8103.10865804761;8137.430379873471;8172.550509721904;3931.803409829497;3978.8806335809973;4005.959940400617;4020.7587544747407;4026.516817981861;4526.841560545365;4623.69945953512;4634.582887540138;4635.281531362644;4682.321063445781;831.8669012957897;860.2644738748405;865.4374656473217;867.8804342398236;869.9565021749014;698.9475789315821;713.53263612334;718.3678363040491;724.6050902258282;727.7707522130512;11177.608783692533;11574;12036.939815300868;12331.828476294737;12611.810822837664;697.1877762406841;705.8694141583824;713.2688993781416;723.4863247094622;724.4349407462188;5245.580353571705;5267.26258323835;5355.7054362009685;5439.918401223985;5508.724563771795;81090.59454702807;81287.5935620318;82145;83596;87343.56328218318;72695.2730472699;72946;73169;76216.61891690617;76769.23230767733;37588.81205593955;60850;61405.38594613997;61944.69027654833;64060.35939640637;11733.882661173278;12621.81067283973;12653.430595623035;12755.170913890568;12756.362181890683;32320;32547.837260813543;32556.837215813768;33034.38415469424;33925.66074339225;39663.603363965995;39830.60169398269;40013.79993100016;40319.193616126926;41060.384094239205;17575.121243938007;17662.205200766253;17749.733753993958;17868.55328616795;18257.634847302714;17757.64484710273;17914;18329.725054124465;18373.356932507297;18733.718994214825;16938.49184524466;17172.22724977354;17380.739288910423;17441.651166976844;17783.28866845312;15810.92094539566;15864.841351586336;15884.68230635404;16116.597085072966;16409.26158322902;16583.336666533203;16677.91661041687;16897.239624217185;16914.492565223063;16949.49151525456;11704.94147529257;11755.764884702428;11762.647120586396;11915.880841191478;12063.698407539881;13494.32528373597;13793.310334483034;13910.652233694238;13960.58118256454;13986.090904091201 04:13:04 INFO - PID 8852 | __end_tp_report 04:13:04 INFO - PID 8852 | __start_cc_report 04:13:04 INFO - PID 8852 | _x_x_mozilla_cycle_collect,2160 04:13:04 INFO - PID 8852 | __end_cc_report 04:13:04 INFO - PID 8852 | __startTimestamp1494760384192__endTimestamp 04:13:04 INFO - PID 8852 | 04:13:04 INFO - PID 8852 | ------- Summary: start ------- 04:13:04 INFO - PID 8852 | Number of tests: 6 04:13:04 INFO - PID 8852 | 04:13:04 INFO - PID 8852 | [#0] dojo.html Cycles:165 Average:5803.21 Median:6101.63 stddev:806.46 (13.2%) stddev-sans-first:782.79 04:13:04 INFO - PID 8852 | Values: 3206.8 3330.6 3360.0 3372.8 3384.6 5723.9 5827.3 5889.7 5898.4 5905.6 5777.9 5806.9 5808.6 5808.9 5818.0 5123.0 5129.6 5143.3 5152.2 5175.3 5196.3 5225.5 5248.4 5264.1 5309.2 5249.2 5272.2 5283.2 5285.4 5291.4 790.7 5101.0 5144.5 5151.1 5249.0 5176.8 5182.0 5183.6 5185.1 5187.7 5710.5 5796.8 5841.3 5843.2 5878.9 6143.5 6177.3 6264.3 6322.0 6360.9 6354.2 6365.5 6377.6 6389.5 6390.9 5914.9 5917.2 5923.3 5925.8 5977.2 6343.8 6402.7 6420.8 6423.0 6481.9 6221.1 6263.1 6264.7 6266.4 6267.4 6268.0 6312.2 6351.1 6376.3 6377.7 6122.3 6193.5 6215.9 6318.5 6336.1 6321.7 6330.5 6333.3 6336.1 6337.9 4764.1 4777.2 4782.1 4786.4 4806.0 4212.9 4235.7 4268.1 4270.8 4291.0 5895.9 6001.7 6003.6 6006.2 6011.4 6347.6 6347.7 6365.9 6375.2 6388.4 5974.1 5985.6 5986.6 5987.3 6028.6 5356.6 5368.4 5374.3 5381.9 5381.9 6308.6 6409.0 6484.9 6534.8 6620.3 6392.4 6410.2 6412.4 6414.4 6427.6 6553.9 6627.8 6629.3 6634.7 6642.7 6106.5 6160.0 6191.8 6246.6 6277.6 6344.6 6379.7 6400.2 6408.8 6409.4 6126.7 6179.8 6191.2 6193.6 6193.8 6083.9 6099.2 6177.7 6194.1 6198.6 6026.2 6101.6 6110.3 6119.5 6143.2 6162.8 6215.3 6216.5 6222.9 6233.6 5883.3 5905.9 5988.1 5992.6 5996.5 04:13:04 INFO - PID 8852 | 04:13:04 INFO - PID 8852 | [#1] ext.html Cycles:180 Average:35161.33 Median:34104.99 stddev:48774.70 (143.0%) stddev-sans-first:48843.25 04:13:04 INFO - PID 8852 | Values: 792.9 820.7 1132.8 1158.5 1160.0 35373.8 35997.0 37939.0 38030.4 38152.2 39886.4 40360.4 40439.6 40452.2 40454.2 7094.2 7175.9 7186.4 7190.2 7190.4 5632.5 5772.3 7275.4 7463.3 7471.2 7551.6 7578.7 7586.9 7587.5 7597.6 7472.1 7536.3 7537.6 7540.3 7546.6 7401.7 7438.6 7441.7 7446.0 7454.2 35122.8 35208.3 35509.6 35519.5 35531.0 3467.2 3524.2 3524.7 3529.4 3529.5 28664.7 28768.4 28800.1 28805.4 28872.0 3753.9 3765.8 3784.3 3795.5 3806.2 189457.0 189589.0 189636.0 189639.0 190120.0 38836.4 48376.0 48389.0 48424.0 48495.5 41375.4 49015.5 49397.8 49596.0 49672.8 13328.2 13400.9 13427.5 13432.7 13434.7 10469.2 10514.3 10523.3 10532.4 10538.7 13507.0 13542.7 13595.3 13647.7 13795.9 5402.7 5430.0 5436.9 5466.7 5475.3 1083.3 1112.4 1114.4 1126.4 1130.3 25984.2 26082.0 26157.2 26303.9 26399.6 1192.2 1194.8 1201.7 1216.3 1232.3 13454.5 13602.9 13719.2 13868.4 13890.0 222874.0 223210.0 223308.0 223341.0 223780.0 47715.0 47733.5 47814.3 47823.8 47874.8 1465.9 1515.0 1518.7 1531.3 1541.2 24335.1 25523.5 25784.7 26007.6 26057.2 39008.8 39021.4 39037.4 39070.8 39078.6 142600.0 142683.0 142875.0 143085.0 143658.0 29330.4 29811.2 32456.0 33157.2 34849.7 39138.2 39988.4 40641.6 40719.4 41151.4 30146.2 30618.4 30871.4 31073.8 32305.5 30557.7 30680.5 30914.4 32307.8 32469.7 35978.9 36238.6 36259.5 36543.8 36657.1 31433.8 31637.7 32079.8 33905.7 34304.3 24240.3 26753.5 27066.5 27082.0 27206.1 04:13:04 INFO - PID 8852 | 04:13:04 INFO - PID 8852 | [#2] jquery.html Cycles:180 Average:31780.23 Median:2186.80 stddev:81488.07 (3726.4%) stddev-sans-first:81682.68 04:13:04 INFO - PID 8852 | Values: 433.4 443.7 449.1 452.8 459.3 18757.2 19809.4 20430.7 20564.8 20578.9 21536.2 22039.8 22282.2 22299.9 22545.0 5606.7 5712.8 5716.8 5721.8 5725.6 5562.6 5608.9 5625.2 5653.9 5658.5 5606.6 5622.2 5635.3 5638.7 5639.1 5462.1 5586.9 5620.3 5634.2 5634.4 4984.8 5123.3 5130.3 5131.4 5138.0 24703.4 24941.9 25451.7 26210.6 26647.6 2142.2 2150.4 2152.1 2169.2 2171.1 16309.5 16880.2 16945.9 17139.7 17208.5 2153.3 2207.9 2226.7 2226.7 2236.5 106700.0 122150.0 122418.2 126695.0 126770.4 12244.4 12348.3 12415.4 12526.4 12648.8 17667.4 17732.6 17749.4 17767.0 17775.3 8756.6 8987.9 9082.0 9160.6 9172.5 8265.8 8363.6 8445.0 8552.4 8603.9 7716.5 7896.0 8023.0 8028.0 8080.0 2202.5 2222.3 2223.7 2259.3 2359.1 1036.1 1051.5 1074.3 1079.0 1083.2 23095.8 25433.1 25549.4 25880.2 25902.4 1078.2 1078.6 1080.4 1082.5 1085.5 10591.3 11324.2 11391.1 11411.5 11444.7 478313.0 484875.0 490777.0 492127.0 492161.0 98595.0 98993.5 104559.0 104962.5 105204.5 1224.4 1260.9 1277.0 1280.3 1281.5 18001.8 18232.8 18579.9 18685.2 18853.7 47383.8 47621.0 48084.4 48381.3 48701.5 60431.0 60567.4 60647.0 62403.4 62606.0 9754.7 9869.7 9951.0 10009.8 10215.7 15641.3 15709.4 15784.1 16258.3 16630.7 13154.8 13225.5 13432.2 13476.5 13833.4 12722.3 12852.4 12893.9 13021.6 13616.5 13890.2 13949.9 14136.4 14248.6 14501.9 9892.8 10009.3 10026.4 10079.6 10222.3 13658.9 13719.5 13786.3 13922.8 13971.2 04:13:04 INFO - PID 8852 | 04:13:04 INFO - PID 8852 | [#3] mootools.html Cycles:180 Average:7266.94 Median:3740.86 stddev:4709.19 (125.9%) stddev-sans-first:4699.75 04:13:04 INFO - PID 8852 | Values: 1120.5 1390.8 1420.6 1429.4 1441.5 9705.2 11075.9 11681.9 11747.4 11760.1 11404.3 11514.4 11528.2 11541.6 11543.3 2092.7 2434.4 2474.1 2474.8 2478.8 2144.6 2168.8 2170.3 2385.8 2478.9 2072.6 2074.4 2084.0 2085.6 2092.7 2321.5 2362.2 2380.9 2383.1 2384.0 2313.3 2359.1 2359.2 2359.5 2360.9 11052.2 11150.6 11179.9 11180.7 11189.9 6536.0 6769.5 6776.8 6778.8 6780.1 3978.1 4184.2 4234.1 4241.6 4253.4 1375.7 1430.7 1476.7 1489.0 1495.7 17244.7 17283.1 17306.7 17314.0 17314.6 5521.5 5649.4 5946.7 5977.4 6002.5 14487.8 14498.8 14500.4 14512.0 14512.5 6453.0 6796.8 6814.6 6833.2 6843.7 6017.4 6047.3 6101.5 6107.3 6117.5 4552.5 4576.7 4639.3 4731.8 4768.5 1417.1 1430.5 1457.7 1460.4 1481.2 828.3 828.5 851.7 867.6 893.0 6550.0 6958.4 6971.7 6976.5 7042.5 608.2 617.1 618.6 620.9 627.7 3694.4 3726.3 3755.4 3771.4 3887.7 14659.3 15489.0 15490.1 15522.1 15528.8 14707.6 15063.8 15219.2 15227.2 15246.4 8979.5 9229.5 9236.9 9301.2 9305.6 7007.5 7034.3 7054.3 7085.0 7160.1 13217.5 13292.1 13602.5 13626.7 13626.7 13672.3 13803.8 13872.1 13988.5 14053.4 9251.4 9438.6 9518.0 9585.5 9607.4 11270.9 11346.2 11349.8 11382.7 11388.3 9348.0 9372.6 9491.0 9534.1 9713.1 9257.9 9304.3 9415.8 9480.8 9629.7 7871.8 7999.2 8001.7 8004.3 8010.5 5933.0 5941.3 5964.0 5998.8 6124.9 6030.2 6070.8 6116.6 6148.8 6273.0 04:13:04 INFO - PID 8852 | 04:13:04 INFO - PID 8852 | [#4] prototype.html Cycles:180 Average:5134.99 Median:5845.24 stddev:1536.88 (26.3%) stddev-sans-first:1499.87 04:13:04 INFO - PID 8852 | Values: 418.8 421.6 426.5 433.4 435.5 5700.6 5826.4 5852.1 5855.4 5904.1 5648.1 5683.5 5726.2 5744.9 5759.1 4291.1 4408.8 4422.2 4443.6 4444.0 4418.1 4430.4 4433.4 4438.3 4446.6 4397.5 4400.8 4403.5 4405.1 4414.6 4324.9 4344.1 4380.3 4393.1 4405.9 3856.7 3858.3 3875.1 3878.0 3883.5 5566.1 5623.5 5627.9 5655.2 5667.7 5060.2 5129.6 5149.8 5164.1 5165.2 6075.9 6124.7 6127.9 6151.5 6158.8 4212.3 4310.4 4322.0 4330.7 4336.8 6052.2 6220.3 6237.9 6353.7 6393.2 4331.2 4411.4 4412.1 4412.3 4437.6 4466.2 4469.9 4471.4 4478.8 4488.8 4898.1 5000.7 5028.9 5113.0 5131.2 6067.3 6104.7 6119.4 6121.3 6123.1 1500.7 1534.1 1543.2 1548.2 1549.6 1002.9 1021.6 1032.3 1039.7 1040.0 5839.5 5851.0 5861.6 5912.9 5928.3 6278.7 6290.7 6295.4 6311.5 6339.0 5739.3 5784.2 5864.8 5869.8 5893.1 3309.4 3326.6 3342.1 3350.7 3352.8 6231.8 6436.4 6464.1 6485.6 6534.5 6469.8 6487.5 6487.8 6500.4 6527.7 6360.9 6592.3 6597.4 6612.5 6624.2 6252.7 6305.9 6353.9 6371.6 6380.2 6315.2 6316.5 6336.6 6339.6 6349.3 6413.3 6546.7 6588.6 6595.0 6622.9 4417.3 4424.9 4435.5 4435.6 4443.7 6158.8 6283.6 6339.1 6358.4 6372.3 6181.5 6184.5 6194.2 6201.2 6201.4 6074.5 6134.7 6155.5 6180.8 6180.9 6115.9 6127.2 6149.0 6152.0 6165.4 6131.5 6138.1 6140.5 6163.5 6177.1 5834.7 5958.2 6021.1 6026.0 6045.0 04:13:04 INFO - PID 8852 | 04:13:04 INFO - PID 8852 | [#5] yui.html Cycles:180 Average:18816.04 Median:27374.59 stddev:23382.93 (85.4%) stddev-sans-first:23409.62 04:13:04 INFO - PID 8852 | Values: 853.2 861.3 866.8 868.2 882.6 15581.7 15955.8 15965.5 17219.0 17340.2 14742.9 14743.7 14745.0 14756.9 14830.2 970.4 986.8 989.3 992.4 992.5 1003.6 1003.7 1003.9 1006.6 1006.6 1012.3 1053.3 1057.5 1058.9 1065.1 1057.2 1057.8 1059.2 1059.5 1060.5 777.5 777.7 777.9 778.2 778.9 15495.1 15537.7 15573.6 17401.7 18005.9 17817.6 18189.7 18238.7 18681.8 18889.9 14932.3 15142.3 15211.6 15342.0 15362.9 3460.4 3461.5 3465.2 3472.1 3473.9 95268.0 95734.5 96164.4 96402.5 96699.0 14598.5 14763.3 14797.6 14808.0 14966.9 27252.2 27497.0 27821.0 28015.6 28386.3 8085.6 8102.2 8103.1 8137.4 8172.6 3931.8 3978.9 4006.0 4020.8 4026.5 4526.8 4623.7 4634.6 4635.3 4682.3 831.9 860.3 865.4 867.9 870.0 698.9 713.5 718.4 724.6 727.8 11177.6 11574.0 12036.9 12331.8 12611.8 697.2 705.9 713.3 723.5 724.4 5245.6 5267.3 5355.7 5439.9 5508.7 81090.6 81287.6 82145.0 83596.0 87343.6 72695.3 72946.0 73169.0 76216.6 76769.2 37588.8 60850.0 61405.4 61944.7 64060.4 11733.9 12621.8 12653.4 12755.2 12756.4 32320.0 32547.8 32556.8 33034.4 33925.7 39663.6 39830.6 40013.8 40319.2 41060.4 17575.1 17662.2 17749.7 17868.6 18257.6 17757.6 17914.0 18329.7 18373.4 18733.7 16938.5 17172.2 17380.7 17441.7 17783.3 15810.9 15864.8 15884.7 16116.6 16409.3 16583.3 16677.9 16897.2 16914.5 16949.5 11704.9 11755.8 11762.6 11915.9 12063.7 13494.3 13793.3 13910.7 13960.6 13986.1 04:13:04 INFO - PID 8852 | -------- Summary: end -------- 04:13:04 INFO - PID 8852 | 04:13:05 INFO - TEST-INFO | 8852: exit 0 04:13:05 INFO - TEST-OK | dromaeo_css | took 1115102ms 04:13:05 INFO - TEST-START | kraken 04:13:05 INFO - operating with platform_type : linux_ 04:13:05 INFO - Initialising browser for kraken test... 04:13:05 INFO - TEST-INFO | started process 9183 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk8Ywzf/profile http://localhost:57001/getInfo.html) 04:13:08 INFO - PID 9183 | __metrics Screen width/height:1600/1200 04:13:08 INFO - PID 9183 | colorDepth:24 04:13:08 INFO - PID 9183 | Browser inner width/height: 1024/695 04:13:08 INFO - PID 9183 | __metrics 04:13:09 INFO - PID 9183 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:13:09 INFO - PID 9183 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:13:10 INFO - TEST-INFO | 9183: exit 0 04:13:10 INFO - Browser initialized. 04:13:10 INFO - Running cycle 1/1 for kraken test... 04:13:10 INFO - TEST-INFO | started process 9280 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk8Ywzf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:13:22 INFO - PID 9280 | RSS: Main: 148398080 04:13:22 INFO - PID 9280 | 04:13:24 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:57001/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57001/tests/kraken/driver.html?testName=audio-beat-detection) 04:13:25 INFO - PID 9280 | RSS: Main: 218324992 04:13:25 INFO - PID 9280 | 04:13:28 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:57001/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57001/tests/kraken/driver.html?testName=audio-dft) 04:13:28 INFO - PID 9280 | RSS: Main: 178446336 04:13:28 INFO - PID 9280 | 04:13:31 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:57001/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57001/tests/kraken/driver.html?testName=audio-fft) 04:13:32 INFO - PID 9280 | RSS: Main: 260816896 04:13:32 INFO - PID 9280 | 04:13:34 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:57001/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57001/tests/kraken/driver.html?testName=audio-oscillator) 04:13:34 INFO - PID 9280 | RSS: Main: 172478464 04:13:34 INFO - PID 9280 | 04:13:37 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:57001/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57001/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:13:37 INFO - PID 9280 | RSS: Main: 174960640 04:13:37 INFO - PID 9280 | 04:13:40 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:57001/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57001/tests/kraken/driver.html?testName=imaging-darkroom) 04:13:41 INFO - PID 9280 | RSS: Main: 236064768 04:13:41 INFO - PID 9280 | 04:13:44 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:57001/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57001/tests/kraken/driver.html?testName=imaging-desaturate) 04:13:45 INFO - PID 9280 | RSS: Main: 252653568 04:13:45 INFO - PID 9280 | 04:13:47 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:57001/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57001/tests/kraken/driver.html?testName=json-parse-financial) 04:13:48 INFO - PID 9280 | RSS: Main: 264900608 04:13:48 INFO - PID 9280 | 04:13:49 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:57001/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57001/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:13:50 INFO - PID 9280 | RSS: Main: 198889472 04:13:50 INFO - PID 9280 | 04:13:52 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:57001/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57001/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:13:52 INFO - PID 9280 | RSS: Main: 203939840 04:13:52 INFO - PID 9280 | 04:13:54 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:57001/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57001/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:13:55 INFO - PID 9280 | RSS: Main: 212811776 04:13:55 INFO - PID 9280 | 04:13:57 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:57001/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:13:58 INFO - PID 9280 | RSS: Main: 222052352 04:13:58 INFO - PID 9280 | 04:14:01 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:57001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:14:02 INFO - PID 9280 | RSS: Main: 217755648 04:14:02 INFO - PID 9280 | 04:14:03 INFO - PID 9280 | Cycle 1(1): loaded http://localhost:57001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57001/tests/kraken/driver.html?testName=ai-astar) 04:14:04 INFO - PID 9280 | RSS: Main: 267702272 04:14:04 INFO - PID 9280 | 04:14:04 INFO - PID 9280 | __start_tp_report 04:14:04 INFO - PID 9280 | _x_x_mozilla_page_load 04:14:04 INFO - PID 9280 | _x_x_mozilla_page_load_details 04:14:04 INFO - PID 9280 | |i|pagename|runs| 04:14:04 INFO - PID 9280 | |0;ai-astar;107;110;109;108;108;109;108;108;108;109 04:14:04 INFO - PID 9280 | |1;audio-beat-detection;151;117;119;163;119;118;116;117;138;119 04:14:04 INFO - PID 9280 | |2;audio-dft;161;161;161;162;161;161;162;163;162;164 04:14:04 INFO - PID 9280 | |3;audio-fft;74;74;73;111;73;73;74;73;93;73 04:14:04 INFO - PID 9280 | |4;audio-oscillator;82;83;108;81;81;81;94;82;82;104 04:14:04 INFO - PID 9280 | |5;imaging-gaussian-blur;113;112;113;114;113;113;113;113;113;113 04:14:04 INFO - PID 9280 | |6;imaging-darkroom;147;146;146;146;147;147;147;147;146;146 04:14:04 INFO - PID 9280 | |7;imaging-desaturate;95;94;94;94;94;93;94;94;94;94 04:14:04 INFO - PID 9280 | |8;json-parse-financial;46;47;47;46;47;48;47;47;46;48 04:14:04 INFO - PID 9280 | |9;json-stringify-tinderbox;54;54;54;54;53;54;54;55;54;54 04:14:04 INFO - PID 9280 | |10;stanford-crypto-aes;78;78;78;78;79;78;80;78;78;78 04:14:04 INFO - PID 9280 | |11;stanford-crypto-ccm;128;130;133;127;123;125;122;124;168;122 04:14:04 INFO - PID 9280 | |12;stanford-crypto-pbkdf2;178;174;186;179;185;181;185;189;186;183 04:14:04 INFO - PID 9280 | |13;stanford-crypto-sha256-iterative;64;64;65;65;66;65;64;66;64;64 04:14:04 INFO - PID 9280 | __end_tp_report 04:14:04 INFO - PID 9280 | __start_cc_report 04:14:04 INFO - PID 9280 | _x_x_mozilla_cycle_collect,1731 04:14:04 INFO - PID 9280 | __end_cc_report 04:14:04 INFO - PID 9280 | __startTimestamp1494760444067__endTimestamp 04:14:04 INFO - PID 9280 | 04:14:04 INFO - PID 9280 | ------- Summary: start ------- 04:14:04 INFO - PID 9280 | Number of tests: 14 04:14:04 INFO - PID 9280 | 04:14:04 INFO - PID 9280 | [#0] ai-astar Cycles:10 Average:108.40 Median:108.50 stddev:0.84 (0.8%) stddev-sans-first:0.73 04:14:04 INFO - PID 9280 | Values: 107.0 110.0 109.0 108.0 108.0 109.0 108.0 108.0 108.0 109.0 04:14:04 INFO - PID 9280 | 04:14:04 INFO - PID 9280 | [#1] audio-beat-detection Cycles:10 Average:127.70 Median:119.00 stddev:16.94 (14.2%) stddev-sans-first:15.73 04:14:04 INFO - PID 9280 | Values: 151.0 117.0 119.0 163.0 119.0 118.0 116.0 117.0 138.0 119.0 04:14:04 INFO - PID 9280 | 04:14:04 INFO - PID 9280 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.03 (0.6%) stddev-sans-first:1.05 04:14:04 INFO - PID 9280 | Values: 161.0 161.0 161.0 162.0 161.0 161.0 162.0 163.0 162.0 164.0 04:14:04 INFO - PID 9280 | 04:14:04 INFO - PID 9280 | [#3] audio-fft Cycles:10 Average:79.10 Median:73.50 stddev:12.80 (17.4%) stddev-sans-first:13.44 04:14:04 INFO - PID 9280 | Values: 74.0 74.0 73.0 111.0 73.0 73.0 74.0 73.0 93.0 73.0 04:14:04 INFO - PID 9280 | 04:14:04 INFO - PID 9280 | [#4] audio-oscillator Cycles:10 Average:87.80 Median:82.00 stddev:10.39 (12.7%) stddev-sans-first:10.81 04:14:04 INFO - PID 9280 | Values: 82.0 83.0 108.0 81.0 81.0 81.0 94.0 82.0 82.0 104.0 04:14:04 INFO - PID 9280 | 04:14:04 INFO - PID 9280 | [#5] imaging-gaussian-blur Cycles:10 Average:113.00 Median:113.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 04:14:04 INFO - PID 9280 | Values: 113.0 112.0 113.0 114.0 113.0 113.0 113.0 113.0 113.0 113.0 04:14:04 INFO - PID 9280 | 04:14:04 INFO - PID 9280 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:14:04 INFO - PID 9280 | Values: 147.0 146.0 146.0 146.0 147.0 147.0 147.0 147.0 146.0 146.0 04:14:04 INFO - PID 9280 | 04:14:04 INFO - PID 9280 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 04:14:04 INFO - PID 9280 | Values: 95.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 04:14:04 INFO - PID 9280 | 04:14:04 INFO - PID 9280 | [#8] json-parse-financial Cycles:10 Average:46.90 Median:47.00 stddev:0.74 (1.6%) stddev-sans-first:0.71 04:14:04 INFO - PID 9280 | Values: 46.0 47.0 47.0 46.0 47.0 48.0 47.0 47.0 46.0 48.0 04:14:04 INFO - PID 9280 | 04:14:04 INFO - PID 9280 | [#9] json-stringify-tinderbox Cycles:10 Average:54.00 Median:54.00 stddev:0.47 (0.9%) stddev-sans-first:0.50 04:14:04 INFO - PID 9280 | Values: 54.0 54.0 54.0 54.0 53.0 54.0 54.0 55.0 54.0 54.0 04:14:04 INFO - PID 9280 | 04:14:04 INFO - PID 9280 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:78.00 stddev:0.67 (0.9%) stddev-sans-first:0.71 04:14:04 INFO - PID 9280 | Values: 78.0 78.0 78.0 78.0 79.0 78.0 80.0 78.0 78.0 78.0 04:14:04 INFO - PID 9280 | 04:14:04 INFO - PID 9280 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:127.50 stddev:13.76 (10.8%) stddev-sans-first:14.57 04:14:04 INFO - PID 9280 | Values: 128.0 130.0 133.0 127.0 123.0 125.0 122.0 124.0 168.0 122.0 04:14:04 INFO - PID 9280 | 04:14:04 INFO - PID 9280 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.60 Median:185.00 stddev:4.55 (2.5%) stddev-sans-first:4.51 04:14:04 INFO - PID 9280 | Values: 178.0 174.0 186.0 179.0 185.0 181.0 185.0 189.0 186.0 183.0 04:14:04 INFO - PID 9280 | 04:14:04 INFO - PID 9280 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 04:14:04 INFO - PID 9280 | Values: 64.0 64.0 65.0 65.0 66.0 65.0 64.0 66.0 64.0 64.0 04:14:04 INFO - PID 9280 | -------- Summary: end -------- 04:14:04 INFO - PID 9280 | 04:14:05 INFO - TEST-INFO | 9280: exit 0 04:14:05 INFO - TEST-OK | kraken | took 60092ms 04:14:05 INFO - SUITE-END | took 1175s 04:14:05 INFO - Completed test suite (00:19:35) 04:14:05 INFO - javascript benchmark 04:14:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7675.100308143095, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3206.839658017099, 3330.6336303006665, 3360.0423879194427, 3372.7976321420733, 3384.560007199064, 5723.942760572393, 5827.329857066438, 5889.705514724268, 5898.410158984105, 5905.645661260327, 5777.855553611152, 5806.883862322761, 5808.622439541437, 5808.941910580893, 5818.0, 5122.974385128069, 5129.6409251352425, 5143.254228136918, 5152.227165925123, 5175.327207463043, 5196.324477817879, 5225.529702326789, 5248.422673505911, 5264.105102132647, 5309.203619457093, 5249.160134378481, 5272.181740248614, 5283.207518872162, 5285.418603953562, 5291.391489978644, 790.7290198210175, 5100.974410526425, 5144.459831717653, 5151.098557752378, 5249.028929648028, 5176.818811341585, 5181.974090129563, 5183.5853131749745, 5185.118529849935, 5187.662801917863, 5710.543156547507, 5796.797112101099, 5841.269841269841, 5843.18195452637, 5878.941210587882, 6143.508519318444, 6177.2587289525545, 6264.342244064399, 6322.0, 6360.872782544369, 6354.173957385557, 6365.458935990447, 6377.553571250014, 6389.4568961638315, 6390.904136437957, 5914.9112763308585, 5917.171595976567, 5923.348431672513, 5925.822225333247, 5977.193078934375, 6343.777967771106, 6402.711877965503, 6420.775272865428, 6422.967885160638, 6481.935180648227, 6221.06683997395, 6263.091851681481, 6264.749410023548, 6266.373362663697, 6267.373262673787, 6268.0, 6312.179416675895, 6351.110844481776, 6376.266729326187, 6377.7448902044325, 6122.265955856691, 6193.473554747897, 6215.9378406215355, 6318.526110541728, 6336.081268216083, 6321.65230912295, 6330.525210609223, 6333.334999825044, 6336.081268216083, 6337.9366206337345, 4764.14245435818, 4777.163996300634, 4782.115308667908, 4786.44955830077, 4806.0, 4212.936805947913, 4235.745855248695, 4268.146370725867, 4270.807813648394, 4291.0130669945465, 5895.882082358329, 6001.669908155093, 6003.609765365237, 6006.159137720722, 6011.368806275365, 6347.55567110307, 6347.650879201688, 6365.904511432333, 6375.171227740364, 6388.39310265524, 5974.103884417285, 5985.610935289193, 5986.580939334205, 5987.2815262168815, 6028.57799953999, 5356.625036247503, 5368.3826359968325, 5374.328208973879, 5381.9461805382225, 5381.9461805382225, 6308.621482711052, 6409.0, 6484.870302594016, 6534.771283005072, 6620.304867988792, 6392.4246817786625, 6410.166678331787, 6412.422881940461, 6414.358564143548, 6427.55007149495, 6553.901691474536, 6627.801165965029, 6629.337066293525, 6634.701438435185, 6642.734290628514, 6106.460667179974, 6160.0, 6191.84520386994, 6246.625202487865, 6277.5605707600025, 6344.555881088279, 6379.681015949277, 6400.167978162809, 6408.775692850914, 6409.35906409374, 6126.693665316806, 6179.84550386244, 6191.1641928339095, 6193.566450348432, 6193.81418557444, 6083.908741368795, 6099.176611157614, 6177.660228687465, 6194.0708893666315, 6198.6280823150755, 6026.216591843032, 6101.633901965896, 6110.297315808739, 6119.4798442132915, 6143.232095988002, 6162.825501346973, 6215.254169499689, 6216.53375996793, 6222.875542489215, 6233.625982441068, 5883.294004719461, 5905.940940590711, 5988.131720900358, 5992.580519363602, 5996.490298324691], "value": 5746.575902699695, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [792.8969233999582, 820.7332616899507, 1132.7621199548094, 1158.536585365854, 1160.025578514048, 35373.82313088434, 35997.0, 37939.0, 38030.42954355687, 38152.23695526088, 39886.40170397439, 40360.39459408104, 40439.59560404395, 40452.19095618086, 40454.19091618166, 7094.184168820574, 7175.856482870339, 7186.425085993134, 7190.209077001526, 7190.388816950565, 5632.464915833009, 5772.336181339137, 7275.381592564639, 7463.290987356192, 7471.215522370155, 7551.584662843569, 7578.734744283951, 7586.924130758704, 7587.4688771785995, 7597.620118994056, 7472.140703819076, 7536.321731044178, 7537.623118844036, 7540.283673051024, 7546.584937828417, 7401.740939067161, 7438.628068596603, 7441.66512506933, 7446.032015837961, 7454.2173071827765, 35122.824385878164, 35208.295834083176, 35509.644903551154, 35519.467207991904, 35531.0, 3467.219875528011, 3524.2422879080864, 3524.7004004659634, 3529.3823580873245, 3529.541159649255, 28664.713352866413, 28768.424631507463, 28800.135995920155, 28805.423891522263, 28872.0, 3753.9061523462133, 3765.7928813915223, 3784.3188226119287, 3795.4876091727538, 3806.2197249563774, 189457.0, 189589.0, 189636.0, 189639.0, 190120.0, 38836.41745373821, 48376.0, 48389.0, 48424.0, 48495.5150448498, 41375.379369309485, 49015.509844901804, 49397.789143706264, 49596.0, 49672.751636241584, 13328.200307981551, 13400.93299533496, 13427.462901483832, 13432.656734326685, 13434.664133396547, 10469.162467002621, 10514.264001519974, 10523.315984460985, 10532.420716860493, 10538.73653158662, 13507.0, 13542.729145417234, 13595.252261125535, 13647.658808529668, 13795.862041379658, 5402.702851343135, 5429.972850135803, 5436.945630543723, 5466.671999680032, 5475.342958844964, 1083.34999000599, 1112.3548341961643, 1114.3759494683004, 1126.4142645824124, 1130.3218069158438, 25984.220473385827, 26082.0, 26157.215283541525, 26303.868480657857, 26399.604005939927, 1192.1833544022372, 1194.8446701928694, 1201.7175963648535, 1216.2641601830765, 1232.2975903734784, 13454.529091481947, 13602.93198534001, 13719.176849389069, 13868.445262189602, 13890.0, 222874.0, 223210.0, 223308.0, 223341.0, 223780.0, 47715.0, 47733.522664773605, 47814.28278575824, 47823.76088119537, 47874.76062619734, 1465.919374434395, 1514.9621259468602, 1518.7190369781626, 1531.2956040221623, 1541.2216830500524, 24335.14826981047, 25523.48953020892, 25784.742152578234, 26007.609885852107, 26057.218283451526, 39008.804955975036, 39021.41467877927, 39037.414438784006, 39070.80464597659, 39078.6092139075, 142600.0, 142683.0, 142875.0, 143085.0, 143658.0, 29330.413391732473, 29811.18681857017, 32456.0, 33157.17107072342, 34849.65150348566, 39138.2172356557, 39988.40017399683, 40641.59358406496, 40719.389209161294, 41151.38272925968, 30146.24634384158, 30618.387632247675, 30871.382572348877, 31073.8446307767, 32305.51541726923, 30557.694423055484, 30680.539791902695, 30914.381712365175, 32307.838460807547, 32469.675303246666, 35978.88358979032, 36238.63761362458, 36259.45610815893, 36543.81728091343, 36657.083572909825, 31433.8428307857, 31637.683623163473, 32079.839600801846, 33905.66094339124, 34304.313913722086, 24240.272791816275, 26753.464930701666, 27066.458670826865, 27082.0, 27206.134317314292], "value": 16584.37460148463, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.42138245442334, 443.7182389182869, 449.09731439806, 452.7736131934035, 459.34313931078555, 18757.15592798322, 19809.40571782847, 20430.69353959688, 20564.794352056473, 20578.89710551449, 21536.246231381905, 22039.779602203973, 22282.220122295723, 22299.888500557474, 22545.0, 5606.747696353664, 5712.800051998181, 5716.799912003081, 5721.799737009205, 5725.6278341907855, 5562.582806289524, 5608.9439105609035, 5625.240592519998, 5653.886922261552, 5658.462446067638, 5606.607537472379, 5622.184783206432, 5635.267415236013, 5638.718064096779, 5639.097744360903, 5462.071447853855, 5586.944130558703, 5620.325560932673, 5634.211210430543, 5634.3520495143175, 4984.775685094143, 5123.2827404163445, 5130.256112863651, 5131.4098878629065, 5138.023775482647, 24703.382415439577, 24941.87529062361, 25451.745482545124, 26210.60684089721, 26647.600285995726, 2142.1966762464076, 2150.35489353195, 2152.0530966374745, 2169.2082389927564, 2171.1206961180746, 16309.51071467858, 16880.155992200464, 16945.91527042369, 17139.657206855794, 17208.483745487654, 2153.3001774423374, 2207.9116835326568, 2226.654868495386, 2226.654868495386, 2236.519148383089, 106700.0, 122149.99999999911, 122418.2065434763, 126695.0, 126770.36614816959, 12244.448999795031, 12348.259104453762, 12415.379231038412, 12526.37368131608, 12648.810267845989, 17667.38164164248, 17732.645347092985, 17749.378771743184, 17767.0, 17775.288988440578, 8756.605952732143, 8987.865182022275, 9082.0, 9160.633574657073, 9172.541372931326, 8265.793355166168, 8363.581820909052, 8445.0, 8552.358573107042, 8603.870941935877, 7716.498427602188, 7896.0, 8022.957015587936, 8028.0, 8079.959600201962, 2202.4714068623416, 2222.2666520048347, 2223.677566752812, 2259.3109101723803, 2359.091749676387, 1036.1348274191134, 1051.5057922776282, 1074.333912973961, 1079.0019232210175, 1083.2200815412891, 23095.769042309697, 25433.10984115547, 25549.3612659685, 25880.22359329223, 25902.35244118912, 1078.245228340165, 1078.568572570978, 1080.3679847289266, 1082.4533610526635, 1085.5386460754148, 10591.258611897094, 11324.207305488537, 11391.145664075228, 11411.48648310828, 11444.656660300205, 478313.0, 484875.0, 490777.0, 492127.0, 492161.0, 98595.0, 98993.50503247438, 104559.0, 104962.4751876251, 105204.47397762962, 1224.3939250071094, 1260.9117361784588, 1277.0422183362477, 1280.3342262023696, 1281.5194302136513, 18001.819981800014, 18232.81767182311, 18579.90710046441, 18685.15916783775, 18853.717194241824, 47383.76308118575, 47621.0, 48084.39367047416, 48381.27428088511, 48701.512984871115, 60431.0, 60567.39432605617, 60647.0, 62403.375966241576, 62606.0, 9754.707358779247, 9869.654562090293, 9950.950245248727, 10009.799804003733, 10215.7446063849, 15641.296141673425, 15709.371625134867, 15784.13187274711, 16258.349666013228, 16630.66738665244, 13154.750298721607, 13225.537106201236, 13432.19406835593, 13476.460941562227, 13833.377498012413, 12722.300273485047, 12852.357382131044, 12893.93553032229, 13021.609351719464, 13616.523421680193, 13890.236037017658, 13949.860501394856, 14136.363863625957, 14248.643783905485, 14501.854981450051, 9892.752681183028, 10009.299349045497, 10026.448545330077, 10079.596816127272, 10222.335548189343, 13658.931705341409, 13719.45122195101, 13786.310684465938, 13922.791158132839, 13971.231582263074], "value": 10440.308557857705, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1120.495776900395, 1390.798334241535, 1420.6448387903024, 1429.4139402844835, 1441.488271663559, 9705.17506011989, 11075.889241107587, 11681.941590292046, 11747.412629368519, 11760.059195264379, 11404.258723182988, 11514.424278786048, 11528.193026488148, 11541.596044138458, 11543.307401555912, 2092.6756352765346, 2434.42790944128, 2474.134053081425, 2474.7772700456953, 2478.764517370847, 2144.603248399051, 2168.772278910715, 2170.316350349635, 2385.7733515316104, 2478.938026549333, 2072.616565935299, 2074.3569493457003, 2084.0413409831494, 2085.614161380142, 2092.7070210170587, 2321.5124823787023, 2362.2204672458047, 2380.8690522021284, 2383.0825132324007, 2383.988080059589, 2313.2597568777996, 2359.1035406545575, 2359.1507057459303, 2359.539889721505, 2360.8819559022154, 11052.171087168414, 11150.553977840877, 11179.888201117967, 11180.720481987933, 11189.888101118966, 6536.0, 6769.458443324572, 6776.8305792355095, 6778.762743303961, 6780.084688567079, 3978.124812541236, 4184.225918205142, 4234.1108367242605, 4241.597048280409, 4253.404523366731, 1375.7317323121995, 1430.7353139669194, 1476.6898951220257, 1488.9851101489064, 1495.6634757179656, 17244.655106897917, 17283.135843207914, 17306.740398894028, 17314.04772737499, 17314.56713582158, 5521.503064724194, 5649.406812284733, 5946.70266486674, 5977.432143946318, 6002.54980876436, 14487.78268325976, 14498.782518262235, 14500.419983200765, 14511.952489977011, 14512.492062777963, 6452.9997850333275, 6796.76211332601, 6814.625195614289, 6833.248342682301, 6843.657817109125, 6017.428344307284, 6047.334793172748, 6101.450869421685, 6107.328193898667, 6117.480014198843, 4552.453705555355, 4576.656750743641, 4639.257718764981, 4731.834385796549, 4768.499307572724, 1417.0788987158223, 1430.4993252361799, 1457.7376072307086, 1460.4304321314696, 1481.2075539586485, 828.2545708862073, 828.45736042892, 851.6721062391024, 867.5748883047262, 892.9910700893038, 6550.0, 6958.443324534025, 6971.65141742921, 6976.5465244758925, 7042.471814613925, 608.1759216261989, 617.1206031405229, 618.5639124417276, 620.8696173803462, 627.6610630259609, 3694.371956767356, 3726.31063253299, 3755.4179102239195, 3771.396576547739, 3887.747296425723, 14659.34032968519, 15489.0, 15490.07059576429, 15522.146281954376, 15528.84471155274, 14707.632309192355, 15063.849361506245, 15219.239038048054, 15227.238638068275, 15246.3901443941, 8979.506127162938, 9229.463171036205, 9236.907630923604, 9301.209397201179, 9305.627774888928, 7007.474439416962, 7034.261402552863, 7054.294570542905, 7085.0, 7160.10498687664, 13217.471301147847, 13292.136011159631, 13602.455901764215, 13626.727465450436, 13626.727465450835, 13672.316384180553, 13803.79294310566, 13872.098313609584, 13988.510402135877, 14053.437862485795, 9251.444913305224, 9438.57526411327, 9518.0, 9585.472798996123, 9607.423554586747, 11270.887291126985, 11346.205765596329, 11349.773004539698, 11382.658520244406, 11388.259763115371, 9348.0, 9372.578233979624, 9490.952545237229, 9534.09426104519, 9713.12581867607, 9257.907420925974, 9304.255659547085, 9415.811683766424, 9480.762980925532, 9629.662961796303, 7871.84256314882, 7999.240072193133, 8001.679932802856, 8004.279614834692, 8010.479318844256, 5932.970335148297, 5941.287045554388, 5963.970180149245, 5998.820035398945, 6124.8775024500155, 6030.246219222598, 6070.848228794315, 6116.633002019893, 6148.78479253224, 6273.0], "value": 5392.848881811862, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.8178142508009, 421.6268602286975, 426.4583978347501, 433.42138245442334, 435.5231022030877, 5700.572457065727, 5826.359100498947, 5852.122181672751, 5855.355910849803, 5904.143899134629, 5648.124540696188, 5683.5169010634145, 5726.1697053927155, 5744.931824543161, 5759.091658712345, 4291.098869237456, 4408.779561021952, 4422.159789639974, 4443.577860103285, 4444.0, 4418.094290670405, 4430.401895744066, 4433.401490798749, 4438.334249862514, 4446.555344465543, 4397.472303323606, 4400.7579583122915, 4403.493598236212, 4405.118976204756, 4414.646828253732, 4324.913501729963, 4344.066025804467, 4380.34294855771, 4393.121375724868, 4405.933910991338, 3856.6914646828186, 3858.2862170498547, 3875.1280961783373, 3878.0, 3883.4951456310782, 5566.137248726453, 5623.465770751772, 5627.943720562783, 5655.1517272409055, 5667.659940403589, 5060.165072762989, 5129.6409251352425, 5149.76826042829, 5164.122099243138, 5165.173572228426, 6075.908861367083, 6124.663143527104, 6127.908081378783, 6151.507879369639, 6158.8152355428965, 4212.326027835532, 4310.4396428464415, 4321.956780432219, 4330.718503297276, 4336.783160841946, 6052.182955301022, 6220.315765265772, 6237.875242495124, 6353.745850165988, 6393.200849893763, 4331.155424692155, 4411.360352748833, 4412.0955204183065, 4412.3160910059, 4437.622802061796, 4466.151431228056, 4469.910601787946, 4471.441069866267, 4478.753668548196, 4488.820447182142, 4898.069366820293, 5000.699958002531, 5028.949710502921, 5112.974435127875, 5131.230315452637, 6067.271927368655, 6104.664243466563, 6119.408953672078, 6121.296050954108, 6123.081537769282, 1500.677354368816, 1534.0642208252957, 1543.202169472552, 1548.2258870564717, 1549.605355180324, 1002.904724051214, 1021.5862575656871, 1032.2670903658336, 1039.7036844499432, 1040.0223789637867, 5839.452545075558, 5851.034579294369, 5861.589688721749, 5912.881742365129, 5928.258967629046, 6278.717457714414, 6290.728821013047, 6295.370462953668, 6311.463525600284, 6339.0, 5739.311282646109, 5784.248047753765, 5864.824055278348, 5869.794557190563, 5893.116032595145, 3309.3546758381885, 3326.600807903067, 3342.147752323142, 3350.698437140669, 3352.832358382071, 6231.753649270074, 6436.420722135031, 6464.095026696266, 6485.643289619022, 6534.509911756637, 6469.838254043687, 6487.545871789024, 6487.799757044962, 6500.447461965691, 6527.738890444424, 6360.855046091748, 6592.30780768022, 6597.406233438917, 6612.471002319803, 6624.238212605612, 6252.718627661857, 6305.873882522415, 6353.8729225416155, 6371.585846919936, 6380.170577824853, 6315.242170939517, 6316.494680425463, 6336.619802811846, 6339.619622822645, 6349.301576826453, 6413.262474815269, 6546.738130474918, 6588.637624930675, 6594.967025164843, 6622.867542649216, 4417.349590245827, 4424.933625995677, 4435.534268901719, 4435.578620031092, 4443.666724995703, 6158.815235542941, 6283.560150789401, 6339.1125242467015, 6358.364163583605, 6372.267189273293, 6181.474574661024, 6184.505239580732, 6194.194754681863, 6201.224846894138, 6201.395413926071, 6074.51403887679, 6134.723937422737, 6155.538334624832, 6180.783672571439, 6180.938190618216, 6115.877682446415, 6127.234095738033, 6148.9692551536955, 6152.0, 6165.352637972948, 6131.509479241561, 6138.140660307471, 6140.478059365004, 6163.506919446344, 6177.104319873503, 5834.679092649945, 5958.225430693982, 6021.126936594082, 6026.0, 6044.969775151096], "value": 4662.177927231426, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [853.1766844994579, 861.2593169873908, 866.8353012927545, 868.1665601023013, 882.6425297754407, 15581.688366232669, 15955.840441595581, 15965.521034368972, 17218.96686198829, 17340.219690113943, 14742.926285368585, 14743.705125897475, 14745.0, 14756.926215368909, 14830.184339861304, 970.3644113105927, 986.7977064701719, 989.3272574649236, 992.3500107429645, 992.4789485520088, 1003.5935446144323, 1003.7189586915675, 1003.8544411060392, 1006.5671761142705, 1006.6023920551378, 1012.3217444312291, 1053.3206082077095, 1057.4501259345136, 1058.878229003663, 1065.0521036277719, 1057.1542765787378, 1057.8466122412285, 1059.179136169471, 1059.5496913811598, 1060.5280650110703, 777.5140537164273, 777.6500574741389, 777.8910952466659, 778.1984555907425, 778.8714862047811, 15495.147766872817, 15537.689246215126, 15573.610659733484, 17401.738973915402, 18005.909970450062, 17817.554561135945, 18189.7271540927, 18238.726419103725, 18681.813181868143, 18889.905550472296, 14932.32804523799, 15142.318595663111, 15211.61970950724, 15342.0, 15362.923185384001, 3460.377132116218, 3461.5153878456786, 3465.151037995682, 3472.1146107742366, 3473.89578312651, 95268.0, 95734.52132739431, 96164.42191358945, 96402.51798741032, 96699.0, 14598.489052883311, 14763.261836908327, 14797.630059248604, 14808.0, 14966.850331496764, 27252.182434526996, 27497.0, 27821.0, 28015.579766303523, 28386.290342741595, 8085.636146373427, 8102.230288122619, 8103.10865804761, 8137.430379873471, 8172.550509721904, 3931.803409829497, 3978.8806335809973, 4005.959940400617, 4020.7587544747407, 4026.516817981861, 4526.841560545365, 4623.69945953512, 4634.582887540138, 4635.281531362644, 4682.321063445781, 831.8669012957897, 860.2644738748405, 865.4374656473217, 867.8804342398236, 869.9565021749014, 698.9475789315821, 713.53263612334, 718.3678363040491, 724.6050902258282, 727.7707522130512, 11177.608783692533, 11574.0, 12036.939815300868, 12331.828476294737, 12611.810822837664, 697.1877762406841, 705.8694141583824, 713.2688993781416, 723.4863247094622, 724.4349407462188, 5245.580353571705, 5267.26258323835, 5355.7054362009685, 5439.918401223985, 5508.724563771795, 81090.59454702807, 81287.5935620318, 82145.0, 83596.0, 87343.56328218318, 72695.2730472699, 72946.0, 73169.0, 76216.61891690617, 76769.23230767733, 37588.81205593955, 60850.0, 61405.38594613997, 61944.69027654833, 64060.35939640637, 11733.882661173278, 12621.81067283973, 12653.430595623035, 12755.170913890568, 12756.362181890683, 32320.0, 32547.837260813543, 32556.837215813768, 33034.38415469424, 33925.66074339225, 39663.603363965995, 39830.60169398269, 40013.79993100016, 40319.193616126926, 41060.384094239205, 17575.121243938007, 17662.205200766253, 17749.733753993958, 17868.55328616795, 18257.634847302714, 17757.64484710273, 17914.0, 18329.725054124465, 18373.356932507297, 18733.718994214825, 16938.49184524466, 17172.22724977354, 17380.739288910423, 17441.651166976844, 17783.28866845312, 15810.92094539566, 15864.841351586336, 15884.68230635404, 16116.597085072966, 16409.26158322902, 16583.336666533203, 16677.91661041687, 16897.239624217185, 16914.492565223063, 16949.49151525456, 11704.94147529257, 11755.764884702428, 11762.647120586396, 11915.880841191478, 12063.698407539881, 13494.32528373597, 13793.310334483034, 13910.652233694238, 13960.58118256454, 13986.090904091201], "value": 8170.431716086839, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1475.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 109.0, 108.0, 108.0, 109.0, 108.0, 108.0, 108.0, 109.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 117.0, 119.0, 163.0, 119.0, 118.0, 116.0, 117.0, 138.0, 119.0], "value": 127.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 161.0, 161.0, 162.0, 163.0, 162.0, 164.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 111.0, 73.0, 73.0, 74.0, 73.0, 93.0, 73.0], "value": 79.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 108.0, 81.0, 81.0, 81.0, 94.0, 82.0, 82.0, 104.0], "value": 87.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 113.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 47.0, 47.0, 46.0, 47.0, 48.0, 47.0, 47.0, 46.0, 48.0], "value": 46.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 53.0, 54.0, 54.0, 55.0, 54.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 78.0, 79.0, 78.0, 80.0, 78.0, 78.0, 78.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 130.0, 133.0, 127.0, 123.0, 125.0, 122.0, 124.0, 168.0, 122.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 174.0, 186.0, 179.0, 185.0, 181.0, 185.0, 189.0, 186.0, 183.0], "value": 182.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 65.0, 66.0, 65.0, 64.0, 66.0, 64.0, 64.0], "value": 64.7, "unit": "score"}]}]} 04:14:05 INFO - Return code: 0 04:14:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:14:05 INFO - # TBPL SUCCESS # 04:14:05 INFO - Running post-action listener: _resource_record_post_action 04:14:05 INFO - [mozharness: 2017-05-14 11:14:05.391999Z] Finished run-tests step (success) 04:14:05 INFO - Running post-run listener: _resource_record_post_run 04:14:05 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 378937344; Read time: 16; Write time: 250936 04:14:05 INFO - TinderboxPrint: CPU usage
12.9% 04:14:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:14:05 INFO - TinderboxPrint: I/O write bytes / time
378,937,344 / 250,936 04:14:05 INFO - TinderboxPrint: CPU idle
8,292.1 (87.1%) 04:14:05 INFO - TinderboxPrint: CPU user
1,186.3 (12.5%) 04:14:05 INFO - TinderboxPrint: Swap in / out
0 / 0 04:14:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111906816; Read time: 0; Write time: 92384 04:14:05 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 267030528; Read time: 0; Write time: 158552 04:14:06 INFO - Running post-run listener: _upload_blobber_files 04:14:06 INFO - Blob upload gear active. 04:14:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:14:06 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 04:14:06 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'] 04:14:06 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 04:14:06 INFO - (blobuploader) - INFO - Open directory for files ... 04:14:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:14:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:14:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:14:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:14:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:14:09 INFO - (blobuploader) - INFO - Done attempting. 04:14:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:14:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:14:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:14:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:14:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:14:10 INFO - (blobuploader) - INFO - Done attempting. 04:14:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:14:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:14:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:14:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:14:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:14:11 INFO - (blobuploader) - INFO - Done attempting. 04:14:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:14:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:14:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:14:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:14:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:14:12 INFO - (blobuploader) - INFO - Done attempting. 04:14:12 INFO - (blobuploader) - INFO - Iteration through files over. 04:14:12 INFO - Return code: 0 04:14:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:14:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:14:12 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/076951467a49ee49642f6865424b744d002a4b1a9603caa39797f28e2889ac83b29a8323a33a06f3e84a042ba2c981e3cff8b9a45eace461c0d45eab68a75588", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/033305c545561fa66f08ae1fb20b06772479b1d41fef3099692d8c87d35ed1c22e53e5ce226ba7c464c74812783c1254d468ba97f2e3922c55dc01eed99c0606", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ebee0ff8c50e8934e5b1fbd5b37937737c926ad02c6746a3749659141dcd0c88e520939d915d3e4d6f05607ec7e487e035ba125e30dbca49658cd1bd90caefc9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7574e8857c62c4f456547e7bc55639e780055600c0614fab6e4b9e785698820cd31d44041a9a9eb1e6fc076be083f5a0d9b048fa549dfce67100569ea6e9a43"} 04:14:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:14:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:14:12 INFO - Contents: 04:14:12 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/076951467a49ee49642f6865424b744d002a4b1a9603caa39797f28e2889ac83b29a8323a33a06f3e84a042ba2c981e3cff8b9a45eace461c0d45eab68a75588", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/033305c545561fa66f08ae1fb20b06772479b1d41fef3099692d8c87d35ed1c22e53e5ce226ba7c464c74812783c1254d468ba97f2e3922c55dc01eed99c0606", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ebee0ff8c50e8934e5b1fbd5b37937737c926ad02c6746a3749659141dcd0c88e520939d915d3e4d6f05607ec7e487e035ba125e30dbca49658cd1bd90caefc9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7574e8857c62c4f456547e7bc55639e780055600c0614fab6e4b9e785698820cd31d44041a9a9eb1e6fc076be083f5a0d9b048fa549dfce67100569ea6e9a43"} 04:14:12 INFO - Running post-run listener: copy_logs_to_upload_dir 04:14:12 INFO - Copying logs to upload dir... 04:14:12 INFO - mkdir: /builds/slave/test/build/upload/logs 04:14:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.047007 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-05-14 04:14:11.801255) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-14 04:14:11.805325) ========= 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=41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349 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/076951467a49ee49642f6865424b744d002a4b1a9603caa39797f28e2889ac83b29a8323a33a06f3e84a042ba2c981e3cff8b9a45eace461c0d45eab68a75588", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/033305c545561fa66f08ae1fb20b06772479b1d41fef3099692d8c87d35ed1c22e53e5ce226ba7c464c74812783c1254d468ba97f2e3922c55dc01eed99c0606", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ebee0ff8c50e8934e5b1fbd5b37937737c926ad02c6746a3749659141dcd0c88e520939d915d3e4d6f05607ec7e487e035ba125e30dbca49658cd1bd90caefc9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7574e8857c62c4f456547e7bc55639e780055600c0614fab6e4b9e785698820cd31d44041a9a9eb1e6fc076be083f5a0d9b048fa549dfce67100569ea6e9a43"} build_url:https://queue.taskcluster.net/v1/task/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011169 build_url: 'https://queue.taskcluster.net/v1/task/QB0hmINOSoazUWUA3T3ZdA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/076951467a49ee49642f6865424b744d002a4b1a9603caa39797f28e2889ac83b29a8323a33a06f3e84a042ba2c981e3cff8b9a45eace461c0d45eab68a75588", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/033305c545561fa66f08ae1fb20b06772479b1d41fef3099692d8c87d35ed1c22e53e5ce226ba7c464c74812783c1254d468ba97f2e3922c55dc01eed99c0606", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ebee0ff8c50e8934e5b1fbd5b37937737c926ad02c6746a3749659141dcd0c88e520939d915d3e4d6f05607ec7e487e035ba125e30dbca49658cd1bd90caefc9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7574e8857c62c4f456547e7bc55639e780055600c0614fab6e4b9e785698820cd31d44041a9a9eb1e6fc076be083f5a0d9b048fa549dfce67100569ea6e9a43"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-14 04:14:11.832727) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 04:14:11.833018) ========= 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=41a7e32711b8e08598a63237000001d6-1494748900.867724-185146349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 04:14:11.912875) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-14 04:14:11.916196) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-14 04:14:11.916479) ========= ========= Total master_lag: 0.18 =========