builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-031 starttime: 1495060234.5 results: success (0) revision: 2c783a7b6d05b4b2b417bc5f21b7e40cbf3df077 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-17 15:30:34.497754) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-17 15:30:34.498195) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-17 15:30:34.498790) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-17 15:30:34.533240) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 15:30:34.533563) ========= 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=db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-17 15:30:34-- 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% 226M=0s 2017-05-17 15:30:34 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113991 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 15:30:34.659968) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 15:30:34.660249) ========= 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=db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019379 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 15:30:34.719762) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-17 15:30:34.720071) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2c783a7b6d05b4b2b417bc5f21b7e40cbf3df077 --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 2c783a7b6d05b4b2b417bc5f21b7e40cbf3df077 --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=db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-17 15:30:34,883 truncating revision to first 12 chars 2017-05-17 15:30:34,883 Setting DEBUG logging. 2017-05-17 15:30:34,883 attempt 1/10 2017-05-17 15:30:34,884 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2c783a7b6d05?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-17 15:30:35,814 unpacking tar archive at: mozilla-central-2c783a7b6d05/testing/mozharness/ program finished with exit code 0 elapsedTime=1.330062 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-17 15:30:36.068954) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-17 15:30:36.069555) ========= script_repo_revision: 2c783a7b6d05b4b2b417bc5f21b7e40cbf3df077 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-17 15:30:36.070028) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-17 15:30:36.070309) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-17 15:30:36.079975) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-05-17 15:30:36.080372) ========= /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=db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:30:36 INFO - MultiFileLogger online at 20170517 15:30:36 in /builds/slave/test 15:30:36 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 15:30:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:30:36 INFO - {'append_to_log': False, 15:30:36 INFO - 'base_work_dir': '/builds/slave/test', 15:30:36 INFO - 'blob_upload_branch': 'Firefox', 15:30:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:30:36 INFO - 'branch': 'Firefox', 15:30:36 INFO - 'buildbot_json_path': 'buildprops.json', 15:30:36 INFO - 'config_files': ('talos/linux_config.py',), 15:30:36 INFO - 'default_actions': ('clobber', 15:30:36 INFO - 'read-buildbot-config', 15:30:36 INFO - 'download-and-extract', 15:30:36 INFO - 'populate-webroot', 15:30:36 INFO - 'create-virtualenv', 15:30:36 INFO - 'install', 15:30:36 INFO - 'run-tests'), 15:30:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:30:36 INFO - 'download_minidump_stackwalk': True, 15:30:36 INFO - 'download_symbols': 'ondemand', 15:30:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:30:36 INFO - 'tooltool.py': '/tools/tooltool.py', 15:30:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:30:36 INFO - '/tools/misc-python/virtualenv.py')}, 15:30:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:30:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:30:36 INFO - 'gecko_profile': False, 15:30:36 INFO - 'gecko_profile_interval': 0, 15:30:36 INFO - 'installer_path': 'installer.exe', 15:30:36 INFO - 'log_level': 'info', 15:30:36 INFO - 'log_name': 'talos', 15:30:36 INFO - 'log_to_console': True, 15:30:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:30:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:30:36 INFO - 'opt_config_files': (), 15:30:36 INFO - 'pip_index': False, 15:30:36 INFO - 'suite': 'dromaeojs-e10s', 15:30:36 INFO - 'system_bits': '32', 15:30:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:30:36 INFO - 'title': 'talos-linux64-ix-031', 15:30:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:30:36 INFO - 'use_talos_json': True, 15:30:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:30:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:30:36 INFO - 'work_dir': 'build'} 15:30:36 INFO - [mozharness: 2017-05-17 22:30:36.340538Z] Running clobber step. 15:30:36 INFO - Running pre-action listener: _resource_record_pre_action 15:30:36 INFO - Running main action method: clobber 15:30:36 INFO - rmtree: /builds/slave/test/build 15:30:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:30:37 INFO - Running post-action listener: _resource_record_post_action 15:30:37 INFO - [mozharness: 2017-05-17 22:30:37.851049Z] Finished clobber step (success) 15:30:37 INFO - [mozharness: 2017-05-17 22:30:37.851149Z] Running read-buildbot-config step. 15:30:37 INFO - Running pre-action listener: _resource_record_pre_action 15:30:37 INFO - Running main action method: read_buildbot_config 15:30:37 INFO - Using buildbot properties: 15:30:37 INFO - { 15:30:37 INFO - "project": "", 15:30:37 INFO - "product": "firefox", 15:30:37 INFO - "who": "kwierso@gmail.com", 15:30:37 INFO - "installer_path": "public/build/target.tar.bz2", 15:30:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 15:30:37 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 15:30:37 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 15:30:37 INFO - "stage_platform": "linux64-styloseq", 15:30:37 INFO - "basedir": "/builds/slave/test", 15:30:37 INFO - "buildnumber": 8, 15:30:37 INFO - "platform": "ubuntu64_hw_styloseq", 15:30:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:30:37 INFO - "slavebuilddir": "test", 15:30:37 INFO - "taskId": "IktUuX3RRKCr-N4NlXZB8A", 15:30:37 INFO - "branch": "mozilla-central", 15:30:37 INFO - "script_repo_revision": "production", 15:30:37 INFO - "revision": "2c783a7b6d05b4b2b417bc5f21b7e40cbf3df077", 15:30:37 INFO - "slavename": "talos-linux64-ix-031", 15:30:37 INFO - "repo_path": "mozilla-central" 15:30:37 INFO - } 15:30:37 INFO - Finding installer, test and symbols from parent task. 15:30:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IktUuX3RRKCr-N4NlXZB8A'}, attempt #1 15:30:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IktUuX3RRKCr-N4NlXZB8A'}, attempt #1 15:30:38 INFO - Task dependencies: OuvZUrIVSx6b13WMCShlAQ 15:30:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OuvZUrIVSx6b13WMCShlAQ'}, attempt #1 15:30:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/target.tar.bz2 15:30:39 INFO - Set test_url: https://queue.taskcluster.net/v1/task/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/test_packages.json 15:30:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/target.crashreporter-symbols.zip 15:30:39 INFO - Running post-action listener: _resource_record_post_action 15:30:39 INFO - [mozharness: 2017-05-17 22:30:39.238568Z] Finished read-buildbot-config step (success) 15:30:39 INFO - [mozharness: 2017-05-17 22:30:39.238789Z] Running download-and-extract step. 15:30:39 INFO - Running pre-action listener: _resource_record_pre_action 15:30:39 INFO - Running main action method: download_and_extract 15:30:39 INFO - mkdir: /builds/slave/test/build/tests 15:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:39 INFO - trying https://queue.taskcluster.net/v1/task/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/target.test_packages.json 15:30:39 INFO - Downloading https://queue.taskcluster.net/v1/task/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:30:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:30:39 INFO - Downloaded 986 bytes. 15:30:39 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:30:39 INFO - Using the following test package requirements: 15:30:39 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:30:39 INFO - u'common': [u'target.common.tests.zip'], 15:30:39 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:30:39 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:30:39 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:30:39 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:30:39 INFO - u'mozbase': [u'target.common.tests.zip'], 15:30:39 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:30:39 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:30:39 INFO - u'web-platform': [u'target.common.tests.zip', 15:30:39 INFO - u'target.web-platform.tests.zip'], 15:30:39 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:30:39 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:30:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/target.common.tests.zip 15:30:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:30:39 INFO - Fetch https://queue.taskcluster.net/v1/task/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/target.common.tests.zip into memory 15:30:41 INFO - Content-Length response header: 62454787 15:30:41 INFO - Bytes received: 62454787 15:30:51 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:30:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/target.common.tests.zip 15:30:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:30:51 INFO - Fetch https://queue.taskcluster.net/v1/task/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/target.common.tests.zip into memory 15:30:52 INFO - Content-Length response header: 62454787 15:30:52 INFO - Bytes received: 62454787 15:31:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/target.talos.tests.zip 15:31:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:31:04 INFO - Fetch https://queue.taskcluster.net/v1/task/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/target.talos.tests.zip into memory 15:31:05 INFO - Content-Length response header: 14410001 15:31:05 INFO - Bytes received: 14410001 15:31:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:05 INFO - trying https://queue.taskcluster.net/v1/task/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/target.tar.bz2 15:31:05 INFO - Downloading https://queue.taskcluster.net/v1/task/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:31:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:31:07 INFO - Downloaded 65014935 bytes. 15:31:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/target.tar.bz2 15:31:07 INFO - mkdir: /builds/slave/test/properties 15:31:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:31:07 INFO - Writing to file /builds/slave/test/properties/build_url 15:31:07 INFO - Contents: 15:31:07 INFO - build_url:https://queue.taskcluster.net/v1/task/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/target.tar.bz2 15:31:07 INFO - Running post-action listener: _resource_record_post_action 15:31:07 INFO - Running post-action listener: set_extra_try_arguments 15:31:07 INFO - [mozharness: 2017-05-17 22:31:07.008736Z] Finished download-and-extract step (success) 15:31:07 INFO - [mozharness: 2017-05-17 22:31:07.009000Z] Running populate-webroot step. 15:31:07 INFO - Running pre-action listener: _resource_record_pre_action 15:31:07 INFO - Running main action method: populate_webroot 15:31:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:31:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:31:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:31:07 INFO - '--tppagecycles', 15:31:07 INFO - '7'], 15:31:07 INFO - 'tests': ['tsvgm']}}, 15:31:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:31:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:31:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:31:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:31:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:31:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:31:07 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:31:07 INFO - 'talos_options': ['--disable-e10s'], 15:31:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:31:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:31:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:31:07 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:31:07 INFO - 'talos_options': ['--disable-e10s'], 15:31:07 INFO - 'tests': ['damp', 'tps']}, 15:31:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:31:07 INFO - 'tests': ['damp', 'tps']}, 15:31:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:31:07 INFO - 'tests': ['dromaeo_dom']}, 15:31:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:31:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:31:07 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 15:31:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:31:07 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:31:07 INFO - 'tests': ['ts_paint', 'tp5o']}, 15:31:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:31:07 INFO - 'tests': ['a11yr', 15:31:07 INFO - 'ts_paint', 15:31:07 INFO - 'tpaint', 15:31:07 INFO - 'sessionrestore', 15:31:07 INFO - 'sessionrestore_no_auto_restore', 15:31:07 INFO - 'tabpaint']}, 15:31:07 INFO - 'other-e10s': {'tests': ['a11yr', 15:31:07 INFO - 'ts_paint', 15:31:07 INFO - 'tpaint', 15:31:07 INFO - 'sessionrestore', 15:31:07 INFO - 'sessionrestore_no_auto_restore', 15:31:07 INFO - 'tabpaint']}, 15:31:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:31:07 INFO - 'ts_paint', 15:31:07 INFO - 'tpaint', 15:31:07 INFO - 'sessionrestore', 15:31:07 INFO - 'sessionrestore_no_auto_restore', 15:31:07 INFO - 'tabpaint']}, 15:31:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:31:07 INFO - 'ts_paint', 15:31:07 INFO - 'tpaint', 15:31:07 INFO - 'sessionrestore', 15:31:07 INFO - 'sessionrestore_no_auto_restore', 15:31:07 INFO - 'tabpaint']}, 15:31:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:31:07 INFO - 'tests': ['a11yr', 15:31:07 INFO - 'ts_paint', 15:31:07 INFO - 'tpaint', 15:31:07 INFO - 'sessionrestore', 15:31:07 INFO - 'sessionrestore_no_auto_restore', 15:31:07 INFO - 'tabpaint']}, 15:31:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:31:07 INFO - 'tests': ['a11yr', 15:31:07 INFO - 'ts_paint', 15:31:07 INFO - 'tpaint', 15:31:07 INFO - 'sessionrestore', 15:31:07 INFO - 'sessionrestore_no_auto_restore', 15:31:07 INFO - 'tabpaint']}, 15:31:07 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 15:31:07 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 15:31:07 INFO - 'bloom_basic_ref']}, 15:31:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:31:07 INFO - 'tests': ['tsvgx', 15:31:07 INFO - 'tsvgr_opacity', 15:31:07 INFO - 'tart', 15:31:07 INFO - 'tscrollx', 15:31:07 INFO - 'cart', 15:31:07 INFO - 'tsvg_static']}, 15:31:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:31:07 INFO - 'tsvgr_opacity', 15:31:07 INFO - 'tart', 15:31:07 INFO - 'tscrollx', 15:31:07 INFO - 'cart', 15:31:07 INFO - 'tsvg_static']}, 15:31:07 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:31:07 INFO - 'talos_options': ['--disable-e10s'], 15:31:07 INFO - 'tests': ['tp5o']}, 15:31:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:31:07 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:31:07 INFO - 'talos_options': ['--disable-e10s', 15:31:07 INFO - '--xperf_path', 15:31:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:31:07 INFO - 'tests': ['tp5n']}, 15:31:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:31:07 INFO - 'talos_options': ['--xperf_path', 15:31:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:31:07 INFO - 'tests': ['tp5n']}}, 15:31:07 INFO - 'talos.zip': {'path': '', 15:31:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:31:07 INFO - Running post-action listener: _resource_record_post_action 15:31:07 INFO - [mozharness: 2017-05-17 22:31:07.030464Z] Finished populate-webroot step (success) 15:31:07 INFO - [mozharness: 2017-05-17 22:31:07.030553Z] Running create-virtualenv step. 15:31:07 INFO - Running pre-action listener: _resource_record_pre_action 15:31:07 INFO - Running main action method: create_virtualenv 15:31:07 INFO - Creating virtualenv /builds/slave/test/build/venv 15:31:07 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 15:31:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:31:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:31:07 INFO - Using real prefix '/usr' 15:31:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:31:07 INFO - Installing distribute.............................................................................................................................................................................................done. 15:31:09 INFO - Installing pip.................done. 15:31:09 INFO - Return code: 0 15:31:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:31:09 INFO - Reading from file tmpfile_stdout 15:31:09 INFO - Output received: 15:31:09 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) 15:31:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13185c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13157a0>, '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 0x13166a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1316b30>, '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': 'db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963', '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 15:31:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:31:09 INFO - Using env: {'DISPLAY': ':0', 15:31:09 INFO - 'HOME': '/home/cltbld', 15:31:09 INFO - 'LANG': 'en_US.UTF-8', 15:31:09 INFO - 'LANGUAGE': 'en_US:en', 15:31:09 INFO - 'LOGNAME': 'cltbld', 15:31:09 INFO - 'MAIL': '/var/mail/cltbld', 15:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:09 INFO - 'MOZ_NO_REMOTE': '1', 15:31:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:09 INFO - 'NO_EM_RESTART': '1', 15:31:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:09 INFO - 'PWD': '/builds/slave/test', 15:31:09 INFO - 'SHELL': '/bin/bash', 15:31:09 INFO - 'SHLVL': '1', 15:31:09 INFO - 'TERM': 'linux', 15:31:09 INFO - 'TMOUT': '86400', 15:31:09 INFO - 'USER': 'cltbld', 15:31:09 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963', 15:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:09 INFO - '_': '/tools/buildbot/bin/python'} 15:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:10 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 15:31:10 INFO - Cleaning up... 15:31:10 INFO - Return code: 0 15:31:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:31:10 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')]} 15:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:10 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')]} 15:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:10 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 0xfa51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13185c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13157a0>, '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 0x13166a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1316b30>, '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': 'db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963', '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 15:31:10 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 15:31:10 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 15:31:10 INFO - Using env: {'DISPLAY': ':0', 15:31:10 INFO - 'HOME': '/home/cltbld', 15:31:10 INFO - 'LANG': 'en_US.UTF-8', 15:31:10 INFO - 'LANGUAGE': 'en_US:en', 15:31:10 INFO - 'LOGNAME': 'cltbld', 15:31:10 INFO - 'MAIL': '/var/mail/cltbld', 15:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:10 INFO - 'MOZ_NO_REMOTE': '1', 15:31:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:10 INFO - 'NO_EM_RESTART': '1', 15:31:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:10 INFO - 'PWD': '/builds/slave/test', 15:31:10 INFO - 'SHELL': '/bin/bash', 15:31:10 INFO - 'SHLVL': '1', 15:31:10 INFO - 'TERM': 'linux', 15:31:10 INFO - 'TMOUT': '86400', 15:31:10 INFO - 'USER': 'cltbld', 15:31:10 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963', 15:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:10 INFO - '_': '/tools/buildbot/bin/python'} 15:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:10 INFO - Downloading/unpacking psutil>=3.1.1 15:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:31:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:31:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:31:11 INFO - Installing collected packages: psutil 15:31:11 INFO - Running setup.py install for psutil 15:31:11 INFO - building 'psutil._psutil_linux' extension 15:31:11 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 15:31:11 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 15:31:11 INFO - building 'psutil._psutil_posix' extension 15:31:11 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 15:31:11 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 15:31:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:31:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:31:11 INFO - Successfully installed psutil 15:31:11 INFO - Cleaning up... 15:31:12 INFO - Return code: 0 15:31:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:31:12 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')]} 15:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:12 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')]} 15:31:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:12 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 0xfa51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13185c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13157a0>, '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 0x13166a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1316b30>, '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': 'db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963', '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 15:31:12 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 15:31:12 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 15:31:12 INFO - Using env: {'DISPLAY': ':0', 15:31:12 INFO - 'HOME': '/home/cltbld', 15:31:12 INFO - 'LANG': 'en_US.UTF-8', 15:31:12 INFO - 'LANGUAGE': 'en_US:en', 15:31:12 INFO - 'LOGNAME': 'cltbld', 15:31:12 INFO - 'MAIL': '/var/mail/cltbld', 15:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:12 INFO - 'MOZ_NO_REMOTE': '1', 15:31:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:12 INFO - 'NO_EM_RESTART': '1', 15:31:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:12 INFO - 'PWD': '/builds/slave/test', 15:31:12 INFO - 'SHELL': '/bin/bash', 15:31:12 INFO - 'SHLVL': '1', 15:31:12 INFO - 'TERM': 'linux', 15:31:12 INFO - 'TMOUT': '86400', 15:31:12 INFO - 'USER': 'cltbld', 15:31:12 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963', 15:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:12 INFO - '_': '/tools/buildbot/bin/python'} 15:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:31:12 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 15:31:12 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 15:31:12 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 15:31:12 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 15:31:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:31:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:31:13 INFO - Installing collected packages: mozsystemmonitor 15:31:13 INFO - Running setup.py install for mozsystemmonitor 15:31:13 INFO - Successfully installed mozsystemmonitor 15:31:13 INFO - Cleaning up... 15:31:13 INFO - Return code: 0 15:31:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:31:13 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')]} 15:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:13 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')]} 15:31:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:13 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 0xfa51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13185c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13157a0>, '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 0x13166a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1316b30>, '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': 'db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963', '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 15:31:13 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 15:31:13 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 15:31:13 INFO - Using env: {'DISPLAY': ':0', 15:31:13 INFO - 'HOME': '/home/cltbld', 15:31:13 INFO - 'LANG': 'en_US.UTF-8', 15:31:13 INFO - 'LANGUAGE': 'en_US:en', 15:31:13 INFO - 'LOGNAME': 'cltbld', 15:31:13 INFO - 'MAIL': '/var/mail/cltbld', 15:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:13 INFO - 'MOZ_NO_REMOTE': '1', 15:31:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:13 INFO - 'NO_EM_RESTART': '1', 15:31:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:13 INFO - 'PWD': '/builds/slave/test', 15:31:13 INFO - 'SHELL': '/bin/bash', 15:31:13 INFO - 'SHLVL': '1', 15:31:13 INFO - 'TERM': 'linux', 15:31:13 INFO - 'TMOUT': '86400', 15:31:13 INFO - 'USER': 'cltbld', 15:31:13 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963', 15:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:13 INFO - '_': '/tools/buildbot/bin/python'} 15:31:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:13 INFO - Downloading/unpacking jsonschema==2.5.1 15:31:13 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 15:31:13 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 15:31:13 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 15:31:13 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 15:31:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:31:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:31:14 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 15:31:14 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 15:31:14 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 15:31:14 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 15:31:14 INFO - Downloading functools32-3.2.3-2.tar.gz 15:31:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:31:14 INFO - warning: no files found matching '*.txt' 15:31:15 INFO - no previously-included directories found matching 'build' 15:31:15 INFO - no previously-included directories found matching 'dist' 15:31:15 INFO - no previously-included directories found matching '.git*' 15:31:15 INFO - Installing collected packages: jsonschema, functools32 15:31:15 INFO - Running setup.py install for functools32 15:31:15 INFO - warning: no files found matching '*.txt' 15:31:15 INFO - no previously-included directories found matching 'build' 15:31:15 INFO - no previously-included directories found matching 'dist' 15:31:15 INFO - no previously-included directories found matching '.git*' 15:31:15 INFO - Successfully installed jsonschema functools32 15:31:15 INFO - Cleaning up... 15:31:15 INFO - Return code: 0 15:31:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:31:15 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')]} 15:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:15 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')]} 15:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:15 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 0xfa51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13185c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13157a0>, '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 0x13166a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1316b30>, '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': 'db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963', '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 15:31:15 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 15:31:15 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 15:31:15 INFO - Using env: {'DISPLAY': ':0', 15:31:15 INFO - 'HOME': '/home/cltbld', 15:31:15 INFO - 'LANG': 'en_US.UTF-8', 15:31:15 INFO - 'LANGUAGE': 'en_US:en', 15:31:15 INFO - 'LOGNAME': 'cltbld', 15:31:15 INFO - 'MAIL': '/var/mail/cltbld', 15:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:15 INFO - 'MOZ_NO_REMOTE': '1', 15:31:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:15 INFO - 'NO_EM_RESTART': '1', 15:31:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:15 INFO - 'PWD': '/builds/slave/test', 15:31:15 INFO - 'SHELL': '/bin/bash', 15:31:15 INFO - 'SHLVL': '1', 15:31:15 INFO - 'TERM': 'linux', 15:31:15 INFO - 'TMOUT': '86400', 15:31:15 INFO - 'USER': 'cltbld', 15:31:15 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963', 15:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:15 INFO - '_': '/tools/buildbot/bin/python'} 15:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:31:15 INFO - Cleaning up... 15:31:15 INFO - Return code: 0 15:31:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:31:15 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')]} 15:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:15 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')]} 15:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:15 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 0xfa51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13185c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13157a0>, '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 0x13166a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1316b30>, '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': 'db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963', '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 15:31:15 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 15:31:15 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 15:31:15 INFO - Using env: {'DISPLAY': ':0', 15:31:15 INFO - 'HOME': '/home/cltbld', 15:31:15 INFO - 'LANG': 'en_US.UTF-8', 15:31:15 INFO - 'LANGUAGE': 'en_US:en', 15:31:15 INFO - 'LOGNAME': 'cltbld', 15:31:15 INFO - 'MAIL': '/var/mail/cltbld', 15:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:15 INFO - 'MOZ_NO_REMOTE': '1', 15:31:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:15 INFO - 'NO_EM_RESTART': '1', 15:31:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:15 INFO - 'PWD': '/builds/slave/test', 15:31:15 INFO - 'SHELL': '/bin/bash', 15:31:15 INFO - 'SHLVL': '1', 15:31:15 INFO - 'TERM': 'linux', 15:31:15 INFO - 'TMOUT': '86400', 15:31:15 INFO - 'USER': 'cltbld', 15:31:15 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963', 15:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:15 INFO - '_': '/tools/buildbot/bin/python'} 15:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:15 INFO - Downloading/unpacking blobuploader==1.2.4 15:31:15 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 15:31:15 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 15:31:15 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 15:31:15 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 15:31:16 INFO - Downloading blobuploader-1.2.4.tar.gz 15:31:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:31:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:31:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:31:17 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 15:31:17 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 15:31:17 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 15:31:17 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 15:31:17 INFO - Downloading docopt-0.6.1.tar.gz 15:31:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:31:17 INFO - Installing collected packages: blobuploader, requests, docopt 15:31:17 INFO - Running setup.py install for blobuploader 15:31:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:31:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:31:17 INFO - Running setup.py install for requests 15:31:17 INFO - Running setup.py install for docopt 15:31:17 INFO - Successfully installed blobuploader requests docopt 15:31:17 INFO - Cleaning up... 15:31:17 INFO - Return code: 0 15:31:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:17 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 0xfa51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13185c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13157a0>, '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 0x13166a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1316b30>, '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': 'db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963', '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 15:31:17 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 15:31:17 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 15:31:17 INFO - Using env: {'DISPLAY': ':0', 15:31:17 INFO - 'HOME': '/home/cltbld', 15:31:17 INFO - 'LANG': 'en_US.UTF-8', 15:31:17 INFO - 'LANGUAGE': 'en_US:en', 15:31:17 INFO - 'LOGNAME': 'cltbld', 15:31:17 INFO - 'MAIL': '/var/mail/cltbld', 15:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:17 INFO - 'MOZ_NO_REMOTE': '1', 15:31:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:17 INFO - 'NO_EM_RESTART': '1', 15:31:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:17 INFO - 'PWD': '/builds/slave/test', 15:31:17 INFO - 'SHELL': '/bin/bash', 15:31:17 INFO - 'SHLVL': '1', 15:31:17 INFO - 'TERM': 'linux', 15:31:17 INFO - 'TMOUT': '86400', 15:31:17 INFO - 'USER': 'cltbld', 15:31:17 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963', 15:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:17 INFO - '_': '/tools/buildbot/bin/python'} 15:31:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:31:18 INFO - Running setup.py (path:/tmp/pip-mmunaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:31:18 INFO - Running setup.py (path:/tmp/pip-WxP4Jz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:31:18 INFO - Running setup.py (path:/tmp/pip-PQPg0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:31:18 INFO - Running setup.py (path:/tmp/pip-IthiNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:31:18 INFO - Running setup.py (path:/tmp/pip-WZeBEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:31:18 INFO - Running setup.py (path:/tmp/pip-WABDuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:31:18 INFO - Running setup.py (path:/tmp/pip-mnlSCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:31:18 INFO - Running setup.py (path:/tmp/pip-iQ29Xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:31:18 INFO - Running setup.py (path:/tmp/pip-vlXmk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:31:18 INFO - Running setup.py (path:/tmp/pip-u0amUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:31:18 INFO - Running setup.py (path:/tmp/pip-XmSx5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:31:18 INFO - Running setup.py (path:/tmp/pip-1pXY1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:31:18 INFO - Running setup.py (path:/tmp/pip-JNCRTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:31:19 INFO - Running setup.py (path:/tmp/pip-ySPsPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:19 INFO - Running setup.py (path:/tmp/pip-yNIZ6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:31:19 INFO - Running setup.py (path:/tmp/pip-blaDQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:31:19 INFO - Running setup.py (path:/tmp/pip-CtA5x2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:31:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:31:19 INFO - Running setup.py install for manifestparser 15:31:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:31:19 INFO - Running setup.py install for mozcrash 15:31:19 INFO - Running setup.py install for mozdebug 15:31:19 INFO - Running setup.py install for mozdevice 15:31:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:31:19 INFO - Running setup.py install for mozfile 15:31:19 INFO - Running setup.py install for mozhttpd 15:31:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:31:19 INFO - Running setup.py install for mozinfo 15:31:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:31:20 INFO - Running setup.py install for mozInstall 15:31:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:31:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:31:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:31:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:31:20 INFO - Running setup.py install for mozleak 15:31:20 INFO - Running setup.py install for mozlog 15:31:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:31:20 INFO - Running setup.py install for moznetwork 15:31:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:31:20 INFO - Running setup.py install for mozprocess 15:31:20 INFO - Running setup.py install for mozprofile 15:31:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:31:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:31:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:31:20 INFO - Running setup.py install for mozrunner 15:31:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:31:20 INFO - Running setup.py install for mozscreenshot 15:31:20 INFO - Running setup.py install for moztest 15:31:21 INFO - Running setup.py install for mozversion 15:31:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:31:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:31:21 INFO - Cleaning up... 15:31:21 INFO - Return code: 0 15:31:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:21 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')]} 15:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:21 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')]} 15:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:21 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 0xfa51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13185c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13157a0>, '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 0x13166a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1316b30>, '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': 'db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963', '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 15:31:21 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 15:31:21 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 15:31:21 INFO - Using env: {'DISPLAY': ':0', 15:31:21 INFO - 'HOME': '/home/cltbld', 15:31:21 INFO - 'LANG': 'en_US.UTF-8', 15:31:21 INFO - 'LANGUAGE': 'en_US:en', 15:31:21 INFO - 'LOGNAME': 'cltbld', 15:31:21 INFO - 'MAIL': '/var/mail/cltbld', 15:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:21 INFO - 'MOZ_NO_REMOTE': '1', 15:31:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:21 INFO - 'NO_EM_RESTART': '1', 15:31:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:21 INFO - 'PWD': '/builds/slave/test', 15:31:21 INFO - 'SHELL': '/bin/bash', 15:31:21 INFO - 'SHLVL': '1', 15:31:21 INFO - 'TERM': 'linux', 15:31:21 INFO - 'TMOUT': '86400', 15:31:21 INFO - 'USER': 'cltbld', 15:31:21 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963', 15:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:21 INFO - '_': '/tools/buildbot/bin/python'} 15:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:31:21 INFO - Running setup.py (path:/tmp/pip-ra_a7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:31:21 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)) 15:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:31:21 INFO - Running setup.py (path:/tmp/pip-MSbMOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:31:21 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)) 15:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:31:21 INFO - Running setup.py (path:/tmp/pip-tgPtPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:31:21 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)) 15:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:31:21 INFO - Running setup.py (path:/tmp/pip-IPwxYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:31:21 INFO - Running setup.py (path:/tmp/pip-j50d2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:31:21 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)) 15:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:31:21 INFO - Running setup.py (path:/tmp/pip-4QgISh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:31:21 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)) 15:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:31:21 INFO - Running setup.py (path:/tmp/pip-s74OVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:31:21 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)) 15:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:31:21 INFO - Running setup.py (path:/tmp/pip-3D3Mod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:31:21 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)) 15:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:31:21 INFO - Running setup.py (path:/tmp/pip-BaQ7Gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:31:21 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)) 15:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:31:21 INFO - Running setup.py (path:/tmp/pip-OdvU04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:31:22 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)) 15:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:31:22 INFO - Running setup.py (path:/tmp/pip-05Q5HO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:31:22 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)) 15:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:31:22 INFO - Running setup.py (path:/tmp/pip-wd6iGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:31:22 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)) 15:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:31:22 INFO - Running setup.py (path:/tmp/pip-5krML_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:31:22 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)) 15:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:31:22 INFO - Running setup.py (path:/tmp/pip-EmCLpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:31:22 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)) 15:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:22 INFO - Running setup.py (path:/tmp/pip-UKSA_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:22 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)) 15:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:31:22 INFO - Running setup.py (path:/tmp/pip-y6cjuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:31:22 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)) 15:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:31:22 INFO - Running setup.py (path:/tmp/pip-KWojQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:31:22 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)) 15:31:22 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)) 15:31:22 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)) 15:31:22 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)) 15:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:31:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:31:22 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 15:31:22 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 15:31:22 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 15:31:22 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 15:31:23 INFO - Downloading blessings-1.6.tar.gz 15:31:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:31:23 INFO - Installing collected packages: blessings 15:31:23 INFO - Running setup.py install for blessings 15:31:23 INFO - Successfully installed blessings 15:31:23 INFO - Cleaning up... 15:31:23 INFO - Return code: 0 15:31:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:31:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:31:24 INFO - Reading from file tmpfile_stdout 15:31:24 INFO - Current package versions: 15:31:24 INFO - argparse == 1.2.1 15:31:24 INFO - blessings == 1.6 15:31:24 INFO - blobuploader == 1.2.4 15:31:24 INFO - docopt == 0.6.1 15:31:24 INFO - functools32 == 3.2.3-2 15:31:24 INFO - jsonschema == 2.5.1 15:31:24 INFO - manifestparser == 1.1 15:31:24 INFO - mozInstall == 1.12 15:31:24 INFO - mozcrash == 1.0 15:31:24 INFO - mozdebug == 0.1 15:31:24 INFO - mozdevice == 0.50 15:31:24 INFO - mozfile == 1.2 15:31:24 INFO - mozhttpd == 0.7 15:31:24 INFO - mozinfo == 0.9 15:31:24 INFO - mozleak == 0.1 15:31:24 INFO - mozlog == 3.4 15:31:24 INFO - moznetwork == 0.27 15:31:24 INFO - mozprocess == 0.25 15:31:24 INFO - mozprofile == 0.28 15:31:24 INFO - mozrunner == 6.13 15:31:24 INFO - mozscreenshot == 0.1 15:31:24 INFO - mozsystemmonitor == 0.3 15:31:24 INFO - moztest == 0.8 15:31:24 INFO - mozversion == 1.4 15:31:24 INFO - psutil == 3.1.1 15:31:24 INFO - requests == 1.2.3 15:31:24 INFO - wsgiref == 0.1.2 15:31:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15: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')]} 15:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15: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')]} 15:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:24 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 0xfa51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13185c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13157a0>, '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 0x13166a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1316b30>, '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': 'db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963', '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 15:31:24 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 15:31:24 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 15:31:24 INFO - Using env: {'DISPLAY': ':0', 15:31:24 INFO - 'HOME': '/home/cltbld', 15:31:24 INFO - 'LANG': 'en_US.UTF-8', 15:31:24 INFO - 'LANGUAGE': 'en_US:en', 15:31:24 INFO - 'LOGNAME': 'cltbld', 15:31:24 INFO - 'MAIL': '/var/mail/cltbld', 15:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:24 INFO - 'MOZ_NO_REMOTE': '1', 15:31:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:24 INFO - 'NO_EM_RESTART': '1', 15:31:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:24 INFO - 'PWD': '/builds/slave/test', 15:31:24 INFO - 'SHELL': '/bin/bash', 15:31:24 INFO - 'SHLVL': '1', 15:31:24 INFO - 'TERM': 'linux', 15:31:24 INFO - 'TMOUT': '86400', 15:31:24 INFO - 'USER': 'cltbld', 15:31:24 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963', 15:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:24 INFO - '_': '/tools/buildbot/bin/python'} 15:31:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:24 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)) 15:31:24 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)) 15:31:24 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)) 15:31:24 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)) 15:31:24 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)) 15:31:24 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)) 15:31:24 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)) 15:31:24 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)) 15:31:24 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)) 15:31:24 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)) 15:31:24 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)) 15:31:24 INFO - Cleaning up... 15:31:24 INFO - Return code: 0 15:31:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15: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')]} 15:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15: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')]} 15:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13185c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13157a0>, '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 0x13166a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1316b30>, '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': 'db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963', '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 15: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', 'jsonschema'] in /builds/slave/test/build 15: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 jsonschema 15:31:24 INFO - Using env: {'DISPLAY': ':0', 15:31:24 INFO - 'HOME': '/home/cltbld', 15:31:24 INFO - 'LANG': 'en_US.UTF-8', 15:31:24 INFO - 'LANGUAGE': 'en_US:en', 15:31:24 INFO - 'LOGNAME': 'cltbld', 15:31:24 INFO - 'MAIL': '/var/mail/cltbld', 15:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:24 INFO - 'MOZ_NO_REMOTE': '1', 15:31:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:24 INFO - 'NO_EM_RESTART': '1', 15:31:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:24 INFO - 'PWD': '/builds/slave/test', 15:31:24 INFO - 'SHELL': '/bin/bash', 15:31:24 INFO - 'SHLVL': '1', 15:31:24 INFO - 'TERM': 'linux', 15:31:24 INFO - 'TMOUT': '86400', 15:31:24 INFO - 'USER': 'cltbld', 15:31:24 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963', 15:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:24 INFO - '_': '/tools/buildbot/bin/python'} 15:31:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:31:24 INFO - Cleaning up... 15:31:24 INFO - Return code: 0 15:31:24 INFO - Running post-action listener: _resource_record_post_action 15:31:24 INFO - Running post-action listener: _start_resource_monitoring 15:31:24 INFO - Starting resource monitoring. 15:31:24 INFO - [mozharness: 2017-05-17 22:31:24.581490Z] Finished create-virtualenv step (success) 15:31:24 INFO - [mozharness: 2017-05-17 22:31:24.581988Z] Running install step. 15:31:24 INFO - Running pre-action listener: _resource_record_pre_action 15:31:24 INFO - Running main action method: install 15:31:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:31:24 INFO - Reading from file tmpfile_stdout 15:31:24 INFO - Detecting whether we're running mozinstall >=1.0... 15:31:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:31:24 INFO - Reading from file tmpfile_stdout 15:31:24 INFO - Output received: 15:31:24 INFO - Usage: mozinstall [options] installer 15:31:24 INFO - Options: 15:31:24 INFO - -h, --help show this help message and exit 15:31:24 INFO - -d DEST, --destination=DEST 15:31:24 INFO - Directory to install application into. [default: 15:31:24 INFO - "/builds/slave/test"] 15:31:24 INFO - --app=APP Application being installed. [default: firefox] 15:31:24 INFO - mkdir: /builds/slave/test/build/application 15:31:24 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'] 15:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:31:41 INFO - Reading from file tmpfile_stdout 15:31:41 INFO - Output received: 15:31:41 INFO - /builds/slave/test/build/application/firefox/firefox 15:31:41 INFO - Running post-action listener: _resource_record_post_action 15:31:41 INFO - [mozharness: 2017-05-17 22:31:41.351042Z] Finished install step (success) 15:31:41 INFO - [mozharness: 2017-05-17 22:31:41.351323Z] Running run-tests step. 15:31:41 INFO - Running pre-action listener: _resource_record_pre_action 15:31:41 INFO - Running main action method: run_tests 15:31:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:31:41 INFO - Python 2.7.3 15:31:41 INFO - Return code: 0 15:31:41 INFO - grabbing minidump binary from tooltool 15:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:41 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 0x13157a0>, '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 0x13166a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1316b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:31:41 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 15:31:41 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 15:31:41 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 15:31:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:31:41 INFO - Return code: 0 15:31:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:31:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:31:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:31:41 INFO - ENV: RUST_BACKTRACE is now 1 15:31:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:31:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:31:41 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/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 15:31:41 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/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 15:31:41 INFO - Using env: {'DISPLAY': ':0', 15:31:41 INFO - 'HOME': '/home/cltbld', 15:31:41 INFO - 'LANG': 'en_US.UTF-8', 15:31:41 INFO - 'LANGUAGE': 'en_US:en', 15:31:41 INFO - 'LOGNAME': 'cltbld', 15:31:41 INFO - 'MAIL': '/var/mail/cltbld', 15:31:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:31:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:41 INFO - 'MOZ_NO_REMOTE': '1', 15:31:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:41 INFO - 'NO_EM_RESTART': '1', 15:31:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:41 INFO - 'PWD': '/builds/slave/test', 15:31:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:31:41 INFO - 'RUST_BACKTRACE': '1', 15:31:41 INFO - 'SHELL': '/bin/bash', 15:31:41 INFO - 'SHLVL': '1', 15:31:41 INFO - 'TERM': 'linux', 15:31:41 INFO - 'TMOUT': '86400', 15:31:41 INFO - 'USER': 'cltbld', 15:31:41 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963', 15:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:41 INFO - '_': '/tools/buildbot/bin/python'} 15:31:41 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/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 15:31:41 INFO - mozversion application_buildid: 20170517215552 15:31:41 INFO - mozversion application_changeset: 2c783a7b6d05b4b2b417bc5f21b7e40cbf3df077 15:31:41 INFO - mozversion application_display_name: Nightly 15:31:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:31:41 INFO - mozversion application_name: Firefox 15:31:41 INFO - mozversion application_remotingname: firefox 15:31:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:31:41 INFO - mozversion application_vendor: Mozilla 15:31:41 INFO - mozversion application_version: 55.0a1 15:31:41 INFO - mozversion platform_buildid: 20170517215552 15:31:41 INFO - mozversion platform_changeset: 2c783a7b6d05b4b2b417bc5f21b7e40cbf3df077 15:31:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:31:41 INFO - mozversion platform_version: 55.0a1 15:31:41 INFO - using testdate: 1495060301 15:31:41 INFO - actual date: 1495060301 15:31:41 INFO - starting webserver on 'localhost:42451' 15:31:41 INFO - SUITE-START | Running 2 tests 15:31:41 INFO - TEST-START | dromaeo_css 15:31:41 INFO - operating with platform_type : linux_ 15:31:41 INFO - Initialising browser for dromaeo_css test... 15:31:41 INFO - TEST-INFO | started process 14032 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCr64yc/profile http://localhost:42451/getInfo.html) 15:31:42 INFO - PID 14032 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2939: String.localeCompare is deprecated; use String.prototype.localeCompare instead 15:31:45 INFO - PID 14032 | __metrics Screen width/height:1600/1200 15:31:45 INFO - PID 14032 | colorDepth:24 15:31:45 INFO - PID 14032 | Browser inner width/height: 1024/695 15:31:45 INFO - PID 14032 | __metrics 15:31:47 INFO - TEST-INFO | 14032: exit 0 15:31:47 INFO - Browser initialized. 15:31:47 INFO - Running cycle 1/1 for dromaeo_css test... 15:31:47 INFO - TEST-INFO | started process 14220 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCr64yc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:31:58 INFO - PID 14220 | RSS: Main: 166019072 15:31:58 INFO - PID 14220 | 15:35:04 INFO - PID 14220 | Cycle 1(1): loaded http://localhost:42451/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42451/tests/dromaeo/cssquery-ext.html) 15:35:05 INFO - PID 14220 | RSS: Main: 171642880 15:35:05 INFO - PID 14220 | 15:38:07 INFO - PID 14220 | Cycle 1(1): loaded http://localhost:42451/tests/dromaeo/cssquery-ext.html (next: http://localhost:42451/tests/dromaeo/cssquery-jquery.html) 15:38:07 INFO - PID 14220 | RSS: Main: 171716608 15:38:07 INFO - PID 14220 | 15:41:09 INFO - PID 14220 | Cycle 1(1): loaded http://localhost:42451/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42451/tests/dromaeo/cssquery-mootools.html) 15:41:10 INFO - PID 14220 | RSS: Main: 173735936 15:41:10 INFO - PID 14220 | 15:44:12 INFO - PID 14220 | Cycle 1(1): loaded http://localhost:42451/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42451/tests/dromaeo/cssquery-prototype.html) 15:44:12 INFO - PID 14220 | RSS: Main: 171376640 15:44:12 INFO - PID 14220 | 15:47:15 INFO - PID 14220 | Cycle 1(1): loaded http://localhost:42451/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42451/tests/dromaeo/cssquery-yui.html) 15:47:16 INFO - PID 14220 | RSS: Main: 171114496 15:47:16 INFO - PID 14220 | 15:50:18 INFO - PID 14220 | Cycle 1(1): loaded http://localhost:42451/tests/dromaeo/cssquery-yui.html (next: http://localhost:42451/tests/dromaeo/cssquery-dojo.html) 15:50:18 INFO - PID 14220 | RSS: Main: 178274304 15:50:18 INFO - PID 14220 | 15:50:18 INFO - PID 14220 | __start_tp_report 15:50:18 INFO - PID 14220 | _x_x_mozilla_page_load 15:50:18 INFO - PID 14220 | _x_x_mozilla_page_load_details 15:50:18 INFO - PID 14220 | |i|pagename|runs| 15:50:18 INFO - PID 14220 | |0;dojo.html;2680.7534496459148;2718.225305787851;2731.508328500869;2743.8628068596577;2758.8344699318036;5159;5266.55234305084;5269.578433725303;5290.497402746742;5325.973370133153;5209.453007434222;5224.582033437326;5275.894482110355;5376.220448035033;5390.865228369293;4408.97795511022;4624.745638989854;4714.292856071583;4733.92899106512;4743.075100355432;4736;4771.33201351811;4785.928211076819;4805.063012712522;4849.878753031167;4607.562281583244;4659.161350956826;4688.249880019181;4718.433787945469;4763.476017638057;4713.457952335457;4729.101470720587;4731.361266229083;4745.430548334188;4777.570018698334;4652.976735116303;4689.62483001359;4695.788689508946;4707.411573553306;4724.480307166209;5091.1854103343285;5172.663776854492;5242.292290540767;5246.580273578104;5250.422453530108;5664.915026274568;5696.145578163268;5700.7719691212305;5737.168110623936;5779.017567013618;5713.4000929902595;5730.856728581777;5753.194552762617;5761;5770.134479828017;5184.714840683799;5256.78972841082;5290.365156181283;5303.7878484860175;5322.707251101149;5828.795992140254;5838.7080645967535;5902.6458412495385;5915.911261331084;5923.289205295392;5564.888702226014;5564.972175139098;5565.443455654483;5573.526250268692;5575.4424557543925;5529.834104976857;5580.553555715533;5659.717014149359;5669.262995810518;5742.684152371576;5703.885922281531;5704.657720536781;5706.629069110494;5722.2561067061015;5758.654480731086;5667.688277144714;5670;5680.914786278209;5681.261436013292;5696.3733989261145;4622.514635963243;4696.295555666609;4705.7647117644665;4758.1435341638835;4815.2054910939305;4114.732542384735;4115.259253334429;4136.73111247768;4200.096979149497;4213.157368526246;4792.472827988919;4799.400074990626;4812.51874812516;4843.588294994895;4861.9027619447415;5523.889522209533;5627.352854421712;5677.602567820296;5711.514521265739;5722.7424765885635;4689.648276379286;4754.286856971482;4827.565519103297;4834.685745426606;4840.201366774513;5060.746962651852;5062.848114556569;5066.214736715815;5113.590912726973;5120.92318615221;5331.866703332447;5333.359996800486;5343.3587969443915;5345.1714984177515;5363.410024897336;5438.23864658956;5512.6968016757855;5609.467100625434;5739.426057394227;5746.080627099644;5243.659162154448;5302.496262855023;5309.681419114865;5342.9198562022375;5350.357957045024;5569.248151499496;5591.273134492652;5601.355844077983;5605.80379686709;5612.158176273591;5512.200730894078;5703.173039909107;5703.520593277833;5740.885182296414;5764.798232061858;5393.460653934575;5452.045891968969;5530.917036244379;5543.528800051879;5551.25058117149;5364.14173732201;5439.048166570913;5496.120620700669;5535.225068490334;5557.888842223214;5437.728113594226;5444.564434845282;5458.372287187024;5464.508194262536;5496.917546236729;5442.482964118402;5579.051561234519;5585.916211256753;5586.916196256978;5588.441155884379;5277.894442111213;5283;5289.100852855101;5328.866778330573;5350.197470379474 15:50:18 INFO - PID 14220 | |1;ext.html;700.2927043685879;742.9182789893113;762.4205603741156;1084.5444913136482;1096.5723367886521;32682.346353072924;33610.83194584023;33613.831930840344;33766.15584610386;33779.32441351171;35169.64830351696;35351.2929741405;35496.46755298672;35564.82217588909;35583.4662480063;6878.518503704755;6932.792016239496;7016.754413595525;7019.403350715195;7148.320909513588;7082.681279342442;7151.89272160918;7163.2836716328475;7176.318249766264;7210.197450637341;7122.109736282965;7149.89275160873;7218.097737782778;7220.350168484835;7245.166805817345;7140.214576396592;7160.606166660831;7181.928180718178;7184.1019872515935;7203.351698347174;7041.683124259421;7051.753188638373;7088.787336379917;7090.822729431754;7104.396126329269;32852.6714732852;32961.34077318464;33033;33076.83461582701;33113.50329745056;3004.72957433832;3059.5257735051105;3078.9692103078905;3084.6144231971;3086.675899030592;24933.5013299733;25061.62407563888;25117.24648260555;25214.495710085695;25251.368715782068;3080.8459577021285;3104.5032794752956;3106.6582675905634;3111.1288839124854;3116.3923035008183;131597.34201329027;132101;144547;144617.27691361477;144701.99999999895;39516.80241598774;39667.82657387402;39702.20595588072;39704.60295397009;39723.80138099291;40731.38902916399;40911.38632920509;40914.795426022676;40991;41075.1784964299;10271.126954208976;10302;10307.896921030844;10337.741556460998;10409.895901041044;7907.683692652229;7911.841763164704;7912.129665736765;7933.761987140395;8017.278444939867;12488.687782805502;12677.936610317074;12702.618921432371;12723.109382343147;12784.74430511403;5479.671219726829;5572.916406253909;5574.637648552831;5597.188407680864;5600.551955843523;869.1178453869328;892.906244844282;900.9683911920814;907.5235501361706;930.3441074042919;21011.684824727643;21475.892620536797;21565;21663.891680541496;25349.36626584313;949.7910459698855;978.9755256118654;979.4123525884412;980.2060331131806;980.8675828763169;11254.437278136224;11693.532258709556;11794.174407791372;11827.40862956866;11832.17174797773;173795;174354;174995;175142;175718;41163.58836411657;41608.791956040026;41659.7917010413;41699.58300417018;41716.37425438621;1176.3965473003532;1205.2105870654734;1214.186495048302;1217.5251651855783;1246.8316777234957;19997.500062498555;20665.483362916046;21097.367078987656;21257.468563286042;21355.346822251773;30463.543046853873;30476.238094047825;30484.390312194075;30525;30693;155110;155278;155477;155603;155962;28164.577531336636;30440.543391849584;30874.375678066717;30940.69059309378;31143.37713245677;35710.46434303436;37059.6294037067;37120.443193352665;37125;37215;27249.31876703098;27459.725402745717;27992.58011129794;28744;29191.7080829189;27897.860510697315;28281.717182828732;28471;29586.704132959258;29677.851610742673;31018.379632407676;31185.53221701631;31379.686203137677;31755.364892702477;31952.36095278035;26804;27052;27372.452550949267;27535.31161720973;28557.143285701462;20677.27629532959;22922.54154916926;22949.88525057364;22984.4253893654;23184.652230216896 15:50:18 INFO - PID 14220 | |2;jquery.html;423.51296009588987;426.8128533320282;429.6090557592589;436.1408026188408;443.9422875026246;17256.13719314034;17599;17816.376426825063;17988.28046878125;18020.279188832465;14520.3465844037;14931.104133751982;15038;15282.109724888012;15911.44309949152;5441.374241962166;5454.99999999999;5522;5617.522510586605;5645.604807663465;5484.533814625762;5558.805441809537;5562.0266453370705;5569.248151499556;5573.27547418837;5334.493223143795;5445.646033007842;5492.121260598305;5511.476409741068;5549.722513874311;5457.5633949283965;5552.250446189773;5574.358948720868;5585.078462053756;5591.1054231323;4997.175466048134;5037.168867136918;5042.84871453857;5059.949400505985;5084.3644544431945;21980.78019219803;22089.447763805874;22261.332160035225;22291.21980730683;22479.32562023142;1669.4490818030142;1692.2892385198247;1692.7037768390483;1693.2803558487717;1694.051331254489;14176.858231417656;14673.779893301502;14849.406023759037;14869.479568215169;14950.40198392063;2085.374387683704;2093.602215579035;2138.764735879052;2160.8487405881597;2169.316665250441;75916.30627702945;76684.61657691676;76707.99999999945;77449;79197;11038.944805275922;11211.831822522669;11328.71678208035;11391.601293954838;11567.248128871597;15581.454649087455;15763.842361576466;15805.683886322438;15806.60483487899;15824.75592503534;6628.105205797252;6724.193096828412;6850.6574671266235;6962;6972.930270697329;5904.940950590525;5913.349531551526;6055.666938318434;6062.393760623991;6063.757449701962;6882.621455819978;6959.329760857459;6970.455783638935;7056.54132481387;7152.606606636581;2062.711220429141;2095.308548179097;2095.8847263400353;2099.6745504446835;2116.8835714035567;860.0968982568278;888.6756333938196;897.5915958238986;911.8541033434618;936.4287784451479;17303.56741081458;17832.55418614545;17917.462476125736;18091.54771130732;18354.449366519028;889.5285498685707;897.4570384917162;898.8606765951288;906.9138431848963;926.9443833370019;9434.292428067922;9494.192993595483;9896.25778066648;10007.49962501872;10037.799244015225;337794;342808;381646;385791;388610;73190;77443.61278193574;77868;79437.60281198558;79501.60249198832;1084.1543595995136;1095.3099547285;1128.5598616539555;1136.023020202625;1142.4744617476053;17159.914200428917;17618.82381176172;17935;18542.907285463487;18805.717914231573;37191.62808371882;37641.247175056895;38247.80876095602;38416.6158338413;38457.807710961264;46978.76510617425;47065.764671176425;47138.76430617825;47168.764156179;48533;8545.2309292164;8650.1349865013;8659.307255419426;8726.345524085846;9038.276937845088;13091.607251782461;13198.868011320148;13369.66575835612;13521.391537380645;13548.79676804829;11001.22991390595;11056.834147487954;11244.437778111225;11305.378204198849;11567.710807229887;10159.136473399843;10365.70428696413;10452.895471045193;10513.264071515227;10631.893681063091;11296.717582060513;11298.830517542408;11413.942930285628;11663.5917742882;11820.940895295469;8168.305694016075;8214.34285257166;8280.385324861594;8428.957855210685;8666.566671666265;10553.186407448113;10573.207009474474;10961.945190273998;11078.944605276922;11242.943785281348 15:50:18 INFO - PID 14220 | |3;mootools.html;1235.5057976809276;1272.0396100943785;1284.8650891656375;1286.659035355631;1296.6758310422401;10021.298509104365;10522.842157367637;10530.104941080017;10600.893991060088;10978.12175025998;10600.257981941268;10769.084627806646;10788.406637634947;10793.02862742353;10827.187960902924;2227.7326720793485;2259.8644081355087;2265.3543740034092;2270.693456383392;2272.0343853862123;2270.3642979965634;2308.9653655195184;2311.711036120485;2313.35226136682;2319.072371051576;2227.3652009177385;2229.3869185973826;2263.841531092824;2272.9659055114103;2278.567072256266;2198.3075331270597;2209.5028618560855;2253.549290141978;2264.365977526287;2269.682244485765;1807.7649905512199;1881.8494520438333;2144.7104640873595;2153.0634174134143;2203.327984964585;10346.586136554528;10437.060664540151;10444.26890117692;10457.947710261476;10460.68617941463;5271.525562699337;5414.756335964891;5449.155380915964;5462.508374246337;5477.972610136963;3306.68586484286;3434.1586311353876;3503.3343664703625;3519.1905861651708;3575.3564358415474;1096.6052221200362;1117.9049780768644;1130.9151813614012;1167.5796713183247;1181.3974872814927;15136.697266054727;15138.621534461616;15258.38966441341;15267.923660381739;15294.082355058732;4651.418572678415;4848.781804818792;4996.225585034253;4999.150144475448;5042.848714538496;10839.403832789114;10917;10977.176711746652;10984.945075274572;11004.834927476095;5376.247325374451;5381.13901775714;5382.2464854920345;5388.892222155535;5393.298871146726;4515.412996310524;4651.883702907387;4655.813767449264;4767;4845.515448455197;3834.539855217392;3882.5052354843588;3906.140649057203;3925.3905898581443;3994.9201015980098;1127.503898284752;1128.8306753986803;1143.4511434511314;1150.3902931446346;1166.2535976974743;676.8544762876005;699.4124935054579;706.0679902528613;715.8926161075776;723.6598798564667;5175.45657705943;5231.084560202025;5306.708131052829;5376;5460.781568737286;536.4581772409816;543.413113837055;836.7071524966335;862.8188080503164;864.6238886084448;3489.0928358626434;3593.1735700788963;3636.090977255686;3640.4539319102346;3721.2557488501866;13101;13185.208887466782;13479.258640774655;13596.93201533986;13710.24593647339;12997.285149316878;13333.200007999358;13408.530701425403;13548.390322435514;13583;7610.657520411595;7698.884516732253;7780.8832867507035;7783.299503044753;7813.609319534115;6353.3011368748475;6401.775937842153;6504.707288172138;6515.934840651723;6588.5058620604605;11857.466414011218;12344.135910486539;12372.505099795908;12395.876041239833;12428.694987026232;12231.388430578258;12266.202696824677;12325.69185770327;12445.439955202219;12611.684707882376;8443.704470343508;8457.703980360659;8488;8532.70135545253;8550.74347769568;9510.809783804423;9809.705708828747;9815.558299876666;9832.803343933225;9836.409815411098;8099.392545558989;8178.550179740171;8280.378971577034;8285.58572071382;8699.04310525829;7992.880106798287;8127.024757029194;8132.227438393344;8205.95897020511;8251.463654862415;7564.810879727831;7711.151773305044;7725.266099720742;7727.92272077272;7740.612969351622;5160.638755287094;5306.761195746123;5357;5420.674759514442;5651.519620832275;5308.708021058879;5327.733613319241;5367.624266301322;5399.271098401822;5523.558115350682 15:50:18 INFO - PID 14220 | |4;prototype.html;368.32228699193496;389.32257871303926;395.2450818935833;398.364608449523;400.67945643485206;5372.462753724635;5580.525655319298;5587.441255874411;5587.972060139698;5601.523870471005;5337.5196232339085;5396.838094857151;5402.162664786954;5408.215808707735;5438.755256013479;4102.528209255944;4111.547729749733;4118.546959834416;4124.092699606082;4126.8968275793195;3983.2630963271745;4098.7540747555095;4117.485314335708;4125.463689720332;4136.81384337704;4079.2657321682086;4083.1629515949307;4085.12169883475;4087.6934229932726;4103.138340948404;4090.9181816363653;4095.7337773044655;4097.754134751909;4105.85629502966;4117.5882411758585;3597.0647631615966;3598.4062629666073;3603.2433189030335;3603.8918832434806;3608.566971963355;5208.880090780501;5287.550558202557;5308;5317.404778566453;5320.414754377015;4791.520847915215;4798.880027999328;4798.904021919577;4807.855764327076;4808.278758186265;5521.613487055908;5720.799772007959;5723.255976723041;5733.426657334275;5739.885202295931;3970.8411663533425;3977;3996.680265578776;4004.2592120457807;4012.8394864205397;5880.5883588148845;6065.4844338231305;6071.878562428727;6105.32841387447;6124.35694252106;4076.9399956011653;4077.8776636700945;4085.611866872642;4090.386442033659;4100.446439730598;4125.092479654471;4140.130572579792;4152.709310348307;4157.771322577227;4170.895727606773;4734.313524538922;4767.165745994437;4769.332293478847;4779.330893674888;4788.233882578771;5715.485606295453;5741.942580574224;5764.337101233328;5767.134929760486;5772.191893134965;1412.7638316473085;1428.9211645207802;1430.935607897647;1432.8925330600246;1437.367558274356;931.3992474853682;949.7008442340641;958.1999030809213;966.9323147379616;972.3485264872552;4898.926516102261;4901.142300097468;4945.282933974553;4949.406071271471;4957.429895562056;5940.980066777316;5945.970270148708;5948.137520059568;5957.642541447527;5961.433663801932;4782.808687652455;4836.371271734652;4870.732109733999;4904.509549045067;4918.336024636628;3112.6264848218357;3138.827364494929;3144.9685503145133;3148.779585429044;3149.3858697553756;5514.518466690006;5524.281843360418;5525.4474552544425;5526.778928842882;5531.944680553223;5914.556408269397;6126.969365153235;6140.478059364915;6151.907721384183;6166.784162554289;5542.168674698827;5552.167174923875;5553.194786755978;5573.164025396223;5577.972110139585;5712.514436272963;5894.440028197314;5939.673317967553;5961.254843144607;6006.429389208019;5847.502962248256;5869.501092407022;5874.676892770939;5883.470297722537;5884.558658100574;5365.382980957083;5485.122380419114;5522.889542209053;5541.556675466034;5547.1679248113105;4042.3936409538805;4046.2716710991126;4073.103917138225;4095.2833254180996;4105.609967053125;5916.461719952929;6022.247219097613;6025.126356678169;6037.27552693662;6037.728302226323;5765.146252604987;5768.855778605568;5778.508826749773;5807.767689292381;5817.214676018683;5743.8564035899435;5744.4542768438605;5751.1373294006235;5770.596058276048;5782.681952492653;5586.16207568868;5591.664500130005;5612.719364031864;5630.5214056805635;5698.914516282342;5790.276215473066;5794.536437084938;5799.710014499343;5801.854953626024;5807.82576522705;5472.452754724496;5597.048501754793;5612.466815652507;5619.634723743107;5646.943530564642 15:50:18 INFO - PID 14220 | |5;yui.html;639.6258188959458;652.7193306878044;727.7998550398639;754.1139161485255;770.710983381232;12182;12726.236425814435;13191.340432978348;14083.155010699353;14197.361118749655;14433.711325773478;14637.634059148526;15084.245787710626;15093.018953767998;15176.620584485394;815.6574238819695;844.3456321350972;845.471580262336;846.834867200896;850.1201256699318;918.2057520245007;920.7836158502746;923.6397804856078;924.1959495239151;924.9491277979708;947.9620815167419;953.6519170502786;958.5638534466801;958.7363475044349;960.9903900961006;945.0407836046419;946.2760987844271;947.2469386837412;948.0614191949988;948.6632245552798;699.867025265198;701.6456689371886;703.3915662951562;703.6305939381814;704.376626685382;13391.531296404579;13485.662858428617;13704.794428083587;14662.340194691264;14857.331420086122;15823;15910;16156.434524791575;16308.266128024268;16323;11338.886611133865;11353.432328383631;11393.145514086476;11418.42907854604;11452.599159029394;2854.971450285512;2855.9286017849513;2856.9000084997133;2863.0981240909045;2866.498362786525;68088.65955670239;68479.65760171217;68528.6573567129;68766.31233687598;69937;12479.251244925334;12581.182223155465;12594.685132871567;12623.495060197673;12638.684032899251;22684.319470415914;22790.886045569667;22920.312390628307;23096;23164.18925337639;6103.572749907464;6175.876482470326;6380.521460890452;6427;6450.870982580416;2834.2347566157023;2867.7275658812378;2881.4669286182125;2883.870225839842;2889.7832662550395;3242.2218667520096;3277.410066188109;3289.555909952174;3300.488424294238;3313.8177400243217;722.1442590530133;747.5626758346319;748.3003391828657;753.2354660020084;754.3399525415261;560.4171661472105;585.1340016775197;586.7066466766616;587.4800801290803;588.8704485013291;9615.807683846284;9937.65218217359;10148.746281343025;10173.186145108373;10400.427976461368;572.3303734630492;579.6493121661418;584.4243420231069;586.7946218823378;600.6066026752484;4163.687723420695;4358.956410435855;4372.781360931941;4389.648828093745;4499.7975091120325;61869.485724534716;62405;63431;65445.67277163584;66567.33432665709;55477.445225548036;55970;56151.43848561462;56642;57887.13169302464;50856;52454.73772631113;52520.737396312776;52928.47071529312;53415.73292133515;8623.449679089012;8952.910470895207;8985.281177505653;9146.176844084064;9181.403208791407;27345.31636709098;27481.725182747916;27511.449771004067;27964;27989;32461.18847028843;32520.186995325304;32642.673573263964;32925.17687057747;33753.83123084369;11539.769204615694;11708.824367634663;11822.645320640395;11870.940645296718;12028.15802893789;13802.861971380158;14241.715165696422;14349;14425.927870360581;14688.265586720834;13947.442102315794;14068;14362.640933976316;14524.055936364524;14700.117992920459;13814;13888.097273677178;14195;14398.136111833324;14514.491992780202;14133.363998619881;14179.29103544798;14194.858051419353;14463.13221206731;14545.636359091108;9018.729438116867;9275.953620231856;9309.348345616012;9323;9392.577334020121;10985;11181.440927953732;11348;11461;11568.363739994045 15:50:18 INFO - PID 14220 | __end_tp_report 15:50:18 INFO - PID 14220 | __start_cc_report 15:50:18 INFO - PID 14220 | _x_x_mozilla_cycle_collect,287 15:50:18 INFO - PID 14220 | __end_cc_report 15:50:18 INFO - PID 14220 | __startTimestamp1495061418398__endTimestamp 15:50:18 INFO - PID 14220 | 15:50:18 INFO - PID 14220 | ------- Summary: start ------- 15:50:18 INFO - PID 14220 | Number of tests: 6 15:50:18 INFO - PID 14220 | 15:50:18 INFO - PID 14220 | [#0] dojo.html Cycles:165 Average:5191.58 Median:5342.92 stddev:607.57 (11.4%) stddev-sans-first:576.62 15:50:18 INFO - PID 14220 | Values: 2680.8 2718.2 2731.5 2743.9 2758.8 5159.0 5266.6 5269.6 5290.5 5326.0 5209.5 5224.6 5275.9 5376.2 5390.9 4409.0 4624.7 4714.3 4733.9 4743.1 4736.0 4771.3 4785.9 4805.1 4849.9 4607.6 4659.2 4688.2 4718.4 4763.5 4713.5 4729.1 4731.4 4745.4 4777.6 4653.0 4689.6 4695.8 4707.4 4724.5 5091.2 5172.7 5242.3 5246.6 5250.4 5664.9 5696.1 5700.8 5737.2 5779.0 5713.4 5730.9 5753.2 5761.0 5770.1 5184.7 5256.8 5290.4 5303.8 5322.7 5828.8 5838.7 5902.6 5915.9 5923.3 5564.9 5565.0 5565.4 5573.5 5575.4 5529.8 5580.6 5659.7 5669.3 5742.7 5703.9 5704.7 5706.6 5722.3 5758.7 5667.7 5670.0 5680.9 5681.3 5696.4 4622.5 4696.3 4705.8 4758.1 4815.2 4114.7 4115.3 4136.7 4200.1 4213.2 4792.5 4799.4 4812.5 4843.6 4861.9 5523.9 5627.4 5677.6 5711.5 5722.7 4689.6 4754.3 4827.6 4834.7 4840.2 5060.7 5062.8 5066.2 5113.6 5120.9 5331.9 5333.4 5343.4 5345.2 5363.4 5438.2 5512.7 5609.5 5739.4 5746.1 5243.7 5302.5 5309.7 5342.9 5350.4 5569.2 5591.3 5601.4 5605.8 5612.2 5512.2 5703.2 5703.5 5740.9 5764.8 5393.5 5452.0 5530.9 5543.5 5551.3 5364.1 5439.0 5496.1 5535.2 5557.9 5437.7 5444.6 5458.4 5464.5 5496.9 5442.5 5579.1 5585.9 5586.9 5588.4 5277.9 5283.0 5289.1 5328.9 5350.2 15:50:18 INFO - PID 14220 | 15:50:18 INFO - PID 14220 | [#1] ext.html Cycles:180 Average:30335.15 Median:17127.25 stddev:40586.10 (237.0%) stddev-sans-first:40638.95 15:50:18 INFO - PID 14220 | Values: 700.3 742.9 762.4 1084.5 1096.6 32682.3 33610.8 33613.8 33766.2 33779.3 35169.6 35351.3 35496.5 35564.8 35583.5 6878.5 6932.8 7016.8 7019.4 7148.3 7082.7 7151.9 7163.3 7176.3 7210.2 7122.1 7149.9 7218.1 7220.4 7245.2 7140.2 7160.6 7181.9 7184.1 7203.4 7041.7 7051.8 7088.8 7090.8 7104.4 32852.7 32961.3 33033.0 33076.8 33113.5 3004.7 3059.5 3079.0 3084.6 3086.7 24933.5 25061.6 25117.2 25214.5 25251.4 3080.8 3104.5 3106.7 3111.1 3116.4 131597.3 132101.0 144547.0 144617.3 144702.0 39516.8 39667.8 39702.2 39704.6 39723.8 40731.4 40911.4 40914.8 40991.0 41075.2 10271.1 10302.0 10307.9 10337.7 10409.9 7907.7 7911.8 7912.1 7933.8 8017.3 12488.7 12677.9 12702.6 12723.1 12784.7 5479.7 5572.9 5574.6 5597.2 5600.6 869.1 892.9 901.0 907.5 930.3 21011.7 21475.9 21565.0 21663.9 25349.4 949.8 979.0 979.4 980.2 980.9 11254.4 11693.5 11794.2 11827.4 11832.2 173795.0 174354.0 174995.0 175142.0 175718.0 41163.6 41608.8 41659.8 41699.6 41716.4 1176.4 1205.2 1214.2 1217.5 1246.8 19997.5 20665.5 21097.4 21257.5 21355.3 30463.5 30476.2 30484.4 30525.0 30693.0 155110.0 155278.0 155477.0 155603.0 155962.0 28164.6 30440.5 30874.4 30940.7 31143.4 35710.5 37059.6 37120.4 37125.0 37215.0 27249.3 27459.7 27992.6 28744.0 29191.7 27897.9 28281.7 28471.0 29586.7 29677.9 31018.4 31185.5 31379.7 31755.4 31952.4 26804.0 27052.0 27372.5 27535.3 28557.1 20677.3 22922.5 22949.9 22984.4 23184.7 15:50:18 INFO - PID 14220 | 15:50:18 INFO - PID 14220 | [#2] jquery.html Cycles:180 Average:24461.99 Median:209643.62 stddev:60955.29 (29.1%) stddev-sans-first:61099.57 15:50:18 INFO - PID 14220 | Values: 423.5 426.8 429.6 436.1 443.9 17256.1 17599.0 17816.4 17988.3 18020.3 14520.3 14931.1 15038.0 15282.1 15911.4 5441.4 5455.0 5522.0 5617.5 5645.6 5484.5 5558.8 5562.0 5569.2 5573.3 5334.5 5445.6 5492.1 5511.5 5549.7 5457.6 5552.3 5574.4 5585.1 5591.1 4997.2 5037.2 5042.8 5059.9 5084.4 21980.8 22089.4 22261.3 22291.2 22479.3 1669.4 1692.3 1692.7 1693.3 1694.1 14176.9 14673.8 14849.4 14869.5 14950.4 2085.4 2093.6 2138.8 2160.8 2169.3 75916.3 76684.6 76708.0 77449.0 79197.0 11038.9 11211.8 11328.7 11391.6 11567.2 15581.5 15763.8 15805.7 15806.6 15824.8 6628.1 6724.2 6850.7 6962.0 6972.9 5904.9 5913.3 6055.7 6062.4 6063.8 6882.6 6959.3 6970.5 7056.5 7152.6 2062.7 2095.3 2095.9 2099.7 2116.9 860.1 888.7 897.6 911.9 936.4 17303.6 17832.6 17917.5 18091.5 18354.4 889.5 897.5 898.9 906.9 926.9 9434.3 9494.2 9896.3 10007.5 10037.8 337794.0 342808.0 381646.0 385791.0 388610.0 73190.0 77443.6 77868.0 79437.6 79501.6 1084.2 1095.3 1128.6 1136.0 1142.5 17159.9 17618.8 17935.0 18542.9 18805.7 37191.6 37641.2 38247.8 38416.6 38457.8 46978.8 47065.8 47138.8 47168.8 48533.0 8545.2 8650.1 8659.3 8726.3 9038.3 13091.6 13198.9 13369.7 13521.4 13548.8 11001.2 11056.8 11244.4 11305.4 11567.7 10159.1 10365.7 10452.9 10513.3 10631.9 11296.7 11298.8 11413.9 11663.6 11820.9 8168.3 8214.3 8280.4 8429.0 8666.6 10553.2 10573.2 10961.9 11078.9 11242.9 15:50:18 INFO - PID 14220 | 15:50:18 INFO - PID 14220 | [#3] mootools.html Cycles:180 Average:6374.49 Median:3584.27 stddev:4133.73 (115.3%) stddev-sans-first:4127.29 15:50:18 INFO - PID 14220 | Values: 1235.5 1272.0 1284.9 1286.7 1296.7 10021.3 10522.8 10530.1 10600.9 10978.1 10600.3 10769.1 10788.4 10793.0 10827.2 2227.7 2259.9 2265.4 2270.7 2272.0 2270.4 2309.0 2311.7 2313.4 2319.1 2227.4 2229.4 2263.8 2273.0 2278.6 2198.3 2209.5 2253.5 2264.4 2269.7 1807.8 1881.8 2144.7 2153.1 2203.3 10346.6 10437.1 10444.3 10457.9 10460.7 5271.5 5414.8 5449.2 5462.5 5478.0 3306.7 3434.2 3503.3 3519.2 3575.4 1096.6 1117.9 1130.9 1167.6 1181.4 15136.7 15138.6 15258.4 15267.9 15294.1 4651.4 4848.8 4996.2 4999.2 5042.8 10839.4 10917.0 10977.2 10984.9 11004.8 5376.2 5381.1 5382.2 5388.9 5393.3 4515.4 4651.9 4655.8 4767.0 4845.5 3834.5 3882.5 3906.1 3925.4 3994.9 1127.5 1128.8 1143.5 1150.4 1166.3 676.9 699.4 706.1 715.9 723.7 5175.5 5231.1 5306.7 5376.0 5460.8 536.5 543.4 836.7 862.8 864.6 3489.1 3593.2 3636.1 3640.5 3721.3 13101.0 13185.2 13479.3 13596.9 13710.2 12997.3 13333.2 13408.5 13548.4 13583.0 7610.7 7698.9 7780.9 7783.3 7813.6 6353.3 6401.8 6504.7 6515.9 6588.5 11857.5 12344.1 12372.5 12395.9 12428.7 12231.4 12266.2 12325.7 12445.4 12611.7 8443.7 8457.7 8488.0 8532.7 8550.7 9510.8 9809.7 9815.6 9832.8 9836.4 8099.4 8178.6 8280.4 8285.6 8699.0 7992.9 8127.0 8132.2 8206.0 8251.5 7564.8 7711.2 7725.3 7727.9 7740.6 5160.6 5306.8 5357.0 5420.7 5651.5 5308.7 5327.7 5367.6 5399.3 5523.6 15:50:18 INFO - PID 14220 | 15:50:18 INFO - PID 14220 | [#4] prototype.html Cycles:180 Average:4729.61 Median:5423.49 stddev:1406.22 (25.9%) stddev-sans-first:1371.53 15:50:18 INFO - PID 14220 | Values: 368.3 389.3 395.2 398.4 400.7 5372.5 5580.5 5587.4 5588.0 5601.5 5337.5 5396.8 5402.2 5408.2 5438.8 4102.5 4111.5 4118.5 4124.1 4126.9 3983.3 4098.8 4117.5 4125.5 4136.8 4079.3 4083.2 4085.1 4087.7 4103.1 4090.9 4095.7 4097.8 4105.9 4117.6 3597.1 3598.4 3603.2 3603.9 3608.6 5208.9 5287.6 5308.0 5317.4 5320.4 4791.5 4798.9 4798.9 4807.9 4808.3 5521.6 5720.8 5723.3 5733.4 5739.9 3970.8 3977.0 3996.7 4004.3 4012.8 5880.6 6065.5 6071.9 6105.3 6124.4 4076.9 4077.9 4085.6 4090.4 4100.4 4125.1 4140.1 4152.7 4157.8 4170.9 4734.3 4767.2 4769.3 4779.3 4788.2 5715.5 5741.9 5764.3 5767.1 5772.2 1412.8 1428.9 1430.9 1432.9 1437.4 931.4 949.7 958.2 966.9 972.3 4898.9 4901.1 4945.3 4949.4 4957.4 5941.0 5946.0 5948.1 5957.6 5961.4 4782.8 4836.4 4870.7 4904.5 4918.3 3112.6 3138.8 3145.0 3148.8 3149.4 5514.5 5524.3 5525.4 5526.8 5531.9 5914.6 6127.0 6140.5 6151.9 6166.8 5542.2 5552.2 5553.2 5573.2 5578.0 5712.5 5894.4 5939.7 5961.3 6006.4 5847.5 5869.5 5874.7 5883.5 5884.6 5365.4 5485.1 5522.9 5541.6 5547.2 4042.4 4046.3 4073.1 4095.3 4105.6 5916.5 6022.2 6025.1 6037.3 6037.7 5765.1 5768.9 5778.5 5807.8 5817.2 5743.9 5744.5 5751.1 5770.6 5782.7 5586.2 5591.7 5612.7 5630.5 5698.9 5790.3 5794.5 5799.7 5801.9 5807.8 5472.5 5597.0 5612.5 5619.6 5646.9 15:50:18 INFO - PID 14220 | 15:50:18 INFO - PID 14220 | [#5] yui.html Cycles:180 Average:15067.53 Median:3307.15 stddev:17951.85 (542.8%) stddev-sans-first:17969.51 15:50:18 INFO - PID 14220 | Values: 639.6 652.7 727.8 754.1 770.7 12182.0 12726.2 13191.3 14083.2 14197.4 14433.7 14637.6 15084.2 15093.0 15176.6 815.7 844.3 845.5 846.8 850.1 918.2 920.8 923.6 924.2 924.9 948.0 953.7 958.6 958.7 961.0 945.0 946.3 947.2 948.1 948.7 699.9 701.6 703.4 703.6 704.4 13391.5 13485.7 13704.8 14662.3 14857.3 15823.0 15910.0 16156.4 16308.3 16323.0 11338.9 11353.4 11393.1 11418.4 11452.6 2855.0 2855.9 2856.9 2863.1 2866.5 68088.7 68479.7 68528.7 68766.3 69937.0 12479.3 12581.2 12594.7 12623.5 12638.7 22684.3 22790.9 22920.3 23096.0 23164.2 6103.6 6175.9 6380.5 6427.0 6450.9 2834.2 2867.7 2881.5 2883.9 2889.8 3242.2 3277.4 3289.6 3300.5 3313.8 722.1 747.6 748.3 753.2 754.3 560.4 585.1 586.7 587.5 588.9 9615.8 9937.7 10148.7 10173.2 10400.4 572.3 579.6 584.4 586.8 600.6 4163.7 4359.0 4372.8 4389.6 4499.8 61869.5 62405.0 63431.0 65445.7 66567.3 55477.4 55970.0 56151.4 56642.0 57887.1 50856.0 52454.7 52520.7 52928.5 53415.7 8623.4 8952.9 8985.3 9146.2 9181.4 27345.3 27481.7 27511.4 27964.0 27989.0 32461.2 32520.2 32642.7 32925.2 33753.8 11539.8 11708.8 11822.6 11870.9 12028.2 13802.9 14241.7 14349.0 14425.9 14688.3 13947.4 14068.0 14362.6 14524.1 14700.1 13814.0 13888.1 14195.0 14398.1 14514.5 14133.4 14179.3 14194.9 14463.1 14545.6 9018.7 9276.0 9309.3 9323.0 9392.6 10985.0 11181.4 11348.0 11461.0 11568.4 15:50:18 INFO - PID 14220 | -------- Summary: end -------- 15:50:18 INFO - PID 14220 | 15:50:19 INFO - TEST-INFO | 14220: exit 0 15:50:19 INFO - TEST-OK | dromaeo_css | took 1117574ms 15:50:19 INFO - TEST-START | kraken 15:50:19 INFO - operating with platform_type : linux_ 15:50:19 INFO - Initialising browser for kraken test... 15:50:19 INFO - TEST-INFO | started process 14652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEb3HNo/profile http://localhost:42451/getInfo.html) 15:50:19 INFO - PID 14652 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2939: String.localeCompare is deprecated; use String.prototype.localeCompare instead 15:50:23 INFO - PID 14652 | __metrics Screen width/height:1600/1200 15:50:23 INFO - PID 14652 | colorDepth:24 15:50:23 INFO - PID 14652 | Browser inner width/height: 1024/695 15:50:23 INFO - PID 14652 | __metrics 15:50:25 INFO - TEST-INFO | 14652: exit 0 15:50:25 INFO - Browser initialized. 15:50:25 INFO - Running cycle 1/1 for kraken test... 15:50:25 INFO - TEST-INFO | started process 14838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEb3HNo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:50:36 INFO - PID 14838 | RSS: Main: 165265408 15:50:36 INFO - PID 14838 | 15:50:39 INFO - PID 14838 | Cycle 1(1): loaded http://localhost:42451/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42451/tests/kraken/driver.html?testName=audio-beat-detection) 15:50:40 INFO - PID 14838 | RSS: Main: 170672128 15:50:40 INFO - PID 14838 | 15:50:43 INFO - PID 14838 | Cycle 1(1): loaded http://localhost:42451/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42451/tests/kraken/driver.html?testName=audio-dft) 15:50:43 INFO - PID 14838 | RSS: Main: 170389504 15:50:43 INFO - PID 14838 | 15:50:46 INFO - PID 14838 | Cycle 1(1): loaded http://localhost:42451/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42451/tests/kraken/driver.html?testName=audio-fft) 15:50:47 INFO - PID 14838 | RSS: Main: 165453824 15:50:47 INFO - PID 14838 | 15:50:49 INFO - PID 14838 | Cycle 1(1): loaded http://localhost:42451/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42451/tests/kraken/driver.html?testName=audio-oscillator) 15:50:49 INFO - PID 14838 | RSS: Main: 165801984 15:50:49 INFO - PID 14838 | 15:50:52 INFO - PID 14838 | Cycle 1(1): loaded http://localhost:42451/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42451/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:50:52 INFO - PID 14838 | RSS: Main: 166457344 15:50:52 INFO - PID 14838 | 15:50:55 INFO - PID 14838 | Cycle 1(1): loaded http://localhost:42451/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42451/tests/kraken/driver.html?testName=imaging-darkroom) 15:50:56 INFO - PID 14838 | RSS: Main: 170745856 15:50:56 INFO - PID 14838 | 15:51:00 INFO - PID 14838 | Cycle 1(1): loaded http://localhost:42451/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42451/tests/kraken/driver.html?testName=imaging-desaturate) 15:51:00 INFO - PID 14838 | RSS: Main: 167997440 15:51:00 INFO - PID 14838 | 15:51:03 INFO - PID 14838 | Cycle 1(1): loaded http://localhost:42451/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42451/tests/kraken/driver.html?testName=json-parse-financial) 15:51:04 INFO - PID 14838 | RSS: Main: 168640512 15:51:04 INFO - PID 14838 | 15:51:05 INFO - PID 14838 | Cycle 1(1): loaded http://localhost:42451/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42451/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:51:06 INFO - PID 14838 | RSS: Main: 169185280 15:51:06 INFO - PID 14838 | 15:51:08 INFO - PID 14838 | Cycle 1(1): loaded http://localhost:42451/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42451/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:51:08 INFO - PID 14838 | RSS: Main: 169062400 15:51:08 INFO - PID 14838 | 15:51:11 INFO - PID 14838 | Cycle 1(1): loaded http://localhost:42451/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42451/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:51:11 INFO - PID 14838 | RSS: Main: 168984576 15:51:11 INFO - PID 14838 | 15:51:14 INFO - PID 14838 | Cycle 1(1): loaded http://localhost:42451/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42451/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:51:15 INFO - PID 14838 | RSS: Main: 169046016 15:51:15 INFO - PID 14838 | 15:51:18 INFO - PID 14838 | Cycle 1(1): loaded http://localhost:42451/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42451/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:51:19 INFO - PID 14838 | RSS: Main: 169377792 15:51:19 INFO - PID 14838 | 15:51:20 INFO - PID 14838 | Cycle 1(1): loaded http://localhost:42451/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42451/tests/kraken/driver.html?testName=ai-astar) 15:51:21 INFO - PID 14838 | RSS: Main: 170655744 15:51:21 INFO - PID 14838 | 15:51:21 INFO - PID 14838 | __start_tp_report 15:51:21 INFO - PID 14838 | _x_x_mozilla_page_load 15:51:21 INFO - PID 14838 | _x_x_mozilla_page_load_details 15:51:21 INFO - PID 14838 | |i|pagename|runs| 15:51:21 INFO - PID 14838 | |0;ai-astar;106;112;112;112;113;111;113;112;112;112 15:51:21 INFO - PID 14838 | |1;audio-beat-detection;153;123;123;169;130;122;125;123;149;126 15:51:21 INFO - PID 14838 | |2;audio-dft;165;163;166;161;162;164;169;170;164;162 15:51:21 INFO - PID 14838 | |3;audio-fft;74;76;75;105;76;76;76;75;94;79 15:51:21 INFO - PID 14838 | |4;audio-oscillator;83;82;109;86;85;87;105;82;83;113 15:51:21 INFO - PID 14838 | |5;imaging-gaussian-blur;114;115;115;114;115;114;115;114;114;114 15:51:21 INFO - PID 14838 | |6;imaging-darkroom;151;154;150;151;152;155;151;150;150;151 15:51:21 INFO - PID 14838 | |7;imaging-desaturate;98;95;95;95;94;94;95;102;95;95 15:51:21 INFO - PID 14838 | |8;json-parse-financial;53;59;54;55;59;55;54;60;53;56 15:51:21 INFO - PID 14838 | |9;json-stringify-tinderbox;55;55;56;55;56;59;56;55;56;56 15:51:21 INFO - PID 14838 | |10;stanford-crypto-aes;82;81;82;84;83;81;83;83;82;83 15:51:21 INFO - PID 14838 | |11;stanford-crypto-ccm;143;135;133;138;136;133;130;132;184;132 15:51:21 INFO - PID 14838 | |12;stanford-crypto-pbkdf2;185;192;189;192;204;195;193;186;186;196 15:51:21 INFO - PID 14838 | |13;stanford-crypto-sha256-iterative;74;74;76;77;78;73;72;73;73;71 15:51:21 INFO - PID 14838 | __end_tp_report 15:51:21 INFO - PID 14838 | __start_cc_report 15:51:21 INFO - PID 14838 | _x_x_mozilla_cycle_collect,797 15:51:21 INFO - PID 14838 | __end_cc_report 15:51:21 INFO - PID 14838 | __startTimestamp1495061481106__endTimestamp 15:51:21 INFO - PID 14838 | 15:51:21 INFO - PID 14838 | ------- Summary: start ------- 15:51:21 INFO - PID 14838 | Number of tests: 14 15:51:21 INFO - PID 14838 | 15:51:21 INFO - PID 14838 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:2.01 (1.8%) stddev-sans-first:0.60 15:51:21 INFO - PID 14838 | Values: 106.0 112.0 112.0 112.0 113.0 111.0 113.0 112.0 112.0 112.0 15:51:21 INFO - PID 14838 | 15:51:21 INFO - PID 14838 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:128.00 stddev:16.59 (13.0%) stddev-sans-first:16.16 15:51:21 INFO - PID 14838 | Values: 153.0 123.0 123.0 169.0 130.0 122.0 125.0 123.0 149.0 126.0 15:51:21 INFO - PID 14838 | 15:51:21 INFO - PID 14838 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.50 stddev:2.99 (1.8%) stddev-sans-first:3.17 15:51:21 INFO - PID 14838 | Values: 165.0 163.0 166.0 161.0 162.0 164.0 169.0 170.0 164.0 162.0 15:51:21 INFO - PID 14838 | 15:51:21 INFO - PID 14838 | [#3] audio-fft Cycles:10 Average:80.60 Median:76.00 stddev:10.37 (13.6%) stddev-sans-first:10.72 15:51:21 INFO - PID 14838 | Values: 74.0 76.0 75.0 105.0 76.0 76.0 76.0 75.0 94.0 79.0 15:51:21 INFO - PID 14838 | 15:51:21 INFO - PID 14838 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:83.00 stddev:12.33 (14.9%) stddev-sans-first:12.69 15:51:21 INFO - PID 14838 | Values: 83.0 82.0 109.0 86.0 85.0 87.0 105.0 82.0 83.0 113.0 15:51:21 INFO - PID 14838 | 15:51:21 INFO - PID 14838 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 15:51:21 INFO - PID 14838 | Values: 114.0 115.0 115.0 114.0 115.0 114.0 115.0 114.0 114.0 114.0 15:51:21 INFO - PID 14838 | 15:51:21 INFO - PID 14838 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:151.00 stddev:1.72 (1.1%) stddev-sans-first:1.81 15:51:21 INFO - PID 14838 | Values: 151.0 154.0 150.0 151.0 152.0 155.0 151.0 150.0 150.0 151.0 15:51:21 INFO - PID 14838 | 15:51:21 INFO - PID 14838 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:2.44 (2.6%) stddev-sans-first:2.46 15:51:21 INFO - PID 14838 | Values: 98.0 95.0 95.0 95.0 94.0 94.0 95.0 102.0 95.0 95.0 15:51:21 INFO - PID 14838 | 15:51:21 INFO - PID 14838 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.50 stddev:2.62 (4.7%) stddev-sans-first:2.57 15:51:21 INFO - PID 14838 | Values: 53.0 59.0 54.0 55.0 59.0 55.0 54.0 60.0 53.0 56.0 15:51:21 INFO - PID 14838 | 15:51:21 INFO - PID 14838 | [#9] json-stringify-tinderbox Cycles:10 Average:55.90 Median:56.00 stddev:1.20 (2.1%) stddev-sans-first:1.22 15:51:21 INFO - PID 14838 | Values: 55.0 55.0 56.0 55.0 56.0 59.0 56.0 55.0 56.0 56.0 15:51:21 INFO - PID 14838 | 15:51:21 INFO - PID 14838 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:0.97 (1.2%) stddev-sans-first:1.01 15:51:21 INFO - PID 14838 | Values: 82.0 81.0 82.0 84.0 83.0 81.0 83.0 83.0 82.0 83.0 15:51:21 INFO - PID 14838 | 15:51:21 INFO - PID 14838 | [#11] stanford-crypto-ccm Cycles:10 Average:139.60 Median:135.50 stddev:16.04 (11.8%) stddev-sans-first:16.96 15:51:21 INFO - PID 14838 | Values: 143.0 135.0 133.0 138.0 136.0 133.0 130.0 132.0 184.0 132.0 15:51:21 INFO - PID 14838 | 15:51:21 INFO - PID 14838 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.80 Median:192.50 stddev:5.77 (3.0%) stddev-sans-first:5.57 15:51:21 INFO - PID 14838 | Values: 185.0 192.0 189.0 192.0 204.0 195.0 193.0 186.0 186.0 196.0 15:51:21 INFO - PID 14838 | 15:51:21 INFO - PID 14838 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.10 Median:74.00 stddev:2.23 (3.0%) stddev-sans-first:2.37 15:51:21 INFO - PID 14838 | Values: 74.0 74.0 76.0 77.0 78.0 73.0 72.0 73.0 73.0 71.0 15:51:21 INFO - PID 14838 | -------- Summary: end -------- 15:51:21 INFO - PID 14838 | 15:51:22 INFO - TEST-INFO | 14838: exit 0 15:51:22 INFO - TEST-OK | kraken | took 62994ms 15:51:22 INFO - SUITE-END | took 1180s 15:51:22 INFO - Completed test suite (00:19:40) 15:51:22 INFO - javascript benchmark 15:51:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6701.698835114924, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2680.7534496459148, 2718.225305787851, 2731.508328500869, 2743.8628068596577, 2758.8344699318036, 5159.0, 5266.55234305084, 5269.578433725303, 5290.497402746742, 5325.973370133153, 5209.453007434222, 5224.582033437326, 5275.894482110355, 5376.220448035033, 5390.865228369293, 4408.97795511022, 4624.745638989854, 4714.292856071583, 4733.92899106512, 4743.075100355432, 4736.0, 4771.33201351811, 4785.928211076819, 4805.063012712522, 4849.878753031167, 4607.562281583244, 4659.161350956826, 4688.249880019181, 4718.433787945469, 4763.476017638057, 4713.457952335457, 4729.101470720587, 4731.361266229083, 4745.430548334188, 4777.570018698334, 4652.976735116303, 4689.62483001359, 4695.788689508946, 4707.411573553306, 4724.480307166209, 5091.1854103343285, 5172.663776854492, 5242.292290540767, 5246.580273578104, 5250.422453530108, 5664.915026274568, 5696.145578163268, 5700.7719691212305, 5737.168110623936, 5779.017567013618, 5713.4000929902595, 5730.856728581777, 5753.194552762617, 5761.0, 5770.134479828017, 5184.714840683799, 5256.78972841082, 5290.365156181283, 5303.7878484860175, 5322.707251101149, 5828.795992140254, 5838.7080645967535, 5902.6458412495385, 5915.911261331084, 5923.289205295392, 5564.888702226014, 5564.972175139098, 5565.443455654483, 5573.526250268692, 5575.4424557543925, 5529.834104976857, 5580.553555715533, 5659.717014149359, 5669.262995810518, 5742.684152371576, 5703.885922281531, 5704.657720536781, 5706.629069110494, 5722.2561067061015, 5758.654480731086, 5667.688277144714, 5670.0, 5680.914786278209, 5681.261436013292, 5696.3733989261145, 4622.514635963243, 4696.295555666609, 4705.7647117644665, 4758.1435341638835, 4815.2054910939305, 4114.732542384735, 4115.259253334429, 4136.73111247768, 4200.096979149497, 4213.157368526246, 4792.472827988919, 4799.400074990626, 4812.51874812516, 4843.588294994895, 4861.9027619447415, 5523.889522209533, 5627.352854421712, 5677.602567820296, 5711.514521265739, 5722.7424765885635, 4689.648276379286, 4754.286856971482, 4827.565519103297, 4834.685745426606, 4840.201366774513, 5060.746962651852, 5062.848114556569, 5066.214736715815, 5113.590912726973, 5120.92318615221, 5331.866703332447, 5333.359996800486, 5343.3587969443915, 5345.1714984177515, 5363.410024897336, 5438.23864658956, 5512.6968016757855, 5609.467100625434, 5739.426057394227, 5746.080627099644, 5243.659162154448, 5302.496262855023, 5309.681419114865, 5342.9198562022375, 5350.357957045024, 5569.248151499496, 5591.273134492652, 5601.355844077983, 5605.80379686709, 5612.158176273591, 5512.200730894078, 5703.173039909107, 5703.520593277833, 5740.885182296414, 5764.798232061858, 5393.460653934575, 5452.045891968969, 5530.917036244379, 5543.528800051879, 5551.25058117149, 5364.14173732201, 5439.048166570913, 5496.120620700669, 5535.225068490334, 5557.888842223214, 5437.728113594226, 5444.564434845282, 5458.372287187024, 5464.508194262536, 5496.917546236729, 5442.482964118402, 5579.051561234519, 5585.916211256753, 5586.916196256978, 5588.441155884379, 5277.894442111213, 5283.0, 5289.100852855101, 5328.866778330573, 5350.197470379474], "value": 5147.579204597624, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.2927043685879, 742.9182789893113, 762.4205603741156, 1084.5444913136482, 1096.5723367886521, 32682.346353072924, 33610.83194584023, 33613.831930840344, 33766.15584610386, 33779.32441351171, 35169.64830351696, 35351.2929741405, 35496.46755298672, 35564.82217588909, 35583.4662480063, 6878.518503704755, 6932.792016239496, 7016.754413595525, 7019.403350715195, 7148.320909513588, 7082.681279342442, 7151.89272160918, 7163.2836716328475, 7176.318249766264, 7210.197450637341, 7122.109736282965, 7149.89275160873, 7218.097737782778, 7220.350168484835, 7245.166805817345, 7140.214576396592, 7160.606166660831, 7181.928180718178, 7184.1019872515935, 7203.351698347174, 7041.683124259421, 7051.753188638373, 7088.787336379917, 7090.822729431754, 7104.396126329269, 32852.6714732852, 32961.34077318464, 33033.0, 33076.83461582701, 33113.50329745056, 3004.72957433832, 3059.5257735051105, 3078.9692103078905, 3084.6144231971, 3086.675899030592, 24933.5013299733, 25061.62407563888, 25117.24648260555, 25214.495710085695, 25251.368715782068, 3080.8459577021285, 3104.5032794752956, 3106.6582675905634, 3111.1288839124854, 3116.3923035008183, 131597.34201329027, 132101.0, 144547.0, 144617.27691361477, 144701.99999999895, 39516.80241598774, 39667.82657387402, 39702.20595588072, 39704.60295397009, 39723.80138099291, 40731.38902916399, 40911.38632920509, 40914.795426022676, 40991.0, 41075.1784964299, 10271.126954208976, 10302.0, 10307.896921030844, 10337.741556460998, 10409.895901041044, 7907.683692652229, 7911.841763164704, 7912.129665736765, 7933.761987140395, 8017.278444939867, 12488.687782805502, 12677.936610317074, 12702.618921432371, 12723.109382343147, 12784.74430511403, 5479.671219726829, 5572.916406253909, 5574.637648552831, 5597.188407680864, 5600.551955843523, 869.1178453869328, 892.906244844282, 900.9683911920814, 907.5235501361706, 930.3441074042919, 21011.684824727643, 21475.892620536797, 21565.0, 21663.891680541496, 25349.36626584313, 949.7910459698855, 978.9755256118654, 979.4123525884412, 980.2060331131806, 980.8675828763169, 11254.437278136224, 11693.532258709556, 11794.174407791372, 11827.40862956866, 11832.17174797773, 173795.0, 174354.0, 174995.0, 175142.0, 175718.0, 41163.58836411657, 41608.791956040026, 41659.7917010413, 41699.58300417018, 41716.37425438621, 1176.3965473003532, 1205.2105870654734, 1214.186495048302, 1217.5251651855783, 1246.8316777234957, 19997.500062498555, 20665.483362916046, 21097.367078987656, 21257.468563286042, 21355.346822251773, 30463.543046853873, 30476.238094047825, 30484.390312194075, 30525.0, 30693.0, 155110.0, 155278.0, 155477.0, 155603.0, 155962.0, 28164.577531336636, 30440.543391849584, 30874.375678066717, 30940.69059309378, 31143.37713245677, 35710.46434303436, 37059.6294037067, 37120.443193352665, 37125.0, 37215.0, 27249.31876703098, 27459.725402745717, 27992.58011129794, 28744.0, 29191.7080829189, 27897.860510697315, 28281.717182828732, 28471.0, 29586.704132959258, 29677.851610742673, 31018.379632407676, 31185.53221701631, 31379.686203137677, 31755.364892702477, 31952.36095278035, 26804.0, 27052.0, 27372.452550949267, 27535.31161720973, 28557.143285701462, 20677.27629532959, 22922.54154916926, 22949.88525057364, 22984.4253893654, 23184.652230216896], "value": 14527.145750079215, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.51296009588987, 426.8128533320282, 429.6090557592589, 436.1408026188408, 443.9422875026246, 17256.13719314034, 17599.0, 17816.376426825063, 17988.28046878125, 18020.279188832465, 14520.3465844037, 14931.104133751982, 15038.0, 15282.109724888012, 15911.44309949152, 5441.374241962166, 5454.99999999999, 5522.0, 5617.522510586605, 5645.604807663465, 5484.533814625762, 5558.805441809537, 5562.0266453370705, 5569.248151499556, 5573.27547418837, 5334.493223143795, 5445.646033007842, 5492.121260598305, 5511.476409741068, 5549.722513874311, 5457.5633949283965, 5552.250446189773, 5574.358948720868, 5585.078462053756, 5591.1054231323, 4997.175466048134, 5037.168867136918, 5042.84871453857, 5059.949400505985, 5084.3644544431945, 21980.78019219803, 22089.447763805874, 22261.332160035225, 22291.21980730683, 22479.32562023142, 1669.4490818030142, 1692.2892385198247, 1692.7037768390483, 1693.2803558487717, 1694.051331254489, 14176.858231417656, 14673.779893301502, 14849.406023759037, 14869.479568215169, 14950.40198392063, 2085.374387683704, 2093.602215579035, 2138.764735879052, 2160.8487405881597, 2169.316665250441, 75916.30627702945, 76684.61657691676, 76707.99999999945, 77449.0, 79197.0, 11038.944805275922, 11211.831822522669, 11328.71678208035, 11391.601293954838, 11567.248128871597, 15581.454649087455, 15763.842361576466, 15805.683886322438, 15806.60483487899, 15824.75592503534, 6628.105205797252, 6724.193096828412, 6850.6574671266235, 6962.0, 6972.930270697329, 5904.940950590525, 5913.349531551526, 6055.666938318434, 6062.393760623991, 6063.757449701962, 6882.621455819978, 6959.329760857459, 6970.455783638935, 7056.54132481387, 7152.606606636581, 2062.711220429141, 2095.308548179097, 2095.8847263400353, 2099.6745504446835, 2116.8835714035567, 860.0968982568278, 888.6756333938196, 897.5915958238986, 911.8541033434618, 936.4287784451479, 17303.56741081458, 17832.55418614545, 17917.462476125736, 18091.54771130732, 18354.449366519028, 889.5285498685707, 897.4570384917162, 898.8606765951288, 906.9138431848963, 926.9443833370019, 9434.292428067922, 9494.192993595483, 9896.25778066648, 10007.49962501872, 10037.799244015225, 337794.0, 342808.0, 381646.0, 385791.0, 388610.0, 73190.0, 77443.61278193574, 77868.0, 79437.60281198558, 79501.60249198832, 1084.1543595995136, 1095.3099547285, 1128.5598616539555, 1136.023020202625, 1142.4744617476053, 17159.914200428917, 17618.82381176172, 17935.0, 18542.907285463487, 18805.717914231573, 37191.62808371882, 37641.247175056895, 38247.80876095602, 38416.6158338413, 38457.807710961264, 46978.76510617425, 47065.764671176425, 47138.76430617825, 47168.764156179, 48533.0, 8545.2309292164, 8650.1349865013, 8659.307255419426, 8726.345524085846, 9038.276937845088, 13091.607251782461, 13198.868011320148, 13369.66575835612, 13521.391537380645, 13548.79676804829, 11001.22991390595, 11056.834147487954, 11244.437778111225, 11305.378204198849, 11567.710807229887, 10159.136473399843, 10365.70428696413, 10452.895471045193, 10513.264071515227, 10631.893681063091, 11296.717582060513, 11298.830517542408, 11413.942930285628, 11663.5917742882, 11820.940895295469, 8168.305694016075, 8214.34285257166, 8280.385324861594, 8428.957855210685, 8666.566671666265, 10553.186407448113, 10573.207009474474, 10961.945190273998, 11078.944605276922, 11242.943785281348], "value": 8825.324744607016, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1235.5057976809276, 1272.0396100943785, 1284.8650891656375, 1286.659035355631, 1296.6758310422401, 10021.298509104365, 10522.842157367637, 10530.104941080017, 10600.893991060088, 10978.12175025998, 10600.257981941268, 10769.084627806646, 10788.406637634947, 10793.02862742353, 10827.187960902924, 2227.7326720793485, 2259.8644081355087, 2265.3543740034092, 2270.693456383392, 2272.0343853862123, 2270.3642979965634, 2308.9653655195184, 2311.711036120485, 2313.35226136682, 2319.072371051576, 2227.3652009177385, 2229.3869185973826, 2263.841531092824, 2272.9659055114103, 2278.567072256266, 2198.3075331270597, 2209.5028618560855, 2253.549290141978, 2264.365977526287, 2269.682244485765, 1807.7649905512199, 1881.8494520438333, 2144.7104640873595, 2153.0634174134143, 2203.327984964585, 10346.586136554528, 10437.060664540151, 10444.26890117692, 10457.947710261476, 10460.68617941463, 5271.525562699337, 5414.756335964891, 5449.155380915964, 5462.508374246337, 5477.972610136963, 3306.68586484286, 3434.1586311353876, 3503.3343664703625, 3519.1905861651708, 3575.3564358415474, 1096.6052221200362, 1117.9049780768644, 1130.9151813614012, 1167.5796713183247, 1181.3974872814927, 15136.697266054727, 15138.621534461616, 15258.38966441341, 15267.923660381739, 15294.082355058732, 4651.418572678415, 4848.781804818792, 4996.225585034253, 4999.150144475448, 5042.848714538496, 10839.403832789114, 10917.0, 10977.176711746652, 10984.945075274572, 11004.834927476095, 5376.247325374451, 5381.13901775714, 5382.2464854920345, 5388.892222155535, 5393.298871146726, 4515.412996310524, 4651.883702907387, 4655.813767449264, 4767.0, 4845.515448455197, 3834.539855217392, 3882.5052354843588, 3906.140649057203, 3925.3905898581443, 3994.9201015980098, 1127.503898284752, 1128.8306753986803, 1143.4511434511314, 1150.3902931446346, 1166.2535976974743, 676.8544762876005, 699.4124935054579, 706.0679902528613, 715.8926161075776, 723.6598798564667, 5175.45657705943, 5231.084560202025, 5306.708131052829, 5376.0, 5460.781568737286, 536.4581772409816, 543.413113837055, 836.7071524966335, 862.8188080503164, 864.6238886084448, 3489.0928358626434, 3593.1735700788963, 3636.090977255686, 3640.4539319102346, 3721.2557488501866, 13101.0, 13185.208887466782, 13479.258640774655, 13596.93201533986, 13710.24593647339, 12997.285149316878, 13333.200007999358, 13408.530701425403, 13548.390322435514, 13583.0, 7610.657520411595, 7698.884516732253, 7780.8832867507035, 7783.299503044753, 7813.609319534115, 6353.3011368748475, 6401.775937842153, 6504.707288172138, 6515.934840651723, 6588.5058620604605, 11857.466414011218, 12344.135910486539, 12372.505099795908, 12395.876041239833, 12428.694987026232, 12231.388430578258, 12266.202696824677, 12325.69185770327, 12445.439955202219, 12611.684707882376, 8443.704470343508, 8457.703980360659, 8488.0, 8532.70135545253, 8550.74347769568, 9510.809783804423, 9809.705708828747, 9815.558299876666, 9832.803343933225, 9836.409815411098, 8099.392545558989, 8178.550179740171, 8280.378971577034, 8285.58572071382, 8699.04310525829, 7992.880106798287, 8127.024757029194, 8132.227438393344, 8205.95897020511, 8251.463654862415, 7564.810879727831, 7711.151773305044, 7725.266099720742, 7727.92272077272, 7740.612969351622, 5160.638755287094, 5306.761195746123, 5357.0, 5420.674759514442, 5651.519620832275, 5308.708021058879, 5327.733613319241, 5367.624266301322, 5399.271098401822, 5523.558115350682], "value": 4770.815965089348, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.32228699193496, 389.32257871303926, 395.2450818935833, 398.364608449523, 400.67945643485206, 5372.462753724635, 5580.525655319298, 5587.441255874411, 5587.972060139698, 5601.523870471005, 5337.5196232339085, 5396.838094857151, 5402.162664786954, 5408.215808707735, 5438.755256013479, 4102.528209255944, 4111.547729749733, 4118.546959834416, 4124.092699606082, 4126.8968275793195, 3983.2630963271745, 4098.7540747555095, 4117.485314335708, 4125.463689720332, 4136.81384337704, 4079.2657321682086, 4083.1629515949307, 4085.12169883475, 4087.6934229932726, 4103.138340948404, 4090.9181816363653, 4095.7337773044655, 4097.754134751909, 4105.85629502966, 4117.5882411758585, 3597.0647631615966, 3598.4062629666073, 3603.2433189030335, 3603.8918832434806, 3608.566971963355, 5208.880090780501, 5287.550558202557, 5308.0, 5317.404778566453, 5320.414754377015, 4791.520847915215, 4798.880027999328, 4798.904021919577, 4807.855764327076, 4808.278758186265, 5521.613487055908, 5720.799772007959, 5723.255976723041, 5733.426657334275, 5739.885202295931, 3970.8411663533425, 3977.0, 3996.680265578776, 4004.2592120457807, 4012.8394864205397, 5880.5883588148845, 6065.4844338231305, 6071.878562428727, 6105.32841387447, 6124.35694252106, 4076.9399956011653, 4077.8776636700945, 4085.611866872642, 4090.386442033659, 4100.446439730598, 4125.092479654471, 4140.130572579792, 4152.709310348307, 4157.771322577227, 4170.895727606773, 4734.313524538922, 4767.165745994437, 4769.332293478847, 4779.330893674888, 4788.233882578771, 5715.485606295453, 5741.942580574224, 5764.337101233328, 5767.134929760486, 5772.191893134965, 1412.7638316473085, 1428.9211645207802, 1430.935607897647, 1432.8925330600246, 1437.367558274356, 931.3992474853682, 949.7008442340641, 958.1999030809213, 966.9323147379616, 972.3485264872552, 4898.926516102261, 4901.142300097468, 4945.282933974553, 4949.406071271471, 4957.429895562056, 5940.980066777316, 5945.970270148708, 5948.137520059568, 5957.642541447527, 5961.433663801932, 4782.808687652455, 4836.371271734652, 4870.732109733999, 4904.509549045067, 4918.336024636628, 3112.6264848218357, 3138.827364494929, 3144.9685503145133, 3148.779585429044, 3149.3858697553756, 5514.518466690006, 5524.281843360418, 5525.4474552544425, 5526.778928842882, 5531.944680553223, 5914.556408269397, 6126.969365153235, 6140.478059364915, 6151.907721384183, 6166.784162554289, 5542.168674698827, 5552.167174923875, 5553.194786755978, 5573.164025396223, 5577.972110139585, 5712.514436272963, 5894.440028197314, 5939.673317967553, 5961.254843144607, 6006.429389208019, 5847.502962248256, 5869.501092407022, 5874.676892770939, 5883.470297722537, 5884.558658100574, 5365.382980957083, 5485.122380419114, 5522.889542209053, 5541.556675466034, 5547.1679248113105, 4042.3936409538805, 4046.2716710991126, 4073.103917138225, 4095.2833254180996, 4105.609967053125, 5916.461719952929, 6022.247219097613, 6025.126356678169, 6037.27552693662, 6037.728302226323, 5765.146252604987, 5768.855778605568, 5778.508826749773, 5807.767689292381, 5817.214676018683, 5743.8564035899435, 5744.4542768438605, 5751.1373294006235, 5770.596058276048, 5782.681952492653, 5586.16207568868, 5591.664500130005, 5612.719364031864, 5630.5214056805635, 5698.914516282342, 5790.276215473066, 5794.536437084938, 5799.710014499343, 5801.854953626024, 5807.82576522705, 5472.452754724496, 5597.048501754793, 5612.466815652507, 5619.634723743107, 5646.943530564642], "value": 4297.857434675529, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.6258188959458, 652.7193306878044, 727.7998550398639, 754.1139161485255, 770.710983381232, 12182.0, 12726.236425814435, 13191.340432978348, 14083.155010699353, 14197.361118749655, 14433.711325773478, 14637.634059148526, 15084.245787710626, 15093.018953767998, 15176.620584485394, 815.6574238819695, 844.3456321350972, 845.471580262336, 846.834867200896, 850.1201256699318, 918.2057520245007, 920.7836158502746, 923.6397804856078, 924.1959495239151, 924.9491277979708, 947.9620815167419, 953.6519170502786, 958.5638534466801, 958.7363475044349, 960.9903900961006, 945.0407836046419, 946.2760987844271, 947.2469386837412, 948.0614191949988, 948.6632245552798, 699.867025265198, 701.6456689371886, 703.3915662951562, 703.6305939381814, 704.376626685382, 13391.531296404579, 13485.662858428617, 13704.794428083587, 14662.340194691264, 14857.331420086122, 15823.0, 15910.0, 16156.434524791575, 16308.266128024268, 16323.0, 11338.886611133865, 11353.432328383631, 11393.145514086476, 11418.42907854604, 11452.599159029394, 2854.971450285512, 2855.9286017849513, 2856.9000084997133, 2863.0981240909045, 2866.498362786525, 68088.65955670239, 68479.65760171217, 68528.6573567129, 68766.31233687598, 69937.0, 12479.251244925334, 12581.182223155465, 12594.685132871567, 12623.495060197673, 12638.684032899251, 22684.319470415914, 22790.886045569667, 22920.312390628307, 23096.0, 23164.18925337639, 6103.572749907464, 6175.876482470326, 6380.521460890452, 6427.0, 6450.870982580416, 2834.2347566157023, 2867.7275658812378, 2881.4669286182125, 2883.870225839842, 2889.7832662550395, 3242.2218667520096, 3277.410066188109, 3289.555909952174, 3300.488424294238, 3313.8177400243217, 722.1442590530133, 747.5626758346319, 748.3003391828657, 753.2354660020084, 754.3399525415261, 560.4171661472105, 585.1340016775197, 586.7066466766616, 587.4800801290803, 588.8704485013291, 9615.807683846284, 9937.65218217359, 10148.746281343025, 10173.186145108373, 10400.427976461368, 572.3303734630492, 579.6493121661418, 584.4243420231069, 586.7946218823378, 600.6066026752484, 4163.687723420695, 4358.956410435855, 4372.781360931941, 4389.648828093745, 4499.7975091120325, 61869.485724534716, 62405.0, 63431.0, 65445.67277163584, 66567.33432665709, 55477.445225548036, 55970.0, 56151.43848561462, 56642.0, 57887.13169302464, 50856.0, 52454.73772631113, 52520.737396312776, 52928.47071529312, 53415.73292133515, 8623.449679089012, 8952.910470895207, 8985.281177505653, 9146.176844084064, 9181.403208791407, 27345.31636709098, 27481.725182747916, 27511.449771004067, 27964.0, 27989.0, 32461.18847028843, 32520.186995325304, 32642.673573263964, 32925.17687057747, 33753.83123084369, 11539.769204615694, 11708.824367634663, 11822.645320640395, 11870.940645296718, 12028.15802893789, 13802.861971380158, 14241.715165696422, 14349.0, 14425.927870360581, 14688.265586720834, 13947.442102315794, 14068.0, 14362.640933976316, 14524.055936364524, 14700.117992920459, 13814.0, 13888.097273677178, 14195.0, 14398.136111833324, 14514.491992780202, 14133.363998619881, 14179.29103544798, 14194.858051419353, 14463.13221206731, 14545.636359091108, 9018.729438116867, 9275.953620231856, 9309.348345616012, 9323.0, 9392.577334020121, 10985.0, 11181.440927953732, 11348.0, 11461.0, 11568.363739994045], "value": 6694.5155012857995, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 112.0, 112.0, 113.0, 111.0, 113.0, 112.0, 112.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 123.0, 169.0, 130.0, 122.0, 125.0, 123.0, 149.0, 126.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 166.0, 161.0, 162.0, 164.0, 169.0, 170.0, 164.0, 162.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 105.0, 76.0, 76.0, 76.0, 75.0, 94.0, 79.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 109.0, 86.0, 85.0, 87.0, 105.0, 82.0, 83.0, 113.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 115.0, 114.0, 115.0, 114.0, 114.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 154.0, 150.0, 151.0, 152.0, 155.0, 151.0, 150.0, 150.0, 151.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 102.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 59.0, 54.0, 55.0, 59.0, 55.0, 54.0, 60.0, 53.0, 56.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 55.0, 56.0, 59.0, 56.0, 55.0, 56.0, 56.0], "value": 55.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 82.0, 84.0, 83.0, 81.0, 83.0, 83.0, 82.0, 83.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 135.0, 133.0, 138.0, 136.0, 133.0, 130.0, 132.0, 184.0, 132.0], "value": 139.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 192.0, 189.0, 192.0, 204.0, 195.0, 193.0, 186.0, 186.0, 196.0], "value": 191.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 77.0, 78.0, 73.0, 72.0, 73.0, 73.0, 71.0], "value": 74.1, "unit": "score"}]}]} 15:51:22 INFO - Return code: 0 15:51:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:51:22 INFO - # TBPL SUCCESS # 15:51:22 INFO - Running post-action listener: _resource_record_post_action 15:51:22 INFO - [mozharness: 2017-05-17 22:51:22.431333Z] Finished run-tests step (success) 15:51:22 INFO - Running post-run listener: _resource_record_post_run 15:51:22 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 382091264; Read time: 124; Write time: 268324 15:51:22 INFO - TinderboxPrint: CPU usage
13.3% 15:51:22 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 124 15:51:22 INFO - TinderboxPrint: I/O write bytes / time
382,091,264 / 268,324 15:51:22 INFO - TinderboxPrint: CPU idle
8,279.9 (86.7%) 15:51:22 INFO - TinderboxPrint: CPU user
1,216.8 (12.7%) 15:51:22 INFO - TinderboxPrint: Swap in / out
0 / 0 15:51:22 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 108572672; Read time: 0; Write time: 115800 15:51:22 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 273518592; Read time: 124; Write time: 152524 15:51:23 INFO - Running post-run listener: _upload_blobber_files 15:51:23 INFO - Blob upload gear active. 15:51:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:51:23 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 15:51:23 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'] 15:51:23 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 15:51:23 INFO - (blobuploader) - INFO - Open directory for files ... 15:51:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:51:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:51:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:24 INFO - (blobuploader) - INFO - Done attempting. 15:51:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:51:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:51:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:27 INFO - (blobuploader) - INFO - Done attempting. 15:51:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:51:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:51:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:28 INFO - (blobuploader) - INFO - Done attempting. 15:51:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:51:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:51:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:29 INFO - (blobuploader) - INFO - Done attempting. 15:51:29 INFO - (blobuploader) - INFO - Iteration through files over. 15:51:29 INFO - Return code: 0 15:51:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:51:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:51:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4573d0ce1542903a3a8aaacbeec98592ed9d28ca07c83fc3daeacd2507169766025a8eabc1a83bb9ed0de6bffbcca197d7a9c7421dc07a5593f5d6eb8affc90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5699d0c7af5b0e41cb06f4d994925f233289975468693eca2facd42469b1d6c19a74b51a8200d971b948670ba974b9c4447c470bbcc55ab24b2ed9d960d1e78f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b860354ac1d8e90cef314a251265811d2cbf6859ed7f632a2cb8746b50d2ddfbdcffe55ceeecd2b57cb64fc68241619e265d3fccdca0a5b6fdd42bee3d1912be", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/285443215b55676d5177ee98d3808763d5902fb5108913785c2c8050af9c4c6383b32e664511a16663d62703e5f4a975db9bce06b2752999f2c066a6a7909446"} 15:51:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:51:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:51:29 INFO - Contents: 15:51:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4573d0ce1542903a3a8aaacbeec98592ed9d28ca07c83fc3daeacd2507169766025a8eabc1a83bb9ed0de6bffbcca197d7a9c7421dc07a5593f5d6eb8affc90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5699d0c7af5b0e41cb06f4d994925f233289975468693eca2facd42469b1d6c19a74b51a8200d971b948670ba974b9c4447c470bbcc55ab24b2ed9d960d1e78f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b860354ac1d8e90cef314a251265811d2cbf6859ed7f632a2cb8746b50d2ddfbdcffe55ceeecd2b57cb64fc68241619e265d3fccdca0a5b6fdd42bee3d1912be", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/285443215b55676d5177ee98d3808763d5902fb5108913785c2c8050af9c4c6383b32e664511a16663d62703e5f4a975db9bce06b2752999f2c066a6a7909446"} 15:51:29 INFO - Running post-run listener: copy_logs_to_upload_dir 15:51:29 INFO - Copying logs to upload dir... 15:51:29 INFO - mkdir: /builds/slave/test/build/upload/logs 15:51:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.327334 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-05-17 15:51:29.498918) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-17 15:51:29.504799) ========= 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=db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4573d0ce1542903a3a8aaacbeec98592ed9d28ca07c83fc3daeacd2507169766025a8eabc1a83bb9ed0de6bffbcca197d7a9c7421dc07a5593f5d6eb8affc90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5699d0c7af5b0e41cb06f4d994925f233289975468693eca2facd42469b1d6c19a74b51a8200d971b948670ba974b9c4447c470bbcc55ab24b2ed9d960d1e78f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b860354ac1d8e90cef314a251265811d2cbf6859ed7f632a2cb8746b50d2ddfbdcffe55ceeecd2b57cb64fc68241619e265d3fccdca0a5b6fdd42bee3d1912be", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/285443215b55676d5177ee98d3808763d5902fb5108913785c2c8050af9c4c6383b32e664511a16663d62703e5f4a975db9bce06b2752999f2c066a6a7909446"} build_url:https://queue.taskcluster.net/v1/task/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/OuvZUrIVSx6b13WMCShlAQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4573d0ce1542903a3a8aaacbeec98592ed9d28ca07c83fc3daeacd2507169766025a8eabc1a83bb9ed0de6bffbcca197d7a9c7421dc07a5593f5d6eb8affc90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5699d0c7af5b0e41cb06f4d994925f233289975468693eca2facd42469b1d6c19a74b51a8200d971b948670ba974b9c4447c470bbcc55ab24b2ed9d960d1e78f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b860354ac1d8e90cef314a251265811d2cbf6859ed7f632a2cb8746b50d2ddfbdcffe55ceeecd2b57cb64fc68241619e265d3fccdca0a5b6fdd42bee3d1912be", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/285443215b55676d5177ee98d3808763d5902fb5108913785c2c8050af9c4c6383b32e664511a16663d62703e5f4a975db9bce06b2752999f2c066a6a7909446"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-17 15:51:29.536470) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-05-17 15:51:29.536787) ========= 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=db0483c52d987ecb441a263b000001ad-1495057783.29003-1947347963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 1.39 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-05-17 15:51:30.927231) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-17 15:51:30.927572) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-17 15:51:30.928395) ========= ========= Total master_lag: 1.57 =========