builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-084 starttime: 1494604850.61 results: success (0) revision: 8a73de724f644192973e88b7685689b048023676 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 09:00:50.608215) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 09:00:50.608616) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 09:00:50.608894) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 09:00:50.666890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:00:50.667170) ========= 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=ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-12 09:00:50-- 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% 69.0M=0s 2017-05-12 09:00:50 (69.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.218351 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:00:50.911816) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:00:50.912114) ========= 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=ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019585 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:00:50.961099) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:00:50.961441) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8a73de724f644192973e88b7685689b048023676 --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 8a73de724f644192973e88b7685689b048023676 --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=ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-12 09:00:51,052 truncating revision to first 12 chars 2017-05-12 09:00:51,052 Setting DEBUG logging. 2017-05-12 09:00:51,052 attempt 1/10 2017-05-12 09:00:51,052 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8a73de724f64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-12 09:00:51,480 unpacking tar archive at: mozilla-central-8a73de724f64/testing/mozharness/ program finished with exit code 0 elapsedTime=0.803618 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:00:51.777879) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 09:00:51.778190) ========= script_repo_revision: 8a73de724f644192973e88b7685689b048023676 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 09:00:51.781601) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 09:00:51.781915) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 09:00:51.805902) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-05-12 09:00:51.806238) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:00:52 INFO - MultiFileLogger online at 20170512 09:00:52 in /builds/slave/test 09:00:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:00:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:00:52 INFO - {'append_to_log': False, 09:00:52 INFO - 'base_work_dir': '/builds/slave/test', 09:00:52 INFO - 'blob_upload_branch': 'Firefox', 09:00:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:00:52 INFO - 'branch': 'Firefox', 09:00:52 INFO - 'buildbot_json_path': 'buildprops.json', 09:00:52 INFO - 'config_files': ('talos/linux_config.py',), 09:00:52 INFO - 'default_actions': ('clobber', 09:00:52 INFO - 'read-buildbot-config', 09:00:52 INFO - 'download-and-extract', 09:00:52 INFO - 'populate-webroot', 09:00:52 INFO - 'create-virtualenv', 09:00:52 INFO - 'install', 09:00:52 INFO - 'run-tests'), 09:00:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:00:52 INFO - 'download_minidump_stackwalk': True, 09:00:52 INFO - 'download_symbols': 'ondemand', 09:00:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:00:52 INFO - 'tooltool.py': '/tools/tooltool.py', 09:00:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:00:52 INFO - '/tools/misc-python/virtualenv.py')}, 09:00:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:00:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:00:52 INFO - 'gecko_profile': False, 09:00:52 INFO - 'gecko_profile_interval': 0, 09:00:52 INFO - 'installer_path': 'installer.exe', 09:00:52 INFO - 'log_level': 'info', 09:00:52 INFO - 'log_name': 'talos', 09:00:52 INFO - 'log_to_console': True, 09:00:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:00:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:00:52 INFO - 'opt_config_files': (), 09:00:52 INFO - 'pip_index': False, 09:00:52 INFO - 'suite': 'dromaeojs-e10s', 09:00:52 INFO - 'system_bits': '32', 09:00:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:00:52 INFO - 'title': 'talos-linux64-ix-084', 09:00:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:00:52 INFO - 'use_talos_json': True, 09:00:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:00:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:00:52 INFO - 'work_dir': 'build'} 09:00:52 INFO - [mozharness: 2017-05-12 16:00:52.114186Z] Running clobber step. 09:00:52 INFO - Running pre-action listener: _resource_record_pre_action 09:00:52 INFO - Running main action method: clobber 09:00:52 INFO - rmtree: /builds/slave/test/build 09:00:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:00:53 INFO - Running post-action listener: _resource_record_post_action 09:00:53 INFO - [mozharness: 2017-05-12 16:00:53.022987Z] Finished clobber step (success) 09:00:53 INFO - [mozharness: 2017-05-12 16:00:53.023087Z] Running read-buildbot-config step. 09:00:53 INFO - Running pre-action listener: _resource_record_pre_action 09:00:53 INFO - Running main action method: read_buildbot_config 09:00:53 INFO - Using buildbot properties: 09:00:53 INFO - { 09:00:53 INFO - "project": "", 09:00:53 INFO - "product": "firefox", 09:00:53 INFO - "who": "ffxbld@noreply.mozilla.org", 09:00:53 INFO - "installer_path": "public/build/target.tar.bz2", 09:00:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 09:00:53 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:00:53 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 09:00:53 INFO - "stage_platform": "linux64-stylo", 09:00:53 INFO - "basedir": "/builds/slave/test", 09:00:53 INFO - "buildnumber": 91, 09:00:53 INFO - "platform": "ubuntu64_hw_stylo", 09:00:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:00:53 INFO - "slavebuilddir": "test", 09:00:53 INFO - "taskId": "F5iPr96bSvKB8IM3um3bqA", 09:00:53 INFO - "branch": "mozilla-central", 09:00:53 INFO - "script_repo_revision": "production", 09:00:53 INFO - "revision": "8a73de724f644192973e88b7685689b048023676", 09:00:53 INFO - "slavename": "talos-linux64-ix-084", 09:00:53 INFO - "repo_path": "mozilla-central" 09:00:53 INFO - } 09:00:53 INFO - Finding installer, test and symbols from parent task. 09:00:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F5iPr96bSvKB8IM3um3bqA'}, attempt #1 09:00:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F5iPr96bSvKB8IM3um3bqA'}, attempt #1 09:00:53 INFO - Task dependencies: Thmn6A7ISkmKYpINRH_5xg 09:00:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg'}, attempt #1 09:00:54 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/target.tar.bz2 09:00:54 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/test_packages.json 09:00:54 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/target.crashreporter-symbols.zip 09:00:54 INFO - Running post-action listener: _resource_record_post_action 09:00:54 INFO - [mozharness: 2017-05-12 16:00:54.377556Z] Finished read-buildbot-config step (success) 09:00:54 INFO - [mozharness: 2017-05-12 16:00:54.377776Z] Running download-and-extract step. 09:00:54 INFO - Running pre-action listener: _resource_record_pre_action 09:00:54 INFO - Running main action method: download_and_extract 09:00:54 INFO - mkdir: /builds/slave/test/build/tests 09:00:54 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')]} 09:00:54 INFO - trying https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/target.test_packages.json 09:00:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:00:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:00:55 INFO - Downloaded 986 bytes. 09:00:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:00:55 INFO - Using the following test package requirements: 09:00:55 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:00:55 INFO - u'common': [u'target.common.tests.zip'], 09:00:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:00:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:00:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:00:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:00:55 INFO - u'mozbase': [u'target.common.tests.zip'], 09:00:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:00:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:00:55 INFO - u'web-platform': [u'target.common.tests.zip', 09:00:55 INFO - u'target.web-platform.tests.zip'], 09:00:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:00:55 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:00:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/target.common.tests.zip 09:00:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:00:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/target.common.tests.zip into memory 09:00:56 INFO - Content-Length response header: 62459793 09:00:56 INFO - Bytes received: 62459793 09:01:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:01:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/target.common.tests.zip 09:01:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:01:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/target.common.tests.zip into memory 09:01:08 INFO - Content-Length response header: 62459793 09:01:08 INFO - Bytes received: 62459793 09:01:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/target.talos.tests.zip 09:01:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:01:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/target.talos.tests.zip into memory 09:01:20 INFO - Content-Length response header: 14409411 09:01:20 INFO - Bytes received: 14409411 09:01:21 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')]} 09:01:21 INFO - trying https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/target.tar.bz2 09:01:21 INFO - Downloading https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:01:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:01:23 INFO - Downloaded 64917429 bytes. 09:01:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/target.tar.bz2 09:01:23 INFO - mkdir: /builds/slave/test/properties 09:01:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:01:23 INFO - Writing to file /builds/slave/test/properties/build_url 09:01:23 INFO - Contents: 09:01:23 INFO - build_url:https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/target.tar.bz2 09:01:23 INFO - Running post-action listener: _resource_record_post_action 09:01:23 INFO - Running post-action listener: set_extra_try_arguments 09:01:23 INFO - [mozharness: 2017-05-12 16:01:23.195374Z] Finished download-and-extract step (success) 09:01:23 INFO - [mozharness: 2017-05-12 16:01:23.195537Z] Running populate-webroot step. 09:01:23 INFO - Running pre-action listener: _resource_record_pre_action 09:01:23 INFO - Running main action method: populate_webroot 09:01:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:01:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:01:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:01:23 INFO - '--tppagecycles', 09:01:23 INFO - '7'], 09:01:23 INFO - 'tests': ['tsvgm']}}, 09:01:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:01:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:01:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:01:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:01:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:01:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:01:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:01:23 INFO - 'talos_options': ['--disable-e10s'], 09:01:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:01:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:01:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:01:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:01:23 INFO - 'talos_options': ['--disable-e10s'], 09:01:23 INFO - 'tests': ['damp', 'tps']}, 09:01:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:01:23 INFO - 'tests': ['damp', 'tps']}, 09:01:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:01:23 INFO - 'tests': ['dromaeo_dom']}, 09:01:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:01:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:01:23 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:01:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:01:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:01:23 INFO - 'tests': ['a11yr', 09:01:23 INFO - 'ts_paint', 09:01:23 INFO - 'tpaint', 09:01:23 INFO - 'sessionrestore', 09:01:23 INFO - 'sessionrestore_no_auto_restore', 09:01:23 INFO - 'tabpaint']}, 09:01:23 INFO - 'other-e10s': {'tests': ['a11yr', 09:01:23 INFO - 'ts_paint', 09:01:23 INFO - 'tpaint', 09:01:23 INFO - 'sessionrestore', 09:01:23 INFO - 'sessionrestore_no_auto_restore', 09:01:23 INFO - 'tabpaint']}, 09:01:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:01:23 INFO - 'ts_paint', 09:01:23 INFO - 'tpaint', 09:01:23 INFO - 'sessionrestore', 09:01:23 INFO - 'sessionrestore_no_auto_restore', 09:01:23 INFO - 'tabpaint']}, 09:01:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:01:23 INFO - 'ts_paint', 09:01:23 INFO - 'tpaint', 09:01:23 INFO - 'sessionrestore', 09:01:23 INFO - 'sessionrestore_no_auto_restore', 09:01:23 INFO - 'tabpaint']}, 09:01:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:01:23 INFO - 'tests': ['a11yr', 09:01:23 INFO - 'ts_paint', 09:01:23 INFO - 'tpaint', 09:01:23 INFO - 'sessionrestore', 09:01:23 INFO - 'sessionrestore_no_auto_restore', 09:01:23 INFO - 'tabpaint']}, 09:01:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:01:23 INFO - 'tests': ['a11yr', 09:01:23 INFO - 'ts_paint', 09:01:23 INFO - 'tpaint', 09:01:23 INFO - 'sessionrestore', 09:01:23 INFO - 'sessionrestore_no_auto_restore', 09:01:23 INFO - 'tabpaint']}, 09:01:23 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:01:23 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:01:23 INFO - 'bloom_basic_ref']}, 09:01:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:01:23 INFO - 'tests': ['tsvgx', 09:01:23 INFO - 'tsvgr_opacity', 09:01:23 INFO - 'tart', 09:01:23 INFO - 'tscrollx', 09:01:23 INFO - 'cart', 09:01:23 INFO - 'tsvg_static']}, 09:01:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:01:23 INFO - 'tsvgr_opacity', 09:01:23 INFO - 'tart', 09:01:23 INFO - 'tscrollx', 09:01:23 INFO - 'cart', 09:01:23 INFO - 'tsvg_static']}, 09:01:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:01:23 INFO - 'talos_options': ['--disable-e10s'], 09:01:23 INFO - 'tests': ['tp5o']}, 09:01:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:01:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:01:23 INFO - 'talos_options': ['--disable-e10s', 09:01:23 INFO - '--xperf_path', 09:01:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:01:23 INFO - 'tests': ['tp5n']}, 09:01:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:01:23 INFO - 'talos_options': ['--xperf_path', 09:01:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:01:23 INFO - 'tests': ['tp5n']}}, 09:01:23 INFO - 'talos.zip': {'path': '', 09:01:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:01:23 INFO - Running post-action listener: _resource_record_post_action 09:01:23 INFO - [mozharness: 2017-05-12 16:01:23.217170Z] Finished populate-webroot step (success) 09:01:23 INFO - [mozharness: 2017-05-12 16:01:23.217259Z] Running create-virtualenv step. 09:01:23 INFO - Running pre-action listener: _resource_record_pre_action 09:01:23 INFO - Running main action method: create_virtualenv 09:01:23 INFO - Creating virtualenv /builds/slave/test/build/venv 09:01:23 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 09:01:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:01:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:01:23 INFO - Using real prefix '/usr' 09:01:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:01:23 INFO - Installing distribute.............................................................................................................................................................................................done. 09:01:25 INFO - Installing pip.................done. 09:01:25 INFO - Return code: 0 09:01:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:01:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:01:26 INFO - Reading from file tmpfile_stdout 09:01:26 INFO - Output received: 09:01:26 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) 09:01:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:01:26 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')]} 09:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:26 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')]} 09:01:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xed21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1244770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1241a30>, '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 0x12427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1242ca0>, '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': 'ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485', '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 09:01:26 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 09:01:26 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 09:01:26 INFO - Using env: {'DISPLAY': ':0', 09:01:26 INFO - 'HOME': '/home/cltbld', 09:01:26 INFO - 'LANG': 'en_US.UTF-8', 09:01:26 INFO - 'LANGUAGE': 'en_US:en', 09:01:26 INFO - 'LOGNAME': 'cltbld', 09:01:26 INFO - 'MAIL': '/var/mail/cltbld', 09:01:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:26 INFO - 'MOZ_NO_REMOTE': '1', 09:01:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:26 INFO - 'NO_EM_RESTART': '1', 09:01:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:26 INFO - 'PWD': '/builds/slave/test', 09:01:26 INFO - 'SHELL': '/bin/bash', 09:01:26 INFO - 'SHLVL': '1', 09:01:26 INFO - 'TERM': 'linux', 09:01:26 INFO - 'TMOUT': '86400', 09:01:26 INFO - 'USER': 'cltbld', 09:01:26 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485', 09:01:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:26 INFO - '_': '/tools/buildbot/bin/python'} 09:01:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:26 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 09:01:26 INFO - Cleaning up... 09:01:26 INFO - Return code: 0 09:01:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:01:26 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')]} 09:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:26 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')]} 09:01:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xed21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1244770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1241a30>, '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 0x12427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1242ca0>, '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': 'ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485', '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 09:01:26 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 09:01:26 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 09:01:26 INFO - Using env: {'DISPLAY': ':0', 09:01:26 INFO - 'HOME': '/home/cltbld', 09:01:26 INFO - 'LANG': 'en_US.UTF-8', 09:01:26 INFO - 'LANGUAGE': 'en_US:en', 09:01:26 INFO - 'LOGNAME': 'cltbld', 09:01:26 INFO - 'MAIL': '/var/mail/cltbld', 09:01:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:26 INFO - 'MOZ_NO_REMOTE': '1', 09:01:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:26 INFO - 'NO_EM_RESTART': '1', 09:01:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:26 INFO - 'PWD': '/builds/slave/test', 09:01:26 INFO - 'SHELL': '/bin/bash', 09:01:26 INFO - 'SHLVL': '1', 09:01:26 INFO - 'TERM': 'linux', 09:01:26 INFO - 'TMOUT': '86400', 09:01:26 INFO - 'USER': 'cltbld', 09:01:26 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485', 09:01:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:26 INFO - '_': '/tools/buildbot/bin/python'} 09:01:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:26 INFO - Downloading/unpacking psutil>=3.1.1 09:01:26 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 09:01:26 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 09:01:26 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 09:01:26 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 09:01:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:01:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:01:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:01:27 INFO - Installing collected packages: psutil 09:01:27 INFO - Running setup.py install for psutil 09:01:27 INFO - building 'psutil._psutil_linux' extension 09:01:27 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 09:01:28 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 09:01:29 INFO - building 'psutil._psutil_posix' extension 09:01:29 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 09:01:29 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 09:01:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:01:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:01:29 INFO - Successfully installed psutil 09:01:29 INFO - Cleaning up... 09:01:29 INFO - Return code: 0 09:01:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:01: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')]} 09:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01: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')]} 09:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:29 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 0xed21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1244770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1241a30>, '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 0x12427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1242ca0>, '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': 'ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485', '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 09:01:29 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 09:01:29 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 09:01:29 INFO - Using env: {'DISPLAY': ':0', 09:01:29 INFO - 'HOME': '/home/cltbld', 09:01:29 INFO - 'LANG': 'en_US.UTF-8', 09:01:29 INFO - 'LANGUAGE': 'en_US:en', 09:01:29 INFO - 'LOGNAME': 'cltbld', 09:01:29 INFO - 'MAIL': '/var/mail/cltbld', 09:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:29 INFO - 'MOZ_NO_REMOTE': '1', 09:01:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:29 INFO - 'NO_EM_RESTART': '1', 09:01:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:29 INFO - 'PWD': '/builds/slave/test', 09:01:29 INFO - 'SHELL': '/bin/bash', 09:01:29 INFO - 'SHLVL': '1', 09:01:29 INFO - 'TERM': 'linux', 09:01:29 INFO - 'TMOUT': '86400', 09:01:29 INFO - 'USER': 'cltbld', 09:01:29 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485', 09:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:29 INFO - '_': '/tools/buildbot/bin/python'} 09:01:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:01:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:01:30 INFO - Installing collected packages: mozsystemmonitor 09:01:30 INFO - Running setup.py install for mozsystemmonitor 09:01:30 INFO - Successfully installed mozsystemmonitor 09:01:30 INFO - Cleaning up... 09:01:30 INFO - Return code: 0 09:01:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:01:30 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')]} 09:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:30 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')]} 09:01:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xed21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1244770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1241a30>, '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 0x12427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1242ca0>, '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': 'ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485', '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 09:01:30 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 09:01:30 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 09:01:30 INFO - Using env: {'DISPLAY': ':0', 09:01:30 INFO - 'HOME': '/home/cltbld', 09:01:30 INFO - 'LANG': 'en_US.UTF-8', 09:01:30 INFO - 'LANGUAGE': 'en_US:en', 09:01:30 INFO - 'LOGNAME': 'cltbld', 09:01:30 INFO - 'MAIL': '/var/mail/cltbld', 09:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:30 INFO - 'MOZ_NO_REMOTE': '1', 09:01:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:30 INFO - 'NO_EM_RESTART': '1', 09:01:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:30 INFO - 'PWD': '/builds/slave/test', 09:01:30 INFO - 'SHELL': '/bin/bash', 09:01:30 INFO - 'SHLVL': '1', 09:01:30 INFO - 'TERM': 'linux', 09:01:30 INFO - 'TMOUT': '86400', 09:01:30 INFO - 'USER': 'cltbld', 09:01:30 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485', 09:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:30 INFO - '_': '/tools/buildbot/bin/python'} 09:01:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:31 INFO - Downloading/unpacking jsonschema==2.5.1 09:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:01:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:32 INFO - Downloading functools32-3.2.3-2.tar.gz 09:01:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:01:32 INFO - warning: no files found matching '*.txt' 09:01:32 INFO - no previously-included directories found matching 'build' 09:01:32 INFO - no previously-included directories found matching 'dist' 09:01:32 INFO - no previously-included directories found matching '.git*' 09:01:32 INFO - Installing collected packages: jsonschema, functools32 09:01:32 INFO - Running setup.py install for functools32 09:01:32 INFO - warning: no files found matching '*.txt' 09:01:32 INFO - no previously-included directories found matching 'build' 09:01:32 INFO - no previously-included directories found matching 'dist' 09:01:32 INFO - no previously-included directories found matching '.git*' 09:01:32 INFO - Successfully installed jsonschema functools32 09:01:32 INFO - Cleaning up... 09:01:32 INFO - Return code: 0 09:01:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:01:32 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')]} 09:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:32 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')]} 09:01:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xed21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1244770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1241a30>, '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 0x12427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1242ca0>, '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': 'ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485', '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 09:01:32 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 09:01:32 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 09:01:32 INFO - Using env: {'DISPLAY': ':0', 09:01:32 INFO - 'HOME': '/home/cltbld', 09:01:32 INFO - 'LANG': 'en_US.UTF-8', 09:01:32 INFO - 'LANGUAGE': 'en_US:en', 09:01:32 INFO - 'LOGNAME': 'cltbld', 09:01:32 INFO - 'MAIL': '/var/mail/cltbld', 09:01:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:32 INFO - 'MOZ_NO_REMOTE': '1', 09:01:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:32 INFO - 'NO_EM_RESTART': '1', 09:01:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:32 INFO - 'PWD': '/builds/slave/test', 09:01:32 INFO - 'SHELL': '/bin/bash', 09:01:32 INFO - 'SHLVL': '1', 09:01:32 INFO - 'TERM': 'linux', 09:01:32 INFO - 'TMOUT': '86400', 09:01:32 INFO - 'USER': 'cltbld', 09:01:32 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485', 09:01:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:32 INFO - '_': '/tools/buildbot/bin/python'} 09:01:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:01:32 INFO - Cleaning up... 09:01:32 INFO - Return code: 0 09:01:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:01:32 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')]} 09:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:32 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')]} 09:01:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xed21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1244770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1241a30>, '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 0x12427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1242ca0>, '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': 'ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485', '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 09:01:32 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 09:01:32 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 09:01:32 INFO - Using env: {'DISPLAY': ':0', 09:01:32 INFO - 'HOME': '/home/cltbld', 09:01:32 INFO - 'LANG': 'en_US.UTF-8', 09:01:32 INFO - 'LANGUAGE': 'en_US:en', 09:01:32 INFO - 'LOGNAME': 'cltbld', 09:01:32 INFO - 'MAIL': '/var/mail/cltbld', 09:01:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:32 INFO - 'MOZ_NO_REMOTE': '1', 09:01:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:32 INFO - 'NO_EM_RESTART': '1', 09:01:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:32 INFO - 'PWD': '/builds/slave/test', 09:01:32 INFO - 'SHELL': '/bin/bash', 09:01:32 INFO - 'SHLVL': '1', 09:01:32 INFO - 'TERM': 'linux', 09:01:32 INFO - 'TMOUT': '86400', 09:01:32 INFO - 'USER': 'cltbld', 09:01:32 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485', 09:01:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:32 INFO - '_': '/tools/buildbot/bin/python'} 09:01:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:32 INFO - Downloading/unpacking blobuploader==1.2.4 09:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:34 INFO - Downloading blobuploader-1.2.4.tar.gz 09:01:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:01:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:01:34 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 09:01:34 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 09:01:34 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 09:01:34 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 09:01:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:01:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:01:34 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 09:01:34 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 09:01:34 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 09:01:34 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 09:01:34 INFO - Downloading docopt-0.6.1.tar.gz 09:01:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:01:34 INFO - Installing collected packages: blobuploader, requests, docopt 09:01:34 INFO - Running setup.py install for blobuploader 09:01:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:01:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:01:34 INFO - Running setup.py install for requests 09:01:35 INFO - Running setup.py install for docopt 09:01:35 INFO - Successfully installed blobuploader requests docopt 09:01:35 INFO - Cleaning up... 09:01:35 INFO - Return code: 0 09:01:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01:35 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')]} 09:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:35 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')]} 09:01:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:35 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 0xed21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1244770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1241a30>, '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 0x12427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1242ca0>, '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': 'ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485', '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 09:01:35 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 09:01:35 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 09:01:35 INFO - Using env: {'DISPLAY': ':0', 09:01:35 INFO - 'HOME': '/home/cltbld', 09:01:35 INFO - 'LANG': 'en_US.UTF-8', 09:01:35 INFO - 'LANGUAGE': 'en_US:en', 09:01:35 INFO - 'LOGNAME': 'cltbld', 09:01:35 INFO - 'MAIL': '/var/mail/cltbld', 09:01:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:35 INFO - 'MOZ_NO_REMOTE': '1', 09:01:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:35 INFO - 'NO_EM_RESTART': '1', 09:01:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:35 INFO - 'PWD': '/builds/slave/test', 09:01:35 INFO - 'SHELL': '/bin/bash', 09:01:35 INFO - 'SHLVL': '1', 09:01:35 INFO - 'TERM': 'linux', 09:01:35 INFO - 'TMOUT': '86400', 09:01:35 INFO - 'USER': 'cltbld', 09:01:35 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485', 09:01:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:35 INFO - '_': '/tools/buildbot/bin/python'} 09:01:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:01:35 INFO - Running setup.py (path:/tmp/pip-Olh7Nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:01:35 INFO - Running setup.py (path:/tmp/pip-dJvS3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:01:35 INFO - Running setup.py (path:/tmp/pip-ZZIzCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:01:35 INFO - Running setup.py (path:/tmp/pip-emuXDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:01:35 INFO - Running setup.py (path:/tmp/pip-gIb4k4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:01:35 INFO - Running setup.py (path:/tmp/pip-_PXR3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:01:35 INFO - Running setup.py (path:/tmp/pip-SHZlD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:01:35 INFO - Running setup.py (path:/tmp/pip-5XEfyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:01:36 INFO - Running setup.py (path:/tmp/pip-VpV5hU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:01:36 INFO - Running setup.py (path:/tmp/pip-Y0AjE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:01:36 INFO - Running setup.py (path:/tmp/pip-jvaqjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:01:36 INFO - Running setup.py (path:/tmp/pip-wm5cER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:01:36 INFO - Running setup.py (path:/tmp/pip-mgDKgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:01:36 INFO - Running setup.py (path:/tmp/pip-4S91mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:36 INFO - Running setup.py (path:/tmp/pip-7sgOoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:01:36 INFO - Running setup.py (path:/tmp/pip-FxnyCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:01:36 INFO - Running setup.py (path:/tmp/pip-PqIhtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:01:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:01:36 INFO - Running setup.py install for manifestparser 09:01:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:01:36 INFO - Running setup.py install for mozcrash 09:01:36 INFO - Running setup.py install for mozdebug 09:01:36 INFO - Running setup.py install for mozdevice 09:01:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:01:37 INFO - Running setup.py install for mozfile 09:01:37 INFO - Running setup.py install for mozhttpd 09:01:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:01:37 INFO - Running setup.py install for mozinfo 09:01:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:01:37 INFO - Running setup.py install for mozInstall 09:01:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:01:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:01:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:01:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:01:37 INFO - Running setup.py install for mozleak 09:01:37 INFO - Running setup.py install for mozlog 09:01:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:01:37 INFO - Running setup.py install for moznetwork 09:01:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:01:37 INFO - Running setup.py install for mozprocess 09:01:37 INFO - Running setup.py install for mozprofile 09:01:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:01:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:01:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:01:37 INFO - Running setup.py install for mozrunner 09:01:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:01:38 INFO - Running setup.py install for mozscreenshot 09:01:38 INFO - Running setup.py install for moztest 09:01:38 INFO - Running setup.py install for mozversion 09:01:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:01:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:01:38 INFO - Cleaning up... 09:01:38 INFO - Return code: 0 09:01:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01:38 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')]} 09:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:38 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')]} 09:01:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:38 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 0xed21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1244770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1241a30>, '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 0x12427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1242ca0>, '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': 'ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485', '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 09:01:38 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 09:01:38 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 09:01:38 INFO - Using env: {'DISPLAY': ':0', 09:01:38 INFO - 'HOME': '/home/cltbld', 09:01:38 INFO - 'LANG': 'en_US.UTF-8', 09:01:38 INFO - 'LANGUAGE': 'en_US:en', 09:01:38 INFO - 'LOGNAME': 'cltbld', 09:01:38 INFO - 'MAIL': '/var/mail/cltbld', 09:01:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:38 INFO - 'MOZ_NO_REMOTE': '1', 09:01:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:38 INFO - 'NO_EM_RESTART': '1', 09:01:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:38 INFO - 'PWD': '/builds/slave/test', 09:01:38 INFO - 'SHELL': '/bin/bash', 09:01:38 INFO - 'SHLVL': '1', 09:01:38 INFO - 'TERM': 'linux', 09:01:38 INFO - 'TMOUT': '86400', 09:01:38 INFO - 'USER': 'cltbld', 09:01:38 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485', 09:01:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:38 INFO - '_': '/tools/buildbot/bin/python'} 09:01:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:01:38 INFO - Running setup.py (path:/tmp/pip-irPKzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:01:38 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)) 09:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:01:38 INFO - Running setup.py (path:/tmp/pip-CUEycw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:01:38 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)) 09:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:01:38 INFO - Running setup.py (path:/tmp/pip-JL9aiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:01:38 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)) 09:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:01:38 INFO - Running setup.py (path:/tmp/pip-kkB1Ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:01:38 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)) 09:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:01:38 INFO - Running setup.py (path:/tmp/pip-mGJpXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:01:38 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)) 09:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:01:39 INFO - Running setup.py (path:/tmp/pip-6W39Dw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:01:39 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)) 09:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:01:39 INFO - Running setup.py (path:/tmp/pip-RH2HI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:01:39 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)) 09:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:01:39 INFO - Running setup.py (path:/tmp/pip-6xz0Yb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:01:39 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)) 09:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:01:39 INFO - Running setup.py (path:/tmp/pip-Wp798k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:01:39 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)) 09:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:01:39 INFO - Running setup.py (path:/tmp/pip-NLJEtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:01:39 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)) 09:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:01:39 INFO - Running setup.py (path:/tmp/pip-Q59ALs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:01:39 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)) 09:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:01:39 INFO - Running setup.py (path:/tmp/pip-pBU0J6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:01:39 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)) 09:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:01:39 INFO - Running setup.py (path:/tmp/pip-dd2XBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:01:39 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)) 09:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:01:39 INFO - Running setup.py (path:/tmp/pip-IiGrN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:01:39 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)) 09:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:39 INFO - Running setup.py (path:/tmp/pip-V9ceDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:39 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)) 09:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:01:39 INFO - Running setup.py (path:/tmp/pip-r87cWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:01:39 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)) 09:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:01:39 INFO - Running setup.py (path:/tmp/pip-YM0JJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:01:39 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)) 09:01:39 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)) 09:01:39 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)) 09:01:39 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)) 09:01:39 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)) 09:01:39 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)) 09:01:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:01:39 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 09:01:39 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 09:01:39 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 09:01:39 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 09:01:40 INFO - Downloading blessings-1.6.tar.gz 09:01:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:01:41 INFO - Installing collected packages: blessings 09:01:41 INFO - Running setup.py install for blessings 09:01:41 INFO - Successfully installed blessings 09:01:41 INFO - Cleaning up... 09:01:41 INFO - Return code: 0 09:01:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:01:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:01:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:01:41 INFO - Reading from file tmpfile_stdout 09:01:41 INFO - Current package versions: 09:01:41 INFO - argparse == 1.2.1 09:01:41 INFO - blessings == 1.6 09:01:41 INFO - blobuploader == 1.2.4 09:01:41 INFO - docopt == 0.6.1 09:01:41 INFO - functools32 == 3.2.3-2 09:01:41 INFO - jsonschema == 2.5.1 09:01:41 INFO - manifestparser == 1.1 09:01:41 INFO - mozInstall == 1.12 09:01:41 INFO - mozcrash == 1.0 09:01:41 INFO - mozdebug == 0.1 09:01:41 INFO - mozdevice == 0.50 09:01:41 INFO - mozfile == 1.2 09:01:41 INFO - mozhttpd == 0.7 09:01:41 INFO - mozinfo == 0.9 09:01:41 INFO - mozleak == 0.1 09:01:41 INFO - mozlog == 3.4 09:01:41 INFO - moznetwork == 0.27 09:01:41 INFO - mozprocess == 0.25 09:01:41 INFO - mozprofile == 0.28 09:01:41 INFO - mozrunner == 6.13 09:01:41 INFO - mozscreenshot == 0.1 09:01:41 INFO - mozsystemmonitor == 0.3 09:01:41 INFO - moztest == 0.8 09:01:41 INFO - mozversion == 1.4 09:01:41 INFO - psutil == 3.1.1 09:01:41 INFO - requests == 1.2.3 09:01:41 INFO - wsgiref == 0.1.2 09:01:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01:41 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')]} 09:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:41 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')]} 09:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xed21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1244770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1241a30>, '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 0x12427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1242ca0>, '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': 'ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485', '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 09:01:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:01:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:01:41 INFO - Using env: {'DISPLAY': ':0', 09:01:41 INFO - 'HOME': '/home/cltbld', 09:01:41 INFO - 'LANG': 'en_US.UTF-8', 09:01:41 INFO - 'LANGUAGE': 'en_US:en', 09:01:41 INFO - 'LOGNAME': 'cltbld', 09:01:41 INFO - 'MAIL': '/var/mail/cltbld', 09:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:41 INFO - 'MOZ_NO_REMOTE': '1', 09:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:41 INFO - 'NO_EM_RESTART': '1', 09:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:41 INFO - 'PWD': '/builds/slave/test', 09:01:41 INFO - 'SHELL': '/bin/bash', 09:01:41 INFO - 'SHLVL': '1', 09:01:41 INFO - 'TERM': 'linux', 09:01:41 INFO - 'TMOUT': '86400', 09:01:41 INFO - 'USER': 'cltbld', 09:01:41 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485', 09:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:41 INFO - '_': '/tools/buildbot/bin/python'} 09:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:01:41 INFO - Cleaning up... 09:01:41 INFO - Return code: 0 09:01:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:01:41 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')]} 09:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:41 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')]} 09:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xed21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1244770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1241a30>, '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 0x12427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1242ca0>, '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': 'ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485', '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 09:01:41 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 09:01:41 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 09:01:41 INFO - Using env: {'DISPLAY': ':0', 09:01:41 INFO - 'HOME': '/home/cltbld', 09:01:41 INFO - 'LANG': 'en_US.UTF-8', 09:01:41 INFO - 'LANGUAGE': 'en_US:en', 09:01:41 INFO - 'LOGNAME': 'cltbld', 09:01:41 INFO - 'MAIL': '/var/mail/cltbld', 09:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:41 INFO - 'MOZ_NO_REMOTE': '1', 09:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:41 INFO - 'NO_EM_RESTART': '1', 09:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:41 INFO - 'PWD': '/builds/slave/test', 09:01:41 INFO - 'SHELL': '/bin/bash', 09:01:41 INFO - 'SHLVL': '1', 09:01:41 INFO - 'TERM': 'linux', 09:01:41 INFO - 'TMOUT': '86400', 09:01:41 INFO - 'USER': 'cltbld', 09:01:41 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485', 09:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:41 INFO - '_': '/tools/buildbot/bin/python'} 09:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:01:41 INFO - Cleaning up... 09:01:41 INFO - Return code: 0 09:01:41 INFO - Running post-action listener: _resource_record_post_action 09:01:41 INFO - Running post-action listener: _start_resource_monitoring 09:01:41 INFO - Starting resource monitoring. 09:01:41 INFO - [mozharness: 2017-05-12 16:01:41.922255Z] Finished create-virtualenv step (success) 09:01:41 INFO - [mozharness: 2017-05-12 16:01:41.922724Z] Running install step. 09:01:41 INFO - Running pre-action listener: _resource_record_pre_action 09:01:41 INFO - Running main action method: install 09:01:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:01:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:01:42 INFO - Reading from file tmpfile_stdout 09:01:42 INFO - Detecting whether we're running mozinstall >=1.0... 09:01:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:01:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:01:42 INFO - Reading from file tmpfile_stdout 09:01:42 INFO - Output received: 09:01:42 INFO - Usage: mozinstall [options] installer 09:01:42 INFO - Options: 09:01:42 INFO - -h, --help show this help message and exit 09:01:42 INFO - -d DEST, --destination=DEST 09:01:42 INFO - Directory to install application into. [default: 09:01:42 INFO - "/builds/slave/test"] 09:01:42 INFO - --app=APP Application being installed. [default: firefox] 09:01:42 INFO - mkdir: /builds/slave/test/build/application 09:01:42 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'] 09:01:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:01:58 INFO - Reading from file tmpfile_stdout 09:01:58 INFO - Output received: 09:01:58 INFO - /builds/slave/test/build/application/firefox/firefox 09:01:58 INFO - Running post-action listener: _resource_record_post_action 09:01:58 INFO - [mozharness: 2017-05-12 16:01:58.570821Z] Finished install step (success) 09:01:58 INFO - [mozharness: 2017-05-12 16:01:58.571064Z] Running run-tests step. 09:01:58 INFO - Running pre-action listener: _resource_record_pre_action 09:01:58 INFO - Running main action method: run_tests 09:01:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:01:58 INFO - Python 2.7.3 09:01:58 INFO - Return code: 0 09:01:58 INFO - grabbing minidump binary from tooltool 09:01:58 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')]} 09:01:58 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1241a30>, '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 0x12427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1242ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:01:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:01:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:01:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:01:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:01:58 INFO - Return code: 0 09:01:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:01:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:01:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:01:58 INFO - ENV: RUST_BACKTRACE is now 1 09:01:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:01:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:01:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-084 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:01:58 INFO - Using env: {'DISPLAY': ':0', 09:01:58 INFO - 'HOME': '/home/cltbld', 09:01:58 INFO - 'LANG': 'en_US.UTF-8', 09:01:58 INFO - 'LANGUAGE': 'en_US:en', 09:01:58 INFO - 'LOGNAME': 'cltbld', 09:01:58 INFO - 'MAIL': '/var/mail/cltbld', 09:01:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:01:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:58 INFO - 'MOZ_NO_REMOTE': '1', 09:01:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:58 INFO - 'NO_EM_RESTART': '1', 09:01:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:58 INFO - 'PWD': '/builds/slave/test', 09:01:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:01:58 INFO - 'RUST_BACKTRACE': '1', 09:01:58 INFO - 'SHELL': '/bin/bash', 09:01:58 INFO - 'SHLVL': '1', 09:01:58 INFO - 'TERM': 'linux', 09:01:58 INFO - 'TMOUT': '86400', 09:01:58 INFO - 'USER': 'cltbld', 09:01:58 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485', 09:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:58 INFO - '_': '/tools/buildbot/bin/python'} 09:01:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:01:58 INFO - mozversion application_buildid: 20170512151418 09:01:58 INFO - mozversion application_changeset: 8a73de724f644192973e88b7685689b048023676 09:01:58 INFO - mozversion application_display_name: Nightly 09:01:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:01:58 INFO - mozversion application_name: Firefox 09:01:58 INFO - mozversion application_remotingname: firefox 09:01:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:01:58 INFO - mozversion application_vendor: Mozilla 09:01:58 INFO - mozversion application_version: 55.0a1 09:01:58 INFO - mozversion platform_buildid: 20170512151418 09:01:58 INFO - mozversion platform_changeset: 8a73de724f644192973e88b7685689b048023676 09:01:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:01:58 INFO - mozversion platform_version: 55.0a1 09:01:58 INFO - using testdate: 1494604918 09:01:58 INFO - actual date: 1494604918 09:01:58 INFO - starting webserver on 'localhost:49233' 09:01:58 INFO - SUITE-START | Running 2 tests 09:01:58 INFO - TEST-START | dromaeo_css 09:01:58 INFO - operating with platform_type : linux_ 09:01:58 INFO - Initialising browser for dromaeo_css test... 09:01:58 INFO - TEST-INFO | started process 3325 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIFnxTA/profile http://localhost:49233/getInfo.html) 09:02:04 INFO - PID 3325 | __metrics Screen width/height:1600/1200 09:02:04 INFO - PID 3325 | colorDepth:24 09:02:04 INFO - PID 3325 | Browser inner width/height: 1024/695 09:02:04 INFO - PID 3325 | __metrics 09:02:06 INFO - TEST-INFO | 3325: exit 0 09:02:06 INFO - Browser initialized. 09:02:06 INFO - Running cycle 1/1 for dromaeo_css test... 09:02:06 INFO - TEST-INFO | started process 3513 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIFnxTA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:19 INFO - PID 3513 | RSS: Main: 172376064 09:02:19 INFO - PID 3513 | 09:05:24 INFO - PID 3513 | Cycle 1(1): loaded http://localhost:49233/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49233/tests/dromaeo/cssquery-ext.html) 09:05:26 INFO - PID 3513 | RSS: Main: 182214656 09:05:26 INFO - PID 3513 | 09:08:28 INFO - PID 3513 | Cycle 1(1): loaded http://localhost:49233/tests/dromaeo/cssquery-ext.html (next: http://localhost:49233/tests/dromaeo/cssquery-jquery.html) 09:08:28 INFO - PID 3513 | RSS: Main: 179253248 09:08:28 INFO - PID 3513 | 09:11:30 INFO - PID 3513 | Cycle 1(1): loaded http://localhost:49233/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49233/tests/dromaeo/cssquery-mootools.html) 09:11:31 INFO - PID 3513 | RSS: Main: 189607936 09:11:31 INFO - PID 3513 | 09:14:33 INFO - PID 3513 | Cycle 1(1): loaded http://localhost:49233/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49233/tests/dromaeo/cssquery-prototype.html) 09:14:33 INFO - PID 3513 | RSS: Main: 181223424 09:14:33 INFO - PID 3513 | 09:17:36 INFO - PID 3513 | Cycle 1(1): loaded http://localhost:49233/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49233/tests/dromaeo/cssquery-yui.html) 09:17:37 INFO - PID 3513 | RSS: Main: 186843136 09:17:37 INFO - PID 3513 | 09:20:39 INFO - PID 3513 | Cycle 1(1): loaded http://localhost:49233/tests/dromaeo/cssquery-yui.html (next: http://localhost:49233/tests/dromaeo/cssquery-dojo.html) 09:20:39 INFO - PID 3513 | RSS: Main: 191700992 09:20:39 INFO - PID 3513 | 09:20:39 INFO - PID 3513 | __start_tp_report 09:20:39 INFO - PID 3513 | _x_x_mozilla_page_load 09:20:39 INFO - PID 3513 | _x_x_mozilla_page_load_details 09:20:39 INFO - PID 3513 | |i|pagename|runs| 09:20:39 INFO - PID 3513 | |0;dojo.html;2697.029069534967;2716.456708658269;2737.9726202737966;2748.491529067123;2750.1612008337447;5172.3793144822575;5213.973930130344;5215.92176117358;5230.293910322105;5281.471852814717;5185.922211166826;5231.424543300234;5240.187770895517;5324.65389749666;5336.38631557371;4360.489637138584;4647.14027904837;4650.395448591678;4674.509176536466;4692.7653617319165;4684.812607495696;4743.217369134089;4749.311349854269;4755.334253204554;4787.473377928425;4599.954000460019;4600.447946246439;4646.767661616906;4651.232546629802;4685.1566717990745;4641.651876109306;4643.674942754009;4682.976585117087;4685.835995740167;4723.952760472385;4557.567031132037;4614.9077018459775;4625.7687115644085;4630.58324750774;4687.20317546018;5091.770870310845;5168.741562921877;5177.301064356301;5191.662541934762;5211.947880521222;5629.746661400247;5672.716364181816;5710.2862142232225;5719.513841323493;5744.913826292609;5678.687672178028;5693.857653558653;5697.6011679182475;5697.800576979786;5714.200011998282;5189.792408303626;5279.656822306538;5290;5293.3647962244;5347.598930080259;5722.914156287659;5770.6249093808765;5839.941600584025;5849.034909240013;5857.853553661107;5531.225628412026;5537.2524709163745;5539.390667026624;5583.078791999355;5600.159976003551;5451.127819548853;5529.142982837667;5555.638883472561;5572.3034620672415;5579.469950354791;5470.671759694431;5534.142207957773;5538.806141785019;5594.468525490072;5650.5479561634975;5573.944260557424;5616.887662246732;5640.069388550925;5662.037453632893;5691.943080569141;4764.4282686077195;4777.522247775195;4780.378550788445;4789.30555069513;4822.890735130869;4020.979895100564;4069.4099355593867;4078.7144899857317;4080.7755573443746;4087.734297270668;4780.641451891122;4810.7835147418455;4839.540243676845;4850.417949846041;4857.732824694675;5676.489115979582;5717.399673034354;5730.255066841367;5772.826815195551;5787;4820.734859582757;4836.903261934742;4843.830465933675;4859.3682821233015;4888.2178851383605;4968.8757781055765;5023.773930173151;5026.220935754891;5078.822241221539;5080.822171223989;5263.736813159403;5268.947310526845;5277.815276465305;5278.129108697022;5286.286351342519;5639.125935480007;5644.491995720405;5645.9153112702525;5727.140928860705;5750.30996280449;5264.499872512105;5338.172583249602;5344.331958505187;5348.705821179872;5374.435684253097;5564.554835613222;5592.7762889483965;5609.719514024364;5626.071698169756;5657.32112146545;5575.776968921197;5651.745671444877;5659.745311460912;5702.657840529581;5732.742026608729;5464.781408743605;5489.258950041693;5500.477454641803;5510.9448905510435;5518.917216241679;5424.674519528841;5490.396056433869;5498.340199176125;5509.807156749494;5552.083906155601;5266.210068489757;5309.283246761638;5390.218418329242;5404.891902162013;5425.13197888336;5520.503154716095;5553.777848885999;5564.888702225851;5573.5819813513335;5576.358718747396;5388;5402.567794576503;5405.297311349499;5408.513233808976;5421.322334708161 09:20:39 INFO - PID 3513 | |1;ext.html;608.8173547935621;658.7430901948239;678.2268214235772;1111.4498323329954;1116.1405717597456;35040.64959350406;35760.821195894016;35768.642313576885;35789.46315805265;35864.641353586456;32435.351292974185;32806;32895.1776205595;32921.353932303406;32923.67076329236;6464.191976003;6877.587344759306;7006.054182685349;7014.964925175367;7032.8945065824055;7010.684519196649;7035.824104397379;7075.752348667797;7098.929010709879;7110.431165506773;7070.964645176793;7113.1464224292895;7114.28857114287;7145.035420218282;7152.213256541776;7095.184053833797;7104.964475177642;7132.286771322878;7137.2149063602965;7142.535735177197;6980.825479363006;7029.051078104492;7040.084788977451;7045.929540704578;7046.224915259318;32065;32092.518612220836;32095.679043209504;32299.677003229903;32314;3003.414334204831;3018.517037274026;3028.37918226763;3028.6214223222096;3037.4684430224843;24465.87767061171;24606.630900536507;24629.137980170788;24727.752722472724;24856.87571562149;3148.5277208418693;3163.715265626082;3168.98415507921;3175.22207059272;3176.1583180457196;141781;141931;142406;152619;158688;39611.60388396137;39674;39745.40381894274;39850.40224396636;39973;41703.7914810424;41795.79102104531;44195.77902110533;44785.55214447879;45056.3241551377;11473.598424055119;11482.138839587064;11553.942230288794;11570.710732231762;11600.65198044043;8808.647654093893;8849.734507964771;8887.644494220289;8891.4665120093;8896.911030889738;13000.739985200244;13091.279979601213;13093.541726039733;13146.802797958038;13283;5283.524482796567;5491.590783078665;5494.395616482184;5517.089680202802;5540.390557038722;855.8031652719909;897.3449381951212;900.7658008917598;935.2938531408879;938.779386844091;20081.59836803256;21124.683129753066;21245.256416025364;21583.568328633653;22089.33731988043;963.0850691842777;969.345691658128;990.0990099009866;991.7024892532212;995.4375777685584;11192.216544841784;11281.605143819927;11468.254563453516;11475.483603237873;11476.770464590662;178227;179324.10337948226;179431.10284448494;179788;180025.09987449978;40522;40636.79681601573;40706.38940415896;40818.79590602028;40939.385909211385;1171.2035815645443;1215.2890559022894;1215.8905698487179;1218.5674085699627;1222.6698791326469;19534.804651953866;20017.499562511053;20297.89851050735;20699.793002069786;20777.64945278552;28891.711082889742;29045.7095429043;29106.854465728382;29158.416831662824;29161;144523;144926;145088;145141;145498;29196.56205156967;29345.85327073351;29463.26341841471;29484.968026118982;30599.388012240077;37044.814775925945;37268;37382.439263411616;37756.62243377531;37842.43236351512;26136.60795088113;27705.199162054403;27926;28345;28886;27217.72782272231;28271.575926361533;28926.276843079093;29035;29743.25641858971;30563;30835.84582077075;31164.37671246517;31443.528347074356;31458.370832583678;27110.457790843677;27203;27667.723322766513;27677.861610691816;27737.722622773515;20162.29431969874;22703.886480567493;22789.658155128018;22861.771382285966;22877.19929802449 09:20:39 INFO - PID 3513 | |2;jquery.html;391.006842619746;396.82539682539664;413.91100913303643;422.4149552869275;424.5245325235736;12731;17225.56936076599;17786.64426711465;18020.18909149088;18027.909860450694;17403.216855241513;17680;17709.911450442763;17751;17911.104444777775;5235.921461178085;5343.412224655294;5414.945850541503;5564.33228012637;5568.749406276727;5381.569474442055;5388.164834450667;5413.593980451462;5420.295361602986;5429.294191755066;5157.226416037587;5271.736413179345;5313.787448502075;5364.785408583672;5382.784688612451;5359.9732001339935;5398.649087809319;5405.783768649249;5410.729463526827;5419.295491586108;4827.396575428072;4907.852764417074;4916.778744956449;4930.704157750511;4965.627577931634;21870.78129218703;21875.78124218769;22132;22389.55220895589;22477;1665.5419759566096;1705.4968784208688;1716.2191203002728;1718.4672751447092;1718.6562687462558;14627.926860365737;14748.63128421798;15047.849521504755;15199.164045977466;15247.313870875838;2050.610384027045;2087.885166315852;2108.9578208435746;2115.8095771380495;2120;89936;91549;92497.53751231269;92991.07008929891;94586;10832.5125369357;10874.891251087545;10876.94561527203;11067.446627668745;11136.610218642309;14818.259087045604;15136.318865651072;15169.469068582768;15282.617934551503;15307.92346038285;6925.653717314114;7160.069191005136;7162.391196748231;7163.570185788869;7230.710771569184;6258.906116408258;6274.529410294246;6472.773452929125;6494.967525162344;6504.414602685781;6956.373926346653;7004.194517630538;7064.858702825914;7122.501424900207;7154.427645788324;2063.329417939146;2081.5212501124824;2108.746950365966;2126.797954194349;2204.6141925163033;844.923956843887;875.1336177184542;885.7431344910033;900.2887718702152;907.6550910653909;16409.343626255053;16540.255688494046;16652.084135372672;16663.50009499717;17241.82758172402;877.9824403511894;878.1876763993281;884.4914174349775;885.4333226734894;906.5150144672568;9004.189622933836;9073.95463022694;9360.812783744286;9455.432674039579;9513.571889265;374956;382876;386486;390413;391761;73423.7972860815;78231;79256;81499.5925020371;81963.18036819674;1079.9676009719722;1089.716673664837;1126.814075677504;1127.4869934180092;1130.796456637813;16595.751063734297;16948.745768813726;17317.74023389625;17561.12194390301;17653.911730441265;37907;38557.421638676;38726.61273387343;38830;39215;48737.75631121822;50835.49164508308;50953.745231273606;51556.22665659943;52691.73654131705;8033;8302.252797248277;8441.788955276168;8501.064882862756;8923.866142008004;13061.281629510468;13236.470541178245;13261.138026028277;13334.19994800315;13352.332383380986;10847.457627118454;10877;10904.78190436171;11001.1749118818;11350.54597816078;10742.355458672504;10776.030157285883;10877.836832447361;10899.891001090205;11156.665300041012;11242.943785281348;11418.200725949437;11502.48238829238;11899.82150267764;11933.284002959503;8334.708285209988;8386.916130838857;8452.873206902024;8517.44636598619;8632.956835215784;11148.442577871236;11230.382328971986;11258.66224013281;11621.6513504595;11657.067434605042 09:20:39 INFO - PID 3513 | |3;mootools.html;1248.2073883084242;1315.8092076648886;1315.9802602960951;1318.8021796730495;1324.0665330941688;10232.2325825563;10342.276040677156;10639.148868090553;10666.146708263339;10666.253362264644;10417.479126043687;10593.629222977197;10598.841017384726;10708.73228169296;10715;2233.1179184222265;2259.062489067035;2260.6156953317977;2281.589313923493;2287.931362059141;2178.9891050544725;2207.9448013799624;2224.7219097612797;2238.7761223877565;2243.9775602244013;2185.803277705006;2191;2219.7336319641668;2224.232639739287;2227.676986836908;2045.6829191475272;2063.649179639465;2064.566441047374;2070.140891530013;2070.472029632434;1992.7010948357718;2057.5164836263466;2099.3072286145534;2111.102781317934;2112.26070875194;10477.26659133861;10578.153747700166;10584.206184536191;10588.258821882471;10600.310979786289;5534.778608855681;5722.427757224286;5733.082706766897;5734;5755.740991655385;3161.7470602351755;3392.8133952632597;3424.623291437965;3453.8445769940413;3473.878414255514;1077.175960390302;1089.455272363818;1117.1118960426481;1120.7254222715405;1123.3933675815051;15035.097894126278;15289.694206115926;15301.311440985182;15315.157666328347;15344.616384590363;4825.5174482551465;4968.683298925787;5091.363579552556;5096.643234973516;5109.591232701375;12691.746165076647;12730.108892377444;12745.04412169091;12768.233905965672;12800.359982000862;5748.770049197985;5756.7121643917635;5776.68228247442;5789.913151302734;5812.447817457335;4899.58353539946;4913.06651736169;4952.430470495867;5093.286939828427;5199.168133098761;4109.198706252312;4180.372944058355;4237.449131612932;4238.978805105955;4319.33050377192;1301.4729034740944;1336.672515233774;1342.9059965802496;1355.8779709826163;1372.7460419822364;664.3323459922747;690.6822861483773;692.4944790303007;704.2218348724585;713.8251128473557;5202.73986300691;5257.684538927677;5259.658122222043;5446.455354464601;5484.478974497416;523.5026724611635;533.751805410486;535.5019831556612;535.6223862177155;820.1880138662681;3546.4927405852927;3606.74752767309;3610.205754733954;3666.7066634669163;3741.85032598693;13050.216986980811;13436.261005644783;13492.257925813978;13493.932530337483;13770.449182032606;13089.738205236032;13454;13537.323133843269;13732.725345493234;13754.724905502035;7457.440691948017;7567.432442566719;7569.091708994956;7666.425018123663;7953.920460795318;5932.673702946379;5955.225820643289;5993.430624090704;6076;6204.689765511796;11770.764584708086;12050.939745301217;12147.088968327587;12332.691682708004;12357.814632780695;11966.58116965902;12257.448414821176;12356.691082723004;12430.69477704828;12446.502139914664;8320.292775114183;8416.495010299157;8531.53076580794;8531.658733650584;8546.658133674584;9207.631694732136;9318.254539636948;9418.62325506972;9430.858537122085;9438.244940404615;7646.8088297793;7861.960690196513;7904.20957904205;8016.7194148204535;8105.311048560939;7420.888686669812;7623.69505219785;7638.465307428427;7845.882311765214;7873.724419645285;7197.640117993975;7257.419406447577;7266.183454136466;7313.268673132857;7344.926550734424;5023.824166154167;5067.746612669425;5247.7113758743635;5272.182811664198;5361.865953351197;5184.922226166535;5263.447338029605;5312.654677445954;5324.920126198188;5387.595930305164 09:20:39 INFO - PID 3513 | |4;prototype.html;363.2227034146926;378.68379902781174;380.6345907928389;382.6020938224247;385.51810237203495;5370;5527.309086364205;5531.087370583854;5556.111022236438;5597.58018148639;5291.947080529194;5373.81191658292;5390.380106287778;5404.405515393303;5418.133098704208;4064.4758215669126;4074.449949256857;4077.1234184650293;4078.306687863063;4078.7348822326453;3904.316744569703;4036.1725846201457;4039.1921615676833;4063.5326937402283;4084.611961863633;3997.060690737674;4002.9985007496252;4016.6385025347713;4022.215667944752;4027.0536423940353;3999.520057593093;4012.3379642358977;4012.518497780285;4023.3361495353233;4035.495563054633;3511.7015053720465;3514.6661067198575;3527.5414196154593;3529.2412131391875;3544.503769472276;5258.737063146866;5277.967982326793;5311.415744268127;5321.255024296602;5333.546648534879;4741.170295198326;4752.287156926454;4762.499937506546;4764.976175119137;4766.261229509431;5603.439656034405;5692.77228910843;5697.373288938214;5708.7145642718115;5708.942910570924;3861.092643228839;3930.921381572381;3934.4098385242155;3947;3951.3282741933654;5928.7628494860155;6005.249343832021;6055.394460553954;6066.575339726221;6069.119977603267;4024.9195016099516;4027.7180597357906;4035.5762644922447;4040.474738284004;4041.6766658667234;4093.89765255871;4101.036256479725;4104.671626269951;4109.97945010279;4113.362428823537;4667.719936803803;4732.621390288768;4743.193657078305;4743.857684269477;4745.145873742759;5691.601587888808;5705.5150312223095;5711.8857622848145;5721.199032135504;5750.539956803529;1405.3605609447677;1412.442085376291;1412.6468382904275;1413.4558195094962;1414.9575512734634;897.228383590112;934.6588495199203;937.3953799799092;946.9857952130724;947.9241061395365;5049.2173713074535;5056.292119103328;5057.999999999926;5061.519155680278;5070.822521211814;5970.402959703995;5970.641761494324;5983.730732116978;5985.653228023747;6002.429769171922;4884.3161957326;4994.875128121754;5014.84955451337;5037.395512538519;5039.319691841554;3155.0027473899886;3171.63526194486;3175.6824317568057;3177.221580712694;3185.87256509737;5413.431589683105;5542.584306177053;5548.4174161712435;5548.833534993957;5550.195221692832;6021.337652858182;6072.05883088122;6089.634621922699;6089.786857459968;6103.023516237381;5522.171674248895;5522.355245538006;5532.391436942014;5539.529140023063;5547.750351234124;5898.469137777621;5939.851503712269;5942.286925568959;5942.73257703413;5969.164316995537;5830.970845145747;5860.267466566679;5874.676892770768;5875.471207591338;5880.852978675567;5389.784408623768;5546.140348246028;5560.165975103605;5578.884223155466;5586.413426590149;4011.498562679665;4056.290149223815;4067.4102255173425;4074.083331250445;4080.8367665293054;5947.226860508106;5961.821145365646;6042.456178943916;6043.395660433922;6056.424639659225;5776.42235776419;5783.566232532661;5807.303123625192;5815.709214539172;5830.358660547252;5688.971555142198;5768;5768.913466297925;5771.134329850556;5780.248567686174;5443.646162999393;5627.521660658726;5674.546036317167;5683.715814209356;5702.743376547983;5834.7082645866685;5836.124581312837;5838.854028649318;5847.883042339045;5869.266341707286;5544.695041772741;5643.858903527444;5738.885222295447;5746.856328591652;5750.539956803362 09:20:39 INFO - PID 3513 | |5;yui.html;695.5513693667581;705.6189657584904;710.6517806274927;719.9028131202286;723.4682508356359;11721.941390293046;12195.390230488485;12228.327441990687;14477.85522144781;14917.403303867859;14444.277786110679;14552.708945821078;14774;14783.482578109768;14831.258437078157;847.9703210387638;871.1680345270283;873.4104479476359;875.8598624220094;877.4340550345023;918.2699753695795;918.4030380252856;919.6781126605702;926.4996901673122;930.16285343191;965.0687086961082;968.6416026070328;969.4910172159603;969.5200875566569;971.4268581536892;943.5942544705774;952.7903861150536;956.9234461243084;965.6234068713172;966.6520052780993;705.0974752317043;705.2031204738613;705.6365971524668;709.6912842913349;710.765447402356;13210.33948302581;13441;13522.459101635923;13651.38568764408;13851.792223116661;14349.426022959069;14495.27523623825;14551.345189466394;14649.267536623127;14690;11661.883381166164;11702;11788.882111178864;11861.584844530485;11864.940675296655;2887.6823549409546;2891.927701807451;2907.549329853876;2909.330853903593;2918.751906087964;68713;69300;69491.65254173697;69790.65104674496;71267.64366178188;10971.945140274247;11683.941580292214;11694.181407301578;11738;11864.644060678194;18863.24547018104;19387.127579258966;19590.118444670024;19590.412287631392;20423.183072676926;5938.851528711817;6113.327533971348;6201.193844800147;6337.588056776295;6379.298277189506;2977.285451491626;3018.622672165979;3049.390121975614;3054.633443986736;3059.2198989257595;3362.503685859818;3440.0367896988882;3440.552728145325;3454.4300190468794;3457.101153700006;718.8785494628293;724.5471580262337;728.9015982842249;734.0640683129053;735.8123678461958;577.9942200578024;581.5899790647584;588.0913987888722;588.1383772772908;607.7599348257413;9069.727908162766;9139.857517810273;9187.724368268962;9202.125798049176;9674.516274186262;579.3308728418683;586.762361243697;600.8708127752467;603.2218438214742;610.3804638292137;3945.506811648544;4161.91904047976;4248.575142485726;4260.10537787062;4267.509236437787;55472.72263638737;57836.71081644565;58125.709371452875;58507.24478265659;59830;50380.24429633485;51817.7409112952;52519.47480525222;52873;53359;46704;47793.76103119462;48628.513714863104;49061.26408103881;49585.75207124013;8564.314854811724;8711.303095752199;8879.156480134377;8973.7756556084;9161.633534658538;24979.125730599342;25073.623895641944;25133.120340788715;25326;25520.872395638646;29977;30358.84820575883;30397.696023039487;31040.379192415574;31527.684723152473;11244.437778111225;11362.54549817998;11440.084793216356;11546.59586914454;11680.649580512598;12355.320457374572;12514.124011319484;12542.686432839251;12644.810327844905;12766.297853617769;11463;11584.304941703525;11629.534818607499;11690.298582085103;11778.234414763014;11381.374024428736;11382.829257561309;11384.943075284571;11509.194356394972;11603.361815099914;10990.945045275043;11189.72025699364;11195.10439164881;12997.285149316878;13508.729825403241;8883.555822208735;9116.36185467011;9133.954330228573;9221.308401870021;9415.952920235355;10515.369077855354;10983.340999540053;11153.21927465102;11197.44012799373;11241.213115082193 09:20:39 INFO - PID 3513 | __end_tp_report 09:20:39 INFO - PID 3513 | __start_cc_report 09:20:39 INFO - PID 3513 | _x_x_mozilla_cycle_collect,379 09:20:39 INFO - PID 3513 | __end_cc_report 09:20:39 INFO - PID 3513 | __startTimestamp1494606039283__endTimestamp 09:20:39 INFO - PID 3513 | 09:20:39 INFO - PID 3513 | ------- Summary: start ------- 09:20:39 INFO - PID 3513 | Number of tests: 6 09:20:39 INFO - PID 3513 | 09:20:39 INFO - PID 3513 | [#0] dojo.html Cycles:165 Average:5170.41 Median:5338.17 stddev:607.23 (11.4%) stddev-sans-first:577.26 09:20:39 INFO - PID 3513 | Values: 2697.0 2716.5 2738.0 2748.5 2750.2 5172.4 5214.0 5215.9 5230.3 5281.5 5185.9 5231.4 5240.2 5324.7 5336.4 4360.5 4647.1 4650.4 4674.5 4692.8 4684.8 4743.2 4749.3 4755.3 4787.5 4600.0 4600.4 4646.8 4651.2 4685.2 4641.7 4643.7 4683.0 4685.8 4724.0 4557.6 4614.9 4625.8 4630.6 4687.2 5091.8 5168.7 5177.3 5191.7 5211.9 5629.7 5672.7 5710.3 5719.5 5744.9 5678.7 5693.9 5697.6 5697.8 5714.2 5189.8 5279.7 5290.0 5293.4 5347.6 5722.9 5770.6 5839.9 5849.0 5857.9 5531.2 5537.3 5539.4 5583.1 5600.2 5451.1 5529.1 5555.6 5572.3 5579.5 5470.7 5534.1 5538.8 5594.5 5650.5 5573.9 5616.9 5640.1 5662.0 5691.9 4764.4 4777.5 4780.4 4789.3 4822.9 4021.0 4069.4 4078.7 4080.8 4087.7 4780.6 4810.8 4839.5 4850.4 4857.7 5676.5 5717.4 5730.3 5772.8 5787.0 4820.7 4836.9 4843.8 4859.4 4888.2 4968.9 5023.8 5026.2 5078.8 5080.8 5263.7 5268.9 5277.8 5278.1 5286.3 5639.1 5644.5 5645.9 5727.1 5750.3 5264.5 5338.2 5344.3 5348.7 5374.4 5564.6 5592.8 5609.7 5626.1 5657.3 5575.8 5651.7 5659.7 5702.7 5732.7 5464.8 5489.3 5500.5 5510.9 5518.9 5424.7 5490.4 5498.3 5509.8 5552.1 5266.2 5309.3 5390.2 5404.9 5425.1 5520.5 5553.8 5564.9 5573.6 5576.4 5388.0 5402.6 5405.3 5408.5 5421.3 09:20:39 INFO - PID 3513 | 09:20:39 INFO - PID 3513 | [#1] ext.html Cycles:180 Average:30327.52 Median:31450.95 stddev:40814.11 (129.8%) stddev-sans-first:40867.60 09:20:39 INFO - PID 3513 | Values: 608.8 658.7 678.2 1111.4 1116.1 35040.6 35760.8 35768.6 35789.5 35864.6 32435.4 32806.0 32895.2 32921.4 32923.7 6464.2 6877.6 7006.1 7015.0 7032.9 7010.7 7035.8 7075.8 7098.9 7110.4 7071.0 7113.1 7114.3 7145.0 7152.2 7095.2 7105.0 7132.3 7137.2 7142.5 6980.8 7029.1 7040.1 7045.9 7046.2 32065.0 32092.5 32095.7 32299.7 32314.0 3003.4 3018.5 3028.4 3028.6 3037.5 24465.9 24606.6 24629.1 24727.8 24856.9 3148.5 3163.7 3169.0 3175.2 3176.2 141781.0 141931.0 142406.0 152619.0 158688.0 39611.6 39674.0 39745.4 39850.4 39973.0 41703.8 41795.8 44195.8 44785.6 45056.3 11473.6 11482.1 11553.9 11570.7 11600.7 8808.6 8849.7 8887.6 8891.5 8896.9 13000.7 13091.3 13093.5 13146.8 13283.0 5283.5 5491.6 5494.4 5517.1 5540.4 855.8 897.3 900.8 935.3 938.8 20081.6 21124.7 21245.3 21583.6 22089.3 963.1 969.3 990.1 991.7 995.4 11192.2 11281.6 11468.3 11475.5 11476.8 178227.0 179324.1 179431.1 179788.0 180025.1 40522.0 40636.8 40706.4 40818.8 40939.4 1171.2 1215.3 1215.9 1218.6 1222.7 19534.8 20017.5 20297.9 20699.8 20777.6 28891.7 29045.7 29106.9 29158.4 29161.0 144523.0 144926.0 145088.0 145141.0 145498.0 29196.6 29345.9 29463.3 29485.0 30599.4 37044.8 37268.0 37382.4 37756.6 37842.4 26136.6 27705.2 27926.0 28345.0 28886.0 27217.7 28271.6 28926.3 29035.0 29743.3 30563.0 30835.8 31164.4 31443.5 31458.4 27110.5 27203.0 27667.7 27677.9 27737.7 20162.3 22703.9 22789.7 22861.8 22877.2 09:20:39 INFO - PID 3513 | 09:20:39 INFO - PID 3513 | [#2] jquery.html Cycles:180 Average:25506.11 Median:38778.31 stddev:64157.68 (165.4%) stddev-sans-first:64309.95 09:20:39 INFO - PID 3513 | Values: 391.0 396.8 413.9 422.4 424.5 12731.0 17225.6 17786.6 18020.2 18027.9 17403.2 17680.0 17709.9 17751.0 17911.1 5235.9 5343.4 5414.9 5564.3 5568.7 5381.6 5388.2 5413.6 5420.3 5429.3 5157.2 5271.7 5313.8 5364.8 5382.8 5360.0 5398.6 5405.8 5410.7 5419.3 4827.4 4907.9 4916.8 4930.7 4965.6 21870.8 21875.8 22132.0 22389.6 22477.0 1665.5 1705.5 1716.2 1718.5 1718.7 14627.9 14748.6 15047.8 15199.2 15247.3 2050.6 2087.9 2109.0 2115.8 2120.0 89936.0 91549.0 92497.5 92991.1 94586.0 10832.5 10874.9 10876.9 11067.4 11136.6 14818.3 15136.3 15169.5 15282.6 15307.9 6925.7 7160.1 7162.4 7163.6 7230.7 6258.9 6274.5 6472.8 6495.0 6504.4 6956.4 7004.2 7064.9 7122.5 7154.4 2063.3 2081.5 2108.7 2126.8 2204.6 844.9 875.1 885.7 900.3 907.7 16409.3 16540.3 16652.1 16663.5 17241.8 878.0 878.2 884.5 885.4 906.5 9004.2 9074.0 9360.8 9455.4 9513.6 374956.0 382876.0 386486.0 390413.0 391761.0 73423.8 78231.0 79256.0 81499.6 81963.2 1080.0 1089.7 1126.8 1127.5 1130.8 16595.8 16948.7 17317.7 17561.1 17653.9 37907.0 38557.4 38726.6 38830.0 39215.0 48737.8 50835.5 50953.7 51556.2 52691.7 8033.0 8302.3 8441.8 8501.1 8923.9 13061.3 13236.5 13261.1 13334.2 13352.3 10847.5 10877.0 10904.8 11001.2 11350.5 10742.4 10776.0 10877.8 10899.9 11156.7 11242.9 11418.2 11502.5 11899.8 11933.3 8334.7 8386.9 8452.9 8517.4 8633.0 11148.4 11230.4 11258.7 11621.7 11657.1 09:20:39 INFO - PID 3513 | 09:20:39 INFO - PID 3513 | [#3] mootools.html Cycles:180 Average:6385.08 Median:3576.62 stddev:4175.05 (116.7%) stddev-sans-first:4168.92 09:20:39 INFO - PID 3513 | Values: 1248.2 1315.8 1316.0 1318.8 1324.1 10232.2 10342.3 10639.1 10666.1 10666.3 10417.5 10593.6 10598.8 10708.7 10715.0 2233.1 2259.1 2260.6 2281.6 2287.9 2179.0 2207.9 2224.7 2238.8 2244.0 2185.8 2191.0 2219.7 2224.2 2227.7 2045.7 2063.6 2064.6 2070.1 2070.5 1992.7 2057.5 2099.3 2111.1 2112.3 10477.3 10578.2 10584.2 10588.3 10600.3 5534.8 5722.4 5733.1 5734.0 5755.7 3161.7 3392.8 3424.6 3453.8 3473.9 1077.2 1089.5 1117.1 1120.7 1123.4 15035.1 15289.7 15301.3 15315.2 15344.6 4825.5 4968.7 5091.4 5096.6 5109.6 12691.7 12730.1 12745.0 12768.2 12800.4 5748.8 5756.7 5776.7 5789.9 5812.4 4899.6 4913.1 4952.4 5093.3 5199.2 4109.2 4180.4 4237.4 4239.0 4319.3 1301.5 1336.7 1342.9 1355.9 1372.7 664.3 690.7 692.5 704.2 713.8 5202.7 5257.7 5259.7 5446.5 5484.5 523.5 533.8 535.5 535.6 820.2 3546.5 3606.7 3610.2 3666.7 3741.9 13050.2 13436.3 13492.3 13493.9 13770.4 13089.7 13454.0 13537.3 13732.7 13754.7 7457.4 7567.4 7569.1 7666.4 7953.9 5932.7 5955.2 5993.4 6076.0 6204.7 11770.8 12050.9 12147.1 12332.7 12357.8 11966.6 12257.4 12356.7 12430.7 12446.5 8320.3 8416.5 8531.5 8531.7 8546.7 9207.6 9318.3 9418.6 9430.9 9438.2 7646.8 7862.0 7904.2 8016.7 8105.3 7420.9 7623.7 7638.5 7845.9 7873.7 7197.6 7257.4 7266.2 7313.3 7344.9 5023.8 5067.7 5247.7 5272.2 5361.9 5184.9 5263.4 5312.7 5324.9 5387.6 09:20:39 INFO - PID 3513 | 09:20:39 INFO - PID 3513 | [#4] prototype.html Cycles:180 Average:4722.17 Median:5408.92 stddev:1419.68 (26.2%) stddev-sans-first:1385.45 09:20:39 INFO - PID 3513 | Values: 363.2 378.7 380.6 382.6 385.5 5370.0 5527.3 5531.1 5556.1 5597.6 5291.9 5373.8 5390.4 5404.4 5418.1 4064.5 4074.4 4077.1 4078.3 4078.7 3904.3 4036.2 4039.2 4063.5 4084.6 3997.1 4003.0 4016.6 4022.2 4027.1 3999.5 4012.3 4012.5 4023.3 4035.5 3511.7 3514.7 3527.5 3529.2 3544.5 5258.7 5278.0 5311.4 5321.3 5333.5 4741.2 4752.3 4762.5 4765.0 4766.3 5603.4 5692.8 5697.4 5708.7 5708.9 3861.1 3930.9 3934.4 3947.0 3951.3 5928.8 6005.2 6055.4 6066.6 6069.1 4024.9 4027.7 4035.6 4040.5 4041.7 4093.9 4101.0 4104.7 4110.0 4113.4 4667.7 4732.6 4743.2 4743.9 4745.1 5691.6 5705.5 5711.9 5721.2 5750.5 1405.4 1412.4 1412.6 1413.5 1415.0 897.2 934.7 937.4 947.0 947.9 5049.2 5056.3 5058.0 5061.5 5070.8 5970.4 5970.6 5983.7 5985.7 6002.4 4884.3 4994.9 5014.8 5037.4 5039.3 3155.0 3171.6 3175.7 3177.2 3185.9 5413.4 5542.6 5548.4 5548.8 5550.2 6021.3 6072.1 6089.6 6089.8 6103.0 5522.2 5522.4 5532.4 5539.5 5547.8 5898.5 5939.9 5942.3 5942.7 5969.2 5831.0 5860.3 5874.7 5875.5 5880.9 5389.8 5546.1 5560.2 5578.9 5586.4 4011.5 4056.3 4067.4 4074.1 4080.8 5947.2 5961.8 6042.5 6043.4 6056.4 5776.4 5783.6 5807.3 5815.7 5830.4 5689.0 5768.0 5768.9 5771.1 5780.2 5443.6 5627.5 5674.5 5683.7 5702.7 5834.7 5836.1 5838.9 5847.9 5869.3 5544.7 5643.9 5738.9 5746.9 5750.5 09:20:39 INFO - PID 3513 | 09:20:39 INFO - PID 3513 | [#5] yui.html Cycles:180 Average:14084.22 Median:4053.71 stddev:16979.11 (418.9%) stddev-sans-first:16996.97 09:20:39 INFO - PID 3513 | Values: 695.6 705.6 710.7 719.9 723.5 11721.9 12195.4 12228.3 14477.9 14917.4 14444.3 14552.7 14774.0 14783.5 14831.3 848.0 871.2 873.4 875.9 877.4 918.3 918.4 919.7 926.5 930.2 965.1 968.6 969.5 969.5 971.4 943.6 952.8 956.9 965.6 966.7 705.1 705.2 705.6 709.7 710.8 13210.3 13441.0 13522.5 13651.4 13851.8 14349.4 14495.3 14551.3 14649.3 14690.0 11661.9 11702.0 11788.9 11861.6 11864.9 2887.7 2891.9 2907.5 2909.3 2918.8 68713.0 69300.0 69491.7 69790.7 71267.6 10971.9 11683.9 11694.2 11738.0 11864.6 18863.2 19387.1 19590.1 19590.4 20423.2 5938.9 6113.3 6201.2 6337.6 6379.3 2977.3 3018.6 3049.4 3054.6 3059.2 3362.5 3440.0 3440.6 3454.4 3457.1 718.9 724.5 728.9 734.1 735.8 578.0 581.6 588.1 588.1 607.8 9069.7 9139.9 9187.7 9202.1 9674.5 579.3 586.8 600.9 603.2 610.4 3945.5 4161.9 4248.6 4260.1 4267.5 55472.7 57836.7 58125.7 58507.2 59830.0 50380.2 51817.7 52519.5 52873.0 53359.0 46704.0 47793.8 48628.5 49061.3 49585.8 8564.3 8711.3 8879.2 8973.8 9161.6 24979.1 25073.6 25133.1 25326.0 25520.9 29977.0 30358.8 30397.7 31040.4 31527.7 11244.4 11362.5 11440.1 11546.6 11680.6 12355.3 12514.1 12542.7 12644.8 12766.3 11463.0 11584.3 11629.5 11690.3 11778.2 11381.4 11382.8 11384.9 11509.2 11603.4 10990.9 11189.7 11195.1 12997.3 13508.7 8883.6 9116.4 9134.0 9221.3 9416.0 10515.4 10983.3 11153.2 11197.4 11241.2 09:20:39 INFO - PID 3513 | -------- Summary: end -------- 09:20:39 INFO - PID 3513 | 09:20:40 INFO - TEST-INFO | 3513: exit 0 09:20:40 INFO - TEST-OK | dromaeo_css | took 1121189ms 09:20:40 INFO - TEST-START | kraken 09:20:40 INFO - operating with platform_type : linux_ 09:20:40 INFO - Initialising browser for kraken test... 09:20:40 INFO - TEST-INFO | started process 3948 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_Olb2P/profile http://localhost:49233/getInfo.html) 09:20:44 INFO - PID 3948 | __metrics Screen width/height:1600/1200 09:20:44 INFO - PID 3948 | colorDepth:24 09:20:44 INFO - PID 3948 | Browser inner width/height: 1024/695 09:20:44 INFO - PID 3948 | __metrics 09:20:46 INFO - TEST-INFO | 3948: exit 0 09:20:46 INFO - Browser initialized. 09:20:46 INFO - Running cycle 1/1 for kraken test... 09:20:46 INFO - TEST-INFO | started process 4137 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_Olb2P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:20:58 INFO - PID 4137 | RSS: Main: 167194624 09:20:58 INFO - PID 4137 | 09:21:01 INFO - PID 4137 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49233/tests/kraken/driver.html?testName=audio-beat-detection) 09:21:02 INFO - PID 4137 | RSS: Main: 177987584 09:21:02 INFO - PID 4137 | 09:21:05 INFO - PID 4137 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49233/tests/kraken/driver.html?testName=audio-dft) 09:21:05 INFO - PID 4137 | RSS: Main: 177094656 09:21:05 INFO - PID 4137 | 09:21:08 INFO - PID 4137 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49233/tests/kraken/driver.html?testName=audio-fft) 09:21:09 INFO - PID 4137 | RSS: Main: 174641152 09:21:09 INFO - PID 4137 | 09:21:11 INFO - PID 4137 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49233/tests/kraken/driver.html?testName=audio-oscillator) 09:21:12 INFO - PID 4137 | RSS: Main: 175271936 09:21:12 INFO - PID 4137 | 09:21:14 INFO - PID 4137 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49233/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:21:14 INFO - PID 4137 | RSS: Main: 176812032 09:21:14 INFO - PID 4137 | 09:21:17 INFO - PID 4137 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49233/tests/kraken/driver.html?testName=imaging-darkroom) 09:21:18 INFO - PID 4137 | RSS: Main: 178970624 09:21:18 INFO - PID 4137 | 09:21:22 INFO - PID 4137 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49233/tests/kraken/driver.html?testName=imaging-desaturate) 09:21:22 INFO - PID 4137 | RSS: Main: 178724864 09:21:22 INFO - PID 4137 | 09:21:25 INFO - PID 4137 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49233/tests/kraken/driver.html?testName=json-parse-financial) 09:21:26 INFO - PID 4137 | RSS: Main: 180604928 09:21:26 INFO - PID 4137 | 09:21:28 INFO - PID 4137 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49233/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:21:28 INFO - PID 4137 | RSS: Main: 181620736 09:21:28 INFO - PID 4137 | 09:21:30 INFO - PID 4137 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49233/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:21:31 INFO - PID 4137 | RSS: Main: 181813248 09:21:31 INFO - PID 4137 | 09:21:33 INFO - PID 4137 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49233/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:21:33 INFO - PID 4137 | RSS: Main: 182050816 09:21:33 INFO - PID 4137 | 09:21:36 INFO - PID 4137 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49233/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:21:37 INFO - PID 4137 | RSS: Main: 181788672 09:21:37 INFO - PID 4137 | 09:21:40 INFO - PID 4137 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49233/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:21:41 INFO - PID 4137 | RSS: Main: 181673984 09:21:41 INFO - PID 4137 | 09:21:42 INFO - PID 4137 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49233/tests/kraken/driver.html?testName=ai-astar) 09:21:43 INFO - PID 4137 | RSS: Main: 183816192 09:21:43 INFO - PID 4137 | 09:21:43 INFO - PID 4137 | __start_tp_report 09:21:43 INFO - PID 4137 | _x_x_mozilla_page_load 09:21:43 INFO - PID 4137 | _x_x_mozilla_page_load_details 09:21:43 INFO - PID 4137 | |i|pagename|runs| 09:21:43 INFO - PID 4137 | |0;ai-astar;103;113;112;111;111;116;113;112;113;113 09:21:43 INFO - PID 4137 | |1;audio-beat-detection;152;122;123;178;133;127;124;121;154;124 09:21:43 INFO - PID 4137 | |2;audio-dft;164;164;161;164;180;174;164;164;163;166 09:21:43 INFO - PID 4137 | |3;audio-fft;77;75;76;103;75;75;77;74;100;75 09:21:43 INFO - PID 4137 | |4;audio-oscillator;83;83;119;84;83;83;107;84;82;101 09:21:43 INFO - PID 4137 | |5;imaging-gaussian-blur;114;115;115;114;114;114;118;114;114;117 09:21:43 INFO - PID 4137 | |6;imaging-darkroom;150;151;151;152;150;155;151;150;150;154 09:21:43 INFO - PID 4137 | |7;imaging-desaturate;94;95;96;95;94;94;94;95;94;94 09:21:43 INFO - PID 4137 | |8;json-parse-financial;55;61;54;55;55;57;59;58;56;62 09:21:43 INFO - PID 4137 | |9;json-stringify-tinderbox;56;56;55;54;56;56;56;56;56;56 09:21:43 INFO - PID 4137 | |10;stanford-crypto-aes;84;80;82;82;84;82;81;82;89;82 09:21:43 INFO - PID 4137 | |11;stanford-crypto-ccm;132;132;130;128;135;135;139;132;172;133 09:21:43 INFO - PID 4137 | |12;stanford-crypto-pbkdf2;190;189;196;196;191;191;196;189;197;183 09:21:43 INFO - PID 4137 | |13;stanford-crypto-sha256-iterative;78;74;74;78;76;73;74;77;73;72 09:21:43 INFO - PID 4137 | __end_tp_report 09:21:43 INFO - PID 4137 | __start_cc_report 09:21:43 INFO - PID 4137 | _x_x_mozilla_cycle_collect,841 09:21:43 INFO - PID 4137 | __end_cc_report 09:21:43 INFO - PID 4137 | __startTimestamp1494606103240__endTimestamp 09:21:43 INFO - PID 4137 | 09:21:43 INFO - PID 4137 | ------- Summary: start ------- 09:21:43 INFO - PID 4137 | Number of tests: 14 09:21:43 INFO - PID 4137 | 09:21:43 INFO - PID 4137 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:3.37 (3.0%) stddev-sans-first:1.50 09:21:43 INFO - PID 4137 | Values: 103.0 113.0 112.0 111.0 111.0 116.0 113.0 112.0 113.0 113.0 09:21:43 INFO - PID 4137 | 09:21:43 INFO - PID 4137 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:130.00 stddev:19.18 (14.8%) stddev-sans-first:19.43 09:21:43 INFO - PID 4137 | Values: 152.0 122.0 123.0 178.0 133.0 127.0 124.0 121.0 154.0 124.0 09:21:43 INFO - PID 4137 | 09:21:43 INFO - PID 4137 | [#2] audio-dft Cycles:10 Average:166.40 Median:164.00 stddev:5.89 (3.6%) stddev-sans-first:6.18 09:21:43 INFO - PID 4137 | Values: 164.0 164.0 161.0 164.0 180.0 174.0 164.0 164.0 163.0 166.0 09:21:43 INFO - PID 4137 | 09:21:43 INFO - PID 4137 | [#3] audio-fft Cycles:10 Average:80.70 Median:75.00 stddev:11.03 (14.7%) stddev-sans-first:11.61 09:21:43 INFO - PID 4137 | Values: 77.0 75.0 76.0 103.0 75.0 75.0 77.0 74.0 100.0 75.0 09:21:43 INFO - PID 4137 | 09:21:43 INFO - PID 4137 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:83.00 stddev:13.23 (15.9%) stddev-sans-first:13.72 09:21:43 INFO - PID 4137 | Values: 83.0 83.0 119.0 84.0 83.0 83.0 107.0 84.0 82.0 101.0 09:21:43 INFO - PID 4137 | 09:21:43 INFO - PID 4137 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:114.50 stddev:1.45 (1.3%) stddev-sans-first:1.50 09:21:43 INFO - PID 4137 | Values: 114.0 115.0 115.0 114.0 114.0 114.0 118.0 114.0 114.0 117.0 09:21:43 INFO - PID 4137 | 09:21:43 INFO - PID 4137 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:151.00 stddev:1.78 (1.2%) stddev-sans-first:1.81 09:21:43 INFO - PID 4137 | Values: 150.0 151.0 151.0 152.0 150.0 155.0 151.0 150.0 150.0 154.0 09:21:43 INFO - PID 4137 | 09:21:43 INFO - PID 4137 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 09:21:43 INFO - PID 4137 | Values: 94.0 95.0 96.0 95.0 94.0 94.0 94.0 95.0 94.0 94.0 09:21:43 INFO - PID 4137 | 09:21:43 INFO - PID 4137 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.50 stddev:2.74 (4.8%) stddev-sans-first:2.79 09:21:43 INFO - PID 4137 | Values: 55.0 61.0 54.0 55.0 55.0 57.0 59.0 58.0 56.0 62.0 09:21:43 INFO - PID 4137 | 09:21:43 INFO - PID 4137 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:56.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 09:21:43 INFO - PID 4137 | Values: 56.0 56.0 55.0 54.0 56.0 56.0 56.0 56.0 56.0 56.0 09:21:43 INFO - PID 4137 | 09:21:43 INFO - PID 4137 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.00 stddev:2.49 (3.0%) stddev-sans-first:2.60 09:21:43 INFO - PID 4137 | Values: 84.0 80.0 82.0 82.0 84.0 82.0 81.0 82.0 89.0 82.0 09:21:43 INFO - PID 4137 | 09:21:43 INFO - PID 4137 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:134.00 stddev:12.73 (9.5%) stddev-sans-first:13.38 09:21:43 INFO - PID 4137 | Values: 132.0 132.0 130.0 128.0 135.0 135.0 139.0 132.0 172.0 133.0 09:21:43 INFO - PID 4137 | 09:21:43 INFO - PID 4137 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.80 Median:193.50 stddev:4.44 (2.3%) stddev-sans-first:4.66 09:21:43 INFO - PID 4137 | Values: 190.0 189.0 196.0 196.0 191.0 191.0 196.0 189.0 197.0 183.0 09:21:43 INFO - PID 4137 | 09:21:43 INFO - PID 4137 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:75.00 stddev:2.18 (2.9%) stddev-sans-first:2.01 09:21:43 INFO - PID 4137 | Values: 78.0 74.0 74.0 78.0 76.0 73.0 74.0 77.0 73.0 72.0 09:21:43 INFO - PID 4137 | -------- Summary: end -------- 09:21:43 INFO - PID 4137 | 09:21:44 INFO - TEST-INFO | 4137: exit 0 09:21:44 INFO - TEST-OK | kraken | took 64331ms 09:21:44 INFO - SUITE-END | took 1185s 09:21:44 INFO - Completed test suite (00:19:45) 09:21:44 INFO - javascript benchmark 09:21:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6644.770549753237, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2697.029069534967, 2716.456708658269, 2737.9726202737966, 2748.491529067123, 2750.1612008337447, 5172.3793144822575, 5213.973930130344, 5215.92176117358, 5230.293910322105, 5281.471852814717, 5185.922211166826, 5231.424543300234, 5240.187770895517, 5324.65389749666, 5336.38631557371, 4360.489637138584, 4647.14027904837, 4650.395448591678, 4674.509176536466, 4692.7653617319165, 4684.812607495696, 4743.217369134089, 4749.311349854269, 4755.334253204554, 4787.473377928425, 4599.954000460019, 4600.447946246439, 4646.767661616906, 4651.232546629802, 4685.1566717990745, 4641.651876109306, 4643.674942754009, 4682.976585117087, 4685.835995740167, 4723.952760472385, 4557.567031132037, 4614.9077018459775, 4625.7687115644085, 4630.58324750774, 4687.20317546018, 5091.770870310845, 5168.741562921877, 5177.301064356301, 5191.662541934762, 5211.947880521222, 5629.746661400247, 5672.716364181816, 5710.2862142232225, 5719.513841323493, 5744.913826292609, 5678.687672178028, 5693.857653558653, 5697.6011679182475, 5697.800576979786, 5714.200011998282, 5189.792408303626, 5279.656822306538, 5290.0, 5293.3647962244, 5347.598930080259, 5722.914156287659, 5770.6249093808765, 5839.941600584025, 5849.034909240013, 5857.853553661107, 5531.225628412026, 5537.2524709163745, 5539.390667026624, 5583.078791999355, 5600.159976003551, 5451.127819548853, 5529.142982837667, 5555.638883472561, 5572.3034620672415, 5579.469950354791, 5470.671759694431, 5534.142207957773, 5538.806141785019, 5594.468525490072, 5650.5479561634975, 5573.944260557424, 5616.887662246732, 5640.069388550925, 5662.037453632893, 5691.943080569141, 4764.4282686077195, 4777.522247775195, 4780.378550788445, 4789.30555069513, 4822.890735130869, 4020.979895100564, 4069.4099355593867, 4078.7144899857317, 4080.7755573443746, 4087.734297270668, 4780.641451891122, 4810.7835147418455, 4839.540243676845, 4850.417949846041, 4857.732824694675, 5676.489115979582, 5717.399673034354, 5730.255066841367, 5772.826815195551, 5787.0, 4820.734859582757, 4836.903261934742, 4843.830465933675, 4859.3682821233015, 4888.2178851383605, 4968.8757781055765, 5023.773930173151, 5026.220935754891, 5078.822241221539, 5080.822171223989, 5263.736813159403, 5268.947310526845, 5277.815276465305, 5278.129108697022, 5286.286351342519, 5639.125935480007, 5644.491995720405, 5645.9153112702525, 5727.140928860705, 5750.30996280449, 5264.499872512105, 5338.172583249602, 5344.331958505187, 5348.705821179872, 5374.435684253097, 5564.554835613222, 5592.7762889483965, 5609.719514024364, 5626.071698169756, 5657.32112146545, 5575.776968921197, 5651.745671444877, 5659.745311460912, 5702.657840529581, 5732.742026608729, 5464.781408743605, 5489.258950041693, 5500.477454641803, 5510.9448905510435, 5518.917216241679, 5424.674519528841, 5490.396056433869, 5498.340199176125, 5509.807156749494, 5552.083906155601, 5266.210068489757, 5309.283246761638, 5390.218418329242, 5404.891902162013, 5425.13197888336, 5520.503154716095, 5553.777848885999, 5564.888702225851, 5573.5819813513335, 5576.358718747396, 5388.0, 5402.567794576503, 5405.297311349499, 5408.513233808976, 5421.322334708161], "value": 5126.275990588559, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.8173547935621, 658.7430901948239, 678.2268214235772, 1111.4498323329954, 1116.1405717597456, 35040.64959350406, 35760.821195894016, 35768.642313576885, 35789.46315805265, 35864.641353586456, 32435.351292974185, 32806.0, 32895.1776205595, 32921.353932303406, 32923.67076329236, 6464.191976003, 6877.587344759306, 7006.054182685349, 7014.964925175367, 7032.8945065824055, 7010.684519196649, 7035.824104397379, 7075.752348667797, 7098.929010709879, 7110.431165506773, 7070.964645176793, 7113.1464224292895, 7114.28857114287, 7145.035420218282, 7152.213256541776, 7095.184053833797, 7104.964475177642, 7132.286771322878, 7137.2149063602965, 7142.535735177197, 6980.825479363006, 7029.051078104492, 7040.084788977451, 7045.929540704578, 7046.224915259318, 32065.0, 32092.518612220836, 32095.679043209504, 32299.677003229903, 32314.0, 3003.414334204831, 3018.517037274026, 3028.37918226763, 3028.6214223222096, 3037.4684430224843, 24465.87767061171, 24606.630900536507, 24629.137980170788, 24727.752722472724, 24856.87571562149, 3148.5277208418693, 3163.715265626082, 3168.98415507921, 3175.22207059272, 3176.1583180457196, 141781.0, 141931.0, 142406.0, 152619.0, 158688.0, 39611.60388396137, 39674.0, 39745.40381894274, 39850.40224396636, 39973.0, 41703.7914810424, 41795.79102104531, 44195.77902110533, 44785.55214447879, 45056.3241551377, 11473.598424055119, 11482.138839587064, 11553.942230288794, 11570.710732231762, 11600.65198044043, 8808.647654093893, 8849.734507964771, 8887.644494220289, 8891.4665120093, 8896.911030889738, 13000.739985200244, 13091.279979601213, 13093.541726039733, 13146.802797958038, 13283.0, 5283.524482796567, 5491.590783078665, 5494.395616482184, 5517.089680202802, 5540.390557038722, 855.8031652719909, 897.3449381951212, 900.7658008917598, 935.2938531408879, 938.779386844091, 20081.59836803256, 21124.683129753066, 21245.256416025364, 21583.568328633653, 22089.33731988043, 963.0850691842777, 969.345691658128, 990.0990099009866, 991.7024892532212, 995.4375777685584, 11192.216544841784, 11281.605143819927, 11468.254563453516, 11475.483603237873, 11476.770464590662, 178227.0, 179324.10337948226, 179431.10284448494, 179788.0, 180025.09987449978, 40522.0, 40636.79681601573, 40706.38940415896, 40818.79590602028, 40939.385909211385, 1171.2035815645443, 1215.2890559022894, 1215.8905698487179, 1218.5674085699627, 1222.6698791326469, 19534.804651953866, 20017.499562511053, 20297.89851050735, 20699.793002069786, 20777.64945278552, 28891.711082889742, 29045.7095429043, 29106.854465728382, 29158.416831662824, 29161.0, 144523.0, 144926.0, 145088.0, 145141.0, 145498.0, 29196.56205156967, 29345.85327073351, 29463.26341841471, 29484.968026118982, 30599.388012240077, 37044.814775925945, 37268.0, 37382.439263411616, 37756.62243377531, 37842.43236351512, 26136.60795088113, 27705.199162054403, 27926.0, 28345.0, 28886.0, 27217.72782272231, 28271.575926361533, 28926.276843079093, 29035.0, 29743.25641858971, 30563.0, 30835.84582077075, 31164.37671246517, 31443.528347074356, 31458.370832583678, 27110.457790843677, 27203.0, 27667.723322766513, 27677.861610691816, 27737.722622773515, 20162.29431969874, 22703.886480567493, 22789.658155128018, 22861.771382285966, 22877.19929802449], "value": 14508.042100035676, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.006842619746, 396.82539682539664, 413.91100913303643, 422.4149552869275, 424.5245325235736, 12731.0, 17225.56936076599, 17786.64426711465, 18020.18909149088, 18027.909860450694, 17403.216855241513, 17680.0, 17709.911450442763, 17751.0, 17911.104444777775, 5235.921461178085, 5343.412224655294, 5414.945850541503, 5564.33228012637, 5568.749406276727, 5381.569474442055, 5388.164834450667, 5413.593980451462, 5420.295361602986, 5429.294191755066, 5157.226416037587, 5271.736413179345, 5313.787448502075, 5364.785408583672, 5382.784688612451, 5359.9732001339935, 5398.649087809319, 5405.783768649249, 5410.729463526827, 5419.295491586108, 4827.396575428072, 4907.852764417074, 4916.778744956449, 4930.704157750511, 4965.627577931634, 21870.78129218703, 21875.78124218769, 22132.0, 22389.55220895589, 22477.0, 1665.5419759566096, 1705.4968784208688, 1716.2191203002728, 1718.4672751447092, 1718.6562687462558, 14627.926860365737, 14748.63128421798, 15047.849521504755, 15199.164045977466, 15247.313870875838, 2050.610384027045, 2087.885166315852, 2108.9578208435746, 2115.8095771380495, 2120.0, 89936.0, 91549.0, 92497.53751231269, 92991.07008929891, 94586.0, 10832.5125369357, 10874.891251087545, 10876.94561527203, 11067.446627668745, 11136.610218642309, 14818.259087045604, 15136.318865651072, 15169.469068582768, 15282.617934551503, 15307.92346038285, 6925.653717314114, 7160.069191005136, 7162.391196748231, 7163.570185788869, 7230.710771569184, 6258.906116408258, 6274.529410294246, 6472.773452929125, 6494.967525162344, 6504.414602685781, 6956.373926346653, 7004.194517630538, 7064.858702825914, 7122.501424900207, 7154.427645788324, 2063.329417939146, 2081.5212501124824, 2108.746950365966, 2126.797954194349, 2204.6141925163033, 844.923956843887, 875.1336177184542, 885.7431344910033, 900.2887718702152, 907.6550910653909, 16409.343626255053, 16540.255688494046, 16652.084135372672, 16663.50009499717, 17241.82758172402, 877.9824403511894, 878.1876763993281, 884.4914174349775, 885.4333226734894, 906.5150144672568, 9004.189622933836, 9073.95463022694, 9360.812783744286, 9455.432674039579, 9513.571889265, 374956.0, 382876.0, 386486.0, 390413.0, 391761.0, 73423.7972860815, 78231.0, 79256.0, 81499.5925020371, 81963.18036819674, 1079.9676009719722, 1089.716673664837, 1126.814075677504, 1127.4869934180092, 1130.796456637813, 16595.751063734297, 16948.745768813726, 17317.74023389625, 17561.12194390301, 17653.911730441265, 37907.0, 38557.421638676, 38726.61273387343, 38830.0, 39215.0, 48737.75631121822, 50835.49164508308, 50953.745231273606, 51556.22665659943, 52691.73654131705, 8033.0, 8302.252797248277, 8441.788955276168, 8501.064882862756, 8923.866142008004, 13061.281629510468, 13236.470541178245, 13261.138026028277, 13334.19994800315, 13352.332383380986, 10847.457627118454, 10877.0, 10904.78190436171, 11001.1749118818, 11350.54597816078, 10742.355458672504, 10776.030157285883, 10877.836832447361, 10899.891001090205, 11156.665300041012, 11242.943785281348, 11418.200725949437, 11502.48238829238, 11899.82150267764, 11933.284002959503, 8334.708285209988, 8386.916130838857, 8452.873206902024, 8517.44636598619, 8632.956835215784, 11148.442577871236, 11230.382328971986, 11258.66224013281, 11621.6513504595, 11657.067434605042], "value": 8862.75681209768, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1248.2073883084242, 1315.8092076648886, 1315.9802602960951, 1318.8021796730495, 1324.0665330941688, 10232.2325825563, 10342.276040677156, 10639.148868090553, 10666.146708263339, 10666.253362264644, 10417.479126043687, 10593.629222977197, 10598.841017384726, 10708.73228169296, 10715.0, 2233.1179184222265, 2259.062489067035, 2260.6156953317977, 2281.589313923493, 2287.931362059141, 2178.9891050544725, 2207.9448013799624, 2224.7219097612797, 2238.7761223877565, 2243.9775602244013, 2185.803277705006, 2191.0, 2219.7336319641668, 2224.232639739287, 2227.676986836908, 2045.6829191475272, 2063.649179639465, 2064.566441047374, 2070.140891530013, 2070.472029632434, 1992.7010948357718, 2057.5164836263466, 2099.3072286145534, 2111.102781317934, 2112.26070875194, 10477.26659133861, 10578.153747700166, 10584.206184536191, 10588.258821882471, 10600.310979786289, 5534.778608855681, 5722.427757224286, 5733.082706766897, 5734.0, 5755.740991655385, 3161.7470602351755, 3392.8133952632597, 3424.623291437965, 3453.8445769940413, 3473.878414255514, 1077.175960390302, 1089.455272363818, 1117.1118960426481, 1120.7254222715405, 1123.3933675815051, 15035.097894126278, 15289.694206115926, 15301.311440985182, 15315.157666328347, 15344.616384590363, 4825.5174482551465, 4968.683298925787, 5091.363579552556, 5096.643234973516, 5109.591232701375, 12691.746165076647, 12730.108892377444, 12745.04412169091, 12768.233905965672, 12800.359982000862, 5748.770049197985, 5756.7121643917635, 5776.68228247442, 5789.913151302734, 5812.447817457335, 4899.58353539946, 4913.06651736169, 4952.430470495867, 5093.286939828427, 5199.168133098761, 4109.198706252312, 4180.372944058355, 4237.449131612932, 4238.978805105955, 4319.33050377192, 1301.4729034740944, 1336.672515233774, 1342.9059965802496, 1355.8779709826163, 1372.7460419822364, 664.3323459922747, 690.6822861483773, 692.4944790303007, 704.2218348724585, 713.8251128473557, 5202.73986300691, 5257.684538927677, 5259.658122222043, 5446.455354464601, 5484.478974497416, 523.5026724611635, 533.751805410486, 535.5019831556612, 535.6223862177155, 820.1880138662681, 3546.4927405852927, 3606.74752767309, 3610.205754733954, 3666.7066634669163, 3741.85032598693, 13050.216986980811, 13436.261005644783, 13492.257925813978, 13493.932530337483, 13770.449182032606, 13089.738205236032, 13454.0, 13537.323133843269, 13732.725345493234, 13754.724905502035, 7457.440691948017, 7567.432442566719, 7569.091708994956, 7666.425018123663, 7953.920460795318, 5932.673702946379, 5955.225820643289, 5993.430624090704, 6076.0, 6204.689765511796, 11770.764584708086, 12050.939745301217, 12147.088968327587, 12332.691682708004, 12357.814632780695, 11966.58116965902, 12257.448414821176, 12356.691082723004, 12430.69477704828, 12446.502139914664, 8320.292775114183, 8416.495010299157, 8531.53076580794, 8531.658733650584, 8546.658133674584, 9207.631694732136, 9318.254539636948, 9418.62325506972, 9430.858537122085, 9438.244940404615, 7646.8088297793, 7861.960690196513, 7904.20957904205, 8016.7194148204535, 8105.311048560939, 7420.888686669812, 7623.69505219785, 7638.465307428427, 7845.882311765214, 7873.724419645285, 7197.640117993975, 7257.419406447577, 7266.183454136466, 7313.268673132857, 7344.926550734424, 5023.824166154167, 5067.746612669425, 5247.7113758743635, 5272.182811664198, 5361.865953351197, 5184.922226166535, 5263.447338029605, 5312.654677445954, 5324.920126198188, 5387.595930305164], "value": 4754.7273211497195, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.2227034146926, 378.68379902781174, 380.6345907928389, 382.6020938224247, 385.51810237203495, 5370.0, 5527.309086364205, 5531.087370583854, 5556.111022236438, 5597.58018148639, 5291.947080529194, 5373.81191658292, 5390.380106287778, 5404.405515393303, 5418.133098704208, 4064.4758215669126, 4074.449949256857, 4077.1234184650293, 4078.306687863063, 4078.7348822326453, 3904.316744569703, 4036.1725846201457, 4039.1921615676833, 4063.5326937402283, 4084.611961863633, 3997.060690737674, 4002.9985007496252, 4016.6385025347713, 4022.215667944752, 4027.0536423940353, 3999.520057593093, 4012.3379642358977, 4012.518497780285, 4023.3361495353233, 4035.495563054633, 3511.7015053720465, 3514.6661067198575, 3527.5414196154593, 3529.2412131391875, 3544.503769472276, 5258.737063146866, 5277.967982326793, 5311.415744268127, 5321.255024296602, 5333.546648534879, 4741.170295198326, 4752.287156926454, 4762.499937506546, 4764.976175119137, 4766.261229509431, 5603.439656034405, 5692.77228910843, 5697.373288938214, 5708.7145642718115, 5708.942910570924, 3861.092643228839, 3930.921381572381, 3934.4098385242155, 3947.0, 3951.3282741933654, 5928.7628494860155, 6005.249343832021, 6055.394460553954, 6066.575339726221, 6069.119977603267, 4024.9195016099516, 4027.7180597357906, 4035.5762644922447, 4040.474738284004, 4041.6766658667234, 4093.89765255871, 4101.036256479725, 4104.671626269951, 4109.97945010279, 4113.362428823537, 4667.719936803803, 4732.621390288768, 4743.193657078305, 4743.857684269477, 4745.145873742759, 5691.601587888808, 5705.5150312223095, 5711.8857622848145, 5721.199032135504, 5750.539956803529, 1405.3605609447677, 1412.442085376291, 1412.6468382904275, 1413.4558195094962, 1414.9575512734634, 897.228383590112, 934.6588495199203, 937.3953799799092, 946.9857952130724, 947.9241061395365, 5049.2173713074535, 5056.292119103328, 5057.999999999926, 5061.519155680278, 5070.822521211814, 5970.402959703995, 5970.641761494324, 5983.730732116978, 5985.653228023747, 6002.429769171922, 4884.3161957326, 4994.875128121754, 5014.84955451337, 5037.395512538519, 5039.319691841554, 3155.0027473899886, 3171.63526194486, 3175.6824317568057, 3177.221580712694, 3185.87256509737, 5413.431589683105, 5542.584306177053, 5548.4174161712435, 5548.833534993957, 5550.195221692832, 6021.337652858182, 6072.05883088122, 6089.634621922699, 6089.786857459968, 6103.023516237381, 5522.171674248895, 5522.355245538006, 5532.391436942014, 5539.529140023063, 5547.750351234124, 5898.469137777621, 5939.851503712269, 5942.286925568959, 5942.73257703413, 5969.164316995537, 5830.970845145747, 5860.267466566679, 5874.676892770768, 5875.471207591338, 5880.852978675567, 5389.784408623768, 5546.140348246028, 5560.165975103605, 5578.884223155466, 5586.413426590149, 4011.498562679665, 4056.290149223815, 4067.4102255173425, 4074.083331250445, 4080.8367665293054, 5947.226860508106, 5961.821145365646, 6042.456178943916, 6043.395660433922, 6056.424639659225, 5776.42235776419, 5783.566232532661, 5807.303123625192, 5815.709214539172, 5830.358660547252, 5688.971555142198, 5768.0, 5768.913466297925, 5771.134329850556, 5780.248567686174, 5443.646162999393, 5627.521660658726, 5674.546036317167, 5683.715814209356, 5702.743376547983, 5834.7082645866685, 5836.124581312837, 5838.854028649318, 5847.883042339045, 5869.266341707286, 5544.695041772741, 5643.858903527444, 5738.885222295447, 5746.856328591652, 5750.539956803362], "value": 4281.530432857782, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.5513693667581, 705.6189657584904, 710.6517806274927, 719.9028131202286, 723.4682508356359, 11721.941390293046, 12195.390230488485, 12228.327441990687, 14477.85522144781, 14917.403303867859, 14444.277786110679, 14552.708945821078, 14774.0, 14783.482578109768, 14831.258437078157, 847.9703210387638, 871.1680345270283, 873.4104479476359, 875.8598624220094, 877.4340550345023, 918.2699753695795, 918.4030380252856, 919.6781126605702, 926.4996901673122, 930.16285343191, 965.0687086961082, 968.6416026070328, 969.4910172159603, 969.5200875566569, 971.4268581536892, 943.5942544705774, 952.7903861150536, 956.9234461243084, 965.6234068713172, 966.6520052780993, 705.0974752317043, 705.2031204738613, 705.6365971524668, 709.6912842913349, 710.765447402356, 13210.33948302581, 13441.0, 13522.459101635923, 13651.38568764408, 13851.792223116661, 14349.426022959069, 14495.27523623825, 14551.345189466394, 14649.267536623127, 14690.0, 11661.883381166164, 11702.0, 11788.882111178864, 11861.584844530485, 11864.940675296655, 2887.6823549409546, 2891.927701807451, 2907.549329853876, 2909.330853903593, 2918.751906087964, 68713.0, 69300.0, 69491.65254173697, 69790.65104674496, 71267.64366178188, 10971.945140274247, 11683.941580292214, 11694.181407301578, 11738.0, 11864.644060678194, 18863.24547018104, 19387.127579258966, 19590.118444670024, 19590.412287631392, 20423.183072676926, 5938.851528711817, 6113.327533971348, 6201.193844800147, 6337.588056776295, 6379.298277189506, 2977.285451491626, 3018.622672165979, 3049.390121975614, 3054.633443986736, 3059.2198989257595, 3362.503685859818, 3440.0367896988882, 3440.552728145325, 3454.4300190468794, 3457.101153700006, 718.8785494628293, 724.5471580262337, 728.9015982842249, 734.0640683129053, 735.8123678461958, 577.9942200578024, 581.5899790647584, 588.0913987888722, 588.1383772772908, 607.7599348257413, 9069.727908162766, 9139.857517810273, 9187.724368268962, 9202.125798049176, 9674.516274186262, 579.3308728418683, 586.762361243697, 600.8708127752467, 603.2218438214742, 610.3804638292137, 3945.506811648544, 4161.91904047976, 4248.575142485726, 4260.10537787062, 4267.509236437787, 55472.72263638737, 57836.71081644565, 58125.709371452875, 58507.24478265659, 59830.0, 50380.24429633485, 51817.7409112952, 52519.47480525222, 52873.0, 53359.0, 46704.0, 47793.76103119462, 48628.513714863104, 49061.26408103881, 49585.75207124013, 8564.314854811724, 8711.303095752199, 8879.156480134377, 8973.7756556084, 9161.633534658538, 24979.125730599342, 25073.623895641944, 25133.120340788715, 25326.0, 25520.872395638646, 29977.0, 30358.84820575883, 30397.696023039487, 31040.379192415574, 31527.684723152473, 11244.437778111225, 11362.54549817998, 11440.084793216356, 11546.59586914454, 11680.649580512598, 12355.320457374572, 12514.124011319484, 12542.686432839251, 12644.810327844905, 12766.297853617769, 11463.0, 11584.304941703525, 11629.534818607499, 11690.298582085103, 11778.234414763014, 11381.374024428736, 11382.829257561309, 11384.943075284571, 11509.194356394972, 11603.361815099914, 10990.945045275043, 11189.72025699364, 11195.10439164881, 12997.285149316878, 13508.729825403241, 8883.555822208735, 9116.36185467011, 9133.954330228573, 9221.308401870021, 9415.952920235355, 10515.369077855354, 10983.340999540053, 11153.21927465102, 11197.44012799373, 11241.213115082193], "value": 6414.21750427162, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 111.0, 111.0, 116.0, 113.0, 112.0, 113.0, 113.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 122.0, 123.0, 178.0, 133.0, 127.0, 124.0, 121.0, 154.0, 124.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 161.0, 164.0, 180.0, 174.0, 164.0, 164.0, 163.0, 166.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 103.0, 75.0, 75.0, 77.0, 74.0, 100.0, 75.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 119.0, 84.0, 83.0, 83.0, 107.0, 84.0, 82.0, 101.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 114.0, 114.0, 118.0, 114.0, 114.0, 117.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 152.0, 150.0, 155.0, 151.0, 150.0, 150.0, 154.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 61.0, 54.0, 55.0, 55.0, 57.0, 59.0, 58.0, 56.0, 62.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 54.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 82.0, 82.0, 84.0, 82.0, 81.0, 82.0, 89.0, 82.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 132.0, 130.0, 128.0, 135.0, 135.0, 139.0, 132.0, 172.0, 133.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 189.0, 196.0, 196.0, 191.0, 191.0, 196.0, 189.0, 197.0, 183.0], "value": 191.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 74.0, 78.0, 76.0, 73.0, 74.0, 77.0, 73.0, 72.0], "value": 74.9, "unit": "score"}]}]} 09:21:44 INFO - Return code: 0 09:21:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:21:45 INFO - # TBPL SUCCESS # 09:21:45 INFO - Running post-action listener: _resource_record_post_action 09:21:45 INFO - [mozharness: 2017-05-12 16:21:45.012793Z] Finished run-tests step (success) 09:21:45 INFO - Running post-run listener: _resource_record_post_run 09:21:45 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 8040448; Write bytes: 372461568; Read time: 2152; Write time: 431712 09:21:45 INFO - TinderboxPrint: CPU usage
13.3% 09:21:45 INFO - TinderboxPrint: I/O read bytes / time
8,040,448 / 2,152 09:21:45 INFO - TinderboxPrint: I/O write bytes / time
372,461,568 / 431,712 09:21:45 INFO - TinderboxPrint: CPU idle
8,321.5 (86.7%) 09:21:45 INFO - TinderboxPrint: CPU user
1,220.2 (12.7%) 09:21:45 INFO - TinderboxPrint: Swap in / out
0 / 0 09:21:45 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 108437504; Read time: 120; Write time: 153936 09:21:45 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 5906432; Write bytes: 264024064; Read time: 1928; Write time: 277776 09:21:45 INFO - Running post-run listener: _upload_blobber_files 09:21:45 INFO - Blob upload gear active. 09:21:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:21:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:21:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:21:46 INFO - (blobuploader) - INFO - Open directory for files ... 09:21:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:21:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:21:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:47 INFO - (blobuploader) - INFO - Done attempting. 09:21:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:21:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:21:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:50 INFO - (blobuploader) - INFO - Done attempting. 09:21:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:21:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:21:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:51 INFO - (blobuploader) - INFO - Done attempting. 09:21:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:21:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:21:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:51 INFO - (blobuploader) - INFO - Done attempting. 09:21:51 INFO - (blobuploader) - INFO - Iteration through files over. 09:21:51 INFO - Return code: 0 09:21:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:21:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:21:51 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcbfa88d361e745bedfc7135ee3576a9a147e9c2d4c9386a37b3345bbf8044a7a38d52eae0b47b082fcfb1b5054b00ae19fff1a8cc8c735477577cbefab7dd35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6463c77dbb2ff467a8379000e72c66887070f46efd3aca171f6faaad3720d7c4bce2d284f79b798e9f4828269e938eb12f52e08fd4410e021e78eca27474cbf", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dea5e18cb7968680e90141f97ae2a14778f5ee7f71ab70653e1b7e87160fe6510bfc92f7c6ba765f158de057d1c50fcf864c81e4e9db1ef635ef3e9ed16ec018", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e55455285397dcb50931e4a6c44c60f781ba3c6ef570bbd719f2487700e20b2ac68ad49bae1b507f6c05dc5a28abcc580cf314ce35962d84355c18e2883836d5"} 09:21:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:21:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:21:51 INFO - Contents: 09:21:51 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcbfa88d361e745bedfc7135ee3576a9a147e9c2d4c9386a37b3345bbf8044a7a38d52eae0b47b082fcfb1b5054b00ae19fff1a8cc8c735477577cbefab7dd35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6463c77dbb2ff467a8379000e72c66887070f46efd3aca171f6faaad3720d7c4bce2d284f79b798e9f4828269e938eb12f52e08fd4410e021e78eca27474cbf", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dea5e18cb7968680e90141f97ae2a14778f5ee7f71ab70653e1b7e87160fe6510bfc92f7c6ba765f158de057d1c50fcf864c81e4e9db1ef635ef3e9ed16ec018", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e55455285397dcb50931e4a6c44c60f781ba3c6ef570bbd719f2487700e20b2ac68ad49bae1b507f6c05dc5a28abcc580cf314ce35962d84355c18e2883836d5"} 09:21:51 INFO - Running post-run listener: copy_logs_to_upload_dir 09:21:51 INFO - Copying logs to upload dir... 09:21:51 INFO - mkdir: /builds/slave/test/build/upload/logs 09:21:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.113277 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-05-12 09:21:51.940339) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 09:21:51.946059) ========= 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=ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485 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/sha512/bcbfa88d361e745bedfc7135ee3576a9a147e9c2d4c9386a37b3345bbf8044a7a38d52eae0b47b082fcfb1b5054b00ae19fff1a8cc8c735477577cbefab7dd35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6463c77dbb2ff467a8379000e72c66887070f46efd3aca171f6faaad3720d7c4bce2d284f79b798e9f4828269e938eb12f52e08fd4410e021e78eca27474cbf", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dea5e18cb7968680e90141f97ae2a14778f5ee7f71ab70653e1b7e87160fe6510bfc92f7c6ba765f158de057d1c50fcf864c81e4e9db1ef635ef3e9ed16ec018", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e55455285397dcb50931e4a6c44c60f781ba3c6ef570bbd719f2487700e20b2ac68ad49bae1b507f6c05dc5a28abcc580cf314ce35962d84355c18e2883836d5"} build_url:https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011245 build_url: 'https://queue.taskcluster.net/v1/task/Thmn6A7ISkmKYpINRH_5xg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcbfa88d361e745bedfc7135ee3576a9a147e9c2d4c9386a37b3345bbf8044a7a38d52eae0b47b082fcfb1b5054b00ae19fff1a8cc8c735477577cbefab7dd35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6463c77dbb2ff467a8379000e72c66887070f46efd3aca171f6faaad3720d7c4bce2d284f79b798e9f4828269e938eb12f52e08fd4410e021e78eca27474cbf", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dea5e18cb7968680e90141f97ae2a14778f5ee7f71ab70653e1b7e87160fe6510bfc92f7c6ba765f158de057d1c50fcf864c81e4e9db1ef635ef3e9ed16ec018", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e55455285397dcb50931e4a6c44c60f781ba3c6ef570bbd719f2487700e20b2ac68ad49bae1b507f6c05dc5a28abcc580cf314ce35962d84355c18e2883836d5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 09:21:51.974163) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:21:51.974599) ========= 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=ea65d483da93c827905c2090000001f5-1494603081.921002-1545524485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004393 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:21:52.053367) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 09:21:52.056772) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 09:21:52.057330) ========= ========= Total master_lag: 0.18 =========