builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-038 starttime: 1494941541.76 results: success (0) revision: b9a4a6e2292e923684c2d25b78addaca23c6abd5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-16 06:32:21.757251) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-16 06:32:21.765930) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-16 06:32:21.766348) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-16 06:32:21.837101) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 06:32:21.837478) ========= 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=8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-16 06:32:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2017-05-16 06:32:22 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.154853 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 06:32:22.018507) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 06:32:22.018890) ========= 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=8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020303 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 06:32:22.082649) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-16 06:32:22.086048) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b9a4a6e2292e923684c2d25b78addaca23c6abd5 --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 b9a4a6e2292e923684c2d25b78addaca23c6abd5 --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=8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-16 06:32:22,336 truncating revision to first 12 chars 2017-05-16 06:32:22,336 Setting DEBUG logging. 2017-05-16 06:32:22,336 attempt 1/10 2017-05-16 06:32:22,337 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b9a4a6e2292e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-16 06:32:23,038 unpacking tar archive at: mozilla-central-b9a4a6e2292e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.994522 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-16 06:32:23.097915) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-16 06:32:23.098222) ========= script_repo_revision: b9a4a6e2292e923684c2d25b78addaca23c6abd5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-16 06:32:23.098597) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-16 06:32:23.098868) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-16 06:32:23.117995) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-05-16 06:32:23.118344) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:32:23 INFO - MultiFileLogger online at 20170516 06:32:23 in /builds/slave/test 06:32:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:32:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:32:23 INFO - {'append_to_log': False, 06:32:23 INFO - 'base_work_dir': '/builds/slave/test', 06:32:23 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:32:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:32:23 INFO - 'branch': 'Firefox-Non-PGO', 06:32:23 INFO - 'buildbot_json_path': 'buildprops.json', 06:32:23 INFO - 'config_files': ('talos/linux_config.py',), 06:32:23 INFO - 'default_actions': ('clobber', 06:32:23 INFO - 'read-buildbot-config', 06:32:23 INFO - 'download-and-extract', 06:32:23 INFO - 'populate-webroot', 06:32:23 INFO - 'create-virtualenv', 06:32:23 INFO - 'install', 06:32:23 INFO - 'run-tests'), 06:32:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:32:23 INFO - 'download_minidump_stackwalk': True, 06:32:23 INFO - 'download_symbols': 'ondemand', 06:32:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:32:23 INFO - 'tooltool.py': '/tools/tooltool.py', 06:32:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:32:23 INFO - '/tools/misc-python/virtualenv.py')}, 06:32:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:32:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:32:23 INFO - 'gecko_profile': False, 06:32:23 INFO - 'gecko_profile_interval': 0, 06:32:23 INFO - 'installer_path': 'installer.exe', 06:32:23 INFO - 'log_level': 'info', 06:32:23 INFO - 'log_name': 'talos', 06:32:23 INFO - 'log_to_console': True, 06:32:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:32:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:32:23 INFO - 'opt_config_files': (), 06:32:23 INFO - 'pip_index': False, 06:32:23 INFO - 'suite': 'dromaeojs-e10s', 06:32:23 INFO - 'system_bits': '32', 06:32:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:32:23 INFO - 'title': 'talos-linux64-ix-038', 06:32:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:32:23 INFO - 'use_talos_json': True, 06:32:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:32:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:32:23 INFO - 'work_dir': 'build'} 06:32:23 INFO - [mozharness: 2017-05-16 13:32:23.469252Z] Running clobber step. 06:32:23 INFO - Running pre-action listener: _resource_record_pre_action 06:32:23 INFO - Running main action method: clobber 06:32:23 INFO - rmtree: /builds/slave/test/build 06:32:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:32:25 INFO - Running post-action listener: _resource_record_post_action 06:32:25 INFO - [mozharness: 2017-05-16 13:32:25.002049Z] Finished clobber step (success) 06:32:25 INFO - [mozharness: 2017-05-16 13:32:25.002147Z] Running read-buildbot-config step. 06:32:25 INFO - Running pre-action listener: _resource_record_pre_action 06:32:25 INFO - Running main action method: read_buildbot_config 06:32:25 INFO - Using buildbot properties: 06:32:25 INFO - { 06:32:25 INFO - "project": "", 06:32:25 INFO - "product": "firefox", 06:32:25 INFO - "who": "cbook@mozilla.com", 06:32:25 INFO - "installer_path": "public/build/target.tar.bz2", 06:32:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:32:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:32:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 06:32:25 INFO - "stage_platform": "linux64", 06:32:25 INFO - "basedir": "/builds/slave/test", 06:32:25 INFO - "buildnumber": 608, 06:32:25 INFO - "platform": "ubuntu64_hw", 06:32:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:32:25 INFO - "slavebuilddir": "test", 06:32:25 INFO - "taskId": "TnwQ-E3NTaC6Vx7TPCBtpw", 06:32:25 INFO - "branch": "mozilla-central", 06:32:25 INFO - "script_repo_revision": "production", 06:32:25 INFO - "revision": "b9a4a6e2292e923684c2d25b78addaca23c6abd5", 06:32:25 INFO - "slavename": "talos-linux64-ix-038", 06:32:25 INFO - "repo_path": "mozilla-central" 06:32:25 INFO - } 06:32:25 INFO - Finding installer, test and symbols from parent task. 06:32:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TnwQ-E3NTaC6Vx7TPCBtpw'}, attempt #1 06:32:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TnwQ-E3NTaC6Vx7TPCBtpw'}, attempt #1 06:32:25 INFO - Task dependencies: SkBauyfUTziQX679CCyemw 06:32:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw'}, attempt #1 06:32:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/target.tar.bz2 06:32:26 INFO - Set test_url: https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/test_packages.json 06:32:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/target.crashreporter-symbols.zip 06:32:26 INFO - Running post-action listener: _resource_record_post_action 06:32:26 INFO - [mozharness: 2017-05-16 13:32:26.354037Z] Finished read-buildbot-config step (success) 06:32:26 INFO - [mozharness: 2017-05-16 13:32:26.354256Z] Running download-and-extract step. 06:32:26 INFO - Running pre-action listener: _resource_record_pre_action 06:32:26 INFO - Running main action method: download_and_extract 06:32:26 INFO - mkdir: /builds/slave/test/build/tests 06:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:26 INFO - trying https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/target.test_packages.json 06:32:26 INFO - Downloading https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:32:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:32:26 INFO - Downloaded 986 bytes. 06:32:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:32:26 INFO - Using the following test package requirements: 06:32:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:32:26 INFO - u'common': [u'target.common.tests.zip'], 06:32:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:32:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:32:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:32:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:32:26 INFO - u'mozbase': [u'target.common.tests.zip'], 06:32:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:32:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:32:26 INFO - u'web-platform': [u'target.common.tests.zip', 06:32:26 INFO - u'target.web-platform.tests.zip'], 06:32:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:32:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:32:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/target.common.tests.zip 06:32:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:32:26 INFO - Fetch https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/target.common.tests.zip into memory 06:32:29 INFO - Content-Length response header: 62450062 06:32:29 INFO - Bytes received: 62450062 06:32:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:32:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/target.common.tests.zip 06:32:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:32:40 INFO - Fetch https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/target.common.tests.zip into memory 06:32:41 INFO - Content-Length response header: 62450062 06:32:41 INFO - Bytes received: 62450062 06:32:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/target.talos.tests.zip 06:32:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:32:53 INFO - Fetch https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/target.talos.tests.zip into memory 06:32:53 INFO - Content-Length response header: 14410069 06:32:53 INFO - Bytes received: 14410069 06:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:54 INFO - trying https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/target.tar.bz2 06:32:54 INFO - Downloading https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:32:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:32:55 INFO - Downloaded 63437372 bytes. 06:32:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/target.tar.bz2 06:32:55 INFO - mkdir: /builds/slave/test/properties 06:32:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:32:55 INFO - Writing to file /builds/slave/test/properties/build_url 06:32:55 INFO - Contents: 06:32:55 INFO - build_url:https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/target.tar.bz2 06:32:55 INFO - Running post-action listener: _resource_record_post_action 06:32:55 INFO - Running post-action listener: set_extra_try_arguments 06:32:55 INFO - [mozharness: 2017-05-16 13:32:55.387407Z] Finished download-and-extract step (success) 06:32:55 INFO - [mozharness: 2017-05-16 13:32:55.387599Z] Running populate-webroot step. 06:32:55 INFO - Running pre-action listener: _resource_record_pre_action 06:32:55 INFO - Running main action method: populate_webroot 06:32:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:32:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:32:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:32:55 INFO - '--tppagecycles', 06:32:55 INFO - '7'], 06:32:55 INFO - 'tests': ['tsvgm']}}, 06:32:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:32:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:32:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:32:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:32:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:32:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:32:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:32:55 INFO - 'talos_options': ['--disable-e10s'], 06:32:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:32:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:32:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:32:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:32:55 INFO - 'talos_options': ['--disable-e10s'], 06:32:55 INFO - 'tests': ['damp', 'tps']}, 06:32:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:32:55 INFO - 'tests': ['damp', 'tps']}, 06:32:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:32:55 INFO - 'tests': ['dromaeo_dom']}, 06:32:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:32:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:32:55 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:32:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:32:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:32:55 INFO - 'tests': ['ts_paint', 'tp5o']}, 06:32:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:32:55 INFO - 'tests': ['a11yr', 06:32:55 INFO - 'ts_paint', 06:32:55 INFO - 'tpaint', 06:32:55 INFO - 'sessionrestore', 06:32:55 INFO - 'sessionrestore_no_auto_restore', 06:32:55 INFO - 'tabpaint']}, 06:32:55 INFO - 'other-e10s': {'tests': ['a11yr', 06:32:55 INFO - 'ts_paint', 06:32:55 INFO - 'tpaint', 06:32:55 INFO - 'sessionrestore', 06:32:55 INFO - 'sessionrestore_no_auto_restore', 06:32:55 INFO - 'tabpaint']}, 06:32:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:32:55 INFO - 'ts_paint', 06:32:55 INFO - 'tpaint', 06:32:55 INFO - 'sessionrestore', 06:32:55 INFO - 'sessionrestore_no_auto_restore', 06:32:55 INFO - 'tabpaint']}, 06:32:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:32:55 INFO - 'ts_paint', 06:32:55 INFO - 'tpaint', 06:32:55 INFO - 'sessionrestore', 06:32:55 INFO - 'sessionrestore_no_auto_restore', 06:32:55 INFO - 'tabpaint']}, 06:32:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:32:55 INFO - 'tests': ['a11yr', 06:32:55 INFO - 'ts_paint', 06:32:55 INFO - 'tpaint', 06:32:55 INFO - 'sessionrestore', 06:32:55 INFO - 'sessionrestore_no_auto_restore', 06:32:55 INFO - 'tabpaint']}, 06:32:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:32:55 INFO - 'tests': ['a11yr', 06:32:55 INFO - 'ts_paint', 06:32:55 INFO - 'tpaint', 06:32:55 INFO - 'sessionrestore', 06:32:55 INFO - 'sessionrestore_no_auto_restore', 06:32:55 INFO - 'tabpaint']}, 06:32:55 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 06:32:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 06:32:55 INFO - 'bloom_basic_ref']}, 06:32:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:32:55 INFO - 'tests': ['tsvgx', 06:32:55 INFO - 'tsvgr_opacity', 06:32:55 INFO - 'tart', 06:32:55 INFO - 'tscrollx', 06:32:55 INFO - 'cart', 06:32:55 INFO - 'tsvg_static']}, 06:32:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:32:55 INFO - 'tsvgr_opacity', 06:32:55 INFO - 'tart', 06:32:55 INFO - 'tscrollx', 06:32:55 INFO - 'cart', 06:32:55 INFO - 'tsvg_static']}, 06:32:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:32:55 INFO - 'talos_options': ['--disable-e10s'], 06:32:55 INFO - 'tests': ['tp5o']}, 06:32:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:32:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:32:55 INFO - 'talos_options': ['--disable-e10s', 06:32:55 INFO - '--xperf_path', 06:32:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:32:55 INFO - 'tests': ['tp5n']}, 06:32:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:32:55 INFO - 'talos_options': ['--xperf_path', 06:32:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:32:55 INFO - 'tests': ['tp5n']}}, 06:32:55 INFO - 'talos.zip': {'path': '', 06:32:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:32:55 INFO - Running post-action listener: _resource_record_post_action 06:32:55 INFO - [mozharness: 2017-05-16 13:32:55.406666Z] Finished populate-webroot step (success) 06:32:55 INFO - [mozharness: 2017-05-16 13:32:55.406755Z] Running create-virtualenv step. 06:32:55 INFO - Running pre-action listener: _resource_record_pre_action 06:32:55 INFO - Running main action method: create_virtualenv 06:32:55 INFO - Creating virtualenv /builds/slave/test/build/venv 06:32:55 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:32:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:32:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:32:55 INFO - Using real prefix '/usr' 06:32:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:32:56 INFO - Installing distribute.............................................................................................................................................................................................done. 06:32:57 INFO - Installing pip.................done. 06:32:57 INFO - Return code: 0 06:32:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:32:58 INFO - Reading from file tmpfile_stdout 06:32:58 INFO - Output received: 06:32:58 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:32:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:32: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:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32: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:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:58 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 0x1a971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e077a0>, '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 0x1e086a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e08b30>, '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': '8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740', '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:32:58 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:32:58 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:32:58 INFO - Using env: {'DISPLAY': ':0', 06:32:58 INFO - 'HOME': '/home/cltbld', 06:32:58 INFO - 'LANG': 'en_US.UTF-8', 06:32:58 INFO - 'LANGUAGE': 'en_US:en', 06:32:58 INFO - 'LOGNAME': 'cltbld', 06:32:58 INFO - 'MAIL': '/var/mail/cltbld', 06:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:58 INFO - 'MOZ_NO_REMOTE': '1', 06:32:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:58 INFO - 'NO_EM_RESTART': '1', 06:32:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:58 INFO - 'PWD': '/builds/slave/test', 06:32:58 INFO - 'SHELL': '/bin/bash', 06:32:58 INFO - 'SHLVL': '1', 06:32:58 INFO - 'TERM': 'linux', 06:32:58 INFO - 'TMOUT': '86400', 06:32:58 INFO - 'USER': 'cltbld', 06:32:58 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740', 06:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:58 INFO - '_': '/tools/buildbot/bin/python'} 06:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:58 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:32:58 INFO - Cleaning up... 06:32:58 INFO - Return code: 0 06:32:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:32: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:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32: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:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:58 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 0x1a971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e077a0>, '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 0x1e086a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e08b30>, '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': '8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740', '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:32:58 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:32:58 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:32:58 INFO - Using env: {'DISPLAY': ':0', 06:32:58 INFO - 'HOME': '/home/cltbld', 06:32:58 INFO - 'LANG': 'en_US.UTF-8', 06:32:58 INFO - 'LANGUAGE': 'en_US:en', 06:32:58 INFO - 'LOGNAME': 'cltbld', 06:32:58 INFO - 'MAIL': '/var/mail/cltbld', 06:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:58 INFO - 'MOZ_NO_REMOTE': '1', 06:32:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:58 INFO - 'NO_EM_RESTART': '1', 06:32:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:58 INFO - 'PWD': '/builds/slave/test', 06:32:58 INFO - 'SHELL': '/bin/bash', 06:32:58 INFO - 'SHLVL': '1', 06:32:58 INFO - 'TERM': 'linux', 06:32:58 INFO - 'TMOUT': '86400', 06:32:58 INFO - 'USER': 'cltbld', 06:32:58 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740', 06:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:58 INFO - '_': '/tools/buildbot/bin/python'} 06:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:58 INFO - Downloading/unpacking psutil>=3.1.1 06:32:58 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:32:58 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:32:58 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:32:58 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:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:32:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:32:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:32:59 INFO - Installing collected packages: psutil 06:32:59 INFO - Running setup.py install for psutil 06:32:59 INFO - building 'psutil._psutil_linux' extension 06:32:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:33:00 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:33:00 INFO - building 'psutil._psutil_posix' extension 06:33:00 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:33:00 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:33:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:33:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:33:00 INFO - Successfully installed psutil 06:33:00 INFO - Cleaning up... 06:33:00 INFO - Return code: 0 06:33:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:33:00 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:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:00 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:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:00 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 0x1a971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e077a0>, '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 0x1e086a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e08b30>, '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': '8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740', '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:33:00 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:33:00 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:33:00 INFO - Using env: {'DISPLAY': ':0', 06:33:00 INFO - 'HOME': '/home/cltbld', 06:33:00 INFO - 'LANG': 'en_US.UTF-8', 06:33:00 INFO - 'LANGUAGE': 'en_US:en', 06:33:00 INFO - 'LOGNAME': 'cltbld', 06:33:00 INFO - 'MAIL': '/var/mail/cltbld', 06:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:00 INFO - 'MOZ_NO_REMOTE': '1', 06:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:33:00 INFO - 'NO_EM_RESTART': '1', 06:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:00 INFO - 'PWD': '/builds/slave/test', 06:33:00 INFO - 'SHELL': '/bin/bash', 06:33:00 INFO - 'SHLVL': '1', 06:33:00 INFO - 'TERM': 'linux', 06:33:00 INFO - 'TMOUT': '86400', 06:33:00 INFO - 'USER': 'cltbld', 06:33:00 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740', 06:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:00 INFO - '_': '/tools/buildbot/bin/python'} 06:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:33:00 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:33:00 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:33:00 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:33:00 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:33:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:33:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:33:01 INFO - Installing collected packages: mozsystemmonitor 06:33:01 INFO - Running setup.py install for mozsystemmonitor 06:33:01 INFO - Successfully installed mozsystemmonitor 06:33:01 INFO - Cleaning up... 06:33:01 INFO - Return code: 0 06:33:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e077a0>, '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 0x1e086a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e08b30>, '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': '8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740', '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:33:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:33:01 INFO - Using env: {'DISPLAY': ':0', 06:33:01 INFO - 'HOME': '/home/cltbld', 06:33:01 INFO - 'LANG': 'en_US.UTF-8', 06:33:01 INFO - 'LANGUAGE': 'en_US:en', 06:33:01 INFO - 'LOGNAME': 'cltbld', 06:33:01 INFO - 'MAIL': '/var/mail/cltbld', 06:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:01 INFO - 'MOZ_NO_REMOTE': '1', 06:33:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:33:01 INFO - 'NO_EM_RESTART': '1', 06:33:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:01 INFO - 'PWD': '/builds/slave/test', 06:33:01 INFO - 'SHELL': '/bin/bash', 06:33:01 INFO - 'SHLVL': '1', 06:33:01 INFO - 'TERM': 'linux', 06:33:01 INFO - 'TMOUT': '86400', 06:33:01 INFO - 'USER': 'cltbld', 06:33:01 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740', 06:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:01 INFO - '_': '/tools/buildbot/bin/python'} 06:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:02 INFO - Downloading/unpacking jsonschema==2.5.1 06:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:33:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:03 INFO - Downloading functools32-3.2.3-2.tar.gz 06:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:33:03 INFO - warning: no files found matching '*.txt' 06:33:03 INFO - no previously-included directories found matching 'build' 06:33:03 INFO - no previously-included directories found matching 'dist' 06:33:03 INFO - no previously-included directories found matching '.git*' 06:33:03 INFO - Installing collected packages: jsonschema, functools32 06:33:03 INFO - Running setup.py install for functools32 06:33:03 INFO - warning: no files found matching '*.txt' 06:33:03 INFO - no previously-included directories found matching 'build' 06:33:03 INFO - no previously-included directories found matching 'dist' 06:33:03 INFO - no previously-included directories found matching '.git*' 06:33:03 INFO - Successfully installed jsonschema functools32 06:33:03 INFO - Cleaning up... 06:33:03 INFO - Return code: 0 06:33:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e077a0>, '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 0x1e086a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e08b30>, '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': '8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740', '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:33:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:33:03 INFO - Using env: {'DISPLAY': ':0', 06:33:03 INFO - 'HOME': '/home/cltbld', 06:33:03 INFO - 'LANG': 'en_US.UTF-8', 06:33:03 INFO - 'LANGUAGE': 'en_US:en', 06:33:03 INFO - 'LOGNAME': 'cltbld', 06:33:03 INFO - 'MAIL': '/var/mail/cltbld', 06:33:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:03 INFO - 'MOZ_NO_REMOTE': '1', 06:33:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:33:03 INFO - 'NO_EM_RESTART': '1', 06:33:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:33:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:03 INFO - 'PWD': '/builds/slave/test', 06:33:03 INFO - 'SHELL': '/bin/bash', 06:33:03 INFO - 'SHLVL': '1', 06:33:03 INFO - 'TERM': 'linux', 06:33:03 INFO - 'TMOUT': '86400', 06:33:03 INFO - 'USER': 'cltbld', 06:33:03 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740', 06:33:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:03 INFO - '_': '/tools/buildbot/bin/python'} 06:33:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:33:03 INFO - Cleaning up... 06:33:03 INFO - Return code: 0 06:33:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e077a0>, '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 0x1e086a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e08b30>, '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': '8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740', '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:33:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:33:03 INFO - Using env: {'DISPLAY': ':0', 06:33:03 INFO - 'HOME': '/home/cltbld', 06:33:03 INFO - 'LANG': 'en_US.UTF-8', 06:33:03 INFO - 'LANGUAGE': 'en_US:en', 06:33:03 INFO - 'LOGNAME': 'cltbld', 06:33:03 INFO - 'MAIL': '/var/mail/cltbld', 06:33:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:03 INFO - 'MOZ_NO_REMOTE': '1', 06:33:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:33:03 INFO - 'NO_EM_RESTART': '1', 06:33:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:33:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:03 INFO - 'PWD': '/builds/slave/test', 06:33:03 INFO - 'SHELL': '/bin/bash', 06:33:03 INFO - 'SHLVL': '1', 06:33:03 INFO - 'TERM': 'linux', 06:33:03 INFO - 'TMOUT': '86400', 06:33:03 INFO - 'USER': 'cltbld', 06:33:03 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740', 06:33:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:03 INFO - '_': '/tools/buildbot/bin/python'} 06:33:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:03 INFO - Downloading/unpacking blobuploader==1.2.4 06:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:05 INFO - Downloading blobuploader-1.2.4.tar.gz 06:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:33:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:33:05 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:33:05 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:33:05 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:33:05 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:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:33:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:33:05 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:33:05 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:33:05 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:33:05 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:33:05 INFO - Downloading docopt-0.6.1.tar.gz 06:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:33:05 INFO - Installing collected packages: blobuploader, requests, docopt 06:33:05 INFO - Running setup.py install for blobuploader 06:33:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:33:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:33:05 INFO - Running setup.py install for requests 06:33:06 INFO - Running setup.py install for docopt 06:33:06 INFO - Successfully installed blobuploader requests docopt 06:33:06 INFO - Cleaning up... 06:33:06 INFO - Return code: 0 06:33:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:33:06 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:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:06 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:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:06 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 0x1a971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e077a0>, '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 0x1e086a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e08b30>, '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': '8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740', '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:33:06 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:33:06 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:33:06 INFO - Using env: {'DISPLAY': ':0', 06:33:06 INFO - 'HOME': '/home/cltbld', 06:33:06 INFO - 'LANG': 'en_US.UTF-8', 06:33:06 INFO - 'LANGUAGE': 'en_US:en', 06:33:06 INFO - 'LOGNAME': 'cltbld', 06:33:06 INFO - 'MAIL': '/var/mail/cltbld', 06:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:06 INFO - 'MOZ_NO_REMOTE': '1', 06:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:33:06 INFO - 'NO_EM_RESTART': '1', 06:33:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:06 INFO - 'PWD': '/builds/slave/test', 06:33:06 INFO - 'SHELL': '/bin/bash', 06:33:06 INFO - 'SHLVL': '1', 06:33:06 INFO - 'TERM': 'linux', 06:33:06 INFO - 'TMOUT': '86400', 06:33:06 INFO - 'USER': 'cltbld', 06:33:06 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740', 06:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:06 INFO - '_': '/tools/buildbot/bin/python'} 06:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:33:06 INFO - Running setup.py (path:/tmp/pip-AezjSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:33:06 INFO - Running setup.py (path:/tmp/pip-eW8dfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:33:06 INFO - Running setup.py (path:/tmp/pip-2m2kI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:33:06 INFO - Running setup.py (path:/tmp/pip-3aHODS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:33:06 INFO - Running setup.py (path:/tmp/pip-g3gffy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:33:06 INFO - Running setup.py (path:/tmp/pip-EhRELg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:33:06 INFO - Running setup.py (path:/tmp/pip-O_U1Nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:33:06 INFO - Running setup.py (path:/tmp/pip-CS1suq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:33:07 INFO - Running setup.py (path:/tmp/pip-_Tz3eL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:33:07 INFO - Running setup.py (path:/tmp/pip-HqKHk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:33:07 INFO - Running setup.py (path:/tmp/pip-9QruVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:33:07 INFO - Running setup.py (path:/tmp/pip-ePeEpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:33:07 INFO - Running setup.py (path:/tmp/pip-AK5B_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:33:07 INFO - Running setup.py (path:/tmp/pip-x0SD2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:33:07 INFO - Running setup.py (path:/tmp/pip-F12BAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:33:07 INFO - Running setup.py (path:/tmp/pip-kGvnX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:33:07 INFO - Running setup.py (path:/tmp/pip-dk5AHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:33:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:33:07 INFO - Running setup.py install for manifestparser 06:33:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:33:07 INFO - Running setup.py install for mozcrash 06:33:07 INFO - Running setup.py install for mozdebug 06:33:07 INFO - Running setup.py install for mozdevice 06:33:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:33:08 INFO - Running setup.py install for mozfile 06:33:08 INFO - Running setup.py install for mozhttpd 06:33:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:33:08 INFO - Running setup.py install for mozinfo 06:33:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:33:08 INFO - Running setup.py install for mozInstall 06:33:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:33:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:33:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:33:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:33:08 INFO - Running setup.py install for mozleak 06:33:08 INFO - Running setup.py install for mozlog 06:33:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:33:08 INFO - Running setup.py install for moznetwork 06:33:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:33:08 INFO - Running setup.py install for mozprocess 06:33:08 INFO - Running setup.py install for mozprofile 06:33:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:33:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:33:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:33:08 INFO - Running setup.py install for mozrunner 06:33:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:33:09 INFO - Running setup.py install for mozscreenshot 06:33:09 INFO - Running setup.py install for moztest 06:33:09 INFO - Running setup.py install for mozversion 06:33:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:33:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:33:09 INFO - Cleaning up... 06:33:09 INFO - Return code: 0 06:33:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:33:09 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:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:09 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:33:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:09 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 0x1a971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e077a0>, '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 0x1e086a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e08b30>, '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': '8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740', '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:33:09 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:33:09 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:33:09 INFO - Using env: {'DISPLAY': ':0', 06:33:09 INFO - 'HOME': '/home/cltbld', 06:33:09 INFO - 'LANG': 'en_US.UTF-8', 06:33:09 INFO - 'LANGUAGE': 'en_US:en', 06:33:09 INFO - 'LOGNAME': 'cltbld', 06:33:09 INFO - 'MAIL': '/var/mail/cltbld', 06:33:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:09 INFO - 'MOZ_NO_REMOTE': '1', 06:33:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:33:09 INFO - 'NO_EM_RESTART': '1', 06:33:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:33:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:09 INFO - 'PWD': '/builds/slave/test', 06:33:09 INFO - 'SHELL': '/bin/bash', 06:33:09 INFO - 'SHLVL': '1', 06:33:09 INFO - 'TERM': 'linux', 06:33:09 INFO - 'TMOUT': '86400', 06:33:09 INFO - 'USER': 'cltbld', 06:33:09 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740', 06:33:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:09 INFO - '_': '/tools/buildbot/bin/python'} 06:33:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:33:09 INFO - Running setup.py (path:/tmp/pip-Gc18rW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:33:09 INFO - Running setup.py (path:/tmp/pip-BYO4F_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:33:09 INFO - Running setup.py (path:/tmp/pip-HOrAyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:33:09 INFO - Running setup.py (path:/tmp/pip-zs2JbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:33:09 INFO - Running setup.py (path:/tmp/pip-TCNv0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:33:10 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:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:33:10 INFO - Running setup.py (path:/tmp/pip-E7Cr5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:33:10 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:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:33:10 INFO - Running setup.py (path:/tmp/pip-4e1trS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:33:10 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:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:33:10 INFO - Running setup.py (path:/tmp/pip-MXYkHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:33:10 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:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:33:10 INFO - Running setup.py (path:/tmp/pip-1hX7F4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:33:10 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:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:33:10 INFO - Running setup.py (path:/tmp/pip-DPfk_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:33:10 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:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:33:10 INFO - Running setup.py (path:/tmp/pip-gLp3gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:33:10 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:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:33:10 INFO - Running setup.py (path:/tmp/pip-xIcWqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:33:10 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:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:33:10 INFO - Running setup.py (path:/tmp/pip-dHdUcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:33:10 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:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:33:10 INFO - Running setup.py (path:/tmp/pip-k5zP7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:33:10 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:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:33:10 INFO - Running setup.py (path:/tmp/pip-FoN8oc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:33:10 INFO - Running setup.py (path:/tmp/pip-2yWqt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:33:10 INFO - Running setup.py (path:/tmp/pip-gTOMd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:33:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:12 INFO - Downloading blessings-1.6.tar.gz 06:33:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:33:12 INFO - Installing collected packages: blessings 06:33:12 INFO - Running setup.py install for blessings 06:33:12 INFO - Successfully installed blessings 06:33:12 INFO - Cleaning up... 06:33:12 INFO - Return code: 0 06:33:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:33:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:33:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:33:12 INFO - Reading from file tmpfile_stdout 06:33:12 INFO - Current package versions: 06:33:12 INFO - argparse == 1.2.1 06:33:12 INFO - blessings == 1.6 06:33:12 INFO - blobuploader == 1.2.4 06:33:12 INFO - docopt == 0.6.1 06:33:12 INFO - functools32 == 3.2.3-2 06:33:12 INFO - jsonschema == 2.5.1 06:33:12 INFO - manifestparser == 1.1 06:33:12 INFO - mozInstall == 1.12 06:33:12 INFO - mozcrash == 1.0 06:33:12 INFO - mozdebug == 0.1 06:33:12 INFO - mozdevice == 0.50 06:33:12 INFO - mozfile == 1.2 06:33:12 INFO - mozhttpd == 0.7 06:33:12 INFO - mozinfo == 0.9 06:33:12 INFO - mozleak == 0.1 06:33:12 INFO - mozlog == 3.4 06:33:12 INFO - moznetwork == 0.27 06:33:12 INFO - mozprocess == 0.25 06:33:12 INFO - mozprofile == 0.28 06:33:12 INFO - mozrunner == 6.13 06:33:12 INFO - mozscreenshot == 0.1 06:33:12 INFO - mozsystemmonitor == 0.3 06:33:12 INFO - moztest == 0.8 06:33:12 INFO - mozversion == 1.4 06:33:12 INFO - psutil == 3.1.1 06:33:12 INFO - requests == 1.2.3 06:33:12 INFO - wsgiref == 0.1.2 06:33:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:33:12 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:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:12 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:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:12 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 0x1a971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e077a0>, '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 0x1e086a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e08b30>, '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': '8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740', '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:33:12 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:33:12 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:33:12 INFO - Using env: {'DISPLAY': ':0', 06:33:12 INFO - 'HOME': '/home/cltbld', 06:33:12 INFO - 'LANG': 'en_US.UTF-8', 06:33:12 INFO - 'LANGUAGE': 'en_US:en', 06:33:12 INFO - 'LOGNAME': 'cltbld', 06:33:12 INFO - 'MAIL': '/var/mail/cltbld', 06:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:12 INFO - 'MOZ_NO_REMOTE': '1', 06:33:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:33:12 INFO - 'NO_EM_RESTART': '1', 06:33:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:12 INFO - 'PWD': '/builds/slave/test', 06:33:12 INFO - 'SHELL': '/bin/bash', 06:33:12 INFO - 'SHLVL': '1', 06:33:12 INFO - 'TERM': 'linux', 06:33:12 INFO - 'TMOUT': '86400', 06:33:12 INFO - 'USER': 'cltbld', 06:33:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740', 06:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:12 INFO - '_': '/tools/buildbot/bin/python'} 06:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:12 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:33:12 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:33:12 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:33:12 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:33:12 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:33:12 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:33:12 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:33:12 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:33:12 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:33:12 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:33:12 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:33:12 INFO - Cleaning up... 06:33:12 INFO - Return code: 0 06:33:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:33:12 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:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:12 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:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1a971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e077a0>, '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 0x1e086a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e08b30>, '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': '8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740', '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:33:12 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:33:12 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:33:12 INFO - Using env: {'DISPLAY': ':0', 06:33:12 INFO - 'HOME': '/home/cltbld', 06:33:12 INFO - 'LANG': 'en_US.UTF-8', 06:33:12 INFO - 'LANGUAGE': 'en_US:en', 06:33:12 INFO - 'LOGNAME': 'cltbld', 06:33:12 INFO - 'MAIL': '/var/mail/cltbld', 06:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:12 INFO - 'MOZ_NO_REMOTE': '1', 06:33:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:33:12 INFO - 'NO_EM_RESTART': '1', 06:33:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:12 INFO - 'PWD': '/builds/slave/test', 06:33:12 INFO - 'SHELL': '/bin/bash', 06:33:12 INFO - 'SHLVL': '1', 06:33:12 INFO - 'TERM': 'linux', 06:33:12 INFO - 'TMOUT': '86400', 06:33:12 INFO - 'USER': 'cltbld', 06:33:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740', 06:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:12 INFO - '_': '/tools/buildbot/bin/python'} 06:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:33:12 INFO - Cleaning up... 06:33:12 INFO - Return code: 0 06:33:12 INFO - Running post-action listener: _resource_record_post_action 06:33:12 INFO - Running post-action listener: _start_resource_monitoring 06:33:12 INFO - Starting resource monitoring. 06:33:12 INFO - [mozharness: 2017-05-16 13:33:12.968728Z] Finished create-virtualenv step (success) 06:33:12 INFO - [mozharness: 2017-05-16 13:33:12.969241Z] Running install step. 06:33:12 INFO - Running pre-action listener: _resource_record_pre_action 06:33:12 INFO - Running main action method: install 06:33:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:33:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:33:13 INFO - Reading from file tmpfile_stdout 06:33:13 INFO - Detecting whether we're running mozinstall >=1.0... 06:33:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:33:13 INFO - Reading from file tmpfile_stdout 06:33:13 INFO - Output received: 06:33:13 INFO - Usage: mozinstall [options] installer 06:33:13 INFO - Options: 06:33:13 INFO - -h, --help show this help message and exit 06:33:13 INFO - -d DEST, --destination=DEST 06:33:13 INFO - Directory to install application into. [default: 06:33:13 INFO - "/builds/slave/test"] 06:33:13 INFO - --app=APP Application being installed. [default: firefox] 06:33:13 INFO - mkdir: /builds/slave/test/build/application 06:33:13 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:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:33:29 INFO - Reading from file tmpfile_stdout 06:33:29 INFO - Output received: 06:33:29 INFO - /builds/slave/test/build/application/firefox/firefox 06:33:29 INFO - Running post-action listener: _resource_record_post_action 06:33:29 INFO - [mozharness: 2017-05-16 13:33:29.182103Z] Finished install step (success) 06:33:29 INFO - [mozharness: 2017-05-16 13:33:29.182382Z] Running run-tests step. 06:33:29 INFO - Running pre-action listener: _resource_record_pre_action 06:33:29 INFO - Running main action method: run_tests 06:33:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:33:29 INFO - Python 2.7.3 06:33:29 INFO - Return code: 0 06:33:29 INFO - grabbing minidump binary from tooltool 06:33: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:33:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e077a0>, '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 0x1e086a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e08b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:33:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:33:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:33:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:33:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:33:29 INFO - Return code: 0 06:33:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:33:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:33:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:33:29 INFO - ENV: RUST_BACKTRACE is now 1 06:33:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:33:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:33:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-038 --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:33:29 INFO - Using env: {'DISPLAY': ':0', 06:33:29 INFO - 'HOME': '/home/cltbld', 06:33:29 INFO - 'LANG': 'en_US.UTF-8', 06:33:29 INFO - 'LANGUAGE': 'en_US:en', 06:33:29 INFO - 'LOGNAME': 'cltbld', 06:33:29 INFO - 'MAIL': '/var/mail/cltbld', 06:33:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:33:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:33:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:29 INFO - 'MOZ_NO_REMOTE': '1', 06:33:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:33:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:33:29 INFO - 'NO_EM_RESTART': '1', 06:33:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:33:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:29 INFO - 'PWD': '/builds/slave/test', 06:33:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:33:29 INFO - 'RUST_BACKTRACE': '1', 06:33:29 INFO - 'SHELL': '/bin/bash', 06:33:29 INFO - 'SHLVL': '1', 06:33:29 INFO - 'TERM': 'linux', 06:33:29 INFO - 'TMOUT': '86400', 06:33:29 INFO - 'USER': 'cltbld', 06:33:29 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740', 06:33:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:29 INFO - '_': '/tools/buildbot/bin/python'} 06:33:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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:33:29 INFO - mozversion application_buildid: 20170516130508 06:33:29 INFO - mozversion application_changeset: b9a4a6e2292e923684c2d25b78addaca23c6abd5 06:33:29 INFO - mozversion application_display_name: Nightly 06:33:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:33:29 INFO - mozversion application_name: Firefox 06:33:29 INFO - mozversion application_remotingname: firefox 06:33:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:33:29 INFO - mozversion application_vendor: Mozilla 06:33:29 INFO - mozversion application_version: 55.0a1 06:33:29 INFO - mozversion platform_buildid: 20170516130508 06:33:29 INFO - mozversion platform_changeset: b9a4a6e2292e923684c2d25b78addaca23c6abd5 06:33:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:33:29 INFO - mozversion platform_version: 55.0a1 06:33:29 INFO - using testdate: 1494941609 06:33:29 INFO - actual date: 1494941609 06:33:29 INFO - starting webserver on 'localhost:41015' 06:33:29 INFO - SUITE-START | Running 2 tests 06:33:29 INFO - TEST-START | dromaeo_css 06:33:29 INFO - operating with platform_type : linux_ 06:33:29 INFO - Initialising browser for dromaeo_css test... 06:33:29 INFO - TEST-INFO | started process 20255 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDXK3VU/profile http://localhost:41015/getInfo.html) 06:33:30 INFO - PID 20255 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2930: String.localeCompare is deprecated; use String.prototype.localeCompare instead 06:33:33 INFO - PID 20255 | __metrics Screen width/height:1600/1200 06:33:33 INFO - PID 20255 | colorDepth:24 06:33:33 INFO - PID 20255 | Browser inner width/height: 1024/695 06:33:33 INFO - PID 20255 | __metrics 06:33:36 INFO - TEST-INFO | 20255: exit 0 06:33:36 INFO - Browser initialized. 06:33:36 INFO - Running cycle 1/1 for dromaeo_css test... 06:33:36 INFO - TEST-INFO | started process 20426 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDXK3VU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:33:47 INFO - PID 20426 | RSS: Main: 161865728 06:33:47 INFO - PID 20426 | 06:36:53 INFO - PID 20426 | Cycle 1(1): loaded http://localhost:41015/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41015/tests/dromaeo/cssquery-ext.html) 06:36:55 INFO - PID 20426 | RSS: Main: 168173568 06:36:55 INFO - PID 20426 | 06:39:57 INFO - PID 20426 | Cycle 1(1): loaded http://localhost:41015/tests/dromaeo/cssquery-ext.html (next: http://localhost:41015/tests/dromaeo/cssquery-jquery.html) 06:39:57 INFO - PID 20426 | RSS: Main: 167391232 06:39:57 INFO - PID 20426 | 06:42:59 INFO - PID 20426 | Cycle 1(1): loaded http://localhost:41015/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41015/tests/dromaeo/cssquery-mootools.html) 06:43:00 INFO - PID 20426 | RSS: Main: 169619456 06:43:00 INFO - PID 20426 | 06:46:02 INFO - PID 20426 | Cycle 1(1): loaded http://localhost:41015/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41015/tests/dromaeo/cssquery-prototype.html) 06:46:02 INFO - PID 20426 | RSS: Main: 166617088 06:46:02 INFO - PID 20426 | 06:49:05 INFO - PID 20426 | Cycle 1(1): loaded http://localhost:41015/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41015/tests/dromaeo/cssquery-yui.html) 06:49:06 INFO - PID 20426 | RSS: Main: 167948288 06:49:06 INFO - PID 20426 | 06:52:08 INFO - PID 20426 | Cycle 1(1): loaded http://localhost:41015/tests/dromaeo/cssquery-yui.html (next: http://localhost:41015/tests/dromaeo/cssquery-dojo.html) 06:52:08 INFO - PID 20426 | RSS: Main: 174632960 06:52:08 INFO - PID 20426 | 06:52:08 INFO - PID 20426 | __start_tp_report 06:52:08 INFO - PID 20426 | _x_x_mozilla_page_load 06:52:08 INFO - PID 20426 | _x_x_mozilla_page_load_details 06:52:08 INFO - PID 20426 | |i|pagename|runs| 06:52:08 INFO - PID 20426 | |0;dojo.html;2718.891244350226;2734.6855111662167;2753.752162305392;2761.696213416525;2767.0177087134066;5221.164613661815;5285.6300058995885;5293.788248470057;5295.549878260343;5319.202119682045;5281.815136470224;5295.655782374143;5341.145416733333;5357.866053348668;5390.51485366317;4661.394018777554;4685.2269375553;4715.669903106784;4731.5268473152755;4775.92836107457;4636.675432719711;4746.857594272177;4773.641976851733;4798.664093513456;4837.080954618629;4637.814487420499;4729.527047295277;4774.904501909977;4784.688995215317;4787.61699064074;4615.26155815068;4669.743164125972;4688.624910007191;4705.129551033036;4706.858794236178;4609.631229501631;4676.041411510632;4677.859664210079;4684.976575117103;4726.172919739066;5252.606054545924;5253;5254.395744489394;5316.142176592191;5335.1197052486295;5637.887242255173;5694.402087780806;5719.914201286984;5728.312602487728;5732.340780810218;5760.049591817345;5785.190073389729;5787.652740835563;5792.623479473863;5795.1017592273265;5309.283246761715;5347.0375332440535;5351.063563876306;5368.812091576776;5370.731463426813;5869.589128760946;5897.705114744245;5920.289565252111;5920.615160014671;5922.526197904157;5613.943860561342;5622.57830662702;5627.212190293362;5648.350439699405;5658.830235092953;5756.827295181151;5759.395263497357;5768.278965129359;5778.191053252548;5778.3354914184565;5612.691301978349;5641.2384328116;5646.915296270559;5669.659820410789;5704.743286552115;5696.914546281809;5698.088305871041;5718.1136923776885;5721.5136713379825;5729.684867332337;4768.451628062748;4776.21192503233;4825.348577942003;4835.564799168092;4868.196747536687;4123.752574845519;4140.420341152241;4183.49798024239;4209.095044565433;4228.809703563347;4857.392825896763;4890.095332363524;4905.3132561441425;4905.9754701226975;4948.851534453972;5671;5771.913421298684;5774.364819869811;5792.4497172768515;5840.649561026352;4853.805847766121;4889.266610008527;4904.583110435653;4908.01839632075;4944.456109827916;5143.537081662594;5168.715720635401;5177.818776342885;5178.093833579109;5178.508041736029;5434.701091439851;5447.155690867922;5454.618176727591;5469.3983661797965;5476.014317422902;5730.684812335361;5760.193572899713;5823.4467725566;5842.474177324061;5880.117982302518;5328.467153284795;5412.323459567554;5412.891742165213;5420.024395608828;5422.6475279106735;5578.86052848682;5649.37856835756;5668.093105103164;5711.742971566373;5746.511546518593;5776.364599893925;5794.1308803679785;5825.76696932118;5836.737346819488;5887.20522729426;5553.694546799965;5581.162825576033;5618.269624948731;5620.606557540933;5632.239647647679;5489.862753431196;5545.3622833374675;5547.44525547442;5612.410696876769;5634.183043458757;5502.394736579053;5504.752286147213;5536.584756143386;5537.335519737496;5539.806106786405;5651.57613179005;5661;5664.065429204135;5680.9147862781265;5737.368889422244;5432.429594892479;5482.42434544383;5482.616216864782;5486.807961721321;5490.3411590609385 06:52:08 INFO - PID 20426 | |1;ext.html;677.0352248046534;998.9650362237321;1015.1777060580926;1018.3533456255285;1022.8363461846106;29635.703642963563;33186.17034574134;33324.833375833114;33378.666213337856;33599.16002099949;34584.1353966151;34830.12924676884;34833.95498135054;34866.302673946506;34908;6786.864262714743;6846.34959678831;6999.160100787913;7007.649617519103;7027.297270272983;6933.098697169361;7034.753783617574;7043.225245223021;7046.577205367695;7050.788476345692;6993.055937448456;7022.19244786851;7042.718291268343;7046;7050.894236586455;6971.825704357381;7012.929870701279;7031.015657807911;7032.15614126303;7057.117860267466;6877.140357455318;6907.896381554281;6955.791326260221;6960.129983752031;6969.825754356181;30278.394432111454;30427.543586846215;30501.847490762404;30679;30905;2869.139258222525;2882.3082460209607;2891.08930686833;2901.970980290191;2906.1281615515472;23743.525129497313;23931.88034059836;23980.520389592286;23987.520249595083;24020.15929442461;3053.755699544053;3065.524843649238;3079.8306093164865;3137.62348518177;3178.777485576011;131845;132257.3387133068;132487.33756331156;132567;132788;36222.275554489286;38086.428703569465;38125.23749524994;38299.23401531954;38658.22683546313;39940.20119597592;40141.397879031836;40209.39685904714;40239.79880100639;40300.39549406761;12127.514899404101;12196.14626976121;12223.69440763988;12258.754824903452;12280.938595306967;9647.179989700953;9683.612655493702;9684.806303874024;9688;9706.272029597667;11999.520019199133;12226.144169908199;12247.387630618434;12265.754684906253;12407.565735199225;5307.319803499208;5320.813771517978;5324.467553244722;5331.306930099062;5353.116735738559;869.8869147010848;906.2523418180028;914.4056363363867;920.1028996728137;944.9952750236205;20080.196792128445;20389;20789.272375466786;20837;21252.25617103394;979.1139019187647;986.5363279258737;986.9161121304626;989.5003023473244;1001.9649312274036;10788.838167427495;10892.564297428173;10990.120790336754;11132.554697812158;11242.775144497227;181805;182368;182390;182399;183133;39318;39634.207315854095;39701.60298397037;39754.80122599369;39764;1207.571312184162;1253.3482589053824;1253.5800506830315;1254.3289340202948;1255.12768625806;19348.226070957568;19468.61062778765;20024.59950801005;20297;20574.897125514275;28561.714382856735;28668.42663146767;28685.28286792847;28728.71271287344;28763.137105886857;150921.2453937767;150971.2451437736;151274;151353;151804;27880.860595697704;27882.26001579777;28146.71853281523;29216.123516294545;29761.851190743906;33815;34265.31469370649;34467.13832154116;34516;34865.82567087148;26300.736992629827;26912.865435672695;27053.1884043479;27358;27867.606619669343;26231.73768262293;26247.081352153346;27045.86477067602;27414.862925685244;27850.44299114047;29640.40719185561;29683.109506714834;29806.956756514286;29873;29891.850540747157;24627;25786.226413207634;26445.33886652849;26497.94008239649;26550.468990620466;19988.600227995066;21633;21729.565408692055;21934;22205.88897055569 06:52:08 INFO - PID 20426 | |2;jquery.html;407.01299349078477;409.6517959734225;415.2152431903701;419.5259356926673;429.26381256145703;16462.83537164628;17219.311227550897;17238.569035774097;18909.24363025481;19530.414087577396;18557;18588.62822743544;18629.254829806792;18731.719024214646;19012.904935475304;5454.290942177511;5497.5601951843855;5552.7223638817895;5584.469475399851;5597.608167428281;5542.418046105161;5573.721313934308;5590.776368945238;5596.244506991565;5620.662760234379;5357;5558.833235002957;5601.103823388259;5622.269105016342;5630.324361076677;5363.651362661414;5524.8342549723575;5536.169574563827;5536.280283563151;5591.049521581321;4897.853064408037;5074.82238121664;5076.18780995039;5076.898462030776;5078.4159821620615;21661.241856535104;21704.891475542678;22153.113875444964;22377.664335034988;22535.098596056137;1631.8531332180162;1655.470249520154;1662.0443245133974;1668.4243935842114;1668.9499315020569;14902.1803800792;15092;15200.46798362063;15383.846161538353;15617.141057241846;2079.365793433002;2112.2184791627196;2129.8083172514393;2146;2161.8810965396897;92049;94187.87778794425;94208;95505;95593.52203239009;11092.279001864854;11191.888081119085;11297.943510282395;11406.771864562663;11420.42897855104;15679.764803527729;15710.450134245246;15737.842621573638;15741.921290393475;15802.525924222291;7338.522996005243;7580.620968951531;7722.884156737653;7730.92269077302;7794.6882124714375;6808.9659551701925;6901.447884169254;6914.619695916773;7090.326418990187;7109.964450177819;7067;7077.292270772881;7116.359527642434;7195.784126476109;7278.890816637755;2108.5255817440952;2137.041387135939;2144.4853235223436;2156.2668692644575;2284.920027799019;845.4842546046906;876.202655583416;876.9649214031367;877.0790669796688;899.2131884600974;16843.494695159166;16890.155492225338;17391.130443477774;17402.82597174012;17996.730049049274;865.6926790989108;872.7163671806688;880.2297989259398;881.9294456443597;895;9221.677241296522;11088.722781930355;12219.26684398939;12258.570950016885;12259.57091501811;359704;373207;374501;376230;376893;67725.3227467719;77721;77932;81636;81806.18193818105;1025.9281850270409;1073.7637719701654;1101.4602844606245;1115.9107271418268;1126.2566705974182;17292.827071729625;17364;17875.910620446815;18340.266389344277;18650.81349186545;38164.809175953946;39026;39263.2147357057;39594;39689.20621587495;48902.26646600375;49493;49504.75247623739;49805.50194498154;50156.74921625369;7930.405219608668;8166.101728809707;8173.5504547250475;8303.792405189919;8324.625391857502;12175.512979481076;12478.688032799253;12662.240265584094;12706.491740330282;12891.290978996245;10513.737156571147;10728.678139655824;10737.731556711145;10859.511321990687;10933.234673573092;9747.220222382335;10052;10059.748506287402;10093.142082923034;10208.336458130198;10086.546105425421;10549.841752373566;10840.5121769519;10922.672319830417;11037.11703063737;8061.798455038671;8067.878981815395;8109.148539403278;8402.747917562483;8494.57527123629;10217.846732299171;10246.590136394461;10289.897101028893;10375.533101010322;10477.580896764044 06:52:08 INFO - PID 20426 | |3;mootools.html;1230.2741382584277;1302.6873550347916;1311.2919023727188;1311.986880131199;1314.093275639809;10024.147947424468;10526.631567895125;10551.841722374162;10630.255882088257;10913.181511386658;10600.310979786309;10712.732181695443;10784.78430431391;10793.892061079387;10808.891911080887;2294.781995710409;2335.92992210234;2344.824138189634;2346.8826558672;2348.3894187511287;2176.2927048709234;2272.5114100468395;2277.3851060213733;2282.9726623019624;2295.4031951692596;2231.040652519416;2238.3620668109593;2283.691701620285;2284.2918695204457;2287.8512896661746;2223.3885681437655;2232.9888350558304;2263.739669937962;2269.7843704848015;2280.486890449652;2141.8179454746364;2236.731592208929;2244.2033078257145;2270.5685919675207;2300.2639155470256;10307.89692103077;10455.215858810543;10460.843087353696;10505.212109091772;10539.262251642389;5723.742431590588;5927.407259274081;5942.910856337158;5954.940450595525;5968.820935371946;3254.4792833146585;3529.294141171776;3537.0980399998093;3565.625609311011;3585.515955346047;1090.939998300093;1116.2019156303281;1133.3539882267112;1149.9942500287445;1162.9360385178811;15175.468858589897;15414.691706165926;15526.301316440788;15544.145072021034;15574.14342211178;5054.191329387354;5279.762410691528;5451.563874889999;5458.699771512605;5477.643953143033;12738.172018818746;12762.447510497752;12867.742645147044;12880.291583962784;12891.228385897077;5881.41185881417;5886.676232807236;5900.262467191601;5904.0553511437965;5919.289685237799;5082.2122571001555;5095.974520127375;5293.788248470095;5294.788208471695;5347.839564813062;4246.936295955563;4288.764117973541;4313.4823821141035;4347.5217726050105;4373.6282415994365;1323.4970711129708;1368.3295185359102;1376.5250988409184;1383.4051357915992;1387.0429403711407;735.5880706804206;739.9223081576465;742.1131747561612;755.2975732568653;759.6809340077181;5659.915101273484;5752.194692743019;5860.677662728591;5904.439078287642;5967.1347654589845;850.9446885952393;854.4702284583598;854.8974123105143;869.1221865915345;875.2123089219626;4001.959980400217;4130.359794231899;4168.520620128664;4352;4519.209138400833;13164.078514504085;13234.536791212262;13399.196048237138;13442.126261792951;13483.19100853952;12896.29070401137;13175.736485270241;13215.141015834133;13418.664533386744;13437.395317210749;7675.462717609826;7760;7872.921270787218;7910.683572657029;7938.9206107939335;6188.876222475616;6358.586691865014;6370.713317900798;6531.412172904462;6657.667116644246;11610.94194529022;11635.592754253561;11751.118666099906;11844.28934263947;11945.343006134746;11926.701832453911;12047.879521204675;12265.570705025639;12324.274601555968;12504.436945381827;8430.199131082538;8508.064112947446;8546.145385461405;8561.48631082137;8566.314694824523;9367.718968430958;9576.712698619052;9579.664711735057;9580.76048098803;9581.233501319739;7669.578173200527;8378.790530236793;8547.658093676184;8576.099509551408;8577.95711021441;8378.664853405795;8394;8434.451760635538;8435.283000944988;8452.1547845215;7436.96281518589;7534.434917381109;7565.962170189114;7628.084629844454;7645.961770191114;5441.183822426509;5462.644928079662;5528.032594295902;5558.638688485235;5602.215689803512;5564.610477266552;5630.690312032878;5645.802396916089;5720.942790572041;5800.50695690871 06:52:08 INFO - PID 20426 | |4;prototype.html;355.07148805872635;361.94932709420675;364.1351789499939;364.6863697220388;368.116520351157;5537.252470916425;5572.944270557288;5590.385057643656;5592.888142237153;5603.551715862732;5388.218708287296;5460.34475862896;5468.72656367181;5487.807926722566;5489.890202195954;4157.771322577257;4191.622753952143;4193.287141185998;4200.789960501978;4221.936670949923;4168.874933751978;4186.476690413699;4189.141226048653;4189.183109293689;4199.664026877857;4192.4549808525;4194.727342722728;4195.265828480019;4199.55904630014;4212.283911735012;3860.4595356650093;4017.4576432181575;4021.296273152216;4034.2567054402994;4206.894827629303;3454.7063499602564;3464.4630082337276;3464.7055000325004;3480.7911525308564;3483.425234836249;5283.682979021232;5293.57651387888;5330.520253177194;5331.386890507602;5338.759755810997;4576.1762882681105;4659.767011649404;4728.219843725781;4746.121967436001;4756.239001759736;5703.686297253649;5721.34204566476;5734.4265573442735;5742.799002034909;5754.539636829086;3904.7071469639604;3912.865269071966;3919.9808049906947;3920.3926390180172;3927.6857851371824;6006.939930600682;6083.270007599072;6090.543209259324;6136.447719705248;6147.600405973642;4009.0779120801794;4012.578679238696;4016.3975403689096;4027.295223335963;4027.81874815634;4054.5134583850127;4058.7564746115327;4071.898202544901;4073.877783666495;4080.7347522410946;4657.208274593328;4714.245720684743;4763.880902977453;4767.284907263938;4768.546988036131;5757.553039958085;5772.191893134965;5774.220480235114;5781.046127389018;5800.1299805029585;1382.4677499162894;1415.8371787244394;1416.3838730152418;1419.9148051116965;1420.6306360346177;893.660409044559;920.392540923001;934.2105920497169;935.8830146231721;939.4551160326994;4976.154053810861;4984.8753781155765;5006.723285562159;5019.899602007939;5023.447420783711;5914.556408269311;5933.643981361132;5953.493953013955;5968.37332080134;5989.431004054608;4805.1590971579835;4954.702717836942;4955;4959.851204463872;5019.247112933016;3123.2816452216116;3125.7030582094662;3133.887469948181;3145.1350878508138;3147.6065491813524;5481.862953426116;5536.612437129443;5568.136938774496;5585.525230355384;5589.692566908859;5957.344692083867;5963.254593175853;6084.787032453843;6105.297890742532;6113.663748493876;5580.330360356783;5595.552355811526;5609.691466969356;5618.213450116987;5619.438056194348;5915.58590898633;5958.374370691015;5975.970120149372;5982.132590774227;5995.5803093783015;5633.915491267716;5849.444302791228;5880.735366908585;5919.260092488439;5930.614510056833;5582.134769110794;5595.468430499096;5624.381318055092;5625.509240051471;5633.887322253614;3976.622220889011;4011.7392369495888;4026.456428382131;4033.959660403476;4044.959550404576;5960.897234011722;5994.730237139252;5996.610220335664;6008.789692360747;6036.547258955508;5806.158107074366;5823.854403639943;5831.620944638585;5837.766489340379;5863.589548731718;5725.570582206435;5749.338826035059;5789.668376273565;5789.8263052108505;5846.94153058464;5678;5711.600187986801;5712.485876271156;5718.25662663851;5736.340320863154;5582.8325150245555;5839.649621022752;5858.978652364927;5867.765289388377;5879.441453061952;5633.718314084197;5634.295713035871;5649.604527683023;5649.71751412436;5662.462066103713 06:52:08 INFO - PID 20426 | |5;yui.html;679.6296018669824;682.0894106368002;687.4603436302503;692.518699503845;695.5861262548782;12203.877961220385;12609.621711348662;12618.432170552313;12965;14834.109953402804;13964.581062568139;14177.574672759834;14206.928965355159;14239.715205695906;15112.848871511282;875.4528419737663;912.32943786317;912.3841407050247;912.6258234123977;912.8950170730351;819.6844214977217;900.545224661545;900.8963969143567;908.404994728454;909.3452714045876;938.4181807279497;939.8496240601505;940.2524992630875;941.8540126280437;942.7218970403748;937.7186843946823;938.6949241496541;943.1370296179023;945.6737425588161;947.5925352098595;689.9965500172467;690.7237105157977;696.1889398850333;697.3201128899333;697.769735987123;12228.449719762632;12318.445669944875;12441.066919981038;12458.636168234525;13198.67003324915;15609.531714048597;15793.921030394775;16053;16127.274272657758;16194.433194838242;11387.487563059682;11543.769124617545;11584.42077896102;11628.302301861915;11639.825402618968;2944.6613639431525;2992.326726486523;3002.459557279689;3010.5785190073407;3011.744001759853;71630.64184679095;72707.27292727058;72769;73851.63074184595;74711.62644186744;12288.815667764991;12431.502739890304;12455.377231138407;12498.500059997497;12547;20328.69506957397;21415.143394264054;21583.67624485634;21738.13047478083;22742;6196.132541444202;6394.712237949303;6454.419102280817;6522.543421960512;6733.663316834237;3082.7533797296164;3149.401613693391;3157;3165.398574270881;3168.524721291825;3434.4333185024193;3496.2483066140903;3503.4044212483427;3507.2989600043957;3518.3139287838626;730.6675462664475;738.1142628845299;745.273358475493;745.7725393754848;748.6406524868094;556.3740791609439;593.9049752039653;623.3236937922405;623.7099748616824;633.9968300158562;8868.911310886808;9252.814943701089;9654.131128198496;9859.161971232383;10087.49562521871;550.4907960136858;566.5014786987425;567.3333832746506;567.8012695556605;569.0525275416468;4303.698741088157;4527.071950250257;4556.703814252063;4571.839985600554;4676.3453116563705;63197;63322.366776332565;64050.35949640537;64537.35462645407;65223;56950;57600.13599796007;58055.70972145112;58065.709671451375;58118.41881581215;50128.248076278884;51979.480205198975;52086.73956630193;52656.21015684768;52985.735071324394;8262.091169971418;8268.917310827055;8486.830263394573;8609.65561377538;8824.5587720615;25788.871055644602;26097.217083487525;26102.86948565245;26354;26513.86743066272;31445.842770786;31931.201719957186;31931.36137277288;32425.837870810494;32606.51090233601;11515.30908145514;11670.824937626112;11726.70683232926;11742.823857641972;11861.406929653655;12700.491980320683;12758.808617870925;12856.614301570968;12992.220466772023;13047.608571742863;10764.838527421938;10884.836727449254;10973.341599504056;11036.834447483454;11099.833502497308;11940.940295298467;11963.521459141537;12019.819702704292;12131.757364852478;12241.387930603612;11291.209615326849;11363.886361136283;11395.259308145276;11551.191416601094;11709.531618735155;8689.913760779902;8854.645814167361;8861.689840855539;9035.50304733246;9114.726558203265;9075.500847453453;9227.35408521397;9304.906950930404;9311.115444032806;9564.995675454256 06:52:08 INFO - PID 20426 | __end_tp_report 06:52:08 INFO - PID 20426 | __start_cc_report 06:52:08 INFO - PID 20426 | _x_x_mozilla_cycle_collect,282 06:52:08 INFO - PID 20426 | __end_cc_report 06:52:08 INFO - PID 20426 | __startTimestamp1494942728301__endTimestamp 06:52:08 INFO - PID 20426 | 06:52:08 INFO - PID 20426 | ------- Summary: start ------- 06:52:08 INFO - PID 20426 | Number of tests: 6 06:52:08 INFO - PID 20426 | 06:52:08 INFO - PID 20426 | [#0] dojo.html Cycles:165 Average:5256.42 Median:5447.16 stddev:623.73 (11.5%) stddev-sans-first:593.03 06:52:08 INFO - PID 20426 | Values: 2718.9 2734.7 2753.8 2761.7 2767.0 5221.2 5285.6 5293.8 5295.5 5319.2 5281.8 5295.7 5341.1 5357.9 5390.5 4661.4 4685.2 4715.7 4731.5 4775.9 4636.7 4746.9 4773.6 4798.7 4837.1 4637.8 4729.5 4774.9 4784.7 4787.6 4615.3 4669.7 4688.6 4705.1 4706.9 4609.6 4676.0 4677.9 4685.0 4726.2 5252.6 5253.0 5254.4 5316.1 5335.1 5637.9 5694.4 5719.9 5728.3 5732.3 5760.0 5785.2 5787.7 5792.6 5795.1 5309.3 5347.0 5351.1 5368.8 5370.7 5869.6 5897.7 5920.3 5920.6 5922.5 5613.9 5622.6 5627.2 5648.4 5658.8 5756.8 5759.4 5768.3 5778.2 5778.3 5612.7 5641.2 5646.9 5669.7 5704.7 5696.9 5698.1 5718.1 5721.5 5729.7 4768.5 4776.2 4825.3 4835.6 4868.2 4123.8 4140.4 4183.5 4209.1 4228.8 4857.4 4890.1 4905.3 4906.0 4948.9 5671.0 5771.9 5774.4 5792.4 5840.6 4853.8 4889.3 4904.6 4908.0 4944.5 5143.5 5168.7 5177.8 5178.1 5178.5 5434.7 5447.2 5454.6 5469.4 5476.0 5730.7 5760.2 5823.4 5842.5 5880.1 5328.5 5412.3 5412.9 5420.0 5422.6 5578.9 5649.4 5668.1 5711.7 5746.5 5776.4 5794.1 5825.8 5836.7 5887.2 5553.7 5581.2 5618.3 5620.6 5632.2 5489.9 5545.4 5547.4 5612.4 5634.2 5502.4 5504.8 5536.6 5537.3 5539.8 5651.6 5661.0 5664.1 5680.9 5737.4 5432.4 5482.4 5482.6 5486.8 5490.3 06:52:08 INFO - PID 20426 | 06:52:08 INFO - PID 20426 | [#1] ext.html Cycles:180 Average:29575.99 Median:29722.48 stddev:40438.24 (136.1%) stddev-sans-first:40493.45 06:52:08 INFO - PID 20426 | Values: 677.0 999.0 1015.2 1018.4 1022.8 29635.7 33186.2 33324.8 33378.7 33599.2 34584.1 34830.1 34834.0 34866.3 34908.0 6786.9 6846.3 6999.2 7007.6 7027.3 6933.1 7034.8 7043.2 7046.6 7050.8 6993.1 7022.2 7042.7 7046.0 7050.9 6971.8 7012.9 7031.0 7032.2 7057.1 6877.1 6907.9 6955.8 6960.1 6969.8 30278.4 30427.5 30501.8 30679.0 30905.0 2869.1 2882.3 2891.1 2902.0 2906.1 23743.5 23931.9 23980.5 23987.5 24020.2 3053.8 3065.5 3079.8 3137.6 3178.8 131845.0 132257.3 132487.3 132567.0 132788.0 36222.3 38086.4 38125.2 38299.2 38658.2 39940.2 40141.4 40209.4 40239.8 40300.4 12127.5 12196.1 12223.7 12258.8 12280.9 9647.2 9683.6 9684.8 9688.0 9706.3 11999.5 12226.1 12247.4 12265.8 12407.6 5307.3 5320.8 5324.5 5331.3 5353.1 869.9 906.3 914.4 920.1 945.0 20080.2 20389.0 20789.3 20837.0 21252.3 979.1 986.5 986.9 989.5 1002.0 10788.8 10892.6 10990.1 11132.6 11242.8 181805.0 182368.0 182390.0 182399.0 183133.0 39318.0 39634.2 39701.6 39754.8 39764.0 1207.6 1253.3 1253.6 1254.3 1255.1 19348.2 19468.6 20024.6 20297.0 20574.9 28561.7 28668.4 28685.3 28728.7 28763.1 150921.2 150971.2 151274.0 151353.0 151804.0 27880.9 27882.3 28146.7 29216.1 29761.9 33815.0 34265.3 34467.1 34516.0 34865.8 26300.7 26912.9 27053.2 27358.0 27867.6 26231.7 26247.1 27045.9 27414.9 27850.4 29640.4 29683.1 29807.0 29873.0 29891.9 24627.0 25786.2 26445.3 26497.9 26550.5 19988.6 21633.0 21729.6 21934.0 22205.9 06:52:08 INFO - PID 20426 | 06:52:08 INFO - PID 20426 | [#2] jquery.html Cycles:180 Average:25250.09 Median:375365.50 stddev:62090.74 (16.5%) stddev-sans-first:62236.90 06:52:08 INFO - PID 20426 | Values: 407.0 409.7 415.2 419.5 429.3 16462.8 17219.3 17238.6 18909.2 19530.4 18557.0 18588.6 18629.3 18731.7 19012.9 5454.3 5497.6 5552.7 5584.5 5597.6 5542.4 5573.7 5590.8 5596.2 5620.7 5357.0 5558.8 5601.1 5622.3 5630.3 5363.7 5524.8 5536.2 5536.3 5591.0 4897.9 5074.8 5076.2 5076.9 5078.4 21661.2 21704.9 22153.1 22377.7 22535.1 1631.9 1655.5 1662.0 1668.4 1668.9 14902.2 15092.0 15200.5 15383.8 15617.1 2079.4 2112.2 2129.8 2146.0 2161.9 92049.0 94187.9 94208.0 95505.0 95593.5 11092.3 11191.9 11297.9 11406.8 11420.4 15679.8 15710.5 15737.8 15741.9 15802.5 7338.5 7580.6 7722.9 7730.9 7794.7 6809.0 6901.4 6914.6 7090.3 7110.0 7067.0 7077.3 7116.4 7195.8 7278.9 2108.5 2137.0 2144.5 2156.3 2284.9 845.5 876.2 877.0 877.1 899.2 16843.5 16890.2 17391.1 17402.8 17996.7 865.7 872.7 880.2 881.9 895.0 9221.7 11088.7 12219.3 12258.6 12259.6 359704.0 373207.0 374501.0 376230.0 376893.0 67725.3 77721.0 77932.0 81636.0 81806.2 1025.9 1073.8 1101.5 1115.9 1126.3 17292.8 17364.0 17875.9 18340.3 18650.8 38164.8 39026.0 39263.2 39594.0 39689.2 48902.3 49493.0 49504.8 49805.5 50156.7 7930.4 8166.1 8173.6 8303.8 8324.6 12175.5 12478.7 12662.2 12706.5 12891.3 10513.7 10728.7 10737.7 10859.5 10933.2 9747.2 10052.0 10059.7 10093.1 10208.3 10086.5 10549.8 10840.5 10922.7 11037.1 8061.8 8067.9 8109.1 8402.7 8494.6 10217.8 10246.6 10289.9 10375.5 10477.6 06:52:08 INFO - PID 20426 | 06:52:08 INFO - PID 20426 | [#3] mootools.html Cycles:180 Average:6538.09 Median:4066.16 stddev:4119.38 (101.3%) stddev-sans-first:4111.62 06:52:08 INFO - PID 20426 | Values: 1230.3 1302.7 1311.3 1312.0 1314.1 10024.1 10526.6 10551.8 10630.3 10913.2 10600.3 10712.7 10784.8 10793.9 10808.9 2294.8 2335.9 2344.8 2346.9 2348.4 2176.3 2272.5 2277.4 2283.0 2295.4 2231.0 2238.4 2283.7 2284.3 2287.9 2223.4 2233.0 2263.7 2269.8 2280.5 2141.8 2236.7 2244.2 2270.6 2300.3 10307.9 10455.2 10460.8 10505.2 10539.3 5723.7 5927.4 5942.9 5954.9 5968.8 3254.5 3529.3 3537.1 3565.6 3585.5 1090.9 1116.2 1133.4 1150.0 1162.9 15175.5 15414.7 15526.3 15544.1 15574.1 5054.2 5279.8 5451.6 5458.7 5477.6 12738.2 12762.4 12867.7 12880.3 12891.2 5881.4 5886.7 5900.3 5904.1 5919.3 5082.2 5096.0 5293.8 5294.8 5347.8 4246.9 4288.8 4313.5 4347.5 4373.6 1323.5 1368.3 1376.5 1383.4 1387.0 735.6 739.9 742.1 755.3 759.7 5659.9 5752.2 5860.7 5904.4 5967.1 850.9 854.5 854.9 869.1 875.2 4002.0 4130.4 4168.5 4352.0 4519.2 13164.1 13234.5 13399.2 13442.1 13483.2 12896.3 13175.7 13215.1 13418.7 13437.4 7675.5 7760.0 7872.9 7910.7 7938.9 6188.9 6358.6 6370.7 6531.4 6657.7 11610.9 11635.6 11751.1 11844.3 11945.3 11926.7 12047.9 12265.6 12324.3 12504.4 8430.2 8508.1 8546.1 8561.5 8566.3 9367.7 9576.7 9579.7 9580.8 9581.2 7669.6 8378.8 8547.7 8576.1 8578.0 8378.7 8394.0 8434.5 8435.3 8452.2 7437.0 7534.4 7566.0 7628.1 7646.0 5441.2 5462.6 5528.0 5558.6 5602.2 5564.6 5630.7 5645.8 5720.9 5800.5 06:52:08 INFO - PID 20426 | 06:52:08 INFO - PID 20426 | [#4] prototype.html Cycles:180 Average:4739.06 Median:5513.25 stddev:1427.99 (25.9%) stddev-sans-first:1393.57 06:52:08 INFO - PID 20426 | Values: 355.1 361.9 364.1 364.7 368.1 5537.3 5572.9 5590.4 5592.9 5603.6 5388.2 5460.3 5468.7 5487.8 5489.9 4157.8 4191.6 4193.3 4200.8 4221.9 4168.9 4186.5 4189.1 4189.2 4199.7 4192.5 4194.7 4195.3 4199.6 4212.3 3860.5 4017.5 4021.3 4034.3 4206.9 3454.7 3464.5 3464.7 3480.8 3483.4 5283.7 5293.6 5330.5 5331.4 5338.8 4576.2 4659.8 4728.2 4746.1 4756.2 5703.7 5721.3 5734.4 5742.8 5754.5 3904.7 3912.9 3920.0 3920.4 3927.7 6006.9 6083.3 6090.5 6136.4 6147.6 4009.1 4012.6 4016.4 4027.3 4027.8 4054.5 4058.8 4071.9 4073.9 4080.7 4657.2 4714.2 4763.9 4767.3 4768.5 5757.6 5772.2 5774.2 5781.0 5800.1 1382.5 1415.8 1416.4 1419.9 1420.6 893.7 920.4 934.2 935.9 939.5 4976.2 4984.9 5006.7 5019.9 5023.4 5914.6 5933.6 5953.5 5968.4 5989.4 4805.2 4954.7 4955.0 4959.9 5019.2 3123.3 3125.7 3133.9 3145.1 3147.6 5481.9 5536.6 5568.1 5585.5 5589.7 5957.3 5963.3 6084.8 6105.3 6113.7 5580.3 5595.6 5609.7 5618.2 5619.4 5915.6 5958.4 5976.0 5982.1 5995.6 5633.9 5849.4 5880.7 5919.3 5930.6 5582.1 5595.5 5624.4 5625.5 5633.9 3976.6 4011.7 4026.5 4034.0 4045.0 5960.9 5994.7 5996.6 6008.8 6036.5 5806.2 5823.9 5831.6 5837.8 5863.6 5725.6 5749.3 5789.7 5789.8 5846.9 5678.0 5711.6 5712.5 5718.3 5736.3 5582.8 5839.6 5859.0 5867.8 5879.4 5633.7 5634.3 5649.6 5649.7 5662.5 06:52:08 INFO - PID 20426 | 06:52:08 INFO - PID 20426 | [#5] yui.html Cycles:180 Average:14707.67 Median:27402.30 stddev:18376.00 (67.1%) stddev-sans-first:18397.36 06:52:08 INFO - PID 20426 | Values: 679.6 682.1 687.5 692.5 695.6 12203.9 12609.6 12618.4 12965.0 14834.1 13964.6 14177.6 14206.9 14239.7 15112.8 875.5 912.3 912.4 912.6 912.9 819.7 900.5 900.9 908.4 909.3 938.4 939.8 940.3 941.9 942.7 937.7 938.7 943.1 945.7 947.6 690.0 690.7 696.2 697.3 697.8 12228.4 12318.4 12441.1 12458.6 13198.7 15609.5 15793.9 16053.0 16127.3 16194.4 11387.5 11543.8 11584.4 11628.3 11639.8 2944.7 2992.3 3002.5 3010.6 3011.7 71630.6 72707.3 72769.0 73851.6 74711.6 12288.8 12431.5 12455.4 12498.5 12547.0 20328.7 21415.1 21583.7 21738.1 22742.0 6196.1 6394.7 6454.4 6522.5 6733.7 3082.8 3149.4 3157.0 3165.4 3168.5 3434.4 3496.2 3503.4 3507.3 3518.3 730.7 738.1 745.3 745.8 748.6 556.4 593.9 623.3 623.7 634.0 8868.9 9252.8 9654.1 9859.2 10087.5 550.5 566.5 567.3 567.8 569.1 4303.7 4527.1 4556.7 4571.8 4676.3 63197.0 63322.4 64050.4 64537.4 65223.0 56950.0 57600.1 58055.7 58065.7 58118.4 50128.2 51979.5 52086.7 52656.2 52985.7 8262.1 8268.9 8486.8 8609.7 8824.6 25788.9 26097.2 26102.9 26354.0 26513.9 31445.8 31931.2 31931.4 32425.8 32606.5 11515.3 11670.8 11726.7 11742.8 11861.4 12700.5 12758.8 12856.6 12992.2 13047.6 10764.8 10884.8 10973.3 11036.8 11099.8 11940.9 11963.5 12019.8 12131.8 12241.4 11291.2 11363.9 11395.3 11551.2 11709.5 8689.9 8854.6 8861.7 9035.5 9114.7 9075.5 9227.4 9304.9 9311.1 9565.0 06:52:08 INFO - PID 20426 | -------- Summary: end -------- 06:52:08 INFO - PID 20426 | 06:52:09 INFO - TEST-INFO | 20426: exit 0 06:52:09 INFO - TEST-OK | dromaeo_css | took 1119727ms 06:52:09 INFO - TEST-START | kraken 06:52:09 INFO - operating with platform_type : linux_ 06:52:09 INFO - Initialising browser for kraken test... 06:52:09 INFO - TEST-INFO | started process 20838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVHGtXU/profile http://localhost:41015/getInfo.html) 06:52:09 INFO - PID 20838 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2930: String.localeCompare is deprecated; use String.prototype.localeCompare instead 06:52:13 INFO - PID 20838 | __metrics Screen width/height:1600/1200 06:52:13 INFO - PID 20838 | colorDepth:24 06:52:13 INFO - PID 20838 | Browser inner width/height: 1024/695 06:52:13 INFO - PID 20838 | __metrics 06:52:15 INFO - TEST-INFO | 20838: exit 0 06:52:15 INFO - Browser initialized. 06:52:15 INFO - Running cycle 1/1 for kraken test... 06:52:15 INFO - TEST-INFO | started process 21009 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVHGtXU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:52:26 INFO - PID 21009 | RSS: Main: 161705984 06:52:26 INFO - PID 21009 | 06:52:29 INFO - PID 21009 | Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41015/tests/kraken/driver.html?testName=audio-beat-detection) 06:52:30 INFO - PID 21009 | RSS: Main: 167096320 06:52:30 INFO - PID 21009 | 06:52:33 INFO - PID 21009 | Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41015/tests/kraken/driver.html?testName=audio-dft) 06:52:33 INFO - PID 21009 | RSS: Main: 166543360 06:52:33 INFO - PID 21009 | 06:52:36 INFO - PID 21009 | Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41015/tests/kraken/driver.html?testName=audio-fft) 06:52:37 INFO - PID 21009 | RSS: Main: 162004992 06:52:37 INFO - PID 21009 | 06:52:39 INFO - PID 21009 | Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41015/tests/kraken/driver.html?testName=audio-oscillator) 06:52:40 INFO - PID 21009 | RSS: Main: 162471936 06:52:40 INFO - PID 21009 | 06:52:42 INFO - PID 21009 | Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41015/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:52:42 INFO - PID 21009 | RSS: Main: 162566144 06:52:42 INFO - PID 21009 | 06:52:45 INFO - PID 21009 | Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41015/tests/kraken/driver.html?testName=imaging-darkroom) 06:52:46 INFO - PID 21009 | RSS: Main: 166862848 06:52:46 INFO - PID 21009 | 06:52:50 INFO - PID 21009 | Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41015/tests/kraken/driver.html?testName=imaging-desaturate) 06:52:50 INFO - PID 21009 | RSS: Main: 164454400 06:52:50 INFO - PID 21009 | 06:52:53 INFO - PID 21009 | Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41015/tests/kraken/driver.html?testName=json-parse-financial) 06:52:54 INFO - PID 21009 | RSS: Main: 165658624 06:52:54 INFO - PID 21009 | 06:52:55 INFO - PID 21009 | Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41015/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:52:56 INFO - PID 21009 | RSS: Main: 165339136 06:52:56 INFO - PID 21009 | 06:52:58 INFO - PID 21009 | Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41015/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:52:58 INFO - PID 21009 | RSS: Main: 165527552 06:52:58 INFO - PID 21009 | 06:53:00 INFO - PID 21009 | Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41015/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:53:01 INFO - PID 21009 | RSS: Main: 165601280 06:53:01 INFO - PID 21009 | 06:53:04 INFO - PID 21009 | Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41015/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:53:05 INFO - PID 21009 | RSS: Main: 165367808 06:53:05 INFO - PID 21009 | 06:53:08 INFO - PID 21009 | Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41015/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:53:08 INFO - PID 21009 | RSS: Main: 165711872 06:53:08 INFO - PID 21009 | 06:53:10 INFO - PID 21009 | Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41015/tests/kraken/driver.html?testName=ai-astar) 06:53:10 INFO - PID 21009 | RSS: Main: 166502400 06:53:10 INFO - PID 21009 | 06:53:10 INFO - PID 21009 | __start_tp_report 06:53:10 INFO - PID 21009 | _x_x_mozilla_page_load 06:53:10 INFO - PID 21009 | _x_x_mozilla_page_load_details 06:53:10 INFO - PID 21009 | |i|pagename|runs| 06:53:10 INFO - PID 21009 | |0;ai-astar;102;112;112;111;112;112;111;110;111;113 06:53:10 INFO - PID 21009 | |1;audio-beat-detection;147;128;124;163;122;124;123;124;147;126 06:53:10 INFO - PID 21009 | |2;audio-dft;164;166;164;163;164;166;168;170;163;165 06:53:10 INFO - PID 21009 | |3;audio-fft;76;76;78;122;76;75;75;75;92;75 06:53:10 INFO - PID 21009 | |4;audio-oscillator;84;82;105;82;83;84;98;84;83;102 06:53:10 INFO - PID 21009 | |5;imaging-gaussian-blur;113;115;114;114;114;115;114;113;113;116 06:53:10 INFO - PID 21009 | |6;imaging-darkroom;151;151;149;151;150;149;150;150;152;151 06:53:10 INFO - PID 21009 | |7;imaging-desaturate;95;94;95;95;94;94;95;94;95;95 06:53:10 INFO - PID 21009 | |8;json-parse-financial;55;57;56;55;56;55;57;56;55;57 06:53:10 INFO - PID 21009 | |9;json-stringify-tinderbox;56;56;60;56;56;56;55;57;57;56 06:53:11 INFO - PID 21009 | |10;stanford-crypto-aes;82;81;90;83;85;81;90;82;81;84 06:53:11 INFO - PID 21009 | |11;stanford-crypto-ccm;133;132;135;134;161;144;148;130;184;135 06:53:11 INFO - PID 21009 | |12;stanford-crypto-pbkdf2;188;201;183;207;196;194;195;212;201;191 06:53:11 INFO - PID 21009 | |13;stanford-crypto-sha256-iterative;75;75;84;74;79;77;78;76;73;73 06:53:11 INFO - PID 21009 | __end_tp_report 06:53:11 INFO - PID 21009 | __start_cc_report 06:53:11 INFO - PID 21009 | _x_x_mozilla_cycle_collect,766 06:53:11 INFO - PID 21009 | __end_cc_report 06:53:11 INFO - PID 21009 | __startTimestamp1494942790993__endTimestamp 06:53:11 INFO - PID 21009 | 06:53:11 INFO - PID 21009 | ------- Summary: start ------- 06:53:11 INFO - PID 21009 | Number of tests: 14 06:53:11 INFO - PID 21009 | 06:53:11 INFO - PID 21009 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:3.13 (2.8%) stddev-sans-first:0.88 06:53:11 INFO - PID 21009 | Values: 102.0 112.0 112.0 111.0 112.0 112.0 111.0 110.0 111.0 113.0 06:53:11 INFO - PID 21009 | 06:53:11 INFO - PID 21009 | [#1] audio-beat-detection Cycles:10 Average:132.80 Median:127.00 stddev:14.26 (11.2%) stddev-sans-first:14.17 06:53:11 INFO - PID 21009 | Values: 147.0 128.0 124.0 163.0 122.0 124.0 123.0 124.0 147.0 126.0 06:53:11 INFO - PID 21009 | 06:53:11 INFO - PID 21009 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.50 stddev:2.26 (1.4%) stddev-sans-first:2.35 06:53:11 INFO - PID 21009 | Values: 164.0 166.0 164.0 163.0 164.0 166.0 168.0 170.0 163.0 165.0 06:53:11 INFO - PID 21009 | 06:53:11 INFO - PID 21009 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:14.98 (19.7%) stddev-sans-first:15.73 06:53:11 INFO - PID 21009 | Values: 76.0 76.0 78.0 122.0 76.0 75.0 75.0 75.0 92.0 75.0 06:53:11 INFO - PID 21009 | 06:53:11 INFO - PID 21009 | [#4] audio-oscillator Cycles:10 Average:88.70 Median:83.50 stddev:9.13 (10.9%) stddev-sans-first:9.52 06:53:11 INFO - PID 21009 | Values: 84.0 82.0 105.0 82.0 83.0 84.0 98.0 84.0 83.0 102.0 06:53:11 INFO - PID 21009 | 06:53:11 INFO - PID 21009 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.99 (0.9%) stddev-sans-first:0.97 06:53:11 INFO - PID 21009 | Values: 113.0 115.0 114.0 114.0 114.0 115.0 114.0 113.0 113.0 116.0 06:53:11 INFO - PID 21009 | 06:53:11 INFO - PID 21009 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:151.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 06:53:11 INFO - PID 21009 | Values: 151.0 151.0 149.0 151.0 150.0 149.0 150.0 150.0 152.0 151.0 06:53:11 INFO - PID 21009 | 06:53:11 INFO - PID 21009 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:53:11 INFO - PID 21009 | Values: 95.0 94.0 95.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 06:53:11 INFO - PID 21009 | 06:53:11 INFO - PID 21009 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:0.88 (1.6%) stddev-sans-first:0.87 06:53:11 INFO - PID 21009 | Values: 55.0 57.0 56.0 55.0 56.0 55.0 57.0 56.0 55.0 57.0 06:53:11 INFO - PID 21009 | 06:53:11 INFO - PID 21009 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:56.00 stddev:1.35 (2.4%) stddev-sans-first:1.42 06:53:11 INFO - PID 21009 | Values: 56.0 56.0 60.0 56.0 56.0 56.0 55.0 57.0 57.0 56.0 06:53:11 INFO - PID 21009 | 06:53:11 INFO - PID 21009 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.50 stddev:3.48 (4.2%) stddev-sans-first:3.62 06:53:11 INFO - PID 21009 | Values: 82.0 81.0 90.0 83.0 85.0 81.0 90.0 82.0 81.0 84.0 06:53:11 INFO - PID 21009 | 06:53:11 INFO - PID 21009 | [#11] stanford-crypto-ccm Cycles:10 Average:143.60 Median:139.50 stddev:17.08 (12.2%) stddev-sans-first:17.68 06:53:11 INFO - PID 21009 | Values: 133.0 132.0 135.0 134.0 161.0 144.0 148.0 130.0 184.0 135.0 06:53:11 INFO - PID 21009 | 06:53:11 INFO - PID 21009 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.80 Median:198.50 stddev:8.72 (4.4%) stddev-sans-first:8.64 06:53:11 INFO - PID 21009 | Values: 188.0 201.0 183.0 207.0 196.0 194.0 195.0 212.0 201.0 191.0 06:53:11 INFO - PID 21009 | 06:53:11 INFO - PID 21009 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.40 Median:76.50 stddev:3.34 (4.4%) stddev-sans-first:3.50 06:53:11 INFO - PID 21009 | Values: 75.0 75.0 84.0 74.0 79.0 77.0 78.0 76.0 73.0 73.0 06:53:11 INFO - PID 21009 | -------- Summary: end -------- 06:53:11 INFO - PID 21009 | 06:53:12 INFO - TEST-INFO | 21009: exit 0 06:53:12 INFO - TEST-OK | kraken | took 62903ms 06:53:12 INFO - SUITE-END | took 1182s 06:53:12 INFO - Completed test suite (00:19:42) 06:53:12 INFO - javascript benchmark 06:53:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6717.669988871929, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2718.891244350226, 2734.6855111662167, 2753.752162305392, 2761.696213416525, 2767.0177087134066, 5221.164613661815, 5285.6300058995885, 5293.788248470057, 5295.549878260343, 5319.202119682045, 5281.815136470224, 5295.655782374143, 5341.145416733333, 5357.866053348668, 5390.51485366317, 4661.394018777554, 4685.2269375553, 4715.669903106784, 4731.5268473152755, 4775.92836107457, 4636.675432719711, 4746.857594272177, 4773.641976851733, 4798.664093513456, 4837.080954618629, 4637.814487420499, 4729.527047295277, 4774.904501909977, 4784.688995215317, 4787.61699064074, 4615.26155815068, 4669.743164125972, 4688.624910007191, 4705.129551033036, 4706.858794236178, 4609.631229501631, 4676.041411510632, 4677.859664210079, 4684.976575117103, 4726.172919739066, 5252.606054545924, 5253.0, 5254.395744489394, 5316.142176592191, 5335.1197052486295, 5637.887242255173, 5694.402087780806, 5719.914201286984, 5728.312602487728, 5732.340780810218, 5760.049591817345, 5785.190073389729, 5787.652740835563, 5792.623479473863, 5795.1017592273265, 5309.283246761715, 5347.0375332440535, 5351.063563876306, 5368.812091576776, 5370.731463426813, 5869.589128760946, 5897.705114744245, 5920.289565252111, 5920.615160014671, 5922.526197904157, 5613.943860561342, 5622.57830662702, 5627.212190293362, 5648.350439699405, 5658.830235092953, 5756.827295181151, 5759.395263497357, 5768.278965129359, 5778.191053252548, 5778.3354914184565, 5612.691301978349, 5641.2384328116, 5646.915296270559, 5669.659820410789, 5704.743286552115, 5696.914546281809, 5698.088305871041, 5718.1136923776885, 5721.5136713379825, 5729.684867332337, 4768.451628062748, 4776.21192503233, 4825.348577942003, 4835.564799168092, 4868.196747536687, 4123.752574845519, 4140.420341152241, 4183.49798024239, 4209.095044565433, 4228.809703563347, 4857.392825896763, 4890.095332363524, 4905.3132561441425, 4905.9754701226975, 4948.851534453972, 5671.0, 5771.913421298684, 5774.364819869811, 5792.4497172768515, 5840.649561026352, 4853.805847766121, 4889.266610008527, 4904.583110435653, 4908.01839632075, 4944.456109827916, 5143.537081662594, 5168.715720635401, 5177.818776342885, 5178.093833579109, 5178.508041736029, 5434.701091439851, 5447.155690867922, 5454.618176727591, 5469.3983661797965, 5476.014317422902, 5730.684812335361, 5760.193572899713, 5823.4467725566, 5842.474177324061, 5880.117982302518, 5328.467153284795, 5412.323459567554, 5412.891742165213, 5420.024395608828, 5422.6475279106735, 5578.86052848682, 5649.37856835756, 5668.093105103164, 5711.742971566373, 5746.511546518593, 5776.364599893925, 5794.1308803679785, 5825.76696932118, 5836.737346819488, 5887.20522729426, 5553.694546799965, 5581.162825576033, 5618.269624948731, 5620.606557540933, 5632.239647647679, 5489.862753431196, 5545.3622833374675, 5547.44525547442, 5612.410696876769, 5634.183043458757, 5502.394736579053, 5504.752286147213, 5536.584756143386, 5537.335519737496, 5539.806106786405, 5651.57613179005, 5661.0, 5664.065429204135, 5680.9147862781265, 5737.368889422244, 5432.429594892479, 5482.42434544383, 5482.616216864782, 5486.807961721321, 5490.3411590609385], "value": 5210.41848232572, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [677.0352248046534, 998.9650362237321, 1015.1777060580926, 1018.3533456255285, 1022.8363461846106, 29635.703642963563, 33186.17034574134, 33324.833375833114, 33378.666213337856, 33599.16002099949, 34584.1353966151, 34830.12924676884, 34833.95498135054, 34866.302673946506, 34908.0, 6786.864262714743, 6846.34959678831, 6999.160100787913, 7007.649617519103, 7027.297270272983, 6933.098697169361, 7034.753783617574, 7043.225245223021, 7046.577205367695, 7050.788476345692, 6993.055937448456, 7022.19244786851, 7042.718291268343, 7046.0, 7050.894236586455, 6971.825704357381, 7012.929870701279, 7031.015657807911, 7032.15614126303, 7057.117860267466, 6877.140357455318, 6907.896381554281, 6955.791326260221, 6960.129983752031, 6969.825754356181, 30278.394432111454, 30427.543586846215, 30501.847490762404, 30679.0, 30905.0, 2869.139258222525, 2882.3082460209607, 2891.08930686833, 2901.970980290191, 2906.1281615515472, 23743.525129497313, 23931.88034059836, 23980.520389592286, 23987.520249595083, 24020.15929442461, 3053.755699544053, 3065.524843649238, 3079.8306093164865, 3137.62348518177, 3178.777485576011, 131845.0, 132257.3387133068, 132487.33756331156, 132567.0, 132788.0, 36222.275554489286, 38086.428703569465, 38125.23749524994, 38299.23401531954, 38658.22683546313, 39940.20119597592, 40141.397879031836, 40209.39685904714, 40239.79880100639, 40300.39549406761, 12127.514899404101, 12196.14626976121, 12223.69440763988, 12258.754824903452, 12280.938595306967, 9647.179989700953, 9683.612655493702, 9684.806303874024, 9688.0, 9706.272029597667, 11999.520019199133, 12226.144169908199, 12247.387630618434, 12265.754684906253, 12407.565735199225, 5307.319803499208, 5320.813771517978, 5324.467553244722, 5331.306930099062, 5353.116735738559, 869.8869147010848, 906.2523418180028, 914.4056363363867, 920.1028996728137, 944.9952750236205, 20080.196792128445, 20389.0, 20789.272375466786, 20837.0, 21252.25617103394, 979.1139019187647, 986.5363279258737, 986.9161121304626, 989.5003023473244, 1001.9649312274036, 10788.838167427495, 10892.564297428173, 10990.120790336754, 11132.554697812158, 11242.775144497227, 181805.0, 182368.0, 182390.0, 182399.0, 183133.0, 39318.0, 39634.207315854095, 39701.60298397037, 39754.80122599369, 39764.0, 1207.571312184162, 1253.3482589053824, 1253.5800506830315, 1254.3289340202948, 1255.12768625806, 19348.226070957568, 19468.61062778765, 20024.59950801005, 20297.0, 20574.897125514275, 28561.714382856735, 28668.42663146767, 28685.28286792847, 28728.71271287344, 28763.137105886857, 150921.2453937767, 150971.2451437736, 151274.0, 151353.0, 151804.0, 27880.860595697704, 27882.26001579777, 28146.71853281523, 29216.123516294545, 29761.851190743906, 33815.0, 34265.31469370649, 34467.13832154116, 34516.0, 34865.82567087148, 26300.736992629827, 26912.865435672695, 27053.1884043479, 27358.0, 27867.606619669343, 26231.73768262293, 26247.081352153346, 27045.86477067602, 27414.862925685244, 27850.44299114047, 29640.40719185561, 29683.109506714834, 29806.956756514286, 29873.0, 29891.850540747157, 24627.0, 25786.226413207634, 26445.33886652849, 26497.94008239649, 26550.468990620466, 19988.600227995066, 21633.0, 21729.565408692055, 21934.0, 22205.88897055569], "value": 14254.967535947262, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.01299349078477, 409.6517959734225, 415.2152431903701, 419.5259356926673, 429.26381256145703, 16462.83537164628, 17219.311227550897, 17238.569035774097, 18909.24363025481, 19530.414087577396, 18557.0, 18588.62822743544, 18629.254829806792, 18731.719024214646, 19012.904935475304, 5454.290942177511, 5497.5601951843855, 5552.7223638817895, 5584.469475399851, 5597.608167428281, 5542.418046105161, 5573.721313934308, 5590.776368945238, 5596.244506991565, 5620.662760234379, 5357.0, 5558.833235002957, 5601.103823388259, 5622.269105016342, 5630.324361076677, 5363.651362661414, 5524.8342549723575, 5536.169574563827, 5536.280283563151, 5591.049521581321, 4897.853064408037, 5074.82238121664, 5076.18780995039, 5076.898462030776, 5078.4159821620615, 21661.241856535104, 21704.891475542678, 22153.113875444964, 22377.664335034988, 22535.098596056137, 1631.8531332180162, 1655.470249520154, 1662.0443245133974, 1668.4243935842114, 1668.9499315020569, 14902.1803800792, 15092.0, 15200.46798362063, 15383.846161538353, 15617.141057241846, 2079.365793433002, 2112.2184791627196, 2129.8083172514393, 2146.0, 2161.8810965396897, 92049.0, 94187.87778794425, 94208.0, 95505.0, 95593.52203239009, 11092.279001864854, 11191.888081119085, 11297.943510282395, 11406.771864562663, 11420.42897855104, 15679.764803527729, 15710.450134245246, 15737.842621573638, 15741.921290393475, 15802.525924222291, 7338.522996005243, 7580.620968951531, 7722.884156737653, 7730.92269077302, 7794.6882124714375, 6808.9659551701925, 6901.447884169254, 6914.619695916773, 7090.326418990187, 7109.964450177819, 7067.0, 7077.292270772881, 7116.359527642434, 7195.784126476109, 7278.890816637755, 2108.5255817440952, 2137.041387135939, 2144.4853235223436, 2156.2668692644575, 2284.920027799019, 845.4842546046906, 876.202655583416, 876.9649214031367, 877.0790669796688, 899.2131884600974, 16843.494695159166, 16890.155492225338, 17391.130443477774, 17402.82597174012, 17996.730049049274, 865.6926790989108, 872.7163671806688, 880.2297989259398, 881.9294456443597, 895.0, 9221.677241296522, 11088.722781930355, 12219.26684398939, 12258.570950016885, 12259.57091501811, 359704.0, 373207.0, 374501.0, 376230.0, 376893.0, 67725.3227467719, 77721.0, 77932.0, 81636.0, 81806.18193818105, 1025.9281850270409, 1073.7637719701654, 1101.4602844606245, 1115.9107271418268, 1126.2566705974182, 17292.827071729625, 17364.0, 17875.910620446815, 18340.266389344277, 18650.81349186545, 38164.809175953946, 39026.0, 39263.2147357057, 39594.0, 39689.20621587495, 48902.26646600375, 49493.0, 49504.75247623739, 49805.50194498154, 50156.74921625369, 7930.405219608668, 8166.101728809707, 8173.5504547250475, 8303.792405189919, 8324.625391857502, 12175.512979481076, 12478.688032799253, 12662.240265584094, 12706.491740330282, 12891.290978996245, 10513.737156571147, 10728.678139655824, 10737.731556711145, 10859.511321990687, 10933.234673573092, 9747.220222382335, 10052.0, 10059.748506287402, 10093.142082923034, 10208.336458130198, 10086.546105425421, 10549.841752373566, 10840.5121769519, 10922.672319830417, 11037.11703063737, 8061.798455038671, 8067.878981815395, 8109.148539403278, 8402.747917562483, 8494.57527123629, 10217.846732299171, 10246.590136394461, 10289.897101028893, 10375.533101010322, 10477.580896764044], "value": 8946.557866540843, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1230.2741382584277, 1302.6873550347916, 1311.2919023727188, 1311.986880131199, 1314.093275639809, 10024.147947424468, 10526.631567895125, 10551.841722374162, 10630.255882088257, 10913.181511386658, 10600.310979786309, 10712.732181695443, 10784.78430431391, 10793.892061079387, 10808.891911080887, 2294.781995710409, 2335.92992210234, 2344.824138189634, 2346.8826558672, 2348.3894187511287, 2176.2927048709234, 2272.5114100468395, 2277.3851060213733, 2282.9726623019624, 2295.4031951692596, 2231.040652519416, 2238.3620668109593, 2283.691701620285, 2284.2918695204457, 2287.8512896661746, 2223.3885681437655, 2232.9888350558304, 2263.739669937962, 2269.7843704848015, 2280.486890449652, 2141.8179454746364, 2236.731592208929, 2244.2033078257145, 2270.5685919675207, 2300.2639155470256, 10307.89692103077, 10455.215858810543, 10460.843087353696, 10505.212109091772, 10539.262251642389, 5723.742431590588, 5927.407259274081, 5942.910856337158, 5954.940450595525, 5968.820935371946, 3254.4792833146585, 3529.294141171776, 3537.0980399998093, 3565.625609311011, 3585.515955346047, 1090.939998300093, 1116.2019156303281, 1133.3539882267112, 1149.9942500287445, 1162.9360385178811, 15175.468858589897, 15414.691706165926, 15526.301316440788, 15544.145072021034, 15574.14342211178, 5054.191329387354, 5279.762410691528, 5451.563874889999, 5458.699771512605, 5477.643953143033, 12738.172018818746, 12762.447510497752, 12867.742645147044, 12880.291583962784, 12891.228385897077, 5881.41185881417, 5886.676232807236, 5900.262467191601, 5904.0553511437965, 5919.289685237799, 5082.2122571001555, 5095.974520127375, 5293.788248470095, 5294.788208471695, 5347.839564813062, 4246.936295955563, 4288.764117973541, 4313.4823821141035, 4347.5217726050105, 4373.6282415994365, 1323.4970711129708, 1368.3295185359102, 1376.5250988409184, 1383.4051357915992, 1387.0429403711407, 735.5880706804206, 739.9223081576465, 742.1131747561612, 755.2975732568653, 759.6809340077181, 5659.915101273484, 5752.194692743019, 5860.677662728591, 5904.439078287642, 5967.1347654589845, 850.9446885952393, 854.4702284583598, 854.8974123105143, 869.1221865915345, 875.2123089219626, 4001.959980400217, 4130.359794231899, 4168.520620128664, 4352.0, 4519.209138400833, 13164.078514504085, 13234.536791212262, 13399.196048237138, 13442.126261792951, 13483.19100853952, 12896.29070401137, 13175.736485270241, 13215.141015834133, 13418.664533386744, 13437.395317210749, 7675.462717609826, 7760.0, 7872.921270787218, 7910.683572657029, 7938.9206107939335, 6188.876222475616, 6358.586691865014, 6370.713317900798, 6531.412172904462, 6657.667116644246, 11610.94194529022, 11635.592754253561, 11751.118666099906, 11844.28934263947, 11945.343006134746, 11926.701832453911, 12047.879521204675, 12265.570705025639, 12324.274601555968, 12504.436945381827, 8430.199131082538, 8508.064112947446, 8546.145385461405, 8561.48631082137, 8566.314694824523, 9367.718968430958, 9576.712698619052, 9579.664711735057, 9580.76048098803, 9581.233501319739, 7669.578173200527, 8378.790530236793, 8547.658093676184, 8576.099509551408, 8577.95711021441, 8378.664853405795, 8394.0, 8434.451760635538, 8435.283000944988, 8452.1547845215, 7436.96281518589, 7534.434917381109, 7565.962170189114, 7628.084629844454, 7645.961770191114, 5441.183822426509, 5462.644928079662, 5528.032594295902, 5558.638688485235, 5602.215689803512, 5564.610477266552, 5630.690312032878, 5645.802396916089, 5720.942790572041, 5800.50695690871], "value": 4965.890713750313, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.07148805872635, 361.94932709420675, 364.1351789499939, 364.6863697220388, 368.116520351157, 5537.252470916425, 5572.944270557288, 5590.385057643656, 5592.888142237153, 5603.551715862732, 5388.218708287296, 5460.34475862896, 5468.72656367181, 5487.807926722566, 5489.890202195954, 4157.771322577257, 4191.622753952143, 4193.287141185998, 4200.789960501978, 4221.936670949923, 4168.874933751978, 4186.476690413699, 4189.141226048653, 4189.183109293689, 4199.664026877857, 4192.4549808525, 4194.727342722728, 4195.265828480019, 4199.55904630014, 4212.283911735012, 3860.4595356650093, 4017.4576432181575, 4021.296273152216, 4034.2567054402994, 4206.894827629303, 3454.7063499602564, 3464.4630082337276, 3464.7055000325004, 3480.7911525308564, 3483.425234836249, 5283.682979021232, 5293.57651387888, 5330.520253177194, 5331.386890507602, 5338.759755810997, 4576.1762882681105, 4659.767011649404, 4728.219843725781, 4746.121967436001, 4756.239001759736, 5703.686297253649, 5721.34204566476, 5734.4265573442735, 5742.799002034909, 5754.539636829086, 3904.7071469639604, 3912.865269071966, 3919.9808049906947, 3920.3926390180172, 3927.6857851371824, 6006.939930600682, 6083.270007599072, 6090.543209259324, 6136.447719705248, 6147.600405973642, 4009.0779120801794, 4012.578679238696, 4016.3975403689096, 4027.295223335963, 4027.81874815634, 4054.5134583850127, 4058.7564746115327, 4071.898202544901, 4073.877783666495, 4080.7347522410946, 4657.208274593328, 4714.245720684743, 4763.880902977453, 4767.284907263938, 4768.546988036131, 5757.553039958085, 5772.191893134965, 5774.220480235114, 5781.046127389018, 5800.1299805029585, 1382.4677499162894, 1415.8371787244394, 1416.3838730152418, 1419.9148051116965, 1420.6306360346177, 893.660409044559, 920.392540923001, 934.2105920497169, 935.8830146231721, 939.4551160326994, 4976.154053810861, 4984.8753781155765, 5006.723285562159, 5019.899602007939, 5023.447420783711, 5914.556408269311, 5933.643981361132, 5953.493953013955, 5968.37332080134, 5989.431004054608, 4805.1590971579835, 4954.702717836942, 4955.0, 4959.851204463872, 5019.247112933016, 3123.2816452216116, 3125.7030582094662, 3133.887469948181, 3145.1350878508138, 3147.6065491813524, 5481.862953426116, 5536.612437129443, 5568.136938774496, 5585.525230355384, 5589.692566908859, 5957.344692083867, 5963.254593175853, 6084.787032453843, 6105.297890742532, 6113.663748493876, 5580.330360356783, 5595.552355811526, 5609.691466969356, 5618.213450116987, 5619.438056194348, 5915.58590898633, 5958.374370691015, 5975.970120149372, 5982.132590774227, 5995.5803093783015, 5633.915491267716, 5849.444302791228, 5880.735366908585, 5919.260092488439, 5930.614510056833, 5582.134769110794, 5595.468430499096, 5624.381318055092, 5625.509240051471, 5633.887322253614, 3976.622220889011, 4011.7392369495888, 4026.456428382131, 4033.959660403476, 4044.959550404576, 5960.897234011722, 5994.730237139252, 5996.610220335664, 6008.789692360747, 6036.547258955508, 5806.158107074366, 5823.854403639943, 5831.620944638585, 5837.766489340379, 5863.589548731718, 5725.570582206435, 5749.338826035059, 5789.668376273565, 5789.8263052108505, 5846.94153058464, 5678.0, 5711.600187986801, 5712.485876271156, 5718.25662663851, 5736.340320863154, 5582.8325150245555, 5839.649621022752, 5858.978652364927, 5867.765289388377, 5879.441453061952, 5633.718314084197, 5634.295713035871, 5649.604527683023, 5649.71751412436, 5662.462066103713], "value": 4289.987938642141, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.6296018669824, 682.0894106368002, 687.4603436302503, 692.518699503845, 695.5861262548782, 12203.877961220385, 12609.621711348662, 12618.432170552313, 12965.0, 14834.109953402804, 13964.581062568139, 14177.574672759834, 14206.928965355159, 14239.715205695906, 15112.848871511282, 875.4528419737663, 912.32943786317, 912.3841407050247, 912.6258234123977, 912.8950170730351, 819.6844214977217, 900.545224661545, 900.8963969143567, 908.404994728454, 909.3452714045876, 938.4181807279497, 939.8496240601505, 940.2524992630875, 941.8540126280437, 942.7218970403748, 937.7186843946823, 938.6949241496541, 943.1370296179023, 945.6737425588161, 947.5925352098595, 689.9965500172467, 690.7237105157977, 696.1889398850333, 697.3201128899333, 697.769735987123, 12228.449719762632, 12318.445669944875, 12441.066919981038, 12458.636168234525, 13198.67003324915, 15609.531714048597, 15793.921030394775, 16053.0, 16127.274272657758, 16194.433194838242, 11387.487563059682, 11543.769124617545, 11584.42077896102, 11628.302301861915, 11639.825402618968, 2944.6613639431525, 2992.326726486523, 3002.459557279689, 3010.5785190073407, 3011.744001759853, 71630.64184679095, 72707.27292727058, 72769.0, 73851.63074184595, 74711.62644186744, 12288.815667764991, 12431.502739890304, 12455.377231138407, 12498.500059997497, 12547.0, 20328.69506957397, 21415.143394264054, 21583.67624485634, 21738.13047478083, 22742.0, 6196.132541444202, 6394.712237949303, 6454.419102280817, 6522.543421960512, 6733.663316834237, 3082.7533797296164, 3149.401613693391, 3157.0, 3165.398574270881, 3168.524721291825, 3434.4333185024193, 3496.2483066140903, 3503.4044212483427, 3507.2989600043957, 3518.3139287838626, 730.6675462664475, 738.1142628845299, 745.273358475493, 745.7725393754848, 748.6406524868094, 556.3740791609439, 593.9049752039653, 623.3236937922405, 623.7099748616824, 633.9968300158562, 8868.911310886808, 9252.814943701089, 9654.131128198496, 9859.161971232383, 10087.49562521871, 550.4907960136858, 566.5014786987425, 567.3333832746506, 567.8012695556605, 569.0525275416468, 4303.698741088157, 4527.071950250257, 4556.703814252063, 4571.839985600554, 4676.3453116563705, 63197.0, 63322.366776332565, 64050.35949640537, 64537.35462645407, 65223.0, 56950.0, 57600.13599796007, 58055.70972145112, 58065.709671451375, 58118.41881581215, 50128.248076278884, 51979.480205198975, 52086.73956630193, 52656.21015684768, 52985.735071324394, 8262.091169971418, 8268.917310827055, 8486.830263394573, 8609.65561377538, 8824.5587720615, 25788.871055644602, 26097.217083487525, 26102.86948565245, 26354.0, 26513.86743066272, 31445.842770786, 31931.201719957186, 31931.36137277288, 32425.837870810494, 32606.51090233601, 11515.30908145514, 11670.824937626112, 11726.70683232926, 11742.823857641972, 11861.406929653655, 12700.491980320683, 12758.808617870925, 12856.614301570968, 12992.220466772023, 13047.608571742863, 10764.838527421938, 10884.836727449254, 10973.341599504056, 11036.834447483454, 11099.833502497308, 11940.940295298467, 11963.521459141537, 12019.819702704292, 12131.757364852478, 12241.387930603612, 11291.209615326849, 11363.886361136283, 11395.259308145276, 11551.191416601094, 11709.531618735155, 8689.913760779902, 8854.645814167361, 8861.689840855539, 9035.50304733246, 9114.726558203265, 9075.500847453453, 9227.35408521397, 9304.906950930404, 9311.115444032806, 9564.995675454256], "value": 6491.333157494725, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 112.0, 111.0, 112.0, 112.0, 111.0, 110.0, 111.0, 113.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 128.0, 124.0, 163.0, 122.0, 124.0, 123.0, 124.0, 147.0, 126.0], "value": 132.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 164.0, 163.0, 164.0, 166.0, 168.0, 170.0, 163.0, 165.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 122.0, 76.0, 75.0, 75.0, 75.0, 92.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 105.0, 82.0, 83.0, 84.0, 98.0, 84.0, 83.0, 102.0], "value": 88.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0, 113.0, 113.0, 116.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 149.0, 151.0, 150.0, 149.0, 150.0, 150.0, 152.0, 151.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 56.0, 55.0, 56.0, 55.0, 57.0, 56.0, 55.0, 57.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 60.0, 56.0, 56.0, 56.0, 55.0, 57.0, 57.0, 56.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 90.0, 83.0, 85.0, 81.0, 90.0, 82.0, 81.0, 84.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 132.0, 135.0, 134.0, 161.0, 144.0, 148.0, 130.0, 184.0, 135.0], "value": 143.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 201.0, 183.0, 207.0, 196.0, 194.0, 195.0, 212.0, 201.0, 191.0], "value": 196.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 84.0, 74.0, 79.0, 77.0, 78.0, 76.0, 73.0, 73.0], "value": 76.4, "unit": "score"}]}]} 06:53:12 INFO - Return code: 0 06:53:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:53:12 INFO - # TBPL SUCCESS # 06:53:12 INFO - Running post-action listener: _resource_record_post_action 06:53:12 INFO - [mozharness: 2017-05-16 13:53:12.323824Z] Finished run-tests step (success) 06:53:12 INFO - Running post-run listener: _resource_record_post_run 06:53:12 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 385826816; Read time: 440; Write time: 528700 06:53:12 INFO - TinderboxPrint: CPU usage
13.3% 06:53:12 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 440 06:53:12 INFO - TinderboxPrint: I/O write bytes / time
385,826,816 / 528,700 06:53:12 INFO - TinderboxPrint: CPU idle
8,296.4 (86.7%) 06:53:12 INFO - TinderboxPrint: CPU user
1,214.1 (12.7%) 06:53:12 INFO - TinderboxPrint: Swap in / out
0 / 0 06:53:12 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 92000256; Read time: 0; Write time: 135340 06:53:12 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 278966272; Read time: 356; Write time: 294440 06:53:12 INFO - Running post-run listener: _upload_blobber_files 06:53:12 INFO - Blob upload gear active. 06:53:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:53:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:53:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:53:13 INFO - (blobuploader) - INFO - Open directory for files ... 06:53:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:53:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:53:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:53:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:53:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:53:14 INFO - (blobuploader) - INFO - Done attempting. 06:53:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:53:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:53:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:53:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:53:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:53:17 INFO - (blobuploader) - INFO - Done attempting. 06:53:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:53:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:53:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:53:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:53:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:53:18 INFO - (blobuploader) - INFO - Done attempting. 06:53:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:53:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:53:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:53:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:53:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:53:19 INFO - (blobuploader) - INFO - Done attempting. 06:53:19 INFO - (blobuploader) - INFO - Iteration through files over. 06:53:19 INFO - Return code: 0 06:53:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:53:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:53:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bbc0f60883ee90de1f9ec868e217f9457ff1733d05c529260342f2a81c96951184b5466cbba5d8a66a61d246c4445c0237f96cce978008ce87deafaee71a6af7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e2b3c3dfef548b53eb1ee966164d7e364564f3686a9a2dcfd5caf4c288e7679a30d7dccd2a882635a798b270a3367cd4a8e3db8117301ceb7f492f15fd45a4a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94e0fd3d2e4157269b034ea5e1c2e717b23c00da71f83f29829bd4edb6728d271287a997f279778add9c26b68385ff11db1dd9f201822b1cad14f809a5a24e16", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/27c122c34190df03e7e29d7f29631bdf5622802d4c64e236dd5a3a4ff6e4c1c5ba66afe6d4fba3931cd7edd69ea6eba33fbc8802830635bbbb1420428c417978"} 06:53:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:53:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:53:19 INFO - Contents: 06:53:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bbc0f60883ee90de1f9ec868e217f9457ff1733d05c529260342f2a81c96951184b5466cbba5d8a66a61d246c4445c0237f96cce978008ce87deafaee71a6af7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e2b3c3dfef548b53eb1ee966164d7e364564f3686a9a2dcfd5caf4c288e7679a30d7dccd2a882635a798b270a3367cd4a8e3db8117301ceb7f492f15fd45a4a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94e0fd3d2e4157269b034ea5e1c2e717b23c00da71f83f29829bd4edb6728d271287a997f279778add9c26b68385ff11db1dd9f201822b1cad14f809a5a24e16", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/27c122c34190df03e7e29d7f29631bdf5622802d4c64e236dd5a3a4ff6e4c1c5ba66afe6d4fba3931cd7edd69ea6eba33fbc8802830635bbbb1420428c417978"} 06:53:19 INFO - Running post-run listener: copy_logs_to_upload_dir 06:53:19 INFO - Copying logs to upload dir... 06:53:19 INFO - mkdir: /builds/slave/test/build/upload/logs 06:53:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.148764 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-05-16 06:53:19.368934) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-16 06:53:19.376306) ========= 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=8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bbc0f60883ee90de1f9ec868e217f9457ff1733d05c529260342f2a81c96951184b5466cbba5d8a66a61d246c4445c0237f96cce978008ce87deafaee71a6af7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e2b3c3dfef548b53eb1ee966164d7e364564f3686a9a2dcfd5caf4c288e7679a30d7dccd2a882635a798b270a3367cd4a8e3db8117301ceb7f492f15fd45a4a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94e0fd3d2e4157269b034ea5e1c2e717b23c00da71f83f29829bd4edb6728d271287a997f279778add9c26b68385ff11db1dd9f201822b1cad14f809a5a24e16", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/27c122c34190df03e7e29d7f29631bdf5622802d4c64e236dd5a3a4ff6e4c1c5ba66afe6d4fba3931cd7edd69ea6eba33fbc8802830635bbbb1420428c417978"} build_url:https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011372 build_url: 'https://queue.taskcluster.net/v1/task/SkBauyfUTziQX679CCyemw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bbc0f60883ee90de1f9ec868e217f9457ff1733d05c529260342f2a81c96951184b5466cbba5d8a66a61d246c4445c0237f96cce978008ce87deafaee71a6af7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e2b3c3dfef548b53eb1ee966164d7e364564f3686a9a2dcfd5caf4c288e7679a30d7dccd2a882635a798b270a3367cd4a8e3db8117301ceb7f492f15fd45a4a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94e0fd3d2e4157269b034ea5e1c2e717b23c00da71f83f29829bd4edb6728d271287a997f279778add9c26b68385ff11db1dd9f201822b1cad14f809a5a24e16", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/27c122c34190df03e7e29d7f29631bdf5622802d4c64e236dd5a3a4ff6e4c1c5ba66afe6d4fba3931cd7edd69ea6eba33fbc8802830635bbbb1420428c417978"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-16 06:53:19.405034) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 06:53:19.405402) ========= 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=8783db0840cc980e80bb0bd400000236-1494935798.522380-480860740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 06:53:19.485635) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-16 06:53:19.485961) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-16 06:53:19.486259) ========= ========= Total master_lag: 0.28 =========