builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1495571449.35 results: success (0) revision: 1ce55499e8193d53aeff91546b16e0c580ebd6f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-23 13:30:49.348794) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-23 13:30:49.349223) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-23 13:30:49.349524) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-23 13:30:49.364913) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 13:30:49.365201) ========= 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=20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-23 13:30:49-- 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% 23.9M=0s 2017-05-23 13:30:49 (23.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127915 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 13:30:49.505962) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 13:30:49.509279) ========= 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=20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019593 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 13:30:49.558982) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-23 13:30:49.560337) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1ce55499e8193d53aeff91546b16e0c580ebd6f1 --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 1ce55499e8193d53aeff91546b16e0c580ebd6f1 --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=20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-23 13:30:49,929 truncating revision to first 12 chars 2017-05-23 13:30:49,929 Setting DEBUG logging. 2017-05-23 13:30:49,929 attempt 1/10 2017-05-23 13:30:49,930 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1ce55499e819?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-23 13:30:50,747 unpacking tar archive at: mozilla-central-1ce55499e819/testing/mozharness/ program finished with exit code 0 elapsedTime=1.082428 ========= master_lag: 0.19 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-23 13:30:50.830730) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-23 13:30:50.831044) ========= script_repo_revision: 1ce55499e8193d53aeff91546b16e0c580ebd6f1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-23 13:30:50.831435) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-23 13:30:50.831701) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-23 13:30:50.845654) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-05-23 13:30:50.845976) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:30:51 INFO - MultiFileLogger online at 20170523 13:30:51 in /builds/slave/test 13:30:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 13:30:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:30:51 INFO - {'append_to_log': False, 13:30:51 INFO - 'base_work_dir': '/builds/slave/test', 13:30:51 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 13:30:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:30:51 INFO - 'branch': 'Firefox-Non-PGO', 13:30:51 INFO - 'buildbot_json_path': 'buildprops.json', 13:30:51 INFO - 'config_files': ('talos/linux_config.py',), 13:30:51 INFO - 'default_actions': ('clobber', 13:30:51 INFO - 'read-buildbot-config', 13:30:51 INFO - 'download-and-extract', 13:30:51 INFO - 'populate-webroot', 13:30:51 INFO - 'create-virtualenv', 13:30:51 INFO - 'install', 13:30:51 INFO - 'run-tests'), 13:30:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:30:51 INFO - 'download_minidump_stackwalk': True, 13:30:51 INFO - 'download_symbols': 'ondemand', 13:30:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:30:51 INFO - 'tooltool.py': '/tools/tooltool.py', 13:30:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:30:51 INFO - '/tools/misc-python/virtualenv.py')}, 13:30:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:30:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:30:51 INFO - 'gecko_profile': False, 13:30:51 INFO - 'gecko_profile_interval': 0, 13:30:51 INFO - 'installer_path': 'installer.exe', 13:30:51 INFO - 'log_level': 'info', 13:30:51 INFO - 'log_name': 'talos', 13:30:51 INFO - 'log_to_console': True, 13:30:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:30:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:30:51 INFO - 'opt_config_files': (), 13:30:51 INFO - 'pip_index': False, 13:30:51 INFO - 'suite': 'dromaeojs-e10s', 13:30:51 INFO - 'system_bits': '32', 13:30:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:30:51 INFO - 'title': 'talos-linux64-ix-015', 13:30:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:30:51 INFO - 'use_talos_json': True, 13:30:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:30:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:30:51 INFO - 'work_dir': 'build'} 13:30:51 INFO - [mozharness: 2017-05-23 20:30:51.320639Z] Running clobber step. 13:30:51 INFO - Running pre-action listener: _resource_record_pre_action 13:30:51 INFO - Running main action method: clobber 13:30:51 INFO - rmtree: /builds/slave/test/build 13:30:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:30:52 INFO - Running post-action listener: _resource_record_post_action 13:30:52 INFO - [mozharness: 2017-05-23 20:30:52.946255Z] Finished clobber step (success) 13:30:52 INFO - [mozharness: 2017-05-23 20:30:52.946353Z] Running read-buildbot-config step. 13:30:52 INFO - Running pre-action listener: _resource_record_pre_action 13:30:52 INFO - Running main action method: read_buildbot_config 13:30:52 INFO - Using buildbot properties: 13:30:52 INFO - { 13:30:52 INFO - "project": "", 13:30:52 INFO - "product": "firefox", 13:30:52 INFO - "who": "kwierso@gmail.com", 13:30:52 INFO - "installer_path": "public/build/target.tar.bz2", 13:30:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 13:30:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 13:30:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 13:30:52 INFO - "stage_platform": "linux64", 13:30:52 INFO - "basedir": "/builds/slave/test", 13:30:52 INFO - "buildnumber": 625, 13:30:52 INFO - "platform": "ubuntu64_hw", 13:30:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:30:52 INFO - "slavebuilddir": "test", 13:30:52 INFO - "taskId": "SJhQOBAVQ1eZt-zvrjP3-w", 13:30:52 INFO - "branch": "mozilla-central", 13:30:52 INFO - "script_repo_revision": "production", 13:30:52 INFO - "revision": "1ce55499e8193d53aeff91546b16e0c580ebd6f1", 13:30:52 INFO - "slavename": "talos-linux64-ix-015", 13:30:52 INFO - "repo_path": "mozilla-central" 13:30:52 INFO - } 13:30:52 INFO - Finding installer, test and symbols from parent task. 13:30:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SJhQOBAVQ1eZt-zvrjP3-w'}, attempt #1 13:30:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SJhQOBAVQ1eZt-zvrjP3-w'}, attempt #1 13:30:53 INFO - Task dependencies: MOS5bP-qSIKODkKS8t6IqQ 13:30:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ'}, attempt #1 13:30:54 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/target.tar.bz2 13:30:54 INFO - Set test_url: https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/test_packages.json 13:30:54 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/target.crashreporter-symbols.zip 13:30:54 INFO - Running post-action listener: _resource_record_post_action 13:30:54 INFO - [mozharness: 2017-05-23 20:30:54.345789Z] Finished read-buildbot-config step (success) 13:30:54 INFO - [mozharness: 2017-05-23 20:30:54.346011Z] Running download-and-extract step. 13:30:54 INFO - Running pre-action listener: _resource_record_pre_action 13:30:54 INFO - Running main action method: download_and_extract 13:30:54 INFO - mkdir: /builds/slave/test/build/tests 13:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:30:54 INFO - trying https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/target.test_packages.json 13:30:54 INFO - Downloading https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:30:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:30:55 INFO - Downloaded 986 bytes. 13:30:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:30:55 INFO - Using the following test package requirements: 13:30:55 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:30:55 INFO - u'common': [u'target.common.tests.zip'], 13:30:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:30:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:30:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:30:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:30:55 INFO - u'mozbase': [u'target.common.tests.zip'], 13:30:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:30:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:30:55 INFO - u'web-platform': [u'target.common.tests.zip', 13:30:55 INFO - u'target.web-platform.tests.zip'], 13:30:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:30:55 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 13:30:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/target.common.tests.zip 13:30:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:30:55 INFO - Fetch https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/target.common.tests.zip into memory 13:30:57 INFO - Content-Length response header: 63522557 13:30:57 INFO - Bytes received: 63522557 13:31:08 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 13:31:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/target.common.tests.zip 13:31:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:31:08 INFO - Fetch https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/target.common.tests.zip into memory 13:31:09 INFO - Content-Length response header: 63522557 13:31:09 INFO - Bytes received: 63522557 13:31:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/target.talos.tests.zip 13:31:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:31:21 INFO - Fetch https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/target.talos.tests.zip into memory 13:31:22 INFO - Content-Length response header: 14410000 13:31:22 INFO - Bytes received: 14410000 13:31:22 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')]} 13:31:22 INFO - trying https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/target.tar.bz2 13:31:22 INFO - Downloading https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:31:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:31:23 INFO - Downloaded 54897392 bytes. 13:31:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/target.tar.bz2 13:31:23 INFO - mkdir: /builds/slave/test/properties 13:31:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:31:23 INFO - Writing to file /builds/slave/test/properties/build_url 13:31:23 INFO - Contents: 13:31:23 INFO - build_url:https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/target.tar.bz2 13:31:23 INFO - Running post-action listener: _resource_record_post_action 13:31:23 INFO - Running post-action listener: set_extra_try_arguments 13:31:23 INFO - [mozharness: 2017-05-23 20:31:23.979407Z] Finished download-and-extract step (success) 13:31:23 INFO - [mozharness: 2017-05-23 20:31:23.979536Z] Running populate-webroot step. 13:31:23 INFO - Running pre-action listener: _resource_record_pre_action 13:31:23 INFO - Running main action method: populate_webroot 13:31:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:31:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:31:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:31:23 INFO - '--tppagecycles', 13:31:23 INFO - '7'], 13:31:23 INFO - 'tests': ['tsvgm']}}, 13:31:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:31:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:31:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:31:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:31:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:31:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:31:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:31:23 INFO - 'talos_options': ['--disable-e10s'], 13:31:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:31:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:31:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:31:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:31:23 INFO - 'talos_options': ['--disable-e10s'], 13:31:23 INFO - 'tests': ['damp', 'tps']}, 13:31:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:31:23 INFO - 'tests': ['damp', 'tps']}, 13:31:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:31:23 INFO - 'tests': ['dromaeo_dom']}, 13:31:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:31:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:31:23 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 13:31:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:31:23 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:31:23 INFO - 'tests': ['ts_paint', 'tp5o']}, 13:31:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:31:23 INFO - 'tests': ['a11yr', 13:31:23 INFO - 'ts_paint', 13:31:23 INFO - 'tpaint', 13:31:23 INFO - 'sessionrestore', 13:31:23 INFO - 'sessionrestore_no_auto_restore', 13:31:23 INFO - 'tabpaint']}, 13:31:23 INFO - 'other-e10s': {'tests': ['a11yr', 13:31:23 INFO - 'ts_paint', 13:31:23 INFO - 'tpaint', 13:31:23 INFO - 'sessionrestore', 13:31:23 INFO - 'sessionrestore_no_auto_restore', 13:31:23 INFO - 'tabpaint']}, 13:31:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:31:23 INFO - 'ts_paint', 13:31:23 INFO - 'tpaint', 13:31:23 INFO - 'sessionrestore', 13:31:23 INFO - 'sessionrestore_no_auto_restore', 13:31:23 INFO - 'tabpaint']}, 13:31:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:31:23 INFO - 'ts_paint', 13:31:23 INFO - 'tpaint', 13:31:23 INFO - 'sessionrestore', 13:31:23 INFO - 'sessionrestore_no_auto_restore', 13:31:23 INFO - 'tabpaint']}, 13:31:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:31:23 INFO - 'tests': ['a11yr', 13:31:23 INFO - 'ts_paint', 13:31:23 INFO - 'tpaint', 13:31:23 INFO - 'sessionrestore', 13:31:23 INFO - 'sessionrestore_no_auto_restore', 13:31:23 INFO - 'tabpaint']}, 13:31:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:31:23 INFO - 'tests': ['a11yr', 13:31:23 INFO - 'ts_paint', 13:31:23 INFO - 'tpaint', 13:31:23 INFO - 'sessionrestore', 13:31:23 INFO - 'sessionrestore_no_auto_restore', 13:31:23 INFO - 'tabpaint']}, 13:31:23 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 13:31:23 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 13:31:23 INFO - 'bloom_basic_ref']}, 13:31:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:31:23 INFO - 'tests': ['tsvgx', 13:31:23 INFO - 'tsvgr_opacity', 13:31:23 INFO - 'tart', 13:31:23 INFO - 'tscrollx', 13:31:23 INFO - 'cart', 13:31:23 INFO - 'tsvg_static']}, 13:31:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:31:23 INFO - 'tsvgr_opacity', 13:31:23 INFO - 'tart', 13:31:23 INFO - 'tscrollx', 13:31:23 INFO - 'cart', 13:31:23 INFO - 'tsvg_static']}, 13:31:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:31:23 INFO - 'talos_options': ['--disable-e10s'], 13:31:23 INFO - 'tests': ['tp5o']}, 13:31:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:31:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:31:23 INFO - 'talos_options': ['--disable-e10s', 13:31:23 INFO - '--xperf_path', 13:31:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:31:23 INFO - 'tests': ['tp5n']}, 13:31:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:31:23 INFO - 'talos_options': ['--xperf_path', 13:31:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:31:23 INFO - 'tests': ['tp5n']}}, 13:31:23 INFO - 'talos.zip': {'path': '', 13:31:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:31:23 INFO - Running post-action listener: _resource_record_post_action 13:31:23 INFO - [mozharness: 2017-05-23 20:31:23.995140Z] Finished populate-webroot step (success) 13:31:23 INFO - [mozharness: 2017-05-23 20:31:23.995230Z] Running create-virtualenv step. 13:31:23 INFO - Running pre-action listener: _resource_record_pre_action 13:31:23 INFO - Running main action method: create_virtualenv 13:31:23 INFO - Creating virtualenv /builds/slave/test/build/venv 13:31:23 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:31:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:31:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:31:24 INFO - Using real prefix '/usr' 13:31:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:31:24 INFO - Installing distribute.............................................................................................................................................................................................done. 13:31:26 INFO - Installing pip.................done. 13:31:26 INFO - Return code: 0 13:31:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:31:26 INFO - Reading from file tmpfile_stdout 13:31:26 INFO - Output received: 13:31:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:31:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dda7a0>, '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 0x1ddb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddbb30>, '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': '20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987', '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 13:31:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:31:26 INFO - Using env: {'DISPLAY': ':0', 13:31:26 INFO - 'HOME': '/home/cltbld', 13:31:26 INFO - 'LANG': 'en_US.UTF-8', 13:31:26 INFO - 'LANGUAGE': 'en_US:en', 13:31:26 INFO - 'LOGNAME': 'cltbld', 13:31:26 INFO - 'MAIL': '/var/mail/cltbld', 13:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:26 INFO - 'MOZ_NO_REMOTE': '1', 13:31:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:26 INFO - 'NO_EM_RESTART': '1', 13:31:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:26 INFO - 'PWD': '/builds/slave/test', 13:31:26 INFO - 'SHELL': '/bin/bash', 13:31:26 INFO - 'SHLVL': '1', 13:31:26 INFO - 'TERM': 'linux', 13:31:26 INFO - 'TMOUT': '86400', 13:31:26 INFO - 'USER': 'cltbld', 13:31:26 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987', 13:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:26 INFO - '_': '/tools/buildbot/bin/python'} 13:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:31:26 INFO - Cleaning up... 13:31:26 INFO - Return code: 0 13:31:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dda7a0>, '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 0x1ddb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddbb30>, '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': '20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987', '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 13:31:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:31:26 INFO - Using env: {'DISPLAY': ':0', 13:31:26 INFO - 'HOME': '/home/cltbld', 13:31:26 INFO - 'LANG': 'en_US.UTF-8', 13:31:27 INFO - 'LANGUAGE': 'en_US:en', 13:31:27 INFO - 'LOGNAME': 'cltbld', 13:31:27 INFO - 'MAIL': '/var/mail/cltbld', 13:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:27 INFO - 'MOZ_NO_REMOTE': '1', 13:31:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:27 INFO - 'NO_EM_RESTART': '1', 13:31:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:27 INFO - 'PWD': '/builds/slave/test', 13:31:27 INFO - 'SHELL': '/bin/bash', 13:31:27 INFO - 'SHLVL': '1', 13:31:27 INFO - 'TERM': 'linux', 13:31:27 INFO - 'TMOUT': '86400', 13:31:27 INFO - 'USER': 'cltbld', 13:31:27 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987', 13:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:27 INFO - '_': '/tools/buildbot/bin/python'} 13:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:27 INFO - Downloading/unpacking psutil>=3.1.1 13:31: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 13:31: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 13:31: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 13:31: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 13:31:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:31:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:31:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:31:28 INFO - Installing collected packages: psutil 13:31:28 INFO - Running setup.py install for psutil 13:31:28 INFO - building 'psutil._psutil_linux' extension 13:31:28 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 13:31:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:31:28 INFO - building 'psutil._psutil_posix' extension 13:31:28 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 13:31:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:31:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:31:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:31:28 INFO - Successfully installed psutil 13:31:28 INFO - Cleaning up... 13:31:28 INFO - Return code: 0 13:31:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:31: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')]} 13:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31: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')]} 13:31:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dda7a0>, '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 0x1ddb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddbb30>, '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': '20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987', '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 13:31: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:31: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 mozsystemmonitor==0.3 13:31:28 INFO - Using env: {'DISPLAY': ':0', 13:31:28 INFO - 'HOME': '/home/cltbld', 13:31:28 INFO - 'LANG': 'en_US.UTF-8', 13:31:28 INFO - 'LANGUAGE': 'en_US:en', 13:31:28 INFO - 'LOGNAME': 'cltbld', 13:31:28 INFO - 'MAIL': '/var/mail/cltbld', 13:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:28 INFO - 'MOZ_NO_REMOTE': '1', 13:31:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:28 INFO - 'NO_EM_RESTART': '1', 13:31:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:28 INFO - 'PWD': '/builds/slave/test', 13:31:28 INFO - 'SHELL': '/bin/bash', 13:31:28 INFO - 'SHLVL': '1', 13:31:28 INFO - 'TERM': 'linux', 13:31:28 INFO - 'TMOUT': '86400', 13:31:28 INFO - 'USER': 'cltbld', 13:31:28 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987', 13:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:28 INFO - '_': '/tools/buildbot/bin/python'} 13:31:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:31:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:31:30 INFO - Installing collected packages: mozsystemmonitor 13:31:30 INFO - Running setup.py install for mozsystemmonitor 13:31:30 INFO - Successfully installed mozsystemmonitor 13:31:30 INFO - Cleaning up... 13:31:30 INFO - Return code: 0 13:31:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:31: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')]} 13:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31: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')]} 13:31:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dda7a0>, '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 0x1ddb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddbb30>, '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': '20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987', '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 13:31:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:31:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:31:30 INFO - Using env: {'DISPLAY': ':0', 13:31:30 INFO - 'HOME': '/home/cltbld', 13:31:30 INFO - 'LANG': 'en_US.UTF-8', 13:31:30 INFO - 'LANGUAGE': 'en_US:en', 13:31:30 INFO - 'LOGNAME': 'cltbld', 13:31:30 INFO - 'MAIL': '/var/mail/cltbld', 13:31:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:30 INFO - 'MOZ_NO_REMOTE': '1', 13:31:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:30 INFO - 'NO_EM_RESTART': '1', 13:31:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:30 INFO - 'PWD': '/builds/slave/test', 13:31:30 INFO - 'SHELL': '/bin/bash', 13:31:30 INFO - 'SHLVL': '1', 13:31:30 INFO - 'TERM': 'linux', 13:31:30 INFO - 'TMOUT': '86400', 13:31:30 INFO - 'USER': 'cltbld', 13:31:30 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987', 13:31:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:30 INFO - '_': '/tools/buildbot/bin/python'} 13:31:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:30 INFO - Downloading/unpacking jsonschema==2.5.1 13:31: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 13:31: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 13:31: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 13:31: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 13:31:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:31:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:31 INFO - Downloading functools32-3.2.3-2.tar.gz 13:31:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:31:31 INFO - warning: no files found matching '*.txt' 13:31:31 INFO - no previously-included directories found matching 'build' 13:31:31 INFO - no previously-included directories found matching 'dist' 13:31:31 INFO - no previously-included directories found matching '.git*' 13:31:31 INFO - Installing collected packages: jsonschema, functools32 13:31:31 INFO - Running setup.py install for functools32 13:31:32 INFO - warning: no files found matching '*.txt' 13:31:32 INFO - no previously-included directories found matching 'build' 13:31:32 INFO - no previously-included directories found matching 'dist' 13:31:32 INFO - no previously-included directories found matching '.git*' 13:31:32 INFO - Successfully installed jsonschema functools32 13:31:32 INFO - Cleaning up... 13:31:32 INFO - Return code: 0 13:31:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dda7a0>, '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 0x1ddb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddbb30>, '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': '20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987', '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 13:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:31:32 INFO - Using env: {'DISPLAY': ':0', 13:31:32 INFO - 'HOME': '/home/cltbld', 13:31:32 INFO - 'LANG': 'en_US.UTF-8', 13:31:32 INFO - 'LANGUAGE': 'en_US:en', 13:31:32 INFO - 'LOGNAME': 'cltbld', 13:31:32 INFO - 'MAIL': '/var/mail/cltbld', 13:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:32 INFO - 'MOZ_NO_REMOTE': '1', 13:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:32 INFO - 'NO_EM_RESTART': '1', 13:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:32 INFO - 'PWD': '/builds/slave/test', 13:31:32 INFO - 'SHELL': '/bin/bash', 13:31:32 INFO - 'SHLVL': '1', 13:31:32 INFO - 'TERM': 'linux', 13:31:32 INFO - 'TMOUT': '86400', 13:31:32 INFO - 'USER': 'cltbld', 13:31:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987', 13:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:32 INFO - '_': '/tools/buildbot/bin/python'} 13:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:31:32 INFO - Cleaning up... 13:31:32 INFO - Return code: 0 13:31:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dda7a0>, '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 0x1ddb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddbb30>, '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': '20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987', '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 13:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:31:32 INFO - Using env: {'DISPLAY': ':0', 13:31:32 INFO - 'HOME': '/home/cltbld', 13:31:32 INFO - 'LANG': 'en_US.UTF-8', 13:31:32 INFO - 'LANGUAGE': 'en_US:en', 13:31:32 INFO - 'LOGNAME': 'cltbld', 13:31:32 INFO - 'MAIL': '/var/mail/cltbld', 13:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:32 INFO - 'MOZ_NO_REMOTE': '1', 13:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:32 INFO - 'NO_EM_RESTART': '1', 13:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:32 INFO - 'PWD': '/builds/slave/test', 13:31:32 INFO - 'SHELL': '/bin/bash', 13:31:32 INFO - 'SHLVL': '1', 13:31:32 INFO - 'TERM': 'linux', 13:31:32 INFO - 'TMOUT': '86400', 13:31:32 INFO - 'USER': 'cltbld', 13:31:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987', 13:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:32 INFO - '_': '/tools/buildbot/bin/python'} 13:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:32 INFO - Downloading/unpacking blobuploader==1.2.4 13:31: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 13:31: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 13:31: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 13:31: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 13:31:33 INFO - Downloading blobuploader-1.2.4.tar.gz 13:31:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:31:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:31:33 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 13:31:33 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 13:31:33 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 13:31:33 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 13:31:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:31:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:34 INFO - Downloading docopt-0.6.1.tar.gz 13:31:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:31:34 INFO - Installing collected packages: blobuploader, requests, docopt 13:31:34 INFO - Running setup.py install for blobuploader 13:31:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:31:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:31:34 INFO - Running setup.py install for requests 13:31:34 INFO - Running setup.py install for docopt 13:31:34 INFO - Successfully installed blobuploader requests docopt 13:31:34 INFO - Cleaning up... 13:31:34 INFO - Return code: 0 13:31:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:31:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:34 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 0x1a6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dda7a0>, '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 0x1ddb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddbb30>, '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': '20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987', '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 13:31:34 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 13:31:34 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 13:31:34 INFO - Using env: {'DISPLAY': ':0', 13:31:34 INFO - 'HOME': '/home/cltbld', 13:31:34 INFO - 'LANG': 'en_US.UTF-8', 13:31:34 INFO - 'LANGUAGE': 'en_US:en', 13:31:34 INFO - 'LOGNAME': 'cltbld', 13:31:34 INFO - 'MAIL': '/var/mail/cltbld', 13:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:34 INFO - 'MOZ_NO_REMOTE': '1', 13:31:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:34 INFO - 'NO_EM_RESTART': '1', 13:31:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:34 INFO - 'PWD': '/builds/slave/test', 13:31:34 INFO - 'SHELL': '/bin/bash', 13:31:34 INFO - 'SHLVL': '1', 13:31:34 INFO - 'TERM': 'linux', 13:31:34 INFO - 'TMOUT': '86400', 13:31:34 INFO - 'USER': 'cltbld', 13:31:34 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987', 13:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:34 INFO - '_': '/tools/buildbot/bin/python'} 13:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:31:35 INFO - Running setup.py (path:/tmp/pip-8O5bDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:31:35 INFO - Running setup.py (path:/tmp/pip-9G0bgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:31:35 INFO - Running setup.py (path:/tmp/pip-iqBwxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:31:35 INFO - Running setup.py (path:/tmp/pip-EfY3dD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:31:35 INFO - Running setup.py (path:/tmp/pip-t4_Ujk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:31:35 INFO - Running setup.py (path:/tmp/pip-qECuF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:31:35 INFO - Running setup.py (path:/tmp/pip-24PRH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:31:35 INFO - Running setup.py (path:/tmp/pip-r25okH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:31:35 INFO - Running setup.py (path:/tmp/pip-BNco1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:31:35 INFO - Running setup.py (path:/tmp/pip-MPZIr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:31:35 INFO - Running setup.py (path:/tmp/pip-hLRSQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:31:35 INFO - Running setup.py (path:/tmp/pip-oPZSmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:31:35 INFO - Running setup.py (path:/tmp/pip-s_pO16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:31:35 INFO - Running setup.py (path:/tmp/pip-3Du5CR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:31:36 INFO - Running setup.py (path:/tmp/pip-RediEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:31:36 INFO - Running setup.py (path:/tmp/pip-7czfZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:31:36 INFO - Running setup.py (path:/tmp/pip-PwbjDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:31:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:31:36 INFO - Running setup.py install for manifestparser 13:31:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:31:36 INFO - Running setup.py install for mozcrash 13:31:36 INFO - Running setup.py install for mozdebug 13:31:36 INFO - Running setup.py install for mozdevice 13:31:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:31:36 INFO - Running setup.py install for mozfile 13:31:36 INFO - Running setup.py install for mozhttpd 13:31:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:31:36 INFO - Running setup.py install for mozinfo 13:31:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:31:36 INFO - Running setup.py install for mozInstall 13:31:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:31:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:31:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:31:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:31:37 INFO - Running setup.py install for mozleak 13:31:37 INFO - Running setup.py install for mozlog 13:31:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:31:37 INFO - Running setup.py install for moznetwork 13:31:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:31:37 INFO - Running setup.py install for mozprocess 13:31:37 INFO - Running setup.py install for mozprofile 13:31:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:31:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:31:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:31:37 INFO - Running setup.py install for mozrunner 13:31:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:31:37 INFO - Running setup.py install for mozscreenshot 13:31:37 INFO - Running setup.py install for moztest 13:31:37 INFO - Running setup.py install for mozversion 13:31:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:31:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:31:38 INFO - Cleaning up... 13:31:38 INFO - Return code: 0 13:31:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dda7a0>, '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 0x1ddb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddbb30>, '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': '20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987', '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 13:31:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:31:38 INFO - Using env: {'DISPLAY': ':0', 13:31:38 INFO - 'HOME': '/home/cltbld', 13:31:38 INFO - 'LANG': 'en_US.UTF-8', 13:31:38 INFO - 'LANGUAGE': 'en_US:en', 13:31:38 INFO - 'LOGNAME': 'cltbld', 13:31:38 INFO - 'MAIL': '/var/mail/cltbld', 13:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:38 INFO - 'MOZ_NO_REMOTE': '1', 13:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:38 INFO - 'NO_EM_RESTART': '1', 13:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:38 INFO - 'PWD': '/builds/slave/test', 13:31:38 INFO - 'SHELL': '/bin/bash', 13:31:38 INFO - 'SHLVL': '1', 13:31:38 INFO - 'TERM': 'linux', 13:31:38 INFO - 'TMOUT': '86400', 13:31:38 INFO - 'USER': 'cltbld', 13:31:38 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987', 13:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:38 INFO - '_': '/tools/buildbot/bin/python'} 13:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:31:38 INFO - Running setup.py (path:/tmp/pip-n1x9Lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:31:38 INFO - Running setup.py (path:/tmp/pip-Mru4en-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:31:38 INFO - Running setup.py (path:/tmp/pip-FdVy1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:31:38 INFO - Running setup.py (path:/tmp/pip-ApiG4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:31:38 INFO - Running setup.py (path:/tmp/pip-rH_4OW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:31:38 INFO - Running setup.py (path:/tmp/pip-4uqBaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:31:38 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)) 13:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:31:38 INFO - Running setup.py (path:/tmp/pip-HhDQrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:31:38 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)) 13:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:31:38 INFO - Running setup.py (path:/tmp/pip-tztY_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:31:38 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)) 13:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:31:38 INFO - Running setup.py (path:/tmp/pip-6shvD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:31:38 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)) 13:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:31:38 INFO - Running setup.py (path:/tmp/pip-hTRJdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:31:38 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)) 13:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:31:38 INFO - Running setup.py (path:/tmp/pip-NIGsp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:31:39 INFO - Running setup.py (path:/tmp/pip-EgUF6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:31:39 INFO - Running setup.py (path:/tmp/pip-i0ghT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:31:39 INFO - Running setup.py (path:/tmp/pip-yns1Cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:31:39 INFO - Running setup.py (path:/tmp/pip-LvV4Pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:31:39 INFO - Running setup.py (path:/tmp/pip-f84Ocs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:31:39 INFO - Running setup.py (path:/tmp/pip-_O2gAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:31:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:40 INFO - Downloading blessings-1.6.tar.gz 13:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:31:40 INFO - Installing collected packages: blessings 13:31:40 INFO - Running setup.py install for blessings 13:31:40 INFO - Successfully installed blessings 13:31:40 INFO - Cleaning up... 13:31:40 INFO - Return code: 0 13:31:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:31:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:31:41 INFO - Reading from file tmpfile_stdout 13:31:41 INFO - Current package versions: 13:31:41 INFO - argparse == 1.2.1 13:31:41 INFO - blessings == 1.6 13:31:41 INFO - blobuploader == 1.2.4 13:31:41 INFO - docopt == 0.6.1 13:31:41 INFO - functools32 == 3.2.3-2 13:31:41 INFO - jsonschema == 2.5.1 13:31:41 INFO - manifestparser == 1.1 13:31:41 INFO - mozInstall == 1.12 13:31:41 INFO - mozcrash == 1.0 13:31:41 INFO - mozdebug == 0.1 13:31:41 INFO - mozdevice == 0.50 13:31:41 INFO - mozfile == 1.2 13:31:41 INFO - mozhttpd == 0.7 13:31:41 INFO - mozinfo == 0.9 13:31:41 INFO - mozleak == 0.1 13:31:41 INFO - mozlog == 3.4 13:31:41 INFO - moznetwork == 0.27 13:31:41 INFO - mozprocess == 0.25 13:31:41 INFO - mozprofile == 0.28 13:31:41 INFO - mozrunner == 6.13 13:31:41 INFO - mozscreenshot == 0.1 13:31:41 INFO - mozsystemmonitor == 0.3 13:31:41 INFO - moztest == 0.8 13:31:41 INFO - mozversion == 1.4 13:31:41 INFO - psutil == 3.1.1 13:31:41 INFO - requests == 1.2.3 13:31:41 INFO - wsgiref == 0.1.2 13:31:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dda7a0>, '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 0x1ddb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddbb30>, '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': '20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987', '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 13:31:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:31:41 INFO - Using env: {'DISPLAY': ':0', 13:31:41 INFO - 'HOME': '/home/cltbld', 13:31:41 INFO - 'LANG': 'en_US.UTF-8', 13:31:41 INFO - 'LANGUAGE': 'en_US:en', 13:31:41 INFO - 'LOGNAME': 'cltbld', 13:31:41 INFO - 'MAIL': '/var/mail/cltbld', 13:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:41 INFO - 'MOZ_NO_REMOTE': '1', 13:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:41 INFO - 'NO_EM_RESTART': '1', 13:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:41 INFO - 'PWD': '/builds/slave/test', 13:31:41 INFO - 'SHELL': '/bin/bash', 13:31:41 INFO - 'SHLVL': '1', 13:31:41 INFO - 'TERM': 'linux', 13:31:41 INFO - 'TMOUT': '86400', 13:31:41 INFO - 'USER': 'cltbld', 13:31:41 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987', 13:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:41 INFO - '_': '/tools/buildbot/bin/python'} 13:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:31:41 INFO - Cleaning up... 13:31:41 INFO - Return code: 0 13:31:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dda7a0>, '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 0x1ddb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddbb30>, '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': '20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987', '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 13:31:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:31:41 INFO - Using env: {'DISPLAY': ':0', 13:31:41 INFO - 'HOME': '/home/cltbld', 13:31:41 INFO - 'LANG': 'en_US.UTF-8', 13:31:41 INFO - 'LANGUAGE': 'en_US:en', 13:31:41 INFO - 'LOGNAME': 'cltbld', 13:31:41 INFO - 'MAIL': '/var/mail/cltbld', 13:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:41 INFO - 'MOZ_NO_REMOTE': '1', 13:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:41 INFO - 'NO_EM_RESTART': '1', 13:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:41 INFO - 'PWD': '/builds/slave/test', 13:31:41 INFO - 'SHELL': '/bin/bash', 13:31:41 INFO - 'SHLVL': '1', 13:31:41 INFO - 'TERM': 'linux', 13:31:41 INFO - 'TMOUT': '86400', 13:31:41 INFO - 'USER': 'cltbld', 13:31:41 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987', 13:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:41 INFO - '_': '/tools/buildbot/bin/python'} 13:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:31:41 INFO - Cleaning up... 13:31:41 INFO - Return code: 0 13:31:41 INFO - Running post-action listener: _resource_record_post_action 13:31:41 INFO - Running post-action listener: _start_resource_monitoring 13:31:41 INFO - Starting resource monitoring. 13:31:41 INFO - [mozharness: 2017-05-23 20:31:41.520935Z] Finished create-virtualenv step (success) 13:31:41 INFO - [mozharness: 2017-05-23 20:31:41.521497Z] Running install step. 13:31:41 INFO - Running pre-action listener: _resource_record_pre_action 13:31:41 INFO - Running main action method: install 13:31:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:31:41 INFO - Reading from file tmpfile_stdout 13:31:41 INFO - Detecting whether we're running mozinstall >=1.0... 13:31:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:31:41 INFO - Reading from file tmpfile_stdout 13:31:41 INFO - Output received: 13:31:41 INFO - Usage: mozinstall [options] installer 13:31:41 INFO - Options: 13:31:41 INFO - -h, --help show this help message and exit 13:31:41 INFO - -d DEST, --destination=DEST 13:31:41 INFO - Directory to install application into. [default: 13:31:41 INFO - "/builds/slave/test"] 13:31:41 INFO - --app=APP Application being installed. [default: firefox] 13:31:41 INFO - mkdir: /builds/slave/test/build/application 13:31:41 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'] 13:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:31:57 INFO - Reading from file tmpfile_stdout 13:31:57 INFO - Output received: 13:31:57 INFO - /builds/slave/test/build/application/firefox/firefox 13:31:57 INFO - Running post-action listener: _resource_record_post_action 13:31:57 INFO - [mozharness: 2017-05-23 20:31:57.527793Z] Finished install step (success) 13:31:57 INFO - [mozharness: 2017-05-23 20:31:57.528075Z] Running run-tests step. 13:31:57 INFO - Running pre-action listener: _resource_record_pre_action 13:31:57 INFO - Running main action method: run_tests 13:31:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:31:57 INFO - Python 2.7.3 13:31:57 INFO - Return code: 0 13:31:57 INFO - grabbing minidump binary from tooltool 13:31:57 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')]} 13:31:57 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 0x1dda7a0>, '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 0x1ddb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddbb30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:31:57 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 13:31:57 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 13:31:57 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 13:31:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:31:57 INFO - Return code: 0 13:31:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:31:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:31:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:31:57 INFO - ENV: RUST_BACKTRACE is now 1 13:31:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:31:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:31:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 13:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 13:31:57 INFO - Using env: {'DISPLAY': ':0', 13:31:57 INFO - 'HOME': '/home/cltbld', 13:31:57 INFO - 'LANG': 'en_US.UTF-8', 13:31:57 INFO - 'LANGUAGE': 'en_US:en', 13:31:57 INFO - 'LOGNAME': 'cltbld', 13:31:57 INFO - 'MAIL': '/var/mail/cltbld', 13:31:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:31:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:57 INFO - 'MOZ_NO_REMOTE': '1', 13:31:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:57 INFO - 'NO_EM_RESTART': '1', 13:31:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:57 INFO - 'PWD': '/builds/slave/test', 13:31:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:31:57 INFO - 'RUST_BACKTRACE': '1', 13:31:57 INFO - 'SHELL': '/bin/bash', 13:31:57 INFO - 'SHLVL': '1', 13:31:57 INFO - 'TERM': 'linux', 13:31:57 INFO - 'TMOUT': '86400', 13:31:57 INFO - 'USER': 'cltbld', 13:31:57 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987', 13:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:57 INFO - '_': '/tools/buildbot/bin/python'} 13:31:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 13:31:57 INFO - mozversion application_buildid: 20170523195543 13:31:57 INFO - mozversion application_changeset: 1ce55499e8193d53aeff91546b16e0c580ebd6f1 13:31:57 INFO - mozversion application_display_name: Nightly 13:31:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:31:57 INFO - mozversion application_name: Firefox 13:31:57 INFO - mozversion application_remotingname: firefox 13:31:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:31:57 INFO - mozversion application_vendor: Mozilla 13:31:57 INFO - mozversion application_version: 55.0a1 13:31:57 INFO - mozversion platform_buildid: 20170523195543 13:31:57 INFO - mozversion platform_changeset: 1ce55499e8193d53aeff91546b16e0c580ebd6f1 13:31:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:31:57 INFO - mozversion platform_version: 55.0a1 13:31:57 INFO - using testdate: 1495571517 13:31:57 INFO - actual date: 1495571517 13:31:57 INFO - starting webserver on 'localhost:50451' 13:31:57 INFO - SUITE-START | Running 2 tests 13:31:57 INFO - TEST-START | dromaeo_css 13:31:57 INFO - operating with platform_type : linux_ 13:31:57 INFO - Initialising browser for dromaeo_css test... 13:31:57 INFO - TEST-INFO | started process 14496 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj6fC19/profile http://localhost:50451/getInfo.html) 13:31:58 INFO - PID 14496 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2978: String.localeCompare is deprecated; use String.prototype.localeCompare instead 13:32:01 INFO - PID 14496 | __metrics Screen width/height:1600/1200 13:32:01 INFO - PID 14496 | colorDepth:24 13:32:01 INFO - PID 14496 | Browser inner width/height: 1024/695 13:32:01 INFO - PID 14496 | __metrics 13:32:03 INFO - TEST-INFO | 14496: exit 0 13:32:03 INFO - Browser initialized. 13:32:03 INFO - Running cycle 1/1 for dromaeo_css test... 13:32:03 INFO - TEST-INFO | started process 14656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj6fC19/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:32:15 INFO - PID 14656 | RSS: Main: 166330368 13:32:15 INFO - PID 14656 | 13:35:20 INFO - PID 14656 | Cycle 1(1): loaded http://localhost:50451/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50451/tests/dromaeo/cssquery-ext.html) 13:35:21 INFO - PID 14656 | RSS: Main: 172187648 13:35:21 INFO - PID 14656 | 13:38:23 INFO - PID 14656 | Cycle 1(1): loaded http://localhost:50451/tests/dromaeo/cssquery-ext.html (next: http://localhost:50451/tests/dromaeo/cssquery-jquery.html) 13:38:24 INFO - PID 14656 | RSS: Main: 170831872 13:38:24 INFO - PID 14656 | 13:41:26 INFO - PID 14656 | Cycle 1(1): loaded http://localhost:50451/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50451/tests/dromaeo/cssquery-mootools.html) 13:41:26 INFO - PID 14656 | RSS: Main: 173400064 13:41:26 INFO - PID 14656 | 13:44:28 INFO - PID 14656 | Cycle 1(1): loaded http://localhost:50451/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50451/tests/dromaeo/cssquery-prototype.html) 13:44:29 INFO - PID 14656 | RSS: Main: 171139072 13:44:29 INFO - PID 14656 | 13:47:32 INFO - PID 14656 | Cycle 1(1): loaded http://localhost:50451/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50451/tests/dromaeo/cssquery-yui.html) 13:47:32 INFO - PID 14656 | RSS: Main: 171425792 13:47:32 INFO - PID 14656 | 13:50:34 INFO - PID 14656 | Cycle 1(1): loaded http://localhost:50451/tests/dromaeo/cssquery-yui.html (next: http://localhost:50451/tests/dromaeo/cssquery-dojo.html) 13:50:34 INFO - PID 14656 | RSS: Main: 178020352 13:50:34 INFO - PID 14656 | 13:50:34 INFO - PID 14656 | __start_tp_report 13:50:34 INFO - PID 14656 | _x_x_mozilla_page_load 13:50:34 INFO - PID 14656 | _x_x_mozilla_page_load_details 13:50:34 INFO - PID 14656 | |i|pagename|runs| 13:50:34 INFO - PID 14656 | |0;dojo.html;2726.1412655013673;2748.5464898291784;2768.473989941911;2788.6514185726783;2790.455861107084;5165.81919632813;5267.209918512225;5289.761960711768;5293.153095504716;5322.361316642004;5177.689338639684;5225.451327610594;5308.044551980652;5322.733863306828;5344.759485823138;4529.34324522944;4734.384530011093;4743.501932297111;4753.881152971168;4775.997040621473;4770.785314660849;4818.25317075852;4819.0602832447685;4833;4850.684705494149;4598.126355992351;4644.86065418038;4658.510856360102;4734.715917044989;4742.739149346785;4724.811007559693;4728.881777955544;4744.881377965544;4764.142454358214;4783.880402989918;4655.162070827249;4682.063587282557;4699.177643912301;4700.177468942956;4732.574068333832;5192.221166825007;5247.895042099175;5266.7629956652045;5276.3140791697215;5283.973580132113;5611.102223644238;5673.546116310686;5742.339630942453;5743.62666426681;5763.682997435139;5753.252077229975;5757.251557297566;5770.394108618577;5771.422857714237;5787;5205.583553315726;5322.38792538863;5358.303420555342;5365;5367.033933891859;5790.392008839011;5845.941540584625;5882.676452795137;5891.204687367151;5893.970530147321;5563.388027316992;5584.190292407578;5589.636673616202;5591.8602034948635;5605.439456054362;5634.154876768435;5691.146328050825;5701.629394089371;5713.4000929902595;5762.827115186551;5626.606137570413;5689.061304884648;5700.144978253295;5701.4298570142655;5706.514946229534;5557.360903496069;5593.944060559343;5613.298337707786;5646.181303710939;5681.971590142106;4793.9280910786365;4837.443693975238;4842.709437433765;4870.805167793319;4887.266909963463;4113.074558224375;4125.1749650070105;4126.257273690704;4127.030147915238;4157.230912281238;4736.692115012582;4736.8578942631775;4787.473377928425;4810.350602668665;4834.7824347904425;5721.284839395075;5734.340550836624;5737.627054241461;5742.425757424307;5763.538916886639;4771.475137734847;4795.232762757942;4796.184648609745;4804.159272127364;4857.489963553776;4992.276119962585;5018.949810501921;5045.117104506697;5061.544460998528;5080.161773307437;5233.790648374023;5250.501202385767;5252.422233554383;5255.684658920324;5296.179092240709;5629.915551266652;5663.207150998781;5676.290463692038;5677.630953987978;5691.914621280601;5162.277281180563;5197.22041693749;5216.921746173886;5246.658967167122;5295.7087360195555;5508.91736623943;5586.581006424616;5586.664800112007;5621.634593751393;5638.5771067170945;5704.686242256716;5721.685307308138;5728.828135155952;5731.168980497888;5747.453991870766;5440.863978400572;5546.889062218814;5549.639273447213;5557.1664250361155;5627.7467513961155;5514.724263786715;5540.861478463071;5550.250716153268;5555.805546805843;5601.075822489243;5450.482204190595;5465.098258787256;5475.041867673221;5522.088855338824;5522.144067669517;5482.616216864782;5505.201745746765;5584.804531841366;5607.532536149945;5682.147677848356;5408.621396502364;5424.701641409761;5455.0726376515295;5481.835544933659;5482.725863706878 13:50:34 INFO - PID 14656 | |1;ext.html;626.1578177351464;673.2089794491471;700.3451772592626;1184.0468422919546;1189.0606420927468;34430.82784586077;35368;35416.645833541654;35501.2899742005;35510.467342989876;33288.66711332886;34329.65670343296;34378.31243375137;34383;34436.82781586095;7038.366547010781;7145.678444469985;7154;7156.4274858011495;7165.820854478628;6885.277045910182;7036.824079398005;7045.626102909934;7056.294370562954;7065.32879376461;6961.164660240753;6982.581045137283;7062;7071.257517960592;7082.220955694869;6950.582965022089;7020.824479388005;7032.929670703279;7064;7068.11648543932;6878.415334696557;6945.548539344977;6949.687264073078;6953.374196322356;6953.826154346182;32241.83879080613;32287.515687264477;32503.187420314443;32730.672693273;32794.18014549655;2869.210966984075;2894.131760471871;2899.405621847537;2899.782516311264;2911.544227886057;24573.877130614233;24597;24651.137210197558;24658.931276339383;24760.133395331257;3094.164575564585;3096.5974423324824;3115.049909777517;3123.484625036866;3149.6692847251165;147737;147907;148907;152754;156971.4302856968;38672.613273867464;38841.6115838838;39134.217315654096;39305.803470982464;39406.60593394029;40306.395404068964;40884;46035.76982115135;47083;47402.288965665546;12662.620121396372;12734.554290599785;12759.42582583786;12769.744605108031;12787.232766034067;10128.797424051478;10156.39061656303;10190.592376304865;10202.897971020195;10208.744781380525;12678.683032924251;12703.491860325668;12734.80897786534;12819.743605127846;12890.419931103123;5300.151975683949;5458.754356053987;5492.780288788484;5499.972500137474;5589.608727389043;823.320760372695;878.0692465986075;894.9149830766066;898.3756289378819;904.5432056811268;20447.488812779502;21578.568428631654;21656.891715541322;21713.67429488559;21798.455038623844;969.762408209993;977.5063592885547;992.4591097851688;997.6308765756717;1002.5638847101534;11139.443027848574;11316.151288653384;11511.30932144074;11516.712082197844;11552.191346605825;177340.11329943527;178350;178485;178851;179079;39510.80244598759;40062.39906401406;40194.39708404318;40246.56055031181;40344.19311613751;1212.9206295682902;1216.3249396584804;1225.3628113381171;1230.3417671545858;1235.110720281396;19445.8055419444;19736.802631973496;20298;20751.8962405187;21254.25610103639;28625.570616441186;28670.42659146847;28675.426491470473;28685.71314286914;28731;146823.2658836699;147806;147918;147978;148307;28715;28892.42215155727;28947.56578651364;29171.124866254046;30157.246068848453;35828.64171358253;35858.8207058963;36218;36240.456393153596;36331;25758.484830302914;27467;27478.313042174104;27770.444591107662;28006.2998425041;26751.464970700865;26780.59829102604;27338;28057;28290.575641364983;29495.410091797614;30067.69932300649;30479.238019049702;30513.694863051085;30695.2326191847;26278.209932291385;26725.331866703487;26851;26885.327866802705;27907.581386278816;20599.691004635242;22378.77621223832;22428.32715018552;22561.323160305215;22608.886955565118 13:50:34 INFO - PID 14656 | |2;jquery.html;384.5020698195836;387.74796382351485;400.403398935586;412.97522148671084;426.1519576043673;12972.870271297284;17348.82651173488;17480.21339039743;18020.819791802096;18038.278468861245;18157.546061348472;18457.90771046143;18544.443666689986;18554.90722546389;18622.441326760218;5321.521063104329;5359.919601205985;5531.25328080708;5572.0527510323345;5574.080276754331;5434.347878254595;5527.972360138194;5532.75102620383;5536.307961504812;5550.91673624896;5359.785608575652;5370.650907690988;5489.313835770528;5506.311711036121;5512.118061110203;5439.592030597721;5451.236826844245;5464.6994415307145;5471.288732464794;5483.835484935458;4750;4841;4870.123377791996;4891.217405215149;4925.852224433273;21483.892580536998;21595;21810;21867.453313667127;21888.671669924963;1545.65995480994;1618.660081382911;1635.7301045327506;1672.1388484930271;1673.5314112048645;14516.419343226258;14593.635159121;14725.410983560752;14783;14856.925715371463;2027.9898600507051;2065.6694928811467;2077.522169900931;2086.968695469569;2103.5582527669208;85946.57026714826;86851;87247.56376218142;88041.67937480944;89165;10089.394636321844;10266.897331026743;10270.537825797857;10320.43237621938;10449.791004179873;13757.931210343884;13872.306384680927;13885.166889986633;13913.30433478322;14389.568312950629;7385.593792341473;7410.555366678017;7414.888776668355;7590.051243594551;7611.467197296136;6996.755113571001;7022.4733145014325;7190.532615379983;7202.53183543068;7241.275872412716;6633.7346506140175;6792.932070679329;6822.863542729117;6856.074429951893;6864.24493305736;2014.3453377652322;2022.2113375783456;2063.8968051597362;2079.5321052763006;2165.9133634654436;853.9829203415896;878.7232021913077;892.4422236102436;892.4511425473287;918.5958178401482;16375.263113159936;16550.255238514295;16656.666866662843;16743.413980510868;17329.65340693179;877.2806298835021;891.8216356728681;898.9011208767031;900.3337530227584;916.2395211974045;8948.239399650973;9006.144416280444;10692.839607405895;11642.708932276591;11670;364293;367816;368446;370047;373108;75999.62000190074;78232;79921;80717.59641201874;81052;1086.9076128529164;1118.2898859224288;1134.5291703942937;1142.657202839145;1153.1121036801617;16842.663146737243;16933.830661693224;17206.22571984289;17563.56091097733;17663.205155767766;38854.028649283995;38961.6103838958;39677.80161099176;39698.206035879695;40528.392074118325;48336.758316208194;48709.269360958904;50601.74699126481;50806.237906430695;51557.22664159966;7820.687172513036;7836.09884863248;8008.359331253602;8279.172082791672;8366.205210504992;12317.137800353888;12702.428390722254;12722.61832145037;12835.93582032084;13153.736925261632;11487;11761.705957350792;11890;11966.46150923228;12014.699632509257;11118;11184.552617895193;11221.60724374643;11386.089112871116;11386.715332116763;11743.76512469763;11860.644180674593;11919;11972.16194866351;12561.309127998047;8238.854465395836;8346.248837604644;8521.488710677379;8562.229399354088;8654.524001179996;11320.150988675718;11424.600138995427;11641.417929103342;11837.289762614271;11873.109516786102 13:50:34 INFO - PID 14656 | |3;mootools.html;1253.7429826885489;1302.2772361339453;1321.4714114354258;1333.2733660155213;1333.53992872459;9741.220702343813;10174.033466820649;10183.59265629375;10299.48502574872;10674.519646615901;10298.227632927523;10476;10480.371177729323;10481.790364192711;10497.947510262438;2171.283476452767;2204.2505548113636;2216.601011817872;2225.610518159324;2229.7547269800307;2088.874667519946;2160.6758986152045;2163.8809865457392;2180.5965896309153;2185.748638906522;2216.92240771573;2229;2260.1411463643876;2260.5026894083276;2260.5930932432157;2130.068265189603;2182.879941603211;2221.911123555056;2226.109556177526;2232.05137816429;2092.6756352765346;2162.1999860051724;2196.198387588535;2197.835162362829;2209.5470428562107;10030.899691003142;10124.139448146916;10136.94931525345;10161.644342447978;10220.948895255477;5260.289860868772;5420.972895135499;5446.972765136188;5447.836564903059;5448.264484294609;3093.3040065985197;3315.668433156689;3371.123507887942;3386.9491957620658;3387.8983630491125;1047.748540350318;1063.9893601063968;1092.3500517192258;1117.1788735279563;1135.103268417957;14678.633034174125;14747.483838065617;14821.851781482155;14843.109413435228;14872.925635371754;4264.381664658607;4379.693421460467;4573.977130114328;4612.238980568236;4631.560001799824;10354.016368444985;10373.066424021874;10446.582136714447;10455.215858810467;10504.737381565523;5329.387120481117;5338.3060202173465;5389.353277606712;5410.621256512007;5412.458754124556;4784.4497882743235;4991.401031876126;5057.291979122926;5109.310243117206;5151.351567498439;3632.0919770057485;3688.5573731152435;3733.1227161617;3781.6785573226584;3784.545854497478;992.7617371830853;1028.6708253359002;1029.696239609317;1032.695354870315;1035.166690813902;687.9105716256854;714.907062081926;717.4941666125369;727.3998950865451;739.7817643795094;5325.920111198335;5403.891922161613;5468.835934921879;5562.110062389998;5578.135389014709;504.3896884769397;518.2537146509015;519.2730177751179;522.0941666209125;525.4797750227248;3264.249222678797;3354.2117602363423;3360.6135294440965;3507.6667716566885;3583.8924832255075;12750.171238869443;13166.605001849959;13423.926085913103;13460.93269533646;13468.5286014989;12599.370031498389;13061.869381306255;13223.404946777418;13327.466901324033;13379.53171638988;6935.965320173367;7025.121859767529;7072.646367681698;7158.355747982707;7158.749443769443;5455.590830687794;5468.617196796186;5528.391876893619;5575.330960284792;5727;11264.211505194558;11277.154213434189;11346.716332091764;11392.886071139183;11433.884731324732;11723.41382930833;11831.704207394883;11878.46546905374;12004.639860804189;12135.211211271238;7027.7188912442925;7230.566166030055;7237.095363079615;7239.710411583688;7242.818929526804;9441.952790236004;9538.427694338361;9538.618455261712;9547.42715437076;9557.808843822946;7860.371170306247;7946.284834364935;8074.071481779436;8327.167283271867;8370.330373570221;8001.319887809602;8086.83826323482;8111.634976426193;8116.026076870813;8200.671973121247;7342.19235884063;7395.112586489656;7436.776896693108;7458.21688722698;7511.399088073051;5107.9233811493605;5130.948690513196;5169.302144210484;5238;5439.156930675752;5049.2173713074535;5149;5246;5246.108161612458;5277 13:50:34 INFO - PID 14656 | |4;prototype.html;349.8093539021234;367.2269871919609;383.78316251318006;386.1909300016468;391.69643526267157;5619.269494965654;5631.8592035199035;5634.3802181759975;5639.407862174474;5653.604247702662;5442.9727851360685;5498.725063746817;5521.558275337973;5524.751386187621;5539.529140023093;4286.207051695446;4298.806553705091;4305.203537345586;4305.318952295789;4338.457692788402;4298;4302.806373713175;4311.8706438806885;4326.134773045388;4326.3559847258;4193.329067349225;4302.634276086536;4313.266744653401;4315.611594956454;4323.567643235683;4254.765987870666;4261;4262.1688770689725;4270.893227669302;4302.182585308781;3829.17672700368;3838.2899163654815;3867.1298957734566;3872.3997780344093;3872.845086196549;5357.946420535784;5444.537214336786;5455.345358556959;5458.099413596752;5473.8357849264585;5053.216751403538;5072.771725272335;5078.187490001619;5103.8468845934685;5106.157484015133;5862.97068514659;5881.764729410818;5889.586499240151;5894.616849904785;5896.823095307148;4184.769837658928;4294.1197054604045;4342.717723348004;4350.715210016449;4353.172897149531;5988.9101663475085;6146.907796383058;6151.907721384183;6155.753769849201;6178.135061091451;4066.7356621819486;4081.2653722329674;4097.44684467599;4103.261412945699;4104.671626269891;4144.834206631701;4169.770662613585;4173.4157217989505;4173.518400967613;4188.078622703;4739.7630118493935;4801.207800712913;4819.759012049383;4822.541858523435;4824.758762061883;5862.296524417012;5865.178874957424;5867.794627188114;5869.706514674249;5889.1755154278435;1424.622475044114;1430.7409479658043;1436.1167881752856;1438.6834896322791;1438.8129543159323;891.9732408027769;935.881621462346;942.9104235097655;944.650479322655;946.4888959961681;4991.775370108354;5016.423111342169;5037.539113656999;5042.546170844642;5044.4198917125;5999.610025348338;6073.271207455045;6081.75672973085;6092.451679348791;6121.540884433685;4791.616670666338;4963.6277279204205;4975.825846095369;5019.14674505335;5043.117454445457;3191.521271809247;3217.951730724041;3222.258880457461;3236.401265765841;3240.643529211785;5455.0453670607485;5579.7489112990015;5584.46947539983;5601.08743453402;5611.298587676541;6148.661823599745;6189.5048396129105;6228.110932917638;6229.875402491924;6270.7805226816845;5525.889482210333;5554.2779438672715;5585.218069470277;5606.831795046155;5611.579131565068;5830.5044071254415;6037.184980027816;6070.726817293144;6089.786857460145;6090.543209259412;5982.371850955587;5991.011483105239;5997.760089596367;5999.370066142992;6015.037593984942;5411.945880541144;5574.832755017356;5593.2728745264485;5604.271444712324;5617.43825617435;4081.40819581165;4113.9794301028305;4115.991582062414;4118.588141185857;4126.814293356746;6018.277806663228;6119.938800611937;6135.754569817157;6145.508359331154;6148.292946311052;5900.144479050427;5934.109883517507;5936.22829032223;5956.166136740773;5970.5522085844605;5902.7343769531335;5930.48772563011;5939.198208241832;5943.702814859326;5960.3443621202505;5717;5839.0949402842625;5851.736671849862;5865.4134586541;5897.7935772247765;5963.463288304073;5970.835687040985;5977.2665926882455;5983.491403230774;5997.880042399041;5645.350784659652;5760.423957604374;5797.9420205797405;5805.79679711225;5813.360530341574 13:50:34 INFO - PID 14656 | |5;yui.html;653.1737352249403;674.1707699529578;730.5142080516457;745.9440541959352;772.64072206424;10709.892901070987;11115.333080015205;12456.626301210956;13030.283334416592;13097.934510327446;13836.169829810218;14243.28783560823;14335.856641433582;14398.49605263816;14478.782818257734;851.7146755836802;858.8067684770939;866.3762091294258;869.6217145541709;872;878.947263164209;880.6961598248594;881.7575166829141;881.9073997230295;883.8099808541162;921.9446833189996;923.5659240157115;924.7318277699459;924.8381533231658;930.4975313330793;911.2527727263647;912.7444315591612;913.4108500017518;919.9954000230023;922.0594993107027;669.829193555645;671.5668393885965;673.2560520624737;673.8012286375531;676.681959479044;12964.351782410842;13179.73640527184;13238.205707657571;13399.933000335033;13709.45162193511;14401.20793356365;14429.927850360786;14431.927840360837;14551.636209094857;14584.48954286595;11856.347900865449;11912.404379781063;11917.344546049964;11987.820182697267;12026.39868006605;2817.7323154300307;2823.3365159187574;2854.628898243215;2863.9713602863912;2867.0538722221618;65983;66458.66770666164;66746.66626666836;67443.66278168627;67761.66119169373;9619.90380096204;9838.557264923096;9962.800743985079;10004.19966402686;11354.489047992694;19865;20314.695279570817;20329.18683252683;20357.694634580195;20362.898185508977;6023.849403764941;6149.754009839646;6197.876042479125;6275.466585340206;6296.811095667137;2979.3445442002726;3037.331787006855;3038.9088327350214;3041.528563072727;3046.466868298039;3012.774041946863;3020.652624948159;3035.9089227323216;3066.6166729158854;3111;627.5136769004058;631.1637080867869;636.1952130554852;637.1589501857596;637.6939069246695;600.474584738354;615.8152554233801;615.9784407545715;620.5407998081387;638.1353266324156;9337.533123343806;9573.808523829484;9666;9781.070798274153;9934.354266972623;573.7188777498995;582.1384351160307;584.1092334190394;585.3824215452738;591.1576004194093;4161.91676166475;4245.1934132514725;4293.592108749664;4302.376155457504;4322.265214913472;59579;59627.403725962184;59667.403325967054;60952;62628.373716263166;53583;53782;54702.1277659207;56793.43206567964;57252.14121788176;46546;46620.3006954896;46705.5329446708;47453.76273118612;48107.27839082417;8405.159484051546;8685.652573897227;8763.956180219058;8938.10618938101;9070.092990700878;25445.87277063603;25691.3577160565;25849.095281665803;25979.74020259849;26454.603180951915;31065.8446707765;31185.064448066594;31347.68652313448;31614.36771264608;31952.680473195902;11678.124140689313;11778.057755379721;11805.822912656145;11850.229735067192;11927.165098443025;15153.318100685716;15218.923905380845;15668.92165539165;15898.841011589737;16051.117188554275;14506.347214375168;14531.709365812836;14754.114753114847;15302.31139598743;15426.84573154254;14339.569812905629;14405.567832965027;14616.196109214095;15533.533993980198;15644;13736.244506552235;13747.725045499234;13877.236751978739;13975.09161904473;14193.929030354782;10520;10676;10755;10788;11386.715332116763;10345.74135646615;11188.552457901918;11235.045021172964;11270.154738394816;11273.82925045166 13:50:34 INFO - PID 14656 | __end_tp_report 13:50:34 INFO - PID 14656 | __start_cc_report 13:50:34 INFO - PID 14656 | _x_x_mozilla_cycle_collect,280 13:50:34 INFO - PID 14656 | __end_cc_report 13:50:34 INFO - PID 14656 | __startTimestamp1495572634692__endTimestamp 13:50:34 INFO - PID 14656 | 13:50:34 INFO - PID 14656 | ------- Summary: start ------- 13:50:34 INFO - PID 14656 | Number of tests: 6 13:50:34 INFO - PID 14656 | 13:50:34 INFO - PID 14656 | [#0] dojo.html Cycles:165 Average:5208.16 Median:5358.30 stddev:606.37 (11.3%) stddev-sans-first:576.12 13:50:34 INFO - PID 14656 | Values: 2726.1 2748.5 2768.5 2788.7 2790.5 5165.8 5267.2 5289.8 5293.2 5322.4 5177.7 5225.5 5308.0 5322.7 5344.8 4529.3 4734.4 4743.5 4753.9 4776.0 4770.8 4818.3 4819.1 4833.0 4850.7 4598.1 4644.9 4658.5 4734.7 4742.7 4724.8 4728.9 4744.9 4764.1 4783.9 4655.2 4682.1 4699.2 4700.2 4732.6 5192.2 5247.9 5266.8 5276.3 5284.0 5611.1 5673.5 5742.3 5743.6 5763.7 5753.3 5757.3 5770.4 5771.4 5787.0 5205.6 5322.4 5358.3 5365.0 5367.0 5790.4 5845.9 5882.7 5891.2 5894.0 5563.4 5584.2 5589.6 5591.9 5605.4 5634.2 5691.1 5701.6 5713.4 5762.8 5626.6 5689.1 5700.1 5701.4 5706.5 5557.4 5593.9 5613.3 5646.2 5682.0 4793.9 4837.4 4842.7 4870.8 4887.3 4113.1 4125.2 4126.3 4127.0 4157.2 4736.7 4736.9 4787.5 4810.4 4834.8 5721.3 5734.3 5737.6 5742.4 5763.5 4771.5 4795.2 4796.2 4804.2 4857.5 4992.3 5018.9 5045.1 5061.5 5080.2 5233.8 5250.5 5252.4 5255.7 5296.2 5629.9 5663.2 5676.3 5677.6 5691.9 5162.3 5197.2 5216.9 5246.7 5295.7 5508.9 5586.6 5586.7 5621.6 5638.6 5704.7 5721.7 5728.8 5731.2 5747.5 5440.9 5546.9 5549.6 5557.2 5627.7 5514.7 5540.9 5550.3 5555.8 5601.1 5450.5 5465.1 5475.0 5522.1 5522.1 5482.6 5505.2 5584.8 5607.5 5682.1 5408.6 5424.7 5455.1 5481.8 5482.7 13:50:34 INFO - PID 14656 | 13:50:34 INFO - PID 14656 | [#1] ext.html Cycles:180 Average:30402.82 Median:16041.33 stddev:41171.19 (256.7%) stddev-sans-first:41225.97 13:50:34 INFO - PID 14656 | Values: 626.2 673.2 700.3 1184.0 1189.1 34430.8 35368.0 35416.6 35501.3 35510.5 33288.7 34329.7 34378.3 34383.0 34436.8 7038.4 7145.7 7154.0 7156.4 7165.8 6885.3 7036.8 7045.6 7056.3 7065.3 6961.2 6982.6 7062.0 7071.3 7082.2 6950.6 7020.8 7032.9 7064.0 7068.1 6878.4 6945.5 6949.7 6953.4 6953.8 32241.8 32287.5 32503.2 32730.7 32794.2 2869.2 2894.1 2899.4 2899.8 2911.5 24573.9 24597.0 24651.1 24658.9 24760.1 3094.2 3096.6 3115.0 3123.5 3149.7 147737.0 147907.0 148907.0 152754.0 156971.4 38672.6 38841.6 39134.2 39305.8 39406.6 40306.4 40884.0 46035.8 47083.0 47402.3 12662.6 12734.6 12759.4 12769.7 12787.2 10128.8 10156.4 10190.6 10202.9 10208.7 12678.7 12703.5 12734.8 12819.7 12890.4 5300.2 5458.8 5492.8 5500.0 5589.6 823.3 878.1 894.9 898.4 904.5 20447.5 21578.6 21656.9 21713.7 21798.5 969.8 977.5 992.5 997.6 1002.6 11139.4 11316.2 11511.3 11516.7 11552.2 177340.1 178350.0 178485.0 178851.0 179079.0 39510.8 40062.4 40194.4 40246.6 40344.2 1212.9 1216.3 1225.4 1230.3 1235.1 19445.8 19736.8 20298.0 20751.9 21254.3 28625.6 28670.4 28675.4 28685.7 28731.0 146823.3 147806.0 147918.0 147978.0 148307.0 28715.0 28892.4 28947.6 29171.1 30157.2 35828.6 35858.8 36218.0 36240.5 36331.0 25758.5 27467.0 27478.3 27770.4 28006.3 26751.5 26780.6 27338.0 28057.0 28290.6 29495.4 30067.7 30479.2 30513.7 30695.2 26278.2 26725.3 26851.0 26885.3 27907.6 20599.7 22378.8 22428.3 22561.3 22608.9 13:50:34 INFO - PID 14656 | 13:50:34 INFO - PID 14656 | [#2] jquery.html Cycles:180 Average:24956.31 Median:369246.50 stddev:61408.90 (16.6%) stddev-sans-first:61553.46 13:50:34 INFO - PID 14656 | Values: 384.5 387.7 400.4 413.0 426.2 12972.9 17348.8 17480.2 18020.8 18038.3 18157.5 18457.9 18544.4 18554.9 18622.4 5321.5 5359.9 5531.3 5572.1 5574.1 5434.3 5528.0 5532.8 5536.3 5550.9 5359.8 5370.7 5489.3 5506.3 5512.1 5439.6 5451.2 5464.7 5471.3 5483.8 4750.0 4841.0 4870.1 4891.2 4925.9 21483.9 21595.0 21810.0 21867.5 21888.7 1545.7 1618.7 1635.7 1672.1 1673.5 14516.4 14593.6 14725.4 14783.0 14856.9 2028.0 2065.7 2077.5 2087.0 2103.6 85946.6 86851.0 87247.6 88041.7 89165.0 10089.4 10266.9 10270.5 10320.4 10449.8 13757.9 13872.3 13885.2 13913.3 14389.6 7385.6 7410.6 7414.9 7590.1 7611.5 6996.8 7022.5 7190.5 7202.5 7241.3 6633.7 6792.9 6822.9 6856.1 6864.2 2014.3 2022.2 2063.9 2079.5 2165.9 854.0 878.7 892.4 892.5 918.6 16375.3 16550.3 16656.7 16743.4 17329.7 877.3 891.8 898.9 900.3 916.2 8948.2 9006.1 10692.8 11642.7 11670.0 364293.0 367816.0 368446.0 370047.0 373108.0 75999.6 78232.0 79921.0 80717.6 81052.0 1086.9 1118.3 1134.5 1142.7 1153.1 16842.7 16933.8 17206.2 17563.6 17663.2 38854.0 38961.6 39677.8 39698.2 40528.4 48336.8 48709.3 50601.7 50806.2 51557.2 7820.7 7836.1 8008.4 8279.2 8366.2 12317.1 12702.4 12722.6 12835.9 13153.7 11487.0 11761.7 11890.0 11966.5 12014.7 11118.0 11184.6 11221.6 11386.1 11386.7 11743.8 11860.6 11919.0 11972.2 12561.3 8238.9 8346.2 8521.5 8562.2 8654.5 11320.2 11424.6 11641.4 11837.3 11873.1 13:50:34 INFO - PID 14656 | 13:50:34 INFO - PID 14656 | [#3] mootools.html Cycles:180 Average:6135.98 Median:3447.78 stddev:3990.59 (115.7%) stddev-sans-first:3984.93 13:50:34 INFO - PID 14656 | Values: 1253.7 1302.3 1321.5 1333.3 1333.5 9741.2 10174.0 10183.6 10299.5 10674.5 10298.2 10476.0 10480.4 10481.8 10497.9 2171.3 2204.3 2216.6 2225.6 2229.8 2088.9 2160.7 2163.9 2180.6 2185.7 2216.9 2229.0 2260.1 2260.5 2260.6 2130.1 2182.9 2221.9 2226.1 2232.1 2092.7 2162.2 2196.2 2197.8 2209.5 10030.9 10124.1 10136.9 10161.6 10220.9 5260.3 5421.0 5447.0 5447.8 5448.3 3093.3 3315.7 3371.1 3386.9 3387.9 1047.7 1064.0 1092.4 1117.2 1135.1 14678.6 14747.5 14821.9 14843.1 14872.9 4264.4 4379.7 4574.0 4612.2 4631.6 10354.0 10373.1 10446.6 10455.2 10504.7 5329.4 5338.3 5389.4 5410.6 5412.5 4784.4 4991.4 5057.3 5109.3 5151.4 3632.1 3688.6 3733.1 3781.7 3784.5 992.8 1028.7 1029.7 1032.7 1035.2 687.9 714.9 717.5 727.4 739.8 5325.9 5403.9 5468.8 5562.1 5578.1 504.4 518.3 519.3 522.1 525.5 3264.2 3354.2 3360.6 3507.7 3583.9 12750.2 13166.6 13423.9 13460.9 13468.5 12599.4 13061.9 13223.4 13327.5 13379.5 6936.0 7025.1 7072.6 7158.4 7158.7 5455.6 5468.6 5528.4 5575.3 5727.0 11264.2 11277.2 11346.7 11392.9 11433.9 11723.4 11831.7 11878.5 12004.6 12135.2 7027.7 7230.6 7237.1 7239.7 7242.8 9442.0 9538.4 9538.6 9547.4 9557.8 7860.4 7946.3 8074.1 8327.2 8370.3 8001.3 8086.8 8111.6 8116.0 8200.7 7342.2 7395.1 7436.8 7458.2 7511.4 5107.9 5130.9 5169.3 5238.0 5439.2 5049.2 5149.0 5246.0 5246.1 5277.0 13:50:34 INFO - PID 14656 | 13:50:34 INFO - PID 14656 | [#4] prototype.html Cycles:180 Average:4849.52 Median:5525.32 stddev:1434.98 (26.0%) stddev-sans-first:1398.70 13:50:34 INFO - PID 14656 | Values: 349.8 367.2 383.8 386.2 391.7 5619.3 5631.9 5634.4 5639.4 5653.6 5443.0 5498.7 5521.6 5524.8 5539.5 4286.2 4298.8 4305.2 4305.3 4338.5 4298.0 4302.8 4311.9 4326.1 4326.4 4193.3 4302.6 4313.3 4315.6 4323.6 4254.8 4261.0 4262.2 4270.9 4302.2 3829.2 3838.3 3867.1 3872.4 3872.8 5357.9 5444.5 5455.3 5458.1 5473.8 5053.2 5072.8 5078.2 5103.8 5106.2 5863.0 5881.8 5889.6 5894.6 5896.8 4184.8 4294.1 4342.7 4350.7 4353.2 5988.9 6146.9 6151.9 6155.8 6178.1 4066.7 4081.3 4097.4 4103.3 4104.7 4144.8 4169.8 4173.4 4173.5 4188.1 4739.8 4801.2 4819.8 4822.5 4824.8 5862.3 5865.2 5867.8 5869.7 5889.2 1424.6 1430.7 1436.1 1438.7 1438.8 892.0 935.9 942.9 944.7 946.5 4991.8 5016.4 5037.5 5042.5 5044.4 5999.6 6073.3 6081.8 6092.5 6121.5 4791.6 4963.6 4975.8 5019.1 5043.1 3191.5 3218.0 3222.3 3236.4 3240.6 5455.0 5579.7 5584.5 5601.1 5611.3 6148.7 6189.5 6228.1 6229.9 6270.8 5525.9 5554.3 5585.2 5606.8 5611.6 5830.5 6037.2 6070.7 6089.8 6090.5 5982.4 5991.0 5997.8 5999.4 6015.0 5411.9 5574.8 5593.3 5604.3 5617.4 4081.4 4114.0 4116.0 4118.6 4126.8 6018.3 6119.9 6135.8 6145.5 6148.3 5900.1 5934.1 5936.2 5956.2 5970.6 5902.7 5930.5 5939.2 5943.7 5960.3 5717.0 5839.1 5851.7 5865.4 5897.8 5963.5 5970.8 5977.3 5983.5 5997.9 5645.4 5760.4 5797.9 5805.8 5813.4 13:50:34 INFO - PID 14656 | 13:50:34 INFO - PID 14656 | [#5] yui.html Cycles:180 Average:14474.64 Median:31783.52 stddev:17069.80 (53.7%) stddev-sans-first:17086.13 13:50:34 INFO - PID 14656 | Values: 653.2 674.2 730.5 745.9 772.6 10709.9 11115.3 12456.6 13030.3 13097.9 13836.2 14243.3 14335.9 14398.5 14478.8 851.7 858.8 866.4 869.6 872.0 878.9 880.7 881.8 881.9 883.8 921.9 923.6 924.7 924.8 930.5 911.3 912.7 913.4 920.0 922.1 669.8 671.6 673.3 673.8 676.7 12964.4 13179.7 13238.2 13399.9 13709.5 14401.2 14429.9 14431.9 14551.6 14584.5 11856.3 11912.4 11917.3 11987.8 12026.4 2817.7 2823.3 2854.6 2864.0 2867.1 65983.0 66458.7 66746.7 67443.7 67761.7 9619.9 9838.6 9962.8 10004.2 11354.5 19865.0 20314.7 20329.2 20357.7 20362.9 6023.8 6149.8 6197.9 6275.5 6296.8 2979.3 3037.3 3038.9 3041.5 3046.5 3012.8 3020.7 3035.9 3066.6 3111.0 627.5 631.2 636.2 637.2 637.7 600.5 615.8 616.0 620.5 638.1 9337.5 9573.8 9666.0 9781.1 9934.4 573.7 582.1 584.1 585.4 591.2 4161.9 4245.2 4293.6 4302.4 4322.3 59579.0 59627.4 59667.4 60952.0 62628.4 53583.0 53782.0 54702.1 56793.4 57252.1 46546.0 46620.3 46705.5 47453.8 48107.3 8405.2 8685.7 8764.0 8938.1 9070.1 25445.9 25691.4 25849.1 25979.7 26454.6 31065.8 31185.1 31347.7 31614.4 31952.7 11678.1 11778.1 11805.8 11850.2 11927.2 15153.3 15218.9 15668.9 15898.8 16051.1 14506.3 14531.7 14754.1 15302.3 15426.8 14339.6 14405.6 14616.2 15533.5 15644.0 13736.2 13747.7 13877.2 13975.1 14193.9 10520.0 10676.0 10755.0 10788.0 11386.7 10345.7 11188.6 11235.0 11270.2 11273.8 13:50:34 INFO - PID 14656 | -------- Summary: end -------- 13:50:34 INFO - PID 14656 | 13:50:35 INFO - TEST-INFO | 14656: exit 0 13:50:35 INFO - TEST-OK | dromaeo_css | took 1117688ms 13:50:35 INFO - TEST-START | kraken 13:50:35 INFO - operating with platform_type : linux_ 13:50:35 INFO - Initialising browser for kraken test... 13:50:35 INFO - TEST-INFO | started process 15061 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6ANqBI/profile http://localhost:50451/getInfo.html) 13:50:36 INFO - PID 15061 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2978: String.localeCompare is deprecated; use String.prototype.localeCompare instead 13:50:39 INFO - PID 15061 | __metrics Screen width/height:1600/1200 13:50:39 INFO - PID 15061 | colorDepth:24 13:50:39 INFO - PID 15061 | Browser inner width/height: 1024/695 13:50:39 INFO - PID 15061 | __metrics 13:50:41 INFO - TEST-INFO | 15061: exit 0 13:50:41 INFO - Browser initialized. 13:50:41 INFO - Running cycle 1/1 for kraken test... 13:50:41 INFO - TEST-INFO | started process 15226 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6ANqBI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:50:52 INFO - PID 15226 | RSS: Main: 166285312 13:50:52 INFO - PID 15226 | 13:50:55 INFO - PID 15226 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50451/tests/kraken/driver.html?testName=audio-beat-detection) 13:50:56 INFO - PID 15226 | RSS: Main: 171016192 13:50:56 INFO - PID 15226 | 13:50:59 INFO - PID 15226 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50451/tests/kraken/driver.html?testName=audio-dft) 13:50:59 INFO - PID 15226 | RSS: Main: 170713088 13:50:59 INFO - PID 15226 | 13:51:02 INFO - PID 15226 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50451/tests/kraken/driver.html?testName=audio-fft) 13:51:03 INFO - PID 15226 | RSS: Main: 165806080 13:51:03 INFO - PID 15226 | 13:51:05 INFO - PID 15226 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50451/tests/kraken/driver.html?testName=audio-oscillator) 13:51:06 INFO - PID 15226 | RSS: Main: 166244352 13:51:06 INFO - PID 15226 | 13:51:08 INFO - PID 15226 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50451/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:51:08 INFO - PID 15226 | RSS: Main: 166510592 13:51:08 INFO - PID 15226 | 13:51:12 INFO - PID 15226 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50451/tests/kraken/driver.html?testName=imaging-darkroom) 13:51:12 INFO - PID 15226 | RSS: Main: 171175936 13:51:12 INFO - PID 15226 | 13:51:16 INFO - PID 15226 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50451/tests/kraken/driver.html?testName=imaging-desaturate) 13:51:16 INFO - PID 15226 | RSS: Main: 168665088 13:51:16 INFO - PID 15226 | 13:51:19 INFO - PID 15226 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50451/tests/kraken/driver.html?testName=json-parse-financial) 13:51:20 INFO - PID 15226 | RSS: Main: 169992192 13:51:20 INFO - PID 15226 | 13:51:21 INFO - PID 15226 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50451/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:51:22 INFO - PID 15226 | RSS: Main: 169689088 13:51:22 INFO - PID 15226 | 13:51:24 INFO - PID 15226 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50451/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:51:25 INFO - PID 15226 | RSS: Main: 169541632 13:51:25 INFO - PID 15226 | 13:51:27 INFO - PID 15226 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50451/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:51:27 INFO - PID 15226 | RSS: Main: 169582592 13:51:27 INFO - PID 15226 | 13:51:30 INFO - PID 15226 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50451/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:51:31 INFO - PID 15226 | RSS: Main: 169824256 13:51:31 INFO - PID 15226 | 13:51:34 INFO - PID 15226 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50451/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:51:35 INFO - PID 15226 | RSS: Main: 169787392 13:51:35 INFO - PID 15226 | 13:51:36 INFO - PID 15226 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50451/tests/kraken/driver.html?testName=ai-astar) 13:51:37 INFO - PID 15226 | RSS: Main: 170774528 13:51:37 INFO - PID 15226 | 13:51:37 INFO - PID 15226 | __start_tp_report 13:51:37 INFO - PID 15226 | _x_x_mozilla_page_load 13:51:37 INFO - PID 15226 | _x_x_mozilla_page_load_details 13:51:37 INFO - PID 15226 | |i|pagename|runs| 13:51:37 INFO - PID 15226 | |0;ai-astar;107;113;111;112;110;112;112;111;111;112 13:51:37 INFO - PID 15226 | |1;audio-beat-detection;160;123;123;173;126;126;129;126;151;125 13:51:37 INFO - PID 15226 | |2;audio-dft;164;166;166;162;164;167;169;175;167;165 13:51:37 INFO - PID 15226 | |3;audio-fft;75;74;76;102;76;78;76;75;95;77 13:51:37 INFO - PID 15226 | |4;audio-oscillator;83;83;105;83;83;83;98;84;83;112 13:51:37 INFO - PID 15226 | |5;imaging-gaussian-blur;114;116;113;115;116;117;114;115;114;118 13:51:37 INFO - PID 15226 | |6;imaging-darkroom;151;151;151;153;150;150;150;154;151;150 13:51:37 INFO - PID 15226 | |7;imaging-desaturate;94;96;95;95;95;95;94;95;96;94 13:51:37 INFO - PID 15226 | |8;json-parse-financial;54;54;56;54;56;56;57;57;55;55 13:51:37 INFO - PID 15226 | |9;json-stringify-tinderbox;56;57;57;56;56;56;57;56;58;57 13:51:37 INFO - PID 15226 | |10;stanford-crypto-aes;82;84;83;83;82;81;84;86;84;82 13:51:37 INFO - PID 15226 | |11;stanford-crypto-ccm;132;140;133;135;135;132;132;135;192;132 13:51:37 INFO - PID 15226 | |12;stanford-crypto-pbkdf2;187;195;202;195;198;192;195;198;209;204 13:51:37 INFO - PID 15226 | |13;stanford-crypto-sha256-iterative;76;76;76;74;74;73;77;72;71;72 13:51:37 INFO - PID 15226 | __end_tp_report 13:51:37 INFO - PID 15226 | __start_cc_report 13:51:37 INFO - PID 15226 | _x_x_mozilla_cycle_collect,792 13:51:37 INFO - PID 15226 | __end_cc_report 13:51:37 INFO - PID 15226 | __startTimestamp1495572697237__endTimestamp 13:51:37 INFO - PID 15226 | 13:51:37 INFO - PID 15226 | ------- Summary: start ------- 13:51:37 INFO - PID 15226 | Number of tests: 14 13:51:37 INFO - PID 15226 | 13:51:37 INFO - PID 15226 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:1.66 (1.5%) stddev-sans-first:0.88 13:51:37 INFO - PID 15226 | Values: 107.0 113.0 111.0 112.0 110.0 112.0 112.0 111.0 111.0 112.0 13:51:37 INFO - PID 15226 | 13:51:37 INFO - PID 15226 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:127.50 stddev:18.19 (14.3%) stddev-sans-first:17.13 13:51:37 INFO - PID 15226 | Values: 160.0 123.0 123.0 173.0 126.0 126.0 129.0 126.0 151.0 125.0 13:51:37 INFO - PID 15226 | 13:51:37 INFO - PID 15226 | [#2] audio-dft Cycles:10 Average:166.50 Median:166.50 stddev:3.57 (2.1%) stddev-sans-first:3.67 13:51:37 INFO - PID 15226 | Values: 164.0 166.0 166.0 162.0 164.0 167.0 169.0 175.0 167.0 165.0 13:51:37 INFO - PID 15226 | 13:51:37 INFO - PID 15226 | [#3] audio-fft Cycles:10 Average:80.40 Median:76.00 stddev:9.74 (12.8%) stddev-sans-first:10.14 13:51:37 INFO - PID 15226 | Values: 75.0 74.0 76.0 102.0 76.0 78.0 76.0 75.0 95.0 77.0 13:51:37 INFO - PID 15226 | 13:51:37 INFO - PID 15226 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:83.00 stddev:11.07 (13.3%) stddev-sans-first:11.47 13:51:37 INFO - PID 15226 | Values: 83.0 83.0 105.0 83.0 83.0 83.0 98.0 84.0 83.0 112.0 13:51:37 INFO - PID 15226 | 13:51:37 INFO - PID 15226 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.50 stddev:1.55 (1.3%) stddev-sans-first:1.58 13:51:37 INFO - PID 15226 | Values: 114.0 116.0 113.0 115.0 116.0 117.0 114.0 115.0 114.0 118.0 13:51:37 INFO - PID 15226 | 13:51:37 INFO - PID 15226 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:1.37 (0.9%) stddev-sans-first:1.45 13:51:37 INFO - PID 15226 | Values: 151.0 151.0 151.0 153.0 150.0 150.0 150.0 154.0 151.0 150.0 13:51:37 INFO - PID 15226 | 13:51:37 INFO - PID 15226 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 13:51:37 INFO - PID 15226 | Values: 94.0 96.0 95.0 95.0 95.0 95.0 94.0 95.0 96.0 94.0 13:51:37 INFO - PID 15226 | 13:51:37 INFO - PID 15226 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.00 stddev:1.17 (2.1%) stddev-sans-first:1.13 13:51:37 INFO - PID 15226 | Values: 54.0 54.0 56.0 54.0 56.0 56.0 57.0 57.0 55.0 55.0 13:51:37 INFO - PID 15226 | 13:51:37 INFO - PID 15226 | [#9] json-stringify-tinderbox Cycles:10 Average:56.60 Median:57.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 13:51:37 INFO - PID 15226 | Values: 56.0 57.0 57.0 56.0 56.0 56.0 57.0 56.0 58.0 57.0 13:51:37 INFO - PID 15226 | 13:51:37 INFO - PID 15226 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.50 stddev:1.45 (1.7%) stddev-sans-first:1.48 13:51:37 INFO - PID 15226 | Values: 82.0 84.0 83.0 83.0 82.0 81.0 84.0 86.0 84.0 82.0 13:51:37 INFO - PID 15226 | 13:51:37 INFO - PID 15226 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:135.00 stddev:18.51 (13.7%) stddev-sans-first:19.42 13:51:37 INFO - PID 15226 | Values: 132.0 140.0 133.0 135.0 135.0 132.0 132.0 135.0 192.0 132.0 13:51:37 INFO - PID 15226 | 13:51:37 INFO - PID 15226 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.50 Median:198.00 stddev:6.28 (3.2%) stddev-sans-first:5.39 13:51:37 INFO - PID 15226 | Values: 187.0 195.0 202.0 195.0 198.0 192.0 195.0 198.0 209.0 204.0 13:51:37 INFO - PID 15226 | 13:51:37 INFO - PID 15226 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.10 Median:75.00 stddev:2.08 (2.8%) stddev-sans-first:2.09 13:51:37 INFO - PID 15226 | Values: 76.0 76.0 76.0 74.0 74.0 73.0 77.0 72.0 71.0 72.0 13:51:37 INFO - PID 15226 | -------- Summary: end -------- 13:51:37 INFO - PID 15226 | 13:51:38 INFO - TEST-INFO | 15226: exit 0 13:51:38 INFO - TEST-OK | kraken | took 62865ms 13:51:38 INFO - SUITE-END | took 1180s 13:51:38 INFO - Completed test suite (00:19:40) 13:51:38 INFO - javascript benchmark 13:51:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6661.073446661825, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2726.1412655013673, 2748.5464898291784, 2768.473989941911, 2788.6514185726783, 2790.455861107084, 5165.81919632813, 5267.209918512225, 5289.761960711768, 5293.153095504716, 5322.361316642004, 5177.689338639684, 5225.451327610594, 5308.044551980652, 5322.733863306828, 5344.759485823138, 4529.34324522944, 4734.384530011093, 4743.501932297111, 4753.881152971168, 4775.997040621473, 4770.785314660849, 4818.25317075852, 4819.0602832447685, 4833.0, 4850.684705494149, 4598.126355992351, 4644.86065418038, 4658.510856360102, 4734.715917044989, 4742.739149346785, 4724.811007559693, 4728.881777955544, 4744.881377965544, 4764.142454358214, 4783.880402989918, 4655.162070827249, 4682.063587282557, 4699.177643912301, 4700.177468942956, 4732.574068333832, 5192.221166825007, 5247.895042099175, 5266.7629956652045, 5276.3140791697215, 5283.973580132113, 5611.102223644238, 5673.546116310686, 5742.339630942453, 5743.62666426681, 5763.682997435139, 5753.252077229975, 5757.251557297566, 5770.394108618577, 5771.422857714237, 5787.0, 5205.583553315726, 5322.38792538863, 5358.303420555342, 5365.0, 5367.033933891859, 5790.392008839011, 5845.941540584625, 5882.676452795137, 5891.204687367151, 5893.970530147321, 5563.388027316992, 5584.190292407578, 5589.636673616202, 5591.8602034948635, 5605.439456054362, 5634.154876768435, 5691.146328050825, 5701.629394089371, 5713.4000929902595, 5762.827115186551, 5626.606137570413, 5689.061304884648, 5700.144978253295, 5701.4298570142655, 5706.514946229534, 5557.360903496069, 5593.944060559343, 5613.298337707786, 5646.181303710939, 5681.971590142106, 4793.9280910786365, 4837.443693975238, 4842.709437433765, 4870.805167793319, 4887.266909963463, 4113.074558224375, 4125.1749650070105, 4126.257273690704, 4127.030147915238, 4157.230912281238, 4736.692115012582, 4736.8578942631775, 4787.473377928425, 4810.350602668665, 4834.7824347904425, 5721.284839395075, 5734.340550836624, 5737.627054241461, 5742.425757424307, 5763.538916886639, 4771.475137734847, 4795.232762757942, 4796.184648609745, 4804.159272127364, 4857.489963553776, 4992.276119962585, 5018.949810501921, 5045.117104506697, 5061.544460998528, 5080.161773307437, 5233.790648374023, 5250.501202385767, 5252.422233554383, 5255.684658920324, 5296.179092240709, 5629.915551266652, 5663.207150998781, 5676.290463692038, 5677.630953987978, 5691.914621280601, 5162.277281180563, 5197.22041693749, 5216.921746173886, 5246.658967167122, 5295.7087360195555, 5508.91736623943, 5586.581006424616, 5586.664800112007, 5621.634593751393, 5638.5771067170945, 5704.686242256716, 5721.685307308138, 5728.828135155952, 5731.168980497888, 5747.453991870766, 5440.863978400572, 5546.889062218814, 5549.639273447213, 5557.1664250361155, 5627.7467513961155, 5514.724263786715, 5540.861478463071, 5550.250716153268, 5555.805546805843, 5601.075822489243, 5450.482204190595, 5465.098258787256, 5475.041867673221, 5522.088855338824, 5522.144067669517, 5482.616216864782, 5505.201745746765, 5584.804531841366, 5607.532536149945, 5682.147677848356, 5408.621396502364, 5424.701641409761, 5455.0726376515295, 5481.835544933659, 5482.725863706878], "value": 5164.571334621322, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.1578177351464, 673.2089794491471, 700.3451772592626, 1184.0468422919546, 1189.0606420927468, 34430.82784586077, 35368.0, 35416.645833541654, 35501.2899742005, 35510.467342989876, 33288.66711332886, 34329.65670343296, 34378.31243375137, 34383.0, 34436.82781586095, 7038.366547010781, 7145.678444469985, 7154.0, 7156.4274858011495, 7165.820854478628, 6885.277045910182, 7036.824079398005, 7045.626102909934, 7056.294370562954, 7065.32879376461, 6961.164660240753, 6982.581045137283, 7062.0, 7071.257517960592, 7082.220955694869, 6950.582965022089, 7020.824479388005, 7032.929670703279, 7064.0, 7068.11648543932, 6878.415334696557, 6945.548539344977, 6949.687264073078, 6953.374196322356, 6953.826154346182, 32241.83879080613, 32287.515687264477, 32503.187420314443, 32730.672693273, 32794.18014549655, 2869.210966984075, 2894.131760471871, 2899.405621847537, 2899.782516311264, 2911.544227886057, 24573.877130614233, 24597.0, 24651.137210197558, 24658.931276339383, 24760.133395331257, 3094.164575564585, 3096.5974423324824, 3115.049909777517, 3123.484625036866, 3149.6692847251165, 147737.0, 147907.0, 148907.0, 152754.0, 156971.4302856968, 38672.613273867464, 38841.6115838838, 39134.217315654096, 39305.803470982464, 39406.60593394029, 40306.395404068964, 40884.0, 46035.76982115135, 47083.0, 47402.288965665546, 12662.620121396372, 12734.554290599785, 12759.42582583786, 12769.744605108031, 12787.232766034067, 10128.797424051478, 10156.39061656303, 10190.592376304865, 10202.897971020195, 10208.744781380525, 12678.683032924251, 12703.491860325668, 12734.80897786534, 12819.743605127846, 12890.419931103123, 5300.151975683949, 5458.754356053987, 5492.780288788484, 5499.972500137474, 5589.608727389043, 823.320760372695, 878.0692465986075, 894.9149830766066, 898.3756289378819, 904.5432056811268, 20447.488812779502, 21578.568428631654, 21656.891715541322, 21713.67429488559, 21798.455038623844, 969.762408209993, 977.5063592885547, 992.4591097851688, 997.6308765756717, 1002.5638847101534, 11139.443027848574, 11316.151288653384, 11511.30932144074, 11516.712082197844, 11552.191346605825, 177340.11329943527, 178350.0, 178485.0, 178851.0, 179079.0, 39510.80244598759, 40062.39906401406, 40194.39708404318, 40246.56055031181, 40344.19311613751, 1212.9206295682902, 1216.3249396584804, 1225.3628113381171, 1230.3417671545858, 1235.110720281396, 19445.8055419444, 19736.802631973496, 20298.0, 20751.8962405187, 21254.25610103639, 28625.570616441186, 28670.42659146847, 28675.426491470473, 28685.71314286914, 28731.0, 146823.2658836699, 147806.0, 147918.0, 147978.0, 148307.0, 28715.0, 28892.42215155727, 28947.56578651364, 29171.124866254046, 30157.246068848453, 35828.64171358253, 35858.8207058963, 36218.0, 36240.456393153596, 36331.0, 25758.484830302914, 27467.0, 27478.313042174104, 27770.444591107662, 28006.2998425041, 26751.464970700865, 26780.59829102604, 27338.0, 28057.0, 28290.575641364983, 29495.410091797614, 30067.69932300649, 30479.238019049702, 30513.694863051085, 30695.2326191847, 26278.209932291385, 26725.331866703487, 26851.0, 26885.327866802705, 27907.581386278816, 20599.691004635242, 22378.77621223832, 22428.32715018552, 22561.323160305215, 22608.886955565118], "value": 14536.48489448242, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.5020698195836, 387.74796382351485, 400.403398935586, 412.97522148671084, 426.1519576043673, 12972.870271297284, 17348.82651173488, 17480.21339039743, 18020.819791802096, 18038.278468861245, 18157.546061348472, 18457.90771046143, 18544.443666689986, 18554.90722546389, 18622.441326760218, 5321.521063104329, 5359.919601205985, 5531.25328080708, 5572.0527510323345, 5574.080276754331, 5434.347878254595, 5527.972360138194, 5532.75102620383, 5536.307961504812, 5550.91673624896, 5359.785608575652, 5370.650907690988, 5489.313835770528, 5506.311711036121, 5512.118061110203, 5439.592030597721, 5451.236826844245, 5464.6994415307145, 5471.288732464794, 5483.835484935458, 4750.0, 4841.0, 4870.123377791996, 4891.217405215149, 4925.852224433273, 21483.892580536998, 21595.0, 21810.0, 21867.453313667127, 21888.671669924963, 1545.65995480994, 1618.660081382911, 1635.7301045327506, 1672.1388484930271, 1673.5314112048645, 14516.419343226258, 14593.635159121, 14725.410983560752, 14783.0, 14856.925715371463, 2027.9898600507051, 2065.6694928811467, 2077.522169900931, 2086.968695469569, 2103.5582527669208, 85946.57026714826, 86851.0, 87247.56376218142, 88041.67937480944, 89165.0, 10089.394636321844, 10266.897331026743, 10270.537825797857, 10320.43237621938, 10449.791004179873, 13757.931210343884, 13872.306384680927, 13885.166889986633, 13913.30433478322, 14389.568312950629, 7385.593792341473, 7410.555366678017, 7414.888776668355, 7590.051243594551, 7611.467197296136, 6996.755113571001, 7022.4733145014325, 7190.532615379983, 7202.53183543068, 7241.275872412716, 6633.7346506140175, 6792.932070679329, 6822.863542729117, 6856.074429951893, 6864.24493305736, 2014.3453377652322, 2022.2113375783456, 2063.8968051597362, 2079.5321052763006, 2165.9133634654436, 853.9829203415896, 878.7232021913077, 892.4422236102436, 892.4511425473287, 918.5958178401482, 16375.263113159936, 16550.255238514295, 16656.666866662843, 16743.413980510868, 17329.65340693179, 877.2806298835021, 891.8216356728681, 898.9011208767031, 900.3337530227584, 916.2395211974045, 8948.239399650973, 9006.144416280444, 10692.839607405895, 11642.708932276591, 11670.0, 364293.0, 367816.0, 368446.0, 370047.0, 373108.0, 75999.62000190074, 78232.0, 79921.0, 80717.59641201874, 81052.0, 1086.9076128529164, 1118.2898859224288, 1134.5291703942937, 1142.657202839145, 1153.1121036801617, 16842.663146737243, 16933.830661693224, 17206.22571984289, 17563.56091097733, 17663.205155767766, 38854.028649283995, 38961.6103838958, 39677.80161099176, 39698.206035879695, 40528.392074118325, 48336.758316208194, 48709.269360958904, 50601.74699126481, 50806.237906430695, 51557.22664159966, 7820.687172513036, 7836.09884863248, 8008.359331253602, 8279.172082791672, 8366.205210504992, 12317.137800353888, 12702.428390722254, 12722.61832145037, 12835.93582032084, 13153.736925261632, 11487.0, 11761.705957350792, 11890.0, 11966.46150923228, 12014.699632509257, 11118.0, 11184.552617895193, 11221.60724374643, 11386.089112871116, 11386.715332116763, 11743.76512469763, 11860.644180674593, 11919.0, 11972.16194866351, 12561.309127998047, 8238.854465395836, 8346.248837604644, 8521.488710677379, 8562.229399354088, 8654.524001179996, 11320.150988675718, 11424.600138995427, 11641.417929103342, 11837.289762614271, 11873.109516786102], "value": 8880.47443509619, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1253.7429826885489, 1302.2772361339453, 1321.4714114354258, 1333.2733660155213, 1333.53992872459, 9741.220702343813, 10174.033466820649, 10183.59265629375, 10299.48502574872, 10674.519646615901, 10298.227632927523, 10476.0, 10480.371177729323, 10481.790364192711, 10497.947510262438, 2171.283476452767, 2204.2505548113636, 2216.601011817872, 2225.610518159324, 2229.7547269800307, 2088.874667519946, 2160.6758986152045, 2163.8809865457392, 2180.5965896309153, 2185.748638906522, 2216.92240771573, 2229.0, 2260.1411463643876, 2260.5026894083276, 2260.5930932432157, 2130.068265189603, 2182.879941603211, 2221.911123555056, 2226.109556177526, 2232.05137816429, 2092.6756352765346, 2162.1999860051724, 2196.198387588535, 2197.835162362829, 2209.5470428562107, 10030.899691003142, 10124.139448146916, 10136.94931525345, 10161.644342447978, 10220.948895255477, 5260.289860868772, 5420.972895135499, 5446.972765136188, 5447.836564903059, 5448.264484294609, 3093.3040065985197, 3315.668433156689, 3371.123507887942, 3386.9491957620658, 3387.8983630491125, 1047.748540350318, 1063.9893601063968, 1092.3500517192258, 1117.1788735279563, 1135.103268417957, 14678.633034174125, 14747.483838065617, 14821.851781482155, 14843.109413435228, 14872.925635371754, 4264.381664658607, 4379.693421460467, 4573.977130114328, 4612.238980568236, 4631.560001799824, 10354.016368444985, 10373.066424021874, 10446.582136714447, 10455.215858810467, 10504.737381565523, 5329.387120481117, 5338.3060202173465, 5389.353277606712, 5410.621256512007, 5412.458754124556, 4784.4497882743235, 4991.401031876126, 5057.291979122926, 5109.310243117206, 5151.351567498439, 3632.0919770057485, 3688.5573731152435, 3733.1227161617, 3781.6785573226584, 3784.545854497478, 992.7617371830853, 1028.6708253359002, 1029.696239609317, 1032.695354870315, 1035.166690813902, 687.9105716256854, 714.907062081926, 717.4941666125369, 727.3998950865451, 739.7817643795094, 5325.920111198335, 5403.891922161613, 5468.835934921879, 5562.110062389998, 5578.135389014709, 504.3896884769397, 518.2537146509015, 519.2730177751179, 522.0941666209125, 525.4797750227248, 3264.249222678797, 3354.2117602363423, 3360.6135294440965, 3507.6667716566885, 3583.8924832255075, 12750.171238869443, 13166.605001849959, 13423.926085913103, 13460.93269533646, 13468.5286014989, 12599.370031498389, 13061.869381306255, 13223.404946777418, 13327.466901324033, 13379.53171638988, 6935.965320173367, 7025.121859767529, 7072.646367681698, 7158.355747982707, 7158.749443769443, 5455.590830687794, 5468.617196796186, 5528.391876893619, 5575.330960284792, 5727.0, 11264.211505194558, 11277.154213434189, 11346.716332091764, 11392.886071139183, 11433.884731324732, 11723.41382930833, 11831.704207394883, 11878.46546905374, 12004.639860804189, 12135.211211271238, 7027.7188912442925, 7230.566166030055, 7237.095363079615, 7239.710411583688, 7242.818929526804, 9441.952790236004, 9538.427694338361, 9538.618455261712, 9547.42715437076, 9557.808843822946, 7860.371170306247, 7946.284834364935, 8074.071481779436, 8327.167283271867, 8370.330373570221, 8001.319887809602, 8086.83826323482, 8111.634976426193, 8116.026076870813, 8200.671973121247, 7342.19235884063, 7395.112586489656, 7436.776896693108, 7458.21688722698, 7511.399088073051, 5107.9233811493605, 5130.948690513196, 5169.302144210484, 5238.0, 5439.156930675752, 5049.2173713074535, 5149.0, 5246.0, 5246.108161612458, 5277.0], "value": 4573.312554434282, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.8093539021234, 367.2269871919609, 383.78316251318006, 386.1909300016468, 391.69643526267157, 5619.269494965654, 5631.8592035199035, 5634.3802181759975, 5639.407862174474, 5653.604247702662, 5442.9727851360685, 5498.725063746817, 5521.558275337973, 5524.751386187621, 5539.529140023093, 4286.207051695446, 4298.806553705091, 4305.203537345586, 4305.318952295789, 4338.457692788402, 4298.0, 4302.806373713175, 4311.8706438806885, 4326.134773045388, 4326.3559847258, 4193.329067349225, 4302.634276086536, 4313.266744653401, 4315.611594956454, 4323.567643235683, 4254.765987870666, 4261.0, 4262.1688770689725, 4270.893227669302, 4302.182585308781, 3829.17672700368, 3838.2899163654815, 3867.1298957734566, 3872.3997780344093, 3872.845086196549, 5357.946420535784, 5444.537214336786, 5455.345358556959, 5458.099413596752, 5473.8357849264585, 5053.216751403538, 5072.771725272335, 5078.187490001619, 5103.8468845934685, 5106.157484015133, 5862.97068514659, 5881.764729410818, 5889.586499240151, 5894.616849904785, 5896.823095307148, 4184.769837658928, 4294.1197054604045, 4342.717723348004, 4350.715210016449, 4353.172897149531, 5988.9101663475085, 6146.907796383058, 6151.907721384183, 6155.753769849201, 6178.135061091451, 4066.7356621819486, 4081.2653722329674, 4097.44684467599, 4103.261412945699, 4104.671626269891, 4144.834206631701, 4169.770662613585, 4173.4157217989505, 4173.518400967613, 4188.078622703, 4739.7630118493935, 4801.207800712913, 4819.759012049383, 4822.541858523435, 4824.758762061883, 5862.296524417012, 5865.178874957424, 5867.794627188114, 5869.706514674249, 5889.1755154278435, 1424.622475044114, 1430.7409479658043, 1436.1167881752856, 1438.6834896322791, 1438.8129543159323, 891.9732408027769, 935.881621462346, 942.9104235097655, 944.650479322655, 946.4888959961681, 4991.775370108354, 5016.423111342169, 5037.539113656999, 5042.546170844642, 5044.4198917125, 5999.610025348338, 6073.271207455045, 6081.75672973085, 6092.451679348791, 6121.540884433685, 4791.616670666338, 4963.6277279204205, 4975.825846095369, 5019.14674505335, 5043.117454445457, 3191.521271809247, 3217.951730724041, 3222.258880457461, 3236.401265765841, 3240.643529211785, 5455.0453670607485, 5579.7489112990015, 5584.46947539983, 5601.08743453402, 5611.298587676541, 6148.661823599745, 6189.5048396129105, 6228.110932917638, 6229.875402491924, 6270.7805226816845, 5525.889482210333, 5554.2779438672715, 5585.218069470277, 5606.831795046155, 5611.579131565068, 5830.5044071254415, 6037.184980027816, 6070.726817293144, 6089.786857460145, 6090.543209259412, 5982.371850955587, 5991.011483105239, 5997.760089596367, 5999.370066142992, 6015.037593984942, 5411.945880541144, 5574.832755017356, 5593.2728745264485, 5604.271444712324, 5617.43825617435, 4081.40819581165, 4113.9794301028305, 4115.991582062414, 4118.588141185857, 4126.814293356746, 6018.277806663228, 6119.938800611937, 6135.754569817157, 6145.508359331154, 6148.292946311052, 5900.144479050427, 5934.109883517507, 5936.22829032223, 5956.166136740773, 5970.5522085844605, 5902.7343769531335, 5930.48772563011, 5939.198208241832, 5943.702814859326, 5960.3443621202505, 5717.0, 5839.0949402842625, 5851.736671849862, 5865.4134586541, 5897.7935772247765, 5963.463288304073, 5970.835687040985, 5977.2665926882455, 5983.491403230774, 5997.880042399041, 5645.350784659652, 5760.423957604374, 5797.9420205797405, 5805.79679711225, 5813.360530341574], "value": 4396.933320853768, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.1737352249403, 674.1707699529578, 730.5142080516457, 745.9440541959352, 772.64072206424, 10709.892901070987, 11115.333080015205, 12456.626301210956, 13030.283334416592, 13097.934510327446, 13836.169829810218, 14243.28783560823, 14335.856641433582, 14398.49605263816, 14478.782818257734, 851.7146755836802, 858.8067684770939, 866.3762091294258, 869.6217145541709, 872.0, 878.947263164209, 880.6961598248594, 881.7575166829141, 881.9073997230295, 883.8099808541162, 921.9446833189996, 923.5659240157115, 924.7318277699459, 924.8381533231658, 930.4975313330793, 911.2527727263647, 912.7444315591612, 913.4108500017518, 919.9954000230023, 922.0594993107027, 669.829193555645, 671.5668393885965, 673.2560520624737, 673.8012286375531, 676.681959479044, 12964.351782410842, 13179.73640527184, 13238.205707657571, 13399.933000335033, 13709.45162193511, 14401.20793356365, 14429.927850360786, 14431.927840360837, 14551.636209094857, 14584.48954286595, 11856.347900865449, 11912.404379781063, 11917.344546049964, 11987.820182697267, 12026.39868006605, 2817.7323154300307, 2823.3365159187574, 2854.628898243215, 2863.9713602863912, 2867.0538722221618, 65983.0, 66458.66770666164, 66746.66626666836, 67443.66278168627, 67761.66119169373, 9619.90380096204, 9838.557264923096, 9962.800743985079, 10004.19966402686, 11354.489047992694, 19865.0, 20314.695279570817, 20329.18683252683, 20357.694634580195, 20362.898185508977, 6023.849403764941, 6149.754009839646, 6197.876042479125, 6275.466585340206, 6296.811095667137, 2979.3445442002726, 3037.331787006855, 3038.9088327350214, 3041.528563072727, 3046.466868298039, 3012.774041946863, 3020.652624948159, 3035.9089227323216, 3066.6166729158854, 3111.0, 627.5136769004058, 631.1637080867869, 636.1952130554852, 637.1589501857596, 637.6939069246695, 600.474584738354, 615.8152554233801, 615.9784407545715, 620.5407998081387, 638.1353266324156, 9337.533123343806, 9573.808523829484, 9666.0, 9781.070798274153, 9934.354266972623, 573.7188777498995, 582.1384351160307, 584.1092334190394, 585.3824215452738, 591.1576004194093, 4161.91676166475, 4245.1934132514725, 4293.592108749664, 4302.376155457504, 4322.265214913472, 59579.0, 59627.403725962184, 59667.403325967054, 60952.0, 62628.373716263166, 53583.0, 53782.0, 54702.1277659207, 56793.43206567964, 57252.14121788176, 46546.0, 46620.3006954896, 46705.5329446708, 47453.76273118612, 48107.27839082417, 8405.159484051546, 8685.652573897227, 8763.956180219058, 8938.10618938101, 9070.092990700878, 25445.87277063603, 25691.3577160565, 25849.095281665803, 25979.74020259849, 26454.603180951915, 31065.8446707765, 31185.064448066594, 31347.68652313448, 31614.36771264608, 31952.680473195902, 11678.124140689313, 11778.057755379721, 11805.822912656145, 11850.229735067192, 11927.165098443025, 15153.318100685716, 15218.923905380845, 15668.92165539165, 15898.841011589737, 16051.117188554275, 14506.347214375168, 14531.709365812836, 14754.114753114847, 15302.31139598743, 15426.84573154254, 14339.569812905629, 14405.567832965027, 14616.196109214095, 15533.533993980198, 15644.0, 13736.244506552235, 13747.725045499234, 13877.236751978739, 13975.09161904473, 14193.929030354782, 10520.0, 10676.0, 10755.0, 10788.0, 11386.715332116763, 10345.74135646615, 11188.552457901918, 11235.045021172964, 11270.154738394816, 11273.82925045166], "value": 6515.123570111679, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 111.0, 112.0, 110.0, 112.0, 112.0, 111.0, 111.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 123.0, 123.0, 173.0, 126.0, 126.0, 129.0, 126.0, 151.0, 125.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 166.0, 162.0, 164.0, 167.0, 169.0, 175.0, 167.0, 165.0], "value": 166.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 102.0, 76.0, 78.0, 76.0, 75.0, 95.0, 77.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 105.0, 83.0, 83.0, 83.0, 98.0, 84.0, 83.0, 112.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 113.0, 115.0, 116.0, 117.0, 114.0, 115.0, 114.0, 118.0], "value": 115.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 153.0, 150.0, 150.0, 150.0, 154.0, 151.0, 150.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 56.0, 54.0, 56.0, 56.0, 57.0, 57.0, 55.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 56.0, 56.0, 56.0, 57.0, 56.0, 58.0, 57.0], "value": 56.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 83.0, 83.0, 82.0, 81.0, 84.0, 86.0, 84.0, 82.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 140.0, 133.0, 135.0, 135.0, 132.0, 132.0, 135.0, 192.0, 132.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 195.0, 202.0, 195.0, 198.0, 192.0, 195.0, 198.0, 209.0, 204.0], "value": 197.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 74.0, 74.0, 73.0, 77.0, 72.0, 71.0, 72.0], "value": 74.1, "unit": "score"}]}]} 13:51:38 INFO - Return code: 0 13:51:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:51:38 INFO - # TBPL SUCCESS # 13:51:38 INFO - Running post-action listener: _resource_record_post_action 13:51:38 INFO - [mozharness: 2017-05-23 20:51:38.521908Z] Finished run-tests step (success) 13:51:38 INFO - Running post-run listener: _resource_record_post_run 13:51:38 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 24576; Write bytes: 412033024; Read time: 252; Write time: 254724 13:51:38 INFO - TinderboxPrint: CPU usage
13.3% 13:51:38 INFO - TinderboxPrint: I/O read bytes / time
24,576 / 252 13:51:38 INFO - TinderboxPrint: I/O write bytes / time
412,033,024 / 254,724 13:51:38 INFO - TinderboxPrint: CPU idle
8,276.1 (86.7%) 13:51:38 INFO - TinderboxPrint: CPU user
1,214.0 (12.7%) 13:51:38 INFO - TinderboxPrint: Swap in / out
0 / 0 13:51:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 45494272; Read time: 0; Write time: 10168 13:51:38 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 24576; Write bytes: 302526464; Read time: 252; Write time: 160984 13:51:39 INFO - Running post-run listener: _upload_blobber_files 13:51:39 INFO - Blob upload gear active. 13:51:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:51:39 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 13:51:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:51:39 INFO - (blobuploader) - INFO - Open directory for files ... 13:51:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:51:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:51:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:51:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:51:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:51:40 INFO - (blobuploader) - INFO - Done attempting. 13:51:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:51:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:51:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:51:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:51:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:51:44 INFO - (blobuploader) - INFO - Done attempting. 13:51:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:51:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:51:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:51:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:51:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:51:44 INFO - (blobuploader) - INFO - Done attempting. 13:51:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:51:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:51:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:51:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:51:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:51:45 INFO - (blobuploader) - INFO - Done attempting. 13:51:45 INFO - (blobuploader) - INFO - Iteration through files over. 13:51:45 INFO - Return code: 0 13:51:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:51:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:51:45 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43d2c7e7332fa3dabbad0fcdbf40203591f3fa78e84b0d3f461e4c42f85678152919d9c80fe6008b1caa286c64a76d271454058b951328684588d67b07c6699f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f9c93eda135d154f46a69e652b307c22f68e0132cf3e12a47f5c305778784cdffcff564ee9d1d5e0a32683fe96dc7819059cb36f44bdeabe94e0268a43d9b20f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc09a202bd657cdcbea57b071d87935475e094da2e9115060b05e2ddd5002fc657a4e9f26b5339200262e8034676fbfaa08bd86bb495f56a0f36dce837cf649d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ba0b792839136cb53eaaad193f1773b586472825ae3d7434a62218bf4d3a46391b55b2c555e80110bb5bdd6825044068f89edb6cabd1c14919459307cec93305"} 13:51:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:51:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:51:45 INFO - Contents: 13:51:45 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43d2c7e7332fa3dabbad0fcdbf40203591f3fa78e84b0d3f461e4c42f85678152919d9c80fe6008b1caa286c64a76d271454058b951328684588d67b07c6699f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f9c93eda135d154f46a69e652b307c22f68e0132cf3e12a47f5c305778784cdffcff564ee9d1d5e0a32683fe96dc7819059cb36f44bdeabe94e0268a43d9b20f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc09a202bd657cdcbea57b071d87935475e094da2e9115060b05e2ddd5002fc657a4e9f26b5339200262e8034676fbfaa08bd86bb495f56a0f36dce837cf649d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ba0b792839136cb53eaaad193f1773b586472825ae3d7434a62218bf4d3a46391b55b2c555e80110bb5bdd6825044068f89edb6cabd1c14919459307cec93305"} 13:51:45 INFO - Running post-run listener: copy_logs_to_upload_dir 13:51:45 INFO - Copying logs to upload dir... 13:51:45 INFO - mkdir: /builds/slave/test/build/upload/logs 13:51:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.607559 ========= master_lag: 0.28 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-05-23 13:51:45.734181) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-23 13:51:45.740982) ========= 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=20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43d2c7e7332fa3dabbad0fcdbf40203591f3fa78e84b0d3f461e4c42f85678152919d9c80fe6008b1caa286c64a76d271454058b951328684588d67b07c6699f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f9c93eda135d154f46a69e652b307c22f68e0132cf3e12a47f5c305778784cdffcff564ee9d1d5e0a32683fe96dc7819059cb36f44bdeabe94e0268a43d9b20f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc09a202bd657cdcbea57b071d87935475e094da2e9115060b05e2ddd5002fc657a4e9f26b5339200262e8034676fbfaa08bd86bb495f56a0f36dce837cf649d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ba0b792839136cb53eaaad193f1773b586472825ae3d7434a62218bf4d3a46391b55b2c555e80110bb5bdd6825044068f89edb6cabd1c14919459307cec93305"} build_url:https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011289 build_url: 'https://queue.taskcluster.net/v1/task/MOS5bP-qSIKODkKS8t6IqQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43d2c7e7332fa3dabbad0fcdbf40203591f3fa78e84b0d3f461e4c42f85678152919d9c80fe6008b1caa286c64a76d271454058b951328684588d67b07c6699f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f9c93eda135d154f46a69e652b307c22f68e0132cf3e12a47f5c305778784cdffcff564ee9d1d5e0a32683fe96dc7819059cb36f44bdeabe94e0268a43d9b20f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc09a202bd657cdcbea57b071d87935475e094da2e9115060b05e2ddd5002fc657a4e9f26b5339200262e8034676fbfaa08bd86bb495f56a0f36dce837cf649d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ba0b792839136cb53eaaad193f1773b586472825ae3d7434a62218bf4d3a46391b55b2c555e80110bb5bdd6825044068f89edb6cabd1c14919459307cec93305"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-23 13:51:45.765331) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 13:51:45.769765) ========= 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=20e666a3d4cfbb71505a330e000001b4-1495571448.957888-450007987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004406 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 13:51:45.849286) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-23 13:51:45.851629) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-23 13:51:45.851920) ========= ========= Total master_lag: 0.60 =========