builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-037 starttime: 1494596873.46 results: success (0) revision: 1178b701781de2b1a5afb7b7d6b4954a3a7a51ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 06:47:53.456016) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 06:47:53.456461) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 06:47:53.456764) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 06:47:53.472433) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:47:53.472813) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-12 06:47:53-- 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% 207M=0s 2017-05-12 06:47:53 (207 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.183083 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:47:53.696050) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:47:53.696358) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017306 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:47:53.748330) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-12 06:47:53.751740) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1178b701781de2b1a5afb7b7d6b4954a3a7a51ba --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 1178b701781de2b1a5afb7b7d6b4954a3a7a51ba --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=56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-12 06:47:53,806 truncating revision to first 12 chars 2017-05-12 06:47:53,806 Setting DEBUG logging. 2017-05-12 06:47:53,806 attempt 1/10 2017-05-12 06:47:53,806 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1178b701781d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-12 06:47:55,226 unpacking tar archive at: mozilla-central-1178b701781d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.740068 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-12 06:47:55.504983) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 06:47:55.505329) ========= script_repo_revision: 1178b701781de2b1a5afb7b7d6b4954a3a7a51ba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 06:47:55.508907) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 06:47:55.509290) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 06:47:55.519833) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-05-12 06:47:55.520252) ========= /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=56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:47:55 INFO - MultiFileLogger online at 20170512 06:47:55 in /builds/slave/test 06:47:55 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 06:47:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:47:55 INFO - {'append_to_log': False, 06:47:55 INFO - 'base_work_dir': '/builds/slave/test', 06:47:55 INFO - 'blob_upload_branch': 'Firefox', 06:47:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:47:55 INFO - 'branch': 'Firefox', 06:47:55 INFO - 'buildbot_json_path': 'buildprops.json', 06:47:55 INFO - 'config_files': ('talos/linux_config.py',), 06:47:55 INFO - 'default_actions': ('clobber', 06:47:55 INFO - 'read-buildbot-config', 06:47:55 INFO - 'download-and-extract', 06:47:55 INFO - 'populate-webroot', 06:47:55 INFO - 'create-virtualenv', 06:47:55 INFO - 'install', 06:47:55 INFO - 'run-tests'), 06:47:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:47:55 INFO - 'download_minidump_stackwalk': True, 06:47:55 INFO - 'download_symbols': 'ondemand', 06:47:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:47:55 INFO - 'tooltool.py': '/tools/tooltool.py', 06:47:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:47:55 INFO - '/tools/misc-python/virtualenv.py')}, 06:47:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:47:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:47:55 INFO - 'gecko_profile': False, 06:47:55 INFO - 'gecko_profile_interval': 0, 06:47:55 INFO - 'installer_path': 'installer.exe', 06:47:55 INFO - 'log_level': 'info', 06:47:55 INFO - 'log_name': 'talos', 06:47:55 INFO - 'log_to_console': True, 06:47:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:47:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:47:55 INFO - 'opt_config_files': (), 06:47:55 INFO - 'pip_index': False, 06:47:55 INFO - 'suite': 'dromaeojs-e10s', 06:47:55 INFO - 'system_bits': '32', 06:47:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:47:55 INFO - 'title': 'talos-linux64-ix-037', 06:47:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:47:55 INFO - 'use_talos_json': True, 06:47:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:47:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:47:55 INFO - 'work_dir': 'build'} 06:47:55 INFO - [mozharness: 2017-05-12 13:47:55.753599Z] Running clobber step. 06:47:55 INFO - Running pre-action listener: _resource_record_pre_action 06:47:55 INFO - Running main action method: clobber 06:47:55 INFO - rmtree: /builds/slave/test/build 06:47:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:47:56 INFO - Running post-action listener: _resource_record_post_action 06:47:56 INFO - [mozharness: 2017-05-12 13:47:56.663884Z] Finished clobber step (success) 06:47:56 INFO - [mozharness: 2017-05-12 13:47:56.663984Z] Running read-buildbot-config step. 06:47:56 INFO - Running pre-action listener: _resource_record_pre_action 06:47:56 INFO - Running main action method: read_buildbot_config 06:47:56 INFO - Using buildbot properties: 06:47:56 INFO - { 06:47:56 INFO - "project": "", 06:47:56 INFO - "product": "firefox", 06:47:56 INFO - "who": "florian@queze.net", 06:47:56 INFO - "installer_path": "public/build/target.tar.bz2", 06:47:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 06:47:56 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:47:56 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 06:47:56 INFO - "stage_platform": "linux64-stylo", 06:47:56 INFO - "basedir": "/builds/slave/test", 06:47:56 INFO - "buildnumber": 89, 06:47:56 INFO - "platform": "ubuntu64_hw_stylo", 06:47:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:47:56 INFO - "slavebuilddir": "test", 06:47:56 INFO - "taskId": "WeJNnPqYTV2KQnGzTZUrPw", 06:47:56 INFO - "branch": "mozilla-central", 06:47:56 INFO - "script_repo_revision": "production", 06:47:56 INFO - "revision": "1178b701781de2b1a5afb7b7d6b4954a3a7a51ba", 06:47:56 INFO - "slavename": "talos-linux64-ix-037", 06:47:56 INFO - "repo_path": "mozilla-central" 06:47:56 INFO - } 06:47:56 INFO - Finding installer, test and symbols from parent task. 06:47:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WeJNnPqYTV2KQnGzTZUrPw'}, attempt #1 06:47:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WeJNnPqYTV2KQnGzTZUrPw'}, attempt #1 06:47:57 INFO - Task dependencies: O_TecXXPTkK2D6vZK7E_eA 06:47:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O_TecXXPTkK2D6vZK7E_eA'}, attempt #1 06:47:58 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/target.tar.bz2 06:47:58 INFO - Set test_url: https://queue.taskcluster.net/v1/task/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/test_packages.json 06:47:58 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/target.crashreporter-symbols.zip 06:47:58 INFO - Running post-action listener: _resource_record_post_action 06:47:58 INFO - [mozharness: 2017-05-12 13:47:58.034102Z] Finished read-buildbot-config step (success) 06:47:58 INFO - [mozharness: 2017-05-12 13:47:58.034319Z] Running download-and-extract step. 06:47:58 INFO - Running pre-action listener: _resource_record_pre_action 06:47:58 INFO - Running main action method: download_and_extract 06:47:58 INFO - mkdir: /builds/slave/test/build/tests 06:47: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')]} 06:47:58 INFO - trying https://queue.taskcluster.net/v1/task/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/target.test_packages.json 06:47:58 INFO - Downloading https://queue.taskcluster.net/v1/task/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:47:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:47:58 INFO - Downloaded 986 bytes. 06:47:58 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:47:58 INFO - Using the following test package requirements: 06:47:58 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:47:58 INFO - u'common': [u'target.common.tests.zip'], 06:47:58 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:47:58 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:47:58 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:47:58 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:47:58 INFO - u'mozbase': [u'target.common.tests.zip'], 06:47:58 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:47:58 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:47:58 INFO - u'web-platform': [u'target.common.tests.zip', 06:47:58 INFO - u'target.web-platform.tests.zip'], 06:47:58 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:47:58 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:47:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/target.common.tests.zip 06:47:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:47:58 INFO - Fetch https://queue.taskcluster.net/v1/task/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/target.common.tests.zip into memory 06:47:59 INFO - Content-Length response header: 62452317 06:47:59 INFO - Bytes received: 62452317 06:48:10 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:48:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/target.common.tests.zip 06:48:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:48:10 INFO - Fetch https://queue.taskcluster.net/v1/task/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/target.common.tests.zip into memory 06:48:11 INFO - Content-Length response header: 62452317 06:48:11 INFO - Bytes received: 62452317 06:48:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/target.talos.tests.zip 06:48:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:48:23 INFO - Fetch https://queue.taskcluster.net/v1/task/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/target.talos.tests.zip into memory 06:48:24 INFO - Content-Length response header: 14409411 06:48:24 INFO - Bytes received: 14409411 06:48:24 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')]} 06:48:24 INFO - trying https://queue.taskcluster.net/v1/task/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/target.tar.bz2 06:48:24 INFO - Downloading https://queue.taskcluster.net/v1/task/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:48:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:48:25 INFO - Downloaded 65029255 bytes. 06:48:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/target.tar.bz2 06:48:25 INFO - mkdir: /builds/slave/test/properties 06:48:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:48:25 INFO - Writing to file /builds/slave/test/properties/build_url 06:48:25 INFO - Contents: 06:48:25 INFO - build_url:https://queue.taskcluster.net/v1/task/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/target.tar.bz2 06:48:25 INFO - Running post-action listener: _resource_record_post_action 06:48:25 INFO - Running post-action listener: set_extra_try_arguments 06:48:25 INFO - [mozharness: 2017-05-12 13:48:25.927807Z] Finished download-and-extract step (success) 06:48:25 INFO - [mozharness: 2017-05-12 13:48:25.927904Z] Running populate-webroot step. 06:48:25 INFO - Running pre-action listener: _resource_record_pre_action 06:48:25 INFO - Running main action method: populate_webroot 06:48:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:48:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:48:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:48:25 INFO - '--tppagecycles', 06:48:25 INFO - '7'], 06:48:25 INFO - 'tests': ['tsvgm']}}, 06:48:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:48:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:48:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:48:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:48:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:48:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:48:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:48:25 INFO - 'talos_options': ['--disable-e10s'], 06:48:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:48:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:48:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:48:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:48:25 INFO - 'talos_options': ['--disable-e10s'], 06:48:25 INFO - 'tests': ['damp', 'tps']}, 06:48:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:48:25 INFO - 'tests': ['damp', 'tps']}, 06:48:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:48:25 INFO - 'tests': ['dromaeo_dom']}, 06:48:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:48:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:48:25 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:48:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:48:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:48:25 INFO - 'tests': ['a11yr', 06:48:25 INFO - 'ts_paint', 06:48:25 INFO - 'tpaint', 06:48:25 INFO - 'sessionrestore', 06:48:25 INFO - 'sessionrestore_no_auto_restore', 06:48:25 INFO - 'tabpaint']}, 06:48:25 INFO - 'other-e10s': {'tests': ['a11yr', 06:48:25 INFO - 'ts_paint', 06:48:25 INFO - 'tpaint', 06:48:25 INFO - 'sessionrestore', 06:48:25 INFO - 'sessionrestore_no_auto_restore', 06:48:25 INFO - 'tabpaint']}, 06:48:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:48:25 INFO - 'ts_paint', 06:48:25 INFO - 'tpaint', 06:48:25 INFO - 'sessionrestore', 06:48:25 INFO - 'sessionrestore_no_auto_restore', 06:48:25 INFO - 'tabpaint']}, 06:48:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:48:25 INFO - 'ts_paint', 06:48:25 INFO - 'tpaint', 06:48:25 INFO - 'sessionrestore', 06:48:25 INFO - 'sessionrestore_no_auto_restore', 06:48:25 INFO - 'tabpaint']}, 06:48:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:48:25 INFO - 'tests': ['a11yr', 06:48:25 INFO - 'ts_paint', 06:48:25 INFO - 'tpaint', 06:48:25 INFO - 'sessionrestore', 06:48:25 INFO - 'sessionrestore_no_auto_restore', 06:48:25 INFO - 'tabpaint']}, 06:48:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:48:25 INFO - 'tests': ['a11yr', 06:48:25 INFO - 'ts_paint', 06:48:25 INFO - 'tpaint', 06:48:25 INFO - 'sessionrestore', 06:48:25 INFO - 'sessionrestore_no_auto_restore', 06:48:25 INFO - 'tabpaint']}, 06:48:25 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 06:48:25 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 06:48:25 INFO - 'bloom_basic_ref']}, 06:48:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:48:25 INFO - 'tests': ['tsvgx', 06:48:25 INFO - 'tsvgr_opacity', 06:48:25 INFO - 'tart', 06:48:25 INFO - 'tscrollx', 06:48:25 INFO - 'cart', 06:48:25 INFO - 'tsvg_static']}, 06:48:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:48:25 INFO - 'tsvgr_opacity', 06:48:25 INFO - 'tart', 06:48:25 INFO - 'tscrollx', 06:48:25 INFO - 'cart', 06:48:25 INFO - 'tsvg_static']}, 06:48:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:48:25 INFO - 'talos_options': ['--disable-e10s'], 06:48:25 INFO - 'tests': ['tp5o']}, 06:48:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:48:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:48:25 INFO - 'talos_options': ['--disable-e10s', 06:48:25 INFO - '--xperf_path', 06:48:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:48:25 INFO - 'tests': ['tp5n']}, 06:48:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:48:25 INFO - 'talos_options': ['--xperf_path', 06:48:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:48:25 INFO - 'tests': ['tp5n']}}, 06:48:25 INFO - 'talos.zip': {'path': '', 06:48:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:48:25 INFO - Running post-action listener: _resource_record_post_action 06:48:25 INFO - [mozharness: 2017-05-12 13:48:25.941588Z] Finished populate-webroot step (success) 06:48:25 INFO - [mozharness: 2017-05-12 13:48:25.941678Z] Running create-virtualenv step. 06:48:25 INFO - Running pre-action listener: _resource_record_pre_action 06:48:25 INFO - Running main action method: create_virtualenv 06:48:25 INFO - Creating virtualenv /builds/slave/test/build/venv 06:48:25 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:48:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:48:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:48:26 INFO - Using real prefix '/usr' 06:48:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:48:26 INFO - Installing distribute.............................................................................................................................................................................................done. 06:48:28 INFO - Installing pip.................done. 06:48:28 INFO - Return code: 0 06:48:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:48:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:48:29 INFO - Reading from file tmpfile_stdout 06:48:29 INFO - Output received: 06:48:29 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:48:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:48: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')]} 06:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48: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')]} 06:48:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d36a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9a30>, '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 0x1eda7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edaca0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:48: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', 'pip>=1.5'] in /builds/slave/test/build 06:48: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 pip>=1.5 06:48:29 INFO - Using env: {'DISPLAY': ':0', 06:48:29 INFO - 'HOME': '/home/cltbld', 06:48:29 INFO - 'LANG': 'en_US.UTF-8', 06:48:29 INFO - 'LANGUAGE': 'en_US:en', 06:48:29 INFO - 'LOGNAME': 'cltbld', 06:48:29 INFO - 'MAIL': '/var/mail/cltbld', 06:48:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:29 INFO - 'MOZ_NO_REMOTE': '1', 06:48:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:29 INFO - 'NO_EM_RESTART': '1', 06:48:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:29 INFO - 'PWD': '/builds/slave/test', 06:48:29 INFO - 'SHELL': '/bin/bash', 06:48:29 INFO - 'SHLVL': '1', 06:48:29 INFO - 'TERM': 'linux', 06:48:29 INFO - 'TMOUT': '86400', 06:48:29 INFO - 'USER': 'cltbld', 06:48:29 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523', 06:48:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:29 INFO - '_': '/tools/buildbot/bin/python'} 06:48:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:48:29 INFO - Cleaning up... 06:48:29 INFO - Return code: 0 06:48:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:48: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')]} 06:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48: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')]} 06:48:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48: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', '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 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d36a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9a30>, '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 0x1eda7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edaca0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:48: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', 'psutil>=3.1.1'] in /builds/slave/test/build 06:48: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 psutil>=3.1.1 06:48:29 INFO - Using env: {'DISPLAY': ':0', 06:48:29 INFO - 'HOME': '/home/cltbld', 06:48:29 INFO - 'LANG': 'en_US.UTF-8', 06:48:29 INFO - 'LANGUAGE': 'en_US:en', 06:48:29 INFO - 'LOGNAME': 'cltbld', 06:48:29 INFO - 'MAIL': '/var/mail/cltbld', 06:48:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:29 INFO - 'MOZ_NO_REMOTE': '1', 06:48:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:29 INFO - 'NO_EM_RESTART': '1', 06:48:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:29 INFO - 'PWD': '/builds/slave/test', 06:48:29 INFO - 'SHELL': '/bin/bash', 06:48:29 INFO - 'SHLVL': '1', 06:48:29 INFO - 'TERM': 'linux', 06:48:29 INFO - 'TMOUT': '86400', 06:48:29 INFO - 'USER': 'cltbld', 06:48:29 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523', 06:48:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:29 INFO - '_': '/tools/buildbot/bin/python'} 06:48:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:29 INFO - Downloading/unpacking psutil>=3.1.1 06:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:48:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:48:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:48:31 INFO - Installing collected packages: psutil 06:48:31 INFO - Running setup.py install for psutil 06:48:31 INFO - building 'psutil._psutil_linux' extension 06:48:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:48:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:48:32 INFO - building 'psutil._psutil_posix' extension 06:48:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:48:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:48:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:48:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:48:32 INFO - Successfully installed psutil 06:48:32 INFO - Cleaning up... 06:48:32 INFO - Return code: 0 06:48:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:48: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')]} 06:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48: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')]} 06:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d36a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9a30>, '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 0x1eda7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edaca0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:48: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:48: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 mozsystemmonitor==0.3 06:48:32 INFO - Using env: {'DISPLAY': ':0', 06:48:32 INFO - 'HOME': '/home/cltbld', 06:48:32 INFO - 'LANG': 'en_US.UTF-8', 06:48:32 INFO - 'LANGUAGE': 'en_US:en', 06:48:32 INFO - 'LOGNAME': 'cltbld', 06:48:32 INFO - 'MAIL': '/var/mail/cltbld', 06:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:32 INFO - 'MOZ_NO_REMOTE': '1', 06:48:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:32 INFO - 'NO_EM_RESTART': '1', 06:48:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:32 INFO - 'PWD': '/builds/slave/test', 06:48:32 INFO - 'SHELL': '/bin/bash', 06:48:32 INFO - 'SHLVL': '1', 06:48:32 INFO - 'TERM': 'linux', 06:48:32 INFO - 'TMOUT': '86400', 06:48:32 INFO - 'USER': 'cltbld', 06:48:32 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523', 06:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:32 INFO - '_': '/tools/buildbot/bin/python'} 06:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:48:34 INFO - Installing collected packages: mozsystemmonitor 06:48:34 INFO - Running setup.py install for mozsystemmonitor 06:48:34 INFO - Successfully installed mozsystemmonitor 06:48:34 INFO - Cleaning up... 06:48:34 INFO - Return code: 0 06:48:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:48:34 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')]} 06:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:34 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')]} 06:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:34 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 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d36a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9a30>, '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 0x1eda7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edaca0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:48:34 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 06:48:34 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 06:48:34 INFO - Using env: {'DISPLAY': ':0', 06:48:34 INFO - 'HOME': '/home/cltbld', 06:48:34 INFO - 'LANG': 'en_US.UTF-8', 06:48:34 INFO - 'LANGUAGE': 'en_US:en', 06:48:34 INFO - 'LOGNAME': 'cltbld', 06:48:34 INFO - 'MAIL': '/var/mail/cltbld', 06:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:34 INFO - 'MOZ_NO_REMOTE': '1', 06:48:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:34 INFO - 'NO_EM_RESTART': '1', 06:48:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:34 INFO - 'PWD': '/builds/slave/test', 06:48:34 INFO - 'SHELL': '/bin/bash', 06:48:34 INFO - 'SHLVL': '1', 06:48:34 INFO - 'TERM': 'linux', 06:48:34 INFO - 'TMOUT': '86400', 06:48:34 INFO - 'USER': 'cltbld', 06:48:34 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523', 06:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:34 INFO - '_': '/tools/buildbot/bin/python'} 06:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:34 INFO - Downloading/unpacking jsonschema==2.5.1 06:48: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 06:48: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 06:48: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 06:48: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 06:48:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:48:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:35 INFO - Downloading functools32-3.2.3-2.tar.gz 06:48:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:48:35 INFO - warning: no files found matching '*.txt' 06:48:35 INFO - no previously-included directories found matching 'build' 06:48:35 INFO - no previously-included directories found matching 'dist' 06:48:35 INFO - no previously-included directories found matching '.git*' 06:48:35 INFO - Installing collected packages: jsonschema, functools32 06:48:35 INFO - Running setup.py install for functools32 06:48:35 INFO - warning: no files found matching '*.txt' 06:48:35 INFO - no previously-included directories found matching 'build' 06:48:35 INFO - no previously-included directories found matching 'dist' 06:48:35 INFO - no previously-included directories found matching '.git*' 06:48:35 INFO - Successfully installed jsonschema functools32 06:48:35 INFO - Cleaning up... 06:48:35 INFO - Return code: 0 06:48:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:48: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')]} 06:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48: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')]} 06:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:35 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 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d36a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9a30>, '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 0x1eda7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edaca0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:48:35 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 06:48:35 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 06:48:35 INFO - Using env: {'DISPLAY': ':0', 06:48:35 INFO - 'HOME': '/home/cltbld', 06:48:35 INFO - 'LANG': 'en_US.UTF-8', 06:48:35 INFO - 'LANGUAGE': 'en_US:en', 06:48:35 INFO - 'LOGNAME': 'cltbld', 06:48:35 INFO - 'MAIL': '/var/mail/cltbld', 06:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:35 INFO - 'MOZ_NO_REMOTE': '1', 06:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:35 INFO - 'NO_EM_RESTART': '1', 06:48:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:35 INFO - 'PWD': '/builds/slave/test', 06:48:35 INFO - 'SHELL': '/bin/bash', 06:48:35 INFO - 'SHLVL': '1', 06:48:35 INFO - 'TERM': 'linux', 06:48:35 INFO - 'TMOUT': '86400', 06:48:35 INFO - 'USER': 'cltbld', 06:48:35 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523', 06:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:35 INFO - '_': '/tools/buildbot/bin/python'} 06:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:48:36 INFO - Cleaning up... 06:48:36 INFO - Return code: 0 06:48:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:48:36 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')]} 06:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:36 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')]} 06:48:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:36 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 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d36a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9a30>, '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 0x1eda7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edaca0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:48:36 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 06:48:36 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 06:48:36 INFO - Using env: {'DISPLAY': ':0', 06:48:36 INFO - 'HOME': '/home/cltbld', 06:48:36 INFO - 'LANG': 'en_US.UTF-8', 06:48:36 INFO - 'LANGUAGE': 'en_US:en', 06:48:36 INFO - 'LOGNAME': 'cltbld', 06:48:36 INFO - 'MAIL': '/var/mail/cltbld', 06:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:36 INFO - 'MOZ_NO_REMOTE': '1', 06:48:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:36 INFO - 'NO_EM_RESTART': '1', 06:48:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:36 INFO - 'PWD': '/builds/slave/test', 06:48:36 INFO - 'SHELL': '/bin/bash', 06:48:36 INFO - 'SHLVL': '1', 06:48:36 INFO - 'TERM': 'linux', 06:48:36 INFO - 'TMOUT': '86400', 06:48:36 INFO - 'USER': 'cltbld', 06:48:36 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523', 06:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:36 INFO - '_': '/tools/buildbot/bin/python'} 06:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:36 INFO - Downloading/unpacking blobuploader==1.2.4 06:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:37 INFO - Downloading blobuploader-1.2.4.tar.gz 06:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:48:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:48:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:37 INFO - Downloading docopt-0.6.1.tar.gz 06:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:48:38 INFO - Installing collected packages: blobuploader, requests, docopt 06:48:38 INFO - Running setup.py install for blobuploader 06:48:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:48:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:48:38 INFO - Running setup.py install for requests 06:48:38 INFO - Running setup.py install for docopt 06:48:38 INFO - Successfully installed blobuploader requests docopt 06:48:38 INFO - Cleaning up... 06:48:38 INFO - Return code: 0 06:48:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:48: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')]} 06:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48: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')]} 06:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:38 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 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d36a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9a30>, '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 0x1eda7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edaca0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:48:38 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 06:48:38 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 06:48:38 INFO - Using env: {'DISPLAY': ':0', 06:48:38 INFO - 'HOME': '/home/cltbld', 06:48:38 INFO - 'LANG': 'en_US.UTF-8', 06:48:38 INFO - 'LANGUAGE': 'en_US:en', 06:48:38 INFO - 'LOGNAME': 'cltbld', 06:48:38 INFO - 'MAIL': '/var/mail/cltbld', 06:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:38 INFO - 'MOZ_NO_REMOTE': '1', 06:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:38 INFO - 'NO_EM_RESTART': '1', 06:48:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:38 INFO - 'PWD': '/builds/slave/test', 06:48:38 INFO - 'SHELL': '/bin/bash', 06:48:38 INFO - 'SHLVL': '1', 06:48:38 INFO - 'TERM': 'linux', 06:48:38 INFO - 'TMOUT': '86400', 06:48:38 INFO - 'USER': 'cltbld', 06:48:38 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523', 06:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:38 INFO - '_': '/tools/buildbot/bin/python'} 06:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:48:38 INFO - Running setup.py (path:/tmp/pip-WGdDSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:48:38 INFO - Running setup.py (path:/tmp/pip-X17LZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:48:38 INFO - Running setup.py (path:/tmp/pip-1pyb5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:48:39 INFO - Running setup.py (path:/tmp/pip-bqzzaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:48:39 INFO - Running setup.py (path:/tmp/pip-xbjUM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:48:39 INFO - Running setup.py (path:/tmp/pip-3ABG7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:48:39 INFO - Running setup.py (path:/tmp/pip-im2dwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:48:39 INFO - Running setup.py (path:/tmp/pip-08qO3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:48:39 INFO - Running setup.py (path:/tmp/pip-IJl9hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:48:39 INFO - Running setup.py (path:/tmp/pip-F81_GT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:48:39 INFO - Running setup.py (path:/tmp/pip-tkILRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:48:39 INFO - Running setup.py (path:/tmp/pip-405WAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:48:39 INFO - Running setup.py (path:/tmp/pip-9M6cJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:48:39 INFO - Running setup.py (path:/tmp/pip-a0FfJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:39 INFO - Running setup.py (path:/tmp/pip-W6M_Eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:48:39 INFO - Running setup.py (path:/tmp/pip-_IVLaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:48:39 INFO - Running setup.py (path:/tmp/pip-m4Pa8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:48:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:48:40 INFO - Running setup.py install for manifestparser 06:48:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:48:40 INFO - Running setup.py install for mozcrash 06:48:40 INFO - Running setup.py install for mozdebug 06:48:40 INFO - Running setup.py install for mozdevice 06:48:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:48:40 INFO - Running setup.py install for mozfile 06:48:40 INFO - Running setup.py install for mozhttpd 06:48:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:48:40 INFO - Running setup.py install for mozinfo 06:48:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:48:40 INFO - Running setup.py install for mozInstall 06:48:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:48:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:48:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:48:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:48:40 INFO - Running setup.py install for mozleak 06:48:40 INFO - Running setup.py install for mozlog 06:48:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:48:41 INFO - Running setup.py install for moznetwork 06:48:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:48:41 INFO - Running setup.py install for mozprocess 06:48:41 INFO - Running setup.py install for mozprofile 06:48:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:48:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:48:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:48:41 INFO - Running setup.py install for mozrunner 06:48:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:48:41 INFO - Running setup.py install for mozscreenshot 06:48:41 INFO - Running setup.py install for moztest 06:48:41 INFO - Running setup.py install for mozversion 06:48:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:48:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:48:41 INFO - Cleaning up... 06:48:41 INFO - Return code: 0 06:48:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:48: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')]} 06:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48: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')]} 06:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:41 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 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d36a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9a30>, '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 0x1eda7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edaca0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:48:41 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 06:48:41 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 06:48:41 INFO - Using env: {'DISPLAY': ':0', 06:48:41 INFO - 'HOME': '/home/cltbld', 06:48:41 INFO - 'LANG': 'en_US.UTF-8', 06:48:41 INFO - 'LANGUAGE': 'en_US:en', 06:48:41 INFO - 'LOGNAME': 'cltbld', 06:48:41 INFO - 'MAIL': '/var/mail/cltbld', 06:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:41 INFO - 'MOZ_NO_REMOTE': '1', 06:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:41 INFO - 'NO_EM_RESTART': '1', 06:48:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:41 INFO - 'PWD': '/builds/slave/test', 06:48:41 INFO - 'SHELL': '/bin/bash', 06:48:41 INFO - 'SHLVL': '1', 06:48:41 INFO - 'TERM': 'linux', 06:48:41 INFO - 'TMOUT': '86400', 06:48:41 INFO - 'USER': 'cltbld', 06:48:41 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523', 06:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:41 INFO - '_': '/tools/buildbot/bin/python'} 06:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:48:42 INFO - Running setup.py (path:/tmp/pip-6yWSpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:48:42 INFO - Running setup.py (path:/tmp/pip-QnZFUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:48:42 INFO - Running setup.py (path:/tmp/pip-VDUZQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:48:42 INFO - Running setup.py (path:/tmp/pip-LVL8As-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:48:42 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)) 06:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:48:42 INFO - Running setup.py (path:/tmp/pip-i66g7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:48:42 INFO - Running setup.py (path:/tmp/pip-HQ9o77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:48:42 INFO - Running setup.py (path:/tmp/pip-jhM1NM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:48:42 INFO - Running setup.py (path:/tmp/pip-ZHlI1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:48:42 INFO - Running setup.py (path:/tmp/pip-dm2vux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:48:42 INFO - Running setup.py (path:/tmp/pip-U2mWc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:48:42 INFO - Running setup.py (path:/tmp/pip-Egvuxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:48:42 INFO - Running setup.py (path:/tmp/pip-YEun41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:48:42 INFO - Running setup.py (path:/tmp/pip-od98Xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:48:42 INFO - Running setup.py (path:/tmp/pip-XFr7JU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:43 INFO - Running setup.py (path:/tmp/pip-3BuEZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:48:43 INFO - Running setup.py (path:/tmp/pip-jreNyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:48:43 INFO - Running setup.py (path:/tmp/pip-ThmgJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:48:43 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)) 06:48:43 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)) 06:48:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:44 INFO - Downloading blessings-1.6.tar.gz 06:48:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:48:44 INFO - Installing collected packages: blessings 06:48:44 INFO - Running setup.py install for blessings 06:48:44 INFO - Successfully installed blessings 06:48:44 INFO - Cleaning up... 06:48:44 INFO - Return code: 0 06:48:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:48:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:48:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:48:44 INFO - Reading from file tmpfile_stdout 06:48:44 INFO - Current package versions: 06:48:44 INFO - argparse == 1.2.1 06:48:44 INFO - blessings == 1.6 06:48:44 INFO - blobuploader == 1.2.4 06:48:44 INFO - docopt == 0.6.1 06:48:44 INFO - functools32 == 3.2.3-2 06:48:44 INFO - jsonschema == 2.5.1 06:48:44 INFO - manifestparser == 1.1 06:48:44 INFO - mozInstall == 1.12 06:48:44 INFO - mozcrash == 1.0 06:48:44 INFO - mozdebug == 0.1 06:48:44 INFO - mozdevice == 0.50 06:48:44 INFO - mozfile == 1.2 06:48:44 INFO - mozhttpd == 0.7 06:48:44 INFO - mozinfo == 0.9 06:48:44 INFO - mozleak == 0.1 06:48:44 INFO - mozlog == 3.4 06:48:44 INFO - moznetwork == 0.27 06:48:44 INFO - mozprocess == 0.25 06:48:44 INFO - mozprofile == 0.28 06:48:44 INFO - mozrunner == 6.13 06:48:44 INFO - mozscreenshot == 0.1 06:48:44 INFO - mozsystemmonitor == 0.3 06:48:44 INFO - moztest == 0.8 06:48:44 INFO - mozversion == 1.4 06:48:44 INFO - psutil == 3.1.1 06:48:44 INFO - requests == 1.2.3 06:48:44 INFO - wsgiref == 0.1.2 06:48:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:48:44 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')]} 06:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:44 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')]} 06:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:44 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 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d36a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9a30>, '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 0x1eda7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edaca0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:48:44 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 06:48:44 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 06:48:44 INFO - Using env: {'DISPLAY': ':0', 06:48:44 INFO - 'HOME': '/home/cltbld', 06:48:44 INFO - 'LANG': 'en_US.UTF-8', 06:48:44 INFO - 'LANGUAGE': 'en_US:en', 06:48:44 INFO - 'LOGNAME': 'cltbld', 06:48:44 INFO - 'MAIL': '/var/mail/cltbld', 06:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:44 INFO - 'MOZ_NO_REMOTE': '1', 06:48:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:44 INFO - 'NO_EM_RESTART': '1', 06:48:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:44 INFO - 'PWD': '/builds/slave/test', 06:48:44 INFO - 'SHELL': '/bin/bash', 06:48:44 INFO - 'SHLVL': '1', 06:48:44 INFO - 'TERM': 'linux', 06:48:44 INFO - 'TMOUT': '86400', 06:48:44 INFO - 'USER': 'cltbld', 06:48:44 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523', 06:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:44 INFO - '_': '/tools/buildbot/bin/python'} 06:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:48:45 INFO - Cleaning up... 06:48:45 INFO - Return code: 0 06:48:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:48:45 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')]} 06:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:45 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')]} 06:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:45 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 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d36a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9a30>, '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 0x1eda7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edaca0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:48:45 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 06:48:45 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 06:48:45 INFO - Using env: {'DISPLAY': ':0', 06:48:45 INFO - 'HOME': '/home/cltbld', 06:48:45 INFO - 'LANG': 'en_US.UTF-8', 06:48:45 INFO - 'LANGUAGE': 'en_US:en', 06:48:45 INFO - 'LOGNAME': 'cltbld', 06:48:45 INFO - 'MAIL': '/var/mail/cltbld', 06:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:45 INFO - 'MOZ_NO_REMOTE': '1', 06:48:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:45 INFO - 'NO_EM_RESTART': '1', 06:48:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:45 INFO - 'PWD': '/builds/slave/test', 06:48:45 INFO - 'SHELL': '/bin/bash', 06:48:45 INFO - 'SHLVL': '1', 06:48:45 INFO - 'TERM': 'linux', 06:48:45 INFO - 'TMOUT': '86400', 06:48:45 INFO - 'USER': 'cltbld', 06:48:45 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523', 06:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:45 INFO - '_': '/tools/buildbot/bin/python'} 06:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:48:45 INFO - Cleaning up... 06:48:45 INFO - Return code: 0 06:48:45 INFO - Running post-action listener: _resource_record_post_action 06:48:45 INFO - Running post-action listener: _start_resource_monitoring 06:48:45 INFO - Starting resource monitoring. 06:48:45 INFO - [mozharness: 2017-05-12 13:48:45.402198Z] Finished create-virtualenv step (success) 06:48:45 INFO - [mozharness: 2017-05-12 13:48:45.403154Z] Running install step. 06:48:45 INFO - Running pre-action listener: _resource_record_pre_action 06:48:45 INFO - Running main action method: install 06:48:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:48:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:48:45 INFO - Reading from file tmpfile_stdout 06:48:45 INFO - Detecting whether we're running mozinstall >=1.0... 06:48:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:48:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:48:45 INFO - Reading from file tmpfile_stdout 06:48:45 INFO - Output received: 06:48:45 INFO - Usage: mozinstall [options] installer 06:48:45 INFO - Options: 06:48:45 INFO - -h, --help show this help message and exit 06:48:45 INFO - -d DEST, --destination=DEST 06:48:45 INFO - Directory to install application into. [default: 06:48:45 INFO - "/builds/slave/test"] 06:48:45 INFO - --app=APP Application being installed. [default: firefox] 06:48:45 INFO - mkdir: /builds/slave/test/build/application 06:48:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:48:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:49:02 INFO - Reading from file tmpfile_stdout 06:49:02 INFO - Output received: 06:49:02 INFO - /builds/slave/test/build/application/firefox/firefox 06:49:02 INFO - Running post-action listener: _resource_record_post_action 06:49:02 INFO - [mozharness: 2017-05-12 13:49:02.108864Z] Finished install step (success) 06:49:02 INFO - [mozharness: 2017-05-12 13:49:02.109008Z] Running run-tests step. 06:49:02 INFO - Running pre-action listener: _resource_record_pre_action 06:49:02 INFO - Running main action method: run_tests 06:49:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:49:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:49:02 INFO - Python 2.7.3 06:49:02 INFO - Return code: 0 06:49:02 INFO - grabbing minidump binary from tooltool 06:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:02 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 0x1ed9a30>, '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 0x1eda7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edaca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:49:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:49:02 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:49:02 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:49:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:49:02 INFO - Return code: 0 06:49:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:49:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:49:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:49:02 INFO - ENV: RUST_BACKTRACE is now 1 06:49:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:49:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:49:02 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/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 06:49:02 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/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 06:49:02 INFO - Using env: {'DISPLAY': ':0', 06:49:02 INFO - 'HOME': '/home/cltbld', 06:49:02 INFO - 'LANG': 'en_US.UTF-8', 06:49:02 INFO - 'LANGUAGE': 'en_US:en', 06:49:02 INFO - 'LOGNAME': 'cltbld', 06:49:02 INFO - 'MAIL': '/var/mail/cltbld', 06:49:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:49:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:02 INFO - 'MOZ_NO_REMOTE': '1', 06:49:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:49:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:02 INFO - 'NO_EM_RESTART': '1', 06:49:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:02 INFO - 'PWD': '/builds/slave/test', 06:49:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:49:02 INFO - 'RUST_BACKTRACE': '1', 06:49:02 INFO - 'SHELL': '/bin/bash', 06:49:02 INFO - 'SHLVL': '1', 06:49:02 INFO - 'TERM': 'linux', 06:49:02 INFO - 'TMOUT': '86400', 06:49:02 INFO - 'USER': 'cltbld', 06:49:02 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523', 06:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:02 INFO - '_': '/tools/buildbot/bin/python'} 06:49:02 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/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 06:49:02 INFO - mozversion application_buildid: 20170512125958 06:49:02 INFO - mozversion application_changeset: 1178b701781de2b1a5afb7b7d6b4954a3a7a51ba 06:49:02 INFO - mozversion application_display_name: Nightly 06:49:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:49:02 INFO - mozversion application_name: Firefox 06:49:02 INFO - mozversion application_remotingname: firefox 06:49:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:49:02 INFO - mozversion application_vendor: Mozilla 06:49:02 INFO - mozversion application_version: 55.0a1 06:49:02 INFO - mozversion platform_buildid: 20170512125958 06:49:02 INFO - mozversion platform_changeset: 1178b701781de2b1a5afb7b7d6b4954a3a7a51ba 06:49:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:49:02 INFO - mozversion platform_version: 55.0a1 06:49:02 INFO - using testdate: 1494596942 06:49:02 INFO - actual date: 1494596942 06:49:02 INFO - starting webserver on 'localhost:56299' 06:49:02 INFO - SUITE-START | Running 2 tests 06:49:02 INFO - TEST-START | dromaeo_css 06:49:02 INFO - operating with platform_type : linux_ 06:49:02 INFO - Initialising browser for dromaeo_css test... 06:49:02 INFO - TEST-INFO | started process 3296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5QVHND/profile http://localhost:56299/getInfo.html) 06:49:07 INFO - PID 3296 | __metrics Screen width/height:1600/1200 06:49:07 INFO - PID 3296 | colorDepth:24 06:49:07 INFO - PID 3296 | Browser inner width/height: 1024/695 06:49:07 INFO - PID 3296 | __metrics 06:49:09 INFO - TEST-INFO | 3296: exit 0 06:49:09 INFO - Browser initialized. 06:49:09 INFO - Running cycle 1/1 for dromaeo_css test... 06:49:09 INFO - TEST-INFO | started process 3487 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5QVHND/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:49:21 INFO - PID 3487 | RSS: Main: 168030208 06:49:21 INFO - PID 3487 | 06:52:27 INFO - PID 3487 | Cycle 1(1): loaded http://localhost:56299/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56299/tests/dromaeo/cssquery-ext.html) 06:52:28 INFO - PID 3487 | RSS: Main: 185364480 06:52:28 INFO - PID 3487 | 06:55:30 INFO - PID 3487 | Cycle 1(1): loaded http://localhost:56299/tests/dromaeo/cssquery-ext.html (next: http://localhost:56299/tests/dromaeo/cssquery-jquery.html) 06:55:31 INFO - PID 3487 | RSS: Main: 181276672 06:55:31 INFO - PID 3487 | 06:58:33 INFO - PID 3487 | Cycle 1(1): loaded http://localhost:56299/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56299/tests/dromaeo/cssquery-mootools.html) 06:58:34 INFO - PID 3487 | RSS: Main: 190947328 06:58:34 INFO - PID 3487 | 07:01:35 INFO - PID 3487 | Cycle 1(1): loaded http://localhost:56299/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56299/tests/dromaeo/cssquery-prototype.html) 07:01:36 INFO - PID 3487 | RSS: Main: 183857152 07:01:36 INFO - PID 3487 | 07:04:39 INFO - PID 3487 | Cycle 1(1): loaded http://localhost:56299/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56299/tests/dromaeo/cssquery-yui.html) 07:04:40 INFO - PID 3487 | RSS: Main: 187871232 07:04:40 INFO - PID 3487 | 07:07:41 INFO - PID 3487 | Cycle 1(1): loaded http://localhost:56299/tests/dromaeo/cssquery-yui.html (next: http://localhost:56299/tests/dromaeo/cssquery-dojo.html) 07:07:42 INFO - PID 3487 | RSS: Main: 192184320 07:07:42 INFO - PID 3487 | 07:07:42 INFO - PID 3487 | __start_tp_report 07:07:42 INFO - PID 3487 | _x_x_mozilla_page_load 07:07:42 INFO - PID 3487 | _x_x_mozilla_page_load_details 07:07:42 INFO - PID 3487 | |i|pagename|runs| 07:07:42 INFO - PID 3487 | |0;dojo.html;2738.5481395569727;2754.4904192724334;2773.445310937813;2785.4150628368047;2787.442511497701;5151.330327057487;5289.947100528999;5326.067938110835;5349.063913815086;5379.220013098098;5269.1832765921245;5308;5327.973360133204;5400.216968539569;5424.593155513323;4370.063571566169;4649.558291962258;4686.27362758773;4701.43582770068;4723.692959957609;4739.857804265877;4748.216544270192;4760.880977975544;4777.90444191116;4780.90438191236;4599.701019433726;4660.72035677857;4660.790264438108;4664.183767840648;4713.858584242478;4684.648651351128;4692.577668009895;4696;4705.905881882343;4717.716936983792;4607.516210797885;4642.210824159901;4663.207254766664;4666.766661666937;4668.953310466886;5151.742412879341;5198.766055527472;5212.50481204285;5216.582673386158;5233.581313494949;5679.687617181054;5688.544916406678;5688.60179787415;5694.629849059798;5695.45893140151;5704.11586204139;5707.486326230659;5716.971415142898;5743.4543718346695;5812.796552120655;5296.523312901857;5307.4427185145005;5337.172738225542;5337.226102215234;5363.03465376236;5874.676892770939;5879.882402351929;5884.352721200665;5889.852753681106;5891.49922256613;5487.2317875497465;5570.053090974544;5603.467670571289;5611.102223644198;5707.686077265707;5718.399568045378;5728.770849165987;5728.77084916607;5759.827205183851;5773.16289138081;5691.658500489901;5698.686572238484;5707.71461426927;5708.286464191976;5722.399148089391;5519;5618.410066942912;5677.148427735872;5696.971515142481;5711.742971566289;4830.879228019257;4831.637627177975;4832.758362081881;4841.273808928689;4879.878003049881;4103.363978583325;4111.033907031845;4123.0516981094515;4136.793160341971;4144.647704945053;4750.95249047512;4816.325714399917;4832.106060378841;4879.634027447955;4896.4858689837765;5705.286839145107;5709.65742055478;5725.227094342211;5754.683492407958;5756.913646295309;4818.349522814376;4837.6613637045775;4840.419149702058;4843.588294994965;4870.025994801054;4967.205247160437;5034.572061374678;5040.521150490697;5084.949150508522;5093.312402825572;5215.1964145524225;5249.842504724865;5268.394134674561;5268.631195816256;5275.841724748264;5628.127640215773;5631.521320687787;5635.239242702182;5640.915386269291;5642.88714225705;5242.711650859239;5262.552683021986;5267.762950667306;5271.182966640177;5274.077036518671;5527.8894422112135;5534.640248383842;5608.10270356741;5652.886942261214;5707.714614269187;5780.884382312414;5789.797357092481;5796.333421656564;5799.362070172193;5837.737301821343;5391.002664507078;5494.890102198014;5556.249906262765;5574.386817450159;5587.580931430078;5317.308749862493;5472.699001554953;5481.342238931354;5498.725063746717;5513.5037846594;5435.592330575144;5514.09017512106;5537.418571049981;5540.307461567304;5562.332520097614;5590.273264475592;5606.327240731139;5616.85957851057;5643.238162847963;5646.971765141148;5324.227986941949;5487.890242195054;5491.395946445968;5497.945020549903;5543.778248870161 07:07:42 INFO - PID 3487 | |1;ext.html;655.2824657000585;705.5837056136879;719.9992011104564;1025.3796453145842;1027.7584767579613;33055.173620659494;33586;33588.4961725574;33654.49518257228;33766;35433.2913341733;35604.2879142417;35764.10589735258;35889.282214355764;35941.10147246314;6828.385445309921;6901.551399159039;7023.789286321418;7026.43788496919;7026.964865175667;7018.964905175467;7064.25825288345;7084.362407383334;7105.751298704547;7114.146302443714;6999.370056694896;7109.8933515997305;7111.751088711896;7120.750773722921;7135.607541585211;7065.89401158983;7115.679794409264;7117.608531530764;7119.430445564342;7122.252163522808;6962.965185174042;6972.546784458994;6991.47563932702;7031;7033.156021277428;31537.684623153706;32071.358572828645;32079.358412831614;32086.518702219484;32302.515462268086;3002.7597792176575;3018.2907016851022;3047.6799936006623;3051.6643169251365;3056.8165910045245;24618.384540386454;24782.87608561964;24881.751182488126;24924.875375623007;24949.126780562594;3211.7912335698106;3225.8870939517237;3233.6281327647384;3234;3259.4784834426378;146067.99999999892;146199;146428;148765.33025353317;152274;38911;39199.864010879064;39270;39303;39337;40483.39274910879;40563.594364056575;40571.59428405678;43682.12635747331;44646;12249.387530623611;12253;12269.263844169378;12276.324802135969;12295.938520307342;9756.365781239027;9772.21822254218;9787.608495660093;9791.706248812547;9816;12562.81155782664;12575.308358040396;12733;12749.490020399266;12797.680057998437;5441.129419292894;5476.808311709071;5553.750081246354;5562.972185139049;5616.354119276336;885.6457417033109;911.2300106410073;919.4391421233042;930.3812964378612;958.6500927161675;21208.469788255108;21259.574808504054;21264.25575104864;21938.890305548688;22153.224637137624;1010.4291075542295;1013.8124446977333;1017.1151098544314;1017.4099022566893;1027.9229057820694;11417.68696599885;11440.599579014695;11565.537378504765;11581.478833452515;11668.416579171007;178384;178710;178766;179145.1042744804;179554;40700.796496017334;40956;41009;41047;41140.58859411367;1220.3410158514303;1254.5734450286764;1259.6724851538665;1274.5666473398903;1276.9808452873215;19734.506637334183;19821.062628080057;19944.401667949984;20853.061612227182;21070.68393974061;29674;29753;29804.403911922072;29805.5529167067;29807.552886706282;147355;148267;148412;149044;149610.25194873955;29124.252544847375;29340.853295733385;29364.706352937053;29802.254943626584;30357;36016.27967440689;36051.459228111074;36249.81875090713;36366;36431.27137457289;26219.606705899045;27452.17643470699;27683.72316276892;27847.58228626532;29203.85398072996;26761;26785;27688.030918917742;27809.304767380978;28068;30488.390232195674;30555.694443056174;30589.694103058686;30611.2347191322;30638.234044149074;26285.605715913895;26430.735692642826;26862.731372686805;27445.588316174875;27789.58315625227;19813.245995639776;22265.220717274817;22360.888195558917;22367.552648946603;22524.436889077904 07:07:42 INFO - PID 3487 | |2;jquery.html;399.894028082558;400.6074047433517;422.2062522457779;435.6231859441583;435.86488188661497;13599.320033998285;17125.74311385329;17442.47672569825;17468.388606398777;17490.56273593159;18095.276188952426;18197;18448.631027379477;18457.90771046143;18485.537861553436;5415.377231618355;5428.294321738178;5533.778648854041;5600.467955544217;5642.689652069134;5413.160960051198;5511.724413779315;5524.944750552483;5536.4186760390185;5546.168074788794;5275.788968441258;5475.233467314579;5504.834854954358;5507.118860982244;5512.91730624041;5453.727313634322;5477.4796394342475;5485.753141108639;5492.478214569649;5509.173623956399;4795.808167673289;4890.926636100461;4927.581155601778;4932.506749325074;4950.579200767939;20773.27293544719;20923.26768563093;21223;21315.253966111268;21629.783702162935;1621.3595629726192;1646.1357787161717;1670.899746015243;1674.6650669865953;1677.8406051425095;14493.347799349054;14512.201828899406;14797.778033329509;14842.554723358317;14908.925455372762;2018.929337473196;2052.220156340581;2097.8846163461003;2106.493856892314;2110.482931681732;92818;93071;93660;93923;94377.52811235968;10724.678259652223;10783.78432431347;10948.726281842859;11198;11333.716657083638;15431.305591248421;15480.380784768484;15491.302891369915;15505.767413488808;15661.29524171415;7197.604131772803;7238.304568274325;7262.04291252072;7365.558066516026;7475.813104672427;6892.517523773388;7106.253843346478;7144.535605185646;7283.308085731847;7300.196978332379;6588.703508342136;6814.897776533356;6914.1702995639835;6930.688119034656;6943.236244013155;2115.843423602023;2126.957460850774;2149.21553632926;2155.978440215609;2371.5494056129623;853.7225401744458;882.938194326391;887.8179973105628;892.4422236102436;920.7145784806731;15941.202939852961;16447.506574802774;16554.337826487048;16736.497905062868;17225.3971111013;888.7689200807837;892.2817132208505;904.2765787370078;908.3459908865606;920.3833431600843;8910.821783564423;9163.95418022919;9272.443653380818;9405.341626086245;9454.43273403598;352360;355335;362500;362733;363782;76919;78379.21620783833;78809;78982.60508697535;81296.18703813004;1042.6246551241395;1059.9152067834555;1082.880883102858;1094.5512339940585;1098.5111625326654;14183.21992290434;14337.283135843374;14495.20276384809;14566.41734330615;15113.622159446102;37670.62329376781;38702.419463707505;38728.61271387363;38906.6109338903;39006.80496597499;47821.28268076051;47928;47966.76016619895;48092;48208.758956206395;8300.584970751317;8348.457350272212;8363.745438184078;8552.273056790242;8563.914360856312;12584.496620135458;12660.430280637209;12660.683482913;12942.870571294166;12990.675233119247;10677.09244714208;10703.839442408525;10719.088877445505;10995.835062474229;11076.501557430096;10604.89395106039;10771.6229931952;10774.299670521392;10821.350718956888;10856.565737370416;11190.94404527972;11257.155713321697;11329.376884271443;11345.773084538429;11357.48891299877;8450.577471126297;8462.534560599226;8483;8556.486610803371;8612.827743445221;11023.889761102608;11167.218294719292;11270.83093753578;11451.198416111125;11451.942740286579 07:07:42 INFO - PID 3487 | |3;mootools.html;1269.8857102860743;1322.3586560518154;1336.2116351352704;1338.2907059258596;1343.8051482535034;10039.04629060239;10501.474926253695;10518.368897866134;10615.203859710533;10705.732356691087;10563.788724225511;10722.517486713097;10750.935983244777;10757.085647719954;10785.83821242682;2249.4713742270555;2290.3014580552926;2291.598970180212;2291.9312420627325;2294.139697613395;2174.1738139507042;2207.62470380035;2215.7784221577795;2221.4002219400754;2226.92205772798;2169.381726208031;2178.3900507857747;2216.423729830248;2217.8225741940687;2219.933401997943;2094.392626138433;2167.0789914286443;2200.8789516576503;2202.493426511895;2203.966940495894;2006.4883454718954;2141.1649456711893;2186.9890650546804;2187;2206.5476577301615;10304.381737095799;10377.84433233502;10379.532921018572;10388.480575971247;10414.218933580012;5624.55003599711;5817.272840894888;5824.796132135355;5826.300843898759;5839.941600583982;3317.270200555874;3442.6557344265625;3470.4620783778555;3516.0682419158943;3525.806080665562;1066.8879767624364;1097.2827524923468;1107.9944600277029;1129.7514546799773;1142.5087212498622;15100.395984160621;15222.391104355813;15265.389384424721;15267.083974961537;15328.846711532853;4726.432828060655;4772.880677983008;5012.24816277554;5024.346834911511;5052.9242061369105;10871.51078201467;10911.618093366853;10999.945000274947;11000.284981476338;11002.33985960845;5733.3406658234835;5757.050086735641;5770.653760774367;5771.249737534094;5792.536597072224;5233.973830130825;5356.758945847446;5373.892522149613;5375.193720941812;5430.375506816687;3652.3243200008083;3894.6105389461395;3898.3567711327314;3930.941035884464;3945.8421663133154;1115.0800589513683;1118.0440723181725;1122.119136477861;1129.4860838318546;1147.7991351513451;687.295522089862;699.3111784891878;700.6006576251488;701.5580184483742;717.433227750082;5275.182346736262;5425.13197888336;5426.538744206787;5474.343078830566;5495.065838807413;537.1539824775994;551.7434393007271;553.23653358366;553.7120697237494;563.3043191658298;3352.580927384077;3611.349957007764;3704.0369503929173;3730.123420996064;3828.3300422426523;13251.73496530064;13634.250116243504;13901.58295251144;13922;13927.234002129777;13160.47358105665;13473.528426505221;13747.656308592164;13756;13787.690169433889;7532.585707786125;7557.244275572509;7629.694812207561;7653.961730191313;7660;5473.370562385217;5479.780808767605;5543.1685247213245;5653.067243904709;5658.85852853682;11930.105242106703;12070.637880863587;12095.395230238277;12210.26738395699;12305.138640295094;12000.879991199976;12403.317817519763;12406.565770198;12572.748545029232;12617.93691031539;8404.453710508797;8514.872276915727;8625.482471051757;8629.352798540009;8648.264897483532;9737.951310243403;9827.361221520578;9858.014198580084;9861.802763944537;9872.45701486425;7945;8053.395995300493;8208.09710931785;8344.207300306462;8352.331813454788;7624.466287359832;7707.267809558083;7736.419768517496;7759.6120193988945;7850.057993040643;7562.848743025219;7713.730019449293;7717.498362606412;7730.7680769577;7734.303912647889;4988.725620090785;5043.218301163325;5047.318611987334;5214.817481388133;5279.340082489689;5149.794008239628;5303.708296043755;5419.458054194549;5427.83716488506;5509.118541033416 07:07:42 INFO - PID 3487 | |4;prototype.html;373.0598890795196;398.4680451597118;400.35942492012776;403.44526276369993;406.2383031815346;5445.646033007852;5534.833954981352;5582.637128586639;5596.972015139929;5608.214849921004;5322.175062865253;5434.347878254605;5437.429069947658;5439.4832490913395;5448.182772584114;4070.6132917372875;4073.9592604074023;4082.632563069323;4110.219058378899;4116.958830411688;4124.638419687944;4130.648894843942;4132.8140233689555;4153.293940030187;4316.525182229952;4306.8277268909205;4316.892077698051;4319.913601727963;4327.567243275663;4327.805248763813;4321.243782338078;4322.502912165094;4339.631131353839;4343.326784348431;4352.151330490556;3863.8840834775;3976.4631774710333;3977.443157957888;3978.602139785998;3982.8734443461744;5344.599155063386;5357.973210133924;5372.57019438444;5399.136138217906;5431.071969450828;5166.276721259027;5176.404713457925;5187.948120518822;5192.844214673566;5213.921791173136;5773.3318017689635;5791;5806;5865.648061116304;5877.382874798127;4450.910981780346;4458.398116254297;4468.664850136252;4474;4482.170798402306;5926.4073592640825;6120.387961203933;6126.479249263773;6131.233595800525;6193.659348735818;4271.978640106841;4276.123394704078;4281.116308824107;4287.121140166259;4289.656827453796;4339.589633369168;4349;4351.282038463682;4352.368906508602;4356.3683265926265;4949.232868905326;4953.925691114636;4972.801087956441;5134.614903882224;5162.148245539519;5884.11738239259;5884.382139875337;5885.882282354414;5893.764249430061;5900.232969713909;1610.2673283655909;1629.3482606957075;1632.6081740382224;1638.2054703468807;1638.5493989153078;1150.8734039255676;1154.9133814963911;1160.2632328471482;1165.1785491228663;1171.8047591456666;5017.247412888096;5020.598352131894;5024.84925452237;5033.5721463676;5035.924461133086;5967.761289548456;6009.879802403927;6014.6391216527145;6020.367861374492;6055.485283750931;4831.903361932742;4999.400071991385;5044.899102017939;5048.570871475892;5059.595232381401;3159.557661927332;3184.5700830388064;3189.2824114574037;3190.633077196152;3191.250056236829;5476.397596264408;5573.164025396142;5603.7478313475995;5610.635308704921;5613.053147097725;6158.7228574714245;6159.568830181934;6173.84565385869;6183.505319574423;6183.5884005237995;5590.720463976866;5598.916016259759;5601.215829783833;5604.542818867206;5610.102383618601;5795.420457954171;5994.13085102649;6028.57799953999;6034.275886893425;6047.848803779941;5754.539636829128;5966.880662386815;5972.671503067199;5979.252593425822;5998.70006499682;5538.556915446674;5582.720863956867;5601.355844077983;5601.775928962796;5634.74643641029;4087.6321131097156;4117.649999750055;4122;4123.092919557693;4134.669226461936;5891.263592050994;5970.462658360769;6000.69996500182;6049.727762250621;6050.21347224858;5772.105323674838;5777.8555536111935;5778.797742079007;5803.332616749128;5828.388019258086;5788.479036886532;5789.3921138279875;5793.362730099601;5797.362290148165;5807.070868660994;5486.231927530229;5656.547476201977;5705.372409035086;5717.42825717425;5725.942740572541;5790.710464476675;5811.704376771237;5813.215215945793;5816.41835816415;5825.126231065374;5494.890102198014;5607.271054763018;5627.493525582717;5641.464060914206;5661.207430959751 07:07:42 INFO - PID 3487 | |5;yui.html;739.7226040234912;762.0322190817661;762.6720510180623;768.650264129821;781.289026985443;11326.150538709588;11669.183157179;12314.938425307872;12852.807207891878;12864.485420583178;14787.704245915102;15068.924655376735;15486.69026619467;15502.147381893992;15678.372865085383;836.7531578184451;848.0247715127622;849.0109022988212;849.1254008371387;849.5072857742525;868.3660927522881;896.6413434626137;896.9596368163416;897.6723495924006;898.3711402018613;914.4787471141452;945.8344789661816;948.5020364308724;955.2930831184908;956.6986399284203;899.4827973914993;949.0651708067548;949.2216382566264;950.1401231885086;951.3198063384713;670.9094272273229;683.2313647146959;698.6751160710294;703.9155301363869;704.9154101507801;14517.491887783983;14569.271536423137;14705.779413308808;14980.400783968627;15069.43819550668;15479.845201547952;15718.607034824106;15792.684146317124;16075.035497870165;16133.354665813353;12579.308138052404;12750.426230819543;12848;12950.48198072076;12970.286634235114;3019.5470679398045;3037.7721670874553;3044.756419486458;3046.5224366182383;3058.0672894767085;71764.28235717629;72725.2727472729;72805.63597181981;73533.63233183854;75693;11248.100151987821;11483.885161148448;11488;11490.023348015513;11502.482388292547;20302.766695663464;21159.471013224793;21232.469188270108;21411.35765927025;21459.141634334454;6062.090686397076;6204.224471941007;6235.906461403082;6267.373262673696;6274.435300822948;3070.4319700855413;3119.5008798592116;3144.261098641817;3145.937081258408;3147;3542.167590616203;3565.1978304881713;3604.6034936157002;3614.4397618369194;3640.12636967126;731.9085114360705;751.8082888863414;754.6717178027466;754.8905408715815;757.1595528962847;557.8703126169539;584.6258394627442;584.9931352846373;594.3195041677342;628.3998781163978;9192.724218273463;10101.545430455648;10669.733256668645;10947.945260273647;11129.554817807197;579.956503262257;587.717895410197;603.02611282778;611.513846492031;639.1946147853645;4554.24854898938;4686.343911852344;4751.857444276678;4787.928181077286;4958.652894297436;60646;62707;62952.37047629557;64251.67874160693;64743.67628161829;57216.84530475104;57807.4219257802;57853.71073144692;58004;58739.70630146907;49390.50609493859;50298.74850625724;51211.23183152256;51776.22335664968;52126;9173.587188576397;9745.415275083518;9787.80424391494;9813.460259685786;9850.507474626096;26493.33766655849;26525.734742652327;27269.86365068162;27448.451030979668;28059;31970.20074498063;32411.015848271636;32774.34451311008;33232.833835830665;33851.4922276171;12387.62837114888;12532.686682833002;12574.559890403792;12575.685607859878;12702.555410560586;14543.418263269774;15578.844211558193;16144.838551614333;16226.107564084088;16512.83487165113;13512.93243533776;13557.728845423233;14568.125912445286;14684.265786710408;14871.107733536022;14659.48691795782;14839.180555694815;14997.550073497812;15070.136674031899;15425.305861236047;13424.597262082154;14159.504417345344;14204.502842400467;14209.573712788633;14301.57095287143;9826.705198844045;9889.85165222508;10123.493825308558;10163.186945044527;10546.894531054591;10849;11142.665720028412;11887;11887.821682674594;12010.519579217083 07:07:42 INFO - PID 3487 | __end_tp_report 07:07:42 INFO - PID 3487 | __start_cc_report 07:07:42 INFO - PID 3487 | _x_x_mozilla_cycle_collect,375 07:07:42 INFO - PID 3487 | __end_cc_report 07:07:42 INFO - PID 3487 | __startTimestamp1494598062244__endTimestamp 07:07:42 INFO - PID 3487 | 07:07:42 INFO - PID 3487 | ------- Summary: start ------- 07:07:42 INFO - PID 3487 | Number of tests: 6 07:07:42 INFO - PID 3487 | 07:07:42 INFO - PID 3487 | [#0] dojo.html Cycles:165 Average:5209.24 Median:5349.06 stddev:614.71 (11.5%) stddev-sans-first:585.24 07:07:42 INFO - PID 3487 | Values: 2738.5 2754.5 2773.4 2785.4 2787.4 5151.3 5289.9 5326.1 5349.1 5379.2 5269.2 5308.0 5328.0 5400.2 5424.6 4370.1 4649.6 4686.3 4701.4 4723.7 4739.9 4748.2 4760.9 4777.9 4780.9 4599.7 4660.7 4660.8 4664.2 4713.9 4684.6 4692.6 4696.0 4705.9 4717.7 4607.5 4642.2 4663.2 4666.8 4669.0 5151.7 5198.8 5212.5 5216.6 5233.6 5679.7 5688.5 5688.6 5694.6 5695.5 5704.1 5707.5 5717.0 5743.5 5812.8 5296.5 5307.4 5337.2 5337.2 5363.0 5874.7 5879.9 5884.4 5889.9 5891.5 5487.2 5570.1 5603.5 5611.1 5707.7 5718.4 5728.8 5728.8 5759.8 5773.2 5691.7 5698.7 5707.7 5708.3 5722.4 5519.0 5618.4 5677.1 5697.0 5711.7 4830.9 4831.6 4832.8 4841.3 4879.9 4103.4 4111.0 4123.1 4136.8 4144.6 4751.0 4816.3 4832.1 4879.6 4896.5 5705.3 5709.7 5725.2 5754.7 5756.9 4818.3 4837.7 4840.4 4843.6 4870.0 4967.2 5034.6 5040.5 5084.9 5093.3 5215.2 5249.8 5268.4 5268.6 5275.8 5628.1 5631.5 5635.2 5640.9 5642.9 5242.7 5262.6 5267.8 5271.2 5274.1 5527.9 5534.6 5608.1 5652.9 5707.7 5780.9 5789.8 5796.3 5799.4 5837.7 5391.0 5494.9 5556.2 5574.4 5587.6 5317.3 5472.7 5481.3 5498.7 5513.5 5435.6 5514.1 5537.4 5540.3 5562.3 5590.3 5606.3 5616.9 5643.2 5647.0 5324.2 5487.9 5491.4 5497.9 5543.8 07:07:42 INFO - PID 3487 | 07:07:42 INFO - PID 3487 | [#1] ext.html Cycles:180 Average:30359.62 Median:16770.03 stddev:41029.34 (244.7%) stddev-sans-first:41083.81 07:07:42 INFO - PID 3487 | Values: 655.3 705.6 720.0 1025.4 1027.8 33055.2 33586.0 33588.5 33654.5 33766.0 35433.3 35604.3 35764.1 35889.3 35941.1 6828.4 6901.6 7023.8 7026.4 7027.0 7019.0 7064.3 7084.4 7105.8 7114.1 6999.4 7109.9 7111.8 7120.8 7135.6 7065.9 7115.7 7117.6 7119.4 7122.3 6963.0 6972.5 6991.5 7031.0 7033.2 31537.7 32071.4 32079.4 32086.5 32302.5 3002.8 3018.3 3047.7 3051.7 3056.8 24618.4 24782.9 24881.8 24924.9 24949.1 3211.8 3225.9 3233.6 3234.0 3259.5 146068.0 146199.0 146428.0 148765.3 152274.0 38911.0 39199.9 39270.0 39303.0 39337.0 40483.4 40563.6 40571.6 43682.1 44646.0 12249.4 12253.0 12269.3 12276.3 12295.9 9756.4 9772.2 9787.6 9791.7 9816.0 12562.8 12575.3 12733.0 12749.5 12797.7 5441.1 5476.8 5553.8 5563.0 5616.4 885.6 911.2 919.4 930.4 958.7 21208.5 21259.6 21264.3 21938.9 22153.2 1010.4 1013.8 1017.1 1017.4 1027.9 11417.7 11440.6 11565.5 11581.5 11668.4 178384.0 178710.0 178766.0 179145.1 179554.0 40700.8 40956.0 41009.0 41047.0 41140.6 1220.3 1254.6 1259.7 1274.6 1277.0 19734.5 19821.1 19944.4 20853.1 21070.7 29674.0 29753.0 29804.4 29805.6 29807.6 147355.0 148267.0 148412.0 149044.0 149610.3 29124.3 29340.9 29364.7 29802.3 30357.0 36016.3 36051.5 36249.8 36366.0 36431.3 26219.6 27452.2 27683.7 27847.6 29203.9 26761.0 26785.0 27688.0 27809.3 28068.0 30488.4 30555.7 30589.7 30611.2 30638.2 26285.6 26430.7 26862.7 27445.6 27789.6 19813.2 22265.2 22360.9 22367.6 22524.4 07:07:42 INFO - PID 3487 | 07:07:42 INFO - PID 3487 | [#2] jquery.html Cycles:180 Average:24648.77 Median:38186.52 stddev:60113.60 (157.4%) stddev-sans-first:60254.67 07:07:42 INFO - PID 3487 | Values: 399.9 400.6 422.2 435.6 435.9 13599.3 17125.7 17442.5 17468.4 17490.6 18095.3 18197.0 18448.6 18457.9 18485.5 5415.4 5428.3 5533.8 5600.5 5642.7 5413.2 5511.7 5524.9 5536.4 5546.2 5275.8 5475.2 5504.8 5507.1 5512.9 5453.7 5477.5 5485.8 5492.5 5509.2 4795.8 4890.9 4927.6 4932.5 4950.6 20773.3 20923.3 21223.0 21315.3 21629.8 1621.4 1646.1 1670.9 1674.7 1677.8 14493.3 14512.2 14797.8 14842.6 14908.9 2018.9 2052.2 2097.9 2106.5 2110.5 92818.0 93071.0 93660.0 93923.0 94377.5 10724.7 10783.8 10948.7 11198.0 11333.7 15431.3 15480.4 15491.3 15505.8 15661.3 7197.6 7238.3 7262.0 7365.6 7475.8 6892.5 7106.3 7144.5 7283.3 7300.2 6588.7 6814.9 6914.2 6930.7 6943.2 2115.8 2127.0 2149.2 2156.0 2371.5 853.7 882.9 887.8 892.4 920.7 15941.2 16447.5 16554.3 16736.5 17225.4 888.8 892.3 904.3 908.3 920.4 8910.8 9164.0 9272.4 9405.3 9454.4 352360.0 355335.0 362500.0 362733.0 363782.0 76919.0 78379.2 78809.0 78982.6 81296.2 1042.6 1059.9 1082.9 1094.6 1098.5 14183.2 14337.3 14495.2 14566.4 15113.6 37670.6 38702.4 38728.6 38906.6 39006.8 47821.3 47928.0 47966.8 48092.0 48208.8 8300.6 8348.5 8363.7 8552.3 8563.9 12584.5 12660.4 12660.7 12942.9 12990.7 10677.1 10703.8 10719.1 10995.8 11076.5 10604.9 10771.6 10774.3 10821.4 10856.6 11190.9 11257.2 11329.4 11345.8 11357.5 8450.6 8462.5 8483.0 8556.5 8612.8 11023.9 11167.2 11270.8 11451.2 11451.9 07:07:42 INFO - PID 3487 | 07:07:42 INFO - PID 3487 | [#3] mootools.html Cycles:180 Average:6368.69 Median:3568.58 stddev:4149.50 (116.3%) stddev-sans-first:4143.45 07:07:42 INFO - PID 3487 | Values: 1269.9 1322.4 1336.2 1338.3 1343.8 10039.0 10501.5 10518.4 10615.2 10705.7 10563.8 10722.5 10750.9 10757.1 10785.8 2249.5 2290.3 2291.6 2291.9 2294.1 2174.2 2207.6 2215.8 2221.4 2226.9 2169.4 2178.4 2216.4 2217.8 2219.9 2094.4 2167.1 2200.9 2202.5 2204.0 2006.5 2141.2 2187.0 2187.0 2206.5 10304.4 10377.8 10379.5 10388.5 10414.2 5624.6 5817.3 5824.8 5826.3 5839.9 3317.3 3442.7 3470.5 3516.1 3525.8 1066.9 1097.3 1108.0 1129.8 1142.5 15100.4 15222.4 15265.4 15267.1 15328.8 4726.4 4772.9 5012.2 5024.3 5052.9 10871.5 10911.6 10999.9 11000.3 11002.3 5733.3 5757.1 5770.7 5771.2 5792.5 5234.0 5356.8 5373.9 5375.2 5430.4 3652.3 3894.6 3898.4 3930.9 3945.8 1115.1 1118.0 1122.1 1129.5 1147.8 687.3 699.3 700.6 701.6 717.4 5275.2 5425.1 5426.5 5474.3 5495.1 537.2 551.7 553.2 553.7 563.3 3352.6 3611.3 3704.0 3730.1 3828.3 13251.7 13634.3 13901.6 13922.0 13927.2 13160.5 13473.5 13747.7 13756.0 13787.7 7532.6 7557.2 7629.7 7654.0 7660.0 5473.4 5479.8 5543.2 5653.1 5658.9 11930.1 12070.6 12095.4 12210.3 12305.1 12000.9 12403.3 12406.6 12572.7 12617.9 8404.5 8514.9 8625.5 8629.4 8648.3 9738.0 9827.4 9858.0 9861.8 9872.5 7945.0 8053.4 8208.1 8344.2 8352.3 7624.5 7707.3 7736.4 7759.6 7850.1 7562.8 7713.7 7717.5 7730.8 7734.3 4988.7 5043.2 5047.3 5214.8 5279.3 5149.8 5303.7 5419.5 5427.8 5509.1 07:07:42 INFO - PID 3487 | 07:07:42 INFO - PID 3487 | [#4] prototype.html Cycles:180 Average:4844.19 Median:5432.71 stddev:1374.46 (25.3%) stddev-sans-first:1336.71 07:07:42 INFO - PID 3487 | Values: 373.1 398.5 400.4 403.4 406.2 5445.6 5534.8 5582.6 5597.0 5608.2 5322.2 5434.3 5437.4 5439.5 5448.2 4070.6 4074.0 4082.6 4110.2 4117.0 4124.6 4130.6 4132.8 4153.3 4316.5 4306.8 4316.9 4319.9 4327.6 4327.8 4321.2 4322.5 4339.6 4343.3 4352.2 3863.9 3976.5 3977.4 3978.6 3982.9 5344.6 5358.0 5372.6 5399.1 5431.1 5166.3 5176.4 5187.9 5192.8 5213.9 5773.3 5791.0 5806.0 5865.6 5877.4 4450.9 4458.4 4468.7 4474.0 4482.2 5926.4 6120.4 6126.5 6131.2 6193.7 4272.0 4276.1 4281.1 4287.1 4289.7 4339.6 4349.0 4351.3 4352.4 4356.4 4949.2 4953.9 4972.8 5134.6 5162.1 5884.1 5884.4 5885.9 5893.8 5900.2 1610.3 1629.3 1632.6 1638.2 1638.5 1150.9 1154.9 1160.3 1165.2 1171.8 5017.2 5020.6 5024.8 5033.6 5035.9 5967.8 6009.9 6014.6 6020.4 6055.5 4831.9 4999.4 5044.9 5048.6 5059.6 3159.6 3184.6 3189.3 3190.6 3191.3 5476.4 5573.2 5603.7 5610.6 5613.1 6158.7 6159.6 6173.8 6183.5 6183.6 5590.7 5598.9 5601.2 5604.5 5610.1 5795.4 5994.1 6028.6 6034.3 6047.8 5754.5 5966.9 5972.7 5979.3 5998.7 5538.6 5582.7 5601.4 5601.8 5634.7 4087.6 4117.6 4122.0 4123.1 4134.7 5891.3 5970.5 6000.7 6049.7 6050.2 5772.1 5777.9 5778.8 5803.3 5828.4 5788.5 5789.4 5793.4 5797.4 5807.1 5486.2 5656.5 5705.4 5717.4 5725.9 5790.7 5811.7 5813.2 5816.4 5825.1 5494.9 5607.3 5627.5 5641.5 5661.2 07:07:42 INFO - PID 3487 | 07:07:42 INFO - PID 3487 | [#5] yui.html Cycles:180 Average:15274.72 Median:33542.16 stddev:18224.42 (54.3%) stddev-sans-first:18242.86 07:07:42 INFO - PID 3487 | Values: 739.7 762.0 762.7 768.7 781.3 11326.2 11669.2 12314.9 12852.8 12864.5 14787.7 15068.9 15486.7 15502.1 15678.4 836.8 848.0 849.0 849.1 849.5 868.4 896.6 897.0 897.7 898.4 914.5 945.8 948.5 955.3 956.7 899.5 949.1 949.2 950.1 951.3 670.9 683.2 698.7 703.9 704.9 14517.5 14569.3 14705.8 14980.4 15069.4 15479.8 15718.6 15792.7 16075.0 16133.4 12579.3 12750.4 12848.0 12950.5 12970.3 3019.5 3037.8 3044.8 3046.5 3058.1 71764.3 72725.3 72805.6 73533.6 75693.0 11248.1 11483.9 11488.0 11490.0 11502.5 20302.8 21159.5 21232.5 21411.4 21459.1 6062.1 6204.2 6235.9 6267.4 6274.4 3070.4 3119.5 3144.3 3145.9 3147.0 3542.2 3565.2 3604.6 3614.4 3640.1 731.9 751.8 754.7 754.9 757.2 557.9 584.6 585.0 594.3 628.4 9192.7 10101.5 10669.7 10947.9 11129.6 580.0 587.7 603.0 611.5 639.2 4554.2 4686.3 4751.9 4787.9 4958.7 60646.0 62707.0 62952.4 64251.7 64743.7 57216.8 57807.4 57853.7 58004.0 58739.7 49390.5 50298.7 51211.2 51776.2 52126.0 9173.6 9745.4 9787.8 9813.5 9850.5 26493.3 26525.7 27269.9 27448.5 28059.0 31970.2 32411.0 32774.3 33232.8 33851.5 12387.6 12532.7 12574.6 12575.7 12702.6 14543.4 15578.8 16144.8 16226.1 16512.8 13512.9 13557.7 14568.1 14684.3 14871.1 14659.5 14839.2 14997.6 15070.1 15425.3 13424.6 14159.5 14204.5 14209.6 14301.6 9826.7 9889.9 10123.5 10163.2 10546.9 10849.0 11142.7 11887.0 11887.8 12010.5 07:07:42 INFO - PID 3487 | -------- Summary: end -------- 07:07:42 INFO - PID 3487 | 07:07:43 INFO - TEST-INFO | 3487: exit 0 07:07:43 INFO - TEST-OK | dromaeo_css | took 1120607ms 07:07:43 INFO - TEST-START | kraken 07:07:43 INFO - operating with platform_type : linux_ 07:07:43 INFO - Initialising browser for kraken test... 07:07:43 INFO - TEST-INFO | started process 3920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoobVGH/profile http://localhost:56299/getInfo.html) 07:07:47 INFO - PID 3920 | __metrics Screen width/height:1600/1200 07:07:47 INFO - PID 3920 | colorDepth:24 07:07:47 INFO - PID 3920 | Browser inner width/height: 1024/695 07:07:47 INFO - PID 3920 | __metrics 07:07:49 INFO - TEST-INFO | 3920: exit 0 07:07:49 INFO - Browser initialized. 07:07:49 INFO - Running cycle 1/1 for kraken test... 07:07:49 INFO - TEST-INFO | started process 4112 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoobVGH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:08:00 INFO - PID 4112 | RSS: Main: 171835392 07:08:00 INFO - PID 4112 | 07:08:03 INFO - PID 4112 | Cycle 1(1): loaded http://localhost:56299/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56299/tests/kraken/driver.html?testName=audio-beat-detection) 07:08:04 INFO - PID 4112 | RSS: Main: 180584448 07:08:04 INFO - PID 4112 | 07:08:07 INFO - PID 4112 | Cycle 1(1): loaded http://localhost:56299/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56299/tests/kraken/driver.html?testName=audio-dft) 07:08:07 INFO - PID 4112 | RSS: Main: 180375552 07:08:07 INFO - PID 4112 | 07:08:10 INFO - PID 4112 | Cycle 1(1): loaded http://localhost:56299/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56299/tests/kraken/driver.html?testName=audio-fft) 07:08:11 INFO - PID 4112 | RSS: Main: 176881664 07:08:11 INFO - PID 4112 | 07:08:13 INFO - PID 4112 | Cycle 1(1): loaded http://localhost:56299/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56299/tests/kraken/driver.html?testName=audio-oscillator) 07:08:14 INFO - PID 4112 | RSS: Main: 177582080 07:08:14 INFO - PID 4112 | 07:08:16 INFO - PID 4112 | Cycle 1(1): loaded http://localhost:56299/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56299/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:08:17 INFO - PID 4112 | RSS: Main: 178040832 07:08:17 INFO - PID 4112 | 07:08:20 INFO - PID 4112 | Cycle 1(1): loaded http://localhost:56299/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56299/tests/kraken/driver.html?testName=imaging-darkroom) 07:08:20 INFO - PID 4112 | RSS: Main: 180989952 07:08:20 INFO - PID 4112 | 07:08:24 INFO - PID 4112 | Cycle 1(1): loaded http://localhost:56299/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56299/tests/kraken/driver.html?testName=imaging-desaturate) 07:08:25 INFO - PID 4112 | RSS: Main: 180011008 07:08:25 INFO - PID 4112 | 07:08:27 INFO - PID 4112 | Cycle 1(1): loaded http://localhost:56299/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56299/tests/kraken/driver.html?testName=json-parse-financial) 07:08:28 INFO - PID 4112 | RSS: Main: 181272576 07:08:28 INFO - PID 4112 | 07:08:30 INFO - PID 4112 | Cycle 1(1): loaded http://localhost:56299/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56299/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:08:30 INFO - PID 4112 | RSS: Main: 182288384 07:08:30 INFO - PID 4112 | 07:08:32 INFO - PID 4112 | Cycle 1(1): loaded http://localhost:56299/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56299/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:08:33 INFO - PID 4112 | RSS: Main: 182968320 07:08:33 INFO - PID 4112 | 07:08:35 INFO - PID 4112 | Cycle 1(1): loaded http://localhost:56299/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56299/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:08:36 INFO - PID 4112 | RSS: Main: 182865920 07:08:36 INFO - PID 4112 | 07:08:38 INFO - PID 4112 | Cycle 1(1): loaded http://localhost:56299/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56299/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:08:39 INFO - PID 4112 | RSS: Main: 182804480 07:08:39 INFO - PID 4112 | 07:08:42 INFO - PID 4112 | Cycle 1(1): loaded http://localhost:56299/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56299/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:08:43 INFO - PID 4112 | RSS: Main: 182820864 07:08:43 INFO - PID 4112 | 07:08:45 INFO - PID 4112 | Cycle 1(1): loaded http://localhost:56299/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56299/tests/kraken/driver.html?testName=ai-astar) 07:08:45 INFO - PID 4112 | RSS: Main: 184139776 07:08:45 INFO - PID 4112 | 07:08:45 INFO - PID 4112 | __start_tp_report 07:08:45 INFO - PID 4112 | _x_x_mozilla_page_load 07:08:45 INFO - PID 4112 | _x_x_mozilla_page_load_details 07:08:45 INFO - PID 4112 | |i|pagename|runs| 07:08:45 INFO - PID 4112 | |0;ai-astar;103;112;115;114;116;114;111;110;112;113 07:08:45 INFO - PID 4112 | |1;audio-beat-detection;146;123;126;170;121;121;122;121;154;122 07:08:45 INFO - PID 4112 | |2;audio-dft;163;165;162;164;168;169;171;163;163;161 07:08:45 INFO - PID 4112 | |3;audio-fft;76;77;75;120;75;77;76;77;93;75 07:08:45 INFO - PID 4112 | |4;audio-oscillator;83;82;106;83;85;86;94;84;82;107 07:08:45 INFO - PID 4112 | |5;imaging-gaussian-blur;114;114;113;115;115;115;114;115;114;116 07:08:45 INFO - PID 4112 | |6;imaging-darkroom;150;150;152;150;150;150;150;148;151;150 07:08:45 INFO - PID 4112 | |7;imaging-desaturate;94;94;95;94;94;94;94;95;95;95 07:08:45 INFO - PID 4112 | |8;json-parse-financial;53;54;58;58;56;59;54;54;55;58 07:08:45 INFO - PID 4112 | |9;json-stringify-tinderbox;56;57;56;56;56;56;56;56;56;56 07:08:45 INFO - PID 4112 | |10;stanford-crypto-aes;92;83;91;86;86;83;83;83;83;86 07:08:45 INFO - PID 4112 | |11;stanford-crypto-ccm;133;135;133;131;140;133;136;134;187;135 07:08:45 INFO - PID 4112 | |12;stanford-crypto-pbkdf2;193;209;203;196;217;190;194;191;187;199 07:08:45 INFO - PID 4112 | |13;stanford-crypto-sha256-iterative;74;73;81;77;73;74;73;78;73;74 07:08:45 INFO - PID 4112 | __end_tp_report 07:08:45 INFO - PID 4112 | __start_cc_report 07:08:45 INFO - PID 4112 | _x_x_mozilla_cycle_collect,861 07:08:45 INFO - PID 4112 | __end_cc_report 07:08:45 INFO - PID 4112 | __startTimestamp1494598125542__endTimestamp 07:08:45 INFO - PID 4112 | 07:08:45 INFO - PID 4112 | ------- Summary: start ------- 07:08:45 INFO - PID 4112 | Number of tests: 14 07:08:45 INFO - PID 4112 | 07:08:45 INFO - PID 4112 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.50 stddev:3.65 (3.2%) stddev-sans-first:1.94 07:08:45 INFO - PID 4112 | Values: 103.0 112.0 115.0 114.0 116.0 114.0 111.0 110.0 112.0 113.0 07:08:45 INFO - PID 4112 | 07:08:45 INFO - PID 4112 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:124.50 stddev:17.64 (14.2%) stddev-sans-first:18.03 07:08:45 INFO - PID 4112 | Values: 146.0 123.0 126.0 170.0 121.0 121.0 122.0 121.0 154.0 122.0 07:08:45 INFO - PID 4112 | 07:08:45 INFO - PID 4112 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.50 stddev:3.31 (2.0%) stddev-sans-first:3.44 07:08:45 INFO - PID 4112 | Values: 163.0 165.0 162.0 164.0 168.0 169.0 171.0 163.0 163.0 161.0 07:08:45 INFO - PID 4112 | 07:08:45 INFO - PID 4112 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.50 stddev:14.37 (18.8%) stddev-sans-first:15.07 07:08:45 INFO - PID 4112 | Values: 76.0 77.0 75.0 120.0 75.0 77.0 76.0 77.0 93.0 75.0 07:08:45 INFO - PID 4112 | 07:08:45 INFO - PID 4112 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:83.50 stddev:9.76 (11.7%) stddev-sans-first:10.09 07:08:45 INFO - PID 4112 | Values: 83.0 82.0 106.0 83.0 85.0 86.0 94.0 84.0 82.0 107.0 07:08:45 INFO - PID 4112 | 07:08:45 INFO - PID 4112 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:115.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 07:08:45 INFO - PID 4112 | Values: 114.0 114.0 113.0 115.0 115.0 115.0 114.0 115.0 114.0 116.0 07:08:45 INFO - PID 4112 | 07:08:45 INFO - PID 4112 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 07:08:45 INFO - PID 4112 | Values: 150.0 150.0 152.0 150.0 150.0 150.0 150.0 148.0 151.0 150.0 07:08:45 INFO - PID 4112 | 07:08:45 INFO - PID 4112 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:08:45 INFO - PID 4112 | Values: 94.0 94.0 95.0 94.0 94.0 94.0 94.0 95.0 95.0 95.0 07:08:45 INFO - PID 4112 | 07:08:45 INFO - PID 4112 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:57.00 stddev:2.18 (3.8%) stddev-sans-first:2.05 07:08:45 INFO - PID 4112 | Values: 53.0 54.0 58.0 58.0 56.0 59.0 54.0 54.0 55.0 58.0 07:08:45 INFO - PID 4112 | 07:08:45 INFO - PID 4112 | [#9] json-stringify-tinderbox Cycles:10 Average:56.10 Median:56.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 07:08:45 INFO - PID 4112 | Values: 56.0 57.0 56.0 56.0 56.0 56.0 56.0 56.0 56.0 56.0 07:08:45 INFO - PID 4112 | 07:08:45 INFO - PID 4112 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.00 stddev:3.41 (4.0%) stddev-sans-first:2.71 07:08:45 INFO - PID 4112 | Values: 92.0 83.0 91.0 86.0 86.0 83.0 83.0 83.0 83.0 86.0 07:08:45 INFO - PID 4112 | 07:08:45 INFO - PID 4112 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:135.00 stddev:16.79 (12.4%) stddev-sans-first:17.64 07:08:45 INFO - PID 4112 | Values: 133.0 135.0 133.0 131.0 140.0 133.0 136.0 134.0 187.0 135.0 07:08:45 INFO - PID 4112 | 07:08:45 INFO - PID 4112 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.90 Median:197.50 stddev:9.35 (4.7%) stddev-sans-first:9.75 07:08:45 INFO - PID 4112 | Values: 193.0 209.0 203.0 196.0 217.0 190.0 194.0 191.0 187.0 199.0 07:08:45 INFO - PID 4112 | 07:08:45 INFO - PID 4112 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.00 Median:74.00 stddev:2.75 (3.7%) stddev-sans-first:2.89 07:08:45 INFO - PID 4112 | Values: 74.0 73.0 81.0 77.0 73.0 74.0 73.0 78.0 73.0 74.0 07:08:45 INFO - PID 4112 | -------- Summary: end -------- 07:08:45 INFO - PID 4112 | 07:08:46 INFO - TEST-INFO | 4112: exit 0 07:08:46 INFO - TEST-OK | kraken | took 63653ms 07:08:46 INFO - SUITE-END | took 1184s 07:08:47 INFO - Completed test suite (00:19:44) 07:08:47 INFO - javascript benchmark 07:08:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6756.704353532585, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2738.5481395569727, 2754.4904192724334, 2773.445310937813, 2785.4150628368047, 2787.442511497701, 5151.330327057487, 5289.947100528999, 5326.067938110835, 5349.063913815086, 5379.220013098098, 5269.1832765921245, 5308.0, 5327.973360133204, 5400.216968539569, 5424.593155513323, 4370.063571566169, 4649.558291962258, 4686.27362758773, 4701.43582770068, 4723.692959957609, 4739.857804265877, 4748.216544270192, 4760.880977975544, 4777.90444191116, 4780.90438191236, 4599.701019433726, 4660.72035677857, 4660.790264438108, 4664.183767840648, 4713.858584242478, 4684.648651351128, 4692.577668009895, 4696.0, 4705.905881882343, 4717.716936983792, 4607.516210797885, 4642.210824159901, 4663.207254766664, 4666.766661666937, 4668.953310466886, 5151.742412879341, 5198.766055527472, 5212.50481204285, 5216.582673386158, 5233.581313494949, 5679.687617181054, 5688.544916406678, 5688.60179787415, 5694.629849059798, 5695.45893140151, 5704.11586204139, 5707.486326230659, 5716.971415142898, 5743.4543718346695, 5812.796552120655, 5296.523312901857, 5307.4427185145005, 5337.172738225542, 5337.226102215234, 5363.03465376236, 5874.676892770939, 5879.882402351929, 5884.352721200665, 5889.852753681106, 5891.49922256613, 5487.2317875497465, 5570.053090974544, 5603.467670571289, 5611.102223644198, 5707.686077265707, 5718.399568045378, 5728.770849165987, 5728.77084916607, 5759.827205183851, 5773.16289138081, 5691.658500489901, 5698.686572238484, 5707.71461426927, 5708.286464191976, 5722.399148089391, 5519.0, 5618.410066942912, 5677.148427735872, 5696.971515142481, 5711.742971566289, 4830.879228019257, 4831.637627177975, 4832.758362081881, 4841.273808928689, 4879.878003049881, 4103.363978583325, 4111.033907031845, 4123.0516981094515, 4136.793160341971, 4144.647704945053, 4750.95249047512, 4816.325714399917, 4832.106060378841, 4879.634027447955, 4896.4858689837765, 5705.286839145107, 5709.65742055478, 5725.227094342211, 5754.683492407958, 5756.913646295309, 4818.349522814376, 4837.6613637045775, 4840.419149702058, 4843.588294994965, 4870.025994801054, 4967.205247160437, 5034.572061374678, 5040.521150490697, 5084.949150508522, 5093.312402825572, 5215.1964145524225, 5249.842504724865, 5268.394134674561, 5268.631195816256, 5275.841724748264, 5628.127640215773, 5631.521320687787, 5635.239242702182, 5640.915386269291, 5642.88714225705, 5242.711650859239, 5262.552683021986, 5267.762950667306, 5271.182966640177, 5274.077036518671, 5527.8894422112135, 5534.640248383842, 5608.10270356741, 5652.886942261214, 5707.714614269187, 5780.884382312414, 5789.797357092481, 5796.333421656564, 5799.362070172193, 5837.737301821343, 5391.002664507078, 5494.890102198014, 5556.249906262765, 5574.386817450159, 5587.580931430078, 5317.308749862493, 5472.699001554953, 5481.342238931354, 5498.725063746717, 5513.5037846594, 5435.592330575144, 5514.09017512106, 5537.418571049981, 5540.307461567304, 5562.332520097614, 5590.273264475592, 5606.327240731139, 5616.85957851057, 5643.238162847963, 5646.971765141148, 5324.227986941949, 5487.890242195054, 5491.395946445968, 5497.945020549903, 5543.778248870161], "value": 5164.738489988578, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.2824657000585, 705.5837056136879, 719.9992011104564, 1025.3796453145842, 1027.7584767579613, 33055.173620659494, 33586.0, 33588.4961725574, 33654.49518257228, 33766.0, 35433.2913341733, 35604.2879142417, 35764.10589735258, 35889.282214355764, 35941.10147246314, 6828.385445309921, 6901.551399159039, 7023.789286321418, 7026.43788496919, 7026.964865175667, 7018.964905175467, 7064.25825288345, 7084.362407383334, 7105.751298704547, 7114.146302443714, 6999.370056694896, 7109.8933515997305, 7111.751088711896, 7120.750773722921, 7135.607541585211, 7065.89401158983, 7115.679794409264, 7117.608531530764, 7119.430445564342, 7122.252163522808, 6962.965185174042, 6972.546784458994, 6991.47563932702, 7031.0, 7033.156021277428, 31537.684623153706, 32071.358572828645, 32079.358412831614, 32086.518702219484, 32302.515462268086, 3002.7597792176575, 3018.2907016851022, 3047.6799936006623, 3051.6643169251365, 3056.8165910045245, 24618.384540386454, 24782.87608561964, 24881.751182488126, 24924.875375623007, 24949.126780562594, 3211.7912335698106, 3225.8870939517237, 3233.6281327647384, 3234.0, 3259.4784834426378, 146067.99999999892, 146199.0, 146428.0, 148765.33025353317, 152274.0, 38911.0, 39199.864010879064, 39270.0, 39303.0, 39337.0, 40483.39274910879, 40563.594364056575, 40571.59428405678, 43682.12635747331, 44646.0, 12249.387530623611, 12253.0, 12269.263844169378, 12276.324802135969, 12295.938520307342, 9756.365781239027, 9772.21822254218, 9787.608495660093, 9791.706248812547, 9816.0, 12562.81155782664, 12575.308358040396, 12733.0, 12749.490020399266, 12797.680057998437, 5441.129419292894, 5476.808311709071, 5553.750081246354, 5562.972185139049, 5616.354119276336, 885.6457417033109, 911.2300106410073, 919.4391421233042, 930.3812964378612, 958.6500927161675, 21208.469788255108, 21259.574808504054, 21264.25575104864, 21938.890305548688, 22153.224637137624, 1010.4291075542295, 1013.8124446977333, 1017.1151098544314, 1017.4099022566893, 1027.9229057820694, 11417.68696599885, 11440.599579014695, 11565.537378504765, 11581.478833452515, 11668.416579171007, 178384.0, 178710.0, 178766.0, 179145.1042744804, 179554.0, 40700.796496017334, 40956.0, 41009.0, 41047.0, 41140.58859411367, 1220.3410158514303, 1254.5734450286764, 1259.6724851538665, 1274.5666473398903, 1276.9808452873215, 19734.506637334183, 19821.062628080057, 19944.401667949984, 20853.061612227182, 21070.68393974061, 29674.0, 29753.0, 29804.403911922072, 29805.5529167067, 29807.552886706282, 147355.0, 148267.0, 148412.0, 149044.0, 149610.25194873955, 29124.252544847375, 29340.853295733385, 29364.706352937053, 29802.254943626584, 30357.0, 36016.27967440689, 36051.459228111074, 36249.81875090713, 36366.0, 36431.27137457289, 26219.606705899045, 27452.17643470699, 27683.72316276892, 27847.58228626532, 29203.85398072996, 26761.0, 26785.0, 27688.030918917742, 27809.304767380978, 28068.0, 30488.390232195674, 30555.694443056174, 30589.694103058686, 30611.2347191322, 30638.234044149074, 26285.605715913895, 26430.735692642826, 26862.731372686805, 27445.588316174875, 27789.58315625227, 19813.245995639776, 22265.220717274817, 22360.888195558917, 22367.552648946603, 22524.436889077904], "value": 14578.137092365674, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.894028082558, 400.6074047433517, 422.2062522457779, 435.6231859441583, 435.86488188661497, 13599.320033998285, 17125.74311385329, 17442.47672569825, 17468.388606398777, 17490.56273593159, 18095.276188952426, 18197.0, 18448.631027379477, 18457.90771046143, 18485.537861553436, 5415.377231618355, 5428.294321738178, 5533.778648854041, 5600.467955544217, 5642.689652069134, 5413.160960051198, 5511.724413779315, 5524.944750552483, 5536.4186760390185, 5546.168074788794, 5275.788968441258, 5475.233467314579, 5504.834854954358, 5507.118860982244, 5512.91730624041, 5453.727313634322, 5477.4796394342475, 5485.753141108639, 5492.478214569649, 5509.173623956399, 4795.808167673289, 4890.926636100461, 4927.581155601778, 4932.506749325074, 4950.579200767939, 20773.27293544719, 20923.26768563093, 21223.0, 21315.253966111268, 21629.783702162935, 1621.3595629726192, 1646.1357787161717, 1670.899746015243, 1674.6650669865953, 1677.8406051425095, 14493.347799349054, 14512.201828899406, 14797.778033329509, 14842.554723358317, 14908.925455372762, 2018.929337473196, 2052.220156340581, 2097.8846163461003, 2106.493856892314, 2110.482931681732, 92818.0, 93071.0, 93660.0, 93923.0, 94377.52811235968, 10724.678259652223, 10783.78432431347, 10948.726281842859, 11198.0, 11333.716657083638, 15431.305591248421, 15480.380784768484, 15491.302891369915, 15505.767413488808, 15661.29524171415, 7197.604131772803, 7238.304568274325, 7262.04291252072, 7365.558066516026, 7475.813104672427, 6892.517523773388, 7106.253843346478, 7144.535605185646, 7283.308085731847, 7300.196978332379, 6588.703508342136, 6814.897776533356, 6914.1702995639835, 6930.688119034656, 6943.236244013155, 2115.843423602023, 2126.957460850774, 2149.21553632926, 2155.978440215609, 2371.5494056129623, 853.7225401744458, 882.938194326391, 887.8179973105628, 892.4422236102436, 920.7145784806731, 15941.202939852961, 16447.506574802774, 16554.337826487048, 16736.497905062868, 17225.3971111013, 888.7689200807837, 892.2817132208505, 904.2765787370078, 908.3459908865606, 920.3833431600843, 8910.821783564423, 9163.95418022919, 9272.443653380818, 9405.341626086245, 9454.43273403598, 352360.0, 355335.0, 362500.0, 362733.0, 363782.0, 76919.0, 78379.21620783833, 78809.0, 78982.60508697535, 81296.18703813004, 1042.6246551241395, 1059.9152067834555, 1082.880883102858, 1094.5512339940585, 1098.5111625326654, 14183.21992290434, 14337.283135843374, 14495.20276384809, 14566.41734330615, 15113.622159446102, 37670.62329376781, 38702.419463707505, 38728.61271387363, 38906.6109338903, 39006.80496597499, 47821.28268076051, 47928.0, 47966.76016619895, 48092.0, 48208.758956206395, 8300.584970751317, 8348.457350272212, 8363.745438184078, 8552.273056790242, 8563.914360856312, 12584.496620135458, 12660.430280637209, 12660.683482913, 12942.870571294166, 12990.675233119247, 10677.09244714208, 10703.839442408525, 10719.088877445505, 10995.835062474229, 11076.501557430096, 10604.89395106039, 10771.6229931952, 10774.299670521392, 10821.350718956888, 10856.565737370416, 11190.94404527972, 11257.155713321697, 11329.376884271443, 11345.773084538429, 11357.48891299877, 8450.577471126297, 8462.534560599226, 8483.0, 8556.486610803371, 8612.827743445221, 11023.889761102608, 11167.218294719292, 11270.83093753578, 11451.198416111125, 11451.942740286579], "value": 8810.96526918235, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1269.8857102860743, 1322.3586560518154, 1336.2116351352704, 1338.2907059258596, 1343.8051482535034, 10039.04629060239, 10501.474926253695, 10518.368897866134, 10615.203859710533, 10705.732356691087, 10563.788724225511, 10722.517486713097, 10750.935983244777, 10757.085647719954, 10785.83821242682, 2249.4713742270555, 2290.3014580552926, 2291.598970180212, 2291.9312420627325, 2294.139697613395, 2174.1738139507042, 2207.62470380035, 2215.7784221577795, 2221.4002219400754, 2226.92205772798, 2169.381726208031, 2178.3900507857747, 2216.423729830248, 2217.8225741940687, 2219.933401997943, 2094.392626138433, 2167.0789914286443, 2200.8789516576503, 2202.493426511895, 2203.966940495894, 2006.4883454718954, 2141.1649456711893, 2186.9890650546804, 2187.0, 2206.5476577301615, 10304.381737095799, 10377.84433233502, 10379.532921018572, 10388.480575971247, 10414.218933580012, 5624.55003599711, 5817.272840894888, 5824.796132135355, 5826.300843898759, 5839.941600583982, 3317.270200555874, 3442.6557344265625, 3470.4620783778555, 3516.0682419158943, 3525.806080665562, 1066.8879767624364, 1097.2827524923468, 1107.9944600277029, 1129.7514546799773, 1142.5087212498622, 15100.395984160621, 15222.391104355813, 15265.389384424721, 15267.083974961537, 15328.846711532853, 4726.432828060655, 4772.880677983008, 5012.24816277554, 5024.346834911511, 5052.9242061369105, 10871.51078201467, 10911.618093366853, 10999.945000274947, 11000.284981476338, 11002.33985960845, 5733.3406658234835, 5757.050086735641, 5770.653760774367, 5771.249737534094, 5792.536597072224, 5233.973830130825, 5356.758945847446, 5373.892522149613, 5375.193720941812, 5430.375506816687, 3652.3243200008083, 3894.6105389461395, 3898.3567711327314, 3930.941035884464, 3945.8421663133154, 1115.0800589513683, 1118.0440723181725, 1122.119136477861, 1129.4860838318546, 1147.7991351513451, 687.295522089862, 699.3111784891878, 700.6006576251488, 701.5580184483742, 717.433227750082, 5275.182346736262, 5425.13197888336, 5426.538744206787, 5474.343078830566, 5495.065838807413, 537.1539824775994, 551.7434393007271, 553.23653358366, 553.7120697237494, 563.3043191658298, 3352.580927384077, 3611.349957007764, 3704.0369503929173, 3730.123420996064, 3828.3300422426523, 13251.73496530064, 13634.250116243504, 13901.58295251144, 13922.0, 13927.234002129777, 13160.47358105665, 13473.528426505221, 13747.656308592164, 13756.0, 13787.690169433889, 7532.585707786125, 7557.244275572509, 7629.694812207561, 7653.961730191313, 7660.0, 5473.370562385217, 5479.780808767605, 5543.1685247213245, 5653.067243904709, 5658.85852853682, 11930.105242106703, 12070.637880863587, 12095.395230238277, 12210.26738395699, 12305.138640295094, 12000.879991199976, 12403.317817519763, 12406.565770198, 12572.748545029232, 12617.93691031539, 8404.453710508797, 8514.872276915727, 8625.482471051757, 8629.352798540009, 8648.264897483532, 9737.951310243403, 9827.361221520578, 9858.014198580084, 9861.802763944537, 9872.45701486425, 7945.0, 8053.395995300493, 8208.09710931785, 8344.207300306462, 8352.331813454788, 7624.466287359832, 7707.267809558083, 7736.419768517496, 7759.6120193988945, 7850.057993040643, 7562.848743025219, 7713.730019449293, 7717.498362606412, 7730.7680769577, 7734.303912647889, 4988.725620090785, 5043.218301163325, 5047.318611987334, 5214.817481388133, 5279.340082489689, 5149.794008239628, 5303.708296043755, 5419.458054194549, 5427.83716488506, 5509.118541033416], "value": 4731.46875741694, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.0598890795196, 398.4680451597118, 400.35942492012776, 403.44526276369993, 406.2383031815346, 5445.646033007852, 5534.833954981352, 5582.637128586639, 5596.972015139929, 5608.214849921004, 5322.175062865253, 5434.347878254605, 5437.429069947658, 5439.4832490913395, 5448.182772584114, 4070.6132917372875, 4073.9592604074023, 4082.632563069323, 4110.219058378899, 4116.958830411688, 4124.638419687944, 4130.648894843942, 4132.8140233689555, 4153.293940030187, 4316.525182229952, 4306.8277268909205, 4316.892077698051, 4319.913601727963, 4327.567243275663, 4327.805248763813, 4321.243782338078, 4322.502912165094, 4339.631131353839, 4343.326784348431, 4352.151330490556, 3863.8840834775, 3976.4631774710333, 3977.443157957888, 3978.602139785998, 3982.8734443461744, 5344.599155063386, 5357.973210133924, 5372.57019438444, 5399.136138217906, 5431.071969450828, 5166.276721259027, 5176.404713457925, 5187.948120518822, 5192.844214673566, 5213.921791173136, 5773.3318017689635, 5791.0, 5806.0, 5865.648061116304, 5877.382874798127, 4450.910981780346, 4458.398116254297, 4468.664850136252, 4474.0, 4482.170798402306, 5926.4073592640825, 6120.387961203933, 6126.479249263773, 6131.233595800525, 6193.659348735818, 4271.978640106841, 4276.123394704078, 4281.116308824107, 4287.121140166259, 4289.656827453796, 4339.589633369168, 4349.0, 4351.282038463682, 4352.368906508602, 4356.3683265926265, 4949.232868905326, 4953.925691114636, 4972.801087956441, 5134.614903882224, 5162.148245539519, 5884.11738239259, 5884.382139875337, 5885.882282354414, 5893.764249430061, 5900.232969713909, 1610.2673283655909, 1629.3482606957075, 1632.6081740382224, 1638.2054703468807, 1638.5493989153078, 1150.8734039255676, 1154.9133814963911, 1160.2632328471482, 1165.1785491228663, 1171.8047591456666, 5017.247412888096, 5020.598352131894, 5024.84925452237, 5033.5721463676, 5035.924461133086, 5967.761289548456, 6009.879802403927, 6014.6391216527145, 6020.367861374492, 6055.485283750931, 4831.903361932742, 4999.400071991385, 5044.899102017939, 5048.570871475892, 5059.595232381401, 3159.557661927332, 3184.5700830388064, 3189.2824114574037, 3190.633077196152, 3191.250056236829, 5476.397596264408, 5573.164025396142, 5603.7478313475995, 5610.635308704921, 5613.053147097725, 6158.7228574714245, 6159.568830181934, 6173.84565385869, 6183.505319574423, 6183.5884005237995, 5590.720463976866, 5598.916016259759, 5601.215829783833, 5604.542818867206, 5610.102383618601, 5795.420457954171, 5994.13085102649, 6028.57799953999, 6034.275886893425, 6047.848803779941, 5754.539636829128, 5966.880662386815, 5972.671503067199, 5979.252593425822, 5998.70006499682, 5538.556915446674, 5582.720863956867, 5601.355844077983, 5601.775928962796, 5634.74643641029, 4087.6321131097156, 4117.649999750055, 4122.0, 4123.092919557693, 4134.669226461936, 5891.263592050994, 5970.462658360769, 6000.69996500182, 6049.727762250621, 6050.21347224858, 5772.105323674838, 5777.8555536111935, 5778.797742079007, 5803.332616749128, 5828.388019258086, 5788.479036886532, 5789.3921138279875, 5793.362730099601, 5797.362290148165, 5807.070868660994, 5486.231927530229, 5656.547476201977, 5705.372409035086, 5717.42825717425, 5725.942740572541, 5790.710464476675, 5811.704376771237, 5813.215215945793, 5816.41835816415, 5825.126231065374, 5494.890102198014, 5607.271054763018, 5627.493525582717, 5641.464060914206, 5661.207430959751], "value": 4436.282683733321, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.7226040234912, 762.0322190817661, 762.6720510180623, 768.650264129821, 781.289026985443, 11326.150538709588, 11669.183157179, 12314.938425307872, 12852.807207891878, 12864.485420583178, 14787.704245915102, 15068.924655376735, 15486.69026619467, 15502.147381893992, 15678.372865085383, 836.7531578184451, 848.0247715127622, 849.0109022988212, 849.1254008371387, 849.5072857742525, 868.3660927522881, 896.6413434626137, 896.9596368163416, 897.6723495924006, 898.3711402018613, 914.4787471141452, 945.8344789661816, 948.5020364308724, 955.2930831184908, 956.6986399284203, 899.4827973914993, 949.0651708067548, 949.2216382566264, 950.1401231885086, 951.3198063384713, 670.9094272273229, 683.2313647146959, 698.6751160710294, 703.9155301363869, 704.9154101507801, 14517.491887783983, 14569.271536423137, 14705.779413308808, 14980.400783968627, 15069.43819550668, 15479.845201547952, 15718.607034824106, 15792.684146317124, 16075.035497870165, 16133.354665813353, 12579.308138052404, 12750.426230819543, 12848.0, 12950.48198072076, 12970.286634235114, 3019.5470679398045, 3037.7721670874553, 3044.756419486458, 3046.5224366182383, 3058.0672894767085, 71764.28235717629, 72725.2727472729, 72805.63597181981, 73533.63233183854, 75693.0, 11248.100151987821, 11483.885161148448, 11488.0, 11490.023348015513, 11502.482388292547, 20302.766695663464, 21159.471013224793, 21232.469188270108, 21411.35765927025, 21459.141634334454, 6062.090686397076, 6204.224471941007, 6235.906461403082, 6267.373262673696, 6274.435300822948, 3070.4319700855413, 3119.5008798592116, 3144.261098641817, 3145.937081258408, 3147.0, 3542.167590616203, 3565.1978304881713, 3604.6034936157002, 3614.4397618369194, 3640.12636967126, 731.9085114360705, 751.8082888863414, 754.6717178027466, 754.8905408715815, 757.1595528962847, 557.8703126169539, 584.6258394627442, 584.9931352846373, 594.3195041677342, 628.3998781163978, 9192.724218273463, 10101.545430455648, 10669.733256668645, 10947.945260273647, 11129.554817807197, 579.956503262257, 587.717895410197, 603.02611282778, 611.513846492031, 639.1946147853645, 4554.24854898938, 4686.343911852344, 4751.857444276678, 4787.928181077286, 4958.652894297436, 60646.0, 62707.0, 62952.37047629557, 64251.67874160693, 64743.67628161829, 57216.84530475104, 57807.4219257802, 57853.71073144692, 58004.0, 58739.70630146907, 49390.50609493859, 50298.74850625724, 51211.23183152256, 51776.22335664968, 52126.0, 9173.587188576397, 9745.415275083518, 9787.80424391494, 9813.460259685786, 9850.507474626096, 26493.33766655849, 26525.734742652327, 27269.86365068162, 27448.451030979668, 28059.0, 31970.20074498063, 32411.015848271636, 32774.34451311008, 33232.833835830665, 33851.4922276171, 12387.62837114888, 12532.686682833002, 12574.559890403792, 12575.685607859878, 12702.555410560586, 14543.418263269774, 15578.844211558193, 16144.838551614333, 16226.107564084088, 16512.83487165113, 13512.93243533776, 13557.728845423233, 14568.125912445286, 14684.265786710408, 14871.107733536022, 14659.48691795782, 14839.180555694815, 14997.550073497812, 15070.136674031899, 15425.305861236047, 13424.597262082154, 14159.504417345344, 14204.502842400467, 14209.573712788633, 14301.57095287143, 9826.705198844045, 9889.85165222508, 10123.493825308558, 10163.186945044527, 10546.894531054591, 10849.0, 11142.665720028412, 11887.0, 11887.821682674594, 12010.519579217083], "value": 6832.658316218957, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 115.0, 114.0, 116.0, 114.0, 111.0, 110.0, 112.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 123.0, 126.0, 170.0, 121.0, 121.0, 122.0, 121.0, 154.0, 122.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 162.0, 164.0, 168.0, 169.0, 171.0, 163.0, 163.0, 161.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 120.0, 75.0, 77.0, 76.0, 77.0, 93.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 106.0, 83.0, 85.0, 86.0, 94.0, 84.0, 82.0, 107.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 115.0, 115.0, 115.0, 114.0, 115.0, 114.0, 116.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 152.0, 150.0, 150.0, 150.0, 150.0, 148.0, 151.0, 150.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 58.0, 58.0, 56.0, 59.0, 54.0, 54.0, 55.0, 58.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 83.0, 91.0, 86.0, 86.0, 83.0, 83.0, 83.0, 83.0, 86.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 135.0, 133.0, 131.0, 140.0, 133.0, 136.0, 134.0, 187.0, 135.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 209.0, 203.0, 196.0, 217.0, 190.0, 194.0, 191.0, 187.0, 199.0], "value": 197.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 81.0, 77.0, 73.0, 74.0, 73.0, 78.0, 73.0, 74.0], "value": 75.0, "unit": "score"}]}]} 07:08:47 INFO - Return code: 0 07:08:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:08:47 INFO - # TBPL SUCCESS # 07:08:47 INFO - Running post-action listener: _resource_record_post_action 07:08:47 INFO - [mozharness: 2017-05-12 14:08:47.346709Z] Finished run-tests step (success) 07:08:47 INFO - Running post-run listener: _resource_record_post_run 07:08:47 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 7970816; Write bytes: 379158528; Read time: 2176; Write time: 287204 07:08:47 INFO - TinderboxPrint: CPU usage
13.3% 07:08:47 INFO - TinderboxPrint: I/O read bytes / time
7,970,816 / 2,176 07:08:47 INFO - TinderboxPrint: I/O write bytes / time
379,158,528 / 287,204 07:08:47 INFO - TinderboxPrint: CPU idle
8,307.8 (86.7%) 07:08:47 INFO - TinderboxPrint: CPU user
1,220.2 (12.7%) 07:08:47 INFO - TinderboxPrint: Swap in / out
0 / 0 07:08:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114835456; Read time: 0; Write time: 99816 07:08:47 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 5939200; Write bytes: 264323072; Read time: 2104; Write time: 187388 07:08:47 INFO - Running post-run listener: _upload_blobber_files 07:08:47 INFO - Blob upload gear active. 07:08:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:08:47 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 07:08:47 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'] 07:08:47 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 07:08:48 INFO - (blobuploader) - INFO - Open directory for files ... 07:08:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:08:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:08:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:08:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:08:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:08:49 INFO - (blobuploader) - INFO - Done attempting. 07:08:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:08:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:08:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:08:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:08:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:08:53 INFO - (blobuploader) - INFO - Done attempting. 07:08:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:08:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:08:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:08:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:08:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:08:54 INFO - (blobuploader) - INFO - Done attempting. 07:08:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:08:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:08:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:08:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:08:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:08:55 INFO - (blobuploader) - INFO - Done attempting. 07:08:55 INFO - (blobuploader) - INFO - Iteration through files over. 07:08:55 INFO - Return code: 0 07:08:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:08:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:08:55 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/820d88de69a855f45437b38a84a3154f13db289ca210f58f10193a6230fe852195bcd833374eff0ff616b9c2dd6c068f1b84ca8c9906e0e2956ebde5c58943f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e64bf7d2eb5cdff12bb61b41e462a56f28f2ff8e21b8408f32a0ecca6ea5df00e1593d0b34dbb3209e1d338bb0f40d2f5b145c3c1fd6b305d5c97aabd8be76bb", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24b73b9913bb6b47f73b557c80a3dcb507eb4fb1244a40dd6a2b200cf5bf2d10b2ef215ddec8442cded89313431c14fe5fa467a46993ff17d8e93ab661eeb0eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/447276e85c892381e6ab9b8c1236ab268a13736aeaa65479987853d69ecf27c524d1a55b8f3d79d2740929d820f515b3b8dac962bdcd6204fce428574a47900d"} 07:08:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:08:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:08:55 INFO - Contents: 07:08:55 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/820d88de69a855f45437b38a84a3154f13db289ca210f58f10193a6230fe852195bcd833374eff0ff616b9c2dd6c068f1b84ca8c9906e0e2956ebde5c58943f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e64bf7d2eb5cdff12bb61b41e462a56f28f2ff8e21b8408f32a0ecca6ea5df00e1593d0b34dbb3209e1d338bb0f40d2f5b145c3c1fd6b305d5c97aabd8be76bb", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24b73b9913bb6b47f73b557c80a3dcb507eb4fb1244a40dd6a2b200cf5bf2d10b2ef215ddec8442cded89313431c14fe5fa467a46993ff17d8e93ab661eeb0eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/447276e85c892381e6ab9b8c1236ab268a13736aeaa65479987853d69ecf27c524d1a55b8f3d79d2740929d820f515b3b8dac962bdcd6204fce428574a47900d"} 07:08:55 INFO - Running post-run listener: copy_logs_to_upload_dir 07:08:55 INFO - Copying logs to upload dir... 07:08:55 INFO - mkdir: /builds/slave/test/build/upload/logs 07:08:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.882584 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-05-12 07:08:55.427989) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 07:08:55.432972) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523 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/820d88de69a855f45437b38a84a3154f13db289ca210f58f10193a6230fe852195bcd833374eff0ff616b9c2dd6c068f1b84ca8c9906e0e2956ebde5c58943f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e64bf7d2eb5cdff12bb61b41e462a56f28f2ff8e21b8408f32a0ecca6ea5df00e1593d0b34dbb3209e1d338bb0f40d2f5b145c3c1fd6b305d5c97aabd8be76bb", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24b73b9913bb6b47f73b557c80a3dcb507eb4fb1244a40dd6a2b200cf5bf2d10b2ef215ddec8442cded89313431c14fe5fa467a46993ff17d8e93ab661eeb0eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/447276e85c892381e6ab9b8c1236ab268a13736aeaa65479987853d69ecf27c524d1a55b8f3d79d2740929d820f515b3b8dac962bdcd6204fce428574a47900d"} build_url:https://queue.taskcluster.net/v1/task/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011284 build_url: 'https://queue.taskcluster.net/v1/task/O_TecXXPTkK2D6vZK7E_eA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/820d88de69a855f45437b38a84a3154f13db289ca210f58f10193a6230fe852195bcd833374eff0ff616b9c2dd6c068f1b84ca8c9906e0e2956ebde5c58943f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e64bf7d2eb5cdff12bb61b41e462a56f28f2ff8e21b8408f32a0ecca6ea5df00e1593d0b34dbb3209e1d338bb0f40d2f5b145c3c1fd6b305d5c97aabd8be76bb", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24b73b9913bb6b47f73b557c80a3dcb507eb4fb1244a40dd6a2b200cf5bf2d10b2ef215ddec8442cded89313431c14fe5fa467a46993ff17d8e93ab661eeb0eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/447276e85c892381e6ab9b8c1236ab268a13736aeaa65479987853d69ecf27c524d1a55b8f3d79d2740929d820f515b3b8dac962bdcd6204fce428574a47900d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 07:08:55.457787) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 07:08:55.458106) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1494596872.236931-1798372523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004386 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 07:08:55.542281) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 07:08:55.545352) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 07:08:55.545653) ========= ========= Total master_lag: 0.21 =========