builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-021 starttime: 1495675847.35 results: success (0) revision: d10f5ccd882b965fcad39914f7c3c930d1301a41 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-24 18:30:47.348704) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-24 18:30:47.349152) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-24 18:30:47.349424) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-24 18:30:47.365322) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 18:30:47.365702) ========= 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=df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-24 18:30:47-- 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% 47.9K=0.2s 2017-05-24 18:30:47 (47.9 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.396706 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 18:30:47.775613) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 18:30:47.779028) ========= 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=df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020409 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 18:30:47.828643) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-24 18:30:47.829016) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d10f5ccd882b965fcad39914f7c3c930d1301a41 --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 d10f5ccd882b965fcad39914f7c3c930d1301a41 --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=df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-24 18:30:47,849 truncating revision to first 12 chars 2017-05-24 18:30:47,849 Setting DEBUG logging. 2017-05-24 18:30:47,850 attempt 1/10 2017-05-24 18:30:47,850 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d10f5ccd882b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-24 18:30:48,897 unpacking tar archive at: mozilla-central-d10f5ccd882b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.400318 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-24 18:30:49.244622) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-24 18:30:49.248078) ========= script_repo_revision: d10f5ccd882b965fcad39914f7c3c930d1301a41 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-24 18:30:49.248539) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-24 18:30:49.248818) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-24 18:30:49.258974) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2017-05-24 18:30:49.259359) ========= /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=df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:30:49 INFO - MultiFileLogger online at 20170524 18:30:49 in /builds/slave/test 18:30:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:30:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:30:49 INFO - {'append_to_log': False, 18:30:49 INFO - 'base_work_dir': '/builds/slave/test', 18:30:49 INFO - 'blob_upload_branch': 'Firefox', 18:30:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:30:49 INFO - 'branch': 'Firefox', 18:30:49 INFO - 'buildbot_json_path': 'buildprops.json', 18:30:49 INFO - 'config_files': ('talos/linux_config.py',), 18:30:49 INFO - 'default_actions': ('clobber', 18:30:49 INFO - 'read-buildbot-config', 18:30:49 INFO - 'download-and-extract', 18:30:49 INFO - 'populate-webroot', 18:30:49 INFO - 'create-virtualenv', 18:30:49 INFO - 'install', 18:30:49 INFO - 'run-tests'), 18:30:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:30:49 INFO - 'download_minidump_stackwalk': True, 18:30:49 INFO - 'download_symbols': 'ondemand', 18:30:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:30:49 INFO - 'tooltool.py': '/tools/tooltool.py', 18:30:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:30:49 INFO - '/tools/misc-python/virtualenv.py')}, 18:30:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:30:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:30:49 INFO - 'gecko_profile': False, 18:30:49 INFO - 'gecko_profile_interval': 0, 18:30:49 INFO - 'installer_path': 'installer.exe', 18:30:49 INFO - 'log_level': 'info', 18:30:49 INFO - 'log_name': 'talos', 18:30:49 INFO - 'log_to_console': True, 18:30:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:30:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:30:49 INFO - 'opt_config_files': (), 18:30:49 INFO - 'pip_index': False, 18:30:49 INFO - 'suite': 'dromaeojs-e10s', 18:30:49 INFO - 'system_bits': '32', 18:30:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:30:49 INFO - 'title': 'talos-linux64-ix-021', 18:30:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:30:49 INFO - 'use_talos_json': True, 18:30:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:30:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:30:49 INFO - 'work_dir': 'build'} 18:30:49 INFO - [mozharness: 2017-05-25 01:30:49.377475Z] Running clobber step. 18:30:49 INFO - Running pre-action listener: _resource_record_pre_action 18:30:49 INFO - Running main action method: clobber 18:30:49 INFO - rmtree: /builds/slave/test/build 18:30:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:30:51 INFO - Running post-action listener: _resource_record_post_action 18:30:51 INFO - [mozharness: 2017-05-25 01:30:51.317744Z] Finished clobber step (success) 18:30:51 INFO - [mozharness: 2017-05-25 01:30:51.317843Z] Running read-buildbot-config step. 18:30:51 INFO - Running pre-action listener: _resource_record_pre_action 18:30:51 INFO - Running main action method: read_buildbot_config 18:30:51 INFO - Using buildbot properties: 18:30:51 INFO - { 18:30:51 INFO - "project": "", 18:30:51 INFO - "product": "firefox", 18:30:51 INFO - "who": "ryanvm@gmail.com", 18:30:51 INFO - "installer_path": "public/build/target.tar.bz2", 18:30:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 18:30:51 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:30:51 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 18:30:51 INFO - "stage_platform": "linux64-stylosequential", 18:30:51 INFO - "basedir": "/builds/slave/test", 18:30:51 INFO - "buildnumber": 17, 18:30:51 INFO - "platform": "ubuntu64_hw_styloseq", 18:30:51 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:30:51 INFO - "slavebuilddir": "test", 18:30:51 INFO - "taskId": "dpBLWweaRrikUMBhgsfj4Q", 18:30:51 INFO - "branch": "mozilla-central", 18:30:51 INFO - "script_repo_revision": "production", 18:30:51 INFO - "revision": "d10f5ccd882b965fcad39914f7c3c930d1301a41", 18:30:51 INFO - "slavename": "talos-linux64-ix-021", 18:30:51 INFO - "repo_path": "mozilla-central" 18:30:51 INFO - } 18:30:51 INFO - Finding installer, test and symbols from parent task. 18:30:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dpBLWweaRrikUMBhgsfj4Q'}, attempt #1 18:30:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dpBLWweaRrikUMBhgsfj4Q'}, attempt #1 18:30:52 INFO - Task dependencies: S9A9DE2BT9iTQraJI7917g 18:30:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g'}, attempt #1 18:30:52 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/target.tar.bz2 18:30:52 INFO - Set test_url: https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/test_packages.json 18:30:52 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/target.crashreporter-symbols.zip 18:30:52 INFO - Running post-action listener: _resource_record_post_action 18:30:52 INFO - [mozharness: 2017-05-25 01:30:52.682154Z] Finished read-buildbot-config step (success) 18:30:52 INFO - [mozharness: 2017-05-25 01:30:52.682374Z] Running download-and-extract step. 18:30:52 INFO - Running pre-action listener: _resource_record_pre_action 18:30:52 INFO - Running main action method: download_and_extract 18:30:52 INFO - mkdir: /builds/slave/test/build/tests 18:30:52 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')]} 18:30:52 INFO - trying https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/target.test_packages.json 18:30:52 INFO - Downloading https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:30:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:30:53 INFO - Downloaded 989 bytes. 18:30:53 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:30:53 INFO - Using the following test package requirements: 18:30:53 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:30:53 INFO - u'common': [u'target.common.tests.zip'], 18:30:53 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:30:53 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:30:53 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:30:53 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:30:53 INFO - u'mozbase': [u'target.common.tests.zip'], 18:30:53 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:30:53 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:30:53 INFO - u'web-platform': [u'target.common.tests.zip', 18:30:53 INFO - u'target.web-platform.tests.tar.gz'], 18:30:53 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:30:53 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:30:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/target.common.tests.zip 18:30:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:30:53 INFO - Fetch https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/target.common.tests.zip into memory 18:30:54 INFO - Content-Length response header: 63523807 18:30:54 INFO - Bytes received: 63523807 18:31:05 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:31:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/target.common.tests.zip 18:31:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:31:05 INFO - Fetch https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/target.common.tests.zip into memory 18:31:06 INFO - Content-Length response header: 63523807 18:31:06 INFO - Bytes received: 63523807 18:31:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/target.talos.tests.zip 18:31:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:31:19 INFO - Fetch https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/target.talos.tests.zip into memory 18:31:19 INFO - Content-Length response header: 14411859 18:31:19 INFO - Bytes received: 14411859 18:31: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')]} 18:31:19 INFO - trying https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/target.tar.bz2 18:31:19 INFO - Downloading https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:31:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:31:21 INFO - Downloaded 55561194 bytes. 18:31:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/target.tar.bz2 18:31:21 INFO - mkdir: /builds/slave/test/properties 18:31:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:31:21 INFO - Writing to file /builds/slave/test/properties/build_url 18:31:21 INFO - Contents: 18:31:21 INFO - build_url:https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/target.tar.bz2 18:31:21 INFO - Running post-action listener: _resource_record_post_action 18:31:21 INFO - Running post-action listener: set_extra_try_arguments 18:31:21 INFO - [mozharness: 2017-05-25 01:31:21.142259Z] Finished download-and-extract step (success) 18:31:21 INFO - [mozharness: 2017-05-25 01:31:21.142356Z] Running populate-webroot step. 18:31:21 INFO - Running pre-action listener: _resource_record_pre_action 18:31:21 INFO - Running main action method: populate_webroot 18:31:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:31:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:31:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:31:21 INFO - '--tppagecycles', 18:31:21 INFO - '7'], 18:31:21 INFO - 'tests': ['tsvgm']}}, 18:31:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:31:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:31:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:31:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:31:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:31:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:31:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:31:21 INFO - 'talos_options': ['--disable-e10s'], 18:31:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:31:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:31:21 INFO - 'talos_options': ['--disable-e10s'], 18:31:21 INFO - 'tests': ['damp', 'tps']}, 18:31:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:31:21 INFO - 'tests': ['damp', 'tps']}, 18:31:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:31:21 INFO - 'tests': ['dromaeo_dom']}, 18:31:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:31:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:31:21 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:31:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:31:21 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:31:21 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:31:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:31:21 INFO - 'tests': ['a11yr', 18:31:21 INFO - 'ts_paint', 18:31:21 INFO - 'tpaint', 18:31:21 INFO - 'sessionrestore', 18:31:21 INFO - 'sessionrestore_no_auto_restore', 18:31:21 INFO - 'tabpaint']}, 18:31:21 INFO - 'other-e10s': {'tests': ['a11yr', 18:31:21 INFO - 'ts_paint', 18:31:21 INFO - 'tpaint', 18:31:21 INFO - 'sessionrestore', 18:31:21 INFO - 'sessionrestore_no_auto_restore', 18:31:21 INFO - 'tabpaint']}, 18:31:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:31:21 INFO - 'ts_paint', 18:31:21 INFO - 'tpaint', 18:31:21 INFO - 'sessionrestore', 18:31:21 INFO - 'sessionrestore_no_auto_restore', 18:31:21 INFO - 'tabpaint']}, 18:31:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:31:21 INFO - 'ts_paint', 18:31:21 INFO - 'tpaint', 18:31:21 INFO - 'sessionrestore', 18:31:21 INFO - 'sessionrestore_no_auto_restore', 18:31:21 INFO - 'tabpaint']}, 18:31:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:31:21 INFO - 'tests': ['a11yr', 18:31:21 INFO - 'ts_paint', 18:31:21 INFO - 'tpaint', 18:31:21 INFO - 'sessionrestore', 18:31:21 INFO - 'sessionrestore_no_auto_restore', 18:31:21 INFO - 'tabpaint']}, 18:31:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:31:21 INFO - 'tests': ['a11yr', 18:31:21 INFO - 'ts_paint', 18:31:21 INFO - 'tpaint', 18:31:21 INFO - 'sessionrestore', 18:31:21 INFO - 'sessionrestore_no_auto_restore', 18:31:21 INFO - 'tabpaint']}, 18:31:21 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 18:31:21 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 18:31:21 INFO - 'bloom_basic_ref']}, 18:31:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:31:21 INFO - 'tests': ['tsvgx', 18:31:21 INFO - 'tsvgr_opacity', 18:31:21 INFO - 'tart', 18:31:21 INFO - 'tscrollx', 18:31:21 INFO - 'cart', 18:31:21 INFO - 'tsvg_static']}, 18:31:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:31:21 INFO - 'tsvgr_opacity', 18:31:21 INFO - 'tart', 18:31:21 INFO - 'tscrollx', 18:31:21 INFO - 'cart', 18:31:21 INFO - 'tsvg_static']}, 18:31:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:31:21 INFO - 'talos_options': ['--disable-e10s'], 18:31:21 INFO - 'tests': ['tp5o']}, 18:31:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:31:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:31:21 INFO - 'talos_options': ['--disable-e10s', 18:31:21 INFO - '--xperf_path', 18:31:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:21 INFO - 'tests': ['tp5n']}, 18:31:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:31:21 INFO - 'talos_options': ['--xperf_path', 18:31:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:21 INFO - 'tests': ['tp5n']}}, 18:31:21 INFO - 'talos.zip': {'path': '', 18:31:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:31:21 INFO - Running post-action listener: _resource_record_post_action 18:31:21 INFO - [mozharness: 2017-05-25 01:31:21.156244Z] Finished populate-webroot step (success) 18:31:21 INFO - [mozharness: 2017-05-25 01:31:21.156332Z] Running create-virtualenv step. 18:31:21 INFO - Running pre-action listener: _resource_record_pre_action 18:31:21 INFO - Running main action method: create_virtualenv 18:31:21 INFO - Creating virtualenv /builds/slave/test/build/venv 18:31:21 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 18:31:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:31:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:31:21 INFO - Using real prefix '/usr' 18:31:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:31:21 INFO - Installing distribute.............................................................................................................................................................................................done. 18:31:23 INFO - Installing pip.................done. 18:31:23 INFO - Return code: 0 18:31:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:31:23 INFO - Reading from file tmpfile_stdout 18:31:23 INFO - Output received: 18:31:23 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) 18:31:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:31:23 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')]} 18:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:23 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')]} 18:31:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:23 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 0x29531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc65c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc37a0>, '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 0x2cc46a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4b30>, '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': 'df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553', '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 18:31:23 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 18:31:23 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 18:31:23 INFO - Using env: {'DISPLAY': ':0', 18:31:23 INFO - 'HOME': '/home/cltbld', 18:31:23 INFO - 'LANG': 'en_US.UTF-8', 18:31:23 INFO - 'LANGUAGE': 'en_US:en', 18:31:23 INFO - 'LOGNAME': 'cltbld', 18:31:23 INFO - 'MAIL': '/var/mail/cltbld', 18:31:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:23 INFO - 'MOZ_NO_REMOTE': '1', 18:31:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:23 INFO - 'NO_EM_RESTART': '1', 18:31:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:23 INFO - 'PWD': '/builds/slave/test', 18:31:23 INFO - 'SHELL': '/bin/bash', 18:31:23 INFO - 'SHLVL': '1', 18:31:23 INFO - 'TERM': 'linux', 18:31:23 INFO - 'TMOUT': '86400', 18:31:23 INFO - 'USER': 'cltbld', 18:31:23 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553', 18:31:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:23 INFO - '_': '/tools/buildbot/bin/python'} 18:31:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:24 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 18:31:24 INFO - Cleaning up... 18:31:24 INFO - Return code: 0 18:31:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:31:24 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')]} 18:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:24 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')]} 18:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:24 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 0x29531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc65c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc37a0>, '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 0x2cc46a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4b30>, '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': 'df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553', '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 18:31:24 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 18:31:24 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 18:31:24 INFO - Using env: {'DISPLAY': ':0', 18:31:24 INFO - 'HOME': '/home/cltbld', 18:31:24 INFO - 'LANG': 'en_US.UTF-8', 18:31:24 INFO - 'LANGUAGE': 'en_US:en', 18:31:24 INFO - 'LOGNAME': 'cltbld', 18:31:24 INFO - 'MAIL': '/var/mail/cltbld', 18:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:24 INFO - 'MOZ_NO_REMOTE': '1', 18:31:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:24 INFO - 'NO_EM_RESTART': '1', 18:31:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:24 INFO - 'PWD': '/builds/slave/test', 18:31:24 INFO - 'SHELL': '/bin/bash', 18:31:24 INFO - 'SHLVL': '1', 18:31:24 INFO - 'TERM': 'linux', 18:31:24 INFO - 'TMOUT': '86400', 18:31:24 INFO - 'USER': 'cltbld', 18:31:24 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553', 18:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:24 INFO - '_': '/tools/buildbot/bin/python'} 18:31:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:24 INFO - Downloading/unpacking psutil>=3.1.1 18:31:24 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 18:31:24 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 18:31:24 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 18:31:24 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 18:31:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:31:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:25 INFO - Installing collected packages: psutil 18:31:25 INFO - Running setup.py install for psutil 18:31:25 INFO - building 'psutil._psutil_linux' extension 18:31:25 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 18:31:25 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 18:31:25 INFO - building 'psutil._psutil_posix' extension 18:31:25 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 18:31:25 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 18:31:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:26 INFO - Successfully installed psutil 18:31:26 INFO - Cleaning up... 18:31:26 INFO - Return code: 0 18:31:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc65c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc37a0>, '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 0x2cc46a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4b30>, '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': 'df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553', '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 18:31:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:31:26 INFO - Using env: {'DISPLAY': ':0', 18:31:26 INFO - 'HOME': '/home/cltbld', 18:31:26 INFO - 'LANG': 'en_US.UTF-8', 18:31:26 INFO - 'LANGUAGE': 'en_US:en', 18:31:26 INFO - 'LOGNAME': 'cltbld', 18:31:26 INFO - 'MAIL': '/var/mail/cltbld', 18:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:26 INFO - 'MOZ_NO_REMOTE': '1', 18:31:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:26 INFO - 'NO_EM_RESTART': '1', 18:31:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:26 INFO - 'PWD': '/builds/slave/test', 18:31:26 INFO - 'SHELL': '/bin/bash', 18:31:26 INFO - 'SHLVL': '1', 18:31:26 INFO - 'TERM': 'linux', 18:31:26 INFO - 'TMOUT': '86400', 18:31:26 INFO - 'USER': 'cltbld', 18:31:26 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553', 18:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:26 INFO - '_': '/tools/buildbot/bin/python'} 18:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:31:26 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 18:31:26 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 18:31:26 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 18:31:26 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 18:31:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:31:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:31:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:31:27 INFO - Installing collected packages: mozsystemmonitor 18:31:27 INFO - Running setup.py install for mozsystemmonitor 18:31:27 INFO - Successfully installed mozsystemmonitor 18:31:27 INFO - Cleaning up... 18:31:27 INFO - Return code: 0 18:31:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc65c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc37a0>, '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 0x2cc46a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4b30>, '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': 'df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553', '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 18:31:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:31:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:31:27 INFO - Using env: {'DISPLAY': ':0', 18:31:27 INFO - 'HOME': '/home/cltbld', 18:31:27 INFO - 'LANG': 'en_US.UTF-8', 18:31:27 INFO - 'LANGUAGE': 'en_US:en', 18:31:27 INFO - 'LOGNAME': 'cltbld', 18:31:27 INFO - 'MAIL': '/var/mail/cltbld', 18:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:27 INFO - 'MOZ_NO_REMOTE': '1', 18:31:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:27 INFO - 'NO_EM_RESTART': '1', 18:31:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:27 INFO - 'PWD': '/builds/slave/test', 18:31:27 INFO - 'SHELL': '/bin/bash', 18:31:27 INFO - 'SHLVL': '1', 18:31:27 INFO - 'TERM': 'linux', 18:31:27 INFO - 'TMOUT': '86400', 18:31:27 INFO - 'USER': 'cltbld', 18:31:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553', 18:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:27 INFO - '_': '/tools/buildbot/bin/python'} 18:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:27 INFO - Downloading/unpacking jsonschema==2.5.1 18:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:31:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:29 INFO - Downloading functools32-3.2.3-2.tar.gz 18:31:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:31:29 INFO - warning: no files found matching '*.txt' 18:31:29 INFO - no previously-included directories found matching 'build' 18:31:29 INFO - no previously-included directories found matching 'dist' 18:31:29 INFO - no previously-included directories found matching '.git*' 18:31:29 INFO - Installing collected packages: jsonschema, functools32 18:31:29 INFO - Running setup.py install for functools32 18:31:29 INFO - warning: no files found matching '*.txt' 18:31:29 INFO - no previously-included directories found matching 'build' 18:31:29 INFO - no previously-included directories found matching 'dist' 18:31:29 INFO - no previously-included directories found matching '.git*' 18:31:29 INFO - Successfully installed jsonschema functools32 18:31:29 INFO - Cleaning up... 18:31:29 INFO - Return code: 0 18:31:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:29 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 0x29531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc65c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc37a0>, '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 0x2cc46a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4b30>, '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': 'df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553', '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 18:31:29 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 18:31:29 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 18:31:29 INFO - Using env: {'DISPLAY': ':0', 18:31:29 INFO - 'HOME': '/home/cltbld', 18:31:29 INFO - 'LANG': 'en_US.UTF-8', 18:31:29 INFO - 'LANGUAGE': 'en_US:en', 18:31:29 INFO - 'LOGNAME': 'cltbld', 18:31:29 INFO - 'MAIL': '/var/mail/cltbld', 18:31:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:29 INFO - 'MOZ_NO_REMOTE': '1', 18:31:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:29 INFO - 'NO_EM_RESTART': '1', 18:31:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:29 INFO - 'PWD': '/builds/slave/test', 18:31:29 INFO - 'SHELL': '/bin/bash', 18:31:29 INFO - 'SHLVL': '1', 18:31:29 INFO - 'TERM': 'linux', 18:31:29 INFO - 'TMOUT': '86400', 18:31:29 INFO - 'USER': 'cltbld', 18:31:29 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553', 18:31:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:29 INFO - '_': '/tools/buildbot/bin/python'} 18:31:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:31:29 INFO - Cleaning up... 18:31:29 INFO - Return code: 0 18:31:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:29 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 0x29531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc65c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc37a0>, '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 0x2cc46a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4b30>, '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': 'df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553', '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 18:31:29 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 18:31:29 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 18:31:29 INFO - Using env: {'DISPLAY': ':0', 18:31:29 INFO - 'HOME': '/home/cltbld', 18:31:29 INFO - 'LANG': 'en_US.UTF-8', 18:31:29 INFO - 'LANGUAGE': 'en_US:en', 18:31:29 INFO - 'LOGNAME': 'cltbld', 18:31:29 INFO - 'MAIL': '/var/mail/cltbld', 18:31:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:29 INFO - 'MOZ_NO_REMOTE': '1', 18:31:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:29 INFO - 'NO_EM_RESTART': '1', 18:31:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:29 INFO - 'PWD': '/builds/slave/test', 18:31:29 INFO - 'SHELL': '/bin/bash', 18:31:29 INFO - 'SHLVL': '1', 18:31:29 INFO - 'TERM': 'linux', 18:31:29 INFO - 'TMOUT': '86400', 18:31:29 INFO - 'USER': 'cltbld', 18:31:29 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553', 18:31:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:29 INFO - '_': '/tools/buildbot/bin/python'} 18:31:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:29 INFO - Downloading/unpacking blobuploader==1.2.4 18:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:30 INFO - Downloading blobuploader-1.2.4.tar.gz 18:31:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:31:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:31:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:31 INFO - Downloading docopt-0.6.1.tar.gz 18:31:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:31:31 INFO - Installing collected packages: blobuploader, requests, docopt 18:31:31 INFO - Running setup.py install for blobuploader 18:31:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:31:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:31:31 INFO - Running setup.py install for requests 18:31:32 INFO - Running setup.py install for docopt 18:31:32 INFO - Successfully installed blobuploader requests docopt 18:31:32 INFO - Cleaning up... 18:31:32 INFO - Return code: 0 18:31:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:32 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 0x29531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc65c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc37a0>, '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 0x2cc46a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4b30>, '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': 'df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553', '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 18:31:32 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 18:31:32 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 18:31:32 INFO - Using env: {'DISPLAY': ':0', 18:31:32 INFO - 'HOME': '/home/cltbld', 18:31:32 INFO - 'LANG': 'en_US.UTF-8', 18:31:32 INFO - 'LANGUAGE': 'en_US:en', 18:31:32 INFO - 'LOGNAME': 'cltbld', 18:31:32 INFO - 'MAIL': '/var/mail/cltbld', 18:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:32 INFO - 'MOZ_NO_REMOTE': '1', 18:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:32 INFO - 'NO_EM_RESTART': '1', 18:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:32 INFO - 'PWD': '/builds/slave/test', 18:31:32 INFO - 'SHELL': '/bin/bash', 18:31:32 INFO - 'SHLVL': '1', 18:31:32 INFO - 'TERM': 'linux', 18:31:32 INFO - 'TMOUT': '86400', 18:31:32 INFO - 'USER': 'cltbld', 18:31:32 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553', 18:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:32 INFO - '_': '/tools/buildbot/bin/python'} 18:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:32 INFO - Running setup.py (path:/tmp/pip-VNehtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:32 INFO - Running setup.py (path:/tmp/pip-1AkXZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:32 INFO - Running setup.py (path:/tmp/pip-gbRKqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:32 INFO - Running setup.py (path:/tmp/pip-TEjwIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:32 INFO - Running setup.py (path:/tmp/pip-5yr_Oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:32 INFO - Running setup.py (path:/tmp/pip-c0oi2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:32 INFO - Running setup.py (path:/tmp/pip-c7K3bJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:32 INFO - Running setup.py (path:/tmp/pip-3EyanI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:32 INFO - Running setup.py (path:/tmp/pip-HRVmgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:33 INFO - Running setup.py (path:/tmp/pip-XOEWOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:33 INFO - Running setup.py (path:/tmp/pip-mb5uom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:33 INFO - Running setup.py (path:/tmp/pip-xDHhkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:33 INFO - Running setup.py (path:/tmp/pip-tPrin3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:33 INFO - Running setup.py (path:/tmp/pip-O_XuKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:33 INFO - Running setup.py (path:/tmp/pip-gI28pP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:33 INFO - Running setup.py (path:/tmp/pip-frT7U0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:33 INFO - Running setup.py (path:/tmp/pip-yD5wHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:31:33 INFO - Running setup.py install for manifestparser 18:31:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:31:33 INFO - Running setup.py install for mozcrash 18:31:33 INFO - Running setup.py install for mozdebug 18:31:33 INFO - Running setup.py install for mozdevice 18:31:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:31:34 INFO - Running setup.py install for mozfile 18:31:34 INFO - Running setup.py install for mozhttpd 18:31:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:31:34 INFO - Running setup.py install for mozinfo 18:31:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:31:34 INFO - Running setup.py install for mozInstall 18:31:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:31:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:31:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:31:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:31:34 INFO - Running setup.py install for mozleak 18:31:34 INFO - Running setup.py install for mozlog 18:31:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:31:34 INFO - Running setup.py install for moznetwork 18:31:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:31:34 INFO - Running setup.py install for mozprocess 18:31:34 INFO - Running setup.py install for mozprofile 18:31:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:31:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:31:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:31:34 INFO - Running setup.py install for mozrunner 18:31:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:31:35 INFO - Running setup.py install for mozscreenshot 18:31:35 INFO - Running setup.py install for moztest 18:31:35 INFO - Running setup.py install for mozversion 18:31:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:31:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:31:35 INFO - Cleaning up... 18:31:35 INFO - Return code: 0 18:31:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:35 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 0x29531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc65c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc37a0>, '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 0x2cc46a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4b30>, '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': 'df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553', '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 18:31:35 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 18:31:35 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 18:31:35 INFO - Using env: {'DISPLAY': ':0', 18:31:35 INFO - 'HOME': '/home/cltbld', 18:31:35 INFO - 'LANG': 'en_US.UTF-8', 18:31:35 INFO - 'LANGUAGE': 'en_US:en', 18:31:35 INFO - 'LOGNAME': 'cltbld', 18:31:35 INFO - 'MAIL': '/var/mail/cltbld', 18:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:35 INFO - 'MOZ_NO_REMOTE': '1', 18:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:35 INFO - 'NO_EM_RESTART': '1', 18:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:35 INFO - 'PWD': '/builds/slave/test', 18:31:35 INFO - 'SHELL': '/bin/bash', 18:31:35 INFO - 'SHLVL': '1', 18:31:35 INFO - 'TERM': 'linux', 18:31:35 INFO - 'TMOUT': '86400', 18:31:35 INFO - 'USER': 'cltbld', 18:31:35 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553', 18:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:35 INFO - '_': '/tools/buildbot/bin/python'} 18:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:35 INFO - Running setup.py (path:/tmp/pip-XArTYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:35 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)) 18:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:35 INFO - Running setup.py (path:/tmp/pip-UNPDx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:35 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)) 18:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:35 INFO - Running setup.py (path:/tmp/pip-laE1hW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:35 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)) 18:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:35 INFO - Running setup.py (path:/tmp/pip-wq2CQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:35 INFO - Running setup.py (path:/tmp/pip-mCabYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:35 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)) 18:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:35 INFO - Running setup.py (path:/tmp/pip-0sbATa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:36 INFO - Running setup.py (path:/tmp/pip-bZvuSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:36 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)) 18:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:36 INFO - Running setup.py (path:/tmp/pip-mUGYGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:36 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)) 18:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:36 INFO - Running setup.py (path:/tmp/pip-OGYlCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:36 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)) 18:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:36 INFO - Running setup.py (path:/tmp/pip-rTTT76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:36 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)) 18:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:36 INFO - Running setup.py (path:/tmp/pip-GEY7X5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:36 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)) 18:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:36 INFO - Running setup.py (path:/tmp/pip-Syps6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:36 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)) 18:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:36 INFO - Running setup.py (path:/tmp/pip-SKu2rZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:36 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)) 18:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:36 INFO - Running setup.py (path:/tmp/pip-SeY4vT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:36 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)) 18:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:36 INFO - Running setup.py (path:/tmp/pip-lAiv8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:36 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)) 18:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:36 INFO - Running setup.py (path:/tmp/pip-TozXuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:36 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)) 18:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:36 INFO - Running setup.py (path:/tmp/pip-aREqH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:36 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)) 18:31:36 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)) 18:31:36 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)) 18:31:36 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)) 18:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:31:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:31:36 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 18:31:36 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 18:31:36 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 18:31:36 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 18:31:37 INFO - Downloading blessings-1.6.tar.gz 18:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:31:38 INFO - Installing collected packages: blessings 18:31:38 INFO - Running setup.py install for blessings 18:31:38 INFO - Successfully installed blessings 18:31:38 INFO - Cleaning up... 18:31:38 INFO - Return code: 0 18:31:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:31:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:31:38 INFO - Reading from file tmpfile_stdout 18:31:38 INFO - Current package versions: 18:31:38 INFO - argparse == 1.2.1 18:31:38 INFO - blessings == 1.6 18:31:38 INFO - blobuploader == 1.2.4 18:31:38 INFO - docopt == 0.6.1 18:31:38 INFO - functools32 == 3.2.3-2 18:31:38 INFO - jsonschema == 2.5.1 18:31:38 INFO - manifestparser == 1.1 18:31:38 INFO - mozInstall == 1.12 18:31:38 INFO - mozcrash == 1.0 18:31:38 INFO - mozdebug == 0.1 18:31:38 INFO - mozdevice == 0.51 18:31:38 INFO - mozfile == 1.2 18:31:38 INFO - mozhttpd == 0.7 18:31:38 INFO - mozinfo == 0.9 18:31:38 INFO - mozleak == 0.1 18:31:38 INFO - mozlog == 3.4 18:31:38 INFO - moznetwork == 0.27 18:31:38 INFO - mozprocess == 0.25 18:31:38 INFO - mozprofile == 0.28 18:31:38 INFO - mozrunner == 6.13 18:31:38 INFO - mozscreenshot == 0.1 18:31:38 INFO - mozsystemmonitor == 0.3 18:31:38 INFO - moztest == 0.8 18:31:38 INFO - mozversion == 1.4 18:31:38 INFO - psutil == 3.1.1 18:31:38 INFO - requests == 1.2.3 18:31:38 INFO - wsgiref == 0.1.2 18:31:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x29531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc65c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc37a0>, '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 0x2cc46a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4b30>, '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': 'df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553', '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 18:31:38 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 18:31:38 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 18:31:38 INFO - Using env: {'DISPLAY': ':0', 18:31:38 INFO - 'HOME': '/home/cltbld', 18:31:38 INFO - 'LANG': 'en_US.UTF-8', 18:31:38 INFO - 'LANGUAGE': 'en_US:en', 18:31:38 INFO - 'LOGNAME': 'cltbld', 18:31:38 INFO - 'MAIL': '/var/mail/cltbld', 18:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:38 INFO - 'MOZ_NO_REMOTE': '1', 18:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:38 INFO - 'NO_EM_RESTART': '1', 18:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:38 INFO - 'PWD': '/builds/slave/test', 18:31:38 INFO - 'SHELL': '/bin/bash', 18:31:38 INFO - 'SHLVL': '1', 18:31:38 INFO - 'TERM': 'linux', 18:31:38 INFO - 'TMOUT': '86400', 18:31:38 INFO - 'USER': 'cltbld', 18:31:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553', 18:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:38 INFO - '_': '/tools/buildbot/bin/python'} 18:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:38 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)) 18:31:38 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)) 18:31:38 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)) 18:31:38 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)) 18:31:38 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)) 18:31:38 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)) 18:31:38 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)) 18:31:38 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)) 18:31:38 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)) 18:31:38 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:39 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:31:39 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)) 18:31:39 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)) 18:31:40 INFO - Installing collected packages: marionette-driver 18:31:40 INFO - Running setup.py install for marionette-driver 18:31:40 INFO - Successfully installed marionette-driver 18:31:40 INFO - Cleaning up... 18:31:40 INFO - Return code: 0 18:31:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:31:40 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')]} 18:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:40 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')]} 18:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:40 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 0x29531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc65c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc37a0>, '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 0x2cc46a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4b30>, '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': 'df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553', '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 18:31:40 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 18:31:40 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 18:31:40 INFO - Using env: {'DISPLAY': ':0', 18:31:40 INFO - 'HOME': '/home/cltbld', 18:31:40 INFO - 'LANG': 'en_US.UTF-8', 18:31:40 INFO - 'LANGUAGE': 'en_US:en', 18:31:40 INFO - 'LOGNAME': 'cltbld', 18:31:40 INFO - 'MAIL': '/var/mail/cltbld', 18:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:40 INFO - 'MOZ_NO_REMOTE': '1', 18:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:40 INFO - 'NO_EM_RESTART': '1', 18:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:40 INFO - 'PWD': '/builds/slave/test', 18:31:40 INFO - 'SHELL': '/bin/bash', 18:31:40 INFO - 'SHLVL': '1', 18:31:40 INFO - 'TERM': 'linux', 18:31:40 INFO - 'TMOUT': '86400', 18:31:40 INFO - 'USER': 'cltbld', 18:31:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553', 18:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:40 INFO - '_': '/tools/buildbot/bin/python'} 18:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:31:40 INFO - Cleaning up... 18:31:40 INFO - Return code: 0 18:31:40 INFO - Running post-action listener: _resource_record_post_action 18:31:40 INFO - Running post-action listener: _start_resource_monitoring 18:31:40 INFO - Starting resource monitoring. 18:31:40 INFO - [mozharness: 2017-05-25 01:31:40.417913Z] Finished create-virtualenv step (success) 18:31:40 INFO - [mozharness: 2017-05-25 01:31:40.418372Z] Running install step. 18:31:40 INFO - Running pre-action listener: _resource_record_pre_action 18:31:40 INFO - Running main action method: install 18:31:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:31:40 INFO - Reading from file tmpfile_stdout 18:31:40 INFO - Detecting whether we're running mozinstall >=1.0... 18:31:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:31:40 INFO - Reading from file tmpfile_stdout 18:31:40 INFO - Output received: 18:31:40 INFO - Usage: mozinstall [options] installer 18:31:40 INFO - Options: 18:31:40 INFO - -h, --help show this help message and exit 18:31:40 INFO - -d DEST, --destination=DEST 18:31:40 INFO - Directory to install application into. [default: 18:31:40 INFO - "/builds/slave/test"] 18:31:40 INFO - --app=APP Application being installed. [default: firefox] 18:31:40 INFO - mkdir: /builds/slave/test/build/application 18:31:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:31:56 INFO - Reading from file tmpfile_stdout 18:31:56 INFO - Output received: 18:31:56 INFO - /builds/slave/test/build/application/firefox/firefox 18:31:56 INFO - Running post-action listener: _resource_record_post_action 18:31:56 INFO - [mozharness: 2017-05-25 01:31:56.680370Z] Finished install step (success) 18:31:56 INFO - [mozharness: 2017-05-25 01:31:56.680649Z] Running run-tests step. 18:31:56 INFO - Running pre-action listener: _resource_record_pre_action 18:31:56 INFO - Running main action method: run_tests 18:31:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:31:56 INFO - Python 2.7.3 18:31:56 INFO - Return code: 0 18:31:56 INFO - grabbing minidump binary from tooltool 18:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:56 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc37a0>, '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 0x2cc46a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:31:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:31:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:31:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:31:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:31:56 INFO - Return code: 0 18:31:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:31:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:31:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:31:56 INFO - ENV: RUST_BACKTRACE is now 1 18:31:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:31:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:31:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 18:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 18:31:56 INFO - Using env: {'DISPLAY': ':0', 18:31:56 INFO - 'HOME': '/home/cltbld', 18:31:56 INFO - 'LANG': 'en_US.UTF-8', 18:31:56 INFO - 'LANGUAGE': 'en_US:en', 18:31:56 INFO - 'LOGNAME': 'cltbld', 18:31:56 INFO - 'MAIL': '/var/mail/cltbld', 18:31:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:31:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:56 INFO - 'MOZ_NO_REMOTE': '1', 18:31:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:56 INFO - 'NO_EM_RESTART': '1', 18:31:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:56 INFO - 'PWD': '/builds/slave/test', 18:31:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:31:56 INFO - 'RUST_BACKTRACE': '1', 18:31:56 INFO - 'SHELL': '/bin/bash', 18:31:56 INFO - 'SHLVL': '1', 18:31:56 INFO - 'TERM': 'linux', 18:31:56 INFO - 'TMOUT': '86400', 18:31:56 INFO - 'USER': 'cltbld', 18:31:56 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553', 18:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:56 INFO - '_': '/tools/buildbot/bin/python'} 18:31:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 18:31:57 INFO - mozversion application_buildid: 20170525004348 18:31:57 INFO - mozversion application_changeset: d10f5ccd882b965fcad39914f7c3c930d1301a41 18:31:57 INFO - mozversion application_display_name: Nightly 18:31:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:31:57 INFO - mozversion application_name: Firefox 18:31:57 INFO - mozversion application_remotingname: firefox 18:31:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:31:57 INFO - mozversion application_vendor: Mozilla 18:31:57 INFO - mozversion application_version: 55.0a1 18:31:57 INFO - mozversion platform_buildid: 20170525004348 18:31:57 INFO - mozversion platform_changeset: d10f5ccd882b965fcad39914f7c3c930d1301a41 18:31:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:31:57 INFO - mozversion platform_version: 55.0a1 18:31:57 INFO - using testdate: 1495675917 18:31:57 INFO - actual date: 1495675917 18:31:57 INFO - starting webserver on 'localhost:36353' 18:31:57 INFO - SUITE-START | Running 2 tests 18:31:57 INFO - TEST-START | dromaeo_css 18:31:57 INFO - operating with platform_type : linux_ 18:31:57 INFO - Initialising browser for dromaeo_css test... 18:31:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36353/getInfo.html -profile /tmp/tmpFqCCP5/profile 18:31:57 INFO - TEST-INFO | started process 23806 (/builds/slave/test/build/application/firefox/firefox http://localhost:36353/getInfo.html) 18:32:32 INFO - TEST-INFO | 23806: killed by SIGTERM 18:32:32 INFO - Browser initialized. 18:32:32 INFO - Running cycle 1/1 for dromaeo_css test... 18:32:32 INFO - TEST-INFO | started process 24027 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFqCCP5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:32:44 INFO - PID 24027 | RSS: Main: 176386048 18:32:44 INFO - PID 24027 | 18:35:49 INFO - PID 24027 | Cycle 1(1): loaded http://localhost:36353/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36353/tests/dromaeo/cssquery-ext.html) 18:35:50 INFO - PID 24027 | RSS: Main: 173641728 18:35:50 INFO - PID 24027 | 18:38:52 INFO - PID 24027 | Cycle 1(1): loaded http://localhost:36353/tests/dromaeo/cssquery-ext.html (next: http://localhost:36353/tests/dromaeo/cssquery-jquery.html) 18:38:53 INFO - PID 24027 | RSS: Main: 180113408 18:38:53 INFO - PID 24027 | 18:41:55 INFO - PID 24027 | Cycle 1(1): loaded http://localhost:36353/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36353/tests/dromaeo/cssquery-mootools.html) 18:41:55 INFO - PID 24027 | RSS: Main: 178503680 18:41:55 INFO - PID 24027 | 18:44:57 INFO - PID 24027 | Cycle 1(1): loaded http://localhost:36353/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36353/tests/dromaeo/cssquery-prototype.html) 18:44:58 INFO - PID 24027 | RSS: Main: 183816192 18:44:58 INFO - PID 24027 | 18:48:00 INFO - PID 24027 | Cycle 1(1): loaded http://localhost:36353/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36353/tests/dromaeo/cssquery-yui.html) 18:48:01 INFO - PID 24027 | RSS: Main: 180756480 18:48:01 INFO - PID 24027 | 18:51:03 INFO - PID 24027 | Cycle 1(1): loaded http://localhost:36353/tests/dromaeo/cssquery-yui.html (next: http://localhost:36353/tests/dromaeo/cssquery-dojo.html) 18:51:03 INFO - PID 24027 | RSS: Main: 178176000 18:51:03 INFO - PID 24027 | 18:51:03 INFO - PID 24027 | __start_tp_report 18:51:03 INFO - PID 24027 | _x_x_mozilla_page_load 18:51:03 INFO - PID 24027 | _x_x_mozilla_page_load_details 18:51:03 INFO - PID 24027 | |i|pagename|runs| 18:51:03 INFO - PID 24027 | |0;dojo.html;2685.798565107617;2691.179190346945;2700.6489156409666;2726.9727302726965;2738.6029025791263;5208.036513245052;5231.921521177181;5241.859120675394;5267.86830329242;5322.49436303551;5221.921671174926;5247.317848679676;5270.525652691257;5316.946830531693;5340;4672.299155126724;4676.205045142334;4719.764011799396;4720.457147428038;4761.714297142165;4673.252279635259;4741.668083234175;4760.642951778613;4766.213574760161;4808.663393562452;4631.235846085392;4670.929936050962;4684.344191813149;4707.882302942419;4772.546608072245;4645.187092258841;4682.08699303636;4684.086603112394;4709.670323077386;4719.646026548023;4698.08387364464;4701.976490117561;4711.740854253015;4712.858614241578;4749.453812811536;5154.896902061938;5203.895922081575;5234.110201265794;5281.049411106;5308.309919710451;5641.802536911188;5666.150077488369;5702.942970570282;5727.083666613322;5727.971360143214;5786.566007549409;5789.102689083199;5792.362840087587;5823.650580965155;5838.824835254906;5313.335833020872;5325.733713314319;5327.760250788724;5328.653637513549;5335.0663633863915;5716.256886604715;5803.187553742479;5884.440978107073;5886.735096920649;5886.823395298148;5593.049181639131;5636.267285252973;5651.180578816131;5664.178694089334;5685.715714214272;5562.694051827108;5661.207430959669;5693.829185124453;5699.629524081004;5703.144528320785;5556.111022236423;5644.774209031675;5645.379008309083;5646.378898321182;5654.3497497788285;5665.631733937281;5677.205191273225;5708.257926469615;5742.167385729046;5760.855978600569;4421.447319085114;4422.491413487426;4433.091216300651;4461.665375096816;4461.776911154429;3829.6744776694295;3834.750741201813;3836.501254836853;3853.171568112813;3873.748206366577;4728.527147285313;4767.189577771787;4774.40319960005;4781.856544303677;4791.856244312677;5729.083346664514;5737.3975732548315;5738.77044918207;5770;5794.768209271666;4790.856274311776;4794.5924596409695;4824.035192961422;4825.806967721322;4846.248831431134;5024.522670346311;5106.055379754757;5124.487551244772;5138.203578445347;5144.43411224765;5258.237555554347;5264.368275806928;5273.604479664117;5309.522143007148;5325.174597937326;5588.050031494575;5673.149027645886;5758.654480731169;5781.479666830005;5794.420557944172;5237.81667641646;5251.474852514718;5276.208568714724;5312.548433383051;5330.653507521999;5523.585731070106;5627.718614069362;5680.914786278292;5684.403137670651;5716.5998380113;5724.141378793214;5734.942650573441;5737.770489180553;5737.8565535861935;5738.254026976633;5438.184272359178;5485.6982865942755;5529.944700552943;5555.694436805853;5561.277033985556;5559.833205003694;5586.413426590149;5601.271834661468;5618.157276408408;5628.549716022791;5470.562355011669;5496.560275178056;5501.642393244426;5504.9449505504435;5512.889742205213;5482.42434544383;5564.888702226014;5622.044252477171;5627.268455100811;5628.60599758013;5384.380796208487;5429.049916264717;5429.131338985743;5433.185022246536;5497.39528651856 18:51:03 INFO - PID 24027 | |1;ext.html;618.601002353482;673.5924765516862;683.2450142592435;1188.7681902029108;1197.712548988243;34435.655643443555;35357.823210883944;35361.2927741445;35571.82214088929;35642.2871542569;33499.33001339972;33812;34060.318793624116;34124.48813267803;34253.486197707054;6610.636414997173;6797.52417330787;6811.4550835933005;6811.591304521719;6830.863382732342;6566.704498297564;6636.070950066995;6648;6664.733410663568;6666.200055993263;6657.766978155765;6699.229588597301;6706.0276259942275;6708.865822683543;6715.160604924385;6633.800985970429;6642.169728783902;6657.966710166466;6668.466522678174;6683.632400217962;6745.763898263586;6771.593704377753;6773.8983915241315;6812.4550035997;6812.48906332027;32622;33107.834460827544;33177.50233746496;33241;33270.83364583162;2826.1380279014893;2846.4307138572367;2858.3282928511785;2860.699626539204;2864.5130327844317;24959.62560561593;25117;25180.49639007228;25204;25224.87387563069;2898.8260704357594;2902.071337172106;2903.8112522685956;2917.416516696669;2932.8680209390627;143559;145191;146207;152667;156563.43436565602;40918.38622420666;40950.38574421386;41152;41282.38076428856;41298.58701413008;42869.35695964563;42878.35682464766;42922.57077429186;42982.78508607437;45980;11367.715807104889;11452.713682158013;11496.942515287537;11502.424878756028;11506.712332191762;8689.6524139035;8745.562721863882;8757.824843503222;8807.33944954131;8833.867491987625;12895.355232238539;12927.676808079685;12951.158174718614;13028.47886084546;13046.347682615831;5334.946650533522;5440.836774896759;5449.765596105657;5515.4760297771645;5547.667139971614;824.995875020621;862.1077185113378;890.8396488631979;893.821235752852;897.5063714956748;20610.278640247518;21082.89458552728;21437.67843482349;21514.46213844635;21603.13968008554;935.3546053223254;942.137943781446;960.9327347085637;967.5645959318335;971.1017308989157;10542.209334299958;11193;11236.438178091063;11367.261128026652;11424.885751142383;172906;172911;173446;173592;173643;41465.1706965865;41805;41834.37248441276;41848.815118488514;41867;1148.5004023249912;1179.7463545337794;1193.3078814287867;1194.343111288805;1196.9820452693216;19041.333553325567;20229.49426264355;20810.27164049251;20866.26968056111;21001.369958901258;29987.4002519944;36951.630483695895;37283.81358093192;37598;37713;155080;155155;155333;156344.21827890788;156540;29661.406771864873;30640;30701.53947690831;30840.228994275323;31021.069367918997;35779.642203578675;35912.4613130798;36712.81643591765;36808.26383472369;37247.62752372442;26753.464930701666;27540.862295689196;27557.586636200875;27749.12543728136;28278.293042674097;26980.86509567518;27113.1866044019;27741.722582773913;27786.444271114062;28842.134735957115;27624.171274861787;27630;27788.58317125204;28050.719492804812;28371.14886553324;26582.468350633266;26879.86560067187;27114.72885271122;27117.72882271152;28091;21542.569148617255;22538.21116260923;22586.322410327717;22634.660480092483;22697.205597803997 18:51:03 INFO - PID 24027 | |2;jquery.html;401.95980401959787;407.668960842848;417.4969162159598;422.34958164426786;432.37305906435654;17431.82568174318;18040.368587099456;18064.909675451636;18536.165872535734;19227.134778934946;17853.91073044633;18126.3655772048;18240.08799560023;18270.086495675198;18294.634107317845;5036.496350364971;5177.32694749682;5337.5196232338985;5519.558435325164;5534.916976245359;5350.384705758848;5396.217548455472;5399;5444.428335024825;5445.401005889349;5191.688498690071;5309.442508536606;5319.388270348902;5343.812966546172;5383.219433182187;5216.191490318987;5308.124159513675;5313.282706834586;5321.574274058085;5335.039692855285;4810;4812.494688057774;4814.855554333376;4822.614190864722;4830.178869592178;21589.892050539645;22464.550708985727;22471.101155953744;22519.54960900773;22586.322410327717;1545.5363390982773;1598.696247712931;1635.2232689472523;1670.13987796285;1670.8078570964374;14304.213268270241;14725.190114543695;14785.186814725186;14789.038712483654;15074.623134421727;1975.940721778349;2059.2072052259837;2078.7089807426973;2107.8735275883496;2124.0866427436194;88798.55600722019;91306;93982.5300873498;94865;96368;10811.135109191246;11035.779284414428;11097.55609775616;11270.718232044264;11433.314001159957;15242.390304387922;15388.615284617974;15500.30248638814;15514.146721930176;15525.378984840705;7038.2961703829205;7225.638718064076;7236.710531578678;7272.127344718668;7317.817054573678;6368.5860419072615;6386.10594516768;6547.247066587308;6557.704903279364;6573.967130164318;6889.414399776075;6950.687219075154;6964.686589103401;7118.216996130422;7120.750773722998;1961.1861077652613;1977.1794705197183;2005.1878989009474;2017.8083082107175;2129.127057906251;825.1377310710322;854.9700760473478;861.8539835808791;880.2781718990494;888.6845169964698;16726.916365418096;16760.497185084467;16891;16956;17594.560135996446;839.5802098950525;839.8824164616958;846.7502086884384;846.8348672009022;867.9609417576224;8759.60581773809;8781.69264075767;8839.337049721296;9041.321900857462;9112.635494580276;339312;346532;346832;347071;347960;68471.65764171147;74914;75627.24372756312;76758;77583.06042348986;1042.67677020124;1071.4160782373624;1091.6288461922984;1098.083100610983;1100.6312885183393;15911.28399222061;16104.597385065466;16189.838101618832;16658.333666653198;17045.232964516876;39278.41082383824;40579.59420405876;40826.387604185365;40958.59041409667;41232.38151427791;49273.753631231615;51366.74316628393;51413.22880156726;52240.21639675484;52363.21455178252;8067.435279530377;8158.224968627971;8210.958945205235;8225.917740822515;8372.61380506577;11895.643130706092;11925.76148477043;12106.530288756285;12149;12394.938025309815;9995.550200240861;10227.795444091225;10298.691039268833;10471.528781205016;10723.839142412715;9442.95278523603;9664.275179361717;9711.223102151669;9949;10041.849372259276;10311.432871191857;10312.381257124596;10869;10949.781004379709;11048.281861678965;7880.527168369917;7943.761687149395;7955;8087.312578430664;8261.710840120568;10029.297949143782;10459.529321180413;10461.895381046092;10891.782164356828;11089.833652495057 18:51:03 INFO - PID 24027 | |3;mootools.html;1264.6142926407445;1313.553391846772;1324.6622111361596;1328.4354149486467;1338.0299283019808;9342.813143737121;9632.325737198391;9713.271504637154;10251.641192558262;10589.947050264738;10480.79038419233;10649.09482693972;10663.413512256822;10700.946495267532;10734.248602597801;2142.207383268193;2180.051677520276;2182.454386403399;2187.245400336881;2187.6171669957776;2081.8230450411656;2160.3087012156116;2164.848460607758;2165.761766205716;2166.8483206175574;2126.2983215538834;2137.8289736821016;2149.924752633658;2153.6446486329737;2159.136345461812;2090.049027692404;2094.2251366994155;2100.495880988567;2107.92622258221;2112.9894350528302;2006.839452843769;2026.3110542415502;2044.0597325230412;2122.8514004019726;2125.0331099349914;10062.647807326708;10182.847257291147;10185.847212291821;10218.233632477593;10219.386836789816;5303.734813259361;5412.485813847678;5507.697076660782;5510.81517473741;5528.55771538276;3077.9076627701206;3203.4874420092674;3231.8545665445113;3258.4949332853444;3280.5735254417013;1062.16089289462;1069.1286601419818;1085.9294145880492;1089.8147314956398;1125.9943700281528;13641.863581364258;13957.720845583133;13959.092658977133;13963.301834908316;13975.720485590333;4414.624756895636;4515.877537557343;4572.88567785808;4583.954160458353;4661.3707149534375;10251.7437064074;10252.58989640421;10253.231007674454;10254.230932680079;10259.384436933808;5154.768035438415;5260.079486089919;5261.921071183935;5274.340707411574;5281.788728450819;4755.120302744003;4821;4826.107170173459;4861.683990540603;5027.371578552681;3601.981990090085;3650.0874781304674;3706.6478684524927;3756.492873462102;3762.4168253920684;1066.664000839733;1072.5066469423996;1073.1146803886668;1089.1559041742555;1089.7929393415225;630.224823467138;646.0632083478974;665.3147258323934;667.7829705345782;681.2880539835785;5181.3782346118705;5266.262723218752;5337.86655333612;5339.359276886798;5435.83692489226;495.5193462341523;811.4684881402691;839.4627438439404;850.1795767084669;857.3055824781947;3591.06632275605;3773.7924414157483;3895.2793733159456;3929.1298071399647;3937;11460.656180314603;12843.100982931292;13265.66835829112;13307.933460332637;13398.799018014737;12801.423935922905;13225.074244802963;13234.073614846868;13278.269695166666;13439.260840653858;7164.534305270141;7236.782896513113;7259.782206533707;7319.670614822346;7332.78001659951;5527.309086364205;5590.413006634408;5720.2849643794525;5805.10020946754;5968.850778730392;11692.766144677229;11986.981106606036;12049.51801927913;12103.092268079754;12159.939200303941;12139.575114870937;12167.939160304495;12193.51225950952;12315.815262770886;12316.199447035913;8033.718819841278;8223.917760822314;8232.34141268685;8247.835043299221;8251.83496330082;9315.580798863932;9445.622175112918;9550.140487356171;9551.665691700757;9610.423374597547;8004.679812807422;8014.719484818003;8162.959185204273;8197.05733840592;8260.958695206726;7651.502652327581;7696.538207707556;7706.576138312446;7742.883856742266;7760.068791745027;7132.037174981519;7155.034070400638;7193.244709305657;7206.315400036988;7227.205007449282;4507.414036175276;4935.75321233944;4968.254761785616;4979.278004689228;5193.935243275195;5111.514406131411;5118;5126.769295381642;5254.500822421864;5356.089464791073 18:51:03 INFO - PID 24027 | |4;prototype.html;341.51675379338235;356.55608767084965;357.17492592112205;365.8061227549399;367.1866815004765;5466.180072989054;5573.693446860421;5624.578156638253;5642.391918303284;5679.5740319476;5460.453954604538;5538.141588053848;5547.639403438774;5550.2507161533185;5569.6658200508;4370.56294370562;4373.759443230629;4373.825046998117;4381.868543943687;4389.266239835263;4206.705530612859;4352.107817897323;4369.73781573105;4390.912181756363;4392.494863090737;4317.611414972652;4320.913581728363;4335.219660461115;4347.60871521563;4361.49842768081;4320.416743739586;4328.48058233014;4329.935050974238;4332.566743325642;4347.934780978288;3751.643593858579;3890.727649064567;3928.4696565963513;3941;3950.6641935435523;5422.593305502063;5427.810026649048;5431.293931788842;5442.863928401782;5446.373667028302;5086.3896332440345;5144.742762861842;5171.301874246966;5179.792808287664;5204.895902081975;5855.824325270249;5869.530437564985;5898.498627616657;5919.146300033974;5952.642841429528;4397.428334316551;4402.823887044515;4404.427424434835;4418.29307310832;4427.911441771179;5962.701864906738;6081.695915204222;6162.845928851814;6238.688065596747;6312.926802443596;4277.91444171121;4297.67767417445;4303.806328715215;4310.892227694333;4317.373980772771;4337.566243375701;4366.366876802846;4366.607005369532;4370.929122364977;4373.846915358011;4978.626603004789;4979.228219625964;4983.90032199354;5163.97418012915;5171.4311425743135;5920.171176035358;5935.881282374328;5955.553333500005;5963.19496867926;5982.760689572368;1572.5989872582647;1606.1005836731467;1610.7503336982786;1614.6367067409974;1615.3377115382636;1116.5143162724241;1122.640754958422;1127.2053202492223;1133.2916926920675;1145.9140564457698;5004.399472063303;5034.748262586856;5055.140626093573;5079.492050794891;5092.337996060489;6065.363136870653;6132.08018797184;6135.723892424851;6143.170671959318;6156.199694039836;4889.951100489021;4986.950130498649;5000.924986125211;5036.84889453317;5054.974725126351;3192.776505644629;3218.9195270118435;3243.7997940761597;3264.8367581620823;3270.7219886309454;5503.367112782082;5586.245856809279;5590.18942253371;5637.548996080386;5646.6894320811925;6234.781782637586;6241.750329986749;6244.687765611701;6245.28179259391;6314.116023756677;5570.470805273573;5576.358718747396;5610.410906854803;5625.312406278182;5640.802571909963;5759;6037.849053773691;6084.482818960261;6084.665343406155;6122.142899993915;5852.590318677651;6010.1585777991995;6013.579049466495;6029.78895738647;6042.214512113573;5531.170324451204;5582.7766889323975;5617.185508101385;5620.522255608319;5638.351589567088;4048.21059893318;4101.630853223224;4105.4662893823615;4115.506139263308;4120.546739858673;5956.553258505716;6059.182245326472;6098.146259523759;6099.176611157437;6136.32500424944;5875.94124058771;5879.412058794086;5901.173835662925;5901.881962360643;5904.409559044061;5830.854228644318;5869.882602348014;5889.970550147222;5924.644521328734;5939.554533409925;5819.912701309399;5824.883502330014;5861.120831875252;5867;5906.970465147647;5923.940760592339;5971.552133589911;5988.640681559121;6009.609375390585;6013.909791353046;5633.661980281032;5747.281589801275;5773.672055427359;5790.218320526844;5793.275840519935 18:51:03 INFO - PID 24027 | |5;yui.html;649.1713376320748;669.6350488983503;717.6878058044751;722.1731117870039;743.4535616322004;12506.812397814017;13033.93483032586;13542.593722188338;14413.999999999987;14441.205733684656;14771.55685329439;15135.697286054272;15178.696426071472;15180.54458366248;15200.695986080273;883.1521739130426;902.431468175052;906.1436942089728;906.8821053263066;908.600215905003;899.5412339706764;904.1546154345675;905.302916754099;907.1971305394708;908;926.9907300926972;939.6335429182624;940.3699521320732;941.2422999485445;944.0748066894448;925.9398139120935;939.375315415248;941.2140862379887;943.3726571829725;949.3212353167484;683.4156795939499;686.5125760709902;689.6448329110513;691.0670594697169;692.705600119947;13624.18254904699;14261.215633140173;14314.212718300489;14321.14073155614;14375.568732938029;14702.11787292755;15363.692726145415;15391.769123463157;15516.844831551765;15572.37710491579;11468.71328216793;11613.18707690462;11714.589989350417;11746.177767556275;11896.22674526153;2935.57434172046;2946.1603443018853;2958.3195864950967;2961.7038296170426;2962.1853990152663;73809;76251;78515;79211.60394197992;83628.16371836264;12978.091533592558;13446.932765336307;13512.93243533776;13685.384157712926;13892.305384730724;20928.895355523124;21531.56936861254;21751;24245.878770606036;24263.393415164763;6019.247594050744;6153.2000839891425;6163.3836616338;6165.075238714228;6181.227346581677;2713.769329606966;2769.2384594236746;2784.303924018995;2786.1223714530265;2788.9860550697117;3501.964980350164;3658.176910195185;3771.4908487354405;3791.75353602015;3798.6581207691443;711.5623891306809;738.1990540263873;750.2422553221177;763.2215140556601;766.6281853301144;542.6771071212622;560.7953097119522;561.1330494386183;566.6175331651201;571.8398848322477;9896.901030989598;10120.59517619287;10277.845832312521;10495;10690.251682382159;549.7636016512938;550.7659244820935;552.2958228258922;553.1177771454524;559.2729451712758;4433.733975961452;4594.333821595917;4636.86089417318;4636.884077898012;4796.928046079312;82400;82499.58750206331;82557;84284.15715842762;84896.15103849006;66179.33820661828;66438;72801.27198727946;73839;74094.62952685202;57242.141367879514;60042.69978650166;60116.39883601108;60659.69670151621;61332.386676132664;9082.636694532144;9920.553575089283;10188.083072523508;10252.846207307046;10512.159027277647;26476.602850957635;27186.456270874867;27311.72688273092;28360.57459138156;28445.573316399856;34379;34535.65464345324;34622;35087;35385.115372115906;13726.588202353945;13862.584122476343;13952.093113947562;14165.504207352693;14165.645858853199;14836.406543738129;14918.776218356516;14978.625534361729;15459;15638.139902305482;14110.50613228532;14301.213433261271;14495.565133046026;14699.485518006819;14710.19093949843;14385.64035899111;14636.121832690073;15376.461823836113;15517.612059698598;15702.450414235447;14368;14388.85611143917;14490.275486225857;14532.27338633043;14691;9893.65372211969;10045.748856278358;10304.433256170683;10351;10471.633492827714;11075.280106793354;11929.164958452826;11953.282803031845;12074.577389791315;12090.818637720266 18:51:03 INFO - PID 24027 | __end_tp_report 18:51:03 INFO - PID 24027 | __start_cc_report 18:51:03 INFO - PID 24027 | _x_x_mozilla_cycle_collect,354 18:51:03 INFO - PID 24027 | __end_cc_report 18:51:03 INFO - PID 24027 | __startTimestamp1495677063534__endTimestamp 18:51:03 INFO - PID 24027 | 18:51:03 INFO - PID 24027 | ------- Summary: start ------- 18:51:03 INFO - PID 24027 | Number of tests: 6 18:51:03 INFO - PID 24027 | 18:51:03 INFO - PID 24027 | [#0] dojo.html Cycles:165 Average:5193.25 Median:5330.65 stddev:647.02 (12.1%) stddev-sans-first:618.38 18:51:03 INFO - PID 24027 | Values: 2685.8 2691.2 2700.6 2727.0 2738.6 5208.0 5231.9 5241.9 5267.9 5322.5 5221.9 5247.3 5270.5 5316.9 5340.0 4672.3 4676.2 4719.8 4720.5 4761.7 4673.3 4741.7 4760.6 4766.2 4808.7 4631.2 4670.9 4684.3 4707.9 4772.5 4645.2 4682.1 4684.1 4709.7 4719.6 4698.1 4702.0 4711.7 4712.9 4749.5 5154.9 5203.9 5234.1 5281.0 5308.3 5641.8 5666.2 5702.9 5727.1 5728.0 5786.6 5789.1 5792.4 5823.7 5838.8 5313.3 5325.7 5327.8 5328.7 5335.1 5716.3 5803.2 5884.4 5886.7 5886.8 5593.0 5636.3 5651.2 5664.2 5685.7 5562.7 5661.2 5693.8 5699.6 5703.1 5556.1 5644.8 5645.4 5646.4 5654.3 5665.6 5677.2 5708.3 5742.2 5760.9 4421.4 4422.5 4433.1 4461.7 4461.8 3829.7 3834.8 3836.5 3853.2 3873.7 4728.5 4767.2 4774.4 4781.9 4791.9 5729.1 5737.4 5738.8 5770.0 5794.8 4790.9 4794.6 4824.0 4825.8 4846.2 5024.5 5106.1 5124.5 5138.2 5144.4 5258.2 5264.4 5273.6 5309.5 5325.2 5588.1 5673.1 5758.7 5781.5 5794.4 5237.8 5251.5 5276.2 5312.5 5330.7 5523.6 5627.7 5680.9 5684.4 5716.6 5724.1 5734.9 5737.8 5737.9 5738.3 5438.2 5485.7 5529.9 5555.7 5561.3 5559.8 5586.4 5601.3 5618.2 5628.5 5470.6 5496.6 5501.6 5504.9 5512.9 5482.4 5564.9 5622.0 5627.3 5628.6 5384.4 5429.0 5429.1 5433.2 5497.4 18:51:03 INFO - PID 24027 | 18:51:03 INFO - PID 24027 | [#1] ext.html Cycles:180 Average:30611.63 Median:30770.88 stddev:41253.17 (134.1%) stddev-sans-first:41307.42 18:51:03 INFO - PID 24027 | Values: 618.6 673.6 683.2 1188.8 1197.7 34435.7 35357.8 35361.3 35571.8 35642.3 33499.3 33812.0 34060.3 34124.5 34253.5 6610.6 6797.5 6811.5 6811.6 6830.9 6566.7 6636.1 6648.0 6664.7 6666.2 6657.8 6699.2 6706.0 6708.9 6715.2 6633.8 6642.2 6658.0 6668.5 6683.6 6745.8 6771.6 6773.9 6812.5 6812.5 32622.0 33107.8 33177.5 33241.0 33270.8 2826.1 2846.4 2858.3 2860.7 2864.5 24959.6 25117.0 25180.5 25204.0 25224.9 2898.8 2902.1 2903.8 2917.4 2932.9 143559.0 145191.0 146207.0 152667.0 156563.4 40918.4 40950.4 41152.0 41282.4 41298.6 42869.4 42878.4 42922.6 42982.8 45980.0 11367.7 11452.7 11496.9 11502.4 11506.7 8689.7 8745.6 8757.8 8807.3 8833.9 12895.4 12927.7 12951.2 13028.5 13046.3 5334.9 5440.8 5449.8 5515.5 5547.7 825.0 862.1 890.8 893.8 897.5 20610.3 21082.9 21437.7 21514.5 21603.1 935.4 942.1 960.9 967.6 971.1 10542.2 11193.0 11236.4 11367.3 11424.9 172906.0 172911.0 173446.0 173592.0 173643.0 41465.2 41805.0 41834.4 41848.8 41867.0 1148.5 1179.7 1193.3 1194.3 1197.0 19041.3 20229.5 20810.3 20866.3 21001.4 29987.4 36951.6 37283.8 37598.0 37713.0 155080.0 155155.0 155333.0 156344.2 156540.0 29661.4 30640.0 30701.5 30840.2 31021.1 35779.6 35912.5 36712.8 36808.3 37247.6 26753.5 27540.9 27557.6 27749.1 28278.3 26980.9 27113.2 27741.7 27786.4 28842.1 27624.2 27630.0 27788.6 28050.7 28371.1 26582.5 26879.9 27114.7 27117.7 28091.0 21542.6 22538.2 22586.3 22634.7 22697.2 18:51:03 INFO - PID 24027 | 18:51:03 INFO - PID 24027 | [#2] jquery.html Cycles:180 Average:24250.12 Median:41095.49 stddev:57933.46 (141.0%) stddev-sans-first:58068.30 18:51:03 INFO - PID 24027 | Values: 402.0 407.7 417.5 422.3 432.4 17431.8 18040.4 18064.9 18536.2 19227.1 17853.9 18126.4 18240.1 18270.1 18294.6 5036.5 5177.3 5337.5 5519.6 5534.9 5350.4 5396.2 5399.0 5444.4 5445.4 5191.7 5309.4 5319.4 5343.8 5383.2 5216.2 5308.1 5313.3 5321.6 5335.0 4810.0 4812.5 4814.9 4822.6 4830.2 21589.9 22464.6 22471.1 22519.5 22586.3 1545.5 1598.7 1635.2 1670.1 1670.8 14304.2 14725.2 14785.2 14789.0 15074.6 1975.9 2059.2 2078.7 2107.9 2124.1 88798.6 91306.0 93982.5 94865.0 96368.0 10811.1 11035.8 11097.6 11270.7 11433.3 15242.4 15388.6 15500.3 15514.1 15525.4 7038.3 7225.6 7236.7 7272.1 7317.8 6368.6 6386.1 6547.2 6557.7 6574.0 6889.4 6950.7 6964.7 7118.2 7120.8 1961.2 1977.2 2005.2 2017.8 2129.1 825.1 855.0 861.9 880.3 888.7 16726.9 16760.5 16891.0 16956.0 17594.6 839.6 839.9 846.8 846.8 868.0 8759.6 8781.7 8839.3 9041.3 9112.6 339312.0 346532.0 346832.0 347071.0 347960.0 68471.7 74914.0 75627.2 76758.0 77583.1 1042.7 1071.4 1091.6 1098.1 1100.6 15911.3 16104.6 16189.8 16658.3 17045.2 39278.4 40579.6 40826.4 40958.6 41232.4 49273.8 51366.7 51413.2 52240.2 52363.2 8067.4 8158.2 8211.0 8225.9 8372.6 11895.6 11925.8 12106.5 12149.0 12394.9 9995.6 10227.8 10298.7 10471.5 10723.8 9443.0 9664.3 9711.2 9949.0 10041.8 10311.4 10312.4 10869.0 10949.8 11048.3 7880.5 7943.8 7955.0 8087.3 8261.7 10029.3 10459.5 10461.9 10891.8 11089.8 18:51:03 INFO - PID 24027 | 18:51:03 INFO - PID 24027 | [#3] mootools.html Cycles:180 Average:6129.42 Median:3731.57 stddev:3961.72 (106.2%) stddev-sans-first:3955.97 18:51:03 INFO - PID 24027 | Values: 1264.6 1313.6 1324.7 1328.4 1338.0 9342.8 9632.3 9713.3 10251.6 10589.9 10480.8 10649.1 10663.4 10700.9 10734.2 2142.2 2180.1 2182.5 2187.2 2187.6 2081.8 2160.3 2164.8 2165.8 2166.8 2126.3 2137.8 2149.9 2153.6 2159.1 2090.0 2094.2 2100.5 2107.9 2113.0 2006.8 2026.3 2044.1 2122.9 2125.0 10062.6 10182.8 10185.8 10218.2 10219.4 5303.7 5412.5 5507.7 5510.8 5528.6 3077.9 3203.5 3231.9 3258.5 3280.6 1062.2 1069.1 1085.9 1089.8 1126.0 13641.9 13957.7 13959.1 13963.3 13975.7 4414.6 4515.9 4572.9 4584.0 4661.4 10251.7 10252.6 10253.2 10254.2 10259.4 5154.8 5260.1 5261.9 5274.3 5281.8 4755.1 4821.0 4826.1 4861.7 5027.4 3602.0 3650.1 3706.6 3756.5 3762.4 1066.7 1072.5 1073.1 1089.2 1089.8 630.2 646.1 665.3 667.8 681.3 5181.4 5266.3 5337.9 5339.4 5435.8 495.5 811.5 839.5 850.2 857.3 3591.1 3773.8 3895.3 3929.1 3937.0 11460.7 12843.1 13265.7 13307.9 13398.8 12801.4 13225.1 13234.1 13278.3 13439.3 7164.5 7236.8 7259.8 7319.7 7332.8 5527.3 5590.4 5720.3 5805.1 5968.9 11692.8 11987.0 12049.5 12103.1 12159.9 12139.6 12167.9 12193.5 12315.8 12316.2 8033.7 8223.9 8232.3 8247.8 8251.8 9315.6 9445.6 9550.1 9551.7 9610.4 8004.7 8014.7 8163.0 8197.1 8261.0 7651.5 7696.5 7706.6 7742.9 7760.1 7132.0 7155.0 7193.2 7206.3 7227.2 4507.4 4935.8 4968.3 4979.3 5193.9 5111.5 5118.0 5126.8 5254.5 5356.1 18:51:03 INFO - PID 24027 | 18:51:03 INFO - PID 24027 | [#4] prototype.html Cycles:180 Average:4895.39 Median:5463.32 stddev:1405.14 (25.7%) stddev-sans-first:1366.88 18:51:03 INFO - PID 24027 | Values: 341.5 356.6 357.2 365.8 367.2 5466.2 5573.7 5624.6 5642.4 5679.6 5460.5 5538.1 5547.6 5550.3 5569.7 4370.6 4373.8 4373.8 4381.9 4389.3 4206.7 4352.1 4369.7 4390.9 4392.5 4317.6 4320.9 4335.2 4347.6 4361.5 4320.4 4328.5 4329.9 4332.6 4347.9 3751.6 3890.7 3928.5 3941.0 3950.7 5422.6 5427.8 5431.3 5442.9 5446.4 5086.4 5144.7 5171.3 5179.8 5204.9 5855.8 5869.5 5898.5 5919.1 5952.6 4397.4 4402.8 4404.4 4418.3 4427.9 5962.7 6081.7 6162.8 6238.7 6312.9 4277.9 4297.7 4303.8 4310.9 4317.4 4337.6 4366.4 4366.6 4370.9 4373.8 4978.6 4979.2 4983.9 5164.0 5171.4 5920.2 5935.9 5955.6 5963.2 5982.8 1572.6 1606.1 1610.8 1614.6 1615.3 1116.5 1122.6 1127.2 1133.3 1145.9 5004.4 5034.7 5055.1 5079.5 5092.3 6065.4 6132.1 6135.7 6143.2 6156.2 4890.0 4987.0 5000.9 5036.8 5055.0 3192.8 3218.9 3243.8 3264.8 3270.7 5503.4 5586.2 5590.2 5637.5 5646.7 6234.8 6241.8 6244.7 6245.3 6314.1 5570.5 5576.4 5610.4 5625.3 5640.8 5759.0 6037.8 6084.5 6084.7 6122.1 5852.6 6010.2 6013.6 6029.8 6042.2 5531.2 5582.8 5617.2 5620.5 5638.4 4048.2 4101.6 4105.5 4115.5 4120.5 5956.6 6059.2 6098.1 6099.2 6136.3 5875.9 5879.4 5901.2 5901.9 5904.4 5830.9 5869.9 5890.0 5924.6 5939.6 5819.9 5824.9 5861.1 5867.0 5907.0 5923.9 5971.6 5988.6 6009.6 6013.9 5633.7 5747.3 5773.7 5790.2 5793.3 18:51:03 INFO - PID 24027 | 18:51:03 INFO - PID 24027 | [#5] yui.html Cycles:180 Average:16752.35 Median:18670.59 stddev:21690.49 (116.2%) stddev-sans-first:21717.63 18:51:03 INFO - PID 24027 | Values: 649.2 669.6 717.7 722.2 743.5 12506.8 13033.9 13542.6 14414.0 14441.2 14771.6 15135.7 15178.7 15180.5 15200.7 883.2 902.4 906.1 906.9 908.6 899.5 904.2 905.3 907.2 908.0 927.0 939.6 940.4 941.2 944.1 925.9 939.4 941.2 943.4 949.3 683.4 686.5 689.6 691.1 692.7 13624.2 14261.2 14314.2 14321.1 14375.6 14702.1 15363.7 15391.8 15516.8 15572.4 11468.7 11613.2 11714.6 11746.2 11896.2 2935.6 2946.2 2958.3 2961.7 2962.2 73809.0 76251.0 78515.0 79211.6 83628.2 12978.1 13446.9 13512.9 13685.4 13892.3 20928.9 21531.6 21751.0 24245.9 24263.4 6019.2 6153.2 6163.4 6165.1 6181.2 2713.8 2769.2 2784.3 2786.1 2789.0 3502.0 3658.2 3771.5 3791.8 3798.7 711.6 738.2 750.2 763.2 766.6 542.7 560.8 561.1 566.6 571.8 9896.9 10120.6 10277.8 10495.0 10690.3 549.8 550.8 552.3 553.1 559.3 4433.7 4594.3 4636.9 4636.9 4796.9 82400.0 82499.6 82557.0 84284.2 84896.2 66179.3 66438.0 72801.3 73839.0 74094.6 57242.1 60042.7 60116.4 60659.7 61332.4 9082.6 9920.6 10188.1 10252.8 10512.2 26476.6 27186.5 27311.7 28360.6 28445.6 34379.0 34535.7 34622.0 35087.0 35385.1 13726.6 13862.6 13952.1 14165.5 14165.6 14836.4 14918.8 14978.6 15459.0 15638.1 14110.5 14301.2 14495.6 14699.5 14710.2 14385.6 14636.1 15376.5 15517.6 15702.5 14368.0 14388.9 14490.3 14532.3 14691.0 9893.7 10045.7 10304.4 10351.0 10471.6 11075.3 11929.2 11953.3 12074.6 12090.8 18:51:03 INFO - PID 24027 | -------- Summary: end -------- 18:51:03 INFO - PID 24027 | 18:51:04 INFO - TEST-INFO | 24027: exit 0 18:51:04 INFO - TEST-OK | dromaeo_css | took 1147364ms 18:51:04 INFO - TEST-START | kraken 18:51:04 INFO - operating with platform_type : linux_ 18:51:04 INFO - Initialising browser for kraken test... 18:51:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36353/getInfo.html -profile /tmp/tmpL050ZO/profile 18:51:04 INFO - TEST-INFO | started process 24445 (/builds/slave/test/build/application/firefox/firefox http://localhost:36353/getInfo.html) 18:51:39 INFO - TEST-INFO | 24445: killed by SIGTERM 18:51:40 INFO - Browser initialized. 18:51:40 INFO - Running cycle 1/1 for kraken test... 18:51:40 INFO - TEST-INFO | started process 24664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL050ZO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:51:52 INFO - PID 24664 | RSS: Main: 177295360 18:51:52 INFO - PID 24664 | 18:51:54 INFO - PID 24664 | Cycle 1(1): loaded http://localhost:36353/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36353/tests/kraken/driver.html?testName=audio-beat-detection) 18:51:55 INFO - PID 24664 | RSS: Main: 182759424 18:51:55 INFO - PID 24664 | 18:51:58 INFO - PID 24664 | Cycle 1(1): loaded http://localhost:36353/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36353/tests/kraken/driver.html?testName=audio-dft) 18:51:59 INFO - PID 24664 | RSS: Main: 181899264 18:51:59 INFO - PID 24664 | 18:52:02 INFO - PID 24664 | Cycle 1(1): loaded http://localhost:36353/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36353/tests/kraken/driver.html?testName=audio-fft) 18:52:02 INFO - PID 24664 | RSS: Main: 179015680 18:52:02 INFO - PID 24664 | 18:52:04 INFO - PID 24664 | Cycle 1(1): loaded http://localhost:36353/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36353/tests/kraken/driver.html?testName=audio-oscillator) 18:52:05 INFO - PID 24664 | RSS: Main: 179507200 18:52:05 INFO - PID 24664 | 18:52:07 INFO - PID 24664 | Cycle 1(1): loaded http://localhost:36353/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36353/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:52:08 INFO - PID 24664 | RSS: Main: 179818496 18:52:08 INFO - PID 24664 | 18:52:11 INFO - PID 24664 | Cycle 1(1): loaded http://localhost:36353/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36353/tests/kraken/driver.html?testName=imaging-darkroom) 18:52:11 INFO - PID 24664 | RSS: Main: 183689216 18:52:11 INFO - PID 24664 | 18:52:15 INFO - PID 24664 | Cycle 1(1): loaded http://localhost:36353/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36353/tests/kraken/driver.html?testName=imaging-desaturate) 18:52:16 INFO - PID 24664 | RSS: Main: 180060160 18:52:16 INFO - PID 24664 | 18:52:19 INFO - PID 24664 | Cycle 1(1): loaded http://localhost:36353/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36353/tests/kraken/driver.html?testName=json-parse-financial) 18:52:19 INFO - PID 24664 | RSS: Main: 180449280 18:52:19 INFO - PID 24664 | 18:52:21 INFO - PID 24664 | Cycle 1(1): loaded http://localhost:36353/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36353/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:52:22 INFO - PID 24664 | RSS: Main: 180871168 18:52:22 INFO - PID 24664 | 18:52:23 INFO - PID 24664 | Cycle 1(1): loaded http://localhost:36353/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36353/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:52:24 INFO - PID 24664 | RSS: Main: 180645888 18:52:24 INFO - PID 24664 | 18:52:26 INFO - PID 24664 | Cycle 1(1): loaded http://localhost:36353/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36353/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:52:27 INFO - PID 24664 | RSS: Main: 180326400 18:52:27 INFO - PID 24664 | 18:52:30 INFO - PID 24664 | Cycle 1(1): loaded http://localhost:36353/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36353/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:52:30 INFO - PID 24664 | RSS: Main: 180494336 18:52:30 INFO - PID 24664 | 18:52:34 INFO - PID 24664 | Cycle 1(1): loaded http://localhost:36353/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36353/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:52:34 INFO - PID 24664 | RSS: Main: 181108736 18:52:34 INFO - PID 24664 | 18:52:36 INFO - PID 24664 | Cycle 1(1): loaded http://localhost:36353/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36353/tests/kraken/driver.html?testName=ai-astar) 18:52:36 INFO - PID 24664 | RSS: Main: 182026240 18:52:36 INFO - PID 24664 | 18:52:36 INFO - PID 24664 | __start_tp_report 18:52:36 INFO - PID 24664 | _x_x_mozilla_page_load 18:52:36 INFO - PID 24664 | _x_x_mozilla_page_load_details 18:52:36 INFO - PID 24664 | |i|pagename|runs| 18:52:36 INFO - PID 24664 | |0;ai-astar;106;113;111;111;111;110;110;113;111;115 18:52:36 INFO - PID 24664 | |1;audio-beat-detection;155;125;131;167;136;125;124;124;148;124 18:52:36 INFO - PID 24664 | |2;audio-dft;165;165;164;168;169;173;165;165;164;163 18:52:36 INFO - PID 24664 | |3;audio-fft;75;76;75;102;80;74;75;76;109;74 18:52:36 INFO - PID 24664 | |4;audio-oscillator;83;84;113;85;83;84;98;84;86;106 18:52:36 INFO - PID 24664 | |5;imaging-gaussian-blur;113;115;114;114;114;114;115;119;115;113 18:52:36 INFO - PID 24664 | |6;imaging-darkroom;150;151;152;150;150;150;150;151;154;152 18:52:36 INFO - PID 24664 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;95 18:52:36 INFO - PID 24664 | |8;json-parse-financial;53;57;57;55;54;57;64;56;56;55 18:52:36 INFO - PID 24664 | |9;json-stringify-tinderbox;57;63;56;56;57;56;56;57;56;56 18:52:36 INFO - PID 24664 | |10;stanford-crypto-aes;89;85;86;86;88;87;90;88;127;88 18:52:36 INFO - PID 24664 | |11;stanford-crypto-ccm;136;149;137;136;135;133;133;138;131;142 18:52:36 INFO - PID 24664 | |12;stanford-crypto-pbkdf2;187;196;198;187;187;206;194;192;194;198 18:52:36 INFO - PID 24664 | |13;stanford-crypto-sha256-iterative;72;73;73;73;75;76;81;78;71;74 18:52:36 INFO - PID 24664 | __end_tp_report 18:52:36 INFO - PID 24664 | __start_cc_report 18:52:36 INFO - PID 24664 | _x_x_mozilla_cycle_collect,932 18:52:36 INFO - PID 24664 | __end_cc_report 18:52:36 INFO - PID 24664 | __startTimestamp1495677156793__endTimestamp 18:52:36 INFO - PID 24664 | 18:52:36 INFO - PID 24664 | ------- Summary: start ------- 18:52:36 INFO - PID 24664 | Number of tests: 14 18:52:36 INFO - PID 24664 | 18:52:36 INFO - PID 24664 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:2.38 (2.1%) stddev-sans-first:1.66 18:52:36 INFO - PID 24664 | Values: 106.0 113.0 111.0 111.0 111.0 110.0 110.0 113.0 111.0 115.0 18:52:36 INFO - PID 24664 | 18:52:36 INFO - PID 24664 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:133.50 stddev:15.51 (11.6%) stddev-sans-first:14.83 18:52:36 INFO - PID 24664 | Values: 155.0 125.0 131.0 167.0 136.0 125.0 124.0 124.0 148.0 124.0 18:52:36 INFO - PID 24664 | 18:52:36 INFO - PID 24664 | [#2] audio-dft Cycles:10 Average:166.10 Median:165.00 stddev:3.03 (1.8%) stddev-sans-first:3.19 18:52:36 INFO - PID 24664 | Values: 165.0 165.0 164.0 168.0 169.0 173.0 165.0 165.0 164.0 163.0 18:52:36 INFO - PID 24664 | 18:52:36 INFO - PID 24664 | [#3] audio-fft Cycles:10 Average:81.60 Median:75.00 stddev:12.82 (17.1%) stddev-sans-first:13.37 18:52:36 INFO - PID 24664 | Values: 75.0 76.0 75.0 102.0 80.0 74.0 75.0 76.0 109.0 74.0 18:52:36 INFO - PID 24664 | 18:52:36 INFO - PID 24664 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:84.00 stddev:11.02 (13.1%) stddev-sans-first:11.34 18:52:36 INFO - PID 24664 | Values: 83.0 84.0 113.0 85.0 83.0 84.0 98.0 84.0 86.0 106.0 18:52:36 INFO - PID 24664 | 18:52:36 INFO - PID 24664 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.50 stddev:1.71 (1.5%) stddev-sans-first:1.72 18:52:36 INFO - PID 24664 | Values: 113.0 115.0 114.0 114.0 114.0 114.0 115.0 119.0 115.0 113.0 18:52:36 INFO - PID 24664 | 18:52:36 INFO - PID 24664 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:1.33 (0.9%) stddev-sans-first:1.36 18:52:36 INFO - PID 24664 | Values: 150.0 151.0 152.0 150.0 150.0 150.0 150.0 151.0 154.0 152.0 18:52:36 INFO - PID 24664 | 18:52:36 INFO - PID 24664 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 18:52:36 INFO - PID 24664 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 18:52:36 INFO - PID 24664 | 18:52:36 INFO - PID 24664 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.50 stddev:2.99 (5.3%) stddev-sans-first:2.91 18:52:36 INFO - PID 24664 | Values: 53.0 57.0 57.0 55.0 54.0 57.0 64.0 56.0 56.0 55.0 18:52:36 INFO - PID 24664 | 18:52:36 INFO - PID 24664 | [#9] json-stringify-tinderbox Cycles:10 Average:57.00 Median:56.50 stddev:2.16 (3.8%) stddev-sans-first:2.29 18:52:36 INFO - PID 24664 | Values: 57.0 63.0 56.0 56.0 57.0 56.0 56.0 57.0 56.0 56.0 18:52:36 INFO - PID 24664 | 18:52:36 INFO - PID 24664 | [#10] stanford-crypto-aes Cycles:10 Average:91.40 Median:88.00 stddev:12.60 (14.3%) stddev-sans-first:13.33 18:52:36 INFO - PID 24664 | Values: 89.0 85.0 86.0 86.0 88.0 87.0 90.0 88.0 127.0 88.0 18:52:36 INFO - PID 24664 | 18:52:36 INFO - PID 24664 | [#11] stanford-crypto-ccm Cycles:10 Average:137.00 Median:136.50 stddev:5.21 (3.8%) stddev-sans-first:5.51 18:52:36 INFO - PID 24664 | Values: 136.0 149.0 137.0 136.0 135.0 133.0 133.0 138.0 131.0 142.0 18:52:36 INFO - PID 24664 | 18:52:36 INFO - PID 24664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.90 Median:195.00 stddev:6.06 (3.1%) stddev-sans-first:5.89 18:52:36 INFO - PID 24664 | Values: 187.0 196.0 198.0 187.0 187.0 206.0 194.0 192.0 194.0 198.0 18:52:36 INFO - PID 24664 | 18:52:36 INFO - PID 24664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:74.50 stddev:3.03 (4.1%) stddev-sans-first:3.06 18:52:36 INFO - PID 24664 | Values: 72.0 73.0 73.0 73.0 75.0 76.0 81.0 78.0 71.0 74.0 18:52:36 INFO - PID 24664 | -------- Summary: end -------- 18:52:36 INFO - PID 24664 | 18:52:37 INFO - TEST-INFO | 24664: exit 0 18:52:37 INFO - TEST-OK | kraken | took 93503ms 18:52:37 INFO - SUITE-END | took 1240s 18:52:37 INFO - Completed test suite (00:20:40) 18:52:37 INFO - javascript benchmark 18:52:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6722.548599097124, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2685.798565107617, 2691.179190346945, 2700.6489156409666, 2726.9727302726965, 2738.6029025791263, 5208.036513245052, 5231.921521177181, 5241.859120675394, 5267.86830329242, 5322.49436303551, 5221.921671174926, 5247.317848679676, 5270.525652691257, 5316.946830531693, 5340.0, 4672.299155126724, 4676.205045142334, 4719.764011799396, 4720.457147428038, 4761.714297142165, 4673.252279635259, 4741.668083234175, 4760.642951778613, 4766.213574760161, 4808.663393562452, 4631.235846085392, 4670.929936050962, 4684.344191813149, 4707.882302942419, 4772.546608072245, 4645.187092258841, 4682.08699303636, 4684.086603112394, 4709.670323077386, 4719.646026548023, 4698.08387364464, 4701.976490117561, 4711.740854253015, 4712.858614241578, 4749.453812811536, 5154.896902061938, 5203.895922081575, 5234.110201265794, 5281.049411106, 5308.309919710451, 5641.802536911188, 5666.150077488369, 5702.942970570282, 5727.083666613322, 5727.971360143214, 5786.566007549409, 5789.102689083199, 5792.362840087587, 5823.650580965155, 5838.824835254906, 5313.335833020872, 5325.733713314319, 5327.760250788724, 5328.653637513549, 5335.0663633863915, 5716.256886604715, 5803.187553742479, 5884.440978107073, 5886.735096920649, 5886.823395298148, 5593.049181639131, 5636.267285252973, 5651.180578816131, 5664.178694089334, 5685.715714214272, 5562.694051827108, 5661.207430959669, 5693.829185124453, 5699.629524081004, 5703.144528320785, 5556.111022236423, 5644.774209031675, 5645.379008309083, 5646.378898321182, 5654.3497497788285, 5665.631733937281, 5677.205191273225, 5708.257926469615, 5742.167385729046, 5760.855978600569, 4421.447319085114, 4422.491413487426, 4433.091216300651, 4461.665375096816, 4461.776911154429, 3829.6744776694295, 3834.750741201813, 3836.501254836853, 3853.171568112813, 3873.748206366577, 4728.527147285313, 4767.189577771787, 4774.40319960005, 4781.856544303677, 4791.856244312677, 5729.083346664514, 5737.3975732548315, 5738.77044918207, 5770.0, 5794.768209271666, 4790.856274311776, 4794.5924596409695, 4824.035192961422, 4825.806967721322, 4846.248831431134, 5024.522670346311, 5106.055379754757, 5124.487551244772, 5138.203578445347, 5144.43411224765, 5258.237555554347, 5264.368275806928, 5273.604479664117, 5309.522143007148, 5325.174597937326, 5588.050031494575, 5673.149027645886, 5758.654480731169, 5781.479666830005, 5794.420557944172, 5237.81667641646, 5251.474852514718, 5276.208568714724, 5312.548433383051, 5330.653507521999, 5523.585731070106, 5627.718614069362, 5680.914786278292, 5684.403137670651, 5716.5998380113, 5724.141378793214, 5734.942650573441, 5737.770489180553, 5737.8565535861935, 5738.254026976633, 5438.184272359178, 5485.6982865942755, 5529.944700552943, 5555.694436805853, 5561.277033985556, 5559.833205003694, 5586.413426590149, 5601.271834661468, 5618.157276408408, 5628.549716022791, 5470.562355011669, 5496.560275178056, 5501.642393244426, 5504.9449505504435, 5512.889742205213, 5482.42434544383, 5564.888702226014, 5622.044252477171, 5627.268455100811, 5628.60599758013, 5384.380796208487, 5429.049916264717, 5429.131338985743, 5433.185022246536, 5497.39528651856], "value": 5143.48712552543, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.601002353482, 673.5924765516862, 683.2450142592435, 1188.7681902029108, 1197.712548988243, 34435.655643443555, 35357.823210883944, 35361.2927741445, 35571.82214088929, 35642.2871542569, 33499.33001339972, 33812.0, 34060.318793624116, 34124.48813267803, 34253.486197707054, 6610.636414997173, 6797.52417330787, 6811.4550835933005, 6811.591304521719, 6830.863382732342, 6566.704498297564, 6636.070950066995, 6648.0, 6664.733410663568, 6666.200055993263, 6657.766978155765, 6699.229588597301, 6706.0276259942275, 6708.865822683543, 6715.160604924385, 6633.800985970429, 6642.169728783902, 6657.966710166466, 6668.466522678174, 6683.632400217962, 6745.763898263586, 6771.593704377753, 6773.8983915241315, 6812.4550035997, 6812.48906332027, 32622.0, 33107.834460827544, 33177.50233746496, 33241.0, 33270.83364583162, 2826.1380279014893, 2846.4307138572367, 2858.3282928511785, 2860.699626539204, 2864.5130327844317, 24959.62560561593, 25117.0, 25180.49639007228, 25204.0, 25224.87387563069, 2898.8260704357594, 2902.071337172106, 2903.8112522685956, 2917.416516696669, 2932.8680209390627, 143559.0, 145191.0, 146207.0, 152667.0, 156563.43436565602, 40918.38622420666, 40950.38574421386, 41152.0, 41282.38076428856, 41298.58701413008, 42869.35695964563, 42878.35682464766, 42922.57077429186, 42982.78508607437, 45980.0, 11367.715807104889, 11452.713682158013, 11496.942515287537, 11502.424878756028, 11506.712332191762, 8689.6524139035, 8745.562721863882, 8757.824843503222, 8807.33944954131, 8833.867491987625, 12895.355232238539, 12927.676808079685, 12951.158174718614, 13028.47886084546, 13046.347682615831, 5334.946650533522, 5440.836774896759, 5449.765596105657, 5515.4760297771645, 5547.667139971614, 824.995875020621, 862.1077185113378, 890.8396488631979, 893.821235752852, 897.5063714956748, 20610.278640247518, 21082.89458552728, 21437.67843482349, 21514.46213844635, 21603.13968008554, 935.3546053223254, 942.137943781446, 960.9327347085637, 967.5645959318335, 971.1017308989157, 10542.209334299958, 11193.0, 11236.438178091063, 11367.261128026652, 11424.885751142383, 172906.0, 172911.0, 173446.0, 173592.0, 173643.0, 41465.1706965865, 41805.0, 41834.37248441276, 41848.815118488514, 41867.0, 1148.5004023249912, 1179.7463545337794, 1193.3078814287867, 1194.343111288805, 1196.9820452693216, 19041.333553325567, 20229.49426264355, 20810.27164049251, 20866.26968056111, 21001.369958901258, 29987.4002519944, 36951.630483695895, 37283.81358093192, 37598.0, 37713.0, 155080.0, 155155.0, 155333.0, 156344.21827890788, 156540.0, 29661.406771864873, 30640.0, 30701.53947690831, 30840.228994275323, 31021.069367918997, 35779.642203578675, 35912.4613130798, 36712.81643591765, 36808.26383472369, 37247.62752372442, 26753.464930701666, 27540.862295689196, 27557.586636200875, 27749.12543728136, 28278.293042674097, 26980.86509567518, 27113.1866044019, 27741.722582773913, 27786.444271114062, 28842.134735957115, 27624.171274861787, 27630.0, 27788.58317125204, 28050.719492804812, 28371.14886553324, 26582.468350633266, 26879.86560067187, 27114.72885271122, 27117.72882271152, 28091.0, 21542.569148617255, 22538.21116260923, 22586.322410327717, 22634.660480092483, 22697.205597803997], "value": 14414.29837303535, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.95980401959787, 407.668960842848, 417.4969162159598, 422.34958164426786, 432.37305906435654, 17431.82568174318, 18040.368587099456, 18064.909675451636, 18536.165872535734, 19227.134778934946, 17853.91073044633, 18126.3655772048, 18240.08799560023, 18270.086495675198, 18294.634107317845, 5036.496350364971, 5177.32694749682, 5337.5196232338985, 5519.558435325164, 5534.916976245359, 5350.384705758848, 5396.217548455472, 5399.0, 5444.428335024825, 5445.401005889349, 5191.688498690071, 5309.442508536606, 5319.388270348902, 5343.812966546172, 5383.219433182187, 5216.191490318987, 5308.124159513675, 5313.282706834586, 5321.574274058085, 5335.039692855285, 4810.0, 4812.494688057774, 4814.855554333376, 4822.614190864722, 4830.178869592178, 21589.892050539645, 22464.550708985727, 22471.101155953744, 22519.54960900773, 22586.322410327717, 1545.5363390982773, 1598.696247712931, 1635.2232689472523, 1670.13987796285, 1670.8078570964374, 14304.213268270241, 14725.190114543695, 14785.186814725186, 14789.038712483654, 15074.623134421727, 1975.940721778349, 2059.2072052259837, 2078.7089807426973, 2107.8735275883496, 2124.0866427436194, 88798.55600722019, 91306.0, 93982.5300873498, 94865.0, 96368.0, 10811.135109191246, 11035.779284414428, 11097.55609775616, 11270.718232044264, 11433.314001159957, 15242.390304387922, 15388.615284617974, 15500.30248638814, 15514.146721930176, 15525.378984840705, 7038.2961703829205, 7225.638718064076, 7236.710531578678, 7272.127344718668, 7317.817054573678, 6368.5860419072615, 6386.10594516768, 6547.247066587308, 6557.704903279364, 6573.967130164318, 6889.414399776075, 6950.687219075154, 6964.686589103401, 7118.216996130422, 7120.750773722998, 1961.1861077652613, 1977.1794705197183, 2005.1878989009474, 2017.8083082107175, 2129.127057906251, 825.1377310710322, 854.9700760473478, 861.8539835808791, 880.2781718990494, 888.6845169964698, 16726.916365418096, 16760.497185084467, 16891.0, 16956.0, 17594.560135996446, 839.5802098950525, 839.8824164616958, 846.7502086884384, 846.8348672009022, 867.9609417576224, 8759.60581773809, 8781.69264075767, 8839.337049721296, 9041.321900857462, 9112.635494580276, 339312.0, 346532.0, 346832.0, 347071.0, 347960.0, 68471.65764171147, 74914.0, 75627.24372756312, 76758.0, 77583.06042348986, 1042.67677020124, 1071.4160782373624, 1091.6288461922984, 1098.083100610983, 1100.6312885183393, 15911.28399222061, 16104.597385065466, 16189.838101618832, 16658.333666653198, 17045.232964516876, 39278.41082383824, 40579.59420405876, 40826.387604185365, 40958.59041409667, 41232.38151427791, 49273.753631231615, 51366.74316628393, 51413.22880156726, 52240.21639675484, 52363.21455178252, 8067.435279530377, 8158.224968627971, 8210.958945205235, 8225.917740822515, 8372.61380506577, 11895.643130706092, 11925.76148477043, 12106.530288756285, 12149.0, 12394.938025309815, 9995.550200240861, 10227.795444091225, 10298.691039268833, 10471.528781205016, 10723.839142412715, 9442.95278523603, 9664.275179361717, 9711.223102151669, 9949.0, 10041.849372259276, 10311.432871191857, 10312.381257124596, 10869.0, 10949.781004379709, 11048.281861678965, 7880.527168369917, 7943.761687149395, 7955.0, 8087.312578430664, 8261.710840120568, 10029.297949143782, 10459.529321180413, 10461.895381046092, 10891.782164356828, 11089.833652495057], "value": 8678.43502238017, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1264.6142926407445, 1313.553391846772, 1324.6622111361596, 1328.4354149486467, 1338.0299283019808, 9342.813143737121, 9632.325737198391, 9713.271504637154, 10251.641192558262, 10589.947050264738, 10480.79038419233, 10649.09482693972, 10663.413512256822, 10700.946495267532, 10734.248602597801, 2142.207383268193, 2180.051677520276, 2182.454386403399, 2187.245400336881, 2187.6171669957776, 2081.8230450411656, 2160.3087012156116, 2164.848460607758, 2165.761766205716, 2166.8483206175574, 2126.2983215538834, 2137.8289736821016, 2149.924752633658, 2153.6446486329737, 2159.136345461812, 2090.049027692404, 2094.2251366994155, 2100.495880988567, 2107.92622258221, 2112.9894350528302, 2006.839452843769, 2026.3110542415502, 2044.0597325230412, 2122.8514004019726, 2125.0331099349914, 10062.647807326708, 10182.847257291147, 10185.847212291821, 10218.233632477593, 10219.386836789816, 5303.734813259361, 5412.485813847678, 5507.697076660782, 5510.81517473741, 5528.55771538276, 3077.9076627701206, 3203.4874420092674, 3231.8545665445113, 3258.4949332853444, 3280.5735254417013, 1062.16089289462, 1069.1286601419818, 1085.9294145880492, 1089.8147314956398, 1125.9943700281528, 13641.863581364258, 13957.720845583133, 13959.092658977133, 13963.301834908316, 13975.720485590333, 4414.624756895636, 4515.877537557343, 4572.88567785808, 4583.954160458353, 4661.3707149534375, 10251.7437064074, 10252.58989640421, 10253.231007674454, 10254.230932680079, 10259.384436933808, 5154.768035438415, 5260.079486089919, 5261.921071183935, 5274.340707411574, 5281.788728450819, 4755.120302744003, 4821.0, 4826.107170173459, 4861.683990540603, 5027.371578552681, 3601.981990090085, 3650.0874781304674, 3706.6478684524927, 3756.492873462102, 3762.4168253920684, 1066.664000839733, 1072.5066469423996, 1073.1146803886668, 1089.1559041742555, 1089.7929393415225, 630.224823467138, 646.0632083478974, 665.3147258323934, 667.7829705345782, 681.2880539835785, 5181.3782346118705, 5266.262723218752, 5337.86655333612, 5339.359276886798, 5435.83692489226, 495.5193462341523, 811.4684881402691, 839.4627438439404, 850.1795767084669, 857.3055824781947, 3591.06632275605, 3773.7924414157483, 3895.2793733159456, 3929.1298071399647, 3937.0, 11460.656180314603, 12843.100982931292, 13265.66835829112, 13307.933460332637, 13398.799018014737, 12801.423935922905, 13225.074244802963, 13234.073614846868, 13278.269695166666, 13439.260840653858, 7164.534305270141, 7236.782896513113, 7259.782206533707, 7319.670614822346, 7332.78001659951, 5527.309086364205, 5590.413006634408, 5720.2849643794525, 5805.10020946754, 5968.850778730392, 11692.766144677229, 11986.981106606036, 12049.51801927913, 12103.092268079754, 12159.939200303941, 12139.575114870937, 12167.939160304495, 12193.51225950952, 12315.815262770886, 12316.199447035913, 8033.718819841278, 8223.917760822314, 8232.34141268685, 8247.835043299221, 8251.83496330082, 9315.580798863932, 9445.622175112918, 9550.140487356171, 9551.665691700757, 9610.423374597547, 8004.679812807422, 8014.719484818003, 8162.959185204273, 8197.05733840592, 8260.958695206726, 7651.502652327581, 7696.538207707556, 7706.576138312446, 7742.883856742266, 7760.068791745027, 7132.037174981519, 7155.034070400638, 7193.244709305657, 7206.315400036988, 7227.205007449282, 4507.414036175276, 4935.75321233944, 4968.254761785616, 4979.278004689228, 5193.935243275195, 5111.514406131411, 5118.0, 5126.769295381642, 5254.500822421864, 5356.089464791073], "value": 4602.202950295998, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.51675379338235, 356.55608767084965, 357.17492592112205, 365.8061227549399, 367.1866815004765, 5466.180072989054, 5573.693446860421, 5624.578156638253, 5642.391918303284, 5679.5740319476, 5460.453954604538, 5538.141588053848, 5547.639403438774, 5550.2507161533185, 5569.6658200508, 4370.56294370562, 4373.759443230629, 4373.825046998117, 4381.868543943687, 4389.266239835263, 4206.705530612859, 4352.107817897323, 4369.73781573105, 4390.912181756363, 4392.494863090737, 4317.611414972652, 4320.913581728363, 4335.219660461115, 4347.60871521563, 4361.49842768081, 4320.416743739586, 4328.48058233014, 4329.935050974238, 4332.566743325642, 4347.934780978288, 3751.643593858579, 3890.727649064567, 3928.4696565963513, 3941.0, 3950.6641935435523, 5422.593305502063, 5427.810026649048, 5431.293931788842, 5442.863928401782, 5446.373667028302, 5086.3896332440345, 5144.742762861842, 5171.301874246966, 5179.792808287664, 5204.895902081975, 5855.824325270249, 5869.530437564985, 5898.498627616657, 5919.146300033974, 5952.642841429528, 4397.428334316551, 4402.823887044515, 4404.427424434835, 4418.29307310832, 4427.911441771179, 5962.701864906738, 6081.695915204222, 6162.845928851814, 6238.688065596747, 6312.926802443596, 4277.91444171121, 4297.67767417445, 4303.806328715215, 4310.892227694333, 4317.373980772771, 4337.566243375701, 4366.366876802846, 4366.607005369532, 4370.929122364977, 4373.846915358011, 4978.626603004789, 4979.228219625964, 4983.90032199354, 5163.97418012915, 5171.4311425743135, 5920.171176035358, 5935.881282374328, 5955.553333500005, 5963.19496867926, 5982.760689572368, 1572.5989872582647, 1606.1005836731467, 1610.7503336982786, 1614.6367067409974, 1615.3377115382636, 1116.5143162724241, 1122.640754958422, 1127.2053202492223, 1133.2916926920675, 1145.9140564457698, 5004.399472063303, 5034.748262586856, 5055.140626093573, 5079.492050794891, 5092.337996060489, 6065.363136870653, 6132.08018797184, 6135.723892424851, 6143.170671959318, 6156.199694039836, 4889.951100489021, 4986.950130498649, 5000.924986125211, 5036.84889453317, 5054.974725126351, 3192.776505644629, 3218.9195270118435, 3243.7997940761597, 3264.8367581620823, 3270.7219886309454, 5503.367112782082, 5586.245856809279, 5590.18942253371, 5637.548996080386, 5646.6894320811925, 6234.781782637586, 6241.750329986749, 6244.687765611701, 6245.28179259391, 6314.116023756677, 5570.470805273573, 5576.358718747396, 5610.410906854803, 5625.312406278182, 5640.802571909963, 5759.0, 6037.849053773691, 6084.482818960261, 6084.665343406155, 6122.142899993915, 5852.590318677651, 6010.1585777991995, 6013.579049466495, 6029.78895738647, 6042.214512113573, 5531.170324451204, 5582.7766889323975, 5617.185508101385, 5620.522255608319, 5638.351589567088, 4048.21059893318, 4101.630853223224, 4105.4662893823615, 4115.506139263308, 4120.546739858673, 5956.553258505716, 6059.182245326472, 6098.146259523759, 6099.176611157437, 6136.32500424944, 5875.94124058771, 5879.412058794086, 5901.173835662925, 5901.881962360643, 5904.409559044061, 5830.854228644318, 5869.882602348014, 5889.970550147222, 5924.644521328734, 5939.554533409925, 5819.912701309399, 5824.883502330014, 5861.120831875252, 5867.0, 5906.970465147647, 5923.940760592339, 5971.552133589911, 5988.640681559121, 6009.609375390585, 6013.909791353046, 5633.661980281032, 5747.281589801275, 5773.672055427359, 5790.218320526844, 5793.275840519935], "value": 4463.178593632988, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.1713376320748, 669.6350488983503, 717.6878058044751, 722.1731117870039, 743.4535616322004, 12506.812397814017, 13033.93483032586, 13542.593722188338, 14413.999999999987, 14441.205733684656, 14771.55685329439, 15135.697286054272, 15178.696426071472, 15180.54458366248, 15200.695986080273, 883.1521739130426, 902.431468175052, 906.1436942089728, 906.8821053263066, 908.600215905003, 899.5412339706764, 904.1546154345675, 905.302916754099, 907.1971305394708, 908.0, 926.9907300926972, 939.6335429182624, 940.3699521320732, 941.2422999485445, 944.0748066894448, 925.9398139120935, 939.375315415248, 941.2140862379887, 943.3726571829725, 949.3212353167484, 683.4156795939499, 686.5125760709902, 689.6448329110513, 691.0670594697169, 692.705600119947, 13624.18254904699, 14261.215633140173, 14314.212718300489, 14321.14073155614, 14375.568732938029, 14702.11787292755, 15363.692726145415, 15391.769123463157, 15516.844831551765, 15572.37710491579, 11468.71328216793, 11613.18707690462, 11714.589989350417, 11746.177767556275, 11896.22674526153, 2935.57434172046, 2946.1603443018853, 2958.3195864950967, 2961.7038296170426, 2962.1853990152663, 73809.0, 76251.0, 78515.0, 79211.60394197992, 83628.16371836264, 12978.091533592558, 13446.932765336307, 13512.93243533776, 13685.384157712926, 13892.305384730724, 20928.895355523124, 21531.56936861254, 21751.0, 24245.878770606036, 24263.393415164763, 6019.247594050744, 6153.2000839891425, 6163.3836616338, 6165.075238714228, 6181.227346581677, 2713.769329606966, 2769.2384594236746, 2784.303924018995, 2786.1223714530265, 2788.9860550697117, 3501.964980350164, 3658.176910195185, 3771.4908487354405, 3791.75353602015, 3798.6581207691443, 711.5623891306809, 738.1990540263873, 750.2422553221177, 763.2215140556601, 766.6281853301144, 542.6771071212622, 560.7953097119522, 561.1330494386183, 566.6175331651201, 571.8398848322477, 9896.901030989598, 10120.59517619287, 10277.845832312521, 10495.0, 10690.251682382159, 549.7636016512938, 550.7659244820935, 552.2958228258922, 553.1177771454524, 559.2729451712758, 4433.733975961452, 4594.333821595917, 4636.86089417318, 4636.884077898012, 4796.928046079312, 82400.0, 82499.58750206331, 82557.0, 84284.15715842762, 84896.15103849006, 66179.33820661828, 66438.0, 72801.27198727946, 73839.0, 74094.62952685202, 57242.141367879514, 60042.69978650166, 60116.39883601108, 60659.69670151621, 61332.386676132664, 9082.636694532144, 9920.553575089283, 10188.083072523508, 10252.846207307046, 10512.159027277647, 26476.602850957635, 27186.456270874867, 27311.72688273092, 28360.57459138156, 28445.573316399856, 34379.0, 34535.65464345324, 34622.0, 35087.0, 35385.115372115906, 13726.588202353945, 13862.584122476343, 13952.093113947562, 14165.504207352693, 14165.645858853199, 14836.406543738129, 14918.776218356516, 14978.625534361729, 15459.0, 15638.139902305482, 14110.50613228532, 14301.213433261271, 14495.565133046026, 14699.485518006819, 14710.19093949843, 14385.64035899111, 14636.121832690073, 15376.461823836113, 15517.612059698598, 15702.450414235447, 14368.0, 14388.85611143917, 14490.275486225857, 14532.27338633043, 14691.0, 9893.65372211969, 10045.748856278358, 10304.433256170683, 10351.0, 10471.633492827714, 11075.280106793354, 11929.164958452826, 11953.282803031845, 12074.577389791315, 12090.818637720266], "value": 6983.453492950904, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 111.0, 111.0, 111.0, 110.0, 110.0, 113.0, 111.0, 115.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 131.0, 167.0, 136.0, 125.0, 124.0, 124.0, 148.0, 124.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 164.0, 168.0, 169.0, 173.0, 165.0, 165.0, 164.0, 163.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 102.0, 80.0, 74.0, 75.0, 76.0, 109.0, 74.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 113.0, 85.0, 83.0, 84.0, 98.0, 84.0, 86.0, 106.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 114.0, 114.0, 114.0, 115.0, 119.0, 115.0, 113.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 152.0, 150.0, 150.0, 150.0, 150.0, 151.0, 154.0, 152.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 57.0, 57.0, 55.0, 54.0, 57.0, 64.0, 56.0, 56.0, 55.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 63.0, 56.0, 56.0, 57.0, 56.0, 56.0, 57.0, 56.0, 56.0], "value": 57.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 86.0, 86.0, 88.0, 87.0, 90.0, 88.0, 127.0, 88.0], "value": 91.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 149.0, 137.0, 136.0, 135.0, 133.0, 133.0, 138.0, 131.0, 142.0], "value": 137.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 196.0, 198.0, 187.0, 187.0, 206.0, 194.0, 192.0, 194.0, 198.0], "value": 193.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 73.0, 73.0, 75.0, 76.0, 81.0, 78.0, 71.0, 74.0], "value": 74.6, "unit": "score"}]}]} 18:52:38 INFO - Return code: 0 18:52:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:52:38 INFO - # TBPL SUCCESS # 18:52:38 INFO - Running post-action listener: _resource_record_post_action 18:52:38 INFO - [mozharness: 2017-05-25 01:52:38.089795Z] Finished run-tests step (success) 18:52:38 INFO - Running post-run listener: _resource_record_post_run 18:52:38 INFO - Total resource usage - Wall time: 1257s; CPU: 13.0%; Read bytes: 12288; Write bytes: 418963456; Read time: 220; Write time: 437720 18:52:38 INFO - TinderboxPrint: CPU usage
12.9% 18:52:38 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 220 18:52:38 INFO - TinderboxPrint: I/O write bytes / time
418,963,456 / 437,720 18:52:38 INFO - TinderboxPrint: CPU idle
8,743.7 (87.1%) 18:52:38 INFO - TinderboxPrint: CPU user
1,232.9 (12.3%) 18:52:38 INFO - TinderboxPrint: Swap in / out
0 / 0 18:52:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 116367360; Read time: 60; Write time: 118544 18:52:38 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 4096; Write bytes: 302596096; Read time: 148; Write time: 319176 18:52:38 INFO - Running post-run listener: _upload_blobber_files 18:52:38 INFO - Blob upload gear active. 18:52:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:52:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:52:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:52:39 INFO - (blobuploader) - INFO - Open directory for files ... 18:52:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:52:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:52:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:52:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:52:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:52:40 INFO - (blobuploader) - INFO - Done attempting. 18:52:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:52:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:52:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:52:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:52:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:52:45 INFO - (blobuploader) - INFO - Done attempting. 18:52:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:52:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:52:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:52:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:52:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:52:46 INFO - (blobuploader) - INFO - Done attempting. 18:52:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:52:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:52:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:52:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:52:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:52:47 INFO - (blobuploader) - INFO - Done attempting. 18:52:47 INFO - (blobuploader) - INFO - Iteration through files over. 18:52:47 INFO - Return code: 0 18:52:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:52:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:52:47 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75e5c955b849942327df12405e584cc8c130ea3aa9544eb2015575a85ccddf5aa0f26899589080209df06571383a4413e630a7efe10c27238c1748e3e25b3fb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d429996c2d5db372517faef0f0378adb284a7e09f399486d4ad650a538279da801c2569d6252af1a70f393d4280a50a3aac5928340ce598d3bbf465a4d90f05a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/637224045b0c96d74da5726abe24fb757589f72cae45067c3fff381c280b7889c1313aec5711469f31ada8f9cd5fb3e158201845b515a6520c10146a196577cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6230ad5ef46c0ae6ef0f73d958d51030caf8fc6a134d2968ae41b38120157f2b3a32d41993972dbda2298f4ea77bb62c6026669b72b043b7ee5e2cd2c16343e"} 18:52:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:52:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:52:47 INFO - Contents: 18:52:47 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75e5c955b849942327df12405e584cc8c130ea3aa9544eb2015575a85ccddf5aa0f26899589080209df06571383a4413e630a7efe10c27238c1748e3e25b3fb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d429996c2d5db372517faef0f0378adb284a7e09f399486d4ad650a538279da801c2569d6252af1a70f393d4280a50a3aac5928340ce598d3bbf465a4d90f05a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/637224045b0c96d74da5726abe24fb757589f72cae45067c3fff381c280b7889c1313aec5711469f31ada8f9cd5fb3e158201845b515a6520c10146a196577cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6230ad5ef46c0ae6ef0f73d958d51030caf8fc6a134d2968ae41b38120157f2b3a32d41993972dbda2298f4ea77bb62c6026669b72b043b7ee5e2cd2c16343e"} 18:52:47 INFO - Running post-run listener: copy_logs_to_upload_dir 18:52:47 INFO - Copying logs to upload dir... 18:52:47 INFO - mkdir: /builds/slave/test/build/upload/logs 18:52:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1318.596536 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2017-05-24 18:52:47.914113) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-24 18:52:47.921332) ========= 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=df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553 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/75e5c955b849942327df12405e584cc8c130ea3aa9544eb2015575a85ccddf5aa0f26899589080209df06571383a4413e630a7efe10c27238c1748e3e25b3fb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d429996c2d5db372517faef0f0378adb284a7e09f399486d4ad650a538279da801c2569d6252af1a70f393d4280a50a3aac5928340ce598d3bbf465a4d90f05a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/637224045b0c96d74da5726abe24fb757589f72cae45067c3fff381c280b7889c1313aec5711469f31ada8f9cd5fb3e158201845b515a6520c10146a196577cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6230ad5ef46c0ae6ef0f73d958d51030caf8fc6a134d2968ae41b38120157f2b3a32d41993972dbda2298f4ea77bb62c6026669b72b043b7ee5e2cd2c16343e"} build_url:https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011389 build_url: 'https://queue.taskcluster.net/v1/task/S9A9DE2BT9iTQraJI7917g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75e5c955b849942327df12405e584cc8c130ea3aa9544eb2015575a85ccddf5aa0f26899589080209df06571383a4413e630a7efe10c27238c1748e3e25b3fb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d429996c2d5db372517faef0f0378adb284a7e09f399486d4ad650a538279da801c2569d6252af1a70f393d4280a50a3aac5928340ce598d3bbf465a4d90f05a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/637224045b0c96d74da5726abe24fb757589f72cae45067c3fff381c280b7889c1313aec5711469f31ada8f9cd5fb3e158201845b515a6520c10146a196577cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6230ad5ef46c0ae6ef0f73d958d51030caf8fc6a134d2968ae41b38120157f2b3a32d41993972dbda2298f4ea77bb62c6026669b72b043b7ee5e2cd2c16343e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-24 18:52:47.948521) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 18:52:47.948904) ========= 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=df17445c3590ff7897617a0e00000225-1495675846.602123-1327407553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 18:52:48.029622) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-24 18:52:48.033091) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-24 18:52:48.033503) ========= ========= Total master_lag: 0.21 =========