builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-003 starttime: 1495813855.62 results: success (0) revision: 9104506c0a5eaac89b6c22c804c83ccee7d6e662 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-26 08:50:55.619906) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-26 08:50:55.621060) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-26 08:50:55.621330) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-26 08:50:55.640382) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 08:50:55.640707) ========= 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=7de08804244eb36560b44971000001c3-1495813244.483694-797584003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-26 08:50:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 87.5M=0s 2017-05-26 08:50:55 (87.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120061 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 08:50:55.773710) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 08:50:55.777040) ========= 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=7de08804244eb36560b44971000001c3-1495813244.483694-797584003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021248 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 08:50:55.827731) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-26 08:50:55.828078) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9104506c0a5eaac89b6c22c804c83ccee7d6e662 --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 9104506c0a5eaac89b6c22c804c83ccee7d6e662 --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=7de08804244eb36560b44971000001c3-1495813244.483694-797584003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-26 08:50:55,415 truncating revision to first 12 chars 2017-05-26 08:50:55,415 Setting DEBUG logging. 2017-05-26 08:50:55,415 attempt 1/10 2017-05-26 08:50:55,415 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9104506c0a5e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-26 08:50:56,236 unpacking tar archive at: mozilla-central-9104506c0a5e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.147107 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-26 08:50:56.995572) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-26 08:50:56.996021) ========= script_repo_revision: 9104506c0a5eaac89b6c22c804c83ccee7d6e662 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-26 08:50:56.996485) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-26 08:50:56.996786) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-26 08:50:57.007506) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2017-05-26 08:50:57.007955) ========= /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=7de08804244eb36560b44971000001c3-1495813244.483694-797584003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:50:56 INFO - MultiFileLogger online at 20170526 08:50:56 in /builds/slave/test 08:50:56 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 08:50:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:50:56 INFO - {'append_to_log': False, 08:50:56 INFO - 'base_work_dir': '/builds/slave/test', 08:50:56 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:50:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:50:56 INFO - 'branch': 'Firefox-Non-PGO', 08:50:56 INFO - 'buildbot_json_path': 'buildprops.json', 08:50:56 INFO - 'config_files': ('talos/linux_config.py',), 08:50:56 INFO - 'default_actions': ('clobber', 08:50:56 INFO - 'read-buildbot-config', 08:50:56 INFO - 'download-and-extract', 08:50:56 INFO - 'populate-webroot', 08:50:56 INFO - 'create-virtualenv', 08:50:56 INFO - 'install', 08:50:56 INFO - 'run-tests'), 08:50:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:50:56 INFO - 'download_minidump_stackwalk': True, 08:50:56 INFO - 'download_symbols': 'ondemand', 08:50:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:50:56 INFO - 'tooltool.py': '/tools/tooltool.py', 08:50:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:50:56 INFO - '/tools/misc-python/virtualenv.py')}, 08:50:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:50:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:50:56 INFO - 'gecko_profile': False, 08:50:56 INFO - 'gecko_profile_interval': 0, 08:50:56 INFO - 'installer_path': 'installer.exe', 08:50:56 INFO - 'log_level': 'info', 08:50:56 INFO - 'log_name': 'talos', 08:50:56 INFO - 'log_to_console': True, 08:50:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:50:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:50:56 INFO - 'opt_config_files': (), 08:50:56 INFO - 'pip_index': False, 08:50:56 INFO - 'suite': 'dromaeojs-e10s', 08:50:56 INFO - 'system_bits': '32', 08:50:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:50:56 INFO - 'title': 'talos-linux64-ix-003', 08:50:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:50:56 INFO - 'use_talos_json': True, 08:50:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:50:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:50:56 INFO - 'work_dir': 'build'} 08:50:56 INFO - [mozharness: 2017-05-26 15:50:56.683387Z] Running clobber step. 08:50:56 INFO - Running pre-action listener: _resource_record_pre_action 08:50:56 INFO - Running main action method: clobber 08:50:56 INFO - rmtree: /builds/slave/test/build 08:50:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:50:57 INFO - Running post-action listener: _resource_record_post_action 08:50:57 INFO - [mozharness: 2017-05-26 15:50:57.691743Z] Finished clobber step (success) 08:50:57 INFO - [mozharness: 2017-05-26 15:50:57.691843Z] Running read-buildbot-config step. 08:50:57 INFO - Running pre-action listener: _resource_record_pre_action 08:50:57 INFO - Running main action method: read_buildbot_config 08:50:57 INFO - Using buildbot properties: 08:50:57 INFO - { 08:50:57 INFO - "project": "", 08:50:57 INFO - "product": "firefox", 08:50:57 INFO - "who": "nobody@mozilla.org", 08:50:57 INFO - "installer_path": "public/build/target.tar.bz2", 08:50:57 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:50:57 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 08:50:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:50:57 INFO - "stage_platform": "linux64", 08:50:57 INFO - "basedir": "/builds/slave/test", 08:50:57 INFO - "buildnumber": 639, 08:50:57 INFO - "platform": "ubuntu64_hw", 08:50:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:50:57 INFO - "slavebuilddir": "test", 08:50:57 INFO - "taskId": "cmUe3vt3QHOfuKEC_HJ9yQ", 08:50:57 INFO - "branch": "mozilla-central", 08:50:57 INFO - "script_repo_revision": "production", 08:50:57 INFO - "revision": "9104506c0a5eaac89b6c22c804c83ccee7d6e662", 08:50:57 INFO - "slavename": "talos-linux64-ix-003", 08:50:57 INFO - "repo_path": "mozilla-central" 08:50:57 INFO - } 08:50:57 INFO - Finding installer, test and symbols from parent task. 08:50:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cmUe3vt3QHOfuKEC_HJ9yQ'}, attempt #1 08:50:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cmUe3vt3QHOfuKEC_HJ9yQ'}, attempt #1 08:50:58 INFO - Task dependencies: VmqVCM8nQCKSf9GZip4OMQ 08:50:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VmqVCM8nQCKSf9GZip4OMQ'}, attempt #1 08:50:59 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/target.tar.bz2 08:50:59 INFO - Set test_url: https://queue.taskcluster.net/v1/task/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/test_packages.json 08:50:59 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/target.crashreporter-symbols.zip 08:50:59 INFO - Running post-action listener: _resource_record_post_action 08:50:59 INFO - [mozharness: 2017-05-26 15:50:59.044854Z] Finished read-buildbot-config step (success) 08:50:59 INFO - [mozharness: 2017-05-26 15:50:59.045078Z] Running download-and-extract step. 08:50:59 INFO - Running pre-action listener: _resource_record_pre_action 08:50:59 INFO - Running main action method: download_and_extract 08:50:59 INFO - mkdir: /builds/slave/test/build/tests 08:50:59 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')]} 08:50:59 INFO - trying https://queue.taskcluster.net/v1/task/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/target.test_packages.json 08:50:59 INFO - Downloading https://queue.taskcluster.net/v1/task/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:50:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:50:59 INFO - Downloaded 986 bytes. 08:50:59 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:50:59 INFO - Using the following test package requirements: 08:50:59 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:50:59 INFO - u'common': [u'target.common.tests.zip'], 08:50:59 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:50:59 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:50:59 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:50:59 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:50:59 INFO - u'mozbase': [u'target.common.tests.zip'], 08:50:59 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:50:59 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:50:59 INFO - u'web-platform': [u'target.common.tests.zip', 08:50:59 INFO - u'target.web-platform.tests.zip'], 08:50:59 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:50:59 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:50:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/target.common.tests.zip 08:50:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:50:59 INFO - Fetch https://queue.taskcluster.net/v1/task/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/target.common.tests.zip into memory 08:51:00 INFO - Content-Length response header: 65720035 08:51:00 INFO - Bytes received: 65720035 08:51:11 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:51:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/target.common.tests.zip 08:51:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:51:11 INFO - Fetch https://queue.taskcluster.net/v1/task/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/target.common.tests.zip into memory 08:51:13 INFO - Content-Length response header: 65720035 08:51:13 INFO - Bytes received: 65720035 08:51:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/target.talos.tests.zip 08:51:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:51:28 INFO - Fetch https://queue.taskcluster.net/v1/task/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/target.talos.tests.zip into memory 08:51:29 INFO - Content-Length response header: 14411888 08:51:29 INFO - Bytes received: 14411888 08:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:29 INFO - trying https://queue.taskcluster.net/v1/task/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/target.tar.bz2 08:51:29 INFO - Downloading https://queue.taskcluster.net/v1/task/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:51:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:51:30 INFO - Downloaded 59607304 bytes. 08:51:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/target.tar.bz2 08:51:30 INFO - mkdir: /builds/slave/test/properties 08:51:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:51:30 INFO - Writing to file /builds/slave/test/properties/build_url 08:51:30 INFO - Contents: 08:51:30 INFO - build_url:https://queue.taskcluster.net/v1/task/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/target.tar.bz2 08:51:30 INFO - Running post-action listener: _resource_record_post_action 08:51:30 INFO - Running post-action listener: set_extra_try_arguments 08:51:30 INFO - [mozharness: 2017-05-26 15:51:30.712632Z] Finished download-and-extract step (success) 08:51:30 INFO - [mozharness: 2017-05-26 15:51:30.712744Z] Running populate-webroot step. 08:51:30 INFO - Running pre-action listener: _resource_record_pre_action 08:51:30 INFO - Running main action method: populate_webroot 08:51:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:51:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:51:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:51:30 INFO - '--tppagecycles', 08:51:30 INFO - '7'], 08:51:30 INFO - 'tests': ['tsvgm']}}, 08:51:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:51:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:51:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:51:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:51:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:51:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:51:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:51:30 INFO - 'talos_options': ['--disable-e10s'], 08:51:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:51:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:51:30 INFO - 'talos_options': ['--disable-e10s'], 08:51:30 INFO - 'tests': ['damp', 'tps']}, 08:51:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:51:30 INFO - 'tests': ['damp', 'tps']}, 08:51:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:51:30 INFO - 'tests': ['dromaeo_dom']}, 08:51:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:51:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:51:30 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:51:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:51:30 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:51:30 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:51:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:51:30 INFO - 'tests': ['a11yr', 08:51:30 INFO - 'ts_paint', 08:51:30 INFO - 'tpaint', 08:51:30 INFO - 'sessionrestore', 08:51:30 INFO - 'sessionrestore_no_auto_restore', 08:51:30 INFO - 'tabpaint']}, 08:51:30 INFO - 'other-e10s': {'tests': ['a11yr', 08:51:30 INFO - 'ts_paint', 08:51:30 INFO - 'tpaint', 08:51:30 INFO - 'sessionrestore', 08:51:30 INFO - 'sessionrestore_no_auto_restore', 08:51:30 INFO - 'tabpaint']}, 08:51:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:51:30 INFO - 'ts_paint', 08:51:30 INFO - 'tpaint', 08:51:30 INFO - 'sessionrestore', 08:51:30 INFO - 'sessionrestore_no_auto_restore', 08:51:30 INFO - 'tabpaint']}, 08:51:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:51:30 INFO - 'ts_paint', 08:51:30 INFO - 'tpaint', 08:51:30 INFO - 'sessionrestore', 08:51:30 INFO - 'sessionrestore_no_auto_restore', 08:51:30 INFO - 'tabpaint']}, 08:51:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:51:30 INFO - 'tests': ['a11yr', 08:51:30 INFO - 'ts_paint', 08:51:30 INFO - 'tpaint', 08:51:30 INFO - 'sessionrestore', 08:51:30 INFO - 'sessionrestore_no_auto_restore', 08:51:30 INFO - 'tabpaint']}, 08:51:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:51:30 INFO - 'tests': ['a11yr', 08:51:30 INFO - 'ts_paint', 08:51:30 INFO - 'tpaint', 08:51:30 INFO - 'sessionrestore', 08:51:30 INFO - 'sessionrestore_no_auto_restore', 08:51:30 INFO - 'tabpaint']}, 08:51:30 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:51:30 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:51:30 INFO - 'bloom_basic_ref']}, 08:51:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:51:30 INFO - 'tests': ['tsvgx', 08:51:30 INFO - 'tsvgr_opacity', 08:51:30 INFO - 'tart', 08:51:30 INFO - 'tscrollx', 08:51:30 INFO - 'cart', 08:51:30 INFO - 'tsvg_static']}, 08:51:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:51:30 INFO - 'tsvgr_opacity', 08:51:30 INFO - 'tart', 08:51:30 INFO - 'tscrollx', 08:51:30 INFO - 'cart', 08:51:30 INFO - 'tsvg_static']}, 08:51:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:51:30 INFO - 'talos_options': ['--disable-e10s'], 08:51:30 INFO - 'tests': ['tp5o']}, 08:51:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:51:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:51:30 INFO - 'talos_options': ['--disable-e10s', 08:51:30 INFO - '--xperf_path', 08:51:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:51:30 INFO - 'tests': ['tp5n']}, 08:51:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:51:30 INFO - 'talos_options': ['--xperf_path', 08:51:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:51:30 INFO - 'tests': ['tp5n']}}, 08:51:30 INFO - 'talos.zip': {'path': '', 08:51:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:51:30 INFO - Running post-action listener: _resource_record_post_action 08:51:30 INFO - [mozharness: 2017-05-26 15:51:30.728499Z] Finished populate-webroot step (success) 08:51:30 INFO - [mozharness: 2017-05-26 15:51:30.728588Z] Running create-virtualenv step. 08:51:30 INFO - Running pre-action listener: _resource_record_pre_action 08:51:30 INFO - Running main action method: create_virtualenv 08:51:30 INFO - Creating virtualenv /builds/slave/test/build/venv 08:51:30 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 08:51:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:51:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:51:30 INFO - Using real prefix '/usr' 08:51:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:51:31 INFO - Installing distribute.............................................................................................................................................................................................done. 08:51:33 INFO - Installing pip.................done. 08:51:33 INFO - Return code: 0 08:51:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:51:33 INFO - Reading from file tmpfile_stdout 08:51:33 INFO - Output received: 08:51:33 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) 08:51:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:33 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 0xb151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe885c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe857a0>, '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 0xe866a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe86b30>, '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': '7de08804244eb36560b44971000001c3-1495813244.483694-797584003', '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 08:51:33 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 08:51:33 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 08:51:33 INFO - Using env: {'DISPLAY': ':0', 08:51:33 INFO - 'HOME': '/home/cltbld', 08:51:33 INFO - 'LANG': 'en_US.UTF-8', 08:51:33 INFO - 'LANGUAGE': 'en_US:en', 08:51:33 INFO - 'LOGNAME': 'cltbld', 08:51:33 INFO - 'MAIL': '/var/mail/cltbld', 08:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:33 INFO - 'MOZ_NO_REMOTE': '1', 08:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:33 INFO - 'NO_EM_RESTART': '1', 08:51:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:33 INFO - 'PWD': '/builds/slave/test', 08:51:33 INFO - 'SHELL': '/bin/bash', 08:51:33 INFO - 'SHLVL': '1', 08:51:33 INFO - 'TERM': 'linux', 08:51:33 INFO - 'TMOUT': '86400', 08:51:33 INFO - 'USER': 'cltbld', 08:51:33 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1495813244.483694-797584003', 08:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:33 INFO - '_': '/tools/buildbot/bin/python'} 08:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:33 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 08:51:33 INFO - Cleaning up... 08:51:33 INFO - Return code: 0 08:51:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:33 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 0xb151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe885c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe857a0>, '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 0xe866a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe86b30>, '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': '7de08804244eb36560b44971000001c3-1495813244.483694-797584003', '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 08:51:33 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 08:51:33 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 08:51:33 INFO - Using env: {'DISPLAY': ':0', 08:51:33 INFO - 'HOME': '/home/cltbld', 08:51:33 INFO - 'LANG': 'en_US.UTF-8', 08:51:33 INFO - 'LANGUAGE': 'en_US:en', 08:51:33 INFO - 'LOGNAME': 'cltbld', 08:51:33 INFO - 'MAIL': '/var/mail/cltbld', 08:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:33 INFO - 'MOZ_NO_REMOTE': '1', 08:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:33 INFO - 'NO_EM_RESTART': '1', 08:51:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:33 INFO - 'PWD': '/builds/slave/test', 08:51:33 INFO - 'SHELL': '/bin/bash', 08:51:33 INFO - 'SHLVL': '1', 08:51:33 INFO - 'TERM': 'linux', 08:51:33 INFO - 'TMOUT': '86400', 08:51:33 INFO - 'USER': 'cltbld', 08:51:33 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1495813244.483694-797584003', 08:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:33 INFO - '_': '/tools/buildbot/bin/python'} 08:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:33 INFO - Downloading/unpacking psutil>=3.1.1 08:51: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 08:51: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 08:51: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 08:51: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 08:51:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:51:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:35 INFO - Installing collected packages: psutil 08:51:35 INFO - Running setup.py install for psutil 08:51:35 INFO - building 'psutil._psutil_linux' extension 08:51:35 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 08:51:35 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 08:51:35 INFO - building 'psutil._psutil_posix' extension 08:51:35 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 08:51:35 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 08:51:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:35 INFO - Successfully installed psutil 08:51:35 INFO - Cleaning up... 08:51:35 INFO - Return code: 0 08:51:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe885c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe857a0>, '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 0xe866a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe86b30>, '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': '7de08804244eb36560b44971000001c3-1495813244.483694-797584003', '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 08:51:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:51:35 INFO - Using env: {'DISPLAY': ':0', 08:51:35 INFO - 'HOME': '/home/cltbld', 08:51:35 INFO - 'LANG': 'en_US.UTF-8', 08:51:35 INFO - 'LANGUAGE': 'en_US:en', 08:51:35 INFO - 'LOGNAME': 'cltbld', 08:51:35 INFO - 'MAIL': '/var/mail/cltbld', 08:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:35 INFO - 'MOZ_NO_REMOTE': '1', 08:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:35 INFO - 'NO_EM_RESTART': '1', 08:51:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:35 INFO - 'PWD': '/builds/slave/test', 08:51:35 INFO - 'SHELL': '/bin/bash', 08:51:35 INFO - 'SHLVL': '1', 08:51:35 INFO - 'TERM': 'linux', 08:51:35 INFO - 'TMOUT': '86400', 08:51:35 INFO - 'USER': 'cltbld', 08:51:35 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1495813244.483694-797584003', 08:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:35 INFO - '_': '/tools/buildbot/bin/python'} 08:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:51:37 INFO - Installing collected packages: mozsystemmonitor 08:51:37 INFO - Running setup.py install for mozsystemmonitor 08:51:37 INFO - Successfully installed mozsystemmonitor 08:51:37 INFO - Cleaning up... 08:51:37 INFO - Return code: 0 08:51:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:51:37 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')]} 08:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:37 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')]} 08:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:37 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 0xb151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe885c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe857a0>, '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 0xe866a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe86b30>, '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': '7de08804244eb36560b44971000001c3-1495813244.483694-797584003', '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 08:51:37 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 08:51:37 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 08:51:37 INFO - Using env: {'DISPLAY': ':0', 08:51:37 INFO - 'HOME': '/home/cltbld', 08:51:37 INFO - 'LANG': 'en_US.UTF-8', 08:51:37 INFO - 'LANGUAGE': 'en_US:en', 08:51:37 INFO - 'LOGNAME': 'cltbld', 08:51:37 INFO - 'MAIL': '/var/mail/cltbld', 08:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:37 INFO - 'MOZ_NO_REMOTE': '1', 08:51:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:37 INFO - 'NO_EM_RESTART': '1', 08:51:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:37 INFO - 'PWD': '/builds/slave/test', 08:51:37 INFO - 'SHELL': '/bin/bash', 08:51:37 INFO - 'SHLVL': '1', 08:51:37 INFO - 'TERM': 'linux', 08:51:37 INFO - 'TMOUT': '86400', 08:51:37 INFO - 'USER': 'cltbld', 08:51:37 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1495813244.483694-797584003', 08:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:37 INFO - '_': '/tools/buildbot/bin/python'} 08:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:37 INFO - Downloading/unpacking jsonschema==2.5.1 08:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:51:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:51:38 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 08:51:38 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 08:51:38 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 08:51:38 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 08:51:38 INFO - Downloading functools32-3.2.3-2.tar.gz 08:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:51:38 INFO - warning: no files found matching '*.txt' 08:51:38 INFO - no previously-included directories found matching 'build' 08:51:38 INFO - no previously-included directories found matching 'dist' 08:51:38 INFO - no previously-included directories found matching '.git*' 08:51:38 INFO - Installing collected packages: jsonschema, functools32 08:51:38 INFO - Running setup.py install for functools32 08:51:38 INFO - warning: no files found matching '*.txt' 08:51:38 INFO - no previously-included directories found matching 'build' 08:51:38 INFO - no previously-included directories found matching 'dist' 08:51:38 INFO - no previously-included directories found matching '.git*' 08:51:38 INFO - Successfully installed jsonschema functools32 08:51:38 INFO - Cleaning up... 08:51:38 INFO - Return code: 0 08:51:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:51: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')]} 08:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51: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')]} 08:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:38 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 0xb151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe885c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe857a0>, '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 0xe866a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe86b30>, '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': '7de08804244eb36560b44971000001c3-1495813244.483694-797584003', '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 08:51:38 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 08:51:38 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 08:51:38 INFO - Using env: {'DISPLAY': ':0', 08:51:38 INFO - 'HOME': '/home/cltbld', 08:51:38 INFO - 'LANG': 'en_US.UTF-8', 08:51:38 INFO - 'LANGUAGE': 'en_US:en', 08:51:38 INFO - 'LOGNAME': 'cltbld', 08:51:38 INFO - 'MAIL': '/var/mail/cltbld', 08:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:38 INFO - 'MOZ_NO_REMOTE': '1', 08:51:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:38 INFO - 'NO_EM_RESTART': '1', 08:51:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:38 INFO - 'PWD': '/builds/slave/test', 08:51:38 INFO - 'SHELL': '/bin/bash', 08:51:38 INFO - 'SHLVL': '1', 08:51:38 INFO - 'TERM': 'linux', 08:51:38 INFO - 'TMOUT': '86400', 08:51:38 INFO - 'USER': 'cltbld', 08:51:38 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1495813244.483694-797584003', 08:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:38 INFO - '_': '/tools/buildbot/bin/python'} 08:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:51:39 INFO - Cleaning up... 08:51:39 INFO - Return code: 0 08:51:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe885c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe857a0>, '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 0xe866a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe86b30>, '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': '7de08804244eb36560b44971000001c3-1495813244.483694-797584003', '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 08:51:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:51:39 INFO - Using env: {'DISPLAY': ':0', 08:51:39 INFO - 'HOME': '/home/cltbld', 08:51:39 INFO - 'LANG': 'en_US.UTF-8', 08:51:39 INFO - 'LANGUAGE': 'en_US:en', 08:51:39 INFO - 'LOGNAME': 'cltbld', 08:51:39 INFO - 'MAIL': '/var/mail/cltbld', 08:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:39 INFO - 'MOZ_NO_REMOTE': '1', 08:51:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:39 INFO - 'NO_EM_RESTART': '1', 08:51:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:39 INFO - 'PWD': '/builds/slave/test', 08:51:39 INFO - 'SHELL': '/bin/bash', 08:51:39 INFO - 'SHLVL': '1', 08:51:39 INFO - 'TERM': 'linux', 08:51:39 INFO - 'TMOUT': '86400', 08:51:39 INFO - 'USER': 'cltbld', 08:51:39 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1495813244.483694-797584003', 08:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:39 INFO - '_': '/tools/buildbot/bin/python'} 08:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:39 INFO - Downloading/unpacking blobuploader==1.2.4 08:51: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 08:51: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 08:51: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 08:51: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 08:51:40 INFO - Downloading blobuploader-1.2.4.tar.gz 08:51:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:51:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:51:40 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 08:51:40 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 08:51:40 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 08:51:40 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 08:51:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:51:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:51:40 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 08:51:40 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 08:51:40 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 08:51:40 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 08:51:40 INFO - Downloading docopt-0.6.1.tar.gz 08:51:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:51:40 INFO - Installing collected packages: blobuploader, requests, docopt 08:51:40 INFO - Running setup.py install for blobuploader 08:51:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:51:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:51:41 INFO - Running setup.py install for requests 08:51:41 INFO - Running setup.py install for docopt 08:51:41 INFO - Successfully installed blobuploader requests docopt 08:51:41 INFO - Cleaning up... 08:51:41 INFO - Return code: 0 08:51:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51: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')]} 08:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51: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')]} 08:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:41 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 0xb151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe885c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe857a0>, '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 0xe866a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe86b30>, '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': '7de08804244eb36560b44971000001c3-1495813244.483694-797584003', '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 08:51:41 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 08:51:41 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 08:51:41 INFO - Using env: {'DISPLAY': ':0', 08:51:41 INFO - 'HOME': '/home/cltbld', 08:51:41 INFO - 'LANG': 'en_US.UTF-8', 08:51:41 INFO - 'LANGUAGE': 'en_US:en', 08:51:41 INFO - 'LOGNAME': 'cltbld', 08:51:41 INFO - 'MAIL': '/var/mail/cltbld', 08:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:41 INFO - 'MOZ_NO_REMOTE': '1', 08:51:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:41 INFO - 'NO_EM_RESTART': '1', 08:51:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:41 INFO - 'PWD': '/builds/slave/test', 08:51:41 INFO - 'SHELL': '/bin/bash', 08:51:41 INFO - 'SHLVL': '1', 08:51:41 INFO - 'TERM': 'linux', 08:51:41 INFO - 'TMOUT': '86400', 08:51:41 INFO - 'USER': 'cltbld', 08:51:41 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1495813244.483694-797584003', 08:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:41 INFO - '_': '/tools/buildbot/bin/python'} 08:51:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:51:41 INFO - Running setup.py (path:/tmp/pip-JWccvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:51:41 INFO - Running setup.py (path:/tmp/pip-2tJ4X5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:51:41 INFO - Running setup.py (path:/tmp/pip-heqgIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:51:41 INFO - Running setup.py (path:/tmp/pip-Zb50Wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:51:42 INFO - Running setup.py (path:/tmp/pip-hIL3rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:51:42 INFO - Running setup.py (path:/tmp/pip-ESDUS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:51:42 INFO - Running setup.py (path:/tmp/pip-5B0cD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:51:42 INFO - Running setup.py (path:/tmp/pip-wQJ8fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:51:42 INFO - Running setup.py (path:/tmp/pip-Aj6RA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:51:42 INFO - Running setup.py (path:/tmp/pip-wEd9be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:51:42 INFO - Running setup.py (path:/tmp/pip-CGLU3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:51:42 INFO - Running setup.py (path:/tmp/pip-OuqgGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:51:42 INFO - Running setup.py (path:/tmp/pip-nvRCte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:51:42 INFO - Running setup.py (path:/tmp/pip-JE9BDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:42 INFO - Running setup.py (path:/tmp/pip-e2tVN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:51:42 INFO - Running setup.py (path:/tmp/pip-HYKk8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:51:42 INFO - Running setup.py (path:/tmp/pip-n45WVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:51:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:51:42 INFO - Running setup.py install for manifestparser 08:51:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:51:43 INFO - Running setup.py install for mozcrash 08:51:43 INFO - Running setup.py install for mozdebug 08:51:43 INFO - Running setup.py install for mozdevice 08:51:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:51:43 INFO - Running setup.py install for mozfile 08:51:43 INFO - Running setup.py install for mozhttpd 08:51:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:51:43 INFO - Running setup.py install for mozinfo 08:51:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:51:43 INFO - Running setup.py install for mozInstall 08:51:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:51:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:51:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:51:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:51:43 INFO - Running setup.py install for mozleak 08:51:43 INFO - Running setup.py install for mozlog 08:51:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:51:43 INFO - Running setup.py install for moznetwork 08:51:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:51:44 INFO - Running setup.py install for mozprocess 08:51:44 INFO - Running setup.py install for mozprofile 08:51:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:51:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:51:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:51:44 INFO - Running setup.py install for mozrunner 08:51:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:51:44 INFO - Running setup.py install for mozscreenshot 08:51:44 INFO - Running setup.py install for moztest 08:51:44 INFO - Running setup.py install for mozversion 08:51:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:51:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:51:44 INFO - Cleaning up... 08:51:44 INFO - Return code: 0 08:51:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:44 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 0xb151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe885c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe857a0>, '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 0xe866a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe86b30>, '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': '7de08804244eb36560b44971000001c3-1495813244.483694-797584003', '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 08:51:44 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 08:51:44 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 08:51:44 INFO - Using env: {'DISPLAY': ':0', 08:51:44 INFO - 'HOME': '/home/cltbld', 08:51:44 INFO - 'LANG': 'en_US.UTF-8', 08:51:44 INFO - 'LANGUAGE': 'en_US:en', 08:51:44 INFO - 'LOGNAME': 'cltbld', 08:51:44 INFO - 'MAIL': '/var/mail/cltbld', 08:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:44 INFO - 'MOZ_NO_REMOTE': '1', 08:51:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:44 INFO - 'NO_EM_RESTART': '1', 08:51:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:44 INFO - 'PWD': '/builds/slave/test', 08:51:44 INFO - 'SHELL': '/bin/bash', 08:51:44 INFO - 'SHLVL': '1', 08:51:44 INFO - 'TERM': 'linux', 08:51:44 INFO - 'TMOUT': '86400', 08:51:44 INFO - 'USER': 'cltbld', 08:51:44 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1495813244.483694-797584003', 08:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:44 INFO - '_': '/tools/buildbot/bin/python'} 08:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:51:44 INFO - Running setup.py (path:/tmp/pip-0B0iD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:51:45 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)) 08:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:51:45 INFO - Running setup.py (path:/tmp/pip-ORyvEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:51:45 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)) 08:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:51:45 INFO - Running setup.py (path:/tmp/pip-jI3Sgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:51:45 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)) 08:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:51:45 INFO - Running setup.py (path:/tmp/pip-zCf3OF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 08:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:51:45 INFO - Running setup.py (path:/tmp/pip-o7_MV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:51:45 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)) 08:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:51:45 INFO - Running setup.py (path:/tmp/pip-MEHTfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:51:45 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)) 08:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:51:45 INFO - Running setup.py (path:/tmp/pip-TyZDHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:51:45 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)) 08:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:51:45 INFO - Running setup.py (path:/tmp/pip-5T6FGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:51:45 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)) 08:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:51:45 INFO - Running setup.py (path:/tmp/pip-Kv06YU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:51:45 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)) 08:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:51:45 INFO - Running setup.py (path:/tmp/pip-_5xJ4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:51:45 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)) 08:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:51:45 INFO - Running setup.py (path:/tmp/pip-2oqe7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:51:45 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)) 08:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:51:45 INFO - Running setup.py (path:/tmp/pip-lByoCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:51:45 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)) 08:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:51:45 INFO - Running setup.py (path:/tmp/pip-xrbofQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:51:45 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)) 08:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:51:45 INFO - Running setup.py (path:/tmp/pip-7zQ43k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:51:45 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)) 08:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:45 INFO - Running setup.py (path:/tmp/pip-EQKlvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:46 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)) 08:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:51:46 INFO - Running setup.py (path:/tmp/pip-H_15xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:51:46 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)) 08:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:51:46 INFO - Running setup.py (path:/tmp/pip-q6IlXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:51:46 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)) 08:51:46 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)) 08:51:46 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)) 08:51:46 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)) 08:51:46 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:51:46 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:51:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:51:46 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 08:51:46 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 08:51:46 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 08:51:46 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 08:51:47 INFO - Downloading blessings-1.6.tar.gz 08:51:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:51:47 INFO - Installing collected packages: blessings 08:51:47 INFO - Running setup.py install for blessings 08:51:47 INFO - Successfully installed blessings 08:51:47 INFO - Cleaning up... 08:51:47 INFO - Return code: 0 08:51:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:51:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:51:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:51:47 INFO - Reading from file tmpfile_stdout 08:51:47 INFO - Current package versions: 08:51:47 INFO - argparse == 1.2.1 08:51:47 INFO - blessings == 1.6 08:51:47 INFO - blobuploader == 1.2.4 08:51:47 INFO - docopt == 0.6.1 08:51:47 INFO - functools32 == 3.2.3-2 08:51:47 INFO - jsonschema == 2.5.1 08:51:47 INFO - manifestparser == 1.1 08:51:47 INFO - mozInstall == 1.12 08:51:47 INFO - mozcrash == 1.0 08:51:47 INFO - mozdebug == 0.1 08:51:47 INFO - mozdevice == 0.51 08:51:47 INFO - mozfile == 1.2 08:51:47 INFO - mozhttpd == 0.7 08:51:47 INFO - mozinfo == 0.9 08:51:47 INFO - mozleak == 0.1 08:51:47 INFO - mozlog == 3.4 08:51:47 INFO - moznetwork == 0.27 08:51:47 INFO - mozprocess == 0.25 08:51:47 INFO - mozprofile == 0.28 08:51:47 INFO - mozrunner == 6.13 08:51:47 INFO - mozscreenshot == 0.1 08:51:47 INFO - mozsystemmonitor == 0.3 08:51:47 INFO - moztest == 0.8 08:51:47 INFO - mozversion == 1.4 08:51:47 INFO - psutil == 3.1.1 08:51:47 INFO - requests == 1.2.3 08:51:47 INFO - wsgiref == 0.1.2 08:51:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:47 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')]} 08:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:47 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')]} 08:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:47 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 0xb151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe885c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe857a0>, '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 0xe866a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe86b30>, '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': '7de08804244eb36560b44971000001c3-1495813244.483694-797584003', '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 08:51:47 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 08:51:47 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 08:51:47 INFO - Using env: {'DISPLAY': ':0', 08:51:47 INFO - 'HOME': '/home/cltbld', 08:51:47 INFO - 'LANG': 'en_US.UTF-8', 08:51:47 INFO - 'LANGUAGE': 'en_US:en', 08:51:47 INFO - 'LOGNAME': 'cltbld', 08:51:47 INFO - 'MAIL': '/var/mail/cltbld', 08:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:47 INFO - 'MOZ_NO_REMOTE': '1', 08:51:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:47 INFO - 'NO_EM_RESTART': '1', 08:51:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:47 INFO - 'PWD': '/builds/slave/test', 08:51:47 INFO - 'SHELL': '/bin/bash', 08:51:47 INFO - 'SHLVL': '1', 08:51:47 INFO - 'TERM': 'linux', 08:51:47 INFO - 'TMOUT': '86400', 08:51:47 INFO - 'USER': 'cltbld', 08:51:47 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1495813244.483694-797584003', 08:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:47 INFO - '_': '/tools/buildbot/bin/python'} 08:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:47 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)) 08:51:47 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)) 08:51:47 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)) 08:51:47 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)) 08:51:47 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)) 08:51:47 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)) 08:51:47 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)) 08:51:47 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)) 08:51:47 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)) 08:51:47 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:51:47 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 08:51:47 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 08:51:47 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 08:51:47 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 08:51:49 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:51:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:51:49 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)) 08:51:49 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)) 08:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:51:49 INFO - Installing collected packages: marionette-driver 08:51:49 INFO - Running setup.py install for marionette-driver 08:51:49 INFO - Successfully installed marionette-driver 08:51:49 INFO - Cleaning up... 08:51:49 INFO - Return code: 0 08:51:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:51:49 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')]} 08:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:49 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')]} 08:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:49 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 0xb151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe885c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe857a0>, '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 0xe866a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe86b30>, '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': '7de08804244eb36560b44971000001c3-1495813244.483694-797584003', '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 08:51:49 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 08:51:49 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 08:51:49 INFO - Using env: {'DISPLAY': ':0', 08:51:49 INFO - 'HOME': '/home/cltbld', 08:51:49 INFO - 'LANG': 'en_US.UTF-8', 08:51:49 INFO - 'LANGUAGE': 'en_US:en', 08:51:49 INFO - 'LOGNAME': 'cltbld', 08:51:49 INFO - 'MAIL': '/var/mail/cltbld', 08:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:49 INFO - 'MOZ_NO_REMOTE': '1', 08:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:49 INFO - 'NO_EM_RESTART': '1', 08:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:49 INFO - 'PWD': '/builds/slave/test', 08:51:49 INFO - 'SHELL': '/bin/bash', 08:51:49 INFO - 'SHLVL': '1', 08:51:49 INFO - 'TERM': 'linux', 08:51:49 INFO - 'TMOUT': '86400', 08:51:49 INFO - 'USER': 'cltbld', 08:51:49 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1495813244.483694-797584003', 08:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:49 INFO - '_': '/tools/buildbot/bin/python'} 08:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:51:49 INFO - Cleaning up... 08:51:49 INFO - Return code: 0 08:51:49 INFO - Running post-action listener: _resource_record_post_action 08:51:49 INFO - Running post-action listener: _start_resource_monitoring 08:51:49 INFO - Starting resource monitoring. 08:51:49 INFO - [mozharness: 2017-05-26 15:51:49.503862Z] Finished create-virtualenv step (success) 08:51:49 INFO - [mozharness: 2017-05-26 15:51:49.504367Z] Running install step. 08:51:49 INFO - Running pre-action listener: _resource_record_pre_action 08:51:49 INFO - Running main action method: install 08:51:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:51:49 INFO - Reading from file tmpfile_stdout 08:51:49 INFO - Detecting whether we're running mozinstall >=1.0... 08:51:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:51:49 INFO - Reading from file tmpfile_stdout 08:51:49 INFO - Output received: 08:51:49 INFO - Usage: mozinstall [options] installer 08:51:49 INFO - Options: 08:51:49 INFO - -h, --help show this help message and exit 08:51:49 INFO - -d DEST, --destination=DEST 08:51:49 INFO - Directory to install application into. [default: 08:51:49 INFO - "/builds/slave/test"] 08:51:49 INFO - --app=APP Application being installed. [default: firefox] 08:51:49 INFO - mkdir: /builds/slave/test/build/application 08:51:49 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'] 08:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:52:06 INFO - Reading from file tmpfile_stdout 08:52:06 INFO - Output received: 08:52:06 INFO - /builds/slave/test/build/application/firefox/firefox 08:52:06 INFO - Running post-action listener: _resource_record_post_action 08:52:06 INFO - [mozharness: 2017-05-26 15:52:06.609518Z] Finished install step (success) 08:52:06 INFO - [mozharness: 2017-05-26 15:52:06.609794Z] Running run-tests step. 08:52:06 INFO - Running pre-action listener: _resource_record_pre_action 08:52:06 INFO - Running main action method: run_tests 08:52:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:52:06 INFO - Python 2.7.3 08:52:06 INFO - Return code: 0 08:52:06 INFO - grabbing minidump binary from tooltool 08:52:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:06 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 0xe857a0>, '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 0xe866a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe86b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:52:06 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 08:52:06 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 08:52:06 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 08:52:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:52:06 INFO - Return code: 0 08:52:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:52:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:52:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:52:06 INFO - ENV: RUST_BACKTRACE is now 1 08:52:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:52:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:52:06 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/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 08:52:06 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/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 08:52:06 INFO - Using env: {'DISPLAY': ':0', 08:52:06 INFO - 'HOME': '/home/cltbld', 08:52:06 INFO - 'LANG': 'en_US.UTF-8', 08:52:06 INFO - 'LANGUAGE': 'en_US:en', 08:52:06 INFO - 'LOGNAME': 'cltbld', 08:52:06 INFO - 'MAIL': '/var/mail/cltbld', 08:52:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:52:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:06 INFO - 'MOZ_NO_REMOTE': '1', 08:52:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:52:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:06 INFO - 'NO_EM_RESTART': '1', 08:52:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:06 INFO - 'PWD': '/builds/slave/test', 08:52:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:52:06 INFO - 'RUST_BACKTRACE': '1', 08:52:06 INFO - 'SHELL': '/bin/bash', 08:52:06 INFO - 'SHLVL': '1', 08:52:06 INFO - 'TERM': 'linux', 08:52:06 INFO - 'TMOUT': '86400', 08:52:06 INFO - 'USER': 'cltbld', 08:52:06 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1495813244.483694-797584003', 08:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:06 INFO - '_': '/tools/buildbot/bin/python'} 08:52:06 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/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 08:52:06 INFO - mozversion application_buildid: 20170526150217 08:52:06 INFO - mozversion application_changeset: 9104506c0a5eaac89b6c22c804c83ccee7d6e662 08:52:06 INFO - mozversion application_display_name: Nightly 08:52:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:52:06 INFO - mozversion application_name: Firefox 08:52:06 INFO - mozversion application_remotingname: firefox 08:52:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:52:06 INFO - mozversion application_vendor: Mozilla 08:52:06 INFO - mozversion application_version: 55.0a1 08:52:06 INFO - mozversion platform_buildid: 20170526150217 08:52:06 INFO - mozversion platform_changeset: 9104506c0a5eaac89b6c22c804c83ccee7d6e662 08:52:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:52:06 INFO - mozversion platform_version: 55.0a1 08:52:06 INFO - using testdate: 1495813926 08:52:06 INFO - actual date: 1495813926 08:52:06 INFO - starting webserver on 'localhost:60997' 08:52:06 INFO - SUITE-START | Running 2 tests 08:52:06 INFO - TEST-START | dromaeo_css 08:52:06 INFO - operating with platform_type : linux_ 08:52:06 INFO - Initialising browser for dromaeo_css test... 08:52:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60997/getInfo.html -profile /tmp/tmpkmy86R/profile 08:52:06 INFO - TEST-INFO | started process 4179 (/builds/slave/test/build/application/firefox/firefox http://localhost:60997/getInfo.html) 08:52:41 INFO - TEST-INFO | 4179: killed by SIGTERM 08:52:41 INFO - Browser initialized. 08:52:41 INFO - Running cycle 1/1 for dromaeo_css test... 08:52:41 INFO - TEST-INFO | started process 4380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkmy86R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:52:53 INFO - PID 4380 | RSS: Main: 165715968 08:52:53 INFO - PID 4380 | 08:55:53 INFO - PID 4380 | Cycle 1(1): loaded http://localhost:60997/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60997/tests/dromaeo/cssquery-ext.html) 08:55:54 INFO - PID 4380 | RSS: Main: 166580224 08:55:54 INFO - PID 4380 | 08:58:56 INFO - PID 4380 | Cycle 1(1): loaded http://localhost:60997/tests/dromaeo/cssquery-ext.html (next: http://localhost:60997/tests/dromaeo/cssquery-jquery.html) 08:58:57 INFO - PID 4380 | RSS: Main: 170250240 08:58:57 INFO - PID 4380 | 09:01:58 INFO - PID 4380 | Cycle 1(1): loaded http://localhost:60997/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60997/tests/dromaeo/cssquery-mootools.html) 09:01:59 INFO - PID 4380 | RSS: Main: 170717184 09:01:59 INFO - PID 4380 | 09:05:00 INFO - PID 4380 | Cycle 1(1): loaded http://localhost:60997/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60997/tests/dromaeo/cssquery-prototype.html) 09:05:01 INFO - PID 4380 | RSS: Main: 172593152 09:05:01 INFO - PID 4380 | 09:08:03 INFO - PID 4380 | Cycle 1(1): loaded http://localhost:60997/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60997/tests/dromaeo/cssquery-yui.html) 09:08:04 INFO - PID 4380 | RSS: Main: 173748224 09:08:04 INFO - PID 4380 | 09:11:06 INFO - PID 4380 | Cycle 1(1): loaded http://localhost:60997/tests/dromaeo/cssquery-yui.html (next: http://localhost:60997/tests/dromaeo/cssquery-dojo.html) 09:11:06 INFO - PID 4380 | RSS: Main: 171507712 09:11:06 INFO - PID 4380 | 09:11:06 INFO - PID 4380 | __start_tp_report 09:11:06 INFO - PID 4380 | _x_x_mozilla_page_load 09:11:06 INFO - PID 4380 | _x_x_mozilla_page_load_details 09:11:06 INFO - PID 4380 | |i|pagename|runs| 09:11:06 INFO - PID 4380 | |0;dojo.html;3365.377405180042;3383.1034775784406;3410.727141828654;3414.3683418567566;3418.880339188129;5827.912581311273;5876.236089308394;5938.0499120140785;5951.345352011281;5955.196048533447;5910.674912879801;5918.230630018092;5966.37353077926;5995.700214989255;6039.607425517338;5166.948330516703;5246.68519888806;5274;5299.761510732026;5316.574674026068;5333.466653334674;5361.142217245241;5381.757820898049;5391.595630327722;5400.675959442446;5249.265102885599;5277.683338999673;5280.1815718563685;5319.707416092094;5363.141897296453;5267.710275934822;5280.049591073605;5280.339957505312;5283.920741188886;5335.919961200585;5216.3218781558535;5262.368515778093;5266.499682530153;5267.262583238311;5300.125479295912;5818.505427038707;5873.559483038789;5884;5906.173135760997;5909.940900590982;6404.4876409887565;6406.327335629739;6422.614643121427;6434.967825160891;6443.581167224115;6478.190226221723;6478.643674597895;6481.189851268591;6486.837829054311;6497.48020158391;5836.066229403275;5872.383399743051;5985.132155837423;6000.159977603183;6005.3394126646035;6401.135846660734;6430.485561155097;6528.412442880163;6535.248446428626;6563.474922006228;6069.514438844882;6152.415520525632;6236.750529978841;6256.436920677161;6273.404026617464;6408.198975128109;6416.550841441054;6416.679166041679;6441.323661015525;6443.420092191632;6200;6363.681815909279;6382.361763823674;6391.105245265667;6397.264314603787;6265.592736472115;6321.810345689637;6341.746330146742;6395.168628078413;6399.616023038632;4897.926531101965;4920.138975679241;4927.310176575283;4927.827526036644;4949.430815456197;4363.323684828857;4366.890827729332;4373.715708478939;4388.100439409914;4406.823727050882;5954.851128721816;6024.668643224577;6033.5474839387225;6110.29731580865;6126.785562505291;6326.620402775849;6338.778142764981;6359.904601430982;6369.936300637027;6390.744370225232;5976.701164941735;5982.641041537521;5983.910241346383;5996;6049.153118563405;5335.306410166653;5385.3268341457315;5388.7305634718105;5391.245225668409;5409.486098820685;6563.835904102436;6586.341365863375;6603.339666033455;6610.603363798187;6639.634820084845;6372.5220608455475;6376.426121649074;6379.393957574023;6383.170187875547;6404.1674582304;6488.156539650005;6558.278589355263;6674.666266686743;6713.798586042427;6715.1941766988275;6127.678242056309;6194.132821405097;6255.9374406257175;6291.842703932438;6293.842653933688;6490.545661803817;6497.252815926229;6497.252815926229;6500.609963402211;6522.315156908646;6106.642687876592;6115.605440958429;6180.7527698891545;6258.374162583706;6296.118543404019;6195.2255968004;6237.345078766664;6239.126522286974;6239.78160764371;6242.188515492957;6043.667598282137;6141.84645383869;6163.537734669828;6177.96911015442;6277.058441233851;6295.716692748746;6328.114064031131;6354.618722876642;6354.968225158845;6357.650329231752;6078.270607526948;6089.786857459968;6090.330063693079;6090.725917333642;6091.695415229132 09:11:06 INFO - PID 4380 | |1;ext.html;764.4419573711191;818.5334359415134;841.5035129273728;1119.0991252042108;1122.2817396866003;37282.62717372825;38079.04802379938;38192.42711359325;38250.426243606365;38274.8086259569;39519.60480395195;39563.60436395635;39565.8021709891;39570.802145989226;39907.60092399075;7096.396806271473;7183.425325973935;7254.600996945166;7257.165425976001;7325.926740732604;7331.523450975669;7438.404927605806;7454.55272683638;7457.813554661123;7460.888086678704;7438.776836694908;7487.475876688634;7492.662830172628;7493.100827900659;7495.812604684899;7440.144383395925;7447.069116360455;7453.254674532557;7483.4013278937555;7496.850062998764;6970.059042029312;7000.544964577337;7037.718491260343;7038.542494737826;7048.378872859271;37974.240515189544;38169.42745858814;38209.61790382089;38360.424593630836;38426.807865960494;3557.964420355789;3599.190182209008;3606.711463082947;3609.7653652512504;3618.656227658368;29301.853490732625;29330.266743331373;29369;29474.705252947624;29666.406671866444;3633.963660363389;3638.6361363863666;3648.233870887117;3651.9634803652157;3654.177809992757;202151;202898;207549;212848;213079;47827.76086119617;47951.76024119927;48018.5198148021;48178;48285.5171448281;49147.10234771779;49160;49160;49304.260436093486;49448.50551494439;15556.377744890078;15580.844191558166;15639.139847308279;15730.9213453932;15775.842241577437;12825.935870320589;12834.80747788784;12839.229646221256;12841;12842.165259258118;14022.719545609234;14143.363548640336;14153.575392738234;14178.574642760734;14432.350544225535;5686.317641882918;5755.942060847093;5791.330469104757;5893.145493903446;5969.1646467927385;1063.6277302944063;1069.7111779819404;1108.107973081677;1108.6895669212633;1110.9277896936674;26376.766702804427;26933;27022.864885675444;27051.458970820473;27148.1855544334;1203.4464146492537;1204.740980689156;1207.076586411396;1207.5833837326109;1243.639344590077;13809.861901381058;13865.23741194244;14059;14233.43066277358;14247;248324;249322;250619.22832700767;250915;252019;53076.46923530792;53298.46701533013;53498.73250633722;53786.731066344415;54001.189982150296;1453.4258967707697;1471.433498103238;1497.5806774103269;1507.201183372814;1524.3521503361249;24177.63733543963;25340.60626665551;25608.61587076158;25664;25798.484030318912;37135.628643713215;37235.81382093072;37290;37340.25319493649;37370.43944340783;204064;205720;206768;207460;207492;33542;37088;37399.25201496009;37410.8129459351;37560;47371;47719.76140119416;48027.279590806866;48601.270980934605;49199.508004919495;35084.473732893515;35309.646903530636;35565.46651800173;35671.82164089163;36077.81961090283;34599;34961.475577865844;36256.29691575602;36660.81669591635;37155.6284437163;41029;42421.41887136515;42634;42819.357709633754;42951.57048429476;34703.65296347004;35050.82474587611;35156.64843351534;35782.64217357897;36065;27041.323966900985;28323.57514637241;28324.43351133007;28437.573436398055;28705.856470717514 09:11:06 INFO - PID 4380 | |2;jquery.html;421.34289791353297;430.35231975876303;432.8333591567248;439.3037036297469;445.86178284731716;20094.6985795213;20716.27493037742;21227.787722122775;21792.128314867387;22081.889590552026;22601.54796904061;22662;22749.886250568765;22818.2013629523;22893.19873804417;5420.268263784388;5625.915611265835;5686.630369026;5693.03218452864;5703.885922281552;5381.139017757159;5545;5590.944090559104;5613.859653508654;5615.017371959891;5605.439456054382;5615.719214039282;5626.549876009909;5632.183333416652;5636.7181640918;5404.216388623667;5569.526590239814;5607.607467477278;5609.915851262234;5615.101583746581;5024.296598476216;5060.544550990392;5062.31658726071;5089.312942752718;5100.0309941111445;24923.252302430956;25432.872835635888;25445.23664290074;25680.229593112235;25784.097556585428;2017.1931227508967;2123.309924274617;2125.72365592472;2136.903839327234;2138.786121387864;16966.23651935666;17197.226124824414;17330.39343622967;17654.205560749797;17780.733289000676;2120.236714782677;2154.2675490333363;2181.19295860531;2232.7767223277706;2234.6871437998693;114808;116475.99999999916;117119;117924;118785;11789.115816313639;11944.581939632071;12021.519139234508;12039.277643341427;12205.084618653636;16405.58986025335;16412.589685257724;16424.507264782074;16426.589335266475;16463.83536164623;8518.148185181431;8719.389642725075;8770.079141690157;8809;8821.558922053871;8154.469959452616;8192;8316.37627177964;8548.230659240699;8587.785305367415;7650.8087297818;7669.616519174019;7774.1837107104075;7900.696385096395;7916.010498687664;2101.873887566751;2114.6299397605358;2153.4616345913523;2193.42970827586;2360.6104992676014;999.3654029691053;1032.4270030133198;1042.3954106618144;1042.5152304178594;1053.6154303679255;19517.73302795033;20484.385468435972;20700.275490357766;20781.480462988548;20879.895600522203;1061.0927656853435;1061.2147011211648;1065.9840102398316;1067.3062509368817;1085.8642669666292;11308.264962777394;11316.660500185008;11397.088232941345;11406.201565890475;11497.195196336175;482633;484630;495432;500795;502093;98443;100772;101503.49248253711;101677;102116;1187.3944288412972;1193.3376975778526;1222;1222.4743360355133;1231.944562494672;16840.15799210059;17309;17806.643867122842;17873.910630446764;18015.2793888243;45818.31272530848;46913.76543117263;48129.99047414787;48983;49490;59910.70044649749;60082;60787.39212607817;60797.39202608094;61089;9066.818663626558;9268.95365523168;9327.626894924128;9508.809823803624;9583.295976410192;15194.696106077596;15221.543353699406;15229.695406091594;15287.235638218268;16026.958247713861;13171.275579842817;13180.934095329461;13249.403776829873;13371.732565348444;13590;12490.687732806753;12718.364081796059;12718.491260349483;12854.421551030413;13107;13635.909127269597;13638.727225455634;13694.65763355924;14060.156390616596;14120.858791411954;9308.208802251613;9456.621735130793;9495.097965693249;9588.904110958802;9789.118979291898;12734.490620375082;12818.372233692256;12942.029347798765;13087.083904126619;13293.468261269827 09:11:06 INFO - PID 4380 | |3;mootools.html;1413.3074793351257;1422.1609250542178;1442.105894345506;1443.0836418874012;1484.903481273717;11498.42507874606;11784.882151178486;12006.339651319175;12015.639530814089;12068.336241506713;12229;12312.81530777039;12349.567765128222;12413.193142445734;12453.252804831716;2436.8903399347073;2471.8146139039554;2473.5300292944285;2474.4927289905527;2491.028498885436;2391.689080419543;2419.1653879411665;2422.551827911842;2423.1155628195756;2425.1754403502805;2302.102180149743;2354.2701762453694;2355.422921384263;2365.053978408642;2366.7988221001237;2272.4546108933737;2294.552562250362;2298.425393651587;2301.5166814968875;2304.2741536415974;2275.5107651854933;2283.6917016202765;2284.1434462076722;2285.748567657556;2376.79797217235;11590.884091159065;11602.825957610643;11624.302541847432;11717.29696218221;11721.824172637418;6156.722947467375;6317.399847014526;6339.334369891188;6359.618422894595;6372.490200783926;3777.1879046004965;3918.666913312372;3969.3053715599945;3979.7015223858325;3991.042149884036;1311.960641180766;1332.473672899209;1338.1770211320065;1340.4825737265446;1348.0900392235203;17161.14194290293;17318.913405433017;17341.306347746075;17584.12079396025;18284.360047398277;5287.70917599528;5390.568754499631;5490.780368785204;5506.91739623906;5553.222548843084;13084.738305233843;13105.803412948813;13123.540676076482;13150.27673477968;13174.407151678197;6333.873322533524;6449.838754031093;6477.287498375175;6484;6493.253275873335;6059.666718330534;6075.422834830684;6076.635401875901;6087.634741915499;6109.389061093855;4240.766757828287;4360.062586543845;4385.934210986838;4415;4437.933430998538;1178.3283528388736;1222.4865556466304;1225.841579707186;1231.907606929466;1233.3709807997986;843.7089204224533;879.3800370738614;892.5492626223715;903.0969030969031;934.2992755433424;6715.899261511081;6728.629925354153;6730.562513436611;6754.45964322853;6793.966030169818;598.9131575921467;604.6704546022428;604.9485793707496;609.0498821837947;614.5544480251871;4097.2010457961005;4112.074783173822;4115.36211887158;4164.104717485755;4283.721558098714;14954.027988180733;15421.228938553028;15676.372945082298;15818.525444236691;15829.841701582836;14952.850471495363;15688;15792.60518487047;15957.680846383008;16024.679506409806;9139;9391.389559678599;9408.95295523518;9554.140127388568;9666.95166524163;7125.893111603434;7231.63841807897;7432.3310902019075;7479.551226926402;7752.108507521707;14285.28573571338;14516.564503064925;14560.271986400427;14895.776563351776;14916;14636.780448293497;14668.77996830027;14728.042677225945;14897.47858824936;15134.318955646802;9834.754131146492;9907.950460247652;9913.30606857513;9979;9992.901490687038;10910.61812836547;11025.889741102807;11097.278676885977;11099.889001109885;11111.666650000512;9389.201917837061;9456.810863782823;9462.195713364441;9516.85724714116;9662.17871480932;9356.95321523388;9421.340506164503;9481;9624.133827955518;9715;7794.674905266232;7855;7958.84082318362;7965.044194696674;7970.40221983342;6034.758609655564;6078.969605151946;6104.847378815565;6164.6917654118015;6312.210973628296;6127.3259941407305;6160.537959653134;6279.434850863444;6323.905141422791;6451.290358060516 09:11:06 INFO - PID 4380 | |4;prototype.html;368.5798190063327;376.67417683703604;380.2509057157399;390.9257241124186;396.50634959475457;6017.157597936292;6199.256089269288;6227.9065814012765;6234.407731265523;6258.092576576394;5971.611845230057;6055.5761096723245;6087;6119.684267882416;6125.387461253872;4757.0723708876785;4766.880827979294;4779.852835319516;4780.09178256132;4791.425028996526;4675.88310292242;4744.383230180089;4764.642651801111;4800.711957282557;4808.326834243208;4754.072955773626;4771.713697178163;4779.808807647707;4790.712557246559;4793.3768610080815;4754.263089221159;4767.498238055002;4793.976030119845;4803.903921921542;4804.855854324376;4228.788560571959;4282.293421585435;4309.84915527955;4319.33050377192;4322.113966636864;5987.461128498412;6007.249093863267;6007.7596896124105;6009.519238460956;6034.185384973016;5552.666839989573;5596.4403559644115;5599.832005039814;5668.858278543028;5678.346990096151;6482.902756458657;6485.643289619069;6485.70814313357;6496.440854194959;6549.214094308713;4825.372701548811;4825.686330388514;4827.9034419311765;4840.854774356775;4846.733429661367;6701.564398314094;6822.351876571718;6850.869606514919;6853.623050732208;6867.965660171667;4966.553010229097;4978.701277923336;4986.376702912136;4989.176785830297;4990.50094990498;4887.120318342732;5026.798928042837;5028.2457631354855;5047.268146118792;5062.417821950449;5600.131979543177;5606.635568688022;5657.830265092054;5658.717064146858;5666.631668941505;6491.058796474579;6510.934890651033;6527.5757075789925;6539.280679125292;6582.210134783857;1718.613312004789;1740.3299729604194;1750.0812073661175;1755.1136675978548;1775.1390575571097;1207.7946749052683;1242.316725800806;1243.4031664800946;1262.3751243134707;1263.1347526944073;6213.502919766408;6216.347283535254;6227.19046523949;6237.844053898689;6246.6876656167005;6547.410733034049;6621.768238111643;6630.939049752016;6650.546551827455;6656.600603963778;6138.294096178907;6148.9692551537855;6186.783462578788;6187.02015355082;6203.751849926042;3494.1963348430004;3502.6322236165347;3546.3971124908826;3561.893143205708;3570.2680950405106;6667.49993750461;6745.527813053137;6828.658567071627;6844.953995471968;6908.480134370531;6687.230968438692;6759.188897332351;6798.558093723892;6813.591184528944;6836.726530938806;6819.556728812611;6848.1097457330225;6858.622775747282;6864.141982252218;6876.862462750717;6497.967510162419;6623.437007854386;6660.800175994728;6663.200415950117;6676.83307917306;6569.441597464078;6603.570767900071;6614.371634694697;6615;6622;6861.210960739579;6863.450923925974;6966.5471744336455;6976.767434420936;6991.370776630128;4526.705764125321;4548.613367863769;4567.406237189144;4595.954040459686;4605.263157894721;6705.161854768154;6716.227633822173;6718.865622687616;6729.932700672931;6773.525853190229;6278.780242691484;6450.580712253689;6504.73981040772;6507.902381464187;6595.736170553124;6451.612903225821;6456.9354306456335;6488.896887529037;6493.837654058686;6511.609303441809;6194.2126043281605;6420.967895160495;6478.870422591616;6493.383128602775;6504.349565043647;6483.319251478527;6508.934910651023;6516.804495865132;6523.075692670579;6539.43053667126;6053.364396738279;6112.266528016667;6167.167432396748;6245.219347581552;6269.435750782452 09:11:06 INFO - PID 4380 | |5;yui.html;844.2865778417236;856.9828603427935;859.0679113162219;865.3164000439652;879.3404946290283;15031;15592.142432166254;17456.91271543642;17680.204390802395;17755.822441775577;17886.46340609784;18373.908130459327;18421.35525256616;18459.53851153722;18501.259949602;962.6823148361024;1030.0986636692894;1031.5976769060073;1037.6420135053395;1039.6880935719291;1029.9227557933148;1036.4972988100765;1037.8443233514959;1037.9896201037968;1040.2977989856854;1066.727984363986;1070.3631339353071;1070.9518071686794;1081.643057790927;1086.2884810449168;1069.8609180806484;1073.7691396349744;1076.8061748885198;1077.06833588945;1078.1859695929563;788.2511613966698;789.1989630525022;790.8339248757768;790.9485883417559;791.3194652598761;15687.921560392238;15745.527634170992;15796.447124350592;16470.67058658832;18067.186976586087;18350.816491835045;18570;18699.252029918785;18918.527036824053;18961;14846;14863.554093377108;14887.255637218204;14919;14947.177905215209;3399.3371292597953;3488;3511.262634846685;3513.0690367052753;3515.0157955772424;97980;98873.0112698871;99299;100012.49993749984;101280;14011.159330440003;14227.573172804832;14233.928830355782;14337.713245735027;14341.713165736626;27583.86208068987;28232.71767282342;28297.292567685974;28377;28388.290292742848;8274.172582741678;8326.333893288522;8392.538410387488;8538.957305213435;8601.655933762704;3899.902502437462;3938.8030598469963;3959.267535505883;3982.5420076691553;3989.880303590897;4382.7290085875375;4444.266695995125;4447.911041779146;4470.7764611769935;4494.550544945545;889.6352495476823;904.9095090490898;904.9185573298435;905.0949050949051;910.41733290694;606.9302030266488;644.2816259870211;667.9899801502982;693.5110746923407;693.7051753004953;11871.821922671166;13191.81273685373;13242.20546767197;13700.588982330546;13754.93122534381;716.4769718105708;727.9708811647581;742.2392048150689;742.4431676242818;749.0187853911393;5528.806491772769;5601.691906945076;5699.487046165782;5709.486146246774;5847.853803654943;108788.45605772079;110552;110738;110872.44563777129;111028;85674;87731;94048;94567;94723;71597.71583739368;73918.26081739114;74862.25137748553;75987.62006190044;78045.75633949383;11267.323960562393;11411.771764564495;11498.655040348804;11893.583724569598;12336.691582710504;34757.99999999899;34969.65030349664;35575.46636800502;35590.64409355873;36456.817715912315;45278.320825188304;45962.77018614885;46078.769606151756;46420;47165.52834471749;17067.40264090751;17176.82823171752;17192.398266060627;17249.48251552405;17535.824641753417;16333.836661633706;19497.415077547696;19695.507612309233;21113.683294750284;21191.470213244174;19042.23831046798;19100.42698718985;19133.521661958563;19296.32462863793;19567.510812229808;18902.243910243986;19165.425037248348;19168;19210.135543900837;19421.4173574793;16903.915480422518;17004.829951700325;17088.487345379657;17385.739213911547;17444.651106978043;11933.52265909354;12122.452443108847;12354.629361119181;12370.257784532956;12723.300218488072;12845.807312890502;13513.729725405634;13720.382582783599;13779.793303100661;13837.131987181601 09:11:06 INFO - PID 4380 | __end_tp_report 09:11:06 INFO - PID 4380 | __start_cc_report 09:11:06 INFO - PID 4380 | _x_x_mozilla_cycle_collect,298 09:11:06 INFO - PID 4380 | __end_cc_report 09:11:06 INFO - PID 4380 | __startTimestamp1495815066445__endTimestamp 09:11:06 INFO - PID 4380 | 09:11:06 INFO - PID 4380 | ------- Summary: start ------- 09:11:06 INFO - PID 4380 | Number of tests: 6 09:11:06 INFO - PID 4380 | 09:11:06 INFO - PID 4380 | [#0] dojo.html Cycles:165 Average:5901.19 Median:6115.61 stddev:695.74 (11.4%) stddev-sans-first:668.83 09:11:06 INFO - PID 4380 | Values: 3365.4 3383.1 3410.7 3414.4 3418.9 5827.9 5876.2 5938.0 5951.3 5955.2 5910.7 5918.2 5966.4 5995.7 6039.6 5166.9 5246.7 5274.0 5299.8 5316.6 5333.5 5361.1 5381.8 5391.6 5400.7 5249.3 5277.7 5280.2 5319.7 5363.1 5267.7 5280.0 5280.3 5283.9 5335.9 5216.3 5262.4 5266.5 5267.3 5300.1 5818.5 5873.6 5884.0 5906.2 5909.9 6404.5 6406.3 6422.6 6435.0 6443.6 6478.2 6478.6 6481.2 6486.8 6497.5 5836.1 5872.4 5985.1 6000.2 6005.3 6401.1 6430.5 6528.4 6535.2 6563.5 6069.5 6152.4 6236.8 6256.4 6273.4 6408.2 6416.6 6416.7 6441.3 6443.4 6200.0 6363.7 6382.4 6391.1 6397.3 6265.6 6321.8 6341.7 6395.2 6399.6 4897.9 4920.1 4927.3 4927.8 4949.4 4363.3 4366.9 4373.7 4388.1 4406.8 5954.9 6024.7 6033.5 6110.3 6126.8 6326.6 6338.8 6359.9 6369.9 6390.7 5976.7 5982.6 5983.9 5996.0 6049.2 5335.3 5385.3 5388.7 5391.2 5409.5 6563.8 6586.3 6603.3 6610.6 6639.6 6372.5 6376.4 6379.4 6383.2 6404.2 6488.2 6558.3 6674.7 6713.8 6715.2 6127.7 6194.1 6255.9 6291.8 6293.8 6490.5 6497.3 6497.3 6500.6 6522.3 6106.6 6115.6 6180.8 6258.4 6296.1 6195.2 6237.3 6239.1 6239.8 6242.2 6043.7 6141.8 6163.5 6178.0 6277.1 6295.7 6328.1 6354.6 6355.0 6357.7 6078.3 6089.8 6090.3 6090.7 6091.7 09:11:06 INFO - PID 4380 | 09:11:06 INFO - PID 4380 | [#1] ext.html Cycles:180 Average:39531.78 Median:19945.13 stddev:57650.92 (289.0%) stddev-sans-first:57739.16 09:11:06 INFO - PID 4380 | Values: 764.4 818.5 841.5 1119.1 1122.3 37282.6 38079.0 38192.4 38250.4 38274.8 39519.6 39563.6 39565.8 39570.8 39907.6 7096.4 7183.4 7254.6 7257.2 7325.9 7331.5 7438.4 7454.6 7457.8 7460.9 7438.8 7487.5 7492.7 7493.1 7495.8 7440.1 7447.1 7453.3 7483.4 7496.9 6970.1 7000.5 7037.7 7038.5 7048.4 37974.2 38169.4 38209.6 38360.4 38426.8 3558.0 3599.2 3606.7 3609.8 3618.7 29301.9 29330.3 29369.0 29474.7 29666.4 3634.0 3638.6 3648.2 3652.0 3654.2 202151.0 202898.0 207549.0 212848.0 213079.0 47827.8 47951.8 48018.5 48178.0 48285.5 49147.1 49160.0 49160.0 49304.3 49448.5 15556.4 15580.8 15639.1 15730.9 15775.8 12825.9 12834.8 12839.2 12841.0 12842.2 14022.7 14143.4 14153.6 14178.6 14432.4 5686.3 5755.9 5791.3 5893.1 5969.2 1063.6 1069.7 1108.1 1108.7 1110.9 26376.8 26933.0 27022.9 27051.5 27148.2 1203.4 1204.7 1207.1 1207.6 1243.6 13809.9 13865.2 14059.0 14233.4 14247.0 248324.0 249322.0 250619.2 250915.0 252019.0 53076.5 53298.5 53498.7 53786.7 54001.2 1453.4 1471.4 1497.6 1507.2 1524.4 24177.6 25340.6 25608.6 25664.0 25798.5 37135.6 37235.8 37290.0 37340.3 37370.4 204064.0 205720.0 206768.0 207460.0 207492.0 33542.0 37088.0 37399.3 37410.8 37560.0 47371.0 47719.8 48027.3 48601.3 49199.5 35084.5 35309.6 35565.5 35671.8 36077.8 34599.0 34961.5 36256.3 36660.8 37155.6 41029.0 42421.4 42634.0 42819.4 42951.6 34703.7 35050.8 35156.6 35782.6 36065.0 27041.3 28323.6 28324.4 28437.6 28705.9 09:11:06 INFO - PID 4380 | 09:11:06 INFO - PID 4380 | [#2] jquery.html Cycles:180 Average:31493.05 Median:11973.20 stddev:82224.67 (686.7%) stddev-sans-first:82422.23 09:11:06 INFO - PID 4380 | Values: 421.3 430.4 432.8 439.3 445.9 20094.7 20716.3 21227.8 21792.1 22081.9 22601.5 22662.0 22749.9 22818.2 22893.2 5420.3 5625.9 5686.6 5693.0 5703.9 5381.1 5545.0 5590.9 5613.9 5615.0 5605.4 5615.7 5626.5 5632.2 5636.7 5404.2 5569.5 5607.6 5609.9 5615.1 5024.3 5060.5 5062.3 5089.3 5100.0 24923.3 25432.9 25445.2 25680.2 25784.1 2017.2 2123.3 2125.7 2136.9 2138.8 16966.2 17197.2 17330.4 17654.2 17780.7 2120.2 2154.3 2181.2 2232.8 2234.7 114808.0 116476.0 117119.0 117924.0 118785.0 11789.1 11944.6 12021.5 12039.3 12205.1 16405.6 16412.6 16424.5 16426.6 16463.8 8518.1 8719.4 8770.1 8809.0 8821.6 8154.5 8192.0 8316.4 8548.2 8587.8 7650.8 7669.6 7774.2 7900.7 7916.0 2101.9 2114.6 2153.5 2193.4 2360.6 999.4 1032.4 1042.4 1042.5 1053.6 19517.7 20484.4 20700.3 20781.5 20879.9 1061.1 1061.2 1066.0 1067.3 1085.9 11308.3 11316.7 11397.1 11406.2 11497.2 482633.0 484630.0 495432.0 500795.0 502093.0 98443.0 100772.0 101503.5 101677.0 102116.0 1187.4 1193.3 1222.0 1222.5 1231.9 16840.2 17309.0 17806.6 17873.9 18015.3 45818.3 46913.8 48130.0 48983.0 49490.0 59910.7 60082.0 60787.4 60797.4 61089.0 9066.8 9269.0 9327.6 9508.8 9583.3 15194.7 15221.5 15229.7 15287.2 16027.0 13171.3 13180.9 13249.4 13371.7 13590.0 12490.7 12718.4 12718.5 12854.4 13107.0 13635.9 13638.7 13694.7 14060.2 14120.9 9308.2 9456.6 9495.1 9588.9 9789.1 12734.5 12818.4 12942.0 13087.1 13293.5 09:11:06 INFO - PID 4380 | 09:11:06 INFO - PID 4380 | [#3] mootools.html Cycles:180 Average:7365.51 Median:3847.93 stddev:4851.27 (126.1%) stddev-sans-first:4844.27 09:11:06 INFO - PID 4380 | Values: 1413.3 1422.2 1442.1 1443.1 1484.9 11498.4 11784.9 12006.3 12015.6 12068.3 12229.0 12312.8 12349.6 12413.2 12453.3 2436.9 2471.8 2473.5 2474.5 2491.0 2391.7 2419.2 2422.6 2423.1 2425.2 2302.1 2354.3 2355.4 2365.1 2366.8 2272.5 2294.6 2298.4 2301.5 2304.3 2275.5 2283.7 2284.1 2285.7 2376.8 11590.9 11602.8 11624.3 11717.3 11721.8 6156.7 6317.4 6339.3 6359.6 6372.5 3777.2 3918.7 3969.3 3979.7 3991.0 1312.0 1332.5 1338.2 1340.5 1348.1 17161.1 17318.9 17341.3 17584.1 18284.4 5287.7 5390.6 5490.8 5506.9 5553.2 13084.7 13105.8 13123.5 13150.3 13174.4 6333.9 6449.8 6477.3 6484.0 6493.3 6059.7 6075.4 6076.6 6087.6 6109.4 4240.8 4360.1 4385.9 4415.0 4437.9 1178.3 1222.5 1225.8 1231.9 1233.4 843.7 879.4 892.5 903.1 934.3 6715.9 6728.6 6730.6 6754.5 6794.0 598.9 604.7 604.9 609.0 614.6 4097.2 4112.1 4115.4 4164.1 4283.7 14954.0 15421.2 15676.4 15818.5 15829.8 14952.9 15688.0 15792.6 15957.7 16024.7 9139.0 9391.4 9409.0 9554.1 9667.0 7125.9 7231.6 7432.3 7479.6 7752.1 14285.3 14516.6 14560.3 14895.8 14916.0 14636.8 14668.8 14728.0 14897.5 15134.3 9834.8 9908.0 9913.3 9979.0 9992.9 10910.6 11025.9 11097.3 11099.9 11111.7 9389.2 9456.8 9462.2 9516.9 9662.2 9357.0 9421.3 9481.0 9624.1 9715.0 7794.7 7855.0 7958.8 7965.0 7970.4 6034.8 6079.0 6104.8 6164.7 6312.2 6127.3 6160.5 6279.4 6323.9 6451.3 09:11:06 INFO - PID 4380 | 09:11:06 INFO - PID 4380 | [#4] prototype.html Cycles:180 Average:5485.08 Median:6176.98 stddev:1587.81 (25.7%) stddev-sans-first:1545.12 09:11:06 INFO - PID 4380 | Values: 368.6 376.7 380.3 390.9 396.5 6017.2 6199.3 6227.9 6234.4 6258.1 5971.6 6055.6 6087.0 6119.7 6125.4 4757.1 4766.9 4779.9 4780.1 4791.4 4675.9 4744.4 4764.6 4800.7 4808.3 4754.1 4771.7 4779.8 4790.7 4793.4 4754.3 4767.5 4794.0 4803.9 4804.9 4228.8 4282.3 4309.8 4319.3 4322.1 5987.5 6007.2 6007.8 6009.5 6034.2 5552.7 5596.4 5599.8 5668.9 5678.3 6482.9 6485.6 6485.7 6496.4 6549.2 4825.4 4825.7 4827.9 4840.9 4846.7 6701.6 6822.4 6850.9 6853.6 6868.0 4966.6 4978.7 4986.4 4989.2 4990.5 4887.1 5026.8 5028.2 5047.3 5062.4 5600.1 5606.6 5657.8 5658.7 5666.6 6491.1 6510.9 6527.6 6539.3 6582.2 1718.6 1740.3 1750.1 1755.1 1775.1 1207.8 1242.3 1243.4 1262.4 1263.1 6213.5 6216.3 6227.2 6237.8 6246.7 6547.4 6621.8 6630.9 6650.5 6656.6 6138.3 6149.0 6186.8 6187.0 6203.8 3494.2 3502.6 3546.4 3561.9 3570.3 6667.5 6745.5 6828.7 6845.0 6908.5 6687.2 6759.2 6798.6 6813.6 6836.7 6819.6 6848.1 6858.6 6864.1 6876.9 6498.0 6623.4 6660.8 6663.2 6676.8 6569.4 6603.6 6614.4 6615.0 6622.0 6861.2 6863.5 6966.5 6976.8 6991.4 4526.7 4548.6 4567.4 4596.0 4605.3 6705.2 6716.2 6718.9 6729.9 6773.5 6278.8 6450.6 6504.7 6507.9 6595.7 6451.6 6456.9 6488.9 6493.8 6511.6 6194.2 6421.0 6478.9 6493.4 6504.3 6483.3 6508.9 6516.8 6523.1 6539.4 6053.4 6112.3 6167.2 6245.2 6269.4 09:11:06 INFO - PID 4380 | 09:11:06 INFO - PID 4380 | [#5] yui.html Cycles:180 Average:21176.46 Median:19149.47 stddev:28104.71 (146.8%) stddev-sans-first:28142.08 09:11:06 INFO - PID 4380 | Values: 844.3 857.0 859.1 865.3 879.3 15031.0 15592.1 17456.9 17680.2 17755.8 17886.5 18373.9 18421.4 18459.5 18501.3 962.7 1030.1 1031.6 1037.6 1039.7 1029.9 1036.5 1037.8 1038.0 1040.3 1066.7 1070.4 1071.0 1081.6 1086.3 1069.9 1073.8 1076.8 1077.1 1078.2 788.3 789.2 790.8 790.9 791.3 15687.9 15745.5 15796.4 16470.7 18067.2 18350.8 18570.0 18699.3 18918.5 18961.0 14846.0 14863.6 14887.3 14919.0 14947.2 3399.3 3488.0 3511.3 3513.1 3515.0 97980.0 98873.0 99299.0 100012.5 101280.0 14011.2 14227.6 14233.9 14337.7 14341.7 27583.9 28232.7 28297.3 28377.0 28388.3 8274.2 8326.3 8392.5 8539.0 8601.7 3899.9 3938.8 3959.3 3982.5 3989.9 4382.7 4444.3 4447.9 4470.8 4494.6 889.6 904.9 904.9 905.1 910.4 606.9 644.3 668.0 693.5 693.7 11871.8 13191.8 13242.2 13700.6 13754.9 716.5 728.0 742.2 742.4 749.0 5528.8 5601.7 5699.5 5709.5 5847.9 108788.5 110552.0 110738.0 110872.4 111028.0 85674.0 87731.0 94048.0 94567.0 94723.0 71597.7 73918.3 74862.3 75987.6 78045.8 11267.3 11411.8 11498.7 11893.6 12336.7 34758.0 34969.7 35575.5 35590.6 36456.8 45278.3 45962.8 46078.8 46420.0 47165.5 17067.4 17176.8 17192.4 17249.5 17535.8 16333.8 19497.4 19695.5 21113.7 21191.5 19042.2 19100.4 19133.5 19296.3 19567.5 18902.2 19165.4 19168.0 19210.1 19421.4 16903.9 17004.8 17088.5 17385.7 17444.7 11933.5 12122.5 12354.6 12370.3 12723.3 12845.8 13513.7 13720.4 13779.8 13837.1 09:11:06 INFO - PID 4380 | -------- Summary: end -------- 09:11:06 INFO - PID 4380 | 09:11:07 INFO - TEST-INFO | 4380: exit 0 09:11:07 INFO - TEST-OK | dromaeo_css | took 1140222ms 09:11:07 INFO - TEST-START | kraken 09:11:07 INFO - operating with platform_type : linux_ 09:11:07 INFO - Initialising browser for kraken test... 09:11:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60997/getInfo.html -profile /tmp/tmpWfKhpg/profile 09:11:07 INFO - TEST-INFO | started process 4790 (/builds/slave/test/build/application/firefox/firefox http://localhost:60997/getInfo.html) 09:11:41 INFO - TEST-INFO | 4790: killed by SIGTERM 09:11:41 INFO - Browser initialized. 09:11:41 INFO - Running cycle 1/1 for kraken test... 09:11:41 INFO - TEST-INFO | started process 4988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWfKhpg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:11:53 INFO - PID 4988 | RSS: Main: 165699584 09:11:53 INFO - PID 4988 | 09:11:55 INFO - PID 4988 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60997/tests/kraken/driver.html?testName=audio-beat-detection) 09:11:56 INFO - PID 4988 | RSS: Main: 171810816 09:11:56 INFO - PID 4988 | 09:11:59 INFO - PID 4988 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60997/tests/kraken/driver.html?testName=audio-dft) 09:11:59 INFO - PID 4988 | RSS: Main: 170864640 09:11:59 INFO - PID 4988 | 09:12:02 INFO - PID 4988 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60997/tests/kraken/driver.html?testName=audio-fft) 09:12:03 INFO - PID 4988 | RSS: Main: 167997440 09:12:03 INFO - PID 4988 | 09:12:05 INFO - PID 4988 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60997/tests/kraken/driver.html?testName=audio-oscillator) 09:12:06 INFO - PID 4988 | RSS: Main: 169496576 09:12:06 INFO - PID 4988 | 09:12:08 INFO - PID 4988 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60997/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:12:08 INFO - PID 4988 | RSS: Main: 168644608 09:12:08 INFO - PID 4988 | 09:12:11 INFO - PID 4988 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60997/tests/kraken/driver.html?testName=imaging-darkroom) 09:12:12 INFO - PID 4988 | RSS: Main: 170680320 09:12:12 INFO - PID 4988 | 09:12:15 INFO - PID 4988 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60997/tests/kraken/driver.html?testName=imaging-desaturate) 09:12:16 INFO - PID 4988 | RSS: Main: 169684992 09:12:16 INFO - PID 4988 | 09:12:19 INFO - PID 4988 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60997/tests/kraken/driver.html?testName=json-parse-financial) 09:12:19 INFO - PID 4988 | RSS: Main: 170205184 09:12:19 INFO - PID 4988 | 09:12:21 INFO - PID 4988 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60997/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:12:21 INFO - PID 4988 | RSS: Main: 170090496 09:12:21 INFO - PID 4988 | 09:12:23 INFO - PID 4988 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60997/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:12:24 INFO - PID 4988 | RSS: Main: 169803776 09:12:24 INFO - PID 4988 | 09:12:26 INFO - PID 4988 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60997/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:12:27 INFO - PID 4988 | RSS: Main: 170151936 09:12:27 INFO - PID 4988 | 09:12:29 INFO - PID 4988 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60997/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:12:30 INFO - PID 4988 | RSS: Main: 169877504 09:12:30 INFO - PID 4988 | 09:12:33 INFO - PID 4988 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60997/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:12:33 INFO - PID 4988 | RSS: Main: 170029056 09:12:33 INFO - PID 4988 | 09:12:35 INFO - PID 4988 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60997/tests/kraken/driver.html?testName=ai-astar) 09:12:35 INFO - PID 4988 | RSS: Main: 171917312 09:12:35 INFO - PID 4988 | 09:12:35 INFO - PID 4988 | __start_tp_report 09:12:35 INFO - PID 4988 | _x_x_mozilla_page_load 09:12:35 INFO - PID 4988 | _x_x_mozilla_page_load_details 09:12:35 INFO - PID 4988 | |i|pagename|runs| 09:12:35 INFO - PID 4988 | |0;ai-astar;100;109;111;109;109;110;109;110;111;112 09:12:35 INFO - PID 4988 | |1;audio-beat-detection;150;122;117;163;117;119;121;119;142;125 09:12:35 INFO - PID 4988 | |2;audio-dft;162;162;163;165;165;162;163;166;164;167 09:12:35 INFO - PID 4988 | |3;audio-fft;73;75;77;96;73;74;74;77;90;73 09:12:35 INFO - PID 4988 | |4;audio-oscillator;83;82;105;81;82;83;96;82;82;104 09:12:35 INFO - PID 4988 | |5;imaging-gaussian-blur;114;116;114;113;114;115;114;114;113;114 09:12:35 INFO - PID 4988 | |6;imaging-darkroom;148;148;152;150;147;148;149;148;150;147 09:12:35 INFO - PID 4988 | |7;imaging-desaturate;97;95;94;94;95;99;95;94;94;94 09:12:35 INFO - PID 4988 | |8;json-parse-financial;48;49;49;52;52;49;50;49;47;49 09:12:35 INFO - PID 4988 | |9;json-stringify-tinderbox;56;56;56;57;56;63;56;56;57;56 09:12:35 INFO - PID 4988 | |10;stanford-crypto-aes;87;86;99;84;84;84;84;85;114;84 09:12:35 INFO - PID 4988 | |11;stanford-crypto-ccm;127;128;130;126;130;138;122;127;122;127 09:12:35 INFO - PID 4988 | |12;stanford-crypto-pbkdf2;175;180;181;179;188;177;186;185;186;195 09:12:35 INFO - PID 4988 | |13;stanford-crypto-sha256-iterative;65;65;68;69;62;66;67;63;63;65 09:12:35 INFO - PID 4988 | __end_tp_report 09:12:35 INFO - PID 4988 | __start_cc_report 09:12:35 INFO - PID 4988 | _x_x_mozilla_cycle_collect,787 09:12:35 INFO - PID 4988 | __end_cc_report 09:12:35 INFO - PID 4988 | __startTimestamp1495815155797__endTimestamp 09:12:35 INFO - PID 4988 | 09:12:35 INFO - PID 4988 | ------- Summary: start ------- 09:12:35 INFO - PID 4988 | Number of tests: 14 09:12:35 INFO - PID 4988 | 09:12:35 INFO - PID 4988 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:3.33 (3.0%) stddev-sans-first:1.12 09:12:35 INFO - PID 4988 | Values: 100.0 109.0 111.0 109.0 109.0 110.0 109.0 110.0 111.0 112.0 09:12:35 INFO - PID 4988 | 09:12:35 INFO - PID 4988 | [#1] audio-beat-detection Cycles:10 Average:129.50 Median:123.50 stddev:16.26 (13.2%) stddev-sans-first:15.47 09:12:35 INFO - PID 4988 | Values: 150.0 122.0 117.0 163.0 117.0 119.0 121.0 119.0 142.0 125.0 09:12:35 INFO - PID 4988 | 09:12:35 INFO - PID 4988 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.50 stddev:1.79 (1.1%) stddev-sans-first:1.76 09:12:35 INFO - PID 4988 | Values: 162.0 162.0 163.0 165.0 165.0 162.0 163.0 166.0 164.0 167.0 09:12:35 INFO - PID 4988 | 09:12:35 INFO - PID 4988 | [#3] audio-fft Cycles:10 Average:78.20 Median:76.00 stddev:8.07 (10.6%) stddev-sans-first:8.33 09:12:35 INFO - PID 4988 | Values: 73.0 75.0 77.0 96.0 73.0 74.0 74.0 77.0 90.0 73.0 09:12:35 INFO - PID 4988 | 09:12:35 INFO - PID 4988 | [#4] audio-oscillator Cycles:10 Average:88.00 Median:82.00 stddev:9.73 (11.9%) stddev-sans-first:10.15 09:12:35 INFO - PID 4988 | Values: 83.0 82.0 105.0 81.0 82.0 83.0 96.0 82.0 82.0 104.0 09:12:35 INFO - PID 4988 | 09:12:35 INFO - PID 4988 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.88 (0.8%) stddev-sans-first:0.93 09:12:35 INFO - PID 4988 | Values: 114.0 116.0 114.0 113.0 114.0 115.0 114.0 114.0 113.0 114.0 09:12:35 INFO - PID 4988 | 09:12:35 INFO - PID 4988 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:148.50 stddev:1.57 (1.1%) stddev-sans-first:1.64 09:12:35 INFO - PID 4988 | Values: 148.0 148.0 152.0 150.0 147.0 148.0 149.0 148.0 150.0 147.0 09:12:35 INFO - PID 4988 | 09:12:35 INFO - PID 4988 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:1.66 (1.8%) stddev-sans-first:1.62 09:12:35 INFO - PID 4988 | Values: 97.0 95.0 94.0 94.0 95.0 99.0 95.0 94.0 94.0 94.0 09:12:35 INFO - PID 4988 | 09:12:35 INFO - PID 4988 | [#8] json-parse-financial Cycles:10 Average:49.40 Median:49.00 stddev:1.58 (3.2%) stddev-sans-first:1.59 09:12:35 INFO - PID 4988 | Values: 48.0 49.0 49.0 52.0 52.0 49.0 50.0 49.0 47.0 49.0 09:12:35 INFO - PID 4988 | 09:12:35 INFO - PID 4988 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:56.00 stddev:2.18 (3.9%) stddev-sans-first:2.29 09:12:35 INFO - PID 4988 | Values: 56.0 56.0 56.0 57.0 56.0 63.0 56.0 56.0 57.0 56.0 09:12:35 INFO - PID 4988 | 09:12:35 INFO - PID 4988 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:84.50 stddev:9.88 (11.7%) stddev-sans-first:10.45 09:12:35 INFO - PID 4988 | Values: 87.0 86.0 99.0 84.0 84.0 84.0 84.0 85.0 114.0 84.0 09:12:35 INFO - PID 4988 | 09:12:35 INFO - PID 4988 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:127.50 stddev:4.55 (3.6%) stddev-sans-first:4.82 09:12:35 INFO - PID 4988 | Values: 127.0 128.0 130.0 126.0 130.0 138.0 122.0 127.0 122.0 127.0 09:12:35 INFO - PID 4988 | 09:12:35 INFO - PID 4988 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.20 Median:185.50 stddev:5.96 (3.2%) stddev-sans-first:5.53 09:12:35 INFO - PID 4988 | Values: 175.0 180.0 181.0 179.0 188.0 177.0 186.0 185.0 186.0 195.0 09:12:35 INFO - PID 4988 | 09:12:35 INFO - PID 4988 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:2.26 (3.5%) stddev-sans-first:2.40 09:12:35 INFO - PID 4988 | Values: 65.0 65.0 68.0 69.0 62.0 66.0 67.0 63.0 63.0 65.0 09:12:35 INFO - PID 4988 | -------- Summary: end -------- 09:12:35 INFO - PID 4988 | 09:12:36 INFO - TEST-INFO | 4988: exit 0 09:12:36 INFO - TEST-OK | kraken | took 89634ms 09:12:36 INFO - SUITE-END | took 1229s 09:12:36 INFO - Completed test suite (00:20:30) 09:12:36 INFO - javascript benchmark 09:12:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7901.620312396977, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3365.377405180042, 3383.1034775784406, 3410.727141828654, 3414.3683418567566, 3418.880339188129, 5827.912581311273, 5876.236089308394, 5938.0499120140785, 5951.345352011281, 5955.196048533447, 5910.674912879801, 5918.230630018092, 5966.37353077926, 5995.700214989255, 6039.607425517338, 5166.948330516703, 5246.68519888806, 5274.0, 5299.761510732026, 5316.574674026068, 5333.466653334674, 5361.142217245241, 5381.757820898049, 5391.595630327722, 5400.675959442446, 5249.265102885599, 5277.683338999673, 5280.1815718563685, 5319.707416092094, 5363.141897296453, 5267.710275934822, 5280.049591073605, 5280.339957505312, 5283.920741188886, 5335.919961200585, 5216.3218781558535, 5262.368515778093, 5266.499682530153, 5267.262583238311, 5300.125479295912, 5818.505427038707, 5873.559483038789, 5884.0, 5906.173135760997, 5909.940900590982, 6404.4876409887565, 6406.327335629739, 6422.614643121427, 6434.967825160891, 6443.581167224115, 6478.190226221723, 6478.643674597895, 6481.189851268591, 6486.837829054311, 6497.48020158391, 5836.066229403275, 5872.383399743051, 5985.132155837423, 6000.159977603183, 6005.3394126646035, 6401.135846660734, 6430.485561155097, 6528.412442880163, 6535.248446428626, 6563.474922006228, 6069.514438844882, 6152.415520525632, 6236.750529978841, 6256.436920677161, 6273.404026617464, 6408.198975128109, 6416.550841441054, 6416.679166041679, 6441.323661015525, 6443.420092191632, 6200.0, 6363.681815909279, 6382.361763823674, 6391.105245265667, 6397.264314603787, 6265.592736472115, 6321.810345689637, 6341.746330146742, 6395.168628078413, 6399.616023038632, 4897.926531101965, 4920.138975679241, 4927.310176575283, 4927.827526036644, 4949.430815456197, 4363.323684828857, 4366.890827729332, 4373.715708478939, 4388.100439409914, 4406.823727050882, 5954.851128721816, 6024.668643224577, 6033.5474839387225, 6110.29731580865, 6126.785562505291, 6326.620402775849, 6338.778142764981, 6359.904601430982, 6369.936300637027, 6390.744370225232, 5976.701164941735, 5982.641041537521, 5983.910241346383, 5996.0, 6049.153118563405, 5335.306410166653, 5385.3268341457315, 5388.7305634718105, 5391.245225668409, 5409.486098820685, 6563.835904102436, 6586.341365863375, 6603.339666033455, 6610.603363798187, 6639.634820084845, 6372.5220608455475, 6376.426121649074, 6379.393957574023, 6383.170187875547, 6404.1674582304, 6488.156539650005, 6558.278589355263, 6674.666266686743, 6713.798586042427, 6715.1941766988275, 6127.678242056309, 6194.132821405097, 6255.9374406257175, 6291.842703932438, 6293.842653933688, 6490.545661803817, 6497.252815926229, 6497.252815926229, 6500.609963402211, 6522.315156908646, 6106.642687876592, 6115.605440958429, 6180.7527698891545, 6258.374162583706, 6296.118543404019, 6195.2255968004, 6237.345078766664, 6239.126522286974, 6239.78160764371, 6242.188515492957, 6043.667598282137, 6141.84645383869, 6163.537734669828, 6177.96911015442, 6277.058441233851, 6295.716692748746, 6328.114064031131, 6354.618722876642, 6354.968225158845, 6357.650329231752, 6078.270607526948, 6089.786857459968, 6090.330063693079, 6090.725917333642, 6091.695415229132], "value": 5852.686009159754, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [764.4419573711191, 818.5334359415134, 841.5035129273728, 1119.0991252042108, 1122.2817396866003, 37282.62717372825, 38079.04802379938, 38192.42711359325, 38250.426243606365, 38274.8086259569, 39519.60480395195, 39563.60436395635, 39565.8021709891, 39570.802145989226, 39907.60092399075, 7096.396806271473, 7183.425325973935, 7254.600996945166, 7257.165425976001, 7325.926740732604, 7331.523450975669, 7438.404927605806, 7454.55272683638, 7457.813554661123, 7460.888086678704, 7438.776836694908, 7487.475876688634, 7492.662830172628, 7493.100827900659, 7495.812604684899, 7440.144383395925, 7447.069116360455, 7453.254674532557, 7483.4013278937555, 7496.850062998764, 6970.059042029312, 7000.544964577337, 7037.718491260343, 7038.542494737826, 7048.378872859271, 37974.240515189544, 38169.42745858814, 38209.61790382089, 38360.424593630836, 38426.807865960494, 3557.964420355789, 3599.190182209008, 3606.711463082947, 3609.7653652512504, 3618.656227658368, 29301.853490732625, 29330.266743331373, 29369.0, 29474.705252947624, 29666.406671866444, 3633.963660363389, 3638.6361363863666, 3648.233870887117, 3651.9634803652157, 3654.177809992757, 202151.0, 202898.0, 207549.0, 212848.0, 213079.0, 47827.76086119617, 47951.76024119927, 48018.5198148021, 48178.0, 48285.5171448281, 49147.10234771779, 49160.0, 49160.0, 49304.260436093486, 49448.50551494439, 15556.377744890078, 15580.844191558166, 15639.139847308279, 15730.9213453932, 15775.842241577437, 12825.935870320589, 12834.80747788784, 12839.229646221256, 12841.0, 12842.165259258118, 14022.719545609234, 14143.363548640336, 14153.575392738234, 14178.574642760734, 14432.350544225535, 5686.317641882918, 5755.942060847093, 5791.330469104757, 5893.145493903446, 5969.1646467927385, 1063.6277302944063, 1069.7111779819404, 1108.107973081677, 1108.6895669212633, 1110.9277896936674, 26376.766702804427, 26933.0, 27022.864885675444, 27051.458970820473, 27148.1855544334, 1203.4464146492537, 1204.740980689156, 1207.076586411396, 1207.5833837326109, 1243.639344590077, 13809.861901381058, 13865.23741194244, 14059.0, 14233.43066277358, 14247.0, 248324.0, 249322.0, 250619.22832700767, 250915.0, 252019.0, 53076.46923530792, 53298.46701533013, 53498.73250633722, 53786.731066344415, 54001.189982150296, 1453.4258967707697, 1471.433498103238, 1497.5806774103269, 1507.201183372814, 1524.3521503361249, 24177.63733543963, 25340.60626665551, 25608.61587076158, 25664.0, 25798.484030318912, 37135.628643713215, 37235.81382093072, 37290.0, 37340.25319493649, 37370.43944340783, 204064.0, 205720.0, 206768.0, 207460.0, 207492.0, 33542.0, 37088.0, 37399.25201496009, 37410.8129459351, 37560.0, 47371.0, 47719.76140119416, 48027.279590806866, 48601.270980934605, 49199.508004919495, 35084.473732893515, 35309.646903530636, 35565.46651800173, 35671.82164089163, 36077.81961090283, 34599.0, 34961.475577865844, 36256.29691575602, 36660.81669591635, 37155.6284437163, 41029.0, 42421.41887136515, 42634.0, 42819.357709633754, 42951.57048429476, 34703.65296347004, 35050.82474587611, 35156.64843351534, 35782.64217357897, 36065.0, 27041.323966900985, 28323.57514637241, 28324.43351133007, 28437.573436398055, 28705.856470717514], "value": 17579.061679240953, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.34289791353297, 430.35231975876303, 432.8333591567248, 439.3037036297469, 445.86178284731716, 20094.6985795213, 20716.27493037742, 21227.787722122775, 21792.128314867387, 22081.889590552026, 22601.54796904061, 22662.0, 22749.886250568765, 22818.2013629523, 22893.19873804417, 5420.268263784388, 5625.915611265835, 5686.630369026, 5693.03218452864, 5703.885922281552, 5381.139017757159, 5545.0, 5590.944090559104, 5613.859653508654, 5615.017371959891, 5605.439456054382, 5615.719214039282, 5626.549876009909, 5632.183333416652, 5636.7181640918, 5404.216388623667, 5569.526590239814, 5607.607467477278, 5609.915851262234, 5615.101583746581, 5024.296598476216, 5060.544550990392, 5062.31658726071, 5089.312942752718, 5100.0309941111445, 24923.252302430956, 25432.872835635888, 25445.23664290074, 25680.229593112235, 25784.097556585428, 2017.1931227508967, 2123.309924274617, 2125.72365592472, 2136.903839327234, 2138.786121387864, 16966.23651935666, 17197.226124824414, 17330.39343622967, 17654.205560749797, 17780.733289000676, 2120.236714782677, 2154.2675490333363, 2181.19295860531, 2232.7767223277706, 2234.6871437998693, 114808.0, 116475.99999999916, 117119.0, 117924.0, 118785.0, 11789.115816313639, 11944.581939632071, 12021.519139234508, 12039.277643341427, 12205.084618653636, 16405.58986025335, 16412.589685257724, 16424.507264782074, 16426.589335266475, 16463.83536164623, 8518.148185181431, 8719.389642725075, 8770.079141690157, 8809.0, 8821.558922053871, 8154.469959452616, 8192.0, 8316.37627177964, 8548.230659240699, 8587.785305367415, 7650.8087297818, 7669.616519174019, 7774.1837107104075, 7900.696385096395, 7916.010498687664, 2101.873887566751, 2114.6299397605358, 2153.4616345913523, 2193.42970827586, 2360.6104992676014, 999.3654029691053, 1032.4270030133198, 1042.3954106618144, 1042.5152304178594, 1053.6154303679255, 19517.73302795033, 20484.385468435972, 20700.275490357766, 20781.480462988548, 20879.895600522203, 1061.0927656853435, 1061.2147011211648, 1065.9840102398316, 1067.3062509368817, 1085.8642669666292, 11308.264962777394, 11316.660500185008, 11397.088232941345, 11406.201565890475, 11497.195196336175, 482633.0, 484630.0, 495432.0, 500795.0, 502093.0, 98443.0, 100772.0, 101503.49248253711, 101677.0, 102116.0, 1187.3944288412972, 1193.3376975778526, 1222.0, 1222.4743360355133, 1231.944562494672, 16840.15799210059, 17309.0, 17806.643867122842, 17873.910630446764, 18015.2793888243, 45818.31272530848, 46913.76543117263, 48129.99047414787, 48983.0, 49490.0, 59910.70044649749, 60082.0, 60787.39212607817, 60797.39202608094, 61089.0, 9066.818663626558, 9268.95365523168, 9327.626894924128, 9508.809823803624, 9583.295976410192, 15194.696106077596, 15221.543353699406, 15229.695406091594, 15287.235638218268, 16026.958247713861, 13171.275579842817, 13180.934095329461, 13249.403776829873, 13371.732565348444, 13590.0, 12490.687732806753, 12718.364081796059, 12718.491260349483, 12854.421551030413, 13107.0, 13635.909127269597, 13638.727225455634, 13694.65763355924, 14060.156390616596, 14120.858791411954, 9308.208802251613, 9456.621735130793, 9495.097965693249, 9588.904110958802, 9789.118979291898, 12734.490620375082, 12818.372233692256, 12942.029347798765, 13087.083904126619, 13293.468261269827], "value": 10195.244699528967, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1413.3074793351257, 1422.1609250542178, 1442.105894345506, 1443.0836418874012, 1484.903481273717, 11498.42507874606, 11784.882151178486, 12006.339651319175, 12015.639530814089, 12068.336241506713, 12229.0, 12312.81530777039, 12349.567765128222, 12413.193142445734, 12453.252804831716, 2436.8903399347073, 2471.8146139039554, 2473.5300292944285, 2474.4927289905527, 2491.028498885436, 2391.689080419543, 2419.1653879411665, 2422.551827911842, 2423.1155628195756, 2425.1754403502805, 2302.102180149743, 2354.2701762453694, 2355.422921384263, 2365.053978408642, 2366.7988221001237, 2272.4546108933737, 2294.552562250362, 2298.425393651587, 2301.5166814968875, 2304.2741536415974, 2275.5107651854933, 2283.6917016202765, 2284.1434462076722, 2285.748567657556, 2376.79797217235, 11590.884091159065, 11602.825957610643, 11624.302541847432, 11717.29696218221, 11721.824172637418, 6156.722947467375, 6317.399847014526, 6339.334369891188, 6359.618422894595, 6372.490200783926, 3777.1879046004965, 3918.666913312372, 3969.3053715599945, 3979.7015223858325, 3991.042149884036, 1311.960641180766, 1332.473672899209, 1338.1770211320065, 1340.4825737265446, 1348.0900392235203, 17161.14194290293, 17318.913405433017, 17341.306347746075, 17584.12079396025, 18284.360047398277, 5287.70917599528, 5390.568754499631, 5490.780368785204, 5506.91739623906, 5553.222548843084, 13084.738305233843, 13105.803412948813, 13123.540676076482, 13150.27673477968, 13174.407151678197, 6333.873322533524, 6449.838754031093, 6477.287498375175, 6484.0, 6493.253275873335, 6059.666718330534, 6075.422834830684, 6076.635401875901, 6087.634741915499, 6109.389061093855, 4240.766757828287, 4360.062586543845, 4385.934210986838, 4415.0, 4437.933430998538, 1178.3283528388736, 1222.4865556466304, 1225.841579707186, 1231.907606929466, 1233.3709807997986, 843.7089204224533, 879.3800370738614, 892.5492626223715, 903.0969030969031, 934.2992755433424, 6715.899261511081, 6728.629925354153, 6730.562513436611, 6754.45964322853, 6793.966030169818, 598.9131575921467, 604.6704546022428, 604.9485793707496, 609.0498821837947, 614.5544480251871, 4097.2010457961005, 4112.074783173822, 4115.36211887158, 4164.104717485755, 4283.721558098714, 14954.027988180733, 15421.228938553028, 15676.372945082298, 15818.525444236691, 15829.841701582836, 14952.850471495363, 15688.0, 15792.60518487047, 15957.680846383008, 16024.679506409806, 9139.0, 9391.389559678599, 9408.95295523518, 9554.140127388568, 9666.95166524163, 7125.893111603434, 7231.63841807897, 7432.3310902019075, 7479.551226926402, 7752.108507521707, 14285.28573571338, 14516.564503064925, 14560.271986400427, 14895.776563351776, 14916.0, 14636.780448293497, 14668.77996830027, 14728.042677225945, 14897.47858824936, 15134.318955646802, 9834.754131146492, 9907.950460247652, 9913.30606857513, 9979.0, 9992.901490687038, 10910.61812836547, 11025.889741102807, 11097.278676885977, 11099.889001109885, 11111.666650000512, 9389.201917837061, 9456.810863782823, 9462.195713364441, 9516.85724714116, 9662.17871480932, 9356.95321523388, 9421.340506164503, 9481.0, 9624.133827955518, 9715.0, 7794.674905266232, 7855.0, 7958.84082318362, 7965.044194696674, 7970.40221983342, 6034.758609655564, 6078.969605151946, 6104.847378815565, 6164.6917654118015, 6312.210973628296, 6127.3259941407305, 6160.537959653134, 6279.434850863444, 6323.905141422791, 6451.290358060516], "value": 5420.672931708139, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.5798190063327, 376.67417683703604, 380.2509057157399, 390.9257241124186, 396.50634959475457, 6017.157597936292, 6199.256089269288, 6227.9065814012765, 6234.407731265523, 6258.092576576394, 5971.611845230057, 6055.5761096723245, 6087.0, 6119.684267882416, 6125.387461253872, 4757.0723708876785, 4766.880827979294, 4779.852835319516, 4780.09178256132, 4791.425028996526, 4675.88310292242, 4744.383230180089, 4764.642651801111, 4800.711957282557, 4808.326834243208, 4754.072955773626, 4771.713697178163, 4779.808807647707, 4790.712557246559, 4793.3768610080815, 4754.263089221159, 4767.498238055002, 4793.976030119845, 4803.903921921542, 4804.855854324376, 4228.788560571959, 4282.293421585435, 4309.84915527955, 4319.33050377192, 4322.113966636864, 5987.461128498412, 6007.249093863267, 6007.7596896124105, 6009.519238460956, 6034.185384973016, 5552.666839989573, 5596.4403559644115, 5599.832005039814, 5668.858278543028, 5678.346990096151, 6482.902756458657, 6485.643289619069, 6485.70814313357, 6496.440854194959, 6549.214094308713, 4825.372701548811, 4825.686330388514, 4827.9034419311765, 4840.854774356775, 4846.733429661367, 6701.564398314094, 6822.351876571718, 6850.869606514919, 6853.623050732208, 6867.965660171667, 4966.553010229097, 4978.701277923336, 4986.376702912136, 4989.176785830297, 4990.50094990498, 4887.120318342732, 5026.798928042837, 5028.2457631354855, 5047.268146118792, 5062.417821950449, 5600.131979543177, 5606.635568688022, 5657.830265092054, 5658.717064146858, 5666.631668941505, 6491.058796474579, 6510.934890651033, 6527.5757075789925, 6539.280679125292, 6582.210134783857, 1718.613312004789, 1740.3299729604194, 1750.0812073661175, 1755.1136675978548, 1775.1390575571097, 1207.7946749052683, 1242.316725800806, 1243.4031664800946, 1262.3751243134707, 1263.1347526944073, 6213.502919766408, 6216.347283535254, 6227.19046523949, 6237.844053898689, 6246.6876656167005, 6547.410733034049, 6621.768238111643, 6630.939049752016, 6650.546551827455, 6656.600603963778, 6138.294096178907, 6148.9692551537855, 6186.783462578788, 6187.02015355082, 6203.751849926042, 3494.1963348430004, 3502.6322236165347, 3546.3971124908826, 3561.893143205708, 3570.2680950405106, 6667.49993750461, 6745.527813053137, 6828.658567071627, 6844.953995471968, 6908.480134370531, 6687.230968438692, 6759.188897332351, 6798.558093723892, 6813.591184528944, 6836.726530938806, 6819.556728812611, 6848.1097457330225, 6858.622775747282, 6864.141982252218, 6876.862462750717, 6497.967510162419, 6623.437007854386, 6660.800175994728, 6663.200415950117, 6676.83307917306, 6569.441597464078, 6603.570767900071, 6614.371634694697, 6615.0, 6622.0, 6861.210960739579, 6863.450923925974, 6966.5471744336455, 6976.767434420936, 6991.370776630128, 4526.705764125321, 4548.613367863769, 4567.406237189144, 4595.954040459686, 4605.263157894721, 6705.161854768154, 6716.227633822173, 6718.865622687616, 6729.932700672931, 6773.525853190229, 6278.780242691484, 6450.580712253689, 6504.73981040772, 6507.902381464187, 6595.736170553124, 6451.612903225821, 6456.9354306456335, 6488.896887529037, 6493.837654058686, 6511.609303441809, 6194.2126043281605, 6420.967895160495, 6478.870422591616, 6493.383128602775, 6504.349565043647, 6483.319251478527, 6508.934910651023, 6516.804495865132, 6523.075692670579, 6539.43053667126, 6053.364396738279, 6112.266528016667, 6167.167432396748, 6245.219347581552, 6269.435750782452], "value": 4987.6295906169, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [844.2865778417236, 856.9828603427935, 859.0679113162219, 865.3164000439652, 879.3404946290283, 15031.0, 15592.142432166254, 17456.91271543642, 17680.204390802395, 17755.822441775577, 17886.46340609784, 18373.908130459327, 18421.35525256616, 18459.53851153722, 18501.259949602, 962.6823148361024, 1030.0986636692894, 1031.5976769060073, 1037.6420135053395, 1039.6880935719291, 1029.9227557933148, 1036.4972988100765, 1037.8443233514959, 1037.9896201037968, 1040.2977989856854, 1066.727984363986, 1070.3631339353071, 1070.9518071686794, 1081.643057790927, 1086.2884810449168, 1069.8609180806484, 1073.7691396349744, 1076.8061748885198, 1077.06833588945, 1078.1859695929563, 788.2511613966698, 789.1989630525022, 790.8339248757768, 790.9485883417559, 791.3194652598761, 15687.921560392238, 15745.527634170992, 15796.447124350592, 16470.67058658832, 18067.186976586087, 18350.816491835045, 18570.0, 18699.252029918785, 18918.527036824053, 18961.0, 14846.0, 14863.554093377108, 14887.255637218204, 14919.0, 14947.177905215209, 3399.3371292597953, 3488.0, 3511.262634846685, 3513.0690367052753, 3515.0157955772424, 97980.0, 98873.0112698871, 99299.0, 100012.49993749984, 101280.0, 14011.159330440003, 14227.573172804832, 14233.928830355782, 14337.713245735027, 14341.713165736626, 27583.86208068987, 28232.71767282342, 28297.292567685974, 28377.0, 28388.290292742848, 8274.172582741678, 8326.333893288522, 8392.538410387488, 8538.957305213435, 8601.655933762704, 3899.902502437462, 3938.8030598469963, 3959.267535505883, 3982.5420076691553, 3989.880303590897, 4382.7290085875375, 4444.266695995125, 4447.911041779146, 4470.7764611769935, 4494.550544945545, 889.6352495476823, 904.9095090490898, 904.9185573298435, 905.0949050949051, 910.41733290694, 606.9302030266488, 644.2816259870211, 667.9899801502982, 693.5110746923407, 693.7051753004953, 11871.821922671166, 13191.81273685373, 13242.20546767197, 13700.588982330546, 13754.93122534381, 716.4769718105708, 727.9708811647581, 742.2392048150689, 742.4431676242818, 749.0187853911393, 5528.806491772769, 5601.691906945076, 5699.487046165782, 5709.486146246774, 5847.853803654943, 108788.45605772079, 110552.0, 110738.0, 110872.44563777129, 111028.0, 85674.0, 87731.0, 94048.0, 94567.0, 94723.0, 71597.71583739368, 73918.26081739114, 74862.25137748553, 75987.62006190044, 78045.75633949383, 11267.323960562393, 11411.771764564495, 11498.655040348804, 11893.583724569598, 12336.691582710504, 34757.99999999899, 34969.65030349664, 35575.46636800502, 35590.64409355873, 36456.817715912315, 45278.320825188304, 45962.77018614885, 46078.769606151756, 46420.0, 47165.52834471749, 17067.40264090751, 17176.82823171752, 17192.398266060627, 17249.48251552405, 17535.824641753417, 16333.836661633706, 19497.415077547696, 19695.507612309233, 21113.683294750284, 21191.470213244174, 19042.23831046798, 19100.42698718985, 19133.521661958563, 19296.32462863793, 19567.510812229808, 18902.243910243986, 19165.425037248348, 19168.0, 19210.135543900837, 19421.4173574793, 16903.915480422518, 17004.829951700325, 17088.487345379657, 17385.739213911547, 17444.651106978043, 11933.52265909354, 12122.452443108847, 12354.629361119181, 12370.257784532956, 12723.300218488072, 12845.807312890502, 13513.729725405634, 13720.382582783599, 13779.793303100661, 13837.131987181601], "value": 8581.662958266623, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1498.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 111.0, 109.0, 109.0, 110.0, 109.0, 110.0, 111.0, 112.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 122.0, 117.0, 163.0, 117.0, 119.0, 121.0, 119.0, 142.0, 125.0], "value": 129.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 165.0, 165.0, 162.0, 163.0, 166.0, 164.0, 167.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 77.0, 96.0, 73.0, 74.0, 74.0, 77.0, 90.0, 73.0], "value": 78.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 105.0, 81.0, 82.0, 83.0, 96.0, 82.0, 82.0, 104.0], "value": 88.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 114.0, 113.0, 114.0, 115.0, 114.0, 114.0, 113.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 152.0, 150.0, 147.0, 148.0, 149.0, 148.0, 150.0, 147.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 94.0, 94.0, 95.0, 99.0, 95.0, 94.0, 94.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 49.0, 49.0, 52.0, 52.0, 49.0, 50.0, 49.0, 47.0, 49.0], "value": 49.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 57.0, 56.0, 63.0, 56.0, 56.0, 57.0, 56.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 99.0, 84.0, 84.0, 84.0, 84.0, 85.0, 114.0, 84.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 128.0, 130.0, 126.0, 130.0, 138.0, 122.0, 127.0, 122.0, 127.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 180.0, 181.0, 179.0, 188.0, 177.0, 186.0, 185.0, 186.0, 195.0], "value": 183.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 68.0, 69.0, 62.0, 66.0, 67.0, 63.0, 63.0, 65.0], "value": 65.3, "unit": "score"}]}]} 09:12:37 INFO - Return code: 0 09:12:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:12:37 INFO - # TBPL SUCCESS # 09:12:37 INFO - Running post-action listener: _resource_record_post_action 09:12:37 INFO - [mozharness: 2017-05-26 16:12:37.113928Z] Finished run-tests step (success) 09:12:37 INFO - Running post-run listener: _resource_record_post_run 09:12:37 INFO - Total resource usage - Wall time: 1247s; CPU: 13.0%; Read bytes: 425984; Write bytes: 432123904; Read time: 48; Write time: 290688 09:12:37 INFO - TinderboxPrint: CPU usage
12.6% 09:12:37 INFO - TinderboxPrint: I/O read bytes / time
425,984 / 48 09:12:37 INFO - TinderboxPrint: I/O write bytes / time
432,123,904 / 290,688 09:12:37 INFO - TinderboxPrint: CPU idle
8,696.9 (87.4%) 09:12:37 INFO - TinderboxPrint: CPU user
1,203.8 (12.1%) 09:12:37 INFO - TinderboxPrint: Swap in / out
0 / 0 09:12:37 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118042624; Read time: 0; Write time: 93628 09:12:37 INFO - run-tests - Wall time: 1231s; CPU: 13.0%; Read bytes: 421888; Write bytes: 314081280; Read time: 32; Write time: 197060 09:12:37 INFO - Running post-run listener: _upload_blobber_files 09:12:37 INFO - Blob upload gear active. 09:12:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:12:37 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 09:12:37 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'] 09:12:37 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 09:12:38 INFO - (blobuploader) - INFO - Open directory for files ... 09:12:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:12:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:12:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:39 INFO - (blobuploader) - INFO - Done attempting. 09:12:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:12:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:12:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:40 INFO - (blobuploader) - INFO - Done attempting. 09:12:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:12:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:12:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:41 INFO - (blobuploader) - INFO - Done attempting. 09:12:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:12:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:12:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:47 INFO - (blobuploader) - INFO - Done attempting. 09:12:47 INFO - (blobuploader) - INFO - Iteration through files over. 09:12:47 INFO - Return code: 0 09:12:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:12:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:12:47 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d024ca693a719624a0b64c03f700fd30400e3421844e4393ddc2a6bdce876e40427185190ba1affaf39718f7de566b96cd19e5d2e648fd1932033585db1acbb3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b99d5f13c2f8847169e12062fa90ca880540b69a526430abd693345f722a9d9ab698aee6de9a6d94608fe8f6aa2d6b9ec3069243e30fe049e5939ee983533e36", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51bc66be4cc9f2228026d461eaae85fb3a4d5454bd9e8965b67db3bb4c9bc8ff376a667090f802d9af0dc4533e2289c966078681a0eefbe0043f9f6a118c183c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/339b1f3eda71e2f461dd510b7d444abc435ccb6a86b0fb8a44c3a056b6b1a98a8198aea52cecba958a68291864ef0e0a0f5c06537f7052548c4482f375295026"} 09:12:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:12:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:12:47 INFO - Contents: 09:12:47 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d024ca693a719624a0b64c03f700fd30400e3421844e4393ddc2a6bdce876e40427185190ba1affaf39718f7de566b96cd19e5d2e648fd1932033585db1acbb3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b99d5f13c2f8847169e12062fa90ca880540b69a526430abd693345f722a9d9ab698aee6de9a6d94608fe8f6aa2d6b9ec3069243e30fe049e5939ee983533e36", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51bc66be4cc9f2228026d461eaae85fb3a4d5454bd9e8965b67db3bb4c9bc8ff376a667090f802d9af0dc4533e2289c966078681a0eefbe0043f9f6a118c183c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/339b1f3eda71e2f461dd510b7d444abc435ccb6a86b0fb8a44c3a056b6b1a98a8198aea52cecba958a68291864ef0e0a0f5c06537f7052548c4482f375295026"} 09:12:47 INFO - Running post-run listener: copy_logs_to_upload_dir 09:12:47 INFO - Copying logs to upload dir... 09:12:47 INFO - mkdir: /builds/slave/test/build/upload/logs 09:12:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1310.791971 ========= master_lag: -0.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2017-05-26 09:12:47.644235) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-26 09:12:47.651388) ========= 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=7de08804244eb36560b44971000001c3-1495813244.483694-797584003 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/d024ca693a719624a0b64c03f700fd30400e3421844e4393ddc2a6bdce876e40427185190ba1affaf39718f7de566b96cd19e5d2e648fd1932033585db1acbb3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b99d5f13c2f8847169e12062fa90ca880540b69a526430abd693345f722a9d9ab698aee6de9a6d94608fe8f6aa2d6b9ec3069243e30fe049e5939ee983533e36", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51bc66be4cc9f2228026d461eaae85fb3a4d5454bd9e8965b67db3bb4c9bc8ff376a667090f802d9af0dc4533e2289c966078681a0eefbe0043f9f6a118c183c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/339b1f3eda71e2f461dd510b7d444abc435ccb6a86b0fb8a44c3a056b6b1a98a8198aea52cecba958a68291864ef0e0a0f5c06537f7052548c4482f375295026"} build_url:https://queue.taskcluster.net/v1/task/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011147 build_url: 'https://queue.taskcluster.net/v1/task/VmqVCM8nQCKSf9GZip4OMQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d024ca693a719624a0b64c03f700fd30400e3421844e4393ddc2a6bdce876e40427185190ba1affaf39718f7de566b96cd19e5d2e648fd1932033585db1acbb3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b99d5f13c2f8847169e12062fa90ca880540b69a526430abd693345f722a9d9ab698aee6de9a6d94608fe8f6aa2d6b9ec3069243e30fe049e5939ee983533e36", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51bc66be4cc9f2228026d461eaae85fb3a4d5454bd9e8965b67db3bb4c9bc8ff376a667090f802d9af0dc4533e2289c966078681a0eefbe0043f9f6a118c183c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/339b1f3eda71e2f461dd510b7d444abc435ccb6a86b0fb8a44c3a056b6b1a98a8198aea52cecba958a68291864ef0e0a0f5c06537f7052548c4482f375295026"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-26 09:12:47.679054) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 09:12:47.679437) ========= 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=7de08804244eb36560b44971000001c3-1495813244.483694-797584003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004337 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 09:12:47.763091) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-26 09:12:47.763441) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-26 09:12:47.763785) ========= ========= Total master_lag: 0.00 =========