builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-089 starttime: 1495645946.94 results: success (0) revision: 37d777d872002597198405f22eefa9199e5103af ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-24 10:12:26.944253) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-24 10:12:26.944708) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-24 10:12:26.945037) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-24 10:12:26.962055) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 10:12:26.962352) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-24 10:12:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2017-05-24 10:12:27 (42.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115095 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 10:12:27.093916) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 10:12:27.094294) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023035 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 10:12:27.154260) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-24 10:12:27.154640) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 37d777d872002597198405f22eefa9199e5103af --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 37d777d872002597198405f22eefa9199e5103af --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=8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-24 10:12:27,645 truncating revision to first 12 chars 2017-05-24 10:12:27,646 Setting DEBUG logging. 2017-05-24 10:12:27,646 attempt 1/10 2017-05-24 10:12:27,646 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/37d777d87200?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-24 10:12:28,282 unpacking tar archive at: mozilla-central-37d777d87200/testing/mozharness/ program finished with exit code 0 elapsedTime=0.989541 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-24 10:12:28.156900) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-24 10:12:28.157262) ========= script_repo_revision: 37d777d872002597198405f22eefa9199e5103af ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-24 10:12:28.157707) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-24 10:12:28.158004) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-24 10:12:28.169722) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2017-05-24 10:12:28.170029) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:12:28 INFO - MultiFileLogger online at 20170524 10:12:28 in /builds/slave/test 10:12:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:12:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:12:28 INFO - {'append_to_log': False, 10:12:28 INFO - 'base_work_dir': '/builds/slave/test', 10:12:28 INFO - 'blob_upload_branch': 'Firefox', 10:12:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:12:28 INFO - 'branch': 'Firefox', 10:12:28 INFO - 'buildbot_json_path': 'buildprops.json', 10:12:28 INFO - 'config_files': ('talos/linux_config.py',), 10:12:28 INFO - 'default_actions': ('clobber', 10:12:28 INFO - 'read-buildbot-config', 10:12:28 INFO - 'download-and-extract', 10:12:28 INFO - 'populate-webroot', 10:12:28 INFO - 'create-virtualenv', 10:12:28 INFO - 'install', 10:12:28 INFO - 'run-tests'), 10:12:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:12:28 INFO - 'download_minidump_stackwalk': True, 10:12:28 INFO - 'download_symbols': 'ondemand', 10:12:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:12:28 INFO - 'tooltool.py': '/tools/tooltool.py', 10:12:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:12:28 INFO - '/tools/misc-python/virtualenv.py')}, 10:12:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:12:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:12:28 INFO - 'gecko_profile': False, 10:12:28 INFO - 'gecko_profile_interval': 0, 10:12:28 INFO - 'installer_path': 'installer.exe', 10:12:28 INFO - 'log_level': 'info', 10:12:28 INFO - 'log_name': 'talos', 10:12:28 INFO - 'log_to_console': True, 10:12:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:12:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:12:28 INFO - 'opt_config_files': (), 10:12:28 INFO - 'pip_index': False, 10:12:28 INFO - 'suite': 'dromaeojs-e10s', 10:12:28 INFO - 'system_bits': '32', 10:12:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:12:28 INFO - 'title': 'talos-linux64-ix-089', 10:12:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:12:28 INFO - 'use_talos_json': True, 10:12:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:12:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:12:28 INFO - 'work_dir': 'build'} 10:12:28 INFO - [mozharness: 2017-05-24 17:12:28.764940Z] Running clobber step. 10:12:28 INFO - Running pre-action listener: _resource_record_pre_action 10:12:28 INFO - Running main action method: clobber 10:12:28 INFO - rmtree: /builds/slave/test/build 10:12:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:12:30 INFO - Running post-action listener: _resource_record_post_action 10:12:30 INFO - [mozharness: 2017-05-24 17:12:30.199807Z] Finished clobber step (success) 10:12:30 INFO - [mozharness: 2017-05-24 17:12:30.199907Z] Running read-buildbot-config step. 10:12:30 INFO - Running pre-action listener: _resource_record_pre_action 10:12:30 INFO - Running main action method: read_buildbot_config 10:12:30 INFO - Using buildbot properties: 10:12:30 INFO - { 10:12:30 INFO - "project": "", 10:12:30 INFO - "product": "firefox", 10:12:30 INFO - "who": "bhearsum@mozilla.com", 10:12:30 INFO - "installer_path": "public/build/target.tar.bz2", 10:12:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 10:12:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 10:12:30 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 10:12:30 INFO - "stage_platform": "linux64-stylosequential", 10:12:30 INFO - "basedir": "/builds/slave/test", 10:12:30 INFO - "buildnumber": 16, 10:12:30 INFO - "platform": "ubuntu64_hw_styloseq", 10:12:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:12:30 INFO - "slavebuilddir": "test", 10:12:30 INFO - "taskId": "KRoI2l3CQP-1UzN1mC_KaQ", 10:12:30 INFO - "branch": "mozilla-central", 10:12:30 INFO - "script_repo_revision": "production", 10:12:30 INFO - "revision": "37d777d872002597198405f22eefa9199e5103af", 10:12:30 INFO - "slavename": "talos-linux64-ix-089", 10:12:30 INFO - "repo_path": "mozilla-central" 10:12:30 INFO - } 10:12:30 INFO - Finding installer, test and symbols from parent task. 10:12:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KRoI2l3CQP-1UzN1mC_KaQ'}, attempt #1 10:12:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KRoI2l3CQP-1UzN1mC_KaQ'}, attempt #1 10:12:31 INFO - Task dependencies: Pmdkm0SbSRSzyDU5h1C7HQ 10:12:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ'}, attempt #1 10:12:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/target.tar.bz2 10:12:31 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/test_packages.json 10:12:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/target.crashreporter-symbols.zip 10:12:31 INFO - Running post-action listener: _resource_record_post_action 10:12:31 INFO - [mozharness: 2017-05-24 17:12:31.610870Z] Finished read-buildbot-config step (success) 10:12:31 INFO - [mozharness: 2017-05-24 17:12:31.611088Z] Running download-and-extract step. 10:12:31 INFO - Running pre-action listener: _resource_record_pre_action 10:12:31 INFO - Running main action method: download_and_extract 10:12:31 INFO - mkdir: /builds/slave/test/build/tests 10:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:31 INFO - trying https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/target.test_packages.json 10:12:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:12:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:12:32 INFO - Downloaded 986 bytes. 10:12:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:12:32 INFO - Using the following test package requirements: 10:12:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:12:32 INFO - u'common': [u'target.common.tests.zip'], 10:12:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:12:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:12:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:12:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:12:32 INFO - u'mozbase': [u'target.common.tests.zip'], 10:12:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:12:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:12:32 INFO - u'web-platform': [u'target.common.tests.zip', 10:12:32 INFO - u'target.web-platform.tests.zip'], 10:12:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:12:32 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:12:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/target.common.tests.zip 10:12:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:12:32 INFO - Fetch https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/target.common.tests.zip into memory 10:12:34 INFO - Content-Length response header: 63523790 10:12:34 INFO - Bytes received: 63523790 10:12:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:12:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/target.common.tests.zip 10:12:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:12:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/target.common.tests.zip into memory 10:12:46 INFO - Content-Length response header: 63523790 10:12:46 INFO - Bytes received: 63523790 10:12:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/target.talos.tests.zip 10:12:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:12:57 INFO - Fetch https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/target.talos.tests.zip into memory 10:12:58 INFO - Content-Length response header: 14411859 10:12:58 INFO - Bytes received: 14411859 10:12: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')]} 10:12:59 INFO - trying https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/target.tar.bz2 10:12:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:12:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:13:00 INFO - Downloaded 56537374 bytes. 10:13:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/target.tar.bz2 10:13:00 INFO - mkdir: /builds/slave/test/properties 10:13:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:13:00 INFO - Writing to file /builds/slave/test/properties/build_url 10:13:00 INFO - Contents: 10:13:00 INFO - build_url:https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/target.tar.bz2 10:13:00 INFO - Running post-action listener: _resource_record_post_action 10:13:00 INFO - Running post-action listener: set_extra_try_arguments 10:13:00 INFO - [mozharness: 2017-05-24 17:13:00.865665Z] Finished download-and-extract step (success) 10:13:00 INFO - [mozharness: 2017-05-24 17:13:00.865827Z] Running populate-webroot step. 10:13:00 INFO - Running pre-action listener: _resource_record_pre_action 10:13:00 INFO - Running main action method: populate_webroot 10:13:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:13:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:13:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:13:00 INFO - '--tppagecycles', 10:13:00 INFO - '7'], 10:13:00 INFO - 'tests': ['tsvgm']}}, 10:13:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:13:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:13:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:13:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:13:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:13:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:13:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:13:00 INFO - 'talos_options': ['--disable-e10s'], 10:13:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:13:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:13:00 INFO - 'talos_options': ['--disable-e10s'], 10:13:00 INFO - 'tests': ['damp', 'tps']}, 10:13:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:13:00 INFO - 'tests': ['damp', 'tps']}, 10:13:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:13:00 INFO - 'tests': ['dromaeo_dom']}, 10:13:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:13:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:13:00 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:13:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:13:00 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:13:00 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:13:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:13:00 INFO - 'tests': ['a11yr', 10:13:00 INFO - 'ts_paint', 10:13:00 INFO - 'tpaint', 10:13:00 INFO - 'sessionrestore', 10:13:00 INFO - 'sessionrestore_no_auto_restore', 10:13:00 INFO - 'tabpaint']}, 10:13:00 INFO - 'other-e10s': {'tests': ['a11yr', 10:13:00 INFO - 'ts_paint', 10:13:00 INFO - 'tpaint', 10:13:00 INFO - 'sessionrestore', 10:13:00 INFO - 'sessionrestore_no_auto_restore', 10:13:00 INFO - 'tabpaint']}, 10:13:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:13:00 INFO - 'ts_paint', 10:13:00 INFO - 'tpaint', 10:13:00 INFO - 'sessionrestore', 10:13:00 INFO - 'sessionrestore_no_auto_restore', 10:13:00 INFO - 'tabpaint']}, 10:13:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:13:00 INFO - 'ts_paint', 10:13:00 INFO - 'tpaint', 10:13:00 INFO - 'sessionrestore', 10:13:00 INFO - 'sessionrestore_no_auto_restore', 10:13:00 INFO - 'tabpaint']}, 10:13:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:13:00 INFO - 'tests': ['a11yr', 10:13:00 INFO - 'ts_paint', 10:13:00 INFO - 'tpaint', 10:13:00 INFO - 'sessionrestore', 10:13:00 INFO - 'sessionrestore_no_auto_restore', 10:13:00 INFO - 'tabpaint']}, 10:13:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:13:00 INFO - 'tests': ['a11yr', 10:13:00 INFO - 'ts_paint', 10:13:00 INFO - 'tpaint', 10:13:00 INFO - 'sessionrestore', 10:13:00 INFO - 'sessionrestore_no_auto_restore', 10:13:00 INFO - 'tabpaint']}, 10:13:00 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 10:13:00 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 10:13:00 INFO - 'bloom_basic_ref']}, 10:13:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:13:00 INFO - 'tests': ['tsvgx', 10:13:00 INFO - 'tsvgr_opacity', 10:13:00 INFO - 'tart', 10:13:00 INFO - 'tscrollx', 10:13:00 INFO - 'cart', 10:13:00 INFO - 'tsvg_static']}, 10:13:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:13:00 INFO - 'tsvgr_opacity', 10:13:00 INFO - 'tart', 10:13:00 INFO - 'tscrollx', 10:13:00 INFO - 'cart', 10:13:00 INFO - 'tsvg_static']}, 10:13:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:13:00 INFO - 'talos_options': ['--disable-e10s'], 10:13:00 INFO - 'tests': ['tp5o']}, 10:13:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:13:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:13:00 INFO - 'talos_options': ['--disable-e10s', 10:13:00 INFO - '--xperf_path', 10:13:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:00 INFO - 'tests': ['tp5n']}, 10:13:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:13:00 INFO - 'talos_options': ['--xperf_path', 10:13:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:00 INFO - 'tests': ['tp5n']}}, 10:13:00 INFO - 'talos.zip': {'path': '', 10:13:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:13:00 INFO - Running post-action listener: _resource_record_post_action 10:13:00 INFO - [mozharness: 2017-05-24 17:13:00.882983Z] Finished populate-webroot step (success) 10:13:00 INFO - [mozharness: 2017-05-24 17:13:00.883072Z] Running create-virtualenv step. 10:13:00 INFO - Running pre-action listener: _resource_record_pre_action 10:13:00 INFO - Running main action method: create_virtualenv 10:13:00 INFO - Creating virtualenv /builds/slave/test/build/venv 10:13:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:13:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:13:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:13:00 INFO - Using real prefix '/usr' 10:13:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:13:01 INFO - Installing distribute.............................................................................................................................................................................................done. 10:13:03 INFO - Installing pip.................done. 10:13:03 INFO - Return code: 0 10:13:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:13:03 INFO - Reading from file tmpfile_stdout 10:13:03 INFO - Output received: 10:13:03 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:13:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2362a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25085c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25057a0>, '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 0x25066a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2506b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:13:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:13:03 INFO - Using env: {'DISPLAY': ':0', 10:13:03 INFO - 'HOME': '/home/cltbld', 10:13:03 INFO - 'LANG': 'en_US.UTF-8', 10:13:03 INFO - 'LANGUAGE': 'en_US:en', 10:13:03 INFO - 'LOGNAME': 'cltbld', 10:13:03 INFO - 'MAIL': '/var/mail/cltbld', 10:13:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:03 INFO - 'MOZ_NO_REMOTE': '1', 10:13:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:03 INFO - 'NO_EM_RESTART': '1', 10:13:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:03 INFO - 'PWD': '/builds/slave/test', 10:13:03 INFO - 'SHELL': '/bin/bash', 10:13:03 INFO - 'SHLVL': '1', 10:13:03 INFO - 'TERM': 'linux', 10:13:03 INFO - 'TMOUT': '86400', 10:13:03 INFO - 'USER': 'cltbld', 10:13:03 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918', 10:13:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:03 INFO - '_': '/tools/buildbot/bin/python'} 10:13:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:13:03 INFO - Cleaning up... 10:13:03 INFO - Return code: 0 10:13:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2362a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25085c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25057a0>, '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 0x25066a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2506b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:13:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:13:03 INFO - Using env: {'DISPLAY': ':0', 10:13:03 INFO - 'HOME': '/home/cltbld', 10:13:03 INFO - 'LANG': 'en_US.UTF-8', 10:13:03 INFO - 'LANGUAGE': 'en_US:en', 10:13:03 INFO - 'LOGNAME': 'cltbld', 10:13:03 INFO - 'MAIL': '/var/mail/cltbld', 10:13:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:03 INFO - 'MOZ_NO_REMOTE': '1', 10:13:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:03 INFO - 'NO_EM_RESTART': '1', 10:13:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:03 INFO - 'PWD': '/builds/slave/test', 10:13:03 INFO - 'SHELL': '/bin/bash', 10:13:03 INFO - 'SHLVL': '1', 10:13:03 INFO - 'TERM': 'linux', 10:13:03 INFO - 'TMOUT': '86400', 10:13:03 INFO - 'USER': 'cltbld', 10:13:03 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918', 10:13:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:03 INFO - '_': '/tools/buildbot/bin/python'} 10:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:04 INFO - Downloading/unpacking psutil>=3.1.1 10:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:13:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:13:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:13:05 INFO - Installing collected packages: psutil 10:13:05 INFO - Running setup.py install for psutil 10:13:05 INFO - building 'psutil._psutil_linux' extension 10:13:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:13:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:13:05 INFO - building 'psutil._psutil_posix' extension 10:13:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:13:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:13:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:13:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:13:05 INFO - Successfully installed psutil 10:13:05 INFO - Cleaning up... 10:13:05 INFO - Return code: 0 10:13:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2362a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25085c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25057a0>, '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 0x25066a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2506b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:13:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:13:05 INFO - Using env: {'DISPLAY': ':0', 10:13:05 INFO - 'HOME': '/home/cltbld', 10:13:05 INFO - 'LANG': 'en_US.UTF-8', 10:13:05 INFO - 'LANGUAGE': 'en_US:en', 10:13:05 INFO - 'LOGNAME': 'cltbld', 10:13:05 INFO - 'MAIL': '/var/mail/cltbld', 10:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:05 INFO - 'MOZ_NO_REMOTE': '1', 10:13:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:05 INFO - 'NO_EM_RESTART': '1', 10:13:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:05 INFO - 'PWD': '/builds/slave/test', 10:13:05 INFO - 'SHELL': '/bin/bash', 10:13:05 INFO - 'SHLVL': '1', 10:13:05 INFO - 'TERM': 'linux', 10:13:05 INFO - 'TMOUT': '86400', 10:13:05 INFO - 'USER': 'cltbld', 10:13:05 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918', 10:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:05 INFO - '_': '/tools/buildbot/bin/python'} 10:13:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:13:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:13:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:13:07 INFO - Installing collected packages: mozsystemmonitor 10:13:07 INFO - Running setup.py install for mozsystemmonitor 10:13:07 INFO - Successfully installed mozsystemmonitor 10:13:07 INFO - Cleaning up... 10:13:07 INFO - Return code: 0 10:13:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2362a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25085c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25057a0>, '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 0x25066a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2506b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:13:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:13:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:13:07 INFO - Using env: {'DISPLAY': ':0', 10:13:07 INFO - 'HOME': '/home/cltbld', 10:13:07 INFO - 'LANG': 'en_US.UTF-8', 10:13:07 INFO - 'LANGUAGE': 'en_US:en', 10:13:07 INFO - 'LOGNAME': 'cltbld', 10:13:07 INFO - 'MAIL': '/var/mail/cltbld', 10:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:07 INFO - 'MOZ_NO_REMOTE': '1', 10:13:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:07 INFO - 'NO_EM_RESTART': '1', 10:13:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:07 INFO - 'PWD': '/builds/slave/test', 10:13:07 INFO - 'SHELL': '/bin/bash', 10:13:07 INFO - 'SHLVL': '1', 10:13:07 INFO - 'TERM': 'linux', 10:13:07 INFO - 'TMOUT': '86400', 10:13:07 INFO - 'USER': 'cltbld', 10:13:07 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918', 10:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:07 INFO - '_': '/tools/buildbot/bin/python'} 10:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:07 INFO - Downloading/unpacking jsonschema==2.5.1 10:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:13:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:08 INFO - Downloading functools32-3.2.3-2.tar.gz 10:13:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:13:08 INFO - warning: no files found matching '*.txt' 10:13:08 INFO - no previously-included directories found matching 'build' 10:13:08 INFO - no previously-included directories found matching 'dist' 10:13:08 INFO - no previously-included directories found matching '.git*' 10:13:08 INFO - Installing collected packages: jsonschema, functools32 10:13:08 INFO - Running setup.py install for functools32 10:13:08 INFO - warning: no files found matching '*.txt' 10:13:08 INFO - no previously-included directories found matching 'build' 10:13:08 INFO - no previously-included directories found matching 'dist' 10:13:08 INFO - no previously-included directories found matching '.git*' 10:13:08 INFO - Successfully installed jsonschema functools32 10:13:08 INFO - Cleaning up... 10:13:09 INFO - Return code: 0 10:13:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:09 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 0x21951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2362a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25085c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25057a0>, '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 0x25066a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2506b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:13:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:13:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:13:09 INFO - Using env: {'DISPLAY': ':0', 10:13:09 INFO - 'HOME': '/home/cltbld', 10:13:09 INFO - 'LANG': 'en_US.UTF-8', 10:13:09 INFO - 'LANGUAGE': 'en_US:en', 10:13:09 INFO - 'LOGNAME': 'cltbld', 10:13:09 INFO - 'MAIL': '/var/mail/cltbld', 10:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:09 INFO - 'MOZ_NO_REMOTE': '1', 10:13:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:09 INFO - 'NO_EM_RESTART': '1', 10:13:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:09 INFO - 'PWD': '/builds/slave/test', 10:13:09 INFO - 'SHELL': '/bin/bash', 10:13:09 INFO - 'SHLVL': '1', 10:13:09 INFO - 'TERM': 'linux', 10:13:09 INFO - 'TMOUT': '86400', 10:13:09 INFO - 'USER': 'cltbld', 10:13:09 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918', 10:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:09 INFO - '_': '/tools/buildbot/bin/python'} 10:13:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:13:09 INFO - Cleaning up... 10:13:09 INFO - Return code: 0 10:13:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:09 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 0x21951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2362a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25085c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25057a0>, '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 0x25066a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2506b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:13:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:13:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:13:09 INFO - Using env: {'DISPLAY': ':0', 10:13:09 INFO - 'HOME': '/home/cltbld', 10:13:09 INFO - 'LANG': 'en_US.UTF-8', 10:13:09 INFO - 'LANGUAGE': 'en_US:en', 10:13:09 INFO - 'LOGNAME': 'cltbld', 10:13:09 INFO - 'MAIL': '/var/mail/cltbld', 10:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:09 INFO - 'MOZ_NO_REMOTE': '1', 10:13:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:09 INFO - 'NO_EM_RESTART': '1', 10:13:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:09 INFO - 'PWD': '/builds/slave/test', 10:13:09 INFO - 'SHELL': '/bin/bash', 10:13:09 INFO - 'SHLVL': '1', 10:13:09 INFO - 'TERM': 'linux', 10:13:09 INFO - 'TMOUT': '86400', 10:13:09 INFO - 'USER': 'cltbld', 10:13:09 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918', 10:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:09 INFO - '_': '/tools/buildbot/bin/python'} 10:13:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:09 INFO - Downloading/unpacking blobuploader==1.2.4 10:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:10 INFO - Downloading blobuploader-1.2.4.tar.gz 10:13:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:13:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:13:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:11 INFO - Downloading docopt-0.6.1.tar.gz 10:13:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:13:11 INFO - Installing collected packages: blobuploader, requests, docopt 10:13:11 INFO - Running setup.py install for blobuploader 10:13:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:13:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:13:11 INFO - Running setup.py install for requests 10:13:11 INFO - Running setup.py install for docopt 10:13:11 INFO - Successfully installed blobuploader requests docopt 10:13:11 INFO - Cleaning up... 10:13:11 INFO - Return code: 0 10:13:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:11 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 0x21951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2362a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25085c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25057a0>, '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 0x25066a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2506b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:13:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:13:11 INFO - Using env: {'DISPLAY': ':0', 10:13:11 INFO - 'HOME': '/home/cltbld', 10:13:11 INFO - 'LANG': 'en_US.UTF-8', 10:13:11 INFO - 'LANGUAGE': 'en_US:en', 10:13:11 INFO - 'LOGNAME': 'cltbld', 10:13:11 INFO - 'MAIL': '/var/mail/cltbld', 10:13:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:11 INFO - 'MOZ_NO_REMOTE': '1', 10:13:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:11 INFO - 'NO_EM_RESTART': '1', 10:13:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:11 INFO - 'PWD': '/builds/slave/test', 10:13:11 INFO - 'SHELL': '/bin/bash', 10:13:11 INFO - 'SHLVL': '1', 10:13:11 INFO - 'TERM': 'linux', 10:13:11 INFO - 'TMOUT': '86400', 10:13:11 INFO - 'USER': 'cltbld', 10:13:11 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918', 10:13:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:11 INFO - '_': '/tools/buildbot/bin/python'} 10:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:13:11 INFO - Running setup.py (path:/tmp/pip-N1FufA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:13:12 INFO - Running setup.py (path:/tmp/pip-ZjA6Ad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:13:12 INFO - Running setup.py (path:/tmp/pip-J0sdIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:13:12 INFO - Running setup.py (path:/tmp/pip-uFpe0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:13:12 INFO - Running setup.py (path:/tmp/pip-pWDuc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:13:12 INFO - Running setup.py (path:/tmp/pip-1y2yeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:13:12 INFO - Running setup.py (path:/tmp/pip-cKWP6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:13:12 INFO - Running setup.py (path:/tmp/pip-aci9oH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:13:12 INFO - Running setup.py (path:/tmp/pip-jKA2XJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:13:12 INFO - Running setup.py (path:/tmp/pip-GEyBqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:13:12 INFO - Running setup.py (path:/tmp/pip-HUQAJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:13:12 INFO - Running setup.py (path:/tmp/pip-YlHbCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:13:12 INFO - Running setup.py (path:/tmp/pip-3zTLhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:13:12 INFO - Running setup.py (path:/tmp/pip-Tj1FIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:12 INFO - Running setup.py (path:/tmp/pip-7rx812-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:13:13 INFO - Running setup.py (path:/tmp/pip-KT_G6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:13:13 INFO - Running setup.py (path:/tmp/pip-FragUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:13:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:13:13 INFO - Running setup.py install for manifestparser 10:13:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:13:13 INFO - Running setup.py install for mozcrash 10:13:13 INFO - Running setup.py install for mozdebug 10:13:13 INFO - Running setup.py install for mozdevice 10:13:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:13:13 INFO - Running setup.py install for mozfile 10:13:13 INFO - Running setup.py install for mozhttpd 10:13:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:13:13 INFO - Running setup.py install for mozinfo 10:13:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:13:13 INFO - Running setup.py install for mozInstall 10:13:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:13:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:13:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:13:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:13:13 INFO - Running setup.py install for mozleak 10:13:14 INFO - Running setup.py install for mozlog 10:13:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:13:14 INFO - Running setup.py install for moznetwork 10:13:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:13:14 INFO - Running setup.py install for mozprocess 10:13:14 INFO - Running setup.py install for mozprofile 10:13:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:13:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:13:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:13:14 INFO - Running setup.py install for mozrunner 10:13:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:13:14 INFO - Running setup.py install for mozscreenshot 10:13:14 INFO - Running setup.py install for moztest 10:13:14 INFO - Running setup.py install for mozversion 10:13:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:13:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:13:14 INFO - Cleaning up... 10:13:14 INFO - Return code: 0 10:13:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:14 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 0x21951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2362a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25085c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25057a0>, '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 0x25066a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2506b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:13:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:13:14 INFO - Using env: {'DISPLAY': ':0', 10:13:14 INFO - 'HOME': '/home/cltbld', 10:13:14 INFO - 'LANG': 'en_US.UTF-8', 10:13:14 INFO - 'LANGUAGE': 'en_US:en', 10:13:14 INFO - 'LOGNAME': 'cltbld', 10:13:14 INFO - 'MAIL': '/var/mail/cltbld', 10:13:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:14 INFO - 'MOZ_NO_REMOTE': '1', 10:13:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:14 INFO - 'NO_EM_RESTART': '1', 10:13:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:14 INFO - 'PWD': '/builds/slave/test', 10:13:14 INFO - 'SHELL': '/bin/bash', 10:13:14 INFO - 'SHLVL': '1', 10:13:14 INFO - 'TERM': 'linux', 10:13:14 INFO - 'TMOUT': '86400', 10:13:14 INFO - 'USER': 'cltbld', 10:13:14 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918', 10:13:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:14 INFO - '_': '/tools/buildbot/bin/python'} 10:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:13:15 INFO - Running setup.py (path:/tmp/pip-oERTOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:13:15 INFO - Running setup.py (path:/tmp/pip-B4RIgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:13:15 INFO - Running setup.py (path:/tmp/pip-n48CEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:13:15 INFO - Running setup.py (path:/tmp/pip-4EsR8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:13:15 INFO - Running setup.py (path:/tmp/pip-xPD6GD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:13:15 INFO - Running setup.py (path:/tmp/pip-kXRFUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:13:15 INFO - Running setup.py (path:/tmp/pip-p5DY6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:13:15 INFO - Running setup.py (path:/tmp/pip-c3Gmvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:13:15 INFO - Running setup.py (path:/tmp/pip-MmVZbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:13:15 INFO - Running setup.py (path:/tmp/pip-iXfJNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:13:15 INFO - Running setup.py (path:/tmp/pip-2GIvKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:13:15 INFO - Running setup.py (path:/tmp/pip-2lfiah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:13:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:13:16 INFO - Running setup.py (path:/tmp/pip-9pICLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:13:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:13:16 INFO - Running setup.py (path:/tmp/pip-_D2Bko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:13:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:16 INFO - Running setup.py (path:/tmp/pip-B3Qc0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:13:16 INFO - Running setup.py (path:/tmp/pip-s5rair-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:13:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:13:16 INFO - Running setup.py (path:/tmp/pip-0lXvps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:13:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:13:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:13:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:13:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:13:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:13:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:13:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:17 INFO - Downloading blessings-1.6.tar.gz 10:13:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:13:17 INFO - Installing collected packages: blessings 10:13:17 INFO - Running setup.py install for blessings 10:13:17 INFO - Successfully installed blessings 10:13:17 INFO - Cleaning up... 10:13:17 INFO - Return code: 0 10:13:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:13:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:13:17 INFO - Reading from file tmpfile_stdout 10:13:17 INFO - Current package versions: 10:13:17 INFO - argparse == 1.2.1 10:13:17 INFO - blessings == 1.6 10:13:17 INFO - blobuploader == 1.2.4 10:13:17 INFO - docopt == 0.6.1 10:13:17 INFO - functools32 == 3.2.3-2 10:13:17 INFO - jsonschema == 2.5.1 10:13:17 INFO - manifestparser == 1.1 10:13:17 INFO - mozInstall == 1.12 10:13:17 INFO - mozcrash == 1.0 10:13:17 INFO - mozdebug == 0.1 10:13:17 INFO - mozdevice == 0.50 10:13:17 INFO - mozfile == 1.2 10:13:17 INFO - mozhttpd == 0.7 10:13:17 INFO - mozinfo == 0.9 10:13:17 INFO - mozleak == 0.1 10:13:17 INFO - mozlog == 3.4 10:13:17 INFO - moznetwork == 0.27 10:13:17 INFO - mozprocess == 0.25 10:13:17 INFO - mozprofile == 0.28 10:13:17 INFO - mozrunner == 6.13 10:13:17 INFO - mozscreenshot == 0.1 10:13:17 INFO - mozsystemmonitor == 0.3 10:13:17 INFO - moztest == 0.8 10:13:17 INFO - mozversion == 1.4 10:13:17 INFO - psutil == 3.1.1 10:13:17 INFO - requests == 1.2.3 10:13:17 INFO - wsgiref == 0.1.2 10:13:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:17 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 0x21951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2362a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25085c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25057a0>, '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 0x25066a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2506b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:13:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:13:17 INFO - Using env: {'DISPLAY': ':0', 10:13:17 INFO - 'HOME': '/home/cltbld', 10:13:17 INFO - 'LANG': 'en_US.UTF-8', 10:13:17 INFO - 'LANGUAGE': 'en_US:en', 10:13:17 INFO - 'LOGNAME': 'cltbld', 10:13:17 INFO - 'MAIL': '/var/mail/cltbld', 10:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:17 INFO - 'MOZ_NO_REMOTE': '1', 10:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:17 INFO - 'NO_EM_RESTART': '1', 10:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:17 INFO - 'PWD': '/builds/slave/test', 10:13:17 INFO - 'SHELL': '/bin/bash', 10:13:17 INFO - 'SHLVL': '1', 10:13:17 INFO - 'TERM': 'linux', 10:13:17 INFO - 'TMOUT': '86400', 10:13:17 INFO - 'USER': 'cltbld', 10:13:17 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918', 10:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:17 INFO - '_': '/tools/buildbot/bin/python'} 10:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:13:18 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:19 INFO - Downloading marionette_driver-1.4.0.tar.gz 10:13:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 10:13:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:13:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:13:19 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)) 10:13:19 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)) 10:13:19 INFO - Installing collected packages: marionette-driver 10:13:19 INFO - Running setup.py install for marionette-driver 10:13:19 INFO - Successfully installed marionette-driver 10:13:19 INFO - Cleaning up... 10:13:19 INFO - Return code: 0 10:13:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:19 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 0x21951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2362a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25085c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25057a0>, '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 0x25066a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2506b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:13:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:13:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:13:19 INFO - Using env: {'DISPLAY': ':0', 10:13:19 INFO - 'HOME': '/home/cltbld', 10:13:19 INFO - 'LANG': 'en_US.UTF-8', 10:13:19 INFO - 'LANGUAGE': 'en_US:en', 10:13:19 INFO - 'LOGNAME': 'cltbld', 10:13:19 INFO - 'MAIL': '/var/mail/cltbld', 10:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:19 INFO - 'MOZ_NO_REMOTE': '1', 10:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:19 INFO - 'NO_EM_RESTART': '1', 10:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:19 INFO - 'PWD': '/builds/slave/test', 10:13:19 INFO - 'SHELL': '/bin/bash', 10:13:19 INFO - 'SHLVL': '1', 10:13:19 INFO - 'TERM': 'linux', 10:13:19 INFO - 'TMOUT': '86400', 10:13:19 INFO - 'USER': 'cltbld', 10:13:19 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918', 10:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:19 INFO - '_': '/tools/buildbot/bin/python'} 10:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:13:19 INFO - Cleaning up... 10:13:19 INFO - Return code: 0 10:13:19 INFO - Running post-action listener: _resource_record_post_action 10:13:19 INFO - Running post-action listener: _start_resource_monitoring 10:13:19 INFO - Starting resource monitoring. 10:13:19 INFO - [mozharness: 2017-05-24 17:13:19.715125Z] Finished create-virtualenv step (success) 10:13:19 INFO - [mozharness: 2017-05-24 17:13:19.715632Z] Running install step. 10:13:19 INFO - Running pre-action listener: _resource_record_pre_action 10:13:19 INFO - Running main action method: install 10:13:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:13:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:13:19 INFO - Reading from file tmpfile_stdout 10:13:19 INFO - Detecting whether we're running mozinstall >=1.0... 10:13:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:13:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:13:20 INFO - Reading from file tmpfile_stdout 10:13:20 INFO - Output received: 10:13:20 INFO - Usage: mozinstall [options] installer 10:13:20 INFO - Options: 10:13:20 INFO - -h, --help show this help message and exit 10:13:20 INFO - -d DEST, --destination=DEST 10:13:20 INFO - Directory to install application into. [default: 10:13:20 INFO - "/builds/slave/test"] 10:13:20 INFO - --app=APP Application being installed. [default: firefox] 10:13:20 INFO - mkdir: /builds/slave/test/build/application 10:13:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:13:36 INFO - Reading from file tmpfile_stdout 10:13:36 INFO - Output received: 10:13:36 INFO - /builds/slave/test/build/application/firefox/firefox 10:13:36 INFO - Running post-action listener: _resource_record_post_action 10:13:36 INFO - [mozharness: 2017-05-24 17:13:36.292684Z] Finished install step (success) 10:13:36 INFO - [mozharness: 2017-05-24 17:13:36.292834Z] Running run-tests step. 10:13:36 INFO - Running pre-action listener: _resource_record_pre_action 10:13:36 INFO - Running main action method: run_tests 10:13:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:13:36 INFO - Python 2.7.3 10:13:36 INFO - Return code: 0 10:13:36 INFO - grabbing minidump binary from tooltool 10:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:36 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 0x25057a0>, '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 0x25066a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2506b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:13:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:13:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:13:36 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:13:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:13:36 INFO - Return code: 0 10:13:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:13:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:13:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:13:36 INFO - ENV: RUST_BACKTRACE is now 1 10:13:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:13:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:13:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-089 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:13:36 INFO - Using env: {'DISPLAY': ':0', 10:13:36 INFO - 'HOME': '/home/cltbld', 10:13:36 INFO - 'LANG': 'en_US.UTF-8', 10:13:36 INFO - 'LANGUAGE': 'en_US:en', 10:13:36 INFO - 'LOGNAME': 'cltbld', 10:13:36 INFO - 'MAIL': '/var/mail/cltbld', 10:13:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:13:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:36 INFO - 'MOZ_NO_REMOTE': '1', 10:13:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:36 INFO - 'NO_EM_RESTART': '1', 10:13:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:36 INFO - 'PWD': '/builds/slave/test', 10:13:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:13:36 INFO - 'RUST_BACKTRACE': '1', 10:13:36 INFO - 'SHELL': '/bin/bash', 10:13:36 INFO - 'SHLVL': '1', 10:13:36 INFO - 'TERM': 'linux', 10:13:36 INFO - 'TMOUT': '86400', 10:13:36 INFO - 'USER': 'cltbld', 10:13:36 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918', 10:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:36 INFO - '_': '/tools/buildbot/bin/python'} 10:13:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:13:36 INFO - mozversion application_buildid: 20170524163240 10:13:36 INFO - mozversion application_changeset: 37d777d872002597198405f22eefa9199e5103af 10:13:36 INFO - mozversion application_display_name: Nightly 10:13:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:13:36 INFO - mozversion application_name: Firefox 10:13:36 INFO - mozversion application_remotingname: firefox 10:13:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:13:36 INFO - mozversion application_vendor: Mozilla 10:13:36 INFO - mozversion application_version: 55.0a1 10:13:36 INFO - mozversion platform_buildid: 20170524163240 10:13:36 INFO - mozversion platform_changeset: 37d777d872002597198405f22eefa9199e5103af 10:13:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:13:36 INFO - mozversion platform_version: 55.0a1 10:13:36 INFO - using testdate: 1495646016 10:13:36 INFO - actual date: 1495646016 10:13:36 INFO - starting webserver on 'localhost:37760' 10:13:36 INFO - SUITE-START | Running 2 tests 10:13:36 INFO - TEST-START | dromaeo_css 10:13:36 INFO - operating with platform_type : linux_ 10:13:36 INFO - Initialising browser for dromaeo_css test... 10:13:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37760/getInfo.html -profile /tmp/tmp_WUR0U/profile 10:13:36 INFO - TEST-INFO | started process 12846 (/builds/slave/test/build/application/firefox/firefox http://localhost:37760/getInfo.html) 10:14:11 INFO - TEST-INFO | 12846: killed by SIGTERM 10:14:12 INFO - Browser initialized. 10:14:12 INFO - Running cycle 1/1 for dromaeo_css test... 10:14:12 INFO - TEST-INFO | started process 13069 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_WUR0U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:14:24 INFO - PID 13069 | RSS: Main: 176037888 10:14:24 INFO - PID 13069 | 10:17:29 INFO - PID 13069 | Cycle 1(1): loaded http://localhost:37760/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37760/tests/dromaeo/cssquery-ext.html) 10:17:30 INFO - PID 13069 | RSS: Main: 173367296 10:17:30 INFO - PID 13069 | 10:20:32 INFO - PID 13069 | Cycle 1(1): loaded http://localhost:37760/tests/dromaeo/cssquery-ext.html (next: http://localhost:37760/tests/dromaeo/cssquery-jquery.html) 10:20:33 INFO - PID 13069 | RSS: Main: 179781632 10:20:33 INFO - PID 13069 | 10:23:35 INFO - PID 13069 | Cycle 1(1): loaded http://localhost:37760/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37760/tests/dromaeo/cssquery-mootools.html) 10:23:35 INFO - PID 13069 | RSS: Main: 177713152 10:23:35 INFO - PID 13069 | 10:26:37 INFO - PID 13069 | Cycle 1(1): loaded http://localhost:37760/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37760/tests/dromaeo/cssquery-prototype.html) 10:26:38 INFO - PID 13069 | RSS: Main: 181821440 10:26:38 INFO - PID 13069 | 10:29:40 INFO - PID 13069 | Cycle 1(1): loaded http://localhost:37760/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37760/tests/dromaeo/cssquery-yui.html) 10:29:41 INFO - PID 13069 | RSS: Main: 180350976 10:29:41 INFO - PID 13069 | 10:32:43 INFO - PID 13069 | Cycle 1(1): loaded http://localhost:37760/tests/dromaeo/cssquery-yui.html (next: http://localhost:37760/tests/dromaeo/cssquery-dojo.html) 10:32:43 INFO - PID 13069 | RSS: Main: 178102272 10:32:43 INFO - PID 13069 | 10:32:43 INFO - PID 13069 | __start_tp_report 10:32:43 INFO - PID 13069 | _x_x_mozilla_page_load 10:32:43 INFO - PID 13069 | _x_x_mozilla_page_load_details 10:32:43 INFO - PID 13069 | |i|pagename|runs| 10:32:43 INFO - PID 13069 | |0;dojo.html;2751.944961100778;2752.477029364421;2764.5162096633085;2771.70897055809;2801.8178818376805;5206.791728330872;5275.314209152814;5284.075286824809;5298.576113910887;5331.2269720890445;5238.476152384759;5335.1197052486295;5348.251244825728;5357;5357.598180136496;4666.580007799297;4709.5290470952805;4742.905141897178;4767.785449654774;4771.42742870856;4656.138614356338;4781.784819683123;4784.473707892129;4811.735354555498;4841.128596852565;4613.308003799423;4724.149653062447;4764.714117152982;4797.736124513151;4807.447143578481;4708.128996135726;4737.573618374328;4743.430788305391;4752.025834703877;4769.4515130760055;4650.162970665279;4657.091867085919;4658.301254811771;4678.836240731592;4698.953010469886;5221.086309895791;5226.216067589854;5242.947570524284;5249.396319423277;5267.631265811395;5721.713914304268;5723.399043100456;5723.7996670116345;5746.79886203985;5772.2496075510335;5750.166225897222;5780.595358324919;5824.767009319622;5848.970755146197;5864;5376.489233522809;5378.139497680352;5389.380221274525;5393.4336894626285;5411.83764487066;5904.5571582131515;5946.43508866657;5947.464728174485;5949.881002380015;5964.373740757244;5572.554195664337;5627.831165065055;5634.070378387521;5646.661200327993;5677.630953987978;5714;5753.05074662676;5771.8557036074435;5788.507976822018;5800.1299805029585;5690.2033715279895;5717.142428635738;5749.022666146765;5749.511291540182;5767.480926716616;5691.886162276731;5692.857678557986;5702.515286200636;5703.230063941315;5703.315602127771;4636.211843986531;4652.325412815123;4690.554397332248;4697.342372067913;4708.199606066977;4089.6523795477124;4099.692523060723;4106.897327566835;4138.0689344897155;4167.041580436517;4826.420829500483;4844.733539655283;4866.9513304867205;4868.902621947541;4896.730679812645;5672.914906276409;5698.943010569924;5773.8556536086935;5780.942190578125;5808.186853840466;4839.322494850724;4852.708837469763;4872.80508779652;4897.534734200317;4907.6564640475535;5040.899182016339;5042.268871013683;5044.470330615306;5045.47022562633;5069;5383.569314454912;5384.784608615768;5385.461453854583;5390.218418329242;5429.077056900336;5740.512056475246;5752.971235143965;5783.103618939072;5813.418658134153;5820.970895145497;5276.34045744282;5352.652077614943;5380.139177731544;5420.159875219348;5431.429699881455;5669.858253543694;5679.716014199191;5752.942470575241;5759.539236860957;5759.65442073477;5689.687067211177;5786.450287222707;5816.302043754777;5819.970900145472;5854.297484301911;5603.467670571289;5611.158326251095;5623.634463759842;5636;5639.661620302795;5501.944980550304;5507.779688812403;5537.141743029837;5588.552915766811;5610.382857885547;5516.089845175501;5547.916781248204;5552.444755524415;5565.415631358649;5609.775608975595;5607.214989901336;5615.943840561542;5624.240727501735;5635.830925072254;5648.406917273627;5288.7355632219005;5395.2176934343515;5442.346918369821;5505.03661859181;5540.639858409352 10:32:43 INFO - PID 13069 | |1;ext.html;682.4267615203231;722.4256715910852;735.6946867050175;1058.3279617442922;1079.6599071292546;29455;32885.83557082211;32906.17734556637;32916.34167316655;33272.500912486335;34178.8291058545;34408.31183376331;34463;34581.30837383257;34689.653103468954;6533.836654083662;6745.5278130531005;6878.071460352839;6883.931160688404;6892.4830637702125;6595.8021259362295;6690.096836927026;6691.096701945248;6704.463642908556;6704.9607310866895;6669;6730.764423245188;6732.528722989393;6734.46124310054;6747.797566073025;6661.76683816069;6687.531872768908;6705.6982435790505;6729.663516824139;6743.898841517381;6512.5766825156215;6536.379043990813;6542.280349161589;6551.377619126175;6560.704768285439;30413.847930760425;30503;30540.236494087603;30582.541261881088;30627.2343191422;3042.254647611327;3057.9235519111976;3069.769767267464;3076.7077127672837;3083.260017595783;23933.28200153998;23987.280381588407;24015.159469418486;24023.279301620805;24098.87950560236;2987.865546050433;2992.7605791536625;3002.0093369188335;3028.5608586754797;3040.528718048706;138074;138251.30874345565;138587;145960;148512.2574387121;37221.441678374846;37342.81328593394;37439.25121497555;37441.25117497635;37447.81276093657;39002;39079;39103.608963909996;39174.216515670094;39178.6082139175;11190.776184476264;11273;11311.377874216998;11312.490937907814;11312.773744525228;9003.954980225057;9041.276697864156;9060;9065.138811813;9076.183143517115;12129.818052729217;12166.635000949986;12190.573329933588;12280.385980700928;12406.56577019818;5235.947640523622;5317.41508434072;5428.321459817523;5467.480589344006;5499.120140777456;865.8874346334936;899.7705585075895;900.6397441023643;918.1094338491653;935.4060171790826;19831.504212394804;20779.168833246804;20803.791962080184;21066.578668426544;21153.68269475959;973.1922504321396;973.4159504297506;977.1449981266392;978.1538968791943;997.4464172384396;10377.481125943672;11024.283421577733;11068.723281918017;11126.276792008493;11242.437878106062;165778;165890;167082;167699;167939;38750.61249387526;38913;38956;39000.6099938997;39142.80428597896;1175.9118066145074;1202.044374722098;1213.538855235005;1213.9878601213875;1219.5975328141692;19316.903415482833;19910.60178796445;20751.688724669442;20766.896165519076;21122.788772112697;28200.71799282063;28245.293867653472;28249;28315.433691325645;28321.291967700974;139120;139163;139905;140084;140159;27930.86034569814;28173.295667607654;28636;29731.55402669005;29982.201067935992;34788;34872;34926.30147397089;34970.47544286888;35088.64911350854;25721.614175787752;26797.330066748487;26935.191944241706;27577.310567235978;27734.722652773213;26286.21141365762;26724.331891702084;27390.315242119108;27489.72510274872;27849.860750696927;29881.252968675955;29922.850385747934;29935.101946941628;29955.101346959626;29987.100386988426;25589.232323030337;26310.86844565765;26315.605265920643;26740.732592673823;27672.72327276782;21263.68104478465;21825.672614910472;22079.558408832054;22123.778762212172;22185.44536386603 10:32:43 INFO - PID 13069 | |2;jquery.html;416.9770662613557;418.7654913248583;429.36239684069153;432.7273817494978;442.321037207886;13022.54421095262;13157.539486117988;17194.48416547504;18126.3655772048;18136.54658633535;18755.812441875576;18820.62358752824;18836;19017.809821901777;19054.618907621872;5400.675959442427;5438.184272359138;5593.105103183471;5607.691576963265;5635.971820140893;5105.361829771278;5249.370075590934;5260.947390526084;5272.736363181825;5275.340582427197;5142.820001299955;5354.036273470773;5397.595180361469;5432.70120143392;5463.644863083887;5240.528352448298;5373.328333958255;5410.513053825135;5423.701696406676;5451.454854514556;4915.410150781893;4916.139675556799;4924.079608952511;4926.8768280793265;4959.479254678279;21616.675749863763;21659.891700541553;22006.779932200632;22227.66658500124;22423.551528969492;1581.5334476329394;1589.3404237241532;1605.9882274167317;1610.846969537892;1610.9436169734004;14387.928060359736;14608.393076761547;14721.631959200999;14843.257837108209;14905.552833415015;2005.298145649011;2010.5576773109892;2045.9386218413472;2048.5595596946728;2055.5097554273184;90417.54791226068;91613.54193229058;93761;97067.51466242694;99699.0030099697;11016.449177541092;11237.3257604544;11387.37369444672;11412.486438110305;11424.257423267461;15978.440754573767;15994.280257388446;16096.436624718079;16096.597585060234;16134.677306453805;6994.860102798018;7340.339369456668;7354.485186036926;7375.963120184365;7468.439867009996;6739.393454589111;6755.1556055493065;6925.965370173117;6934.306569343126;6969.7909062728195;6969;7075.540089894141;7088.468364872655;7100.218975912646;7177.712891484282;1992.8804271743743;2022.1608032666572;2059.4027731957863;2068.2864411777914;2183.1158380855777;851.1531026628544;886.5257087458178;891.2780647675404;894.4722613657973;911.8221946720325;16583.91708041452;16624.3350265988;16665.833341666672;16844.157792110345;17441.215145318492;859.7936495241097;874.3660845886808;888.0764005434405;890.0520945193348;894.7807787092204;9222.95388523053;9280.303977201736;9546.809063818824;9548;9588;331031;333665;335367;335952;339634;75412.24587754162;76615.61692191503;78005;78653;79327;1029.4080903480528;1053.1574740207957;1070.7644318249972;1071.517816982361;1075.5805235957982;14363.21002344881;14368.640783980483;14568.635784105481;14721.263936802903;15399.153046582545;38216.235675286895;38805.611943881326;39764.00589985158;39852.800735996134;39930.60069399385;47759.761201193774;48119.75940120417;49653.50346496489;49796.751016244685;50338.2449263254;7680.846383072196;7761.922380776346;7839.333656639022;7987.680492780224;7994.40041996841;12483.188592741442;12497.500099995897;12750.74498510006;13069.869301306866;13134.540291089766;10807.135429165804;11115.72210694739;11159.944200278947;11229.3262404256;11257.774844503228;10341.896581034394;10406.427646479517;10575.206859485723;10603.628872989408;10701.304415212986;10585.735356615838;11294.209405341548;11553.422328883691;11609.245399049034;11652.184347095623;8413.116622754522;8565.314774818124;8573.871391929002;8808.735737927873;8883.466991980502;9999.999999999884;10693.572257109628;10757.623483178364;11346.829797552879;11471.13966452536 10:32:43 INFO - PID 13069 | |3;mootools.html;1250.8811662892024;1320.6104199261217;1328.8604696506873;1335.6059962311117;1348.0563605476164;10322.380657160566;10800.135989120861;10818.945905270482;10820.67537973861;10935.125189984801;10709.732256693587;10880.782384352307;10931.01620854123;10960.506777195025;10987.285826421277;2243.540074284772;2270.7048083749173;2292.277932451281;2294.139697613395;2297.2074634251157;2115.788421157887;2155.741311042669;2174.662927246279;2178.70587470691;2185.4208634711736;2070.2960993262286;2100.6030989392034;2112.86266392684;2119.5548934723724;2127.1491403438595;2092.5396412789164;2102.8317734581274;2112.7992840680113;2116.947076323089;2122.554263604645;2036.98981505093;2073.139647046474;2146.527763891957;2148.430665873545;2153.91384344626;10506.737331566696;10554.261201715883;10572.682819515427;10612.946935265274;10653.893461065367;5517.862053448655;5699.829005129853;5706.3722990471015;5727.713614319267;5730.140478928194;3337.499375093731;3425.092350527112;3451.0854623524788;3474.062003259106;3503.667151620592;1091.8962698543626;1097.9341239525575;1099.411814679151;1120.3445984099312;1137.5449820071954;15655.686886262325;15797.131157786433;15853.207339632972;15864.762028569581;15869.920650396789;4839.879003024953;4844.781984810692;4876.707397556087;4921.729304888266;4954.677945933503;11308;11319.660410187707;11329.037031852386;11357.545698172145;11363.715907102223;5473.7263136843;5669.177969194526;5681.57388195887;5724.79963201286;5727.885442291131;5259.289995850511;5287.07476191665;5299.920501192485;5303.522682958553;5318.388385335736;3811.2187001664593;3876.26350993316;3951.762894226298;3957.3074711925296;3972.106276087915;1111.744298811278;1120.176670147441;1127.537709539085;1137.5051852444212;1137.6814491942268;674.140470899607;702.7189124350301;705.2947052947053;724.0948813982521;724.576122968059;5386.703731294738;5471.671699698031;5472.042392581282;5544.085225937675;5608.719564021782;512.6104160837716;513.3736841053908;515.6905856486153;519.413063238538;522.4070679778479;3465.7227421806197;3762.398016317431;3769.6607305342104;3846.4614953906475;3886.657474571866;13173.27546984925;14183.361748721332;14251.57245282643;14266.072705274124;14271.928640356731;13526.120802147829;13720.176789392468;14044.78932815988;14124.43502259898;14144.787828182585;7467.51461155034;7549.396048316122;7655.349295309961;7732.497387669783;7782.571958542335;5616;5744;5862.853428664317;5875.118732190205;6079.05774604937;12395.380230988234;12437.564685235973;12529.812052819032;12587.24476531411;12706.745865082832;12507.624771256877;12730.07208342068;12768.425420855898;12832.55086071983;13058.21650700923;8321.334293256647;8497.617607207814;8554.18735220153;8578.485290882567;8578.78553036179;9492.288078394286;9628.133467987635;9659.116472287837;9728.464934428674;9733.659321923698;7762.184970578234;7837.647305871135;7875.369970402468;7900.130985591695;8100.554469503998;8062.153473885158;8078.9192108080515;8101.513909165469;8208;8232.711855085043;7283.198848126596;7419.962900185465;7426.5915374654915;7427;7431.442641801995;5359.303290572357;5359.651622644516;5382.838514844561;5438.211459338295;5636.605437619492;4963.354763880672;4990.950090499194;5027.2207807789855;5196.922046169235;5275.894482110413 10:32:43 INFO - PID 13069 | |4;prototype.html;377.9036345731838;389.6843556719058;391.9725619206655;394.2784703991695;399.57445320733433;5461.453854614537;5543.611947163695;5565.30433695788;5572.108462645972;5597.720113994299;5386.676799392029;5453.464139175283;5473.2063850741615;5483.983808905096;5492.47821456962;4142.357934520147;4143.274926887782;4156.771377574232;4156.916861662765;4156.937645935313;4103.850921741917;4106.7761806981525;4131.2357213915375;4152.854650087247;4164.458620379346;4132.29750942339;4143.56492568279;4154.984832356305;4158.251514727363;4161.646260067898;4101.364288535252;4101.589841015904;4119.340905455143;4129.463169787939;4131.132462182945;3570.62508436613;3602.189507360849;3604.279144171176;3614.5662520497444;3614.951254594844;5110.6422550421485;5291.682499050031;5294.364676238837;5311.964166987439;5330.466953304677;4811.59101476375;4815.927761083586;4828;4843.321934929113;4845.127876982142;5709.914351284734;5819.24349834523;5828.870593877361;5830.3586605473365;5831.941680583224;3955.6044395560216;3984.6413822755803;3997.380406037069;4008.6793056555407;4014.698897582664;5924.911126333109;6101.176341193926;6151.569390142692;6153.84615384619;6159.661218632973;4069.552349241581;4114.19773144234;4114.362273847559;4134.565870583606;4134.834606615762;4193.811278492475;4195.1819395217635;4197.055662475979;4198.85304014358;4203.5376108628025;4732.266498692708;4817.434333841446;4830.130576496264;4837.637177211653;4849.830255941025;5816.302043754692;5825.88348233033;5826.65040097587;5827.388124246893;5835.591508594358;1434.5624584501618;1435.3110506956511;1450.8259008918997;1453.25157543865;1456.2645863838904;954.6992697300328;955.0926619711302;962.1484985787629;964.609333220047;964.6816550538306;5056.115179843513;5060.924086138711;5067.037262920034;5082.3228334649475;5086.415062267813;5986.2217911671205;6014.48876845473;6024.8853962017165;6030.638161710312;6075.5747097703625;4900.656954013185;4968.130577148984;4999.500049994971;4999.800007999712;5008.5993120550265;3179.952300715491;3180.3162320101287;3201.6478187399366;3201.791883527563;3203.855826487814;5471.945280547223;5610.80184294948;5611.298587676541;5616.326040875121;5644.689542075143;6143.84640383994;6159.199304090529;6164.907526387108;6177.227846519185;6197.659128747962;5601.263608281364;5603.243562119062;5621.297337832771;5624.74688639004;5640.971795140998;5859.5019423347785;5968.134620480093;6023.216981792339;6027.758889644365;6051.697415129138;5705.515031222392;5921.792737254175;5922;5923.881522369442;5931.495822854933;5604.523615492566;5622.409646987171;5626.803061892814;5669.433056694297;5674.687892165971;4121.948903029708;4139.91720165589;4145.7719825409895;4149.481314835645;4150.750954942713;5960;6046.727897244723;6102.542309326729;6118.112873633388;6119.84700382494;5844.6493210405815;5855.385184555731;5876.823695289148;5886.117082437669;5905.675187864708;5757.712114394348;5843.970780146072;5861.413858614104;5874.647521148745;5885.882282354243;5741.511971482304;5758.740856661544;5763.36602973681;5782.2194003808945;5786.07422812348;5845.678487683218;5869.090291004901;5876.676782776988;5888.146218798164;5919.91120133207;5603.67545421098;5675.744591493475;5700.315962084576;5734.885302294014;5771.711414429178 10:32:43 INFO - PID 13069 | |5;yui.html;679.2663922963201;684.4490185400751;690.0063907972519;716.3851011525949;738.4166508458314;13038.869611303884;13880.722385552283;13891.166530008193;15732.134732589702;16252.18739063045;15986.12076335801;16042;16116.952398094116;16158.111303878282;16263.186840657949;880.3793325705378;917.2616044084509;921.9907800921972;922.128588483883;923.2936803345447;877.9692710755124;901.2969883490855;927.5594092805896;935.6163972771166;935.7520257131865;963.109124060245;965.242284806427;968.7529679931607;969.2536746705033;973.2019743810043;954.8472244440856;959.0697023886819;960.5101398286854;964.8022155458115;965.4979410706428;698.3749544158001;702.3468174597622;704.5279662626053;706.6890568149997;706.9893951590731;14246.786298205536;14489.78265326021;14542.127472351693;14567.781483277759;14605.12369257848;16139.435119770751;16772;16777.580560485963;16797.496075117768;16803.663926721398;12301.876981230163;12357.752844943141;12770.042246831432;12810.487580496769;12830.294333811637;2826.4488424757183;2836.61705669734;2838.389746204555;2850.7719382449354;2882.3802882380387;77978.61010694967;79468.60265698693;79525;80160;80578.99999999942;12553.686157845945;12652.683682907817;12692.111552191443;12698.873011269769;12741.10812243134;23005.769942300696;23923.641145382833;24034.519309613708;24068.39829004289;24070.39824004414;6185.226846644169;6242.250929888442;6267.2479302484;6280.309165991828;6289.150964619717;2980.8509574521186;3135.6394014688603;3145.2294187924103;3145.968540314613;3150.810951342881;3639.3085313790293;3723.646253605957;3741.1021354874633;3746.756460830037;3756.2908876461142;721.8664547058811;755.056179775281;759.5708424740114;761.5621017914722;761.6191904047976;594.8364199844991;607.5382709140996;610.8747706720112;627.1314229791681;635.8442181665522;10377.325473844176;10540.15678745714;10830.51262693165;10979.286346387618;11088.112950963903;562.1202817590458;562.7158285066097;565.2482198675751;603.3544107804695;628.6416742456847;4369.60673539383;4476.664250181184;4585.1746685596245;4639.141758774637;4668.206404911173;74183.62908185425;74352.62823685956;76176;76541;78632.13678632092;63556.36443635504;64244.67877660582;64634;65282;65363.34636653668;45913;52586;56333;59760.70119649374;59817.401825981186;10484.270095434167;10977.670669879917;11121.610743623934;11182.049525790399;11298.265612735146;28107;28475.857620711762;28915.85542072276;28932.710672893;29501.704982949897;35045.299094017464;35050.64949350474;35178.296434071686;35228.295434091684;35812.28375432529;13471.25908075026;13521.121127126706;13711.520096796565;13801.102928310029;13873;15060.246987650793;15116.924415377853;15217.6195595111;15394.07635541871;15494.07035577869;14211.573652790434;14299.85700143027;14319.427222911383;14365.856341436453;14446.349914253673;15242.237888105328;15249.31378088011;15396.46112386061;15431.074135551902;15720;14814;14836.48072317507;15224.695506090038;15415.075095494307;15465.381384744484;9562.235021198427;9800.41197528122;9885.209183265179;10084.899151008396;10400.115990140923;10754.933799650262;10855.18586106061;11220.15848811326;11407.828882566602;11421 10:32:43 INFO - PID 13069 | __end_tp_report 10:32:43 INFO - PID 13069 | __start_cc_report 10:32:43 INFO - PID 13069 | _x_x_mozilla_cycle_collect,351 10:32:43 INFO - PID 13069 | __end_cc_report 10:32:43 INFO - PID 13069 | __startTimestamp1495647163455__endTimestamp 10:32:43 INFO - PID 13069 | 10:32:43 INFO - PID 13069 | ------- Summary: start ------- 10:32:43 INFO - PID 13069 | Number of tests: 6 10:32:43 INFO - PID 13069 | 10:32:43 INFO - PID 13069 | [#0] dojo.html Cycles:165 Average:5247.72 Median:5395.22 stddev:629.23 (11.7%) stddev-sans-first:599.93 10:32:43 INFO - PID 13069 | Values: 2751.9 2752.5 2764.5 2771.7 2801.8 5206.8 5275.3 5284.1 5298.6 5331.2 5238.5 5335.1 5348.3 5357.0 5357.6 4666.6 4709.5 4742.9 4767.8 4771.4 4656.1 4781.8 4784.5 4811.7 4841.1 4613.3 4724.1 4764.7 4797.7 4807.4 4708.1 4737.6 4743.4 4752.0 4769.5 4650.2 4657.1 4658.3 4678.8 4699.0 5221.1 5226.2 5242.9 5249.4 5267.6 5721.7 5723.4 5723.8 5746.8 5772.2 5750.2 5780.6 5824.8 5849.0 5864.0 5376.5 5378.1 5389.4 5393.4 5411.8 5904.6 5946.4 5947.5 5949.9 5964.4 5572.6 5627.8 5634.1 5646.7 5677.6 5714.0 5753.1 5771.9 5788.5 5800.1 5690.2 5717.1 5749.0 5749.5 5767.5 5691.9 5692.9 5702.5 5703.2 5703.3 4636.2 4652.3 4690.6 4697.3 4708.2 4089.7 4099.7 4106.9 4138.1 4167.0 4826.4 4844.7 4867.0 4868.9 4896.7 5672.9 5698.9 5773.9 5780.9 5808.2 4839.3 4852.7 4872.8 4897.5 4907.7 5040.9 5042.3 5044.5 5045.5 5069.0 5383.6 5384.8 5385.5 5390.2 5429.1 5740.5 5753.0 5783.1 5813.4 5821.0 5276.3 5352.7 5380.1 5420.2 5431.4 5669.9 5679.7 5752.9 5759.5 5759.7 5689.7 5786.5 5816.3 5820.0 5854.3 5603.5 5611.2 5623.6 5636.0 5639.7 5501.9 5507.8 5537.1 5588.6 5610.4 5516.1 5547.9 5552.4 5565.4 5609.8 5607.2 5615.9 5624.2 5635.8 5648.4 5288.7 5395.2 5442.3 5505.0 5540.6 10:32:43 INFO - PID 13069 | 10:32:43 INFO - PID 13069 | [#1] ext.html Cycles:180 Average:28977.71 Median:3015.29 stddev:38644.65 (1281.6%) stddev-sans-first:38694.65 10:32:43 INFO - PID 13069 | Values: 682.4 722.4 735.7 1058.3 1079.7 29455.0 32885.8 32906.2 32916.3 33272.5 34178.8 34408.3 34463.0 34581.3 34689.7 6533.8 6745.5 6878.1 6883.9 6892.5 6595.8 6690.1 6691.1 6704.5 6705.0 6669.0 6730.8 6732.5 6734.5 6747.8 6661.8 6687.5 6705.7 6729.7 6743.9 6512.6 6536.4 6542.3 6551.4 6560.7 30413.8 30503.0 30540.2 30582.5 30627.2 3042.3 3057.9 3069.8 3076.7 3083.3 23933.3 23987.3 24015.2 24023.3 24098.9 2987.9 2992.8 3002.0 3028.6 3040.5 138074.0 138251.3 138587.0 145960.0 148512.3 37221.4 37342.8 37439.3 37441.3 37447.8 39002.0 39079.0 39103.6 39174.2 39178.6 11190.8 11273.0 11311.4 11312.5 11312.8 9004.0 9041.3 9060.0 9065.1 9076.2 12129.8 12166.6 12190.6 12280.4 12406.6 5235.9 5317.4 5428.3 5467.5 5499.1 865.9 899.8 900.6 918.1 935.4 19831.5 20779.2 20803.8 21066.6 21153.7 973.2 973.4 977.1 978.2 997.4 10377.5 11024.3 11068.7 11126.3 11242.4 165778.0 165890.0 167082.0 167699.0 167939.0 38750.6 38913.0 38956.0 39000.6 39142.8 1175.9 1202.0 1213.5 1214.0 1219.6 19316.9 19910.6 20751.7 20766.9 21122.8 28200.7 28245.3 28249.0 28315.4 28321.3 139120.0 139163.0 139905.0 140084.0 140159.0 27930.9 28173.3 28636.0 29731.6 29982.2 34788.0 34872.0 34926.3 34970.5 35088.6 25721.6 26797.3 26935.2 27577.3 27734.7 26286.2 26724.3 27390.3 27489.7 27849.9 29881.3 29922.9 29935.1 29955.1 29987.1 25589.2 26310.9 26315.6 26740.7 27672.7 21263.7 21825.7 22079.6 22123.8 22185.4 10:32:43 INFO - PID 13069 | 10:32:43 INFO - PID 13069 | [#2] jquery.html Cycles:180 Average:24035.26 Median:39284.81 stddev:56387.52 (143.5%) stddev-sans-first:56517.82 10:32:43 INFO - PID 13069 | Values: 417.0 418.8 429.4 432.7 442.3 13022.5 13157.5 17194.5 18126.4 18136.5 18755.8 18820.6 18836.0 19017.8 19054.6 5400.7 5438.2 5593.1 5607.7 5636.0 5105.4 5249.4 5260.9 5272.7 5275.3 5142.8 5354.0 5397.6 5432.7 5463.6 5240.5 5373.3 5410.5 5423.7 5451.5 4915.4 4916.1 4924.1 4926.9 4959.5 21616.7 21659.9 22006.8 22227.7 22423.6 1581.5 1589.3 1606.0 1610.8 1610.9 14387.9 14608.4 14721.6 14843.3 14905.6 2005.3 2010.6 2045.9 2048.6 2055.5 90417.5 91613.5 93761.0 97067.5 99699.0 11016.4 11237.3 11387.4 11412.5 11424.3 15978.4 15994.3 16096.4 16096.6 16134.7 6994.9 7340.3 7354.5 7376.0 7468.4 6739.4 6755.2 6926.0 6934.3 6969.8 6969.0 7075.5 7088.5 7100.2 7177.7 1992.9 2022.2 2059.4 2068.3 2183.1 851.2 886.5 891.3 894.5 911.8 16583.9 16624.3 16665.8 16844.2 17441.2 859.8 874.4 888.1 890.1 894.8 9223.0 9280.3 9546.8 9548.0 9588.0 331031.0 333665.0 335367.0 335952.0 339634.0 75412.2 76615.6 78005.0 78653.0 79327.0 1029.4 1053.2 1070.8 1071.5 1075.6 14363.2 14368.6 14568.6 14721.3 15399.2 38216.2 38805.6 39764.0 39852.8 39930.6 47759.8 48119.8 49653.5 49796.8 50338.2 7680.8 7761.9 7839.3 7987.7 7994.4 12483.2 12497.5 12750.7 13069.9 13134.5 10807.1 11115.7 11159.9 11229.3 11257.8 10341.9 10406.4 10575.2 10603.6 10701.3 10585.7 11294.2 11553.4 11609.2 11652.2 8413.1 8565.3 8573.9 8808.7 8883.5 10000.0 10693.6 10757.6 11346.8 11471.1 10:32:43 INFO - PID 13069 | 10:32:43 INFO - PID 13069 | [#3] mootools.html Cycles:180 Average:6440.14 Median:3633.03 stddev:4276.49 (117.7%) stddev-sans-first:4270.71 10:32:43 INFO - PID 13069 | Values: 1250.9 1320.6 1328.9 1335.6 1348.1 10322.4 10800.1 10818.9 10820.7 10935.1 10709.7 10880.8 10931.0 10960.5 10987.3 2243.5 2270.7 2292.3 2294.1 2297.2 2115.8 2155.7 2174.7 2178.7 2185.4 2070.3 2100.6 2112.9 2119.6 2127.1 2092.5 2102.8 2112.8 2116.9 2122.6 2037.0 2073.1 2146.5 2148.4 2153.9 10506.7 10554.3 10572.7 10612.9 10653.9 5517.9 5699.8 5706.4 5727.7 5730.1 3337.5 3425.1 3451.1 3474.1 3503.7 1091.9 1097.9 1099.4 1120.3 1137.5 15655.7 15797.1 15853.2 15864.8 15869.9 4839.9 4844.8 4876.7 4921.7 4954.7 11308.0 11319.7 11329.0 11357.5 11363.7 5473.7 5669.2 5681.6 5724.8 5727.9 5259.3 5287.1 5299.9 5303.5 5318.4 3811.2 3876.3 3951.8 3957.3 3972.1 1111.7 1120.2 1127.5 1137.5 1137.7 674.1 702.7 705.3 724.1 724.6 5386.7 5471.7 5472.0 5544.1 5608.7 512.6 513.4 515.7 519.4 522.4 3465.7 3762.4 3769.7 3846.5 3886.7 13173.3 14183.4 14251.6 14266.1 14271.9 13526.1 13720.2 14044.8 14124.4 14144.8 7467.5 7549.4 7655.3 7732.5 7782.6 5616.0 5744.0 5862.9 5875.1 6079.1 12395.4 12437.6 12529.8 12587.2 12706.7 12507.6 12730.1 12768.4 12832.6 13058.2 8321.3 8497.6 8554.2 8578.5 8578.8 9492.3 9628.1 9659.1 9728.5 9733.7 7762.2 7837.6 7875.4 7900.1 8100.6 8062.2 8078.9 8101.5 8208.0 8232.7 7283.2 7420.0 7426.6 7427.0 7431.4 5359.3 5359.7 5382.8 5438.2 5636.6 4963.4 4991.0 5027.2 5196.9 5275.9 10:32:43 INFO - PID 13069 | 10:32:43 INFO - PID 13069 | [#4] prototype.html Cycles:180 Average:4786.65 Median:5488.23 stddev:1427.53 (26.0%) stddev-sans-first:1392.65 10:32:43 INFO - PID 13069 | Values: 377.9 389.7 392.0 394.3 399.6 5461.5 5543.6 5565.3 5572.1 5597.7 5386.7 5453.5 5473.2 5484.0 5492.5 4142.4 4143.3 4156.8 4156.9 4156.9 4103.9 4106.8 4131.2 4152.9 4164.5 4132.3 4143.6 4155.0 4158.3 4161.6 4101.4 4101.6 4119.3 4129.5 4131.1 3570.6 3602.2 3604.3 3614.6 3615.0 5110.6 5291.7 5294.4 5312.0 5330.5 4811.6 4815.9 4828.0 4843.3 4845.1 5709.9 5819.2 5828.9 5830.4 5831.9 3955.6 3984.6 3997.4 4008.7 4014.7 5924.9 6101.2 6151.6 6153.8 6159.7 4069.6 4114.2 4114.4 4134.6 4134.8 4193.8 4195.2 4197.1 4198.9 4203.5 4732.3 4817.4 4830.1 4837.6 4849.8 5816.3 5825.9 5826.7 5827.4 5835.6 1434.6 1435.3 1450.8 1453.3 1456.3 954.7 955.1 962.1 964.6 964.7 5056.1 5060.9 5067.0 5082.3 5086.4 5986.2 6014.5 6024.9 6030.6 6075.6 4900.7 4968.1 4999.5 4999.8 5008.6 3180.0 3180.3 3201.6 3201.8 3203.9 5471.9 5610.8 5611.3 5616.3 5644.7 6143.8 6159.2 6164.9 6177.2 6197.7 5601.3 5603.2 5621.3 5624.7 5641.0 5859.5 5968.1 6023.2 6027.8 6051.7 5705.5 5921.8 5922.0 5923.9 5931.5 5604.5 5622.4 5626.8 5669.4 5674.7 4121.9 4139.9 4145.8 4149.5 4150.8 5960.0 6046.7 6102.5 6118.1 6119.8 5844.6 5855.4 5876.8 5886.1 5905.7 5757.7 5844.0 5861.4 5874.6 5885.9 5741.5 5758.7 5763.4 5782.2 5786.1 5845.7 5869.1 5876.7 5888.1 5919.9 5603.7 5675.7 5700.3 5734.9 5771.7 10:32:43 INFO - PID 13069 | 10:32:43 INFO - PID 13069 | [#5] yui.html Cycles:180 Average:16507.20 Median:3148.39 stddev:20522.75 (651.8%) stddev-sans-first:20545.90 10:32:43 INFO - PID 13069 | Values: 679.3 684.4 690.0 716.4 738.4 13038.9 13880.7 13891.2 15732.1 16252.2 15986.1 16042.0 16117.0 16158.1 16263.2 880.4 917.3 922.0 922.1 923.3 878.0 901.3 927.6 935.6 935.8 963.1 965.2 968.8 969.3 973.2 954.8 959.1 960.5 964.8 965.5 698.4 702.3 704.5 706.7 707.0 14246.8 14489.8 14542.1 14567.8 14605.1 16139.4 16772.0 16777.6 16797.5 16803.7 12301.9 12357.8 12770.0 12810.5 12830.3 2826.4 2836.6 2838.4 2850.8 2882.4 77978.6 79468.6 79525.0 80160.0 80579.0 12553.7 12652.7 12692.1 12698.9 12741.1 23005.8 23923.6 24034.5 24068.4 24070.4 6185.2 6242.3 6267.2 6280.3 6289.2 2980.9 3135.6 3145.2 3146.0 3150.8 3639.3 3723.6 3741.1 3746.8 3756.3 721.9 755.1 759.6 761.6 761.6 594.8 607.5 610.9 627.1 635.8 10377.3 10540.2 10830.5 10979.3 11088.1 562.1 562.7 565.2 603.4 628.6 4369.6 4476.7 4585.2 4639.1 4668.2 74183.6 74352.6 76176.0 76541.0 78632.1 63556.4 64244.7 64634.0 65282.0 65363.3 45913.0 52586.0 56333.0 59760.7 59817.4 10484.3 10977.7 11121.6 11182.0 11298.3 28107.0 28475.9 28915.9 28932.7 29501.7 35045.3 35050.6 35178.3 35228.3 35812.3 13471.3 13521.1 13711.5 13801.1 13873.0 15060.2 15116.9 15217.6 15394.1 15494.1 14211.6 14299.9 14319.4 14365.9 14446.3 15242.2 15249.3 15396.5 15431.1 15720.0 14814.0 14836.5 15224.7 15415.1 15465.4 9562.2 9800.4 9885.2 10084.9 10400.1 10754.9 10855.2 11220.2 11407.8 11421.0 10:32:43 INFO - PID 13069 | -------- Summary: end -------- 10:32:43 INFO - PID 13069 | 10:32:44 INFO - TEST-INFO | 13069: exit 0 10:32:44 INFO - TEST-OK | dromaeo_css | took 1147674ms 10:32:44 INFO - TEST-START | kraken 10:32:44 INFO - operating with platform_type : linux_ 10:32:44 INFO - Initialising browser for kraken test... 10:32:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37760/getInfo.html -profile /tmp/tmpiPwdtE/profile 10:32:44 INFO - TEST-INFO | started process 13486 (/builds/slave/test/build/application/firefox/firefox http://localhost:37760/getInfo.html) 10:33:19 INFO - TEST-INFO | 13486: killed by SIGTERM 10:33:19 INFO - Browser initialized. 10:33:19 INFO - Running cycle 1/1 for kraken test... 10:33:19 INFO - TEST-INFO | started process 13707 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiPwdtE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:33:31 INFO - PID 13707 | RSS: Main: 175947776 10:33:31 INFO - PID 13707 | 10:33:33 INFO - PID 13707 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37760/tests/kraken/driver.html?testName=audio-beat-detection) 10:33:34 INFO - PID 13707 | RSS: Main: 181321728 10:33:34 INFO - PID 13707 | 10:33:37 INFO - PID 13707 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37760/tests/kraken/driver.html?testName=audio-dft) 10:33:38 INFO - PID 13707 | RSS: Main: 180350976 10:33:38 INFO - PID 13707 | 10:33:41 INFO - PID 13707 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37760/tests/kraken/driver.html?testName=audio-fft) 10:33:41 INFO - PID 13707 | RSS: Main: 177991680 10:33:41 INFO - PID 13707 | 10:33:44 INFO - PID 13707 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37760/tests/kraken/driver.html?testName=audio-oscillator) 10:33:44 INFO - PID 13707 | RSS: Main: 178765824 10:33:44 INFO - PID 13707 | 10:33:46 INFO - PID 13707 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37760/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:33:47 INFO - PID 13707 | RSS: Main: 179109888 10:33:47 INFO - PID 13707 | 10:33:50 INFO - PID 13707 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37760/tests/kraken/driver.html?testName=imaging-darkroom) 10:33:51 INFO - PID 13707 | RSS: Main: 182886400 10:33:51 INFO - PID 13707 | 10:33:54 INFO - PID 13707 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37760/tests/kraken/driver.html?testName=imaging-desaturate) 10:33:55 INFO - PID 13707 | RSS: Main: 179073024 10:33:55 INFO - PID 13707 | 10:33:58 INFO - PID 13707 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37760/tests/kraken/driver.html?testName=json-parse-financial) 10:33:58 INFO - PID 13707 | RSS: Main: 179683328 10:33:58 INFO - PID 13707 | 10:34:00 INFO - PID 13707 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37760/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:34:01 INFO - PID 13707 | RSS: Main: 179752960 10:34:01 INFO - PID 13707 | 10:34:02 INFO - PID 13707 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37760/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:34:03 INFO - PID 13707 | RSS: Main: 179662848 10:34:03 INFO - PID 13707 | 10:34:05 INFO - PID 13707 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37760/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:34:06 INFO - PID 13707 | RSS: Main: 179617792 10:34:06 INFO - PID 13707 | 10:34:09 INFO - PID 13707 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37760/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:34:10 INFO - PID 13707 | RSS: Main: 180105216 10:34:10 INFO - PID 13707 | 10:34:13 INFO - PID 13707 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37760/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:34:13 INFO - PID 13707 | RSS: Main: 180260864 10:34:13 INFO - PID 13707 | 10:34:15 INFO - PID 13707 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37760/tests/kraken/driver.html?testName=ai-astar) 10:34:16 INFO - PID 13707 | RSS: Main: 181751808 10:34:16 INFO - PID 13707 | 10:34:16 INFO - PID 13707 | __start_tp_report 10:34:16 INFO - PID 13707 | _x_x_mozilla_page_load 10:34:16 INFO - PID 13707 | _x_x_mozilla_page_load_details 10:34:16 INFO - PID 13707 | |i|pagename|runs| 10:34:16 INFO - PID 13707 | |0;ai-astar;105;114;111;111;110;110;112;113;113;113 10:34:16 INFO - PID 13707 | |1;audio-beat-detection;154;125;135;202;132;131;133;127;144;124 10:34:16 INFO - PID 13707 | |2;audio-dft;166;163;164;165;170;167;167;164;163;164 10:34:16 INFO - PID 13707 | |3;audio-fft;73;74;74;107;74;74;74;74;104;74 10:34:16 INFO - PID 13707 | |4;audio-oscillator;83;83;106;83;84;85;96;84;84;107 10:34:16 INFO - PID 13707 | |5;imaging-gaussian-blur;113;115;114;114;114;114;114;114;113;115 10:34:16 INFO - PID 13707 | |6;imaging-darkroom;151;151;151;151;151;149;150;150;150;150 10:34:16 INFO - PID 13707 | |7;imaging-desaturate;94;95;95;96;94;95;94;95;94;94 10:34:16 INFO - PID 13707 | |8;json-parse-financial;55;55;54;55;56;57;53;56;55;54 10:34:16 INFO - PID 13707 | |9;json-stringify-tinderbox;58;57;57;56;57;56;57;57;57;57 10:34:16 INFO - PID 13707 | |10;stanford-crypto-aes;88;88;87;87;87;86;93;89;116;88 10:34:16 INFO - PID 13707 | |11;stanford-crypto-ccm;136;138;136;142;140;136;138;137;136;140 10:34:16 INFO - PID 13707 | |12;stanford-crypto-pbkdf2;192;199;207;196;200;200;207;196;196;203 10:34:16 INFO - PID 13707 | |13;stanford-crypto-sha256-iterative;78;74;74;73;74;72;77;73;79;75 10:34:16 INFO - PID 13707 | __end_tp_report 10:34:16 INFO - PID 13707 | __start_cc_report 10:34:16 INFO - PID 13707 | _x_x_mozilla_cycle_collect,912 10:34:16 INFO - PID 13707 | __end_cc_report 10:34:16 INFO - PID 13707 | __startTimestamp1495647256022__endTimestamp 10:34:16 INFO - PID 13707 | 10:34:16 INFO - PID 13707 | ------- Summary: start ------- 10:34:16 INFO - PID 13707 | Number of tests: 14 10:34:16 INFO - PID 13707 | 10:34:16 INFO - PID 13707 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.50 stddev:2.57 (2.3%) stddev-sans-first:1.45 10:34:16 INFO - PID 13707 | Values: 105.0 114.0 111.0 111.0 110.0 110.0 112.0 113.0 113.0 113.0 10:34:16 INFO - PID 13707 | 10:34:16 INFO - PID 13707 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:134.00 stddev:23.38 (17.4%) stddev-sans-first:24.30 10:34:16 INFO - PID 13707 | Values: 154.0 125.0 135.0 202.0 132.0 131.0 133.0 127.0 144.0 124.0 10:34:16 INFO - PID 13707 | 10:34:16 INFO - PID 13707 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.50 stddev:2.21 (1.3%) stddev-sans-first:2.33 10:34:16 INFO - PID 13707 | Values: 166.0 163.0 164.0 165.0 170.0 167.0 167.0 164.0 163.0 164.0 10:34:16 INFO - PID 13707 | 10:34:16 INFO - PID 13707 | [#3] audio-fft Cycles:10 Average:80.20 Median:74.00 stddev:13.36 (18.0%) stddev-sans-first:13.91 10:34:16 INFO - PID 13707 | Values: 73.0 74.0 74.0 107.0 74.0 74.0 74.0 74.0 104.0 74.0 10:34:16 INFO - PID 13707 | 10:34:16 INFO - PID 13707 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:84.00 stddev:9.77 (11.6%) stddev-sans-first:10.07 10:34:16 INFO - PID 13707 | Values: 83.0 83.0 106.0 83.0 84.0 85.0 96.0 84.0 84.0 107.0 10:34:16 INFO - PID 13707 | 10:34:16 INFO - PID 13707 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 10:34:16 INFO - PID 13707 | Values: 113.0 115.0 114.0 114.0 114.0 114.0 114.0 114.0 113.0 115.0 10:34:16 INFO - PID 13707 | 10:34:16 INFO - PID 13707 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:151.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 10:34:16 INFO - PID 13707 | Values: 151.0 151.0 151.0 151.0 151.0 149.0 150.0 150.0 150.0 150.0 10:34:16 INFO - PID 13707 | 10:34:16 INFO - PID 13707 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 10:34:16 INFO - PID 13707 | Values: 94.0 95.0 95.0 96.0 94.0 95.0 94.0 95.0 94.0 94.0 10:34:16 INFO - PID 13707 | 10:34:16 INFO - PID 13707 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:1.15 (2.1%) stddev-sans-first:1.22 10:34:16 INFO - PID 13707 | Values: 55.0 55.0 54.0 55.0 56.0 57.0 53.0 56.0 55.0 54.0 10:34:16 INFO - PID 13707 | 10:34:16 INFO - PID 13707 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:57.00 stddev:0.57 (1.0%) stddev-sans-first:0.44 10:34:16 INFO - PID 13707 | Values: 58.0 57.0 57.0 56.0 57.0 56.0 57.0 57.0 57.0 57.0 10:34:16 INFO - PID 13707 | 10:34:16 INFO - PID 13707 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:88.00 stddev:9.02 (10.3%) stddev-sans-first:9.51 10:34:16 INFO - PID 13707 | Values: 88.0 88.0 87.0 87.0 87.0 86.0 93.0 89.0 116.0 88.0 10:34:16 INFO - PID 13707 | 10:34:16 INFO - PID 13707 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:138.00 stddev:2.13 (1.5%) stddev-sans-first:2.15 10:34:16 INFO - PID 13707 | Values: 136.0 138.0 136.0 142.0 140.0 136.0 138.0 137.0 136.0 140.0 10:34:16 INFO - PID 13707 | 10:34:16 INFO - PID 13707 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.60 Median:200.00 stddev:4.93 (2.5%) stddev-sans-first:4.39 10:34:16 INFO - PID 13707 | Values: 192.0 199.0 207.0 196.0 200.0 200.0 207.0 196.0 196.0 203.0 10:34:16 INFO - PID 13707 | 10:34:16 INFO - PID 13707 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:74.50 stddev:2.33 (3.1%) stddev-sans-first:2.19 10:34:16 INFO - PID 13707 | Values: 78.0 74.0 74.0 73.0 74.0 72.0 77.0 73.0 79.0 75.0 10:34:16 INFO - PID 13707 | -------- Summary: end -------- 10:34:16 INFO - PID 13707 | 10:34:17 INFO - TEST-INFO | 13707: exit 0 10:34:17 INFO - TEST-OK | kraken | took 92854ms 10:34:17 INFO - SUITE-END | took 1240s 10:34:17 INFO - Completed test suite (00:20:40) 10:34:17 INFO - javascript benchmark 10:34:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6736.159232968009, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2751.944961100778, 2752.477029364421, 2764.5162096633085, 2771.70897055809, 2801.8178818376805, 5206.791728330872, 5275.314209152814, 5284.075286824809, 5298.576113910887, 5331.2269720890445, 5238.476152384759, 5335.1197052486295, 5348.251244825728, 5357.0, 5357.598180136496, 4666.580007799297, 4709.5290470952805, 4742.905141897178, 4767.785449654774, 4771.42742870856, 4656.138614356338, 4781.784819683123, 4784.473707892129, 4811.735354555498, 4841.128596852565, 4613.308003799423, 4724.149653062447, 4764.714117152982, 4797.736124513151, 4807.447143578481, 4708.128996135726, 4737.573618374328, 4743.430788305391, 4752.025834703877, 4769.4515130760055, 4650.162970665279, 4657.091867085919, 4658.301254811771, 4678.836240731592, 4698.953010469886, 5221.086309895791, 5226.216067589854, 5242.947570524284, 5249.396319423277, 5267.631265811395, 5721.713914304268, 5723.399043100456, 5723.7996670116345, 5746.79886203985, 5772.2496075510335, 5750.166225897222, 5780.595358324919, 5824.767009319622, 5848.970755146197, 5864.0, 5376.489233522809, 5378.139497680352, 5389.380221274525, 5393.4336894626285, 5411.83764487066, 5904.5571582131515, 5946.43508866657, 5947.464728174485, 5949.881002380015, 5964.373740757244, 5572.554195664337, 5627.831165065055, 5634.070378387521, 5646.661200327993, 5677.630953987978, 5714.0, 5753.05074662676, 5771.8557036074435, 5788.507976822018, 5800.1299805029585, 5690.2033715279895, 5717.142428635738, 5749.022666146765, 5749.511291540182, 5767.480926716616, 5691.886162276731, 5692.857678557986, 5702.515286200636, 5703.230063941315, 5703.315602127771, 4636.211843986531, 4652.325412815123, 4690.554397332248, 4697.342372067913, 4708.199606066977, 4089.6523795477124, 4099.692523060723, 4106.897327566835, 4138.0689344897155, 4167.041580436517, 4826.420829500483, 4844.733539655283, 4866.9513304867205, 4868.902621947541, 4896.730679812645, 5672.914906276409, 5698.943010569924, 5773.8556536086935, 5780.942190578125, 5808.186853840466, 4839.322494850724, 4852.708837469763, 4872.80508779652, 4897.534734200317, 4907.6564640475535, 5040.899182016339, 5042.268871013683, 5044.470330615306, 5045.47022562633, 5069.0, 5383.569314454912, 5384.784608615768, 5385.461453854583, 5390.218418329242, 5429.077056900336, 5740.512056475246, 5752.971235143965, 5783.103618939072, 5813.418658134153, 5820.970895145497, 5276.34045744282, 5352.652077614943, 5380.139177731544, 5420.159875219348, 5431.429699881455, 5669.858253543694, 5679.716014199191, 5752.942470575241, 5759.539236860957, 5759.65442073477, 5689.687067211177, 5786.450287222707, 5816.302043754777, 5819.970900145472, 5854.297484301911, 5603.467670571289, 5611.158326251095, 5623.634463759842, 5636.0, 5639.661620302795, 5501.944980550304, 5507.779688812403, 5537.141743029837, 5588.552915766811, 5610.382857885547, 5516.089845175501, 5547.916781248204, 5552.444755524415, 5565.415631358649, 5609.775608975595, 5607.214989901336, 5615.943840561542, 5624.240727501735, 5635.830925072254, 5648.406917273627, 5288.7355632219005, 5395.2176934343515, 5442.346918369821, 5505.03661859181, 5540.639858409352], "value": 5201.337972373897, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.4267615203231, 722.4256715910852, 735.6946867050175, 1058.3279617442922, 1079.6599071292546, 29455.0, 32885.83557082211, 32906.17734556637, 32916.34167316655, 33272.500912486335, 34178.8291058545, 34408.31183376331, 34463.0, 34581.30837383257, 34689.653103468954, 6533.836654083662, 6745.5278130531005, 6878.071460352839, 6883.931160688404, 6892.4830637702125, 6595.8021259362295, 6690.096836927026, 6691.096701945248, 6704.463642908556, 6704.9607310866895, 6669.0, 6730.764423245188, 6732.528722989393, 6734.46124310054, 6747.797566073025, 6661.76683816069, 6687.531872768908, 6705.6982435790505, 6729.663516824139, 6743.898841517381, 6512.5766825156215, 6536.379043990813, 6542.280349161589, 6551.377619126175, 6560.704768285439, 30413.847930760425, 30503.0, 30540.236494087603, 30582.541261881088, 30627.2343191422, 3042.254647611327, 3057.9235519111976, 3069.769767267464, 3076.7077127672837, 3083.260017595783, 23933.28200153998, 23987.280381588407, 24015.159469418486, 24023.279301620805, 24098.87950560236, 2987.865546050433, 2992.7605791536625, 3002.0093369188335, 3028.5608586754797, 3040.528718048706, 138074.0, 138251.30874345565, 138587.0, 145960.0, 148512.2574387121, 37221.441678374846, 37342.81328593394, 37439.25121497555, 37441.25117497635, 37447.81276093657, 39002.0, 39079.0, 39103.608963909996, 39174.216515670094, 39178.6082139175, 11190.776184476264, 11273.0, 11311.377874216998, 11312.490937907814, 11312.773744525228, 9003.954980225057, 9041.276697864156, 9060.0, 9065.138811813, 9076.183143517115, 12129.818052729217, 12166.635000949986, 12190.573329933588, 12280.385980700928, 12406.56577019818, 5235.947640523622, 5317.41508434072, 5428.321459817523, 5467.480589344006, 5499.120140777456, 865.8874346334936, 899.7705585075895, 900.6397441023643, 918.1094338491653, 935.4060171790826, 19831.504212394804, 20779.168833246804, 20803.791962080184, 21066.578668426544, 21153.68269475959, 973.1922504321396, 973.4159504297506, 977.1449981266392, 978.1538968791943, 997.4464172384396, 10377.481125943672, 11024.283421577733, 11068.723281918017, 11126.276792008493, 11242.437878106062, 165778.0, 165890.0, 167082.0, 167699.0, 167939.0, 38750.61249387526, 38913.0, 38956.0, 39000.6099938997, 39142.80428597896, 1175.9118066145074, 1202.044374722098, 1213.538855235005, 1213.9878601213875, 1219.5975328141692, 19316.903415482833, 19910.60178796445, 20751.688724669442, 20766.896165519076, 21122.788772112697, 28200.71799282063, 28245.293867653472, 28249.0, 28315.433691325645, 28321.291967700974, 139120.0, 139163.0, 139905.0, 140084.0, 140159.0, 27930.86034569814, 28173.295667607654, 28636.0, 29731.55402669005, 29982.201067935992, 34788.0, 34872.0, 34926.30147397089, 34970.47544286888, 35088.64911350854, 25721.614175787752, 26797.330066748487, 26935.191944241706, 27577.310567235978, 27734.722652773213, 26286.21141365762, 26724.331891702084, 27390.315242119108, 27489.72510274872, 27849.860750696927, 29881.252968675955, 29922.850385747934, 29935.101946941628, 29955.101346959626, 29987.100386988426, 25589.232323030337, 26310.86844565765, 26315.605265920643, 26740.732592673823, 27672.72327276782, 21263.68104478465, 21825.672614910472, 22079.558408832054, 22123.778762212172, 22185.44536386603], "value": 14029.562023240205, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.9770662613557, 418.7654913248583, 429.36239684069153, 432.7273817494978, 442.321037207886, 13022.54421095262, 13157.539486117988, 17194.48416547504, 18126.3655772048, 18136.54658633535, 18755.812441875576, 18820.62358752824, 18836.0, 19017.809821901777, 19054.618907621872, 5400.675959442427, 5438.184272359138, 5593.105103183471, 5607.691576963265, 5635.971820140893, 5105.361829771278, 5249.370075590934, 5260.947390526084, 5272.736363181825, 5275.340582427197, 5142.820001299955, 5354.036273470773, 5397.595180361469, 5432.70120143392, 5463.644863083887, 5240.528352448298, 5373.328333958255, 5410.513053825135, 5423.701696406676, 5451.454854514556, 4915.410150781893, 4916.139675556799, 4924.079608952511, 4926.8768280793265, 4959.479254678279, 21616.675749863763, 21659.891700541553, 22006.779932200632, 22227.66658500124, 22423.551528969492, 1581.5334476329394, 1589.3404237241532, 1605.9882274167317, 1610.846969537892, 1610.9436169734004, 14387.928060359736, 14608.393076761547, 14721.631959200999, 14843.257837108209, 14905.552833415015, 2005.298145649011, 2010.5576773109892, 2045.9386218413472, 2048.5595596946728, 2055.5097554273184, 90417.54791226068, 91613.54193229058, 93761.0, 97067.51466242694, 99699.0030099697, 11016.449177541092, 11237.3257604544, 11387.37369444672, 11412.486438110305, 11424.257423267461, 15978.440754573767, 15994.280257388446, 16096.436624718079, 16096.597585060234, 16134.677306453805, 6994.860102798018, 7340.339369456668, 7354.485186036926, 7375.963120184365, 7468.439867009996, 6739.393454589111, 6755.1556055493065, 6925.965370173117, 6934.306569343126, 6969.7909062728195, 6969.0, 7075.540089894141, 7088.468364872655, 7100.218975912646, 7177.712891484282, 1992.8804271743743, 2022.1608032666572, 2059.4027731957863, 2068.2864411777914, 2183.1158380855777, 851.1531026628544, 886.5257087458178, 891.2780647675404, 894.4722613657973, 911.8221946720325, 16583.91708041452, 16624.3350265988, 16665.833341666672, 16844.157792110345, 17441.215145318492, 859.7936495241097, 874.3660845886808, 888.0764005434405, 890.0520945193348, 894.7807787092204, 9222.95388523053, 9280.303977201736, 9546.809063818824, 9548.0, 9588.0, 331031.0, 333665.0, 335367.0, 335952.0, 339634.0, 75412.24587754162, 76615.61692191503, 78005.0, 78653.0, 79327.0, 1029.4080903480528, 1053.1574740207957, 1070.7644318249972, 1071.517816982361, 1075.5805235957982, 14363.21002344881, 14368.640783980483, 14568.635784105481, 14721.263936802903, 15399.153046582545, 38216.235675286895, 38805.611943881326, 39764.00589985158, 39852.800735996134, 39930.60069399385, 47759.761201193774, 48119.75940120417, 49653.50346496489, 49796.751016244685, 50338.2449263254, 7680.846383072196, 7761.922380776346, 7839.333656639022, 7987.680492780224, 7994.40041996841, 12483.188592741442, 12497.500099995897, 12750.74498510006, 13069.869301306866, 13134.540291089766, 10807.135429165804, 11115.72210694739, 11159.944200278947, 11229.3262404256, 11257.774844503228, 10341.896581034394, 10406.427646479517, 10575.206859485723, 10603.628872989408, 10701.304415212986, 10585.735356615838, 11294.209405341548, 11553.422328883691, 11609.245399049034, 11652.184347095623, 8413.116622754522, 8565.314774818124, 8573.871391929002, 8808.735737927873, 8883.466991980502, 9999.999999999884, 10693.572257109628, 10757.623483178364, 11346.829797552879, 11471.13966452536], "value": 8761.23822067442, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1250.8811662892024, 1320.6104199261217, 1328.8604696506873, 1335.6059962311117, 1348.0563605476164, 10322.380657160566, 10800.135989120861, 10818.945905270482, 10820.67537973861, 10935.125189984801, 10709.732256693587, 10880.782384352307, 10931.01620854123, 10960.506777195025, 10987.285826421277, 2243.540074284772, 2270.7048083749173, 2292.277932451281, 2294.139697613395, 2297.2074634251157, 2115.788421157887, 2155.741311042669, 2174.662927246279, 2178.70587470691, 2185.4208634711736, 2070.2960993262286, 2100.6030989392034, 2112.86266392684, 2119.5548934723724, 2127.1491403438595, 2092.5396412789164, 2102.8317734581274, 2112.7992840680113, 2116.947076323089, 2122.554263604645, 2036.98981505093, 2073.139647046474, 2146.527763891957, 2148.430665873545, 2153.91384344626, 10506.737331566696, 10554.261201715883, 10572.682819515427, 10612.946935265274, 10653.893461065367, 5517.862053448655, 5699.829005129853, 5706.3722990471015, 5727.713614319267, 5730.140478928194, 3337.499375093731, 3425.092350527112, 3451.0854623524788, 3474.062003259106, 3503.667151620592, 1091.8962698543626, 1097.9341239525575, 1099.411814679151, 1120.3445984099312, 1137.5449820071954, 15655.686886262325, 15797.131157786433, 15853.207339632972, 15864.762028569581, 15869.920650396789, 4839.879003024953, 4844.781984810692, 4876.707397556087, 4921.729304888266, 4954.677945933503, 11308.0, 11319.660410187707, 11329.037031852386, 11357.545698172145, 11363.715907102223, 5473.7263136843, 5669.177969194526, 5681.57388195887, 5724.79963201286, 5727.885442291131, 5259.289995850511, 5287.07476191665, 5299.920501192485, 5303.522682958553, 5318.388385335736, 3811.2187001664593, 3876.26350993316, 3951.762894226298, 3957.3074711925296, 3972.106276087915, 1111.744298811278, 1120.176670147441, 1127.537709539085, 1137.5051852444212, 1137.6814491942268, 674.140470899607, 702.7189124350301, 705.2947052947053, 724.0948813982521, 724.576122968059, 5386.703731294738, 5471.671699698031, 5472.042392581282, 5544.085225937675, 5608.719564021782, 512.6104160837716, 513.3736841053908, 515.6905856486153, 519.413063238538, 522.4070679778479, 3465.7227421806197, 3762.398016317431, 3769.6607305342104, 3846.4614953906475, 3886.657474571866, 13173.27546984925, 14183.361748721332, 14251.57245282643, 14266.072705274124, 14271.928640356731, 13526.120802147829, 13720.176789392468, 14044.78932815988, 14124.43502259898, 14144.787828182585, 7467.51461155034, 7549.396048316122, 7655.349295309961, 7732.497387669783, 7782.571958542335, 5616.0, 5744.0, 5862.853428664317, 5875.118732190205, 6079.05774604937, 12395.380230988234, 12437.564685235973, 12529.812052819032, 12587.24476531411, 12706.745865082832, 12507.624771256877, 12730.07208342068, 12768.425420855898, 12832.55086071983, 13058.21650700923, 8321.334293256647, 8497.617607207814, 8554.18735220153, 8578.485290882567, 8578.78553036179, 9492.288078394286, 9628.133467987635, 9659.116472287837, 9728.464934428674, 9733.659321923698, 7762.184970578234, 7837.647305871135, 7875.369970402468, 7900.130985591695, 8100.554469503998, 8062.153473885158, 8078.9192108080515, 8101.513909165469, 8208.0, 8232.711855085043, 7283.198848126596, 7419.962900185465, 7426.5915374654915, 7427.0, 7431.442641801995, 5359.303290572357, 5359.651622644516, 5382.838514844561, 5438.211459338295, 5636.605437619492, 4963.354763880672, 4990.950090499194, 5027.2207807789855, 5196.922046169235, 5275.894482110413], "value": 4740.794231665634, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.9036345731838, 389.6843556719058, 391.9725619206655, 394.2784703991695, 399.57445320733433, 5461.453854614537, 5543.611947163695, 5565.30433695788, 5572.108462645972, 5597.720113994299, 5386.676799392029, 5453.464139175283, 5473.2063850741615, 5483.983808905096, 5492.47821456962, 4142.357934520147, 4143.274926887782, 4156.771377574232, 4156.916861662765, 4156.937645935313, 4103.850921741917, 4106.7761806981525, 4131.2357213915375, 4152.854650087247, 4164.458620379346, 4132.29750942339, 4143.56492568279, 4154.984832356305, 4158.251514727363, 4161.646260067898, 4101.364288535252, 4101.589841015904, 4119.340905455143, 4129.463169787939, 4131.132462182945, 3570.62508436613, 3602.189507360849, 3604.279144171176, 3614.5662520497444, 3614.951254594844, 5110.6422550421485, 5291.682499050031, 5294.364676238837, 5311.964166987439, 5330.466953304677, 4811.59101476375, 4815.927761083586, 4828.0, 4843.321934929113, 4845.127876982142, 5709.914351284734, 5819.24349834523, 5828.870593877361, 5830.3586605473365, 5831.941680583224, 3955.6044395560216, 3984.6413822755803, 3997.380406037069, 4008.6793056555407, 4014.698897582664, 5924.911126333109, 6101.176341193926, 6151.569390142692, 6153.84615384619, 6159.661218632973, 4069.552349241581, 4114.19773144234, 4114.362273847559, 4134.565870583606, 4134.834606615762, 4193.811278492475, 4195.1819395217635, 4197.055662475979, 4198.85304014358, 4203.5376108628025, 4732.266498692708, 4817.434333841446, 4830.130576496264, 4837.637177211653, 4849.830255941025, 5816.302043754692, 5825.88348233033, 5826.65040097587, 5827.388124246893, 5835.591508594358, 1434.5624584501618, 1435.3110506956511, 1450.8259008918997, 1453.25157543865, 1456.2645863838904, 954.6992697300328, 955.0926619711302, 962.1484985787629, 964.609333220047, 964.6816550538306, 5056.115179843513, 5060.924086138711, 5067.037262920034, 5082.3228334649475, 5086.415062267813, 5986.2217911671205, 6014.48876845473, 6024.8853962017165, 6030.638161710312, 6075.5747097703625, 4900.656954013185, 4968.130577148984, 4999.500049994971, 4999.800007999712, 5008.5993120550265, 3179.952300715491, 3180.3162320101287, 3201.6478187399366, 3201.791883527563, 3203.855826487814, 5471.945280547223, 5610.80184294948, 5611.298587676541, 5616.326040875121, 5644.689542075143, 6143.84640383994, 6159.199304090529, 6164.907526387108, 6177.227846519185, 6197.659128747962, 5601.263608281364, 5603.243562119062, 5621.297337832771, 5624.74688639004, 5640.971795140998, 5859.5019423347785, 5968.134620480093, 6023.216981792339, 6027.758889644365, 6051.697415129138, 5705.515031222392, 5921.792737254175, 5922.0, 5923.881522369442, 5931.495822854933, 5604.523615492566, 5622.409646987171, 5626.803061892814, 5669.433056694297, 5674.687892165971, 4121.948903029708, 4139.91720165589, 4145.7719825409895, 4149.481314835645, 4150.750954942713, 5960.0, 6046.727897244723, 6102.542309326729, 6118.112873633388, 6119.84700382494, 5844.6493210405815, 5855.385184555731, 5876.823695289148, 5886.117082437669, 5905.675187864708, 5757.712114394348, 5843.970780146072, 5861.413858614104, 5874.647521148745, 5885.882282354243, 5741.511971482304, 5758.740856661544, 5763.36602973681, 5782.2194003808945, 5786.07422812348, 5845.678487683218, 5869.090291004901, 5876.676782776988, 5888.146218798164, 5919.91120133207, 5603.67545421098, 5675.744591493475, 5700.315962084576, 5734.885302294014, 5771.711414429178], "value": 4346.778855758322, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.2663922963201, 684.4490185400751, 690.0063907972519, 716.3851011525949, 738.4166508458314, 13038.869611303884, 13880.722385552283, 13891.166530008193, 15732.134732589702, 16252.18739063045, 15986.12076335801, 16042.0, 16116.952398094116, 16158.111303878282, 16263.186840657949, 880.3793325705378, 917.2616044084509, 921.9907800921972, 922.128588483883, 923.2936803345447, 877.9692710755124, 901.2969883490855, 927.5594092805896, 935.6163972771166, 935.7520257131865, 963.109124060245, 965.242284806427, 968.7529679931607, 969.2536746705033, 973.2019743810043, 954.8472244440856, 959.0697023886819, 960.5101398286854, 964.8022155458115, 965.4979410706428, 698.3749544158001, 702.3468174597622, 704.5279662626053, 706.6890568149997, 706.9893951590731, 14246.786298205536, 14489.78265326021, 14542.127472351693, 14567.781483277759, 14605.12369257848, 16139.435119770751, 16772.0, 16777.580560485963, 16797.496075117768, 16803.663926721398, 12301.876981230163, 12357.752844943141, 12770.042246831432, 12810.487580496769, 12830.294333811637, 2826.4488424757183, 2836.61705669734, 2838.389746204555, 2850.7719382449354, 2882.3802882380387, 77978.61010694967, 79468.60265698693, 79525.0, 80160.0, 80578.99999999942, 12553.686157845945, 12652.683682907817, 12692.111552191443, 12698.873011269769, 12741.10812243134, 23005.769942300696, 23923.641145382833, 24034.519309613708, 24068.39829004289, 24070.39824004414, 6185.226846644169, 6242.250929888442, 6267.2479302484, 6280.309165991828, 6289.150964619717, 2980.8509574521186, 3135.6394014688603, 3145.2294187924103, 3145.968540314613, 3150.810951342881, 3639.3085313790293, 3723.646253605957, 3741.1021354874633, 3746.756460830037, 3756.2908876461142, 721.8664547058811, 755.056179775281, 759.5708424740114, 761.5621017914722, 761.6191904047976, 594.8364199844991, 607.5382709140996, 610.8747706720112, 627.1314229791681, 635.8442181665522, 10377.325473844176, 10540.15678745714, 10830.51262693165, 10979.286346387618, 11088.112950963903, 562.1202817590458, 562.7158285066097, 565.2482198675751, 603.3544107804695, 628.6416742456847, 4369.60673539383, 4476.664250181184, 4585.1746685596245, 4639.141758774637, 4668.206404911173, 74183.62908185425, 74352.62823685956, 76176.0, 76541.0, 78632.13678632092, 63556.36443635504, 64244.67877660582, 64634.0, 65282.0, 65363.34636653668, 45913.0, 52586.0, 56333.0, 59760.70119649374, 59817.401825981186, 10484.270095434167, 10977.670669879917, 11121.610743623934, 11182.049525790399, 11298.265612735146, 28107.0, 28475.857620711762, 28915.85542072276, 28932.710672893, 29501.704982949897, 35045.299094017464, 35050.64949350474, 35178.296434071686, 35228.295434091684, 35812.28375432529, 13471.25908075026, 13521.121127126706, 13711.520096796565, 13801.102928310029, 13873.0, 15060.246987650793, 15116.924415377853, 15217.6195595111, 15394.07635541871, 15494.07035577869, 14211.573652790434, 14299.85700143027, 14319.427222911383, 14365.856341436453, 14446.349914253673, 15242.237888105328, 15249.31378088011, 15396.46112386061, 15431.074135551902, 15720.0, 14814.0, 14836.48072317507, 15224.695506090038, 15415.075095494307, 15465.381384744484, 9562.235021198427, 9800.41197528122, 9885.209183265179, 10084.899151008396, 10400.115990140923, 10754.933799650262, 10855.18586106061, 11220.15848811326, 11407.828882566602, 11421.0], "value": 7090.890721402106, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1561.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 111.0, 111.0, 110.0, 110.0, 112.0, 113.0, 113.0, 113.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 135.0, 202.0, 132.0, 131.0, 133.0, 127.0, 144.0, 124.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 164.0, 165.0, 170.0, 167.0, 167.0, 164.0, 163.0, 164.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 107.0, 74.0, 74.0, 74.0, 74.0, 104.0, 74.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 106.0, 83.0, 84.0, 85.0, 96.0, 84.0, 84.0, 107.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 151.0, 151.0, 149.0, 150.0, 150.0, 150.0, 150.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 55.0, 56.0, 57.0, 53.0, 56.0, 55.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 56.0, 57.0, 56.0, 57.0, 57.0, 57.0, 57.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 87.0, 87.0, 87.0, 86.0, 93.0, 89.0, 116.0, 88.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 138.0, 136.0, 142.0, 140.0, 136.0, 138.0, 137.0, 136.0, 140.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 199.0, 207.0, 196.0, 200.0, 200.0, 207.0, 196.0, 196.0, 203.0], "value": 199.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 74.0, 73.0, 74.0, 72.0, 77.0, 73.0, 79.0, 75.0], "value": 74.9, "unit": "score"}]}]} 10:34:17 INFO - Return code: 0 10:34:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:34:17 INFO - # TBPL SUCCESS # 10:34:17 INFO - Running post-action listener: _resource_record_post_action 10:34:17 INFO - [mozharness: 2017-05-24 17:34:17.346535Z] Finished run-tests step (success) 10:34:17 INFO - Running post-run listener: _resource_record_post_run 10:34:17 INFO - Total resource usage - Wall time: 1257s; CPU: 13.0%; Read bytes: 4096; Write bytes: 408739840; Read time: 8; Write time: 273540 10:34:17 INFO - TinderboxPrint: CPU usage
12.8% 10:34:17 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 10:34:17 INFO - TinderboxPrint: I/O write bytes / time
408,739,840 / 273,540 10:34:17 INFO - TinderboxPrint: CPU idle
8,746.8 (87.2%) 10:34:17 INFO - TinderboxPrint: CPU user
1,230.1 (12.3%) 10:34:17 INFO - TinderboxPrint: Swap in / out
0 / 0 10:34:17 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 96342016; Read time: 0; Write time: 77064 10:34:17 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 0; Write bytes: 312397824; Read time: 0; Write time: 196476 10:34:18 INFO - Running post-run listener: _upload_blobber_files 10:34:18 INFO - Blob upload gear active. 10:34:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:34:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:34:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:34:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:34:18 INFO - (blobuploader) - INFO - Open directory for files ... 10:34:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:34:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:34:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:34:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:34:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:34:19 INFO - (blobuploader) - INFO - Done attempting. 10:34:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:34:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:34:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:34:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:34:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:34:19 INFO - (blobuploader) - INFO - Done attempting. 10:34:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:34:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:34:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:34:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:34:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:34:20 INFO - (blobuploader) - INFO - Done attempting. 10:34:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:34:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:34:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:34:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:34:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:34:27 INFO - (blobuploader) - INFO - Done attempting. 10:34:27 INFO - (blobuploader) - INFO - Iteration through files over. 10:34:27 INFO - Return code: 0 10:34:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:34:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:34:27 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3004227eadb30581fa90ddec3b0c573660a4bc00c542c8c9f4eb95895c0faf290c9ef749aae98e00acee8d147a9f111c3b032683e9f51b4cf72150606ce8642", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0fe8bd170a074865b8063b0da921bea3e4821aa2d76c109e1fb4916db37b96b4e2b2504131611863ba2e63e1ee49216f5ec13eca50ee5d161b5486bf5628bf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b0facdf1b30727da12714af024c442b0f5a3ec5055f8f23b3264274e9c210edab19d98a466753281ddb9faa70f4629d7985161f644b397a30b0a389bf5647c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75af69f4deec1a8ff83b1798139c5abbc9b4b834008c11678f9583cb304c837d9b1f34376dbc0e56915d3c6d9f6ae8be7750f7945ac0c0ea1825d38e8b5f713f"} 10:34:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:34:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:34:27 INFO - Contents: 10:34:27 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3004227eadb30581fa90ddec3b0c573660a4bc00c542c8c9f4eb95895c0faf290c9ef749aae98e00acee8d147a9f111c3b032683e9f51b4cf72150606ce8642", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0fe8bd170a074865b8063b0da921bea3e4821aa2d76c109e1fb4916db37b96b4e2b2504131611863ba2e63e1ee49216f5ec13eca50ee5d161b5486bf5628bf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b0facdf1b30727da12714af024c442b0f5a3ec5055f8f23b3264274e9c210edab19d98a466753281ddb9faa70f4629d7985161f644b397a30b0a389bf5647c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75af69f4deec1a8ff83b1798139c5abbc9b4b834008c11678f9583cb304c837d9b1f34376dbc0e56915d3c6d9f6ae8be7750f7945ac0c0ea1825d38e8b5f713f"} 10:34:27 INFO - Running post-run listener: copy_logs_to_upload_dir 10:34:27 INFO - Copying logs to upload dir... 10:34:27 INFO - mkdir: /builds/slave/test/build/upload/logs 10:34:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1318.539473 ========= master_lag: 0.18 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2017-05-24 10:34:26.887800) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-24 10:34:26.892009) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918 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/sha512/c3004227eadb30581fa90ddec3b0c573660a4bc00c542c8c9f4eb95895c0faf290c9ef749aae98e00acee8d147a9f111c3b032683e9f51b4cf72150606ce8642", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0fe8bd170a074865b8063b0da921bea3e4821aa2d76c109e1fb4916db37b96b4e2b2504131611863ba2e63e1ee49216f5ec13eca50ee5d161b5486bf5628bf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b0facdf1b30727da12714af024c442b0f5a3ec5055f8f23b3264274e9c210edab19d98a466753281ddb9faa70f4629d7985161f644b397a30b0a389bf5647c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75af69f4deec1a8ff83b1798139c5abbc9b4b834008c11678f9583cb304c837d9b1f34376dbc0e56915d3c6d9f6ae8be7750f7945ac0c0ea1825d38e8b5f713f"} build_url:https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011292 build_url: 'https://queue.taskcluster.net/v1/task/Pmdkm0SbSRSzyDU5h1C7HQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3004227eadb30581fa90ddec3b0c573660a4bc00c542c8c9f4eb95895c0faf290c9ef749aae98e00acee8d147a9f111c3b032683e9f51b4cf72150606ce8642", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0fe8bd170a074865b8063b0da921bea3e4821aa2d76c109e1fb4916db37b96b4e2b2504131611863ba2e63e1ee49216f5ec13eca50ee5d161b5486bf5628bf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b0facdf1b30727da12714af024c442b0f5a3ec5055f8f23b3264274e9c210edab19d98a466753281ddb9faa70f4629d7985161f644b397a30b0a389bf5647c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75af69f4deec1a8ff83b1798139c5abbc9b4b834008c11678f9583cb304c837d9b1f34376dbc0e56915d3c6d9f6ae8be7750f7945ac0c0ea1825d38e8b5f713f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-24 10:34:26.919085) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 10:34:26.919471) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1495644437.874601-1325371918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004646 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 10:34:26.969657) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-24 10:34:26.970011) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-24 10:34:26.970383) ========= ========= Total master_lag: 0.31 =========