builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-035 starttime: 1494781007.89 results: success (0) revision: 626efff0df630961981fc6875571fe05725f3636 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-14 09:56:47.887757) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-14 09:56:47.888275) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-14 09:56:47.888587) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-14 09:56:47.919694) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 09:56:47.920034) ========= 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=ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-14 09:56:48-- 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% 50.2M=0s 2017-05-14 09:56:48 (50.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.153892 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 09:56:48.088784) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 09:56:48.089159) ========= 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=ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019521 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 09:56:48.143691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 09:56:48.144041) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 626efff0df630961981fc6875571fe05725f3636 --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 626efff0df630961981fc6875571fe05725f3636 --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=ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-14 09:56:48,342 truncating revision to first 12 chars 2017-05-14 09:56:48,342 Setting DEBUG logging. 2017-05-14 09:56:48,342 attempt 1/10 2017-05-14 09:56:48,342 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/626efff0df63?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-14 09:56:48,758 unpacking tar archive at: mozilla-central-626efff0df63/testing/mozharness/ program finished with exit code 0 elapsedTime=0.760702 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 09:56:48.918035) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-14 09:56:48.918382) ========= script_repo_revision: 626efff0df630961981fc6875571fe05725f3636 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-14 09:56:48.918813) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-14 09:56:48.919170) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-14 09:56:48.929300) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-14 09:56:48.929755) ========= /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=ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:56:49 INFO - MultiFileLogger online at 20170514 09:56:49 in /builds/slave/test 09:56:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:56:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:56:49 INFO - {'append_to_log': False, 09:56:49 INFO - 'base_work_dir': '/builds/slave/test', 09:56:49 INFO - 'blob_upload_branch': 'Firefox', 09:56:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:56:49 INFO - 'branch': 'Firefox', 09:56:49 INFO - 'buildbot_json_path': 'buildprops.json', 09:56:49 INFO - 'config_files': ('talos/linux_config.py',), 09:56:49 INFO - 'default_actions': ('clobber', 09:56:49 INFO - 'read-buildbot-config', 09:56:49 INFO - 'download-and-extract', 09:56:49 INFO - 'populate-webroot', 09:56:49 INFO - 'create-virtualenv', 09:56:49 INFO - 'install', 09:56:49 INFO - 'run-tests'), 09:56:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:56:49 INFO - 'download_minidump_stackwalk': True, 09:56:49 INFO - 'download_symbols': 'ondemand', 09:56:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:56:49 INFO - 'tooltool.py': '/tools/tooltool.py', 09:56:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:56:49 INFO - '/tools/misc-python/virtualenv.py')}, 09:56:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:56:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:56:49 INFO - 'gecko_profile': False, 09:56:49 INFO - 'gecko_profile_interval': 0, 09:56:49 INFO - 'installer_path': 'installer.exe', 09:56:49 INFO - 'log_level': 'info', 09:56:49 INFO - 'log_name': 'talos', 09:56:49 INFO - 'log_to_console': True, 09:56:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:56:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:56:49 INFO - 'opt_config_files': (), 09:56:49 INFO - 'pip_index': False, 09:56:49 INFO - 'suite': 'dromaeojs-e10s', 09:56:49 INFO - 'system_bits': '32', 09:56:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:56:49 INFO - 'title': 'talos-linux64-ix-035', 09:56:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:56:49 INFO - 'use_talos_json': True, 09:56:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:56:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:56:49 INFO - 'work_dir': 'build'} 09:56:49 INFO - [mozharness: 2017-05-14 16:56:49.233114Z] Running clobber step. 09:56:49 INFO - Running pre-action listener: _resource_record_pre_action 09:56:49 INFO - Running main action method: clobber 09:56:49 INFO - rmtree: /builds/slave/test/build 09:56:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:56:50 INFO - Running post-action listener: _resource_record_post_action 09:56:50 INFO - [mozharness: 2017-05-14 16:56:50.218014Z] Finished clobber step (success) 09:56:50 INFO - [mozharness: 2017-05-14 16:56:50.218115Z] Running read-buildbot-config step. 09:56:50 INFO - Running pre-action listener: _resource_record_pre_action 09:56:50 INFO - Running main action method: read_buildbot_config 09:56:50 INFO - Using buildbot properties: 09:56:50 INFO - { 09:56:50 INFO - "project": "", 09:56:50 INFO - "product": "firefox", 09:56:50 INFO - "who": "archaeopteryx@coole-files.de", 09:56:50 INFO - "installer_path": "public/build/target.tar.bz2", 09:56:50 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 09:56:50 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:56:50 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 09:56:50 INFO - "stage_platform": "linux64-stylo", 09:56:50 INFO - "basedir": "/builds/slave/test", 09:56:50 INFO - "buildnumber": 87, 09:56:50 INFO - "platform": "ubuntu64_hw_stylo", 09:56:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:56:50 INFO - "slavebuilddir": "test", 09:56:50 INFO - "taskId": "UVbILA_vTiScDxZ8thLyqA", 09:56:50 INFO - "branch": "mozilla-central", 09:56:50 INFO - "script_repo_revision": "production", 09:56:50 INFO - "revision": "626efff0df630961981fc6875571fe05725f3636", 09:56:50 INFO - "slavename": "talos-linux64-ix-035", 09:56:50 INFO - "repo_path": "mozilla-central" 09:56:50 INFO - } 09:56:50 INFO - Finding installer, test and symbols from parent task. 09:56:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UVbILA_vTiScDxZ8thLyqA'}, attempt #1 09:56:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UVbILA_vTiScDxZ8thLyqA'}, attempt #1 09:56:51 INFO - Task dependencies: WVX3sMNgSNGYmFIwYEMsEg 09:56:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WVX3sMNgSNGYmFIwYEMsEg'}, attempt #1 09:56:51 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/target.tar.bz2 09:56:51 INFO - Set test_url: https://queue.taskcluster.net/v1/task/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/test_packages.json 09:56:51 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/target.crashreporter-symbols.zip 09:56:51 INFO - Running post-action listener: _resource_record_post_action 09:56:51 INFO - [mozharness: 2017-05-14 16:56:51.554206Z] Finished read-buildbot-config step (success) 09:56:51 INFO - [mozharness: 2017-05-14 16:56:51.554427Z] Running download-and-extract step. 09:56:51 INFO - Running pre-action listener: _resource_record_pre_action 09:56:51 INFO - Running main action method: download_and_extract 09:56:51 INFO - mkdir: /builds/slave/test/build/tests 09:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:51 INFO - trying https://queue.taskcluster.net/v1/task/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/target.test_packages.json 09:56:51 INFO - Downloading https://queue.taskcluster.net/v1/task/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:56:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:56:52 INFO - Downloaded 986 bytes. 09:56:52 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:56:52 INFO - Using the following test package requirements: 09:56:52 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:56:52 INFO - u'common': [u'target.common.tests.zip'], 09:56:52 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:56:52 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:56:52 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:56:52 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:56:52 INFO - u'mozbase': [u'target.common.tests.zip'], 09:56:52 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:56:52 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:56:52 INFO - u'web-platform': [u'target.common.tests.zip', 09:56:52 INFO - u'target.web-platform.tests.zip'], 09:56:52 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:56:52 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:56:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/target.common.tests.zip 09:56:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:56:52 INFO - Fetch https://queue.taskcluster.net/v1/task/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/target.common.tests.zip into memory 09:56:55 INFO - Content-Length response header: 62448360 09:56:55 INFO - Bytes received: 62448360 09:57:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:57:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/target.common.tests.zip 09:57:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:57:06 INFO - Fetch https://queue.taskcluster.net/v1/task/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/target.common.tests.zip into memory 09:57:07 INFO - Content-Length response header: 62448360 09:57:07 INFO - Bytes received: 62448360 09:57:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/target.talos.tests.zip 09:57:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:57:19 INFO - Fetch https://queue.taskcluster.net/v1/task/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/target.talos.tests.zip into memory 09:57:20 INFO - Content-Length response header: 14410013 09:57:20 INFO - Bytes received: 14410013 09:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:20 INFO - trying https://queue.taskcluster.net/v1/task/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/target.tar.bz2 09:57:20 INFO - Downloading https://queue.taskcluster.net/v1/task/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:57:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:57:22 INFO - Downloaded 64911583 bytes. 09:57:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/target.tar.bz2 09:57:22 INFO - mkdir: /builds/slave/test/properties 09:57:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:57:22 INFO - Writing to file /builds/slave/test/properties/build_url 09:57:22 INFO - Contents: 09:57:22 INFO - build_url:https://queue.taskcluster.net/v1/task/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/target.tar.bz2 09:57:22 INFO - Running post-action listener: _resource_record_post_action 09:57:22 INFO - Running post-action listener: set_extra_try_arguments 09:57:22 INFO - [mozharness: 2017-05-14 16:57:22.328916Z] Finished download-and-extract step (success) 09:57:22 INFO - [mozharness: 2017-05-14 16:57:22.329014Z] Running populate-webroot step. 09:57:22 INFO - Running pre-action listener: _resource_record_pre_action 09:57:22 INFO - Running main action method: populate_webroot 09:57:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:57:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:57:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:57:22 INFO - '--tppagecycles', 09:57:22 INFO - '7'], 09:57:22 INFO - 'tests': ['tsvgm']}}, 09:57:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:57:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:57:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:57:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:57:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:57:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:57:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:57:22 INFO - 'talos_options': ['--disable-e10s'], 09:57:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:57:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:57:22 INFO - 'talos_options': ['--disable-e10s'], 09:57:22 INFO - 'tests': ['damp', 'tps']}, 09:57:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:57:22 INFO - 'tests': ['damp', 'tps']}, 09:57:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:57:22 INFO - 'tests': ['dromaeo_dom']}, 09:57:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:57:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:57:22 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:57:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:57:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:57:22 INFO - 'tests': ['a11yr', 09:57:22 INFO - 'ts_paint', 09:57:22 INFO - 'tpaint', 09:57:22 INFO - 'sessionrestore', 09:57:22 INFO - 'sessionrestore_no_auto_restore', 09:57:22 INFO - 'tabpaint']}, 09:57:22 INFO - 'other-e10s': {'tests': ['a11yr', 09:57:22 INFO - 'ts_paint', 09:57:22 INFO - 'tpaint', 09:57:22 INFO - 'sessionrestore', 09:57:22 INFO - 'sessionrestore_no_auto_restore', 09:57:22 INFO - 'tabpaint']}, 09:57:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:57:22 INFO - 'ts_paint', 09:57:22 INFO - 'tpaint', 09:57:22 INFO - 'sessionrestore', 09:57:22 INFO - 'sessionrestore_no_auto_restore', 09:57:22 INFO - 'tabpaint']}, 09:57:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:57:22 INFO - 'ts_paint', 09:57:22 INFO - 'tpaint', 09:57:22 INFO - 'sessionrestore', 09:57:22 INFO - 'sessionrestore_no_auto_restore', 09:57:22 INFO - 'tabpaint']}, 09:57:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:57:22 INFO - 'tests': ['a11yr', 09:57:22 INFO - 'ts_paint', 09:57:22 INFO - 'tpaint', 09:57:22 INFO - 'sessionrestore', 09:57:22 INFO - 'sessionrestore_no_auto_restore', 09:57:22 INFO - 'tabpaint']}, 09:57:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:57:22 INFO - 'tests': ['a11yr', 09:57:22 INFO - 'ts_paint', 09:57:22 INFO - 'tpaint', 09:57:22 INFO - 'sessionrestore', 09:57:22 INFO - 'sessionrestore_no_auto_restore', 09:57:22 INFO - 'tabpaint']}, 09:57:22 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:57:22 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:57:22 INFO - 'bloom_basic_ref']}, 09:57:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:57:22 INFO - 'tests': ['tsvgx', 09:57:22 INFO - 'tsvgr_opacity', 09:57:22 INFO - 'tart', 09:57:22 INFO - 'tscrollx', 09:57:22 INFO - 'cart', 09:57:22 INFO - 'tsvg_static']}, 09:57:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:57:22 INFO - 'tsvgr_opacity', 09:57:22 INFO - 'tart', 09:57:22 INFO - 'tscrollx', 09:57:22 INFO - 'cart', 09:57:22 INFO - 'tsvg_static']}, 09:57:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:57:22 INFO - 'talos_options': ['--disable-e10s'], 09:57:22 INFO - 'tests': ['tp5o']}, 09:57:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:57:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:57:22 INFO - 'talos_options': ['--disable-e10s', 09:57:22 INFO - '--xperf_path', 09:57:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:22 INFO - 'tests': ['tp5n']}, 09:57:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:57:22 INFO - 'talos_options': ['--xperf_path', 09:57:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:22 INFO - 'tests': ['tp5n']}}, 09:57:22 INFO - 'talos.zip': {'path': '', 09:57:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:57:22 INFO - Running post-action listener: _resource_record_post_action 09:57:22 INFO - [mozharness: 2017-05-14 16:57:22.342802Z] Finished populate-webroot step (success) 09:57:22 INFO - [mozharness: 2017-05-14 16:57:22.342893Z] Running create-virtualenv step. 09:57:22 INFO - Running pre-action listener: _resource_record_pre_action 09:57:22 INFO - Running main action method: create_virtualenv 09:57:22 INFO - Creating virtualenv /builds/slave/test/build/venv 09:57:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:57:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:57:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:57:22 INFO - Using real prefix '/usr' 09:57:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:57:22 INFO - Installing distribute.............................................................................................................................................................................................done. 09:57:24 INFO - Installing pip.................done. 09:57:24 INFO - Return code: 0 09:57:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:57:25 INFO - Reading from file tmpfile_stdout 09:57:25 INFO - Output received: 09:57:25 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:57:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:25 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 0x17ec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5c7a0>, '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 0x1b5d6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b5db30>, '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': 'ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:57:25 INFO - Using env: {'DISPLAY': ':0', 09:57:25 INFO - 'HOME': '/home/cltbld', 09:57:25 INFO - 'LANG': 'en_US.UTF-8', 09:57:25 INFO - 'LANGUAGE': 'en_US:en', 09:57:25 INFO - 'LOGNAME': 'cltbld', 09:57:25 INFO - 'MAIL': '/var/mail/cltbld', 09:57:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:25 INFO - 'MOZ_NO_REMOTE': '1', 09:57:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:25 INFO - 'NO_EM_RESTART': '1', 09:57:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:25 INFO - 'PWD': '/builds/slave/test', 09:57:25 INFO - 'SHELL': '/bin/bash', 09:57:25 INFO - 'SHLVL': '1', 09:57:25 INFO - 'TERM': 'linux', 09:57:25 INFO - 'TMOUT': '86400', 09:57:25 INFO - 'USER': 'cltbld', 09:57:25 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583', 09:57:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:25 INFO - '_': '/tools/buildbot/bin/python'} 09:57:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:57:25 INFO - Cleaning up... 09:57:25 INFO - Return code: 0 09:57:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:25 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 0x17ec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5c7a0>, '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 0x1b5d6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b5db30>, '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': 'ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:57:25 INFO - Using env: {'DISPLAY': ':0', 09:57:25 INFO - 'HOME': '/home/cltbld', 09:57:25 INFO - 'LANG': 'en_US.UTF-8', 09:57:25 INFO - 'LANGUAGE': 'en_US:en', 09:57:25 INFO - 'LOGNAME': 'cltbld', 09:57:25 INFO - 'MAIL': '/var/mail/cltbld', 09:57:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:25 INFO - 'MOZ_NO_REMOTE': '1', 09:57:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:25 INFO - 'NO_EM_RESTART': '1', 09:57:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:25 INFO - 'PWD': '/builds/slave/test', 09:57:25 INFO - 'SHELL': '/bin/bash', 09:57:25 INFO - 'SHLVL': '1', 09:57:25 INFO - 'TERM': 'linux', 09:57:25 INFO - 'TMOUT': '86400', 09:57:25 INFO - 'USER': 'cltbld', 09:57:25 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583', 09:57:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:25 INFO - '_': '/tools/buildbot/bin/python'} 09:57:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:25 INFO - Downloading/unpacking psutil>=3.1.1 09:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:57:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:26 INFO - Installing collected packages: psutil 09:57:26 INFO - Running setup.py install for psutil 09:57:26 INFO - building 'psutil._psutil_linux' extension 09:57:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:57:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:57:27 INFO - building 'psutil._psutil_posix' extension 09:57:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:57:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:57:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:27 INFO - Successfully installed psutil 09:57:27 INFO - Cleaning up... 09:57:27 INFO - Return code: 0 09:57:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:27 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 0x17ec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5c7a0>, '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 0x1b5d6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b5db30>, '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': 'ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:57:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:57:27 INFO - Using env: {'DISPLAY': ':0', 09:57:27 INFO - 'HOME': '/home/cltbld', 09:57:27 INFO - 'LANG': 'en_US.UTF-8', 09:57:27 INFO - 'LANGUAGE': 'en_US:en', 09:57:27 INFO - 'LOGNAME': 'cltbld', 09:57:27 INFO - 'MAIL': '/var/mail/cltbld', 09:57:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:27 INFO - 'MOZ_NO_REMOTE': '1', 09:57:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:27 INFO - 'NO_EM_RESTART': '1', 09:57:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:27 INFO - 'PWD': '/builds/slave/test', 09:57:27 INFO - 'SHELL': '/bin/bash', 09:57:27 INFO - 'SHLVL': '1', 09:57:27 INFO - 'TERM': 'linux', 09:57:27 INFO - 'TMOUT': '86400', 09:57:27 INFO - 'USER': 'cltbld', 09:57:27 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583', 09:57:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:27 INFO - '_': '/tools/buildbot/bin/python'} 09:57:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:57:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:57:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:57:28 INFO - Installing collected packages: mozsystemmonitor 09:57:28 INFO - Running setup.py install for mozsystemmonitor 09:57:28 INFO - Successfully installed mozsystemmonitor 09:57:28 INFO - Cleaning up... 09:57:28 INFO - Return code: 0 09:57:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:28 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 0x17ec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5c7a0>, '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 0x1b5d6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b5db30>, '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': 'ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:57:28 INFO - Using env: {'DISPLAY': ':0', 09:57:28 INFO - 'HOME': '/home/cltbld', 09:57:28 INFO - 'LANG': 'en_US.UTF-8', 09:57:28 INFO - 'LANGUAGE': 'en_US:en', 09:57:28 INFO - 'LOGNAME': 'cltbld', 09:57:28 INFO - 'MAIL': '/var/mail/cltbld', 09:57:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:28 INFO - 'MOZ_NO_REMOTE': '1', 09:57:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:28 INFO - 'NO_EM_RESTART': '1', 09:57:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:28 INFO - 'PWD': '/builds/slave/test', 09:57:28 INFO - 'SHELL': '/bin/bash', 09:57:28 INFO - 'SHLVL': '1', 09:57:28 INFO - 'TERM': 'linux', 09:57:28 INFO - 'TMOUT': '86400', 09:57:28 INFO - 'USER': 'cltbld', 09:57:28 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583', 09:57:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:28 INFO - '_': '/tools/buildbot/bin/python'} 09:57:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:28 INFO - Downloading/unpacking jsonschema==2.5.1 09:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:57:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:30 INFO - Downloading functools32-3.2.3-2.tar.gz 09:57:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:57:30 INFO - warning: no files found matching '*.txt' 09:57:30 INFO - no previously-included directories found matching 'build' 09:57:30 INFO - no previously-included directories found matching 'dist' 09:57:30 INFO - no previously-included directories found matching '.git*' 09:57:30 INFO - Installing collected packages: jsonschema, functools32 09:57:30 INFO - Running setup.py install for functools32 09:57:30 INFO - warning: no files found matching '*.txt' 09:57:30 INFO - no previously-included directories found matching 'build' 09:57:30 INFO - no previously-included directories found matching 'dist' 09:57:30 INFO - no previously-included directories found matching '.git*' 09:57:30 INFO - Successfully installed jsonschema functools32 09:57:30 INFO - Cleaning up... 09:57:30 INFO - Return code: 0 09:57:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17ec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5c7a0>, '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 0x1b5d6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b5db30>, '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': 'ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:57:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:57:30 INFO - Using env: {'DISPLAY': ':0', 09:57:30 INFO - 'HOME': '/home/cltbld', 09:57:30 INFO - 'LANG': 'en_US.UTF-8', 09:57:30 INFO - 'LANGUAGE': 'en_US:en', 09:57:30 INFO - 'LOGNAME': 'cltbld', 09:57:30 INFO - 'MAIL': '/var/mail/cltbld', 09:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:30 INFO - 'MOZ_NO_REMOTE': '1', 09:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:30 INFO - 'NO_EM_RESTART': '1', 09:57:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:30 INFO - 'PWD': '/builds/slave/test', 09:57:30 INFO - 'SHELL': '/bin/bash', 09:57:30 INFO - 'SHLVL': '1', 09:57:30 INFO - 'TERM': 'linux', 09:57:30 INFO - 'TMOUT': '86400', 09:57:30 INFO - 'USER': 'cltbld', 09:57:30 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583', 09:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:30 INFO - '_': '/tools/buildbot/bin/python'} 09:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:57:30 INFO - Cleaning up... 09:57:30 INFO - Return code: 0 09:57:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17ec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5c7a0>, '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 0x1b5d6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b5db30>, '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': 'ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:57:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:57:30 INFO - Using env: {'DISPLAY': ':0', 09:57:30 INFO - 'HOME': '/home/cltbld', 09:57:30 INFO - 'LANG': 'en_US.UTF-8', 09:57:30 INFO - 'LANGUAGE': 'en_US:en', 09:57:30 INFO - 'LOGNAME': 'cltbld', 09:57:30 INFO - 'MAIL': '/var/mail/cltbld', 09:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:30 INFO - 'MOZ_NO_REMOTE': '1', 09:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:30 INFO - 'NO_EM_RESTART': '1', 09:57:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:30 INFO - 'PWD': '/builds/slave/test', 09:57:30 INFO - 'SHELL': '/bin/bash', 09:57:30 INFO - 'SHLVL': '1', 09:57:30 INFO - 'TERM': 'linux', 09:57:30 INFO - 'TMOUT': '86400', 09:57:30 INFO - 'USER': 'cltbld', 09:57:30 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583', 09:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:30 INFO - '_': '/tools/buildbot/bin/python'} 09:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:30 INFO - Downloading/unpacking blobuploader==1.2.4 09:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:31 INFO - Downloading blobuploader-1.2.4.tar.gz 09:57:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:57:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:57:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:32 INFO - Downloading docopt-0.6.1.tar.gz 09:57:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:57:32 INFO - Installing collected packages: blobuploader, requests, docopt 09:57:32 INFO - Running setup.py install for blobuploader 09:57:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:57:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:57:32 INFO - Running setup.py install for requests 09:57:32 INFO - Running setup.py install for docopt 09:57:33 INFO - Successfully installed blobuploader requests docopt 09:57:33 INFO - Cleaning up... 09:57:33 INFO - Return code: 0 09:57:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57: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')]} 09:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:33 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 0x17ec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5c7a0>, '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 0x1b5d6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b5db30>, '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': 'ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:57:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:57:33 INFO - Using env: {'DISPLAY': ':0', 09:57:33 INFO - 'HOME': '/home/cltbld', 09:57:33 INFO - 'LANG': 'en_US.UTF-8', 09:57:33 INFO - 'LANGUAGE': 'en_US:en', 09:57:33 INFO - 'LOGNAME': 'cltbld', 09:57:33 INFO - 'MAIL': '/var/mail/cltbld', 09:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:33 INFO - 'MOZ_NO_REMOTE': '1', 09:57:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:33 INFO - 'NO_EM_RESTART': '1', 09:57:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:33 INFO - 'PWD': '/builds/slave/test', 09:57:33 INFO - 'SHELL': '/bin/bash', 09:57:33 INFO - 'SHLVL': '1', 09:57:33 INFO - 'TERM': 'linux', 09:57:33 INFO - 'TMOUT': '86400', 09:57:33 INFO - 'USER': 'cltbld', 09:57:33 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583', 09:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:33 INFO - '_': '/tools/buildbot/bin/python'} 09:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:33 INFO - Running setup.py (path:/tmp/pip-H83ciD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:33 INFO - Running setup.py (path:/tmp/pip-QU6URK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:33 INFO - Running setup.py (path:/tmp/pip-gFVTLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:57:33 INFO - Running setup.py (path:/tmp/pip-EIWKIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:57:33 INFO - Running setup.py (path:/tmp/pip-lKYA5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:57:33 INFO - Running setup.py (path:/tmp/pip-a2yXux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:57:33 INFO - Running setup.py (path:/tmp/pip-FmMTfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:57:33 INFO - Running setup.py (path:/tmp/pip-tX4jpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:57:33 INFO - Running setup.py (path:/tmp/pip-KTuzdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:57:33 INFO - Running setup.py (path:/tmp/pip-9oT3VN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:57:34 INFO - Running setup.py (path:/tmp/pip-u_LCXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:57:34 INFO - Running setup.py (path:/tmp/pip-mHsuuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:57:34 INFO - Running setup.py (path:/tmp/pip-n5I8fR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:57:34 INFO - Running setup.py (path:/tmp/pip-2OIKYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:34 INFO - Running setup.py (path:/tmp/pip-fdch0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:57:34 INFO - Running setup.py (path:/tmp/pip-2Nr5Ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:57:34 INFO - Running setup.py (path:/tmp/pip-sBOMsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:57:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:57:34 INFO - Running setup.py install for manifestparser 09:57:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:57:34 INFO - Running setup.py install for mozcrash 09:57:34 INFO - Running setup.py install for mozdebug 09:57:34 INFO - Running setup.py install for mozdevice 09:57:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:57:34 INFO - Running setup.py install for mozfile 09:57:35 INFO - Running setup.py install for mozhttpd 09:57:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:57:35 INFO - Running setup.py install for mozinfo 09:57:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:57:35 INFO - Running setup.py install for mozInstall 09:57:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:57:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:57:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:57:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:57:35 INFO - Running setup.py install for mozleak 09:57:35 INFO - Running setup.py install for mozlog 09:57:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:57:35 INFO - Running setup.py install for moznetwork 09:57:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:57:35 INFO - Running setup.py install for mozprocess 09:57:35 INFO - Running setup.py install for mozprofile 09:57:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:57:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:57:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:57:35 INFO - Running setup.py install for mozrunner 09:57:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:57:35 INFO - Running setup.py install for mozscreenshot 09:57:36 INFO - Running setup.py install for moztest 09:57:36 INFO - Running setup.py install for mozversion 09:57:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:57:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:57:36 INFO - Cleaning up... 09:57:36 INFO - Return code: 0 09:57:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:36 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 0x17ec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5c7a0>, '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 0x1b5d6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b5db30>, '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': 'ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:57:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:57:36 INFO - Using env: {'DISPLAY': ':0', 09:57:36 INFO - 'HOME': '/home/cltbld', 09:57:36 INFO - 'LANG': 'en_US.UTF-8', 09:57:36 INFO - 'LANGUAGE': 'en_US:en', 09:57:36 INFO - 'LOGNAME': 'cltbld', 09:57:36 INFO - 'MAIL': '/var/mail/cltbld', 09:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:36 INFO - 'MOZ_NO_REMOTE': '1', 09:57:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:36 INFO - 'NO_EM_RESTART': '1', 09:57:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:36 INFO - 'PWD': '/builds/slave/test', 09:57:36 INFO - 'SHELL': '/bin/bash', 09:57:36 INFO - 'SHLVL': '1', 09:57:36 INFO - 'TERM': 'linux', 09:57:36 INFO - 'TMOUT': '86400', 09:57:36 INFO - 'USER': 'cltbld', 09:57:36 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583', 09:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:36 INFO - '_': '/tools/buildbot/bin/python'} 09:57:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:36 INFO - Running setup.py (path:/tmp/pip-ioZ74S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57:36 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:36 INFO - Running setup.py (path:/tmp/pip-QCuctD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:36 INFO - Running setup.py (path:/tmp/pip-2fqZVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:57:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:57:36 INFO - Running setup.py (path:/tmp/pip-O15JXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:57:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:57:36 INFO - Running setup.py (path:/tmp/pip-54aJyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:57:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:57:36 INFO - Running setup.py (path:/tmp/pip-JtwcBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:57:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:57:36 INFO - Running setup.py (path:/tmp/pip-MRbjqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:57:37 INFO - Running setup.py (path:/tmp/pip-97I3RD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:57:37 INFO - Running setup.py (path:/tmp/pip-2MDNhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:57:37 INFO - Running setup.py (path:/tmp/pip-5jg7du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:57:37 INFO - Running setup.py (path:/tmp/pip-NVUQsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:57:37 INFO - Running setup.py (path:/tmp/pip-oUESw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:57:37 INFO - Running setup.py (path:/tmp/pip-O6Wbh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:57:37 INFO - Running setup.py (path:/tmp/pip-OXC6cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:37 INFO - Running setup.py (path:/tmp/pip-iQbKLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:57:37 INFO - Running setup.py (path:/tmp/pip-SPNMn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:57:37 INFO - Running setup.py (path:/tmp/pip-YNwVA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:57:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:38 INFO - Downloading blessings-1.6.tar.gz 09:57:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:57:38 INFO - Installing collected packages: blessings 09:57:38 INFO - Running setup.py install for blessings 09:57:39 INFO - Successfully installed blessings 09:57:39 INFO - Cleaning up... 09:57:39 INFO - Return code: 0 09:57:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:57:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:57:39 INFO - Reading from file tmpfile_stdout 09:57:39 INFO - Current package versions: 09:57:39 INFO - argparse == 1.2.1 09:57:39 INFO - blessings == 1.6 09:57:39 INFO - blobuploader == 1.2.4 09:57:39 INFO - docopt == 0.6.1 09:57:39 INFO - functools32 == 3.2.3-2 09:57:39 INFO - jsonschema == 2.5.1 09:57:39 INFO - manifestparser == 1.1 09:57:39 INFO - mozInstall == 1.12 09:57:39 INFO - mozcrash == 1.0 09:57:39 INFO - mozdebug == 0.1 09:57:39 INFO - mozdevice == 0.50 09:57:39 INFO - mozfile == 1.2 09:57:39 INFO - mozhttpd == 0.7 09:57:39 INFO - mozinfo == 0.9 09:57:39 INFO - mozleak == 0.1 09:57:39 INFO - mozlog == 3.4 09:57:39 INFO - moznetwork == 0.27 09:57:39 INFO - mozprocess == 0.25 09:57:39 INFO - mozprofile == 0.28 09:57:39 INFO - mozrunner == 6.13 09:57:39 INFO - mozscreenshot == 0.1 09:57:39 INFO - mozsystemmonitor == 0.3 09:57:39 INFO - moztest == 0.8 09:57:39 INFO - mozversion == 1.4 09:57:39 INFO - psutil == 3.1.1 09:57:39 INFO - requests == 1.2.3 09:57:39 INFO - wsgiref == 0.1.2 09:57:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:39 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 0x17ec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5c7a0>, '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 0x1b5d6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b5db30>, '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': 'ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:57:39 INFO - Using env: {'DISPLAY': ':0', 09:57:39 INFO - 'HOME': '/home/cltbld', 09:57:39 INFO - 'LANG': 'en_US.UTF-8', 09:57:39 INFO - 'LANGUAGE': 'en_US:en', 09:57:39 INFO - 'LOGNAME': 'cltbld', 09:57:39 INFO - 'MAIL': '/var/mail/cltbld', 09:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:39 INFO - 'MOZ_NO_REMOTE': '1', 09:57:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:39 INFO - 'NO_EM_RESTART': '1', 09:57:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:39 INFO - 'PWD': '/builds/slave/test', 09:57:39 INFO - 'SHELL': '/bin/bash', 09:57:39 INFO - 'SHLVL': '1', 09:57:39 INFO - 'TERM': 'linux', 09:57:39 INFO - 'TMOUT': '86400', 09:57:39 INFO - 'USER': 'cltbld', 09:57:39 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583', 09:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:39 INFO - '_': '/tools/buildbot/bin/python'} 09:57:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:57:39 INFO - Cleaning up... 09:57:39 INFO - Return code: 0 09:57:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:39 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 0x17ec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5c7a0>, '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 0x1b5d6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b5db30>, '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': 'ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:57:39 INFO - Using env: {'DISPLAY': ':0', 09:57:39 INFO - 'HOME': '/home/cltbld', 09:57:39 INFO - 'LANG': 'en_US.UTF-8', 09:57:39 INFO - 'LANGUAGE': 'en_US:en', 09:57:39 INFO - 'LOGNAME': 'cltbld', 09:57:39 INFO - 'MAIL': '/var/mail/cltbld', 09:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:39 INFO - 'MOZ_NO_REMOTE': '1', 09:57:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:39 INFO - 'NO_EM_RESTART': '1', 09:57:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:39 INFO - 'PWD': '/builds/slave/test', 09:57:39 INFO - 'SHELL': '/bin/bash', 09:57:39 INFO - 'SHLVL': '1', 09:57:39 INFO - 'TERM': 'linux', 09:57:39 INFO - 'TMOUT': '86400', 09:57:39 INFO - 'USER': 'cltbld', 09:57:39 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583', 09:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:39 INFO - '_': '/tools/buildbot/bin/python'} 09:57:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:57:39 INFO - Cleaning up... 09:57:39 INFO - Return code: 0 09:57:39 INFO - Running post-action listener: _resource_record_post_action 09:57:39 INFO - Running post-action listener: _start_resource_monitoring 09:57:39 INFO - Starting resource monitoring. 09:57:39 INFO - [mozharness: 2017-05-14 16:57:39.788614Z] Finished create-virtualenv step (success) 09:57:39 INFO - [mozharness: 2017-05-14 16:57:39.789079Z] Running install step. 09:57:39 INFO - Running pre-action listener: _resource_record_pre_action 09:57:39 INFO - Running main action method: install 09:57:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:57:39 INFO - Reading from file tmpfile_stdout 09:57:39 INFO - Detecting whether we're running mozinstall >=1.0... 09:57:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:57:40 INFO - Reading from file tmpfile_stdout 09:57:40 INFO - Output received: 09:57:40 INFO - Usage: mozinstall [options] installer 09:57:40 INFO - Options: 09:57:40 INFO - -h, --help show this help message and exit 09:57:40 INFO - -d DEST, --destination=DEST 09:57:40 INFO - Directory to install application into. [default: 09:57:40 INFO - "/builds/slave/test"] 09:57:40 INFO - --app=APP Application being installed. [default: firefox] 09:57:40 INFO - mkdir: /builds/slave/test/build/application 09:57:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:57:56 INFO - Reading from file tmpfile_stdout 09:57:56 INFO - Output received: 09:57:56 INFO - /builds/slave/test/build/application/firefox/firefox 09:57:56 INFO - Running post-action listener: _resource_record_post_action 09:57:56 INFO - [mozharness: 2017-05-14 16:57:56.466097Z] Finished install step (success) 09:57:56 INFO - [mozharness: 2017-05-14 16:57:56.466382Z] Running run-tests step. 09:57:56 INFO - Running pre-action listener: _resource_record_pre_action 09:57:56 INFO - Running main action method: run_tests 09:57:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:57:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:57:56 INFO - Python 2.7.3 09:57:56 INFO - Return code: 0 09:57:56 INFO - grabbing minidump binary from tooltool 09:57: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')]} 09:57:56 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 0x1b5c7a0>, '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 0x1b5d6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b5db30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:57:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:57:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:57:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:57:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:57:56 INFO - Return code: 0 09:57:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:57:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:57:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:57:56 INFO - ENV: RUST_BACKTRACE is now 1 09:57:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:57:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:57:56 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/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:57:56 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/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:57:56 INFO - Using env: {'DISPLAY': ':0', 09:57:56 INFO - 'HOME': '/home/cltbld', 09:57:56 INFO - 'LANG': 'en_US.UTF-8', 09:57:56 INFO - 'LANGUAGE': 'en_US:en', 09:57:56 INFO - 'LOGNAME': 'cltbld', 09:57:56 INFO - 'MAIL': '/var/mail/cltbld', 09:57:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:57:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:56 INFO - 'MOZ_NO_REMOTE': '1', 09:57:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:57:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:56 INFO - 'NO_EM_RESTART': '1', 09:57:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:56 INFO - 'PWD': '/builds/slave/test', 09:57:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:57:56 INFO - 'RUST_BACKTRACE': '1', 09:57:56 INFO - 'SHELL': '/bin/bash', 09:57:56 INFO - 'SHLVL': '1', 09:57:56 INFO - 'TERM': 'linux', 09:57:56 INFO - 'TMOUT': '86400', 09:57:56 INFO - 'USER': 'cltbld', 09:57:56 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583', 09:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:56 INFO - '_': '/tools/buildbot/bin/python'} 09:57:56 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/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:57:56 INFO - mozversion application_buildid: 20170514160450 09:57:56 INFO - mozversion application_changeset: 626efff0df630961981fc6875571fe05725f3636 09:57:56 INFO - mozversion application_display_name: Nightly 09:57:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:57:56 INFO - mozversion application_name: Firefox 09:57:56 INFO - mozversion application_remotingname: firefox 09:57:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:57:56 INFO - mozversion application_vendor: Mozilla 09:57:56 INFO - mozversion application_version: 55.0a1 09:57:56 INFO - mozversion platform_buildid: 20170514160450 09:57:56 INFO - mozversion platform_changeset: 626efff0df630961981fc6875571fe05725f3636 09:57:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:57:56 INFO - mozversion platform_version: 55.0a1 09:57:56 INFO - using testdate: 1494781076 09:57:56 INFO - actual date: 1494781076 09:57:56 INFO - starting webserver on 'localhost:56481' 09:57:56 INFO - SUITE-START | Running 2 tests 09:57:56 INFO - TEST-START | dromaeo_css 09:57:56 INFO - operating with platform_type : linux_ 09:57:56 INFO - Initialising browser for dromaeo_css test... 09:57:56 INFO - TEST-INFO | started process 4110 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ7loKj/profile http://localhost:56481/getInfo.html) 09:57:57 INFO - PID 4110 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2932: String.localeCompare is deprecated; use String.prototype.localeCompare instead 09:58:00 INFO - PID 4110 | __metrics Screen width/height:1600/1200 09:58:00 INFO - PID 4110 | colorDepth:24 09:58:00 INFO - PID 4110 | Browser inner width/height: 1024/695 09:58:00 INFO - PID 4110 | __metrics 09:58:02 INFO - TEST-INFO | 4110: exit 0 09:58:02 INFO - Browser initialized. 09:58:02 INFO - Running cycle 1/1 for dromaeo_css test... 09:58:02 INFO - TEST-INFO | started process 4300 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ7loKj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:58:13 INFO - PID 4300 | RSS: Main: 166596608 09:58:13 INFO - PID 4300 | 10:01:19 INFO - PID 4300 | Cycle 1(1): loaded http://localhost:56481/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56481/tests/dromaeo/cssquery-ext.html) 10:01:20 INFO - PID 4300 | RSS: Main: 170881024 10:01:20 INFO - PID 4300 | 10:04:22 INFO - PID 4300 | Cycle 1(1): loaded http://localhost:56481/tests/dromaeo/cssquery-ext.html (next: http://localhost:56481/tests/dromaeo/cssquery-jquery.html) 10:04:23 INFO - PID 4300 | RSS: Main: 172597248 10:04:23 INFO - PID 4300 | 10:07:25 INFO - PID 4300 | Cycle 1(1): loaded http://localhost:56481/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56481/tests/dromaeo/cssquery-mootools.html) 10:07:25 INFO - PID 4300 | RSS: Main: 172920832 10:07:25 INFO - PID 4300 | 10:10:27 INFO - PID 4300 | Cycle 1(1): loaded http://localhost:56481/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56481/tests/dromaeo/cssquery-prototype.html) 10:10:28 INFO - PID 4300 | RSS: Main: 170557440 10:10:28 INFO - PID 4300 | 10:13:31 INFO - PID 4300 | Cycle 1(1): loaded http://localhost:56481/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56481/tests/dromaeo/cssquery-yui.html) 10:13:31 INFO - PID 4300 | RSS: Main: 172625920 10:13:31 INFO - PID 4300 | 10:16:33 INFO - PID 4300 | Cycle 1(1): loaded http://localhost:56481/tests/dromaeo/cssquery-yui.html (next: http://localhost:56481/tests/dromaeo/cssquery-dojo.html) 10:16:33 INFO - PID 4300 | RSS: Main: 178278400 10:16:33 INFO - PID 4300 | 10:16:33 INFO - PID 4300 | __start_tp_report 10:16:33 INFO - PID 4300 | _x_x_mozilla_page_load 10:16:33 INFO - PID 4300 | _x_x_mozilla_page_load_details 10:16:33 INFO - PID 4300 | |i|pagename|runs| 10:16:33 INFO - PID 4300 | |0;dojo.html;2681.410089780248;2707.458508298341;2719.21142868568;2735.1794461661507;2739.47949889521;5060.392752869651;5150.74246287685;5154.5103215194495;5161.4322424533275;5210.478952104788;5069.366329208849;5128.769205385757;5148.7385590530275;5165.147750621152;5201.661891977009;4608.884777880547;4615.676902616819;4621.12198682251;4621.445426548818;4643.048175124091;4605.470370907338;4639.327297541854;4648.697834640754;4669.276262179367;4720.291956206562;4505.414296141514;4562.133194692998;4638.281066434708;4665.533446655324;4675.672702910798;4571.26859702446;4572.657050721209;4643.024964757405;4645.651576131803;4660.976695116537;4548.113117942003;4557.270836666117;4595.885102872421;4611.76941152941;4640.628749700049;5057.873553161164;5080.74596270185;5123.385193776733;5170.991656626959;5212.348456442945;5509.146082357241;5512.80705175321;5584.804531841366;5586.301712285965;5642.097264437712;5639.238702775114;5664.915026274609;5679;5688.658680479184;5691.317041954951;5242.475752424727;5244.580433565306;5257.421683614799;5270.314859068297;5319.308489896289;5618.353889302701;5678.290213723285;5684.54523638108;5685.971570142123;5710.428957104339;5291.206319052173;5318.547923426475;5318.601104917147;5323.86690332737;5325.094733895247;5412.134058550691;5415.729213539307;5424.077906755782;5433.130699088127;5587.357453892773;5525.806596769094;5570.554355651539;5581.720913954286;5621.297337832771;5627.8593035174445;5551.139573366135;5554.86112847174;5561.749721262553;5562.02664533705;5565;4616.376789133491;4686.601638860667;4689.742064186435;4692.671512994058;4729.834455794099;4025;4038.1519880825354;4051.817668204879;4112.239235741397;4132.690048246393;4850.442199147073;4865.172920603506;4877.585405240594;4882.316475693406;4913.1893237615395;5613.354464236665;5622.718864056781;5625.437456254342;5637.915431268534;5643.238162847963;4739.857804265877;4792.400949881265;4807.326974223612;4850.902981940341;4863.659543831898;5032.597392208688;5038.5969122470115;5038.974805125951;5050.015247026795;5078.162103252996;5292.867678308073;5297.920531192112;5298.496642818926;5302;5351.759170837244;5494.038543254995;5566.638168519034;5676.403977582295;5680.176374425602;5681.2330335404195;5188.507091826271;5225.6603320784025;5247.737613119405;5249.553787928069;5253.553447956813;5437.619366644297;5495.120780675073;5522.06124958766;5587.74855131512;5593.804216852391;5479.6164268500825;5488.039593071277;5489.807856724996;5504.146857237135;5507.917381239365;5341.053734993792;5350.357957045179;5353.143497040455;5355.571554275726;5356.089464790917;5296.179092240709;5349.144136938071;5395;5484.91772623403;5486.506214440719;5368.865778355573;5371.650842695212;5373.489518495737;5423.050966080999;5430.049741295336;5396.541293990055;5419.485148910847;5452.672839629635;5460.5085542301385;5490.478404551562;5219.164933610604;5266.631335806457;5348.545373643128;5351.785928562814;5408.945255675106 10:16:33 INFO - PID 4300 | |1;ext.html;681.2438193605097;724.920258771535;749.9812504687383;1052.1425038593545;1071.5124618298676;31788.841055794717;32175.839120804394;32270.67729322706;32375.190620234505;32600.510992335134;33697.49453758196;34155.146121346916;34286.65713342866;34297;34348.82825585869;6766.763163289286;6849.520533562641;6951.443884489228;6991.615461149635;6997.265287144853;6902.896456553156;6980.581165130083;6984.5110842241065;7021.508494405393;7023.929760702405;6983.301669833027;6994.965025174867;6998.195207551146;7033.859322813566;7049.577025378468;6950.409215216688;6956.547824391449;6985.301469852974;6992.545484543489;6995.230524642311;6891.655417229119;6935.549189302679;6937.340952609494;6946;6961.060256865309;30692.846535767403;30930.68019898494;30940;30974.845125774453;31093;2940.4707152712717;2991.880324787006;3004.969950300491;3008.6540047894555;3010.9397812043853;23694.170704025277;23824.16615418452;23917.16289929844;23922.641160382434;24076.398090047715;3087.675794041616;3161.7944833585743;3170.0331398923317;3170.651228364878;3177.634572024224;137793;138488;149962.25018874835;153016;153124.2343788285;38367.232655346736;38484.230315393535;38526;38529.61470385316;38535;40027.79986100109;40046;40223;40238.19523609511;40343.79828100841;11441.542338306375;11558.94220528892;11609.767804644029;11613.883861161281;11620.709482262842;9265.027172146827;9277.16505514507;9289.674861379954;9307.76730581741;9313.860292095624;12178.695532611579;12218.694532636755;12227.266364018187;12246.326452045045;12331.445084971198;5165.793368265227;5272.7100009499845;5307.230451584576;5345.091334473149;5347.625666203407;848.4145939301862;888.5157589113949;901.2204443156753;905.4793493741125;927.5269612497675;20168.49578760543;20956.895215523826;21003.47491312699;21099.68350474744;21302.467438313855;972.5817898303656;977.3354119199013;978.0806042320196;985.078951180634;1002.2583288366702;10765.3540787553;11041.779164416666;11091;11179.888201117885;11424.771504570028;166499;167604;168269.15865420594;169075.15462422854;170095;39820.60179398227;39865.40201896974;39881;39987.200255994714;40214;1182.860124857459;1215.5380955236953;1232.1990706041145;1234.1299383934304;1236.0111910471587;19287.421377358703;19602.803971960097;20319;20384;20579.58840823145;28168.154955351372;28214.71785282121;28228.15315540537;28229.153125406272;28268;142474;142546.287268563;142774;142868;143055;27792;28025.439491209654;28171.859140704164;29567.112986609576;29879.701202987693;34696;35303.293934121684;35420.82289588536;35489.11277217987;36057.819710901276;26707;27363;27363.31591710223;27416.862915685295;28319.43361132807;26644.733552664224;27255.591166132126;27286;27363.042293520426;27937;29828.70171298346;30292.091237262917;30297;30320.39359212759;30348.696513034585;25347.746522534537;25782.355441114123;26245.34386640349;26450.470990580467;26497.60253596159;20001.799981999993;21356.78643213548;22102.336929892128;22184.667229991886;22285.554288913805 10:16:33 INFO - PID 4300 | |2;jquery.html;407.28114877241654;410.40901102412505;420.8821529971607;431.47575695529935;439.0691733524928;11837.171398002143;13512.459501619924;17139;17840.197191126383;17853.553661158476;18005.09974501273;18248.45254642363;18465.815341846577;18760.343387981422;18971;5250;5319.574434045287;5493.340799104093;5500.3949565547755;5502.0921547944745;5396.946030539683;5470.206820011096;5480.808171713991;5483.506484416402;5493.093639549469;5337.582353910783;5377.516023557879;5420.566354691615;5430.56555475561;5432;5460.6177567570285;5484.808031718911;5499.50504454601;5504.587155963299;5509.256250406184;4711.24620060792;4826.600285917079;4972.676776009584;4984.501549845023;4987.102321582114;22307;22641.547169056692;22665.09339626413;22777.31668049961;23054.65418018731;1669.6326808102199;1704.0627654789816;1709.6324290277526;1710.2731339180923;1715.0824308994752;14105.85894141066;14774.852251477456;15201.771973420407;15261.313240904186;15412.537623871302;2043.5708501214763;2101.63221436248;2125.755538113106;2129.755078166015;2140.65749480084;88169;90413.99999999935;92728.53635731777;92850;94989;10973.780524389467;10979.341239525655;11111.055560277468;11317.717057073474;11565.248258863146;15517.767233491506;15699.48808190684;15760.211989400485;15787.68424631501;15807.841921580637;7338.70645174187;7525.473216874876;7566.167721550625;7683.846323073507;7709.113451953097;6677.899831502531;6833.692483838239;7010.509264351446;7011.193712723;7018.5788852669;6948.096747422803;7020.964895175492;7169.318914703095;7245.203027666952;7250.9637451812405;2100.3173968460005;2105.7262555867637;2107.083418712865;2108.4518025313223;2218;836.8870202522703;855.3328403845011;873.2490058549643;874.510274246424;902.7788191892897;16751.246193921303;16904.154792260582;17227.655446891244;17370.478885633453;17838.55403614894;882.272125496468;890.8129292848445;892.5135800988347;892.6652505310509;914.5930061122737;9208.493532855757;9701.126898579161;9875.259355548362;9880.703578892644;9892.307538472382;353212;354159;355695;359206;359520;71230.28769712236;71869.6406517964;72416;73270;73384.63307683427;1019.4291196929743;1055.3351388625117;1066.1417558865187;1071.0039663113223;1072.3726619927274;15109.54671359861;15136.394544218108;15438;15618.765718514458;15775.646788532522;37373.43939840959;37551.81224093862;37662.81168594139;37935;38851.222975539764;48289.51710482991;49118.508814911394;50247.23640199824;50290;50432.74783626058;7734.574598397142;8247.175282471944;8399.118092600189;8483.27892129176;8980.506072165832;13057.869421306046;13086.869131308566;13322.600321990356;13476.595702128952;13639.931800340935;11421.771564568828;11536.192466527262;11594.826077608674;11862;11963.401829908296;10653.520591573553;10800.351978881292;10823.134149267882;10900.836487452536;10942.835857462303;11006.284591501526;11578.536858525564;11720.824187637021;11761.941190293994;11933.76132477363;8079.232472915063;8091.271785539329;8352.081271060057;8394.790130246793;8437.535935523605;11188.552457901918;11197.72005699864;11302.830457543309;11325.886741132483;11655.18413711032 10:16:33 INFO - PID 4300 | |3;mootools.html;1246.2647038247433;1306.7517171737375;1311.5081844308384;1314.8882345000675;1316.756400065988;9857.309988300813;10282.12601928836;10289.485525723721;10526.157907367411;10839.67480975572;10561.102306303974;10754.655668041494;10757.946210268958;10761.51573179207;10773.730656733585;2268.54629074185;2307.5615633029756;2310.976890231093;2313.0169677886915;2318.5710643531;2120.703101565782;2181.432827464863;2192.265591027;2195.045155357425;2195.681626164205;2136.4552039230052;2157.2880949286778;2162.513434477246;2168.3278183763005;2177.2053200581754;2055.2601063617085;2092.06902928197;2093.3824521766114;2093.4557015176088;2097.3183715292516;2008.7991200879942;2029.6143732690741;2097.2869224463757;2170.218721260345;2175.641019231825;10294.691159265234;10383.636572719919;10409.167266618653;10416;10418.895811041868;5183.3261675981885;5414.025475414423;5420.7018613976215;5428.538574221196;5443.129099344125;3161.8419079046184;3347.397468455677;3420.675035871613;3434.708049815769;3448.620651728308;1012.9037741414554;1019.8113349030378;1031.4481752262504;1076.1283360478037;1082.577794660083;14247.287635618177;14291.071080379847;14349.784753228605;14430.494932677306;14433.494827680981;4363.323684828857;4386.298192289219;4474.731516109044;4732.053589282157;4757.714537127784;10589.576416943237;10614.257002009785;10615.416152111553;10626.14990800734;10665.36007839532;5358.356997160287;5390.595705322116;5400.4599540046465;5427.0773968425465;5449.3460784706085;4819.975900120477;4950;5053.67151135175;5069.695818250917;5074.391073071255;3547.2373439710586;3651.9269614608093;3682.4660424238336;3720.3861362874823;3759.0602349412648;1018.5009345420691;1029.1355261580309;1029.4866546177107;1045.2630895218851;1045.8012977534245;709.61326077288;725.1153592616998;727.3235890621667;736.9042024536776;746.6901235987114;5489.478499542537;5539.446055394428;5554.222408862763;5625.606207565431;5635.9436405635415;529.9947000530022;546.6364867363159;549.5301517202814;551.635920292605;553.8643032457073;3282.967170328266;3467.4812244109826;3756.7558108722847;3903.8048097595574;4304.375865499485;12889.613311600668;13026.41381137851;13100.672483187996;13573.524926627719;13939.303034848217;12727.93636031814;13016.804747928789;13037;13037.934810325887;13510;7815.765527034198;7922;7928.841423171504;7969.322607578305;8003.239692229346;5863.472287494146;6058.606190597597;6073.240844894388;6140.109684095692;6245.594036387621;11977.341246231192;12026.699332516757;12094.818577721166;12265.141440099107;12515.186512876999;12420.875791241971;12459.190152640413;12561.560345387868;12617.179883307555;12728.809067863804;8152.184781521801;8329.83340333202;8421.410501264852;8435.156484351515;8444.859943907739;9360.906390936276;9461.634591352162;9483.099105584959;9491.430514169171;9502.23982081418;8005.359571234404;8097.595120244082;8164.510129392255;8239.876401854097;8450.957745211235;8027.719029833927;8088.919110809052;8268.83462330762;8320.500769953822;8478.406511544134;7489.887651685338;7509.399248060251;7574;7602.1257555379625;7623.733169339046;5199.896002079861;5210.6613070150315;5276.788928442819;5302.840914772563;5399.163129714901;5345.438728933562;5391.622586418913;5435.755391007335;5457.072297709478;5528.612997090326 10:16:33 INFO - PID 4300 | |4;prototype.html;361.5769549626936;374.6047919444985;381.37644950505916;382.99463907243467;386.8317281982337;5345.625806193568;5496.670199788011;5504.394516603181;5539.9446005539985;5550.1674748787655;5239.371275446952;5316.9202461963005;5324.787008519655;5341.439148889369;5355.758990845412;4040.5353384360733;4055.128147448298;4057.5333836608875;4062.6749860011128;4064.4106604542326;3899.74651647642;4037.37420699792;4050.432939388473;4052.817623206948;4063.8984025399304;3989.6608788253034;4007.6793856491413;4019.1157945252;4025.8188381522755;4026.939595906064;3986.641202291793;3993.3211354069585;4013.3979903014488;4018.799060046986;4042.151148258869;3508.614052454228;3520.3487354839435;3524.4184709522897;3535.66411190939;3536.398812201932;5239.214117882349;5247.291615631879;5269.657472264291;5305.681659100466;5329.614300281916;4699.342092107074;4705.1530724469585;4725.385699859031;4725.929111063337;4735.337052812609;5528.391876893538;5657.971710141464;5681.176229446707;5714.085746280617;5723.370429252779;3895.5520115186832;3919.7648141111627;3933.8819835404984;3935.252302062599;3941.8029098544957;5788.8842223155725;5976.342602313742;6019.247594050744;6019.398060193946;6024.638521688757;4022.577629348935;4025.637692607621;4030.778307193074;4037.0916543777416;4049.372347286175;4080.4083407906282;4089.488813898263;4092.959070409258;4093.7953102344763;4103.712740108163;4663.810728264271;4687.7656117194;4727.125481785881;4734.28985652148;4761.309610106515;5730.598858079894;5736.623210429467;5736.68448235351;5746.798862039808;5755.079187330007;1399.6081097292774;1413.7770828233504;1419.21233715289;1420.488624095325;1425.5723283015054;896;926.0970553710079;937.4298050765078;951.2295041016798;957.0716405087194;5049.520295571915;5050.3939527256225;5050.924236136461;5065.9746701266995;5068.265101560253;5895.204147440127;5922.911156332659;5954.392314075176;5957.880842383128;5984.970075149684;4860.878478038077;4957.256411538226;4993.80024799004;5003.449620541737;5009.198528235538;3138.10563989262;3151.196444906534;3170.9365812684077;3172.698593633601;3178.586783718148;5426.131818908955;5503.367112782002;5526.198701188305;5536.695481748462;5553.222548843165;5996.790112346047;6029.487493563009;6068.605540639845;6078.696065196811;6105.175801266861;5501.367342755634;5514.255575497256;5520.392756796749;5520.723963801794;5524.309461317335;5852.7658893643775;5880.206172166874;5888.263967004124;5916.437938395846;5924.46679798803;5863.912041319299;5872.212422987235;5877.29558428051;5886.264216972879;5894.204282421818;5385.676859388449;5544.63959842609;5554.611177217717;5558.166275058774;5576.721163941867;4040.373742069984;4046.979765101156;4063.7358571692744;4065.16664083868;4066.044479547363;5916.3492015877355;6010.639361638316;6017.969910150421;6023.921746997279;6027.246594175728;5741.8564535886935;5779.7110144493445;5781.952633156891;5787.421257874347;5789.913151302818;5744.167095771007;5745.224394706661;5745.6552606843725;5757.466714645542;5775.393583673822;5590.580706447114;5652.802151924663;5683.119116536944;5688.601797874109;5703.800366987136;5790.449907258803;5792.84143171359;5813.970930145322;5820.73806678692;5832.12518122285;5399.919001215064;5560.888782224252;5639.718014099197;5657.660540367591;5671.631343962629 10:16:33 INFO - PID 4300 | |5;yui.html;738.6011553760969;750.3247077630132;766.9309762121411;770.7841804294796;776.9339606133476;11508.942455287734;12029.879701202985;12809.295488748116;13360.665983350422;13386.866131338697;13672.453101875913;14020.649483762885;14129.293535323219;14190.148591084517;14193.71612567748;814.7148498025688;836.8995720513547;838.8154605986704;839.3117643532306;842.1410161635159;904.3082042237694;904.9638014479413;905.248643625789;905.7645012296784;906.7778394293407;962.8026254617821;963.6819849449665;965.4593427680486;965.7778710896498;966.3960024984385;934.4533447932968;940.501534186882;941.2470023980823;942.4957647658504;942.7737343037691;689.8034060292842;690.102866273847;694.8506071194718;696.7282759723712;698.1412862179496;13488;13656.863431365658;13751.587452376445;14240.572782816533;14450.349734261983;15488.612784680361;15488.612784680361;15548.533543993699;15689;15873.603159921095;12298.446569904376;12511.812322815165;12518.12373133881;12597.874021259762;12609;2926.1221633510077;2949.27742703037;2954.4681957247685;2954.8079374840568;2963.9851800741076;66358.33641663619;66681.66659166722;67156;68104;70522;9813.460259685786;9854.950725246328;9932.404055756677;9950.96005318908;9959.153471954965;17110.82889171117;17225.827741722424;17355.392561260294;17425.564360890825;17561.648767024588;5752.539796816244;6270.216222972129;6531.706073226716;6535.8366040848405;6555.410013098749;2966.258435391152;3041.072472895788;3042.8478576071107;3044.2998110434282;3050.313679422157;3249.4638384666264;3281.278118813857;3301.2572171261754;3307.4212012897647;3331.500274958727;714.6605362452897;716.587961921897;721.7365661533607;726.7565365602477;727.0475676863326;590.5305282300582;591.9704014799242;596.740417918207;604.8487878030493;620.5159975219336;9719.271054670928;9833.852492212622;9945.900540994642;10102.39385636864;10287.074163325336;565.1099518258759;577.3995045152993;579.8492391978116;581.2559923298185;597.9701014949235;4209.074003719177;4218.430511880918;4223.852165174204;4246.617804397619;4289.764062976504;61089.38910610926;61284.08073878895;62085.37914620886;63284.36715632877;63313;55890;55990;56845.43154568401;56925.71537142288;57664;48885.266720999214;50433.74783126061;50577.24134137991;51132.74433627808;51202.48797511977;8386.664533418594;8388.370872184732;8458.534780587126;8472.74581762548;8589.098144694717;24617.653212709756;24845.006199751806;25224.24327270185;25845.612315814902;26333.60499592546;42098.57901420946;42382.78808605937;43312;43949.12101758011;44215.33676994783;13641.658958526115;13712.314384280946;13910.234937078558;14018.158910465405;14096.859031409555;14583;14618.195999219719;14644;14657.70684586281;14966.102033878002;13326.133801302884;13523.323833808467;13723.588292351245;13836.93081534626;14004.929975350058;13195.60413187606;13323.800142998056;13328;13428.328583570586;13428.530001449903;13404.865951340751;14020.439182432588;14395.496157634432;14595;14645.121292722471;9456;9501.762455938657;9779.462129582656;9789.657361992297;10125.544350504393;10146.594136234467;10658.253922225369;11052;11154.609588664682;11187.384693841592 10:16:33 INFO - PID 4300 | __end_tp_report 10:16:33 INFO - PID 4300 | __start_cc_report 10:16:33 INFO - PID 4300 | _x_x_mozilla_cycle_collect,292 10:16:33 INFO - PID 4300 | __end_cc_report 10:16:33 INFO - PID 4300 | __startTimestamp1494782193947__endTimestamp 10:16:33 INFO - PID 4300 | 10:16:33 INFO - PID 4300 | ------- Summary: start ------- 10:16:33 INFO - PID 4300 | Number of tests: 6 10:16:33 INFO - PID 4300 | 10:16:33 INFO - PID 4300 | [#0] dojo.html Cycles:165 Average:5107.33 Median:5292.87 stddev:582.82 (11.0%) stddev-sans-first:552.66 10:16:33 INFO - PID 4300 | Values: 2681.4 2707.5 2719.2 2735.2 2739.5 5060.4 5150.7 5154.5 5161.4 5210.5 5069.4 5128.8 5148.7 5165.1 5201.7 4608.9 4615.7 4621.1 4621.4 4643.0 4605.5 4639.3 4648.7 4669.3 4720.3 4505.4 4562.1 4638.3 4665.5 4675.7 4571.3 4572.7 4643.0 4645.7 4661.0 4548.1 4557.3 4595.9 4611.8 4640.6 5057.9 5080.7 5123.4 5171.0 5212.3 5509.1 5512.8 5584.8 5586.3 5642.1 5639.2 5664.9 5679.0 5688.7 5691.3 5242.5 5244.6 5257.4 5270.3 5319.3 5618.4 5678.3 5684.5 5686.0 5710.4 5291.2 5318.5 5318.6 5323.9 5325.1 5412.1 5415.7 5424.1 5433.1 5587.4 5525.8 5570.6 5581.7 5621.3 5627.9 5551.1 5554.9 5561.7 5562.0 5565.0 4616.4 4686.6 4689.7 4692.7 4729.8 4025.0 4038.2 4051.8 4112.2 4132.7 4850.4 4865.2 4877.6 4882.3 4913.2 5613.4 5622.7 5625.4 5637.9 5643.2 4739.9 4792.4 4807.3 4850.9 4863.7 5032.6 5038.6 5039.0 5050.0 5078.2 5292.9 5297.9 5298.5 5302.0 5351.8 5494.0 5566.6 5676.4 5680.2 5681.2 5188.5 5225.7 5247.7 5249.6 5253.6 5437.6 5495.1 5522.1 5587.7 5593.8 5479.6 5488.0 5489.8 5504.1 5507.9 5341.1 5350.4 5353.1 5355.6 5356.1 5296.2 5349.1 5395.0 5484.9 5486.5 5368.9 5371.7 5373.5 5423.1 5430.0 5396.5 5419.5 5452.7 5460.5 5490.5 5219.2 5266.6 5348.5 5351.8 5408.9 10:16:33 INFO - PID 4300 | 10:16:33 INFO - PID 4300 | [#1] ext.html Cycles:180 Average:29377.90 Median:30308.70 stddev:39415.84 (130.0%) stddev-sans-first:39467.51 10:16:33 INFO - PID 4300 | Values: 681.2 724.9 750.0 1052.1 1071.5 31788.8 32175.8 32270.7 32375.2 32600.5 33697.5 34155.1 34286.7 34297.0 34348.8 6766.8 6849.5 6951.4 6991.6 6997.3 6902.9 6980.6 6984.5 7021.5 7023.9 6983.3 6995.0 6998.2 7033.9 7049.6 6950.4 6956.5 6985.3 6992.5 6995.2 6891.7 6935.5 6937.3 6946.0 6961.1 30692.8 30930.7 30940.0 30974.8 31093.0 2940.5 2991.9 3005.0 3008.7 3010.9 23694.2 23824.2 23917.2 23922.6 24076.4 3087.7 3161.8 3170.0 3170.7 3177.6 137793.0 138488.0 149962.3 153016.0 153124.2 38367.2 38484.2 38526.0 38529.6 38535.0 40027.8 40046.0 40223.0 40238.2 40343.8 11441.5 11558.9 11609.8 11613.9 11620.7 9265.0 9277.2 9289.7 9307.8 9313.9 12178.7 12218.7 12227.3 12246.3 12331.4 5165.8 5272.7 5307.2 5345.1 5347.6 848.4 888.5 901.2 905.5 927.5 20168.5 20956.9 21003.5 21099.7 21302.5 972.6 977.3 978.1 985.1 1002.3 10765.4 11041.8 11091.0 11179.9 11424.8 166499.0 167604.0 168269.2 169075.2 170095.0 39820.6 39865.4 39881.0 39987.2 40214.0 1182.9 1215.5 1232.2 1234.1 1236.0 19287.4 19602.8 20319.0 20384.0 20579.6 28168.2 28214.7 28228.2 28229.2 28268.0 142474.0 142546.3 142774.0 142868.0 143055.0 27792.0 28025.4 28171.9 29567.1 29879.7 34696.0 35303.3 35420.8 35489.1 36057.8 26707.0 27363.0 27363.3 27416.9 28319.4 26644.7 27255.6 27286.0 27363.0 27937.0 29828.7 30292.1 30297.0 30320.4 30348.7 25347.7 25782.4 26245.3 26450.5 26497.6 20001.8 21356.8 22102.3 22184.7 22285.6 10:16:33 INFO - PID 4300 | 10:16:33 INFO - PID 4300 | [#2] jquery.html Cycles:180 Average:24500.78 Median:37462.63 stddev:59432.68 (158.6%) stddev-sans-first:59571.87 10:16:33 INFO - PID 4300 | Values: 407.3 410.4 420.9 431.5 439.1 11837.2 13512.5 17139.0 17840.2 17853.6 18005.1 18248.5 18465.8 18760.3 18971.0 5250.0 5319.6 5493.3 5500.4 5502.1 5396.9 5470.2 5480.8 5483.5 5493.1 5337.6 5377.5 5420.6 5430.6 5432.0 5460.6 5484.8 5499.5 5504.6 5509.3 4711.2 4826.6 4972.7 4984.5 4987.1 22307.0 22641.5 22665.1 22777.3 23054.7 1669.6 1704.1 1709.6 1710.3 1715.1 14105.9 14774.9 15201.8 15261.3 15412.5 2043.6 2101.6 2125.8 2129.8 2140.7 88169.0 90414.0 92728.5 92850.0 94989.0 10973.8 10979.3 11111.1 11317.7 11565.2 15517.8 15699.5 15760.2 15787.7 15807.8 7338.7 7525.5 7566.2 7683.8 7709.1 6677.9 6833.7 7010.5 7011.2 7018.6 6948.1 7021.0 7169.3 7245.2 7251.0 2100.3 2105.7 2107.1 2108.5 2218.0 836.9 855.3 873.2 874.5 902.8 16751.2 16904.2 17227.7 17370.5 17838.6 882.3 890.8 892.5 892.7 914.6 9208.5 9701.1 9875.3 9880.7 9892.3 353212.0 354159.0 355695.0 359206.0 359520.0 71230.3 71869.6 72416.0 73270.0 73384.6 1019.4 1055.3 1066.1 1071.0 1072.4 15109.5 15136.4 15438.0 15618.8 15775.6 37373.4 37551.8 37662.8 37935.0 38851.2 48289.5 49118.5 50247.2 50290.0 50432.7 7734.6 8247.2 8399.1 8483.3 8980.5 13057.9 13086.9 13322.6 13476.6 13639.9 11421.8 11536.2 11594.8 11862.0 11963.4 10653.5 10800.4 10823.1 10900.8 10942.8 11006.3 11578.5 11720.8 11761.9 11933.8 8079.2 8091.3 8352.1 8394.8 8437.5 11188.6 11197.7 11302.8 11325.9 11655.2 10:16:33 INFO - PID 4300 | 10:16:33 INFO - PID 4300 | [#3] mootools.html Cycles:180 Average:6283.46 Median:3507.36 stddev:4066.94 (116.0%) stddev-sans-first:4060.73 10:16:33 INFO - PID 4300 | Values: 1246.3 1306.8 1311.5 1314.9 1316.8 9857.3 10282.1 10289.5 10526.2 10839.7 10561.1 10754.7 10757.9 10761.5 10773.7 2268.5 2307.6 2311.0 2313.0 2318.6 2120.7 2181.4 2192.3 2195.0 2195.7 2136.5 2157.3 2162.5 2168.3 2177.2 2055.3 2092.1 2093.4 2093.5 2097.3 2008.8 2029.6 2097.3 2170.2 2175.6 10294.7 10383.6 10409.2 10416.0 10418.9 5183.3 5414.0 5420.7 5428.5 5443.1 3161.8 3347.4 3420.7 3434.7 3448.6 1012.9 1019.8 1031.4 1076.1 1082.6 14247.3 14291.1 14349.8 14430.5 14433.5 4363.3 4386.3 4474.7 4732.1 4757.7 10589.6 10614.3 10615.4 10626.1 10665.4 5358.4 5390.6 5400.5 5427.1 5449.3 4820.0 4950.0 5053.7 5069.7 5074.4 3547.2 3651.9 3682.5 3720.4 3759.1 1018.5 1029.1 1029.5 1045.3 1045.8 709.6 725.1 727.3 736.9 746.7 5489.5 5539.4 5554.2 5625.6 5635.9 530.0 546.6 549.5 551.6 553.9 3283.0 3467.5 3756.8 3903.8 4304.4 12889.6 13026.4 13100.7 13573.5 13939.3 12727.9 13016.8 13037.0 13037.9 13510.0 7815.8 7922.0 7928.8 7969.3 8003.2 5863.5 6058.6 6073.2 6140.1 6245.6 11977.3 12026.7 12094.8 12265.1 12515.2 12420.9 12459.2 12561.6 12617.2 12728.8 8152.2 8329.8 8421.4 8435.2 8444.9 9360.9 9461.6 9483.1 9491.4 9502.2 8005.4 8097.6 8164.5 8239.9 8451.0 8027.7 8088.9 8268.8 8320.5 8478.4 7489.9 7509.4 7574.0 7602.1 7623.7 5199.9 5210.7 5276.8 5302.8 5399.2 5345.4 5391.6 5435.8 5457.1 5528.6 10:16:33 INFO - PID 4300 | 10:16:33 INFO - PID 4300 | [#4] prototype.html Cycles:180 Average:4706.53 Median:5370.72 stddev:1411.69 (26.3%) stddev-sans-first:1377.46 10:16:33 INFO - PID 4300 | Values: 361.6 374.6 381.4 383.0 386.8 5345.6 5496.7 5504.4 5539.9 5550.2 5239.4 5316.9 5324.8 5341.4 5355.8 4040.5 4055.1 4057.5 4062.7 4064.4 3899.7 4037.4 4050.4 4052.8 4063.9 3989.7 4007.7 4019.1 4025.8 4026.9 3986.6 3993.3 4013.4 4018.8 4042.2 3508.6 3520.3 3524.4 3535.7 3536.4 5239.2 5247.3 5269.7 5305.7 5329.6 4699.3 4705.2 4725.4 4725.9 4735.3 5528.4 5658.0 5681.2 5714.1 5723.4 3895.6 3919.8 3933.9 3935.3 3941.8 5788.9 5976.3 6019.2 6019.4 6024.6 4022.6 4025.6 4030.8 4037.1 4049.4 4080.4 4089.5 4093.0 4093.8 4103.7 4663.8 4687.8 4727.1 4734.3 4761.3 5730.6 5736.6 5736.7 5746.8 5755.1 1399.6 1413.8 1419.2 1420.5 1425.6 896.0 926.1 937.4 951.2 957.1 5049.5 5050.4 5050.9 5066.0 5068.3 5895.2 5922.9 5954.4 5957.9 5985.0 4860.9 4957.3 4993.8 5003.4 5009.2 3138.1 3151.2 3170.9 3172.7 3178.6 5426.1 5503.4 5526.2 5536.7 5553.2 5996.8 6029.5 6068.6 6078.7 6105.2 5501.4 5514.3 5520.4 5520.7 5524.3 5852.8 5880.2 5888.3 5916.4 5924.5 5863.9 5872.2 5877.3 5886.3 5894.2 5385.7 5544.6 5554.6 5558.2 5576.7 4040.4 4047.0 4063.7 4065.2 4066.0 5916.3 6010.6 6018.0 6023.9 6027.2 5741.9 5779.7 5782.0 5787.4 5789.9 5744.2 5745.2 5745.7 5757.5 5775.4 5590.6 5652.8 5683.1 5688.6 5703.8 5790.4 5792.8 5814.0 5820.7 5832.1 5399.9 5560.9 5639.7 5657.7 5671.6 10:16:33 INFO - PID 4300 | 10:16:33 INFO - PID 4300 | [#5] yui.html Cycles:180 Average:14923.47 Median:43630.56 stddev:17935.86 (41.1%) stddev-sans-first:17954.54 10:16:33 INFO - PID 4300 | Values: 738.6 750.3 766.9 770.8 776.9 11508.9 12029.9 12809.3 13360.7 13386.9 13672.5 14020.6 14129.3 14190.1 14193.7 814.7 836.9 838.8 839.3 842.1 904.3 905.0 905.2 905.8 906.8 962.8 963.7 965.5 965.8 966.4 934.5 940.5 941.2 942.5 942.8 689.8 690.1 694.9 696.7 698.1 13488.0 13656.9 13751.6 14240.6 14450.3 15488.6 15488.6 15548.5 15689.0 15873.6 12298.4 12511.8 12518.1 12597.9 12609.0 2926.1 2949.3 2954.5 2954.8 2964.0 66358.3 66681.7 67156.0 68104.0 70522.0 9813.5 9855.0 9932.4 9951.0 9959.2 17110.8 17225.8 17355.4 17425.6 17561.6 5752.5 6270.2 6531.7 6535.8 6555.4 2966.3 3041.1 3042.8 3044.3 3050.3 3249.5 3281.3 3301.3 3307.4 3331.5 714.7 716.6 721.7 726.8 727.0 590.5 592.0 596.7 604.8 620.5 9719.3 9833.9 9945.9 10102.4 10287.1 565.1 577.4 579.8 581.3 598.0 4209.1 4218.4 4223.9 4246.6 4289.8 61089.4 61284.1 62085.4 63284.4 63313.0 55890.0 55990.0 56845.4 56925.7 57664.0 48885.3 50433.7 50577.2 51132.7 51202.5 8386.7 8388.4 8458.5 8472.7 8589.1 24617.7 24845.0 25224.2 25845.6 26333.6 42098.6 42382.8 43312.0 43949.1 44215.3 13641.7 13712.3 13910.2 14018.2 14096.9 14583.0 14618.2 14644.0 14657.7 14966.1 13326.1 13523.3 13723.6 13836.9 14004.9 13195.6 13323.8 13328.0 13428.3 13428.5 13404.9 14020.4 14395.5 14595.0 14645.1 9456.0 9501.8 9779.5 9789.7 10125.5 10146.6 10658.3 11052.0 11154.6 11187.4 10:16:33 INFO - PID 4300 | -------- Summary: end -------- 10:16:33 INFO - PID 4300 | 10:16:34 INFO - TEST-INFO | 4300: exit 0 10:16:34 INFO - TEST-OK | dromaeo_css | took 1118019ms 10:16:34 INFO - TEST-START | kraken 10:16:34 INFO - operating with platform_type : linux_ 10:16:34 INFO - Initialising browser for kraken test... 10:16:34 INFO - TEST-INFO | started process 4724 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkA0kwt/profile http://localhost:56481/getInfo.html) 10:16:35 INFO - PID 4724 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2932: String.localeCompare is deprecated; use String.prototype.localeCompare instead 10:16:38 INFO - PID 4724 | __metrics Screen width/height:1600/1200 10:16:38 INFO - PID 4724 | colorDepth:24 10:16:38 INFO - PID 4724 | Browser inner width/height: 1024/695 10:16:38 INFO - PID 4724 | __metrics 10:16:40 INFO - TEST-INFO | 4724: exit 0 10:16:40 INFO - Browser initialized. 10:16:40 INFO - Running cycle 1/1 for kraken test... 10:16:40 INFO - TEST-INFO | started process 4916 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkA0kwt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:51 INFO - PID 4916 | RSS: Main: 165343232 10:16:51 INFO - PID 4916 | 10:16:54 INFO - PID 4916 | Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56481/tests/kraken/driver.html?testName=audio-beat-detection) 10:16:55 INFO - PID 4916 | RSS: Main: 170741760 10:16:55 INFO - PID 4916 | 10:16:58 INFO - PID 4916 | Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56481/tests/kraken/driver.html?testName=audio-dft) 10:16:58 INFO - PID 4916 | RSS: Main: 170586112 10:16:58 INFO - PID 4916 | 10:17:01 INFO - PID 4916 | Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56481/tests/kraken/driver.html?testName=audio-fft) 10:17:02 INFO - PID 4916 | RSS: Main: 165318656 10:17:02 INFO - PID 4916 | 10:17:04 INFO - PID 4916 | Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56481/tests/kraken/driver.html?testName=audio-oscillator) 10:17:05 INFO - PID 4916 | RSS: Main: 165974016 10:17:05 INFO - PID 4916 | 10:17:07 INFO - PID 4916 | Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56481/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:17:07 INFO - PID 4916 | RSS: Main: 166375424 10:17:07 INFO - PID 4916 | 10:17:11 INFO - PID 4916 | Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56481/tests/kraken/driver.html?testName=imaging-darkroom) 10:17:11 INFO - PID 4916 | RSS: Main: 170397696 10:17:11 INFO - PID 4916 | 10:17:15 INFO - PID 4916 | Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56481/tests/kraken/driver.html?testName=imaging-desaturate) 10:17:15 INFO - PID 4916 | RSS: Main: 168198144 10:17:15 INFO - PID 4916 | 10:17:18 INFO - PID 4916 | Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56481/tests/kraken/driver.html?testName=json-parse-financial) 10:17:19 INFO - PID 4916 | RSS: Main: 168587264 10:17:19 INFO - PID 4916 | 10:17:20 INFO - PID 4916 | Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56481/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:17:21 INFO - PID 4916 | RSS: Main: 169521152 10:17:21 INFO - PID 4916 | 10:17:23 INFO - PID 4916 | Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56481/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:17:24 INFO - PID 4916 | RSS: Main: 168890368 10:17:24 INFO - PID 4916 | 10:17:26 INFO - PID 4916 | Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56481/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:17:26 INFO - PID 4916 | RSS: Main: 168894464 10:17:26 INFO - PID 4916 | 10:17:29 INFO - PID 4916 | Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56481/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:17:30 INFO - PID 4916 | RSS: Main: 169697280 10:17:30 INFO - PID 4916 | 10:17:33 INFO - PID 4916 | Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56481/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:17:34 INFO - PID 4916 | RSS: Main: 169508864 10:17:34 INFO - PID 4916 | 10:17:36 INFO - PID 4916 | Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56481/tests/kraken/driver.html?testName=ai-astar) 10:17:36 INFO - PID 4916 | RSS: Main: 170491904 10:17:36 INFO - PID 4916 | 10:17:36 INFO - PID 4916 | __start_tp_report 10:17:36 INFO - PID 4916 | _x_x_mozilla_page_load 10:17:36 INFO - PID 4916 | _x_x_mozilla_page_load_details 10:17:36 INFO - PID 4916 | |i|pagename|runs| 10:17:36 INFO - PID 4916 | |0;ai-astar;104;113;112;110;112;112;112;113;112;113 10:17:36 INFO - PID 4916 | |1;audio-beat-detection;150;125;126;171;130;123;123;125;145;125 10:17:36 INFO - PID 4916 | |2;audio-dft;163;164;161;165;164;165;167;168;172;164 10:17:36 INFO - PID 4916 | |3;audio-fft;75;75;78;113;75;76;75;76;100;75 10:17:36 INFO - PID 4916 | |4;audio-oscillator;83;82;104;84;83;83;112;83;82;105 10:17:36 INFO - PID 4916 | |5;imaging-gaussian-blur;114;114;113;113;114;115;115;113;115;114 10:17:36 INFO - PID 4916 | |6;imaging-darkroom;151;149;150;150;149;150;150;150;149;150 10:17:36 INFO - PID 4916 | |7;imaging-desaturate;98;101;94;95;94;95;95;94;94;94 10:17:36 INFO - PID 4916 | |8;json-parse-financial;54;55;54;55;55;56;56;55;55;55 10:17:36 INFO - PID 4916 | |9;json-stringify-tinderbox;56;59;55;56;55;56;56;55;56;56 10:17:36 INFO - PID 4916 | |10;stanford-crypto-aes;86;83;85;82;102;84;83;84;85;84 10:17:36 INFO - PID 4916 | |11;stanford-crypto-ccm;140;150;133;145;131;132;139;142;182;166 10:17:36 INFO - PID 4916 | |12;stanford-crypto-pbkdf2;183;196;190;198;197;191;211;201;198;201 10:17:36 INFO - PID 4916 | |13;stanford-crypto-sha256-iterative;74;75;74;75;75;73;71;79;72;72 10:17:36 INFO - PID 4916 | __end_tp_report 10:17:36 INFO - PID 4916 | __start_cc_report 10:17:36 INFO - PID 4916 | _x_x_mozilla_cycle_collect,799 10:17:36 INFO - PID 4916 | __end_cc_report 10:17:36 INFO - PID 4916 | __startTimestamp1494782256369__endTimestamp 10:17:36 INFO - PID 4916 | 10:17:36 INFO - PID 4916 | ------- Summary: start ------- 10:17:36 INFO - PID 4916 | Number of tests: 14 10:17:36 INFO - PID 4916 | 10:17:36 INFO - PID 4916 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.71 (2.4%) stddev-sans-first:0.93 10:17:36 INFO - PID 4916 | Values: 104.0 113.0 112.0 110.0 112.0 112.0 112.0 113.0 112.0 113.0 10:17:36 INFO - PID 4916 | 10:17:36 INFO - PID 4916 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:128.00 stddev:16.02 (12.5%) stddev-sans-first:15.95 10:17:36 INFO - PID 4916 | Values: 150.0 125.0 126.0 171.0 130.0 123.0 123.0 125.0 145.0 125.0 10:17:36 INFO - PID 4916 | 10:17:36 INFO - PID 4916 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.00 stddev:3.06 (1.9%) stddev-sans-first:3.13 10:17:36 INFO - PID 4916 | Values: 163.0 164.0 161.0 165.0 164.0 165.0 167.0 168.0 172.0 164.0 10:17:36 INFO - PID 4916 | 10:17:36 INFO - PID 4916 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.00 stddev:13.41 (17.9%) stddev-sans-first:13.99 10:17:36 INFO - PID 4916 | Values: 75.0 75.0 78.0 113.0 75.0 76.0 75.0 76.0 100.0 75.0 10:17:36 INFO - PID 4916 | 10:17:36 INFO - PID 4916 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:83.00 stddev:11.86 (14.3%) stddev-sans-first:12.29 10:17:36 INFO - PID 4916 | Values: 83.0 82.0 104.0 84.0 83.0 83.0 112.0 83.0 82.0 105.0 10:17:36 INFO - PID 4916 | 10:17:36 INFO - PID 4916 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 10:17:36 INFO - PID 4916 | Values: 114.0 114.0 113.0 113.0 114.0 115.0 115.0 113.0 115.0 114.0 10:17:36 INFO - PID 4916 | 10:17:36 INFO - PID 4916 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:150.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 10:17:36 INFO - PID 4916 | Values: 151.0 149.0 150.0 150.0 149.0 150.0 150.0 150.0 149.0 150.0 10:17:36 INFO - PID 4916 | 10:17:36 INFO - PID 4916 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:94.50 stddev:2.32 (2.5%) stddev-sans-first:2.26 10:17:36 INFO - PID 4916 | Values: 98.0 101.0 94.0 95.0 94.0 95.0 95.0 94.0 94.0 94.0 10:17:36 INFO - PID 4916 | 10:17:36 INFO - PID 4916 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:0.67 (1.2%) stddev-sans-first:0.60 10:17:36 INFO - PID 4916 | Values: 54.0 55.0 54.0 55.0 55.0 56.0 56.0 55.0 55.0 55.0 10:17:36 INFO - PID 4916 | 10:17:36 INFO - PID 4916 | [#9] json-stringify-tinderbox Cycles:10 Average:56.00 Median:56.00 stddev:1.15 (2.1%) stddev-sans-first:1.22 10:17:36 INFO - PID 4916 | Values: 56.0 59.0 55.0 56.0 55.0 56.0 56.0 55.0 56.0 56.0 10:17:36 INFO - PID 4916 | 10:17:36 INFO - PID 4916 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:84.00 stddev:5.81 (6.9%) stddev-sans-first:6.16 10:17:36 INFO - PID 4916 | Values: 86.0 83.0 85.0 82.0 102.0 84.0 83.0 84.0 85.0 84.0 10:17:36 INFO - PID 4916 | 10:17:36 INFO - PID 4916 | [#11] stanford-crypto-ccm Cycles:10 Average:146.00 Median:143.50 stddev:16.34 (11.4%) stddev-sans-first:17.19 10:17:36 INFO - PID 4916 | Values: 140.0 150.0 133.0 145.0 131.0 132.0 139.0 142.0 182.0 166.0 10:17:36 INFO - PID 4916 | 10:17:36 INFO - PID 4916 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.60 Median:198.00 stddev:7.53 (3.8%) stddev-sans-first:6.17 10:17:36 INFO - PID 4916 | Values: 183.0 196.0 190.0 198.0 197.0 191.0 211.0 201.0 198.0 201.0 10:17:36 INFO - PID 4916 | 10:17:36 INFO - PID 4916 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.00 Median:74.50 stddev:2.26 (3.0%) stddev-sans-first:2.40 10:17:36 INFO - PID 4916 | Values: 74.0 75.0 74.0 75.0 75.0 73.0 71.0 79.0 72.0 72.0 10:17:36 INFO - PID 4916 | -------- Summary: end -------- 10:17:36 INFO - PID 4916 | 10:17:37 INFO - TEST-INFO | 4916: exit 0 10:17:37 INFO - TEST-OK | kraken | took 62675ms 10:17:37 INFO - SUITE-END | took 1180s 10:17:37 INFO - Completed test suite (00:19:40) 10:17:37 INFO - javascript benchmark 10:17:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6618.698577603896, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2681.410089780248, 2707.458508298341, 2719.21142868568, 2735.1794461661507, 2739.47949889521, 5060.392752869651, 5150.74246287685, 5154.5103215194495, 5161.4322424533275, 5210.478952104788, 5069.366329208849, 5128.769205385757, 5148.7385590530275, 5165.147750621152, 5201.661891977009, 4608.884777880547, 4615.676902616819, 4621.12198682251, 4621.445426548818, 4643.048175124091, 4605.470370907338, 4639.327297541854, 4648.697834640754, 4669.276262179367, 4720.291956206562, 4505.414296141514, 4562.133194692998, 4638.281066434708, 4665.533446655324, 4675.672702910798, 4571.26859702446, 4572.657050721209, 4643.024964757405, 4645.651576131803, 4660.976695116537, 4548.113117942003, 4557.270836666117, 4595.885102872421, 4611.76941152941, 4640.628749700049, 5057.873553161164, 5080.74596270185, 5123.385193776733, 5170.991656626959, 5212.348456442945, 5509.146082357241, 5512.80705175321, 5584.804531841366, 5586.301712285965, 5642.097264437712, 5639.238702775114, 5664.915026274609, 5679.0, 5688.658680479184, 5691.317041954951, 5242.475752424727, 5244.580433565306, 5257.421683614799, 5270.314859068297, 5319.308489896289, 5618.353889302701, 5678.290213723285, 5684.54523638108, 5685.971570142123, 5710.428957104339, 5291.206319052173, 5318.547923426475, 5318.601104917147, 5323.86690332737, 5325.094733895247, 5412.134058550691, 5415.729213539307, 5424.077906755782, 5433.130699088127, 5587.357453892773, 5525.806596769094, 5570.554355651539, 5581.720913954286, 5621.297337832771, 5627.8593035174445, 5551.139573366135, 5554.86112847174, 5561.749721262553, 5562.02664533705, 5565.0, 4616.376789133491, 4686.601638860667, 4689.742064186435, 4692.671512994058, 4729.834455794099, 4025.0, 4038.1519880825354, 4051.817668204879, 4112.239235741397, 4132.690048246393, 4850.442199147073, 4865.172920603506, 4877.585405240594, 4882.316475693406, 4913.1893237615395, 5613.354464236665, 5622.718864056781, 5625.437456254342, 5637.915431268534, 5643.238162847963, 4739.857804265877, 4792.400949881265, 4807.326974223612, 4850.902981940341, 4863.659543831898, 5032.597392208688, 5038.5969122470115, 5038.974805125951, 5050.015247026795, 5078.162103252996, 5292.867678308073, 5297.920531192112, 5298.496642818926, 5302.0, 5351.759170837244, 5494.038543254995, 5566.638168519034, 5676.403977582295, 5680.176374425602, 5681.2330335404195, 5188.507091826271, 5225.6603320784025, 5247.737613119405, 5249.553787928069, 5253.553447956813, 5437.619366644297, 5495.120780675073, 5522.06124958766, 5587.74855131512, 5593.804216852391, 5479.6164268500825, 5488.039593071277, 5489.807856724996, 5504.146857237135, 5507.917381239365, 5341.053734993792, 5350.357957045179, 5353.143497040455, 5355.571554275726, 5356.089464790917, 5296.179092240709, 5349.144136938071, 5395.0, 5484.91772623403, 5486.506214440719, 5368.865778355573, 5371.650842695212, 5373.489518495737, 5423.050966080999, 5430.049741295336, 5396.541293990055, 5419.485148910847, 5452.672839629635, 5460.5085542301385, 5490.478404551562, 5219.164933610604, 5266.631335806457, 5348.545373643128, 5351.785928562814, 5408.945255675106], "value": 5065.974457319808, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.2438193605097, 724.920258771535, 749.9812504687383, 1052.1425038593545, 1071.5124618298676, 31788.841055794717, 32175.839120804394, 32270.67729322706, 32375.190620234505, 32600.510992335134, 33697.49453758196, 34155.146121346916, 34286.65713342866, 34297.0, 34348.82825585869, 6766.763163289286, 6849.520533562641, 6951.443884489228, 6991.615461149635, 6997.265287144853, 6902.896456553156, 6980.581165130083, 6984.5110842241065, 7021.508494405393, 7023.929760702405, 6983.301669833027, 6994.965025174867, 6998.195207551146, 7033.859322813566, 7049.577025378468, 6950.409215216688, 6956.547824391449, 6985.301469852974, 6992.545484543489, 6995.230524642311, 6891.655417229119, 6935.549189302679, 6937.340952609494, 6946.0, 6961.060256865309, 30692.846535767403, 30930.68019898494, 30940.0, 30974.845125774453, 31093.0, 2940.4707152712717, 2991.880324787006, 3004.969950300491, 3008.6540047894555, 3010.9397812043853, 23694.170704025277, 23824.16615418452, 23917.16289929844, 23922.641160382434, 24076.398090047715, 3087.675794041616, 3161.7944833585743, 3170.0331398923317, 3170.651228364878, 3177.634572024224, 137793.0, 138488.0, 149962.25018874835, 153016.0, 153124.2343788285, 38367.232655346736, 38484.230315393535, 38526.0, 38529.61470385316, 38535.0, 40027.79986100109, 40046.0, 40223.0, 40238.19523609511, 40343.79828100841, 11441.542338306375, 11558.94220528892, 11609.767804644029, 11613.883861161281, 11620.709482262842, 9265.027172146827, 9277.16505514507, 9289.674861379954, 9307.76730581741, 9313.860292095624, 12178.695532611579, 12218.694532636755, 12227.266364018187, 12246.326452045045, 12331.445084971198, 5165.793368265227, 5272.7100009499845, 5307.230451584576, 5345.091334473149, 5347.625666203407, 848.4145939301862, 888.5157589113949, 901.2204443156753, 905.4793493741125, 927.5269612497675, 20168.49578760543, 20956.895215523826, 21003.47491312699, 21099.68350474744, 21302.467438313855, 972.5817898303656, 977.3354119199013, 978.0806042320196, 985.078951180634, 1002.2583288366702, 10765.3540787553, 11041.779164416666, 11091.0, 11179.888201117885, 11424.771504570028, 166499.0, 167604.0, 168269.15865420594, 169075.15462422854, 170095.0, 39820.60179398227, 39865.40201896974, 39881.0, 39987.200255994714, 40214.0, 1182.860124857459, 1215.5380955236953, 1232.1990706041145, 1234.1299383934304, 1236.0111910471587, 19287.421377358703, 19602.803971960097, 20319.0, 20384.0, 20579.58840823145, 28168.154955351372, 28214.71785282121, 28228.15315540537, 28229.153125406272, 28268.0, 142474.0, 142546.287268563, 142774.0, 142868.0, 143055.0, 27792.0, 28025.439491209654, 28171.859140704164, 29567.112986609576, 29879.701202987693, 34696.0, 35303.293934121684, 35420.82289588536, 35489.11277217987, 36057.819710901276, 26707.0, 27363.0, 27363.31591710223, 27416.862915685295, 28319.43361132807, 26644.733552664224, 27255.591166132126, 27286.0, 27363.042293520426, 27937.0, 29828.70171298346, 30292.091237262917, 30297.0, 30320.39359212759, 30348.696513034585, 25347.746522534537, 25782.355441114123, 26245.34386640349, 26450.470990580467, 26497.60253596159, 20001.799981999993, 21356.78643213548, 22102.336929892128, 22184.667229991886, 22285.554288913805], "value": 14191.452527849067, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.28114877241654, 410.40901102412505, 420.8821529971607, 431.47575695529935, 439.0691733524928, 11837.171398002143, 13512.459501619924, 17139.0, 17840.197191126383, 17853.553661158476, 18005.09974501273, 18248.45254642363, 18465.815341846577, 18760.343387981422, 18971.0, 5250.0, 5319.574434045287, 5493.340799104093, 5500.3949565547755, 5502.0921547944745, 5396.946030539683, 5470.206820011096, 5480.808171713991, 5483.506484416402, 5493.093639549469, 5337.582353910783, 5377.516023557879, 5420.566354691615, 5430.56555475561, 5432.0, 5460.6177567570285, 5484.808031718911, 5499.50504454601, 5504.587155963299, 5509.256250406184, 4711.24620060792, 4826.600285917079, 4972.676776009584, 4984.501549845023, 4987.102321582114, 22307.0, 22641.547169056692, 22665.09339626413, 22777.31668049961, 23054.65418018731, 1669.6326808102199, 1704.0627654789816, 1709.6324290277526, 1710.2731339180923, 1715.0824308994752, 14105.85894141066, 14774.852251477456, 15201.771973420407, 15261.313240904186, 15412.537623871302, 2043.5708501214763, 2101.63221436248, 2125.755538113106, 2129.755078166015, 2140.65749480084, 88169.0, 90413.99999999935, 92728.53635731777, 92850.0, 94989.0, 10973.780524389467, 10979.341239525655, 11111.055560277468, 11317.717057073474, 11565.248258863146, 15517.767233491506, 15699.48808190684, 15760.211989400485, 15787.68424631501, 15807.841921580637, 7338.70645174187, 7525.473216874876, 7566.167721550625, 7683.846323073507, 7709.113451953097, 6677.899831502531, 6833.692483838239, 7010.509264351446, 7011.193712723, 7018.5788852669, 6948.096747422803, 7020.964895175492, 7169.318914703095, 7245.203027666952, 7250.9637451812405, 2100.3173968460005, 2105.7262555867637, 2107.083418712865, 2108.4518025313223, 2218.0, 836.8870202522703, 855.3328403845011, 873.2490058549643, 874.510274246424, 902.7788191892897, 16751.246193921303, 16904.154792260582, 17227.655446891244, 17370.478885633453, 17838.55403614894, 882.272125496468, 890.8129292848445, 892.5135800988347, 892.6652505310509, 914.5930061122737, 9208.493532855757, 9701.126898579161, 9875.259355548362, 9880.703578892644, 9892.307538472382, 353212.0, 354159.0, 355695.0, 359206.0, 359520.0, 71230.28769712236, 71869.6406517964, 72416.0, 73270.0, 73384.63307683427, 1019.4291196929743, 1055.3351388625117, 1066.1417558865187, 1071.0039663113223, 1072.3726619927274, 15109.54671359861, 15136.394544218108, 15438.0, 15618.765718514458, 15775.646788532522, 37373.43939840959, 37551.81224093862, 37662.81168594139, 37935.0, 38851.222975539764, 48289.51710482991, 49118.508814911394, 50247.23640199824, 50290.0, 50432.74783626058, 7734.574598397142, 8247.175282471944, 8399.118092600189, 8483.27892129176, 8980.506072165832, 13057.869421306046, 13086.869131308566, 13322.600321990356, 13476.595702128952, 13639.931800340935, 11421.771564568828, 11536.192466527262, 11594.826077608674, 11862.0, 11963.401829908296, 10653.520591573553, 10800.351978881292, 10823.134149267882, 10900.836487452536, 10942.835857462303, 11006.284591501526, 11578.536858525564, 11720.824187637021, 11761.941190293994, 11933.76132477363, 8079.232472915063, 8091.271785539329, 8352.081271060057, 8394.790130246793, 8437.535935523605, 11188.552457901918, 11197.72005699864, 11302.830457543309, 11325.886741132483, 11655.18413711032], "value": 8862.146127077685, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1246.2647038247433, 1306.7517171737375, 1311.5081844308384, 1314.8882345000675, 1316.756400065988, 9857.309988300813, 10282.12601928836, 10289.485525723721, 10526.157907367411, 10839.67480975572, 10561.102306303974, 10754.655668041494, 10757.946210268958, 10761.51573179207, 10773.730656733585, 2268.54629074185, 2307.5615633029756, 2310.976890231093, 2313.0169677886915, 2318.5710643531, 2120.703101565782, 2181.432827464863, 2192.265591027, 2195.045155357425, 2195.681626164205, 2136.4552039230052, 2157.2880949286778, 2162.513434477246, 2168.3278183763005, 2177.2053200581754, 2055.2601063617085, 2092.06902928197, 2093.3824521766114, 2093.4557015176088, 2097.3183715292516, 2008.7991200879942, 2029.6143732690741, 2097.2869224463757, 2170.218721260345, 2175.641019231825, 10294.691159265234, 10383.636572719919, 10409.167266618653, 10416.0, 10418.895811041868, 5183.3261675981885, 5414.025475414423, 5420.7018613976215, 5428.538574221196, 5443.129099344125, 3161.8419079046184, 3347.397468455677, 3420.675035871613, 3434.708049815769, 3448.620651728308, 1012.9037741414554, 1019.8113349030378, 1031.4481752262504, 1076.1283360478037, 1082.577794660083, 14247.287635618177, 14291.071080379847, 14349.784753228605, 14430.494932677306, 14433.494827680981, 4363.323684828857, 4386.298192289219, 4474.731516109044, 4732.053589282157, 4757.714537127784, 10589.576416943237, 10614.257002009785, 10615.416152111553, 10626.14990800734, 10665.36007839532, 5358.356997160287, 5390.595705322116, 5400.4599540046465, 5427.0773968425465, 5449.3460784706085, 4819.975900120477, 4950.0, 5053.67151135175, 5069.695818250917, 5074.391073071255, 3547.2373439710586, 3651.9269614608093, 3682.4660424238336, 3720.3861362874823, 3759.0602349412648, 1018.5009345420691, 1029.1355261580309, 1029.4866546177107, 1045.2630895218851, 1045.8012977534245, 709.61326077288, 725.1153592616998, 727.3235890621667, 736.9042024536776, 746.6901235987114, 5489.478499542537, 5539.446055394428, 5554.222408862763, 5625.606207565431, 5635.9436405635415, 529.9947000530022, 546.6364867363159, 549.5301517202814, 551.635920292605, 553.8643032457073, 3282.967170328266, 3467.4812244109826, 3756.7558108722847, 3903.8048097595574, 4304.375865499485, 12889.613311600668, 13026.41381137851, 13100.672483187996, 13573.524926627719, 13939.303034848217, 12727.93636031814, 13016.804747928789, 13037.0, 13037.934810325887, 13510.0, 7815.765527034198, 7922.0, 7928.841423171504, 7969.322607578305, 8003.239692229346, 5863.472287494146, 6058.606190597597, 6073.240844894388, 6140.109684095692, 6245.594036387621, 11977.341246231192, 12026.699332516757, 12094.818577721166, 12265.141440099107, 12515.186512876999, 12420.875791241971, 12459.190152640413, 12561.560345387868, 12617.179883307555, 12728.809067863804, 8152.184781521801, 8329.83340333202, 8421.410501264852, 8435.156484351515, 8444.859943907739, 9360.906390936276, 9461.634591352162, 9483.099105584959, 9491.430514169171, 9502.23982081418, 8005.359571234404, 8097.595120244082, 8164.510129392255, 8239.876401854097, 8450.957745211235, 8027.719029833927, 8088.919110809052, 8268.83462330762, 8320.500769953822, 8478.406511544134, 7489.887651685338, 7509.399248060251, 7574.0, 7602.1257555379625, 7623.733169339046, 5199.896002079861, 5210.6613070150315, 5276.788928442819, 5302.840914772563, 5399.163129714901, 5345.438728933562, 5391.622586418913, 5435.755391007335, 5457.072297709478, 5528.612997090326], "value": 4662.398301653, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.5769549626936, 374.6047919444985, 381.37644950505916, 382.99463907243467, 386.8317281982337, 5345.625806193568, 5496.670199788011, 5504.394516603181, 5539.9446005539985, 5550.1674748787655, 5239.371275446952, 5316.9202461963005, 5324.787008519655, 5341.439148889369, 5355.758990845412, 4040.5353384360733, 4055.128147448298, 4057.5333836608875, 4062.6749860011128, 4064.4106604542326, 3899.74651647642, 4037.37420699792, 4050.432939388473, 4052.817623206948, 4063.8984025399304, 3989.6608788253034, 4007.6793856491413, 4019.1157945252, 4025.8188381522755, 4026.939595906064, 3986.641202291793, 3993.3211354069585, 4013.3979903014488, 4018.799060046986, 4042.151148258869, 3508.614052454228, 3520.3487354839435, 3524.4184709522897, 3535.66411190939, 3536.398812201932, 5239.214117882349, 5247.291615631879, 5269.657472264291, 5305.681659100466, 5329.614300281916, 4699.342092107074, 4705.1530724469585, 4725.385699859031, 4725.929111063337, 4735.337052812609, 5528.391876893538, 5657.971710141464, 5681.176229446707, 5714.085746280617, 5723.370429252779, 3895.5520115186832, 3919.7648141111627, 3933.8819835404984, 3935.252302062599, 3941.8029098544957, 5788.8842223155725, 5976.342602313742, 6019.247594050744, 6019.398060193946, 6024.638521688757, 4022.577629348935, 4025.637692607621, 4030.778307193074, 4037.0916543777416, 4049.372347286175, 4080.4083407906282, 4089.488813898263, 4092.959070409258, 4093.7953102344763, 4103.712740108163, 4663.810728264271, 4687.7656117194, 4727.125481785881, 4734.28985652148, 4761.309610106515, 5730.598858079894, 5736.623210429467, 5736.68448235351, 5746.798862039808, 5755.079187330007, 1399.6081097292774, 1413.7770828233504, 1419.21233715289, 1420.488624095325, 1425.5723283015054, 896.0, 926.0970553710079, 937.4298050765078, 951.2295041016798, 957.0716405087194, 5049.520295571915, 5050.3939527256225, 5050.924236136461, 5065.9746701266995, 5068.265101560253, 5895.204147440127, 5922.911156332659, 5954.392314075176, 5957.880842383128, 5984.970075149684, 4860.878478038077, 4957.256411538226, 4993.80024799004, 5003.449620541737, 5009.198528235538, 3138.10563989262, 3151.196444906534, 3170.9365812684077, 3172.698593633601, 3178.586783718148, 5426.131818908955, 5503.367112782002, 5526.198701188305, 5536.695481748462, 5553.222548843165, 5996.790112346047, 6029.487493563009, 6068.605540639845, 6078.696065196811, 6105.175801266861, 5501.367342755634, 5514.255575497256, 5520.392756796749, 5520.723963801794, 5524.309461317335, 5852.7658893643775, 5880.206172166874, 5888.263967004124, 5916.437938395846, 5924.46679798803, 5863.912041319299, 5872.212422987235, 5877.29558428051, 5886.264216972879, 5894.204282421818, 5385.676859388449, 5544.63959842609, 5554.611177217717, 5558.166275058774, 5576.721163941867, 4040.373742069984, 4046.979765101156, 4063.7358571692744, 4065.16664083868, 4066.044479547363, 5916.3492015877355, 6010.639361638316, 6017.969910150421, 6023.921746997279, 6027.246594175728, 5741.8564535886935, 5779.7110144493445, 5781.952633156891, 5787.421257874347, 5789.913151302818, 5744.167095771007, 5745.224394706661, 5745.6552606843725, 5757.466714645542, 5775.393583673822, 5590.580706447114, 5652.802151924663, 5683.119116536944, 5688.601797874109, 5703.800366987136, 5790.449907258803, 5792.84143171359, 5813.970930145322, 5820.73806678692, 5832.12518122285, 5399.919001215064, 5560.888782224252, 5639.718014099197, 5657.660540367591, 5671.631343962629], "value": 4269.07256831822, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.6011553760969, 750.3247077630132, 766.9309762121411, 770.7841804294796, 776.9339606133476, 11508.942455287734, 12029.879701202985, 12809.295488748116, 13360.665983350422, 13386.866131338697, 13672.453101875913, 14020.649483762885, 14129.293535323219, 14190.148591084517, 14193.71612567748, 814.7148498025688, 836.8995720513547, 838.8154605986704, 839.3117643532306, 842.1410161635159, 904.3082042237694, 904.9638014479413, 905.248643625789, 905.7645012296784, 906.7778394293407, 962.8026254617821, 963.6819849449665, 965.4593427680486, 965.7778710896498, 966.3960024984385, 934.4533447932968, 940.501534186882, 941.2470023980823, 942.4957647658504, 942.7737343037691, 689.8034060292842, 690.102866273847, 694.8506071194718, 696.7282759723712, 698.1412862179496, 13488.0, 13656.863431365658, 13751.587452376445, 14240.572782816533, 14450.349734261983, 15488.612784680361, 15488.612784680361, 15548.533543993699, 15689.0, 15873.603159921095, 12298.446569904376, 12511.812322815165, 12518.12373133881, 12597.874021259762, 12609.0, 2926.1221633510077, 2949.27742703037, 2954.4681957247685, 2954.8079374840568, 2963.9851800741076, 66358.33641663619, 66681.66659166722, 67156.0, 68104.0, 70522.0, 9813.460259685786, 9854.950725246328, 9932.404055756677, 9950.96005318908, 9959.153471954965, 17110.82889171117, 17225.827741722424, 17355.392561260294, 17425.564360890825, 17561.648767024588, 5752.539796816244, 6270.216222972129, 6531.706073226716, 6535.8366040848405, 6555.410013098749, 2966.258435391152, 3041.072472895788, 3042.8478576071107, 3044.2998110434282, 3050.313679422157, 3249.4638384666264, 3281.278118813857, 3301.2572171261754, 3307.4212012897647, 3331.500274958727, 714.6605362452897, 716.587961921897, 721.7365661533607, 726.7565365602477, 727.0475676863326, 590.5305282300582, 591.9704014799242, 596.740417918207, 604.8487878030493, 620.5159975219336, 9719.271054670928, 9833.852492212622, 9945.900540994642, 10102.39385636864, 10287.074163325336, 565.1099518258759, 577.3995045152993, 579.8492391978116, 581.2559923298185, 597.9701014949235, 4209.074003719177, 4218.430511880918, 4223.852165174204, 4246.617804397619, 4289.764062976504, 61089.38910610926, 61284.08073878895, 62085.37914620886, 63284.36715632877, 63313.0, 55890.0, 55990.0, 56845.43154568401, 56925.71537142288, 57664.0, 48885.266720999214, 50433.74783126061, 50577.24134137991, 51132.74433627808, 51202.48797511977, 8386.664533418594, 8388.370872184732, 8458.534780587126, 8472.74581762548, 8589.098144694717, 24617.653212709756, 24845.006199751806, 25224.24327270185, 25845.612315814902, 26333.60499592546, 42098.57901420946, 42382.78808605937, 43312.0, 43949.12101758011, 44215.33676994783, 13641.658958526115, 13712.314384280946, 13910.234937078558, 14018.158910465405, 14096.859031409555, 14583.0, 14618.195999219719, 14644.0, 14657.70684586281, 14966.102033878002, 13326.133801302884, 13523.323833808467, 13723.588292351245, 13836.93081534626, 14004.929975350058, 13195.60413187606, 13323.800142998056, 13328.0, 13428.328583570586, 13428.530001449903, 13404.865951340751, 14020.439182432588, 14395.496157634432, 14595.0, 14645.121292722471, 9456.0, 9501.762455938657, 9779.462129582656, 9789.657361992297, 10125.544350504393, 10146.594136234467, 10658.253922225369, 11052.0, 11154.609588664682, 11187.384693841592], "value": 6628.754505563049, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1555.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 112.0, 110.0, 112.0, 112.0, 112.0, 113.0, 112.0, 113.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 126.0, 171.0, 130.0, 123.0, 123.0, 125.0, 145.0, 125.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 161.0, 165.0, 164.0, 165.0, 167.0, 168.0, 172.0, 164.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 78.0, 113.0, 75.0, 76.0, 75.0, 76.0, 100.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 104.0, 84.0, 83.0, 83.0, 112.0, 83.0, 82.0, 105.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 113.0, 114.0, 115.0, 115.0, 113.0, 115.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 150.0, 150.0, 149.0, 150.0, 150.0, 150.0, 149.0, 150.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 101.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 55.0, 55.0, 56.0, 56.0, 55.0, 55.0, 55.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 55.0, 56.0, 55.0, 56.0, 56.0, 55.0, 56.0, 56.0], "value": 56.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 85.0, 82.0, 102.0, 84.0, 83.0, 84.0, 85.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 150.0, 133.0, 145.0, 131.0, 132.0, 139.0, 142.0, 182.0, 166.0], "value": 146.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 196.0, 190.0, 198.0, 197.0, 191.0, 211.0, 201.0, 198.0, 201.0], "value": 196.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 75.0, 75.0, 73.0, 71.0, 79.0, 72.0, 72.0], "value": 74.0, "unit": "score"}]}]} 10:17:37 INFO - Return code: 0 10:17:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:17:37 INFO - # TBPL SUCCESS # 10:17:37 INFO - Running post-action listener: _resource_record_post_action 10:17:37 INFO - [mozharness: 2017-05-14 17:17:37.701999Z] Finished run-tests step (success) 10:17:37 INFO - Running post-run listener: _resource_record_post_run 10:17:37 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 446464; Write bytes: 391708672; Read time: 180; Write time: 250636 10:17:37 INFO - TinderboxPrint: CPU usage
13.3% 10:17:37 INFO - TinderboxPrint: I/O read bytes / time
446,464 / 180 10:17:37 INFO - TinderboxPrint: I/O write bytes / time
391,708,672 / 250,636 10:17:37 INFO - TinderboxPrint: CPU idle
8,279.7 (86.7%) 10:17:37 INFO - TinderboxPrint: CPU user
1,218.1 (12.8%) 10:17:37 INFO - TinderboxPrint: Swap in / out
0 / 0 10:17:37 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 119070720; Read time: 52; Write time: 98168 10:17:37 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 438272; Write bytes: 272637952; Read time: 116; Write time: 152468 10:17:38 INFO - Running post-run listener: _upload_blobber_files 10:17:38 INFO - Blob upload gear active. 10:17:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:17:38 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:17:38 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:17:38 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:17:38 INFO - (blobuploader) - INFO - Open directory for files ... 10:17:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:17:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:17:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:39 INFO - (blobuploader) - INFO - Done attempting. 10:17:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:17:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:17:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:42 INFO - (blobuploader) - INFO - Done attempting. 10:17:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:17:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:17:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:43 INFO - (blobuploader) - INFO - Done attempting. 10:17:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:17:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:17:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:44 INFO - (blobuploader) - INFO - Done attempting. 10:17:44 INFO - (blobuploader) - INFO - Iteration through files over. 10:17:44 INFO - Return code: 0 10:17:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:17:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:17:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/126933d97a9392fefd0bb8805da8423829b280220410df441a792155441c3036b392b887ee1e1a8aca5a975d62ada01999ababd6a774b2117af87a18ac4e7fbd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ca13766ba50374ea148543fdf8634dd11c7f1a578091bb34e73778ac700f5756e50ec804a211ee408114ada81d5bab536f18670809a1b3baf88c5338dc57928", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e01460e563feadbbf4c10605fc4d66326ee3b4664f512c04e75cef4440f1e2956dc5f9eb52942f9747ecac5fd0e4440d58b86438e4840f26dfdf6edc1b9c014c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5eff317b26171ac5f6e0fcf84981bad021df73233c9878f5c39bd81df1326304cce372b03225ad06d798f148bcbf8554f083af7219713f445f2a14069221ee0"} 10:17:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:17:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:17:44 INFO - Contents: 10:17:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/126933d97a9392fefd0bb8805da8423829b280220410df441a792155441c3036b392b887ee1e1a8aca5a975d62ada01999ababd6a774b2117af87a18ac4e7fbd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ca13766ba50374ea148543fdf8634dd11c7f1a578091bb34e73778ac700f5756e50ec804a211ee408114ada81d5bab536f18670809a1b3baf88c5338dc57928", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e01460e563feadbbf4c10605fc4d66326ee3b4664f512c04e75cef4440f1e2956dc5f9eb52942f9747ecac5fd0e4440d58b86438e4840f26dfdf6edc1b9c014c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5eff317b26171ac5f6e0fcf84981bad021df73233c9878f5c39bd81df1326304cce372b03225ad06d798f148bcbf8554f083af7219713f445f2a14069221ee0"} 10:17:44 INFO - Running post-run listener: copy_logs_to_upload_dir 10:17:44 INFO - Copying logs to upload dir... 10:17:44 INFO - mkdir: /builds/slave/test/build/upload/logs 10:17:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.394382 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-14 10:17:44.337665) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-14 10:17:44.343342) ========= 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=ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583 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/126933d97a9392fefd0bb8805da8423829b280220410df441a792155441c3036b392b887ee1e1a8aca5a975d62ada01999ababd6a774b2117af87a18ac4e7fbd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ca13766ba50374ea148543fdf8634dd11c7f1a578091bb34e73778ac700f5756e50ec804a211ee408114ada81d5bab536f18670809a1b3baf88c5338dc57928", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e01460e563feadbbf4c10605fc4d66326ee3b4664f512c04e75cef4440f1e2956dc5f9eb52942f9747ecac5fd0e4440d58b86438e4840f26dfdf6edc1b9c014c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5eff317b26171ac5f6e0fcf84981bad021df73233c9878f5c39bd81df1326304cce372b03225ad06d798f148bcbf8554f083af7219713f445f2a14069221ee0"} build_url:https://queue.taskcluster.net/v1/task/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011141 build_url: 'https://queue.taskcluster.net/v1/task/WVX3sMNgSNGYmFIwYEMsEg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/126933d97a9392fefd0bb8805da8423829b280220410df441a792155441c3036b392b887ee1e1a8aca5a975d62ada01999ababd6a774b2117af87a18ac4e7fbd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ca13766ba50374ea148543fdf8634dd11c7f1a578091bb34e73778ac700f5756e50ec804a211ee408114ada81d5bab536f18670809a1b3baf88c5338dc57928", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e01460e563feadbbf4c10605fc4d66326ee3b4664f512c04e75cef4440f1e2956dc5f9eb52942f9747ecac5fd0e4440d58b86438e4840f26dfdf6edc1b9c014c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5eff317b26171ac5f6e0fcf84981bad021df73233c9878f5c39bd81df1326304cce372b03225ad06d798f148bcbf8554f083af7219713f445f2a14069221ee0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-14 10:17:44.369007) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 10:17:44.369337) ========= 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=ed14279e38b05397cf4aa391000001a4-1494776474.680941-1470368583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 10:17:44.454958) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-14 10:17:44.455348) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-14 10:17:44.455651) ========= ========= Total master_lag: 0.17 =========