builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-038 starttime: 1495301121.72 results: success (0) revision: 5b74bbf20e803e299790d266fc6ebf5d53b7a1b7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-20 10:25:21.721221) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-20 10:25:21.721672) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-20 10:25:21.721988) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-20 10:25:21.810906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-20 10:25:21.811234) ========= 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-1495283956.76804-937299759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-20 10:25: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% 458K=0.03s 2017-05-20 10:25:22 (458 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.156634 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-20 10:25:22.010221) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-20 10:25:22.010565) ========= 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-1495283956.76804-937299759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015472 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-20 10:25:22.085793) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-20 10:25:22.086129) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5b74bbf20e803e299790d266fc6ebf5d53b7a1b7 --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 5b74bbf20e803e299790d266fc6ebf5d53b7a1b7 --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-1495283956.76804-937299759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-20 10:25:22,419 truncating revision to first 12 chars 2017-05-20 10:25:22,419 Setting DEBUG logging. 2017-05-20 10:25:22,419 attempt 1/10 2017-05-20 10:25:22,419 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5b74bbf20e80?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-20 10:25:23,551 unpacking tar archive at: mozilla-central-5b74bbf20e80/testing/mozharness/ program finished with exit code 0 elapsedTime=1.503407 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-20 10:25:23.610188) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-20 10:25:23.610507) ========= script_repo_revision: 5b74bbf20e803e299790d266fc6ebf5d53b7a1b7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-20 10:25:23.610907) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-20 10:25:23.611211) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-20 10:25:23.624125) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-05-20 10:25:23.624528) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1495283956.76804-937299759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:25:24 INFO - MultiFileLogger online at 20170520 10:25:24 in /builds/slave/test 10:25:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:25:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:25:24 INFO - {'append_to_log': False, 10:25:24 INFO - 'base_work_dir': '/builds/slave/test', 10:25:24 INFO - 'blob_upload_branch': 'Firefox', 10:25:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:25:24 INFO - 'branch': 'Firefox', 10:25:24 INFO - 'buildbot_json_path': 'buildprops.json', 10:25:24 INFO - 'config_files': ('talos/linux_config.py',), 10:25:24 INFO - 'default_actions': ('clobber', 10:25:24 INFO - 'read-buildbot-config', 10:25:24 INFO - 'download-and-extract', 10:25:24 INFO - 'populate-webroot', 10:25:24 INFO - 'create-virtualenv', 10:25:24 INFO - 'install', 10:25:24 INFO - 'run-tests'), 10:25:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:25:24 INFO - 'download_minidump_stackwalk': True, 10:25:24 INFO - 'download_symbols': 'ondemand', 10:25:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:25:24 INFO - 'tooltool.py': '/tools/tooltool.py', 10:25:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:25:24 INFO - '/tools/misc-python/virtualenv.py')}, 10:25:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:25:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:25:24 INFO - 'gecko_profile': False, 10:25:24 INFO - 'gecko_profile_interval': 0, 10:25:24 INFO - 'installer_path': 'installer.exe', 10:25:24 INFO - 'log_level': 'info', 10:25:24 INFO - 'log_name': 'talos', 10:25:24 INFO - 'log_to_console': True, 10:25:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:25:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:25:24 INFO - 'opt_config_files': (), 10:25:24 INFO - 'pip_index': False, 10:25:24 INFO - 'suite': 'dromaeojs-e10s', 10:25:24 INFO - 'system_bits': '32', 10:25:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:25:24 INFO - 'title': 'talos-linux64-ix-038', 10:25:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:25:24 INFO - 'use_talos_json': True, 10:25:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:25:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:25:24 INFO - 'work_dir': 'build'} 10:25:24 INFO - [mozharness: 2017-05-20 17:25:24.130391Z] Running clobber step. 10:25:24 INFO - Running pre-action listener: _resource_record_pre_action 10:25:24 INFO - Running main action method: clobber 10:25:24 INFO - rmtree: /builds/slave/test/build 10:25:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:25:25 INFO - Running post-action listener: _resource_record_post_action 10:25:25 INFO - [mozharness: 2017-05-20 17:25:25.117971Z] Finished clobber step (success) 10:25:25 INFO - [mozharness: 2017-05-20 17:25:25.118072Z] Running read-buildbot-config step. 10:25:25 INFO - Running pre-action listener: _resource_record_pre_action 10:25:25 INFO - Running main action method: read_buildbot_config 10:25:25 INFO - Using buildbot properties: 10:25:25 INFO - { 10:25:25 INFO - "project": "", 10:25:25 INFO - "product": "firefox", 10:25:25 INFO - "who": "archaeopteryx@coole-files.de", 10:25:25 INFO - "installer_path": "public/build/target.tar.bz2", 10:25:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 10:25:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 10:25:25 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 10:25:25 INFO - "stage_platform": "linux64-stylosequential", 10:25:25 INFO - "basedir": "/builds/slave/test", 10:25:25 INFO - "buildnumber": 9, 10:25:25 INFO - "platform": "ubuntu64_hw_styloseq", 10:25:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:25:25 INFO - "slavebuilddir": "test", 10:25:25 INFO - "taskId": "NOklEN8FRE-ktB4D0TY7zg", 10:25:25 INFO - "branch": "mozilla-central", 10:25:25 INFO - "script_repo_revision": "production", 10:25:25 INFO - "revision": "5b74bbf20e803e299790d266fc6ebf5d53b7a1b7", 10:25:25 INFO - "slavename": "talos-linux64-ix-038", 10:25:25 INFO - "repo_path": "mozilla-central" 10:25:25 INFO - } 10:25:25 INFO - Finding installer, test and symbols from parent task. 10:25:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NOklEN8FRE-ktB4D0TY7zg'}, attempt #1 10:25:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NOklEN8FRE-ktB4D0TY7zg'}, attempt #1 10:25:26 INFO - Task dependencies: IvqqVyhhTFWiOBRJzdlIiw 10:25:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw'}, attempt #1 10:25:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/artifacts/public/build/target.tar.bz2 10:25:26 INFO - Set test_url: https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/artifacts/public/build/test_packages.json 10:25:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/artifacts/public/build/target.crashreporter-symbols.zip 10:25:26 INFO - Running post-action listener: _resource_record_post_action 10:25:26 INFO - [mozharness: 2017-05-20 17:25:26.471534Z] Finished read-buildbot-config step (success) 10:25:26 INFO - [mozharness: 2017-05-20 17:25:26.471756Z] Running download-and-extract step. 10:25:26 INFO - Running pre-action listener: _resource_record_pre_action 10:25:26 INFO - Running main action method: download_and_extract 10:25:26 INFO - mkdir: /builds/slave/test/build/tests 10:25: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')]} 10:25:26 INFO - trying https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/artifacts/public/build/target.test_packages.json 10:25:26 INFO - Downloading https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:25:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:25:27 INFO - Downloaded 986 bytes. 10:25:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:25:27 INFO - Using the following test package requirements: 10:25:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:25:27 INFO - u'common': [u'target.common.tests.zip'], 10:25:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:25:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:25:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:25:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:25:27 INFO - u'mozbase': [u'target.common.tests.zip'], 10:25:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:25:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:25:27 INFO - u'web-platform': [u'target.common.tests.zip', 10:25:27 INFO - u'target.web-platform.tests.zip'], 10:25:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:25:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:25:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/artifacts/public/build/target.common.tests.zip 10:25:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:25:27 INFO - Fetch https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/artifacts/public/build/target.common.tests.zip into memory 10:25:29 INFO - Content-Length response header: 63520798 10:25:29 INFO - Bytes received: 63520798 10:25:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:25:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/artifacts/public/build/target.common.tests.zip 10:25:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:25:41 INFO - Fetch https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/artifacts/public/build/target.common.tests.zip into memory 10:25:42 INFO - Content-Length response header: 63520798 10:25:42 INFO - Bytes received: 63520798 10:25:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/artifacts/public/build/target.talos.tests.zip 10:25:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:25:55 INFO - Fetch https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/artifacts/public/build/target.talos.tests.zip into memory 10:25:56 INFO - Content-Length response header: 14410000 10:25:56 INFO - Bytes received: 14410000 10:25:56 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')]} 10:25:56 INFO - trying https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/artifacts/public/build/target.tar.bz2 10:25:56 INFO - Downloading https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:25:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:25:57 INFO - Downloaded 56415675 bytes. 10:25:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/artifacts/public/build/target.tar.bz2 10:25:57 INFO - mkdir: /builds/slave/test/properties 10:25:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:25:57 INFO - Writing to file /builds/slave/test/properties/build_url 10:25:57 INFO - Contents: 10:25:57 INFO - build_url:https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/artifacts/public/build/target.tar.bz2 10:25:57 INFO - Running post-action listener: _resource_record_post_action 10:25:57 INFO - Running post-action listener: set_extra_try_arguments 10:25:57 INFO - [mozharness: 2017-05-20 17:25:57.615217Z] Finished download-and-extract step (success) 10:25:57 INFO - [mozharness: 2017-05-20 17:25:57.615315Z] Running populate-webroot step. 10:25:57 INFO - Running pre-action listener: _resource_record_pre_action 10:25:57 INFO - Running main action method: populate_webroot 10:25:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:25:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:25:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:25:57 INFO - '--tppagecycles', 10:25:57 INFO - '7'], 10:25:57 INFO - 'tests': ['tsvgm']}}, 10:25:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:25:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:25:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:25:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:25:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:25:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:25:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:25:57 INFO - 'talos_options': ['--disable-e10s'], 10:25:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:25:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:25:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:25:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:25:57 INFO - 'talos_options': ['--disable-e10s'], 10:25:57 INFO - 'tests': ['damp', 'tps']}, 10:25:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:25:57 INFO - 'tests': ['damp', 'tps']}, 10:25:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:25:57 INFO - 'tests': ['dromaeo_dom']}, 10:25:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:25:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:25:57 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:25:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:25:57 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:25:57 INFO - 'tests': ['ts_paint', 'tp5o']}, 10:25:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:25:57 INFO - 'tests': ['a11yr', 10:25:57 INFO - 'ts_paint', 10:25:57 INFO - 'tpaint', 10:25:57 INFO - 'sessionrestore', 10:25:57 INFO - 'sessionrestore_no_auto_restore', 10:25:57 INFO - 'tabpaint']}, 10:25:57 INFO - 'other-e10s': {'tests': ['a11yr', 10:25:57 INFO - 'ts_paint', 10:25:57 INFO - 'tpaint', 10:25:57 INFO - 'sessionrestore', 10:25:57 INFO - 'sessionrestore_no_auto_restore', 10:25:57 INFO - 'tabpaint']}, 10:25:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:25:57 INFO - 'ts_paint', 10:25:57 INFO - 'tpaint', 10:25:57 INFO - 'sessionrestore', 10:25:57 INFO - 'sessionrestore_no_auto_restore', 10:25:57 INFO - 'tabpaint']}, 10:25:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:25:57 INFO - 'ts_paint', 10:25:57 INFO - 'tpaint', 10:25:57 INFO - 'sessionrestore', 10:25:57 INFO - 'sessionrestore_no_auto_restore', 10:25:57 INFO - 'tabpaint']}, 10:25:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:25:57 INFO - 'tests': ['a11yr', 10:25:57 INFO - 'ts_paint', 10:25:57 INFO - 'tpaint', 10:25:57 INFO - 'sessionrestore', 10:25:57 INFO - 'sessionrestore_no_auto_restore', 10:25:57 INFO - 'tabpaint']}, 10:25:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:25:57 INFO - 'tests': ['a11yr', 10:25:57 INFO - 'ts_paint', 10:25:57 INFO - 'tpaint', 10:25:57 INFO - 'sessionrestore', 10:25:57 INFO - 'sessionrestore_no_auto_restore', 10:25:57 INFO - 'tabpaint']}, 10:25:57 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 10:25:57 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 10:25:57 INFO - 'bloom_basic_ref']}, 10:25:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:25:57 INFO - 'tests': ['tsvgx', 10:25:57 INFO - 'tsvgr_opacity', 10:25:57 INFO - 'tart', 10:25:57 INFO - 'tscrollx', 10:25:57 INFO - 'cart', 10:25:57 INFO - 'tsvg_static']}, 10:25:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:25:57 INFO - 'tsvgr_opacity', 10:25:57 INFO - 'tart', 10:25:57 INFO - 'tscrollx', 10:25:57 INFO - 'cart', 10:25:57 INFO - 'tsvg_static']}, 10:25:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:25:57 INFO - 'talos_options': ['--disable-e10s'], 10:25:57 INFO - 'tests': ['tp5o']}, 10:25:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:25:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:25:57 INFO - 'talos_options': ['--disable-e10s', 10:25:57 INFO - '--xperf_path', 10:25:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:25:57 INFO - 'tests': ['tp5n']}, 10:25:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:25:57 INFO - 'talos_options': ['--xperf_path', 10:25:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:25:57 INFO - 'tests': ['tp5n']}}, 10:25:57 INFO - 'talos.zip': {'path': '', 10:25:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:25:57 INFO - Running post-action listener: _resource_record_post_action 10:25:57 INFO - [mozharness: 2017-05-20 17:25:57.629408Z] Finished populate-webroot step (success) 10:25:57 INFO - [mozharness: 2017-05-20 17:25:57.629496Z] Running create-virtualenv step. 10:25:57 INFO - Running pre-action listener: _resource_record_pre_action 10:25:57 INFO - Running main action method: create_virtualenv 10:25:57 INFO - Creating virtualenv /builds/slave/test/build/venv 10:25:57 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 10:25:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:25:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:25:57 INFO - Using real prefix '/usr' 10:25:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:25:58 INFO - Installing distribute.............................................................................................................................................................................................done. 10:26:00 INFO - Installing pip.................done. 10:26:00 INFO - Return code: 0 10:26:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:26:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:26:00 INFO - Reading from file tmpfile_stdout 10:26:00 INFO - Output received: 10:26:00 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) 10:26:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:26: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')]} 10:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26: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')]} 10:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28987a0>, '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 0x28996a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2899b30>, '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-1495283956.76804-937299759', '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 10:26: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', 'pip>=1.5'] in /builds/slave/test/build 10:26: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 pip>=1.5 10:26:00 INFO - Using env: {'DISPLAY': ':0', 10:26:00 INFO - 'HOME': '/home/cltbld', 10:26:00 INFO - 'LANG': 'en_US.UTF-8', 10:26:00 INFO - 'LANGUAGE': 'en_US:en', 10:26:00 INFO - 'LOGNAME': 'cltbld', 10:26:00 INFO - 'MAIL': '/var/mail/cltbld', 10:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:00 INFO - 'MOZ_NO_REMOTE': '1', 10:26:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:00 INFO - 'NO_EM_RESTART': '1', 10:26:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:00 INFO - 'PWD': '/builds/slave/test', 10:26:00 INFO - 'SHELL': '/bin/bash', 10:26:00 INFO - 'SHLVL': '1', 10:26:00 INFO - 'TERM': 'linux', 10:26:00 INFO - 'TMOUT': '86400', 10:26:00 INFO - 'USER': 'cltbld', 10:26:00 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1495283956.76804-937299759', 10:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:00 INFO - '_': '/tools/buildbot/bin/python'} 10:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:00 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 10:26:00 INFO - Cleaning up... 10:26:00 INFO - Return code: 0 10:26:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:26: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')]} 10:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26: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')]} 10:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26: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', '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 0x25281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28987a0>, '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 0x28996a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2899b30>, '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-1495283956.76804-937299759', '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 10:26: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', 'psutil>=3.1.1'] in /builds/slave/test/build 10:26: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 psutil>=3.1.1 10:26:00 INFO - Using env: {'DISPLAY': ':0', 10:26:00 INFO - 'HOME': '/home/cltbld', 10:26:00 INFO - 'LANG': 'en_US.UTF-8', 10:26:00 INFO - 'LANGUAGE': 'en_US:en', 10:26:00 INFO - 'LOGNAME': 'cltbld', 10:26:00 INFO - 'MAIL': '/var/mail/cltbld', 10:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:00 INFO - 'MOZ_NO_REMOTE': '1', 10:26:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:00 INFO - 'NO_EM_RESTART': '1', 10:26:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:00 INFO - 'PWD': '/builds/slave/test', 10:26:00 INFO - 'SHELL': '/bin/bash', 10:26:00 INFO - 'SHLVL': '1', 10:26:00 INFO - 'TERM': 'linux', 10:26:00 INFO - 'TMOUT': '86400', 10:26:00 INFO - 'USER': 'cltbld', 10:26:00 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1495283956.76804-937299759', 10:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:00 INFO - '_': '/tools/buildbot/bin/python'} 10:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:01 INFO - Downloading/unpacking psutil>=3.1.1 10:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:26:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:26:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:26:02 INFO - Installing collected packages: psutil 10:26:02 INFO - Running setup.py install for psutil 10:26:02 INFO - building 'psutil._psutil_linux' extension 10:26:02 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 10:26:03 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 10:26:03 INFO - building 'psutil._psutil_posix' extension 10:26:03 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 10:26:03 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 10:26:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:26:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:26:04 INFO - Successfully installed psutil 10:26:04 INFO - Cleaning up... 10:26:04 INFO - Return code: 0 10:26:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:26:04 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')]} 10:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:04 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')]} 10:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:04 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 0x25281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28987a0>, '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 0x28996a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2899b30>, '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-1495283956.76804-937299759', '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 10:26:04 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 10:26:04 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 10:26:04 INFO - Using env: {'DISPLAY': ':0', 10:26:04 INFO - 'HOME': '/home/cltbld', 10:26:04 INFO - 'LANG': 'en_US.UTF-8', 10:26:04 INFO - 'LANGUAGE': 'en_US:en', 10:26:04 INFO - 'LOGNAME': 'cltbld', 10:26:04 INFO - 'MAIL': '/var/mail/cltbld', 10:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:04 INFO - 'MOZ_NO_REMOTE': '1', 10:26:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:04 INFO - 'NO_EM_RESTART': '1', 10:26:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:04 INFO - 'PWD': '/builds/slave/test', 10:26:04 INFO - 'SHELL': '/bin/bash', 10:26:04 INFO - 'SHLVL': '1', 10:26:04 INFO - 'TERM': 'linux', 10:26:04 INFO - 'TMOUT': '86400', 10:26:04 INFO - 'USER': 'cltbld', 10:26:04 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1495283956.76804-937299759', 10:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:04 INFO - '_': '/tools/buildbot/bin/python'} 10:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:26:05 INFO - Installing collected packages: mozsystemmonitor 10:26:05 INFO - Running setup.py install for mozsystemmonitor 10:26:05 INFO - Successfully installed mozsystemmonitor 10:26:05 INFO - Cleaning up... 10:26:05 INFO - Return code: 0 10:26:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:05 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 0x25281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28987a0>, '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 0x28996a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2899b30>, '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-1495283956.76804-937299759', '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 10:26:05 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 10:26:05 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 10:26:05 INFO - Using env: {'DISPLAY': ':0', 10:26:05 INFO - 'HOME': '/home/cltbld', 10:26:05 INFO - 'LANG': 'en_US.UTF-8', 10:26:05 INFO - 'LANGUAGE': 'en_US:en', 10:26:05 INFO - 'LOGNAME': 'cltbld', 10:26:05 INFO - 'MAIL': '/var/mail/cltbld', 10:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:05 INFO - 'MOZ_NO_REMOTE': '1', 10:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:05 INFO - 'NO_EM_RESTART': '1', 10:26:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:05 INFO - 'PWD': '/builds/slave/test', 10:26:05 INFO - 'SHELL': '/bin/bash', 10:26:05 INFO - 'SHLVL': '1', 10:26:05 INFO - 'TERM': 'linux', 10:26:05 INFO - 'TMOUT': '86400', 10:26:05 INFO - 'USER': 'cltbld', 10:26:05 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1495283956.76804-937299759', 10:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:05 INFO - '_': '/tools/buildbot/bin/python'} 10:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:05 INFO - Downloading/unpacking jsonschema==2.5.1 10:26: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 10:26: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 10:26: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 10:26: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 10:26:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:26:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:26:06 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 10:26:06 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 10:26:06 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 10:26:06 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 10:26:06 INFO - Downloading functools32-3.2.3-2.tar.gz 10:26:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:26:07 INFO - warning: no files found matching '*.txt' 10:26:07 INFO - no previously-included directories found matching 'build' 10:26:07 INFO - no previously-included directories found matching 'dist' 10:26:07 INFO - no previously-included directories found matching '.git*' 10:26:07 INFO - Installing collected packages: jsonschema, functools32 10:26:07 INFO - Running setup.py install for functools32 10:26:07 INFO - warning: no files found matching '*.txt' 10:26:07 INFO - no previously-included directories found matching 'build' 10:26:07 INFO - no previously-included directories found matching 'dist' 10:26:07 INFO - no previously-included directories found matching '.git*' 10:26:07 INFO - Successfully installed jsonschema functools32 10:26:07 INFO - Cleaning up... 10:26:07 INFO - Return code: 0 10:26:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:26:07 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')]} 10:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:07 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')]} 10:26:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:07 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 0x25281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28987a0>, '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 0x28996a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2899b30>, '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-1495283956.76804-937299759', '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 10:26:07 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 10:26:07 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 10:26:07 INFO - Using env: {'DISPLAY': ':0', 10:26:07 INFO - 'HOME': '/home/cltbld', 10:26:07 INFO - 'LANG': 'en_US.UTF-8', 10:26:07 INFO - 'LANGUAGE': 'en_US:en', 10:26:07 INFO - 'LOGNAME': 'cltbld', 10:26:07 INFO - 'MAIL': '/var/mail/cltbld', 10:26:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:07 INFO - 'MOZ_NO_REMOTE': '1', 10:26:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:07 INFO - 'NO_EM_RESTART': '1', 10:26:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:07 INFO - 'PWD': '/builds/slave/test', 10:26:07 INFO - 'SHELL': '/bin/bash', 10:26:07 INFO - 'SHLVL': '1', 10:26:07 INFO - 'TERM': 'linux', 10:26:07 INFO - 'TMOUT': '86400', 10:26:07 INFO - 'USER': 'cltbld', 10:26:07 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1495283956.76804-937299759', 10:26:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:07 INFO - '_': '/tools/buildbot/bin/python'} 10:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:26:07 INFO - Cleaning up... 10:26:07 INFO - Return code: 0 10:26:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:26:07 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')]} 10:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:07 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')]} 10:26:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:07 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 0x25281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28987a0>, '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 0x28996a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2899b30>, '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-1495283956.76804-937299759', '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 10:26:07 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 10:26:07 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 10:26:07 INFO - Using env: {'DISPLAY': ':0', 10:26:07 INFO - 'HOME': '/home/cltbld', 10:26:07 INFO - 'LANG': 'en_US.UTF-8', 10:26:07 INFO - 'LANGUAGE': 'en_US:en', 10:26:07 INFO - 'LOGNAME': 'cltbld', 10:26:07 INFO - 'MAIL': '/var/mail/cltbld', 10:26:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:07 INFO - 'MOZ_NO_REMOTE': '1', 10:26:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:07 INFO - 'NO_EM_RESTART': '1', 10:26:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:07 INFO - 'PWD': '/builds/slave/test', 10:26:07 INFO - 'SHELL': '/bin/bash', 10:26:07 INFO - 'SHLVL': '1', 10:26:07 INFO - 'TERM': 'linux', 10:26:07 INFO - 'TMOUT': '86400', 10:26:07 INFO - 'USER': 'cltbld', 10:26:07 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1495283956.76804-937299759', 10:26:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:07 INFO - '_': '/tools/buildbot/bin/python'} 10:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:07 INFO - Downloading/unpacking blobuploader==1.2.4 10:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:08 INFO - Downloading blobuploader-1.2.4.tar.gz 10:26:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:26:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:26:08 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 10:26:08 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 10:26:08 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 10:26:08 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 10:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:26:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:09 INFO - Downloading docopt-0.6.1.tar.gz 10:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:26:09 INFO - Installing collected packages: blobuploader, requests, docopt 10:26:09 INFO - Running setup.py install for blobuploader 10:26:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:26:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:26:09 INFO - Running setup.py install for requests 10:26:09 INFO - Running setup.py install for docopt 10:26:09 INFO - Successfully installed blobuploader requests docopt 10:26:09 INFO - Cleaning up... 10:26:09 INFO - Return code: 0 10:26:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:26: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')]} 10:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26: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')]} 10:26:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:09 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 0x25281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28987a0>, '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 0x28996a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2899b30>, '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-1495283956.76804-937299759', '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 10:26:09 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 10:26:09 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 10:26:09 INFO - Using env: {'DISPLAY': ':0', 10:26:09 INFO - 'HOME': '/home/cltbld', 10:26:09 INFO - 'LANG': 'en_US.UTF-8', 10:26:09 INFO - 'LANGUAGE': 'en_US:en', 10:26:09 INFO - 'LOGNAME': 'cltbld', 10:26:09 INFO - 'MAIL': '/var/mail/cltbld', 10:26:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:09 INFO - 'MOZ_NO_REMOTE': '1', 10:26:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:09 INFO - 'NO_EM_RESTART': '1', 10:26:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:09 INFO - 'PWD': '/builds/slave/test', 10:26:09 INFO - 'SHELL': '/bin/bash', 10:26:09 INFO - 'SHLVL': '1', 10:26:09 INFO - 'TERM': 'linux', 10:26:09 INFO - 'TMOUT': '86400', 10:26:09 INFO - 'USER': 'cltbld', 10:26:09 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1495283956.76804-937299759', 10:26:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:09 INFO - '_': '/tools/buildbot/bin/python'} 10:26:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:26:10 INFO - Running setup.py (path:/tmp/pip-WzaIQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:26:10 INFO - Running setup.py (path:/tmp/pip-IbUVZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:26:10 INFO - Running setup.py (path:/tmp/pip-BLRvTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:26:10 INFO - Running setup.py (path:/tmp/pip-wTTU3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:26:10 INFO - Running setup.py (path:/tmp/pip-jtMaL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:26:10 INFO - Running setup.py (path:/tmp/pip-eMybzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:26:10 INFO - Running setup.py (path:/tmp/pip-tXlhSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:26:10 INFO - Running setup.py (path:/tmp/pip-DycdMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:26:10 INFO - Running setup.py (path:/tmp/pip-NyHQYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:26:10 INFO - Running setup.py (path:/tmp/pip-YReH1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:26:10 INFO - Running setup.py (path:/tmp/pip-SvoXrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:26:10 INFO - Running setup.py (path:/tmp/pip-w92Sgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:26:11 INFO - Running setup.py (path:/tmp/pip-p6DSAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:26:11 INFO - Running setup.py (path:/tmp/pip-U8g_Tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:11 INFO - Running setup.py (path:/tmp/pip-4OUiZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:26:11 INFO - Running setup.py (path:/tmp/pip-hO53p6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:26:11 INFO - Running setup.py (path:/tmp/pip-PHof_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:26:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:26:11 INFO - Running setup.py install for manifestparser 10:26:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:26:11 INFO - Running setup.py install for mozcrash 10:26:11 INFO - Running setup.py install for mozdebug 10:26:11 INFO - Running setup.py install for mozdevice 10:26:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:26:11 INFO - Running setup.py install for mozfile 10:26:11 INFO - Running setup.py install for mozhttpd 10:26:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:26:12 INFO - Running setup.py install for mozinfo 10:26:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:26:12 INFO - Running setup.py install for mozInstall 10:26:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:26:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:26:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:26:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:26:12 INFO - Running setup.py install for mozleak 10:26:12 INFO - Running setup.py install for mozlog 10:26:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:26:12 INFO - Running setup.py install for moznetwork 10:26:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:26:12 INFO - Running setup.py install for mozprocess 10:26:12 INFO - Running setup.py install for mozprofile 10:26:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:26:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:26:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:26:12 INFO - Running setup.py install for mozrunner 10:26:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:26:12 INFO - Running setup.py install for mozscreenshot 10:26:12 INFO - Running setup.py install for moztest 10:26:13 INFO - Running setup.py install for mozversion 10:26:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:26:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:26:13 INFO - Cleaning up... 10:26:13 INFO - Return code: 0 10:26:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:26:13 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')]} 10:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:13 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')]} 10:26:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:13 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 0x25281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28987a0>, '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 0x28996a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2899b30>, '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-1495283956.76804-937299759', '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 10:26:13 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 10:26:13 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 10:26:13 INFO - Using env: {'DISPLAY': ':0', 10:26:13 INFO - 'HOME': '/home/cltbld', 10:26:13 INFO - 'LANG': 'en_US.UTF-8', 10:26:13 INFO - 'LANGUAGE': 'en_US:en', 10:26:13 INFO - 'LOGNAME': 'cltbld', 10:26:13 INFO - 'MAIL': '/var/mail/cltbld', 10:26:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:13 INFO - 'MOZ_NO_REMOTE': '1', 10:26:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:13 INFO - 'NO_EM_RESTART': '1', 10:26:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:13 INFO - 'PWD': '/builds/slave/test', 10:26:13 INFO - 'SHELL': '/bin/bash', 10:26:13 INFO - 'SHLVL': '1', 10:26:13 INFO - 'TERM': 'linux', 10:26:13 INFO - 'TMOUT': '86400', 10:26:13 INFO - 'USER': 'cltbld', 10:26:13 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1495283956.76804-937299759', 10:26:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:13 INFO - '_': '/tools/buildbot/bin/python'} 10:26:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:26:13 INFO - Running setup.py (path:/tmp/pip-EFSpiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:26:13 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)) 10:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:26:13 INFO - Running setup.py (path:/tmp/pip-Iblr_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:26:13 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)) 10:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:26:13 INFO - Running setup.py (path:/tmp/pip-UIQmmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:26:13 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)) 10:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:26:13 INFO - Running setup.py (path:/tmp/pip-cBn_3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:26:13 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)) 10:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:26:13 INFO - Running setup.py (path:/tmp/pip-cvsUSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:26:13 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)) 10:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:26:13 INFO - Running setup.py (path:/tmp/pip-mE5NwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:26:13 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)) 10:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:26:13 INFO - Running setup.py (path:/tmp/pip-m4kCsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:26:13 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)) 10:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:26:13 INFO - Running setup.py (path:/tmp/pip-r5nYym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:26:14 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)) 10:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:26:14 INFO - Running setup.py (path:/tmp/pip-V0r74n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:26:14 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)) 10:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:26:14 INFO - Running setup.py (path:/tmp/pip-tA9m7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:26:14 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)) 10:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:26:14 INFO - Running setup.py (path:/tmp/pip-VwRjC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:26:14 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)) 10:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:26:14 INFO - Running setup.py (path:/tmp/pip-aHpUsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:26:14 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)) 10:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:26:14 INFO - Running setup.py (path:/tmp/pip-I_7Ifo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:26:14 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)) 10:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:26:14 INFO - Running setup.py (path:/tmp/pip-KZ8OAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:26:14 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)) 10:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:14 INFO - Running setup.py (path:/tmp/pip-I5WRN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:14 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)) 10:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:26:14 INFO - Running setup.py (path:/tmp/pip-BlcFDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:26:14 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)) 10:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:26:14 INFO - Running setup.py (path:/tmp/pip-4lQt8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:26:14 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)) 10:26:14 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)) 10:26:14 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)) 10:26:14 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)) 10:26:14 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)) 10:26:14 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)) 10:26:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:15 INFO - Downloading blessings-1.6.tar.gz 10:26:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:26:15 INFO - Installing collected packages: blessings 10:26:15 INFO - Running setup.py install for blessings 10:26:15 INFO - Successfully installed blessings 10:26:15 INFO - Cleaning up... 10:26:16 INFO - Return code: 0 10:26:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:26:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:26:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:26:16 INFO - Reading from file tmpfile_stdout 10:26:16 INFO - Current package versions: 10:26:16 INFO - argparse == 1.2.1 10:26:16 INFO - blessings == 1.6 10:26:16 INFO - blobuploader == 1.2.4 10:26:16 INFO - docopt == 0.6.1 10:26:16 INFO - functools32 == 3.2.3-2 10:26:16 INFO - jsonschema == 2.5.1 10:26:16 INFO - manifestparser == 1.1 10:26:16 INFO - mozInstall == 1.12 10:26:16 INFO - mozcrash == 1.0 10:26:16 INFO - mozdebug == 0.1 10:26:16 INFO - mozdevice == 0.50 10:26:16 INFO - mozfile == 1.2 10:26:16 INFO - mozhttpd == 0.7 10:26:16 INFO - mozinfo == 0.9 10:26:16 INFO - mozleak == 0.1 10:26:16 INFO - mozlog == 3.4 10:26:16 INFO - moznetwork == 0.27 10:26:16 INFO - mozprocess == 0.25 10:26:16 INFO - mozprofile == 0.28 10:26:16 INFO - mozrunner == 6.13 10:26:16 INFO - mozscreenshot == 0.1 10:26:16 INFO - mozsystemmonitor == 0.3 10:26:16 INFO - moztest == 0.8 10:26:16 INFO - mozversion == 1.4 10:26:16 INFO - psutil == 3.1.1 10:26:16 INFO - requests == 1.2.3 10:26:16 INFO - wsgiref == 0.1.2 10:26:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:26:16 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')]} 10:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:16 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')]} 10:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:16 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 0x25281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28987a0>, '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 0x28996a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2899b30>, '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-1495283956.76804-937299759', '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 10:26:16 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 10:26:16 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 10:26:16 INFO - Using env: {'DISPLAY': ':0', 10:26:16 INFO - 'HOME': '/home/cltbld', 10:26:16 INFO - 'LANG': 'en_US.UTF-8', 10:26:16 INFO - 'LANGUAGE': 'en_US:en', 10:26:16 INFO - 'LOGNAME': 'cltbld', 10:26:16 INFO - 'MAIL': '/var/mail/cltbld', 10:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:16 INFO - 'MOZ_NO_REMOTE': '1', 10:26:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:16 INFO - 'NO_EM_RESTART': '1', 10:26:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:16 INFO - 'PWD': '/builds/slave/test', 10:26:16 INFO - 'SHELL': '/bin/bash', 10:26:16 INFO - 'SHLVL': '1', 10:26:16 INFO - 'TERM': 'linux', 10:26:16 INFO - 'TMOUT': '86400', 10:26:16 INFO - 'USER': 'cltbld', 10:26:16 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1495283956.76804-937299759', 10:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:16 INFO - '_': '/tools/buildbot/bin/python'} 10:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:16 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)) 10:26:16 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)) 10:26:16 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)) 10:26:16 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)) 10:26:16 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)) 10:26:16 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)) 10:26:16 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)) 10:26:16 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)) 10:26:16 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)) 10:26:16 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)) 10:26:16 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)) 10:26:16 INFO - Cleaning up... 10:26:16 INFO - Return code: 0 10:26:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:26:16 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')]} 10:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:16 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')]} 10:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:16 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 0x25281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28987a0>, '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 0x28996a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2899b30>, '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-1495283956.76804-937299759', '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 10:26:16 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 10:26:16 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 10:26:16 INFO - Using env: {'DISPLAY': ':0', 10:26:16 INFO - 'HOME': '/home/cltbld', 10:26:16 INFO - 'LANG': 'en_US.UTF-8', 10:26:16 INFO - 'LANGUAGE': 'en_US:en', 10:26:16 INFO - 'LOGNAME': 'cltbld', 10:26:16 INFO - 'MAIL': '/var/mail/cltbld', 10:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:16 INFO - 'MOZ_NO_REMOTE': '1', 10:26:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:16 INFO - 'NO_EM_RESTART': '1', 10:26:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:16 INFO - 'PWD': '/builds/slave/test', 10:26:16 INFO - 'SHELL': '/bin/bash', 10:26:16 INFO - 'SHLVL': '1', 10:26:16 INFO - 'TERM': 'linux', 10:26:16 INFO - 'TMOUT': '86400', 10:26:16 INFO - 'USER': 'cltbld', 10:26:16 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1495283956.76804-937299759', 10:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:16 INFO - '_': '/tools/buildbot/bin/python'} 10:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:26:16 INFO - Cleaning up... 10:26:16 INFO - Return code: 0 10:26:16 INFO - Running post-action listener: _resource_record_post_action 10:26:16 INFO - Running post-action listener: _start_resource_monitoring 10:26:16 INFO - Starting resource monitoring. 10:26:16 INFO - [mozharness: 2017-05-20 17:26:16.730072Z] Finished create-virtualenv step (success) 10:26:16 INFO - [mozharness: 2017-05-20 17:26:16.731092Z] Running install step. 10:26:16 INFO - Running pre-action listener: _resource_record_pre_action 10:26:16 INFO - Running main action method: install 10:26:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:26:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:26:16 INFO - Reading from file tmpfile_stdout 10:26:16 INFO - Detecting whether we're running mozinstall >=1.0... 10:26:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:26:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:26:17 INFO - Reading from file tmpfile_stdout 10:26:17 INFO - Output received: 10:26:17 INFO - Usage: mozinstall [options] installer 10:26:17 INFO - Options: 10:26:17 INFO - -h, --help show this help message and exit 10:26:17 INFO - -d DEST, --destination=DEST 10:26:17 INFO - Directory to install application into. [default: 10:26:17 INFO - "/builds/slave/test"] 10:26:17 INFO - --app=APP Application being installed. [default: firefox] 10:26:17 INFO - mkdir: /builds/slave/test/build/application 10:26:17 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'] 10:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:26:33 INFO - Reading from file tmpfile_stdout 10:26:33 INFO - Output received: 10:26:33 INFO - /builds/slave/test/build/application/firefox/firefox 10:26:33 INFO - Running post-action listener: _resource_record_post_action 10:26:33 INFO - [mozharness: 2017-05-20 17:26:33.150173Z] Finished install step (success) 10:26:33 INFO - [mozharness: 2017-05-20 17:26:33.150367Z] Running run-tests step. 10:26:33 INFO - Running pre-action listener: _resource_record_pre_action 10:26:33 INFO - Running main action method: run_tests 10:26:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:26:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:26:33 INFO - Python 2.7.3 10:26:33 INFO - Return code: 0 10:26:33 INFO - grabbing minidump binary from tooltool 10:26:33 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')]} 10:26:33 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 0x28987a0>, '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 0x28996a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2899b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:26:33 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 10:26:33 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 10:26:33 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 10:26:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:26:33 INFO - Return code: 0 10:26:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:26:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:26:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:26:33 INFO - ENV: RUST_BACKTRACE is now 1 10:26:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:26:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:26:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/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 10:26:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/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 10:26:33 INFO - Using env: {'DISPLAY': ':0', 10:26:33 INFO - 'HOME': '/home/cltbld', 10:26:33 INFO - 'LANG': 'en_US.UTF-8', 10:26:33 INFO - 'LANGUAGE': 'en_US:en', 10:26:33 INFO - 'LOGNAME': 'cltbld', 10:26:33 INFO - 'MAIL': '/var/mail/cltbld', 10:26:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:26:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:33 INFO - 'MOZ_NO_REMOTE': '1', 10:26:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:26:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:33 INFO - 'NO_EM_RESTART': '1', 10:26:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:33 INFO - 'PWD': '/builds/slave/test', 10:26:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:26:33 INFO - 'RUST_BACKTRACE': '1', 10:26:33 INFO - 'SHELL': '/bin/bash', 10:26:33 INFO - 'SHLVL': '1', 10:26:33 INFO - 'TERM': 'linux', 10:26:33 INFO - 'TMOUT': '86400', 10:26:33 INFO - 'USER': 'cltbld', 10:26:33 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1495283956.76804-937299759', 10:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:33 INFO - '_': '/tools/buildbot/bin/python'} 10:26:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/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 10:26:33 INFO - mozversion application_buildid: 20170520164913 10:26:33 INFO - mozversion application_changeset: 5b74bbf20e803e299790d266fc6ebf5d53b7a1b7 10:26:33 INFO - mozversion application_display_name: Nightly 10:26:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:26:33 INFO - mozversion application_name: Firefox 10:26:33 INFO - mozversion application_remotingname: firefox 10:26:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:26:33 INFO - mozversion application_vendor: Mozilla 10:26:33 INFO - mozversion application_version: 55.0a1 10:26:33 INFO - mozversion platform_buildid: 20170520164913 10:26:33 INFO - mozversion platform_changeset: 5b74bbf20e803e299790d266fc6ebf5d53b7a1b7 10:26:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:26:33 INFO - mozversion platform_version: 55.0a1 10:26:33 INFO - using testdate: 1495301193 10:26:33 INFO - actual date: 1495301193 10:26:33 INFO - starting webserver on 'localhost:33135' 10:26:33 INFO - SUITE-START | Running 2 tests 10:26:33 INFO - TEST-START | dromaeo_css 10:26:33 INFO - operating with platform_type : linux_ 10:26:33 INFO - Initialising browser for dromaeo_css test... 10:26:33 INFO - TEST-INFO | started process 3429 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl2_A3q/profile http://localhost:33135/getInfo.html) 10:26:34 INFO - PID 3429 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2970: String.localeCompare is deprecated; use String.prototype.localeCompare instead 10:26:44 INFO - PID 3429 | __metrics Screen width/height:1600/1200 10:26:44 INFO - PID 3429 | colorDepth:24 10:26:44 INFO - PID 3429 | Browser inner width/height: 1024/695 10:26:44 INFO - PID 3429 | __metrics 10:26:46 INFO - TEST-INFO | 3429: exit 0 10:26:46 INFO - Browser initialized. 10:26:46 INFO - Running cycle 1/1 for dromaeo_css test... 10:26:46 INFO - TEST-INFO | started process 3608 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl2_A3q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:26:57 INFO - PID 3608 | RSS: Main: 170004480 10:26:57 INFO - PID 3608 | 10:30:02 INFO - PID 3608 | Cycle 1(1): loaded http://localhost:33135/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33135/tests/dromaeo/cssquery-ext.html) 10:30:04 INFO - PID 3608 | RSS: Main: 173719552 10:30:04 INFO - PID 3608 | 10:33:06 INFO - PID 3608 | Cycle 1(1): loaded http://localhost:33135/tests/dromaeo/cssquery-ext.html (next: http://localhost:33135/tests/dromaeo/cssquery-jquery.html) 10:33:06 INFO - PID 3608 | RSS: Main: 172851200 10:33:06 INFO - PID 3608 | 10:36:08 INFO - PID 3608 | Cycle 1(1): loaded http://localhost:33135/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33135/tests/dromaeo/cssquery-mootools.html) 10:36:09 INFO - PID 3608 | RSS: Main: 175165440 10:36:09 INFO - PID 3608 | 10:39:10 INFO - PID 3608 | Cycle 1(1): loaded http://localhost:33135/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33135/tests/dromaeo/cssquery-prototype.html) 10:39:11 INFO - PID 3608 | RSS: Main: 172613632 10:39:11 INFO - PID 3608 | 10:42:14 INFO - PID 3608 | Cycle 1(1): loaded http://localhost:33135/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33135/tests/dromaeo/cssquery-yui.html) 10:42:15 INFO - PID 3608 | RSS: Main: 172630016 10:42:15 INFO - PID 3608 | 10:45:17 INFO - PID 3608 | Cycle 1(1): loaded http://localhost:33135/tests/dromaeo/cssquery-yui.html (next: http://localhost:33135/tests/dromaeo/cssquery-dojo.html) 10:45:17 INFO - PID 3608 | RSS: Main: 179593216 10:45:17 INFO - PID 3608 | 10:45:17 INFO - PID 3608 | __start_tp_report 10:45:17 INFO - PID 3608 | _x_x_mozilla_page_load 10:45:17 INFO - PID 3608 | _x_x_mozilla_page_load_details 10:45:17 INFO - PID 3608 | |i|pagename|runs| 10:45:17 INFO - PID 3608 | |0;dojo.html;2677.8527181005043;2719.9728002719967;2725.4140359822636;2756.2282560882945;2758.5448401013823;5146.382434107913;5217.817376391827;5240.29256050434;5277.8944421111555;5297.337832770903;5219.269302297672;5234.26720259164;5242.030224408487;5252.3697156341195;5292.470752924715;4624.653151013687;4631.120087183424;4660.044690838387;4670.976645116787;4725.6928299660585;4681.578657920786;4729.030548737501;4731;4742.359781429497;4752.738599377033;4573.931391029138;4592.678512504126;4661.277501987197;4663.044075964419;4686.297055441711;4628.722276663411;4636.83771068011;4652.604528615072;4678.157931572316;4679.461861885893;4563.292689633112;4611.216093264153;4612.907741845178;4633.791479383436;4658.767061646904;5083.262926875619;5136.203888397267;5137.101007323741;5141.717205553693;5192.039472697563;5644.717764111778;5674.035413979634;5674.914876276859;5707.086866101404;5729.713514324267;5666.235058267122;5677.261955945742;5690.118031705092;5693.117566777115;5706.657600543981;5147.459516750762;5224.52979231871;5249.895002100013;5294.54996325309;5297.496737809902;5693.829185124453;5706.942930570641;5722.856928576735;5753.165790960287;5761.9135712964335;5452.59105567084;5456;5457.372402173722;5458;5461.508464238238;5552.028395030853;5556.083246264402;5629;5644.181593668977;5704.286964129484;5643.266375371176;5644.463775941279;5648.85877853057;5663.433656634304;5695.117256825199;5622.775088996476;5639.661620302713;5654.208410822406;5654.575906807006;5658.094704847287;4626.976865115653;4669.276262179367;4693.7653117344;4706.176419126639;4762.666613337103;4018.7588744675413;4044.8179831907637;4046.858359957387;4088.5298190707854;4123.8969025773995;4737.360456338419;4737.692050016738;4737.857864264078;4738.336632871401;4785.784639691222;5507.339119305709;5536.446355364431;5554.861128471821;5555.083411237181;5621.494065534122;4675.08835777027;4712.9057418851435;4712.929306060412;4712.976435117871;4764.928526072112;4956.10790057793;4963.8262660806695;4980.078685443204;5006.6245031622775;5052.242163675478;5199.142141546602;5244.76398562058;5269.235960785588;5275.630705850554;5287.444818294024;5606.299212598426;5621.381648018796;5722.4277572242445;5722.885542289214;5737.196792449144;5228.843134705965;5231.581473482036;5233.528982391603;5235.4502777207845;5239.44985776488;5482.068048431696;5501.697406642513;5504.339479262514;5511.696856672921;5557.44425557441;5561.6663000220115;5592.972035139798;5654.6889921054735;5676.262085928803;5676.914846277392;5479.808206712746;5485.204645326485;5487;5498.725063746717;5524.889502209853;5366.168243922199;5425.267588875609;5490.368607610017;5490.478404551562;5512.062949298709;5323.547498462674;5373.086575282133;5407.810726624549;5421.457854214547;5427.83716488506;5437.34751829783;5444.428335024765;5453.072977593739;5477.233187353853;5500.4499550044675;5296.708681022426;5297.788088476418;5301.284326615858;5310.283111780015;5321 10:45:17 INFO - PID 3608 | |1;ext.html;679.8572299817038;730.3572855886819;741.9925800741993;1038.7818558102804;1052.7841792432553;32507;33427.66572334276;33515.66484335159;33516.329673406515;33547.329053418915;34604.1348966276;34876.558640895084;34887.302253954906;34960.12599685009;35053.123671908215;6760.188777346725;6853.177618685765;6966.512344135913;6979.546329488592;6982.301769823002;6936.34104760047;7019.7543085992;7048.36564709176;7049.436045116378;7054.929450705478;6980.9650951745425;7006.789796306119;7059.823504412379;7060.223375428699;7088.3620474157315;6954.513184077116;6981.82545436363;6999.615021173833;7027.402670772939;7028.086348774652;6782.355676210752;6827.795166145023;6901.068355771957;6903.240643529258;6904.516683832134;31778.205544861332;31839.84080079608;31932.20169495758;31982.20044498883;32051.83974080138;3056.8930087446834;3079.461094308487;3086.6913308669177;3095.922601934947;3108.98445507771;24725.010999559996;24820.50358992828;24838.130665426623;24838.254852354457;24905.377365565826;3014.502607069831;3033.620797400325;3060.6786287439945;3066.1721335239586;3083.1521331633758;146874;147109.26445367705;153878;158565.20717396453;159356;39112.80443597764;39183.804080979986;39363.2127357457;39366.21267574633;39380.80309598491;40218.798906005286;40786;40790.79604602017;40798.18403631911;40871;11395.373254470918;11568.537258509565;11590.13074019452;11599.362035088152;11607.709807254887;9411.952940235393;9455.149036586603;9517.333786635008;9523.761905952268;9564.856527152098;12415.130940834055;12460.252384856938;12466.937665311796;12495.938170201996;12694.238345699288;5301.522862942354;5301.840944771663;5349.545288650508;5353.7590808413715;5446.591505637014;869.3436455476201;905.3300557587338;908.2189317187214;915.6337465013914;936.7939053408239;20714.792852071587;21410;21410.464738381666;21451.141954321964;21786.237481688066;974.7124598243394;987.8123156600223;1006.1548299428368;1007.5415685862915;1009.2077718990557;10946.616868409727;11128.944355278334;11248.775024499464;11263.887361126284;11317.264377815416;173947;175257;176320;176837.11581442266;177380;40030.799846000584;40307.395389069185;40333.77329813608;40348;40422.79788601038;1197.485081415;1229.059769276522;1247.1768632702374;1248.17620370555;1255.428779905141;20134;20140;20917.790822091585;21061;21241.256556020464;28838.567421488275;28902.132936011953;28931.276718082216;28987.5651865218;29111;146300;146881.26559367136;147029;147182;147946.26026869798;28390.290242744097;28420.147395578166;28507.144785656463;28871.133865984055;28911;34858.12854678653;35160.47259291061;35267;35593;35969;26889;27186.72813271842;27537.31156721098;27925.720742793124;28507.714922851337;26461;26513.469730604895;26966;27734;28154.29614259578;30178;30199.547006794477;30319.93880214182;30486.84756576203;30489;25538.233852984442;26523.734762652126;26557.867210663822;26974.730252697223;27217.591736123577;21262.893685531475;22454.775452245267;22459.32622021342;22463.887680561493;22494.775052249923 10:45:17 INFO - PID 3608 | |2;jquery.html;403.69319317318826;403.8586494726846;419.4463308432869;427.98288068477245;431.70212553338195;13676.863231367683;17236.48290551284;17495.212715427806;17966.640667186664;17986.100694965266;17990.370337038206;18214.180361883715;18290.359837405693;18329.17518711658;18371.081445927717;5166.147585648373;5258.263843061955;5341.545968592655;5362.088444964365;5445.128779395298;5231.973840130794;5305.840824775243;5324;5329.280547126146;5369.677819330833;5146.228065790143;5257.185136303879;5276.8153114641;5302.310699609065;5315.176147697113;5261.552768014704;5300.575953923677;5308.601854860901;5320.707361095138;5326.866828329284;4700.858974230779;4794.664373493857;4797.832075877328;4832;4868.902621947576;21416.571668566543;21634.350969470943;21750.129994800347;21816.672749908765;21832.563348733096;1639.3770367260483;1655;1659.3860271699427;1662.036019108914;1669.0486422739043;13406.262655553941;13889.861101389059;14148.787768183485;14230.217338046403;14427.78358324626;2036.0939381975027;2067.7208576842086;2076.885771282579;2083.4895450614545;2097.475631092227;87528.56235718845;87978.5601071997;88154.5592272041;89071.55464222703;94098.52950735271;10460.163186945027;10709.732256693645;10821.296615719953;10898.237123401286;10933.070688991365;14726.92636536832;14831.629209269855;14931.92534037323;14932.925335373471;14981.850181498263;7407.481476296715;7439.925600744032;7606.315431611071;7673.654685539164;7744.845103097907;6864.38220560152;6928.480363972722;7113.253108423541;7185;7202.891956620655;6807.829804254933;6908.378245957888;6950.826229344307;6962.164540255202;6986.860262794716;2058.5677007828226;2075.29439990404;2077.511784730587;2087.102545905245;2222.055626358791;845.1379592815294;850.0946491986015;857.5540718826176;884.8058508783287;897.1387468030764;16444.6711065778;16766;16810.41163559294;17008.829911700974;17116.572085697957;880.2561835249204;881.5900606218139;882.1751662195867;892.1881088209698;897.717219075989;8790.736277911672;8875.689350872688;9202.35583509148;9353.111454411955;9354.438733675865;369763;377140;382881;384350;386793;78113;82041.58979205065;82095;82315;82534.58732706418;1063.2238465919922;1078.6332646900091;1110.8500352452477;1120.0703416164563;1121.7195701074731;16721.832781672027;17032.318707251572;17441.56396090108;17539.56151096233;17827.10864456798;38766;39248.80375598104;39969.40045899372;40343.79828100841;40369.1926161481;49170;49193;51701;52152.47847521476;52210.47789522208;7821.726239581587;8025.23760242776;8162.428629995843;8295.751127466187;8350.164983501601;12774.297413642338;12940.611781646188;12977.870221298044;13355.131916425402;13371.130876492996;10906.182036347147;11134.721631958942;11140.387278699749;11289;11313.434328283718;9774.85337719949;10554.630587929385;10590.682279531626;10647.627333043616;10665.680029598814;10770.892291077302;10834;10851.131909447384;10897.782044359226;11270.718232043937;8276.234313387515;8302.335813135056;8312.792180195544;8414.3268538518;8461.95769021151;10704.464776760975;10724.8927510727;10728.678139655824;11083.556657733601;11218.663440096483 10:45:17 INFO - PID 3608 | |3;mootools.html;1249.1942696960461;1284.8393950756158;1289.284447131842;1294.9999999999993;1296.6693493159255;9472.726545629052;9970.401775893442;9984.001599840003;9998.300118991674;10168.69493915182;9911.653092141776;10061.295709300352;10067.49662516875;10068.748281292954;10075.395476271411;2234.3967128875192;2257.571061498318;2259.7966183043523;2262.694536237603;2272.7045484087043;2168.230278251222;2216.7007453993747;2219.611567975606;2220.877851718155;2224.5662095891307;2227.6435770276757;2228.92198773043;2268.6370180771078;2269.103704036913;2273.920412785553;2135.8504904656525;2178.9782102178933;2215.1693115081925;2231.141010710872;2232.787885150908;2122;2157.0508976050487;2181.345596321113;2190.2224710227797;2261;9613.711588652352;9666.323357364987;9668.903310966942;9718.465484398355;9736.172425343784;5264.947350526484;5452.236686863842;5459.372172200208;5478.890422191534;5481.643693159972;3125.7811953163286;3365.848536815825;3367.44437167867;3383.3928883780254;3396.626371099177;1066.4188017530387;1100.4277775556745;1117.8155604325277;1140.3841925360377;1145.3357052909294;13877.444902203899;14007.929960350235;14047.438102475991;14086.225257610828;14097.224652644101;4392.978035109868;4517.593416592456;4705.12955103307;4748.240281554935;4778.068276686083;9838;9865.309428340091;9902.207823374112;9944.701658950244;9944.950275248577;5398.163284690879;5403.13549832025;5410.269613602113;5423.267858839006;5433.8369848904595;4812.446568644651;5078.5175408336145;5094.439611642716;5097.439281679012;5138.3577052868395;3585.659362360572;3656.8537258509896;3683.686886614668;3708.5364329458816;3767.1335592813807;1009.5759780892043;1018.0786388318584;1021.4841505039907;1031.118393773328;1031.1235449867702;681.8534015186659;700.0968750312143;703.96480175991;720.1250480665911;722.9457790665721;5042.621803364762;5174.24973378858;5218.243354713622;5327.9733601331745;5374.623776335619;559.535585464072;560.2660514725723;563.7181409295353;569.7151424287856;574.8821491594213;3440.8795692151157;3693.4829123922673;3738.0841693785196;3779.168582911755;3866.0141663875534;11960.10299227544;12460.501579936883;12488.937555312164;12613.558525451564;12638.810417843739;12172.452239649238;12446.502139914483;12522.81215781764;12628.989680825513;12637.873621263854;7004.929950700428;7027.7188912442925;7083.220845706968;7086.681099350541;7129.3583577478275;5467.343918729619;5467.480589344006;5477.917831232615;5542.251796007648;5582.385937546947;11077.778444430905;11206.366503871746;11246.718832028937;11409.543618255177;11458.369789661316;11089.889101108885;11614.767704646029;11623.6512904613;11666;11673.533058677898;6886.070380498569;6909.7581584644295;6915.308469153246;6986.720531178696;6986.790396288119;9062.50156241413;9088.818223635622;9091.181793638605;9176.770580735534;9217.585208665492;7792.376609871083;7945.48354356965;7958.880616790637;7973.960130199312;8009.3192078673965;7752.534847908918;7780.961095194488;7803.648835802289;7927.881081783893;8061.798455038671;6956.200036995608;7059.894101588583;7063.752768653072;7077.823054423475;7099.716011359487;4350.891227719332;4657.906841863211;4759.928601071056;4762.190427627243;4895.73073480962;5237.397699264633;5298.523132918056;5314.3091398117995;5343.492368225013;5367.1680889462195 10:45:17 INFO - PID 3608 | |4;prototype.html;344.4918744851345;368.43629247251704;372.43204113726546;374.9381352076907;377.2605692842028;5466.753996070176;5514.36584792749;5532.1425179097205;5580.581456390777;5594.608377413578;5453.263809385731;5466.262054622624;5473.480019398151;5477.068898287291;5495.53287970522;3967.1272320089533;4049.2711311963835;4241.427407300013;4244.533101358848;4250.723702959313;4045.4336392905016;4046.9595304046875;4064.4919385076864;4073.8593193905754;4080.7143499955014;4035.8385664573384;4040.1111755413763;4043.919121617566;4050.291199040171;4050.6354428101463;3982.561918188997;4032.5885939921086;4038.1318016626565;4044.150728347036;4045.3616285404605;3488.337215928965;3488.720902327833;3502.8773992910383;3503.4219353806593;3518.2084031093054;5317.680939143664;5322.175062865262;5325.760340784674;5333.733313334356;5350.565492700812;4735.360726301974;4739.364919102904;4740.696308515151;4753.550167199003;4763.76181190939;5600.411956744565;5712.80005199816;5743.0811070228565;5752.539796816286;5768.538516918637;3881.146147847469;3902.9219415611815;3904.9609503905167;3914.5106861642294;3915.5105611798526;5894.2926848778425;6038.245219347537;6067.302260240085;6111.54163437744;6139.785107521216;3953.940690889639;3954.6638535724787;3961.1285517186175;3969.8884312391997;3973.7615743055508;3993.800309984489;4001.919961600752;4002.0195052212393;4027;4028.637422631977;4573.81704731807;4695.647826413033;4702.882427939329;4710.52894710533;4716.551927566876;5748.626339287933;5754.223179870748;5763.9135412968835;5774.047282198474;5782.7686892523825;1393.212834748364;1403.8385585657577;1407.774756039029;1408.2747385096684;1418.9432422702976;886.601029536711;932.4917919733762;936.1106948399048;949.6106596295485;951.7477868364889;4977.850664480072;4991.775370108281;4997;4999.450060493343;5003.399592048978;5935.198748168942;5961.165436838846;5963.642181469126;5993.700314984233;6002.849928751816;4850.1269771440775;4922.901541969212;4981.950180498221;4984.327115839315;4989.650724449326;3140.120766185472;3162;3164.47786115293;3175.777695561335;3179.713825755693;5462.562994960473;5567.717235933248;5569.192467092249;5572.777088916479;5574.581906356958;6058.909116363258;6096.896570683107;6125.509959203253;6131.080337949344;6151.72317245725;5530.976769297693;5550.861228469321;5563.944360556424;5569.693666848281;5570.637908535932;5712.400197979152;5941.554383421347;5960.552958528041;5973.641581505123;5981.611195272293;5843.474087332161;5914.792982245601;5925.140854576149;5925.40745925404;5930.555208359477;5426.403095659553;5531.3362396512675;5542.256582991445;5553.139263414178;5601.159826026129;3958.129211573449;3959.1685745992513;3968.861089861841;3979.7861652196357;3991.7006224532697;5959.76160953557;6038.909416358671;6066;6068.423499767515;6075.453209211192;5767.740451679769;5790.855228619318;5805.129230615442;5808.941910581009;5823.475887170175;5812.331581868139;5814.069748840166;5815.534757219328;5816.738246778989;5821.5258515131745;5641.971790141023;5647.983362994701;5738.426157384228;5756.1941328214925;5756.884862302814;5830.358660547252;5849.210356601804;5870.442307980735;5871.383504731942;5875.036837609744;5487.588430867621;5649.971750141223;5677.801276955287;5693.829185124453;5722.227499287543 10:45:17 INFO - PID 3608 | |5;yui.html;652.6769249221636;663.1975309875054;727.0548287226604;763.9541627502349;780.328917131267;11434.885651143486;11782.823257651142;12104.152709310352;12291.262524248552;12392.132550721453;14923.477678281262;15285.617859553517;15315.157666328347;15317.157556334398;15399.846001539981;881.7839629290817;908.6637943960744;908.7637214324258;909.6543313540878;911.1890417528372;906.0441234497603;910.2354022620997;910.8087301666658;910.8314961732101;917.3807679816131;958.1711819276345;959.3092973059386;962.129273007929;964.2237998411276;966.5891995901749;956.4022485946283;957.3107362698846;960.0207788056143;962.5668449197854;964.599691128181;706.1702499563045;706.4701473894579;706.8162277807755;707.056080133023;709.5068927095671;13603.795943060863;13815.240161791098;14091.295435228198;14304.785428218585;14493.275336233146;15338.233088345649;15366.615834604112;15503.922480387526;15657.06057636534;16154.757678634829;12632.11575189737;12709.682257943532;12856.742865142738;12910.289934053624;12973.286469244187;3060.464418726714;3061.0510741670155;3084.259777653347;3085.1053194573547;3102.053873568561;70909.29090709079;71602.64198678973;71837;73225;74463;12738.68153296175;12808.6797830055;12831.037672174623;12833.101682882108;12834.229946203257;21789.564208716052;22831.200907968472;22967;22995.195168169033;23077;6152.138700581922;6370.936290637127;6398.232212134573;6403.679816009274;6425.293217746044;2496.288557761066;2544.770970612654;2546.299767563935;2546.452512709739;2562.1288761820697;3659.817009149585;3728.5339332583426;3732.701383889282;3843.7693738375788;3941.7043721720984;771.8263390737152;778.3345239819986;790.2255789326492;792;792.6195426195459;610.7923306075955;613.4632196827775;621.1459243540132;623.9656818875005;641.0160403780175;9731.026897310212;9916.801663966824;10353.119984801377;10376.16990640747;11049.558017679203;606.4875180472494;612.317266248139;616.1743264026137;625.3059104394118;632.2065807411669;4363.6072753452345;4616.261398176276;4772.427308722906;4783.976080119647;4997.200447928387;60311.396886031456;60709.392906070374;60884.39115608876;63923.68038159779;64055.6797216011;49772;50783.49216507861;51446.742766285926;53269.2009619856;55108;47198.764006180434;47600;48437.5156248433;48622.27066594004;49360.25959610609;10321.225908057077;11289.096872250037;11403.315801051964;11426.2001659883;11537.82693259585;25071.498570028863;25247.747522525275;25306.620400694374;25552;25608.487830243663;42753.572464274956;42782;43273;43424;44420.33369499525;13857.445702172203;13964;14353.64115897111;14477;14486.637834054232;15623.921880390526;15910.60223494422;16351.34594616202;16414.67170656604;16671.24979375955;14128.646783830487;14422;14606.561803145923;14742.557723268319;14930.552083437515;14685.339159737623;14705.264736762905;15008.774868376764;15261.694766104394;15605.375784968473;13478.94039998807;13505.594832155051;13753;13864.653383665489;14670.26648667541;9331.113544213289;9675.854862176931;10569.682909512727;10587.4706264688;11080.335179889233;11862.347570883685;12106.213096148722;12396.442160102637;12399.504019839465;12461.813072804096 10:45:17 INFO - PID 3608 | __end_tp_report 10:45:17 INFO - PID 3608 | __start_cc_report 10:45:17 INFO - PID 3608 | _x_x_mozilla_cycle_collect,278 10:45:17 INFO - PID 3608 | __end_cc_report 10:45:17 INFO - PID 3608 | __startTimestamp1495302317256__endTimestamp 10:45:17 INFO - PID 3608 | 10:45:17 INFO - PID 3608 | ------- Summary: start ------- 10:45:17 INFO - PID 3608 | Number of tests: 6 10:45:17 INFO - PID 3608 | 10:45:17 INFO - PID 3608 | [#0] dojo.html Cycles:165 Average:5138.20 Median:5294.55 stddev:601.10 (11.4%) stddev-sans-first:571.11 10:45:17 INFO - PID 3608 | Values: 2677.9 2720.0 2725.4 2756.2 2758.5 5146.4 5217.8 5240.3 5277.9 5297.3 5219.3 5234.3 5242.0 5252.4 5292.5 4624.7 4631.1 4660.0 4671.0 4725.7 4681.6 4729.0 4731.0 4742.4 4752.7 4573.9 4592.7 4661.3 4663.0 4686.3 4628.7 4636.8 4652.6 4678.2 4679.5 4563.3 4611.2 4612.9 4633.8 4658.8 5083.3 5136.2 5137.1 5141.7 5192.0 5644.7 5674.0 5674.9 5707.1 5729.7 5666.2 5677.3 5690.1 5693.1 5706.7 5147.5 5224.5 5249.9 5294.5 5297.5 5693.8 5706.9 5722.9 5753.2 5761.9 5452.6 5456.0 5457.4 5458.0 5461.5 5552.0 5556.1 5629.0 5644.2 5704.3 5643.3 5644.5 5648.9 5663.4 5695.1 5622.8 5639.7 5654.2 5654.6 5658.1 4627.0 4669.3 4693.8 4706.2 4762.7 4018.8 4044.8 4046.9 4088.5 4123.9 4737.4 4737.7 4737.9 4738.3 4785.8 5507.3 5536.4 5554.9 5555.1 5621.5 4675.1 4712.9 4712.9 4713.0 4764.9 4956.1 4963.8 4980.1 5006.6 5052.2 5199.1 5244.8 5269.2 5275.6 5287.4 5606.3 5621.4 5722.4 5722.9 5737.2 5228.8 5231.6 5233.5 5235.5 5239.4 5482.1 5501.7 5504.3 5511.7 5557.4 5561.7 5593.0 5654.7 5676.3 5676.9 5479.8 5485.2 5487.0 5498.7 5524.9 5366.2 5425.3 5490.4 5490.5 5512.1 5323.5 5373.1 5407.8 5421.5 5427.8 5437.3 5444.4 5453.1 5477.2 5500.4 5296.7 5297.8 5301.3 5310.3 5321.0 10:45:17 INFO - PID 3608 | 10:45:17 INFO - PID 3608 | [#1] ext.html Cycles:180 Average:30147.08 Median:30487.92 stddev:41058.86 (134.7%) stddev-sans-first:41114.42 10:45:17 INFO - PID 3608 | Values: 679.9 730.4 742.0 1038.8 1052.8 32507.0 33427.7 33515.7 33516.3 33547.3 34604.1 34876.6 34887.3 34960.1 35053.1 6760.2 6853.2 6966.5 6979.5 6982.3 6936.3 7019.8 7048.4 7049.4 7054.9 6981.0 7006.8 7059.8 7060.2 7088.4 6954.5 6981.8 6999.6 7027.4 7028.1 6782.4 6827.8 6901.1 6903.2 6904.5 31778.2 31839.8 31932.2 31982.2 32051.8 3056.9 3079.5 3086.7 3095.9 3109.0 24725.0 24820.5 24838.1 24838.3 24905.4 3014.5 3033.6 3060.7 3066.2 3083.2 146874.0 147109.3 153878.0 158565.2 159356.0 39112.8 39183.8 39363.2 39366.2 39380.8 40218.8 40786.0 40790.8 40798.2 40871.0 11395.4 11568.5 11590.1 11599.4 11607.7 9412.0 9455.1 9517.3 9523.8 9564.9 12415.1 12460.3 12466.9 12495.9 12694.2 5301.5 5301.8 5349.5 5353.8 5446.6 869.3 905.3 908.2 915.6 936.8 20714.8 21410.0 21410.5 21451.1 21786.2 974.7 987.8 1006.2 1007.5 1009.2 10946.6 11128.9 11248.8 11263.9 11317.3 173947.0 175257.0 176320.0 176837.1 177380.0 40030.8 40307.4 40333.8 40348.0 40422.8 1197.5 1229.1 1247.2 1248.2 1255.4 20134.0 20140.0 20917.8 21061.0 21241.3 28838.6 28902.1 28931.3 28987.6 29111.0 146300.0 146881.3 147029.0 147182.0 147946.3 28390.3 28420.1 28507.1 28871.1 28911.0 34858.1 35160.5 35267.0 35593.0 35969.0 26889.0 27186.7 27537.3 27925.7 28507.7 26461.0 26513.5 26966.0 27734.0 28154.3 30178.0 30199.5 30319.9 30486.8 30489.0 25538.2 26523.7 26557.9 26974.7 27217.6 21262.9 22454.8 22459.3 22463.9 22494.8 10:45:17 INFO - PID 3608 | 10:45:17 INFO - PID 3608 | [#2] jquery.html Cycles:180 Average:25304.40 Median:39609.10 stddev:63355.14 (160.0%) stddev-sans-first:63505.28 10:45:17 INFO - PID 3608 | Values: 403.7 403.9 419.4 428.0 431.7 13676.9 17236.5 17495.2 17966.6 17986.1 17990.4 18214.2 18290.4 18329.2 18371.1 5166.1 5258.3 5341.5 5362.1 5445.1 5232.0 5305.8 5324.0 5329.3 5369.7 5146.2 5257.2 5276.8 5302.3 5315.2 5261.6 5300.6 5308.6 5320.7 5326.9 4700.9 4794.7 4797.8 4832.0 4868.9 21416.6 21634.4 21750.1 21816.7 21832.6 1639.4 1655.0 1659.4 1662.0 1669.0 13406.3 13889.9 14148.8 14230.2 14427.8 2036.1 2067.7 2076.9 2083.5 2097.5 87528.6 87978.6 88154.6 89071.6 94098.5 10460.2 10709.7 10821.3 10898.2 10933.1 14726.9 14831.6 14931.9 14932.9 14981.9 7407.5 7439.9 7606.3 7673.7 7744.8 6864.4 6928.5 7113.3 7185.0 7202.9 6807.8 6908.4 6950.8 6962.2 6986.9 2058.6 2075.3 2077.5 2087.1 2222.1 845.1 850.1 857.6 884.8 897.1 16444.7 16766.0 16810.4 17008.8 17116.6 880.3 881.6 882.2 892.2 897.7 8790.7 8875.7 9202.4 9353.1 9354.4 369763.0 377140.0 382881.0 384350.0 386793.0 78113.0 82041.6 82095.0 82315.0 82534.6 1063.2 1078.6 1110.9 1120.1 1121.7 16721.8 17032.3 17441.6 17539.6 17827.1 38766.0 39248.8 39969.4 40343.8 40369.2 49170.0 49193.0 51701.0 52152.5 52210.5 7821.7 8025.2 8162.4 8295.8 8350.2 12774.3 12940.6 12977.9 13355.1 13371.1 10906.2 11134.7 11140.4 11289.0 11313.4 9774.9 10554.6 10590.7 10647.6 10665.7 10770.9 10834.0 10851.1 10897.8 11270.7 8276.2 8302.3 8312.8 8414.3 8462.0 10704.5 10724.9 10728.7 11083.6 11218.7 10:45:17 INFO - PID 3608 | 10:45:17 INFO - PID 3608 | [#3] mootools.html Cycles:180 Average:5972.80 Median:4754.08 stddev:3779.34 (79.5%) stddev-sans-first:3773.28 10:45:17 INFO - PID 3608 | Values: 1249.2 1284.8 1289.3 1295.0 1296.7 9472.7 9970.4 9984.0 9998.3 10168.7 9911.7 10061.3 10067.5 10068.7 10075.4 2234.4 2257.6 2259.8 2262.7 2272.7 2168.2 2216.7 2219.6 2220.9 2224.6 2227.6 2228.9 2268.6 2269.1 2273.9 2135.9 2179.0 2215.2 2231.1 2232.8 2122.0 2157.1 2181.3 2190.2 2261.0 9613.7 9666.3 9668.9 9718.5 9736.2 5264.9 5452.2 5459.4 5478.9 5481.6 3125.8 3365.8 3367.4 3383.4 3396.6 1066.4 1100.4 1117.8 1140.4 1145.3 13877.4 14007.9 14047.4 14086.2 14097.2 4393.0 4517.6 4705.1 4748.2 4778.1 9838.0 9865.3 9902.2 9944.7 9945.0 5398.2 5403.1 5410.3 5423.3 5433.8 4812.4 5078.5 5094.4 5097.4 5138.4 3585.7 3656.9 3683.7 3708.5 3767.1 1009.6 1018.1 1021.5 1031.1 1031.1 681.9 700.1 704.0 720.1 722.9 5042.6 5174.2 5218.2 5328.0 5374.6 559.5 560.3 563.7 569.7 574.9 3440.9 3693.5 3738.1 3779.2 3866.0 11960.1 12460.5 12488.9 12613.6 12638.8 12172.5 12446.5 12522.8 12629.0 12637.9 7004.9 7027.7 7083.2 7086.7 7129.4 5467.3 5467.5 5477.9 5542.3 5582.4 11077.8 11206.4 11246.7 11409.5 11458.4 11089.9 11614.8 11623.7 11666.0 11673.5 6886.1 6909.8 6915.3 6986.7 6986.8 9062.5 9088.8 9091.2 9176.8 9217.6 7792.4 7945.5 7958.9 7974.0 8009.3 7752.5 7781.0 7803.6 7927.9 8061.8 6956.2 7059.9 7063.8 7077.8 7099.7 4350.9 4657.9 4759.9 4762.2 4895.7 5237.4 5298.5 5314.3 5343.5 5367.2 10:45:17 INFO - PID 3608 | 10:45:17 INFO - PID 3608 | [#4] prototype.html Cycles:180 Average:4726.55 Median:5475.27 stddev:1432.54 (26.2%) stddev-sans-first:1398.29 10:45:17 INFO - PID 3608 | Values: 344.5 368.4 372.4 374.9 377.3 5466.8 5514.4 5532.1 5580.6 5594.6 5453.3 5466.3 5473.5 5477.1 5495.5 3967.1 4049.3 4241.4 4244.5 4250.7 4045.4 4047.0 4064.5 4073.9 4080.7 4035.8 4040.1 4043.9 4050.3 4050.6 3982.6 4032.6 4038.1 4044.2 4045.4 3488.3 3488.7 3502.9 3503.4 3518.2 5317.7 5322.2 5325.8 5333.7 5350.6 4735.4 4739.4 4740.7 4753.6 4763.8 5600.4 5712.8 5743.1 5752.5 5768.5 3881.1 3902.9 3905.0 3914.5 3915.5 5894.3 6038.2 6067.3 6111.5 6139.8 3953.9 3954.7 3961.1 3969.9 3973.8 3993.8 4001.9 4002.0 4027.0 4028.6 4573.8 4695.6 4702.9 4710.5 4716.6 5748.6 5754.2 5763.9 5774.0 5782.8 1393.2 1403.8 1407.8 1408.3 1418.9 886.6 932.5 936.1 949.6 951.7 4977.9 4991.8 4997.0 4999.5 5003.4 5935.2 5961.2 5963.6 5993.7 6002.8 4850.1 4922.9 4982.0 4984.3 4989.7 3140.1 3162.0 3164.5 3175.8 3179.7 5462.6 5567.7 5569.2 5572.8 5574.6 6058.9 6096.9 6125.5 6131.1 6151.7 5531.0 5550.9 5563.9 5569.7 5570.6 5712.4 5941.6 5960.6 5973.6 5981.6 5843.5 5914.8 5925.1 5925.4 5930.6 5426.4 5531.3 5542.3 5553.1 5601.2 3958.1 3959.2 3968.9 3979.8 3991.7 5959.8 6038.9 6066.0 6068.4 6075.5 5767.7 5790.9 5805.1 5808.9 5823.5 5812.3 5814.1 5815.5 5816.7 5821.5 5642.0 5648.0 5738.4 5756.2 5756.9 5830.4 5849.2 5870.4 5871.4 5875.0 5487.6 5650.0 5677.8 5693.8 5722.2 10:45:17 INFO - PID 3608 | 10:45:17 INFO - PID 3608 | [#5] yui.html Cycles:180 Average:15393.86 Median:3380.94 stddev:17897.08 (529.4%) stddev-sans-first:17913.04 10:45:17 INFO - PID 3608 | Values: 652.7 663.2 727.1 764.0 780.3 11434.9 11782.8 12104.2 12291.3 12392.1 14923.5 15285.6 15315.2 15317.2 15399.8 881.8 908.7 908.8 909.7 911.2 906.0 910.2 910.8 910.8 917.4 958.2 959.3 962.1 964.2 966.6 956.4 957.3 960.0 962.6 964.6 706.2 706.5 706.8 707.1 709.5 13603.8 13815.2 14091.3 14304.8 14493.3 15338.2 15366.6 15503.9 15657.1 16154.8 12632.1 12709.7 12856.7 12910.3 12973.3 3060.5 3061.1 3084.3 3085.1 3102.1 70909.3 71602.6 71837.0 73225.0 74463.0 12738.7 12808.7 12831.0 12833.1 12834.2 21789.6 22831.2 22967.0 22995.2 23077.0 6152.1 6370.9 6398.2 6403.7 6425.3 2496.3 2544.8 2546.3 2546.5 2562.1 3659.8 3728.5 3732.7 3843.8 3941.7 771.8 778.3 790.2 792.0 792.6 610.8 613.5 621.1 624.0 641.0 9731.0 9916.8 10353.1 10376.2 11049.6 606.5 612.3 616.2 625.3 632.2 4363.6 4616.3 4772.4 4784.0 4997.2 60311.4 60709.4 60884.4 63923.7 64055.7 49772.0 50783.5 51446.7 53269.2 55108.0 47198.8 47600.0 48437.5 48622.3 49360.3 10321.2 11289.1 11403.3 11426.2 11537.8 25071.5 25247.7 25306.6 25552.0 25608.5 42753.6 42782.0 43273.0 43424.0 44420.3 13857.4 13964.0 14353.6 14477.0 14486.6 15623.9 15910.6 16351.3 16414.7 16671.2 14128.6 14422.0 14606.6 14742.6 14930.6 14685.3 14705.3 15008.8 15261.7 15605.4 13478.9 13505.6 13753.0 13864.7 14670.3 9331.1 9675.9 10569.7 10587.5 11080.3 11862.3 12106.2 12396.4 12399.5 12461.8 10:45:17 INFO - PID 3608 | -------- Summary: end -------- 10:45:17 INFO - PID 3608 | 10:45:18 INFO - TEST-INFO | 3608: exit 0 10:45:18 INFO - TEST-OK | dromaeo_css | took 1124513ms 10:45:18 INFO - TEST-START | kraken 10:45:18 INFO - operating with platform_type : linux_ 10:45:18 INFO - Initialising browser for kraken test... 10:45:18 INFO - TEST-INFO | started process 4025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprmzwaX/profile http://localhost:33135/getInfo.html) 10:45:18 INFO - PID 4025 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2970: String.localeCompare is deprecated; use String.prototype.localeCompare instead 10:45:22 INFO - PID 4025 | __metrics Screen width/height:1600/1200 10:45:22 INFO - PID 4025 | colorDepth:24 10:45:22 INFO - PID 4025 | Browser inner width/height: 1024/695 10:45:22 INFO - PID 4025 | __metrics 10:45:25 INFO - TEST-INFO | 4025: exit 0 10:45:25 INFO - Browser initialized. 10:45:25 INFO - Running cycle 1/1 for kraken test... 10:45:25 INFO - TEST-INFO | started process 4207 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprmzwaX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:45:36 INFO - PID 4207 | RSS: Main: 170733568 10:45:36 INFO - PID 4207 | 10:45:39 INFO - PID 4207 | Cycle 1(1): loaded http://localhost:33135/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33135/tests/kraken/driver.html?testName=audio-beat-detection) 10:45:40 INFO - PID 4207 | RSS: Main: 174055424 10:45:40 INFO - PID 4207 | 10:45:43 INFO - PID 4207 | Cycle 1(1): loaded http://localhost:33135/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33135/tests/kraken/driver.html?testName=audio-dft) 10:45:43 INFO - PID 4207 | RSS: Main: 173318144 10:45:43 INFO - PID 4207 | 10:45:46 INFO - PID 4207 | Cycle 1(1): loaded http://localhost:33135/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33135/tests/kraken/driver.html?testName=audio-fft) 10:45:47 INFO - PID 4207 | RSS: Main: 169918464 10:45:47 INFO - PID 4207 | 10:45:49 INFO - PID 4207 | Cycle 1(1): loaded http://localhost:33135/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33135/tests/kraken/driver.html?testName=audio-oscillator) 10:45:50 INFO - PID 4207 | RSS: Main: 170618880 10:45:50 INFO - PID 4207 | 10:45:52 INFO - PID 4207 | Cycle 1(1): loaded http://localhost:33135/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33135/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:45:52 INFO - PID 4207 | RSS: Main: 170799104 10:45:52 INFO - PID 4207 | 10:45:56 INFO - PID 4207 | Cycle 1(1): loaded http://localhost:33135/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33135/tests/kraken/driver.html?testName=imaging-darkroom) 10:45:56 INFO - PID 4207 | RSS: Main: 174698496 10:45:56 INFO - PID 4207 | 10:46:00 INFO - PID 4207 | Cycle 1(1): loaded http://localhost:33135/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33135/tests/kraken/driver.html?testName=imaging-desaturate) 10:46:00 INFO - PID 4207 | RSS: Main: 172593152 10:46:00 INFO - PID 4207 | 10:46:03 INFO - PID 4207 | Cycle 1(1): loaded http://localhost:33135/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33135/tests/kraken/driver.html?testName=json-parse-financial) 10:46:04 INFO - PID 4207 | RSS: Main: 173715456 10:46:04 INFO - PID 4207 | 10:46:05 INFO - PID 4207 | Cycle 1(1): loaded http://localhost:33135/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33135/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:46:06 INFO - PID 4207 | RSS: Main: 173756416 10:46:06 INFO - PID 4207 | 10:46:08 INFO - PID 4207 | Cycle 1(1): loaded http://localhost:33135/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33135/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:46:09 INFO - PID 4207 | RSS: Main: 173674496 10:46:09 INFO - PID 4207 | 10:46:11 INFO - PID 4207 | Cycle 1(1): loaded http://localhost:33135/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33135/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:46:11 INFO - PID 4207 | RSS: Main: 173400064 10:46:11 INFO - PID 4207 | 10:46:14 INFO - PID 4207 | Cycle 1(1): loaded http://localhost:33135/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33135/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:46:15 INFO - PID 4207 | RSS: Main: 173461504 10:46:15 INFO - PID 4207 | 10:46:18 INFO - PID 4207 | Cycle 1(1): loaded http://localhost:33135/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33135/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:46:19 INFO - PID 4207 | RSS: Main: 173101056 10:46:19 INFO - PID 4207 | 10:46:20 INFO - PID 4207 | Cycle 1(1): loaded http://localhost:33135/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33135/tests/kraken/driver.html?testName=ai-astar) 10:46:21 INFO - PID 4207 | RSS: Main: 174911488 10:46:21 INFO - PID 4207 | 10:46:21 INFO - PID 4207 | __start_tp_report 10:46:21 INFO - PID 4207 | _x_x_mozilla_page_load 10:46:21 INFO - PID 4207 | _x_x_mozilla_page_load_details 10:46:21 INFO - PID 4207 | |i|pagename|runs| 10:46:21 INFO - PID 4207 | |0;ai-astar;105;112;112;112;111;126;112;115;112;113 10:46:21 INFO - PID 4207 | |1;audio-beat-detection;149;126;123;169;124;125;127;126;145;128 10:46:21 INFO - PID 4207 | |2;audio-dft;165;164;163;164;164;164;169;164;165;161 10:46:21 INFO - PID 4207 | |3;audio-fft;75;76;75;120;75;76;76;75;99;77 10:46:21 INFO - PID 4207 | |4;audio-oscillator;83;84;118;84;83;83;97;84;83;104 10:46:21 INFO - PID 4207 | |5;imaging-gaussian-blur;118;115;114;117;115;117;114;114;117;114 10:46:21 INFO - PID 4207 | |6;imaging-darkroom;149;150;151;149;151;150;150;150;150;149 10:46:21 INFO - PID 4207 | |7;imaging-desaturate;94;95;94;97;95;95;95;96;94;95 10:46:21 INFO - PID 4207 | |8;json-parse-financial;56;53;54;57;63;54;54;54;57;55 10:46:21 INFO - PID 4207 | |9;json-stringify-tinderbox;56;56;56;57;57;57;58;56;56;59 10:46:21 INFO - PID 4207 | |10;stanford-crypto-aes;81;81;82;83;90;92;85;82;83;83 10:46:21 INFO - PID 4207 | |11;stanford-crypto-ccm;133;131;145;139;132;132;133;137;177;135 10:46:21 INFO - PID 4207 | |12;stanford-crypto-pbkdf2;195;203;186;203;203;199;194;196;196;197 10:46:21 INFO - PID 4207 | |13;stanford-crypto-sha256-iterative;74;76;73;74;75;73;74;77;77;73 10:46:21 INFO - PID 4207 | __end_tp_report 10:46:21 INFO - PID 4207 | __start_cc_report 10:46:21 INFO - PID 4207 | _x_x_mozilla_cycle_collect,768 10:46:21 INFO - PID 4207 | __end_cc_report 10:46:21 INFO - PID 4207 | __startTimestamp1495302381231__endTimestamp 10:46:21 INFO - PID 4207 | 10:46:21 INFO - PID 4207 | ------- Summary: start ------- 10:46:21 INFO - PID 4207 | Number of tests: 14 10:46:21 INFO - PID 4207 | 10:46:21 INFO - PID 4207 | [#0] ai-astar Cycles:10 Average:113.00 Median:112.00 stddev:5.23 (4.7%) stddev-sans-first:4.68 10:46:21 INFO - PID 4207 | Values: 105.0 112.0 112.0 112.0 111.0 126.0 112.0 115.0 112.0 113.0 10:46:21 INFO - PID 4207 | 10:46:21 INFO - PID 4207 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:127.50 stddev:15.22 (11.9%) stddev-sans-first:15.17 10:46:21 INFO - PID 4207 | Values: 149.0 126.0 123.0 169.0 124.0 125.0 127.0 126.0 145.0 128.0 10:46:21 INFO - PID 4207 | 10:46:21 INFO - PID 4207 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:2.00 (1.2%) stddev-sans-first:2.11 10:46:21 INFO - PID 4207 | Values: 165.0 164.0 163.0 164.0 164.0 164.0 169.0 164.0 165.0 161.0 10:46:21 INFO - PID 4207 | 10:46:21 INFO - PID 4207 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.00 stddev:15.13 (19.9%) stddev-sans-first:15.81 10:46:21 INFO - PID 4207 | Values: 75.0 76.0 75.0 120.0 75.0 76.0 76.0 75.0 99.0 77.0 10:46:21 INFO - PID 4207 | 10:46:21 INFO - PID 4207 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:83.50 stddev:12.17 (14.6%) stddev-sans-first:12.61 10:46:21 INFO - PID 4207 | Values: 83.0 84.0 118.0 84.0 83.0 83.0 97.0 84.0 83.0 104.0 10:46:21 INFO - PID 4207 | 10:46:21 INFO - PID 4207 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:116.00 stddev:1.58 (1.4%) stddev-sans-first:1.39 10:46:21 INFO - PID 4207 | Values: 118.0 115.0 114.0 117.0 115.0 117.0 114.0 114.0 117.0 114.0 10:46:21 INFO - PID 4207 | 10:46:21 INFO - PID 4207 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:150.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 10:46:21 INFO - PID 4207 | Values: 149.0 150.0 151.0 149.0 151.0 150.0 150.0 150.0 150.0 149.0 10:46:21 INFO - PID 4207 | 10:46:21 INFO - PID 4207 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.94 (1.0%) stddev-sans-first:0.93 10:46:21 INFO - PID 4207 | Values: 94.0 95.0 94.0 97.0 95.0 95.0 95.0 96.0 94.0 95.0 10:46:21 INFO - PID 4207 | 10:46:21 INFO - PID 4207 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.50 stddev:2.91 (5.2%) stddev-sans-first:3.08 10:46:21 INFO - PID 4207 | Values: 56.0 53.0 54.0 57.0 63.0 54.0 54.0 54.0 57.0 55.0 10:46:21 INFO - PID 4207 | 10:46:21 INFO - PID 4207 | [#9] json-stringify-tinderbox Cycles:10 Average:56.80 Median:57.00 stddev:1.03 (1.8%) stddev-sans-first:1.05 10:46:21 INFO - PID 4207 | Values: 56.0 56.0 56.0 57.0 57.0 57.0 58.0 56.0 56.0 59.0 10:46:21 INFO - PID 4207 | 10:46:21 INFO - PID 4207 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:83.00 stddev:3.79 (4.6%) stddev-sans-first:3.84 10:46:21 INFO - PID 4207 | Values: 81.0 81.0 82.0 83.0 90.0 92.0 85.0 82.0 83.0 83.0 10:46:21 INFO - PID 4207 | 10:46:21 INFO - PID 4207 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:136.00 stddev:13.87 (10.2%) stddev-sans-first:14.52 10:46:21 INFO - PID 4207 | Values: 133.0 131.0 145.0 139.0 132.0 132.0 133.0 137.0 177.0 135.0 10:46:21 INFO - PID 4207 | 10:46:21 INFO - PID 4207 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.20 Median:198.00 stddev:5.25 (2.6%) stddev-sans-first:5.50 10:46:21 INFO - PID 4207 | Values: 195.0 203.0 186.0 203.0 203.0 199.0 194.0 196.0 196.0 197.0 10:46:21 INFO - PID 4207 | 10:46:21 INFO - PID 4207 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:74.50 stddev:1.58 (2.1%) stddev-sans-first:1.66 10:46:21 INFO - PID 4207 | Values: 74.0 76.0 73.0 74.0 75.0 73.0 74.0 77.0 77.0 73.0 10:46:21 INFO - PID 4207 | -------- Summary: end -------- 10:46:21 INFO - PID 4207 | 10:46:22 INFO - TEST-INFO | 4207: exit 0 10:46:22 INFO - TEST-OK | kraken | took 64439ms 10:46:22 INFO - SUITE-END | took 1188s 10:46:22 INFO - Completed test suite (00:19:49) 10:46:22 INFO - javascript benchmark 10:46:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6650.504579417696, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2677.8527181005043, 2719.9728002719967, 2725.4140359822636, 2756.2282560882945, 2758.5448401013823, 5146.382434107913, 5217.817376391827, 5240.29256050434, 5277.8944421111555, 5297.337832770903, 5219.269302297672, 5234.26720259164, 5242.030224408487, 5252.3697156341195, 5292.470752924715, 4624.653151013687, 4631.120087183424, 4660.044690838387, 4670.976645116787, 4725.6928299660585, 4681.578657920786, 4729.030548737501, 4731.0, 4742.359781429497, 4752.738599377033, 4573.931391029138, 4592.678512504126, 4661.277501987197, 4663.044075964419, 4686.297055441711, 4628.722276663411, 4636.83771068011, 4652.604528615072, 4678.157931572316, 4679.461861885893, 4563.292689633112, 4611.216093264153, 4612.907741845178, 4633.791479383436, 4658.767061646904, 5083.262926875619, 5136.203888397267, 5137.101007323741, 5141.717205553693, 5192.039472697563, 5644.717764111778, 5674.035413979634, 5674.914876276859, 5707.086866101404, 5729.713514324267, 5666.235058267122, 5677.261955945742, 5690.118031705092, 5693.117566777115, 5706.657600543981, 5147.459516750762, 5224.52979231871, 5249.895002100013, 5294.54996325309, 5297.496737809902, 5693.829185124453, 5706.942930570641, 5722.856928576735, 5753.165790960287, 5761.9135712964335, 5452.59105567084, 5456.0, 5457.372402173722, 5458.0, 5461.508464238238, 5552.028395030853, 5556.083246264402, 5629.0, 5644.181593668977, 5704.286964129484, 5643.266375371176, 5644.463775941279, 5648.85877853057, 5663.433656634304, 5695.117256825199, 5622.775088996476, 5639.661620302713, 5654.208410822406, 5654.575906807006, 5658.094704847287, 4626.976865115653, 4669.276262179367, 4693.7653117344, 4706.176419126639, 4762.666613337103, 4018.7588744675413, 4044.8179831907637, 4046.858359957387, 4088.5298190707854, 4123.8969025773995, 4737.360456338419, 4737.692050016738, 4737.857864264078, 4738.336632871401, 4785.784639691222, 5507.339119305709, 5536.446355364431, 5554.861128471821, 5555.083411237181, 5621.494065534122, 4675.08835777027, 4712.9057418851435, 4712.929306060412, 4712.976435117871, 4764.928526072112, 4956.10790057793, 4963.8262660806695, 4980.078685443204, 5006.6245031622775, 5052.242163675478, 5199.142141546602, 5244.76398562058, 5269.235960785588, 5275.630705850554, 5287.444818294024, 5606.299212598426, 5621.381648018796, 5722.4277572242445, 5722.885542289214, 5737.196792449144, 5228.843134705965, 5231.581473482036, 5233.528982391603, 5235.4502777207845, 5239.44985776488, 5482.068048431696, 5501.697406642513, 5504.339479262514, 5511.696856672921, 5557.44425557441, 5561.6663000220115, 5592.972035139798, 5654.6889921054735, 5676.262085928803, 5676.914846277392, 5479.808206712746, 5485.204645326485, 5487.0, 5498.725063746717, 5524.889502209853, 5366.168243922199, 5425.267588875609, 5490.368607610017, 5490.478404551562, 5512.062949298709, 5323.547498462674, 5373.086575282133, 5407.810726624549, 5421.457854214547, 5427.83716488506, 5437.34751829783, 5444.428335024765, 5453.072977593739, 5477.233187353853, 5500.4499550044675, 5296.708681022426, 5297.788088476418, 5301.284326615858, 5310.283111780015, 5321.0], "value": 5094.788262543347, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.8572299817038, 730.3572855886819, 741.9925800741993, 1038.7818558102804, 1052.7841792432553, 32507.0, 33427.66572334276, 33515.66484335159, 33516.329673406515, 33547.329053418915, 34604.1348966276, 34876.558640895084, 34887.302253954906, 34960.12599685009, 35053.123671908215, 6760.188777346725, 6853.177618685765, 6966.512344135913, 6979.546329488592, 6982.301769823002, 6936.34104760047, 7019.7543085992, 7048.36564709176, 7049.436045116378, 7054.929450705478, 6980.9650951745425, 7006.789796306119, 7059.823504412379, 7060.223375428699, 7088.3620474157315, 6954.513184077116, 6981.82545436363, 6999.615021173833, 7027.402670772939, 7028.086348774652, 6782.355676210752, 6827.795166145023, 6901.068355771957, 6903.240643529258, 6904.516683832134, 31778.205544861332, 31839.84080079608, 31932.20169495758, 31982.20044498883, 32051.83974080138, 3056.8930087446834, 3079.461094308487, 3086.6913308669177, 3095.922601934947, 3108.98445507771, 24725.010999559996, 24820.50358992828, 24838.130665426623, 24838.254852354457, 24905.377365565826, 3014.502607069831, 3033.620797400325, 3060.6786287439945, 3066.1721335239586, 3083.1521331633758, 146874.0, 147109.26445367705, 153878.0, 158565.20717396453, 159356.0, 39112.80443597764, 39183.804080979986, 39363.2127357457, 39366.21267574633, 39380.80309598491, 40218.798906005286, 40786.0, 40790.79604602017, 40798.18403631911, 40871.0, 11395.373254470918, 11568.537258509565, 11590.13074019452, 11599.362035088152, 11607.709807254887, 9411.952940235393, 9455.149036586603, 9517.333786635008, 9523.761905952268, 9564.856527152098, 12415.130940834055, 12460.252384856938, 12466.937665311796, 12495.938170201996, 12694.238345699288, 5301.522862942354, 5301.840944771663, 5349.545288650508, 5353.7590808413715, 5446.591505637014, 869.3436455476201, 905.3300557587338, 908.2189317187214, 915.6337465013914, 936.7939053408239, 20714.792852071587, 21410.0, 21410.464738381666, 21451.141954321964, 21786.237481688066, 974.7124598243394, 987.8123156600223, 1006.1548299428368, 1007.5415685862915, 1009.2077718990557, 10946.616868409727, 11128.944355278334, 11248.775024499464, 11263.887361126284, 11317.264377815416, 173947.0, 175257.0, 176320.0, 176837.11581442266, 177380.0, 40030.799846000584, 40307.395389069185, 40333.77329813608, 40348.0, 40422.79788601038, 1197.485081415, 1229.059769276522, 1247.1768632702374, 1248.17620370555, 1255.428779905141, 20134.0, 20140.0, 20917.790822091585, 21061.0, 21241.256556020464, 28838.567421488275, 28902.132936011953, 28931.276718082216, 28987.5651865218, 29111.0, 146300.0, 146881.26559367136, 147029.0, 147182.0, 147946.26026869798, 28390.290242744097, 28420.147395578166, 28507.144785656463, 28871.133865984055, 28911.0, 34858.12854678653, 35160.47259291061, 35267.0, 35593.0, 35969.0, 26889.0, 27186.72813271842, 27537.31156721098, 27925.720742793124, 28507.714922851337, 26461.0, 26513.469730604895, 26966.0, 27734.0, 28154.29614259578, 30178.0, 30199.547006794477, 30319.93880214182, 30486.84756576203, 30489.0, 25538.233852984442, 26523.734762652126, 26557.867210663822, 26974.730252697223, 27217.591736123577, 21262.893685531475, 22454.775452245267, 22459.32622021342, 22463.887680561493, 22494.775052249923], "value": 14392.748374168215, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.69319317318826, 403.8586494726846, 419.4463308432869, 427.98288068477245, 431.70212553338195, 13676.863231367683, 17236.48290551284, 17495.212715427806, 17966.640667186664, 17986.100694965266, 17990.370337038206, 18214.180361883715, 18290.359837405693, 18329.17518711658, 18371.081445927717, 5166.147585648373, 5258.263843061955, 5341.545968592655, 5362.088444964365, 5445.128779395298, 5231.973840130794, 5305.840824775243, 5324.0, 5329.280547126146, 5369.677819330833, 5146.228065790143, 5257.185136303879, 5276.8153114641, 5302.310699609065, 5315.176147697113, 5261.552768014704, 5300.575953923677, 5308.601854860901, 5320.707361095138, 5326.866828329284, 4700.858974230779, 4794.664373493857, 4797.832075877328, 4832.0, 4868.902621947576, 21416.571668566543, 21634.350969470943, 21750.129994800347, 21816.672749908765, 21832.563348733096, 1639.3770367260483, 1655.0, 1659.3860271699427, 1662.036019108914, 1669.0486422739043, 13406.262655553941, 13889.861101389059, 14148.787768183485, 14230.217338046403, 14427.78358324626, 2036.0939381975027, 2067.7208576842086, 2076.885771282579, 2083.4895450614545, 2097.475631092227, 87528.56235718845, 87978.5601071997, 88154.5592272041, 89071.55464222703, 94098.52950735271, 10460.163186945027, 10709.732256693645, 10821.296615719953, 10898.237123401286, 10933.070688991365, 14726.92636536832, 14831.629209269855, 14931.92534037323, 14932.925335373471, 14981.850181498263, 7407.481476296715, 7439.925600744032, 7606.315431611071, 7673.654685539164, 7744.845103097907, 6864.38220560152, 6928.480363972722, 7113.253108423541, 7185.0, 7202.891956620655, 6807.829804254933, 6908.378245957888, 6950.826229344307, 6962.164540255202, 6986.860262794716, 2058.5677007828226, 2075.29439990404, 2077.511784730587, 2087.102545905245, 2222.055626358791, 845.1379592815294, 850.0946491986015, 857.5540718826176, 884.8058508783287, 897.1387468030764, 16444.6711065778, 16766.0, 16810.41163559294, 17008.829911700974, 17116.572085697957, 880.2561835249204, 881.5900606218139, 882.1751662195867, 892.1881088209698, 897.717219075989, 8790.736277911672, 8875.689350872688, 9202.35583509148, 9353.111454411955, 9354.438733675865, 369763.0, 377140.0, 382881.0, 384350.0, 386793.0, 78113.0, 82041.58979205065, 82095.0, 82315.0, 82534.58732706418, 1063.2238465919922, 1078.6332646900091, 1110.8500352452477, 1120.0703416164563, 1121.7195701074731, 16721.832781672027, 17032.318707251572, 17441.56396090108, 17539.56151096233, 17827.10864456798, 38766.0, 39248.80375598104, 39969.40045899372, 40343.79828100841, 40369.1926161481, 49170.0, 49193.0, 51701.0, 52152.47847521476, 52210.47789522208, 7821.726239581587, 8025.23760242776, 8162.428629995843, 8295.751127466187, 8350.164983501601, 12774.297413642338, 12940.611781646188, 12977.870221298044, 13355.131916425402, 13371.130876492996, 10906.182036347147, 11134.721631958942, 11140.387278699749, 11289.0, 11313.434328283718, 9774.85337719949, 10554.630587929385, 10590.682279531626, 10647.627333043616, 10665.680029598814, 10770.892291077302, 10834.0, 10851.131909447384, 10897.782044359226, 11270.718232043937, 8276.234313387515, 8302.335813135056, 8312.792180195544, 8414.3268538518, 8461.95769021151, 10704.464776760975, 10724.8927510727, 10728.678139655824, 11083.556657733601, 11218.663440096483], "value": 8795.257510242165, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1249.1942696960461, 1284.8393950756158, 1289.284447131842, 1294.9999999999993, 1296.6693493159255, 9472.726545629052, 9970.401775893442, 9984.001599840003, 9998.300118991674, 10168.69493915182, 9911.653092141776, 10061.295709300352, 10067.49662516875, 10068.748281292954, 10075.395476271411, 2234.3967128875192, 2257.571061498318, 2259.7966183043523, 2262.694536237603, 2272.7045484087043, 2168.230278251222, 2216.7007453993747, 2219.611567975606, 2220.877851718155, 2224.5662095891307, 2227.6435770276757, 2228.92198773043, 2268.6370180771078, 2269.103704036913, 2273.920412785553, 2135.8504904656525, 2178.9782102178933, 2215.1693115081925, 2231.141010710872, 2232.787885150908, 2122.0, 2157.0508976050487, 2181.345596321113, 2190.2224710227797, 2261.0, 9613.711588652352, 9666.323357364987, 9668.903310966942, 9718.465484398355, 9736.172425343784, 5264.947350526484, 5452.236686863842, 5459.372172200208, 5478.890422191534, 5481.643693159972, 3125.7811953163286, 3365.848536815825, 3367.44437167867, 3383.3928883780254, 3396.626371099177, 1066.4188017530387, 1100.4277775556745, 1117.8155604325277, 1140.3841925360377, 1145.3357052909294, 13877.444902203899, 14007.929960350235, 14047.438102475991, 14086.225257610828, 14097.224652644101, 4392.978035109868, 4517.593416592456, 4705.12955103307, 4748.240281554935, 4778.068276686083, 9838.0, 9865.309428340091, 9902.207823374112, 9944.701658950244, 9944.950275248577, 5398.163284690879, 5403.13549832025, 5410.269613602113, 5423.267858839006, 5433.8369848904595, 4812.446568644651, 5078.5175408336145, 5094.439611642716, 5097.439281679012, 5138.3577052868395, 3585.659362360572, 3656.8537258509896, 3683.686886614668, 3708.5364329458816, 3767.1335592813807, 1009.5759780892043, 1018.0786388318584, 1021.4841505039907, 1031.118393773328, 1031.1235449867702, 681.8534015186659, 700.0968750312143, 703.96480175991, 720.1250480665911, 722.9457790665721, 5042.621803364762, 5174.24973378858, 5218.243354713622, 5327.9733601331745, 5374.623776335619, 559.535585464072, 560.2660514725723, 563.7181409295353, 569.7151424287856, 574.8821491594213, 3440.8795692151157, 3693.4829123922673, 3738.0841693785196, 3779.168582911755, 3866.0141663875534, 11960.10299227544, 12460.501579936883, 12488.937555312164, 12613.558525451564, 12638.810417843739, 12172.452239649238, 12446.502139914483, 12522.81215781764, 12628.989680825513, 12637.873621263854, 7004.929950700428, 7027.7188912442925, 7083.220845706968, 7086.681099350541, 7129.3583577478275, 5467.343918729619, 5467.480589344006, 5477.917831232615, 5542.251796007648, 5582.385937546947, 11077.778444430905, 11206.366503871746, 11246.718832028937, 11409.543618255177, 11458.369789661316, 11089.889101108885, 11614.767704646029, 11623.6512904613, 11666.0, 11673.533058677898, 6886.070380498569, 6909.7581584644295, 6915.308469153246, 6986.720531178696, 6986.790396288119, 9062.50156241413, 9088.818223635622, 9091.181793638605, 9176.770580735534, 9217.585208665492, 7792.376609871083, 7945.48354356965, 7958.880616790637, 7973.960130199312, 8009.3192078673965, 7752.534847908918, 7780.961095194488, 7803.648835802289, 7927.881081783893, 8061.798455038671, 6956.200036995608, 7059.894101588583, 7063.752768653072, 7077.823054423475, 7099.716011359487, 4350.891227719332, 4657.906841863211, 4759.928601071056, 4762.190427627243, 4895.73073480962, 5237.397699264633, 5298.523132918056, 5314.3091398117995, 5343.492368225013, 5367.1680889462195], "value": 4516.756348526434, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.4918744851345, 368.43629247251704, 372.43204113726546, 374.9381352076907, 377.2605692842028, 5466.753996070176, 5514.36584792749, 5532.1425179097205, 5580.581456390777, 5594.608377413578, 5453.263809385731, 5466.262054622624, 5473.480019398151, 5477.068898287291, 5495.53287970522, 3967.1272320089533, 4049.2711311963835, 4241.427407300013, 4244.533101358848, 4250.723702959313, 4045.4336392905016, 4046.9595304046875, 4064.4919385076864, 4073.8593193905754, 4080.7143499955014, 4035.8385664573384, 4040.1111755413763, 4043.919121617566, 4050.291199040171, 4050.6354428101463, 3982.561918188997, 4032.5885939921086, 4038.1318016626565, 4044.150728347036, 4045.3616285404605, 3488.337215928965, 3488.720902327833, 3502.8773992910383, 3503.4219353806593, 3518.2084031093054, 5317.680939143664, 5322.175062865262, 5325.760340784674, 5333.733313334356, 5350.565492700812, 4735.360726301974, 4739.364919102904, 4740.696308515151, 4753.550167199003, 4763.76181190939, 5600.411956744565, 5712.80005199816, 5743.0811070228565, 5752.539796816286, 5768.538516918637, 3881.146147847469, 3902.9219415611815, 3904.9609503905167, 3914.5106861642294, 3915.5105611798526, 5894.2926848778425, 6038.245219347537, 6067.302260240085, 6111.54163437744, 6139.785107521216, 3953.940690889639, 3954.6638535724787, 3961.1285517186175, 3969.8884312391997, 3973.7615743055508, 3993.800309984489, 4001.919961600752, 4002.0195052212393, 4027.0, 4028.637422631977, 4573.81704731807, 4695.647826413033, 4702.882427939329, 4710.52894710533, 4716.551927566876, 5748.626339287933, 5754.223179870748, 5763.9135412968835, 5774.047282198474, 5782.7686892523825, 1393.212834748364, 1403.8385585657577, 1407.774756039029, 1408.2747385096684, 1418.9432422702976, 886.601029536711, 932.4917919733762, 936.1106948399048, 949.6106596295485, 951.7477868364889, 4977.850664480072, 4991.775370108281, 4997.0, 4999.450060493343, 5003.399592048978, 5935.198748168942, 5961.165436838846, 5963.642181469126, 5993.700314984233, 6002.849928751816, 4850.1269771440775, 4922.901541969212, 4981.950180498221, 4984.327115839315, 4989.650724449326, 3140.120766185472, 3162.0, 3164.47786115293, 3175.777695561335, 3179.713825755693, 5462.562994960473, 5567.717235933248, 5569.192467092249, 5572.777088916479, 5574.581906356958, 6058.909116363258, 6096.896570683107, 6125.509959203253, 6131.080337949344, 6151.72317245725, 5530.976769297693, 5550.861228469321, 5563.944360556424, 5569.693666848281, 5570.637908535932, 5712.400197979152, 5941.554383421347, 5960.552958528041, 5973.641581505123, 5981.611195272293, 5843.474087332161, 5914.792982245601, 5925.140854576149, 5925.40745925404, 5930.555208359477, 5426.403095659553, 5531.3362396512675, 5542.256582991445, 5553.139263414178, 5601.159826026129, 3958.129211573449, 3959.1685745992513, 3968.861089861841, 3979.7861652196357, 3991.7006224532697, 5959.76160953557, 6038.909416358671, 6066.0, 6068.423499767515, 6075.453209211192, 5767.740451679769, 5790.855228619318, 5805.129230615442, 5808.941910581009, 5823.475887170175, 5812.331581868139, 5814.069748840166, 5815.534757219328, 5816.738246778989, 5821.5258515131745, 5641.971790141023, 5647.983362994701, 5738.426157384228, 5756.1941328214925, 5756.884862302814, 5830.358660547252, 5849.210356601804, 5870.442307980735, 5871.383504731942, 5875.036837609744, 5487.588430867621, 5649.971750141223, 5677.801276955287, 5693.829185124453, 5722.227499287543], "value": 4279.071144228852, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.6769249221636, 663.1975309875054, 727.0548287226604, 763.9541627502349, 780.328917131267, 11434.885651143486, 11782.823257651142, 12104.152709310352, 12291.262524248552, 12392.132550721453, 14923.477678281262, 15285.617859553517, 15315.157666328347, 15317.157556334398, 15399.846001539981, 881.7839629290817, 908.6637943960744, 908.7637214324258, 909.6543313540878, 911.1890417528372, 906.0441234497603, 910.2354022620997, 910.8087301666658, 910.8314961732101, 917.3807679816131, 958.1711819276345, 959.3092973059386, 962.129273007929, 964.2237998411276, 966.5891995901749, 956.4022485946283, 957.3107362698846, 960.0207788056143, 962.5668449197854, 964.599691128181, 706.1702499563045, 706.4701473894579, 706.8162277807755, 707.056080133023, 709.5068927095671, 13603.795943060863, 13815.240161791098, 14091.295435228198, 14304.785428218585, 14493.275336233146, 15338.233088345649, 15366.615834604112, 15503.922480387526, 15657.06057636534, 16154.757678634829, 12632.11575189737, 12709.682257943532, 12856.742865142738, 12910.289934053624, 12973.286469244187, 3060.464418726714, 3061.0510741670155, 3084.259777653347, 3085.1053194573547, 3102.053873568561, 70909.29090709079, 71602.64198678973, 71837.0, 73225.0, 74463.0, 12738.68153296175, 12808.6797830055, 12831.037672174623, 12833.101682882108, 12834.229946203257, 21789.564208716052, 22831.200907968472, 22967.0, 22995.195168169033, 23077.0, 6152.138700581922, 6370.936290637127, 6398.232212134573, 6403.679816009274, 6425.293217746044, 2496.288557761066, 2544.770970612654, 2546.299767563935, 2546.452512709739, 2562.1288761820697, 3659.817009149585, 3728.5339332583426, 3732.701383889282, 3843.7693738375788, 3941.7043721720984, 771.8263390737152, 778.3345239819986, 790.2255789326492, 792.0, 792.6195426195459, 610.7923306075955, 613.4632196827775, 621.1459243540132, 623.9656818875005, 641.0160403780175, 9731.026897310212, 9916.801663966824, 10353.119984801377, 10376.16990640747, 11049.558017679203, 606.4875180472494, 612.317266248139, 616.1743264026137, 625.3059104394118, 632.2065807411669, 4363.6072753452345, 4616.261398176276, 4772.427308722906, 4783.976080119647, 4997.200447928387, 60311.396886031456, 60709.392906070374, 60884.39115608876, 63923.68038159779, 64055.6797216011, 49772.0, 50783.49216507861, 51446.742766285926, 53269.2009619856, 55108.0, 47198.764006180434, 47600.0, 48437.5156248433, 48622.27066594004, 49360.25959610609, 10321.225908057077, 11289.096872250037, 11403.315801051964, 11426.2001659883, 11537.82693259585, 25071.498570028863, 25247.747522525275, 25306.620400694374, 25552.0, 25608.487830243663, 42753.572464274956, 42782.0, 43273.0, 43424.0, 44420.33369499525, 13857.445702172203, 13964.0, 14353.64115897111, 14477.0, 14486.637834054232, 15623.921880390526, 15910.60223494422, 16351.34594616202, 16414.67170656604, 16671.24979375955, 14128.646783830487, 14422.0, 14606.561803145923, 14742.557723268319, 14930.552083437515, 14685.339159737623, 14705.264736762905, 15008.774868376764, 15261.694766104394, 15605.375784968473, 13478.94039998807, 13505.594832155051, 13753.0, 13864.653383665489, 14670.26648667541, 9331.113544213289, 9675.854862176931, 10569.682909512727, 10587.4706264688, 11080.335179889233, 11862.347570883685, 12106.213096148722, 12396.442160102637, 12399.504019839465, 12461.813072804096], "value": 6940.6443385662515, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 112.0, 112.0, 111.0, 126.0, 112.0, 115.0, 112.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 123.0, 169.0, 124.0, 125.0, 127.0, 126.0, 145.0, 128.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 163.0, 164.0, 164.0, 164.0, 169.0, 164.0, 165.0, 161.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 120.0, 75.0, 76.0, 76.0, 75.0, 99.0, 77.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 118.0, 84.0, 83.0, 83.0, 97.0, 84.0, 83.0, 104.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 115.0, 114.0, 117.0, 115.0, 117.0, 114.0, 114.0, 117.0, 114.0], "value": 115.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 151.0, 149.0, 151.0, 150.0, 150.0, 150.0, 150.0, 149.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 97.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 54.0, 57.0, 63.0, 54.0, 54.0, 54.0, 57.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 57.0, 57.0, 57.0, 58.0, 56.0, 56.0, 59.0], "value": 56.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 82.0, 83.0, 90.0, 92.0, 85.0, 82.0, 83.0, 83.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 131.0, 145.0, 139.0, 132.0, 132.0, 133.0, 137.0, 177.0, 135.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 203.0, 186.0, 203.0, 203.0, 199.0, 194.0, 196.0, 196.0, 197.0], "value": 197.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 73.0, 74.0, 75.0, 73.0, 74.0, 77.0, 77.0, 73.0], "value": 74.6, "unit": "score"}]}]} 10:46:22 INFO - Return code: 0 10:46:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:46:23 INFO - # TBPL SUCCESS # 10:46:23 INFO - Running post-action listener: _resource_record_post_action 10:46:23 INFO - [mozharness: 2017-05-20 17:46:23.045067Z] Finished run-tests step (success) 10:46:23 INFO - Running post-run listener: _resource_record_post_run 10:46:23 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 7843840; Write bytes: 428363776; Read time: 1956; Write time: 549496 10:46:23 INFO - TinderboxPrint: CPU usage
13.3% 10:46:23 INFO - TinderboxPrint: I/O read bytes / time
7,843,840 / 1,956 10:46:23 INFO - TinderboxPrint: I/O write bytes / time
428,363,776 / 549,496 10:46:23 INFO - TinderboxPrint: CPU idle
8,339.2 (86.6%) 10:46:23 INFO - TinderboxPrint: CPU user
1,217.1 (12.6%) 10:46:23 INFO - TinderboxPrint: Swap in / out
0 / 0 10:46:23 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 105586688; Read time: 48; Write time: 163676 10:46:23 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 5492736; Write bytes: 322777088; Read time: 1428; Write time: 385820 10:46:23 INFO - Running post-run listener: _upload_blobber_files 10:46:23 INFO - Blob upload gear active. 10:46:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:46:23 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 10:46:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:46:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:46:24 INFO - (blobuploader) - INFO - Open directory for files ... 10:46:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:46:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:46:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:46:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:46:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:46:25 INFO - (blobuploader) - INFO - Done attempting. 10:46:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:46:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:46:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:46:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:46:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:46:28 INFO - (blobuploader) - INFO - Done attempting. 10:46:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:46:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:46:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:46:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:46:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:46:29 INFO - (blobuploader) - INFO - Done attempting. 10:46:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:46:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:46:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:46:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:46:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:46:30 INFO - (blobuploader) - INFO - Done attempting. 10:46:30 INFO - (blobuploader) - INFO - Iteration through files over. 10:46:30 INFO - Return code: 0 10:46:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:46:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:46:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b17f4e5c7213e52c3728e925d97dddcc3a29a5ca324421de2f51ecddbbf89710d6c2d152b3f020318303b6a7ff0310f2d345e195bbed09258ebdca4361e8e321", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d942b0a30ed29c569f408ea280f6d2f1e20b7429edeacaaf0817c2a3026f410875149ae778ed8afb98b6e10bc87c9598c5a2f8a7da4e641a8a38a6f42a9f025", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6edc84b8e27ceba40d778dc9444df797cb8ecf2f4f596288f72ace5b56a861194536ae4dd517e14f177136f8c134de26c0a214ea559f44ed3d44bb7fdb7ce29f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fc532381e214d4a6dc08c7b72b32c2161358b49a781f9c8e9d3be8be5098a620ed0602c7e7c09b7a23f9a9cff3552c312a47d1f9358415bcb04eae137abb333"} 10:46:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:46:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:46:30 INFO - Contents: 10:46:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b17f4e5c7213e52c3728e925d97dddcc3a29a5ca324421de2f51ecddbbf89710d6c2d152b3f020318303b6a7ff0310f2d345e195bbed09258ebdca4361e8e321", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d942b0a30ed29c569f408ea280f6d2f1e20b7429edeacaaf0817c2a3026f410875149ae778ed8afb98b6e10bc87c9598c5a2f8a7da4e641a8a38a6f42a9f025", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6edc84b8e27ceba40d778dc9444df797cb8ecf2f4f596288f72ace5b56a861194536ae4dd517e14f177136f8c134de26c0a214ea559f44ed3d44bb7fdb7ce29f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fc532381e214d4a6dc08c7b72b32c2161358b49a781f9c8e9d3be8be5098a620ed0602c7e7c09b7a23f9a9cff3552c312a47d1f9358415bcb04eae137abb333"} 10:46:30 INFO - Running post-run listener: copy_logs_to_upload_dir 10:46:30 INFO - Copying logs to upload dir... 10:46:30 INFO - mkdir: /builds/slave/test/build/upload/logs 10:46:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.400988 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-05-20 10:46:30.116808) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-20 10:46:30.121940) ========= 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-1495283956.76804-937299759 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/sha512/b17f4e5c7213e52c3728e925d97dddcc3a29a5ca324421de2f51ecddbbf89710d6c2d152b3f020318303b6a7ff0310f2d345e195bbed09258ebdca4361e8e321", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d942b0a30ed29c569f408ea280f6d2f1e20b7429edeacaaf0817c2a3026f410875149ae778ed8afb98b6e10bc87c9598c5a2f8a7da4e641a8a38a6f42a9f025", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6edc84b8e27ceba40d778dc9444df797cb8ecf2f4f596288f72ace5b56a861194536ae4dd517e14f177136f8c134de26c0a214ea559f44ed3d44bb7fdb7ce29f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fc532381e214d4a6dc08c7b72b32c2161358b49a781f9c8e9d3be8be5098a620ed0602c7e7c09b7a23f9a9cff3552c312a47d1f9358415bcb04eae137abb333"} build_url:https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011218 build_url: 'https://queue.taskcluster.net/v1/task/IvqqVyhhTFWiOBRJzdlIiw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b17f4e5c7213e52c3728e925d97dddcc3a29a5ca324421de2f51ecddbbf89710d6c2d152b3f020318303b6a7ff0310f2d345e195bbed09258ebdca4361e8e321", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d942b0a30ed29c569f408ea280f6d2f1e20b7429edeacaaf0817c2a3026f410875149ae778ed8afb98b6e10bc87c9598c5a2f8a7da4e641a8a38a6f42a9f025", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6edc84b8e27ceba40d778dc9444df797cb8ecf2f4f596288f72ace5b56a861194536ae4dd517e14f177136f8c134de26c0a214ea559f44ed3d44bb7fdb7ce29f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fc532381e214d4a6dc08c7b72b32c2161358b49a781f9c8e9d3be8be5098a620ed0602c7e7c09b7a23f9a9cff3552c312a47d1f9358415bcb04eae137abb333"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-20 10:46:30.146541) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-20 10:46:30.146881) ========= 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-1495283956.76804-937299759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004392 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-20 10:46:30.229263) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-20 10:46:30.232604) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-20 10:46:30.232900) ========= ========= Total master_lag: 0.31 =========