builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-089 starttime: 1494942202.82 results: success (0) revision: b9a4a6e2292e923684c2d25b78addaca23c6abd5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-16 06:43:22.816496) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-16 06:43:22.817809) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-16 06:43:22.818148) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-16 06:43:22.885650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 06:43:22.885959) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-16 06:43:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 110M=0s 2017-05-16 06:43:23 (110 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125846 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 06:43:23.027982) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 06:43:23.028336) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019688 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 06:43:23.084971) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 06:43:23.085359) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b9a4a6e2292e923684c2d25b78addaca23c6abd5 --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 b9a4a6e2292e923684c2d25b78addaca23c6abd5 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-16 06:43:23,309 truncating revision to first 12 chars 2017-05-16 06:43:23,310 Setting DEBUG logging. 2017-05-16 06:43:23,310 attempt 1/10 2017-05-16 06:43:23,310 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b9a4a6e2292e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-16 06:43:23,627 unpacking tar archive at: mozilla-central-b9a4a6e2292e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679400 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 06:43:23.779883) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-16 06:43:23.780274) ========= script_repo_revision: b9a4a6e2292e923684c2d25b78addaca23c6abd5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-16 06:43:23.780723) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-16 06:43:23.781057) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-16 06:43:23.791486) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-05-16 06:43:23.791842) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:43:24 INFO - MultiFileLogger online at 20170516 06:43:24 in /builds/slave/test 06:43:24 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 06:43:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:43:24 INFO - {'append_to_log': False, 06:43:24 INFO - 'base_work_dir': '/builds/slave/test', 06:43:24 INFO - 'blob_upload_branch': 'Firefox', 06:43:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:43:24 INFO - 'branch': 'Firefox', 06:43:24 INFO - 'buildbot_json_path': 'buildprops.json', 06:43:24 INFO - 'config_files': ('talos/linux_config.py',), 06:43:24 INFO - 'default_actions': ('clobber', 06:43:24 INFO - 'read-buildbot-config', 06:43:24 INFO - 'download-and-extract', 06:43:24 INFO - 'populate-webroot', 06:43:24 INFO - 'create-virtualenv', 06:43:24 INFO - 'install', 06:43:24 INFO - 'run-tests'), 06:43:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:43:24 INFO - 'download_minidump_stackwalk': True, 06:43:24 INFO - 'download_symbols': 'ondemand', 06:43:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:43:24 INFO - 'tooltool.py': '/tools/tooltool.py', 06:43:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:43:24 INFO - '/tools/misc-python/virtualenv.py')}, 06:43:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:43:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:43:24 INFO - 'gecko_profile': False, 06:43:24 INFO - 'gecko_profile_interval': 0, 06:43:24 INFO - 'installer_path': 'installer.exe', 06:43:24 INFO - 'log_level': 'info', 06:43:24 INFO - 'log_name': 'talos', 06:43:24 INFO - 'log_to_console': True, 06:43:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:43:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:43:24 INFO - 'opt_config_files': (), 06:43:24 INFO - 'pip_index': False, 06:43:24 INFO - 'suite': 'dromaeojs-e10s', 06:43:24 INFO - 'system_bits': '32', 06:43:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:43:24 INFO - 'title': 'talos-linux64-ix-089', 06:43:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:43:24 INFO - 'use_talos_json': True, 06:43:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:43:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:43:24 INFO - 'work_dir': 'build'} 06:43:24 INFO - [mozharness: 2017-05-16 13:43:24.118159Z] Running clobber step. 06:43:24 INFO - Running pre-action listener: _resource_record_pre_action 06:43:24 INFO - Running main action method: clobber 06:43:24 INFO - rmtree: /builds/slave/test/build 06:43:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:43:25 INFO - Running post-action listener: _resource_record_post_action 06:43:25 INFO - [mozharness: 2017-05-16 13:43:25.114799Z] Finished clobber step (success) 06:43:25 INFO - [mozharness: 2017-05-16 13:43:25.114899Z] Running read-buildbot-config step. 06:43:25 INFO - Running pre-action listener: _resource_record_pre_action 06:43:25 INFO - Running main action method: read_buildbot_config 06:43:25 INFO - Using buildbot properties: 06:43:25 INFO - { 06:43:25 INFO - "project": "", 06:43:25 INFO - "product": "firefox", 06:43:25 INFO - "who": "cbook@mozilla.com", 06:43:25 INFO - "installer_path": "public/build/target.tar.bz2", 06:43:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 06:43:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:43:25 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 06:43:25 INFO - "stage_platform": "linux64-styloseq", 06:43:25 INFO - "basedir": "/builds/slave/test", 06:43:25 INFO - "buildnumber": 1, 06:43:25 INFO - "platform": "ubuntu64_hw_styloseq", 06:43:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:43:25 INFO - "slavebuilddir": "test", 06:43:25 INFO - "taskId": "e_oGFTQqQ5iepdLff1MF1A", 06:43:25 INFO - "branch": "mozilla-central", 06:43:25 INFO - "script_repo_revision": "production", 06:43:25 INFO - "revision": "b9a4a6e2292e923684c2d25b78addaca23c6abd5", 06:43:25 INFO - "slavename": "talos-linux64-ix-089", 06:43:25 INFO - "repo_path": "mozilla-central" 06:43:25 INFO - } 06:43:25 INFO - Finding installer, test and symbols from parent task. 06:43:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e_oGFTQqQ5iepdLff1MF1A'}, attempt #1 06:43:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e_oGFTQqQ5iepdLff1MF1A'}, attempt #1 06:43:26 INFO - Task dependencies: SCSWyz1ySLCp7m69hsdlRA 06:43:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SCSWyz1ySLCp7m69hsdlRA'}, attempt #1 06:43:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/target.tar.bz2 06:43:26 INFO - Set test_url: https://queue.taskcluster.net/v1/task/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/test_packages.json 06:43:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/target.crashreporter-symbols.zip 06:43:26 INFO - Running post-action listener: _resource_record_post_action 06:43:26 INFO - [mozharness: 2017-05-16 13:43:26.479828Z] Finished read-buildbot-config step (success) 06:43:26 INFO - [mozharness: 2017-05-16 13:43:26.480049Z] Running download-and-extract step. 06:43:26 INFO - Running pre-action listener: _resource_record_pre_action 06:43:26 INFO - Running main action method: download_and_extract 06:43:26 INFO - mkdir: /builds/slave/test/build/tests 06:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:43:26 INFO - trying https://queue.taskcluster.net/v1/task/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/target.test_packages.json 06:43:26 INFO - Downloading https://queue.taskcluster.net/v1/task/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:43:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:43:27 INFO - Downloaded 986 bytes. 06:43:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:43:27 INFO - Using the following test package requirements: 06:43:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:43:27 INFO - u'common': [u'target.common.tests.zip'], 06:43:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:43:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:43:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:43:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:43:27 INFO - u'mozbase': [u'target.common.tests.zip'], 06:43:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:43:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:43:27 INFO - u'web-platform': [u'target.common.tests.zip', 06:43:27 INFO - u'target.web-platform.tests.zip'], 06:43:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:43:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:43:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/target.common.tests.zip 06:43:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:43:27 INFO - Fetch https://queue.taskcluster.net/v1/task/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/target.common.tests.zip into memory 06:43:32 INFO - Content-Length response header: 62450325 06:43:32 INFO - Bytes received: 62450325 06:43:43 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:43:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/target.common.tests.zip 06:43:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:43:43 INFO - Fetch https://queue.taskcluster.net/v1/task/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/target.common.tests.zip into memory 06:43:47 INFO - Content-Length response header: 62450325 06:43:47 INFO - Bytes received: 62450325 06:43:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/target.talos.tests.zip 06:43:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:43:59 INFO - Fetch https://queue.taskcluster.net/v1/task/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/target.talos.tests.zip into memory 06:44:00 INFO - Content-Length response header: 14410069 06:44:00 INFO - Bytes received: 14410069 06:44:00 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')]} 06:44:00 INFO - trying https://queue.taskcluster.net/v1/task/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/target.tar.bz2 06:44:00 INFO - Downloading https://queue.taskcluster.net/v1/task/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:44:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:44:03 INFO - Downloaded 64961721 bytes. 06:44:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/target.tar.bz2 06:44:03 INFO - mkdir: /builds/slave/test/properties 06:44:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:44:03 INFO - Writing to file /builds/slave/test/properties/build_url 06:44:03 INFO - Contents: 06:44:03 INFO - build_url:https://queue.taskcluster.net/v1/task/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/target.tar.bz2 06:44:03 INFO - Running post-action listener: _resource_record_post_action 06:44:03 INFO - Running post-action listener: set_extra_try_arguments 06:44:03 INFO - [mozharness: 2017-05-16 13:44:03.233319Z] Finished download-and-extract step (success) 06:44:03 INFO - [mozharness: 2017-05-16 13:44:03.233417Z] Running populate-webroot step. 06:44:03 INFO - Running pre-action listener: _resource_record_pre_action 06:44:03 INFO - Running main action method: populate_webroot 06:44:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:44:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:44:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:44:03 INFO - '--tppagecycles', 06:44:03 INFO - '7'], 06:44:03 INFO - 'tests': ['tsvgm']}}, 06:44:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:44:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:44:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:44:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:44:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:44:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:44:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:44:03 INFO - 'talos_options': ['--disable-e10s'], 06:44:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:44:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:44:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:44:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:44:03 INFO - 'talos_options': ['--disable-e10s'], 06:44:03 INFO - 'tests': ['damp', 'tps']}, 06:44:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:44:03 INFO - 'tests': ['damp', 'tps']}, 06:44:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:44:03 INFO - 'tests': ['dromaeo_dom']}, 06:44:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:44:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:44:03 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:44:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:44:03 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:44:03 INFO - 'tests': ['ts_paint', 'tp5o']}, 06:44:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:44:03 INFO - 'tests': ['a11yr', 06:44:03 INFO - 'ts_paint', 06:44:03 INFO - 'tpaint', 06:44:03 INFO - 'sessionrestore', 06:44:03 INFO - 'sessionrestore_no_auto_restore', 06:44:03 INFO - 'tabpaint']}, 06:44:03 INFO - 'other-e10s': {'tests': ['a11yr', 06:44:03 INFO - 'ts_paint', 06:44:03 INFO - 'tpaint', 06:44:03 INFO - 'sessionrestore', 06:44:03 INFO - 'sessionrestore_no_auto_restore', 06:44:03 INFO - 'tabpaint']}, 06:44:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:44:03 INFO - 'ts_paint', 06:44:03 INFO - 'tpaint', 06:44:03 INFO - 'sessionrestore', 06:44:03 INFO - 'sessionrestore_no_auto_restore', 06:44:03 INFO - 'tabpaint']}, 06:44:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:44:03 INFO - 'ts_paint', 06:44:03 INFO - 'tpaint', 06:44:03 INFO - 'sessionrestore', 06:44:03 INFO - 'sessionrestore_no_auto_restore', 06:44:03 INFO - 'tabpaint']}, 06:44:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:44:03 INFO - 'tests': ['a11yr', 06:44:03 INFO - 'ts_paint', 06:44:03 INFO - 'tpaint', 06:44:03 INFO - 'sessionrestore', 06:44:03 INFO - 'sessionrestore_no_auto_restore', 06:44:03 INFO - 'tabpaint']}, 06:44:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:44:03 INFO - 'tests': ['a11yr', 06:44:03 INFO - 'ts_paint', 06:44:03 INFO - 'tpaint', 06:44:03 INFO - 'sessionrestore', 06:44:03 INFO - 'sessionrestore_no_auto_restore', 06:44:03 INFO - 'tabpaint']}, 06:44:03 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 06:44:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 06:44:03 INFO - 'bloom_basic_ref']}, 06:44:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:44:03 INFO - 'tests': ['tsvgx', 06:44:03 INFO - 'tsvgr_opacity', 06:44:03 INFO - 'tart', 06:44:03 INFO - 'tscrollx', 06:44:03 INFO - 'cart', 06:44:03 INFO - 'tsvg_static']}, 06:44:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:44:03 INFO - 'tsvgr_opacity', 06:44:03 INFO - 'tart', 06:44:03 INFO - 'tscrollx', 06:44:03 INFO - 'cart', 06:44:03 INFO - 'tsvg_static']}, 06:44:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:44:03 INFO - 'talos_options': ['--disable-e10s'], 06:44:03 INFO - 'tests': ['tp5o']}, 06:44:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:44:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:44:03 INFO - 'talos_options': ['--disable-e10s', 06:44:03 INFO - '--xperf_path', 06:44:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:44:03 INFO - 'tests': ['tp5n']}, 06:44:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:44:03 INFO - 'talos_options': ['--xperf_path', 06:44:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:44:03 INFO - 'tests': ['tp5n']}}, 06:44:03 INFO - 'talos.zip': {'path': '', 06:44:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:44:03 INFO - Running post-action listener: _resource_record_post_action 06:44:03 INFO - [mozharness: 2017-05-16 13:44:03.252395Z] Finished populate-webroot step (success) 06:44:03 INFO - [mozharness: 2017-05-16 13:44:03.252485Z] Running create-virtualenv step. 06:44:03 INFO - Running pre-action listener: _resource_record_pre_action 06:44:03 INFO - Running main action method: create_virtualenv 06:44:03 INFO - Creating virtualenv /builds/slave/test/build/venv 06:44:03 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 06:44:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:44:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:44:03 INFO - Using real prefix '/usr' 06:44:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:44:03 INFO - Installing distribute.............................................................................................................................................................................................done. 06:44:05 INFO - Installing pip.................done. 06:44:05 INFO - Return code: 0 06:44:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:44:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:44:06 INFO - Reading from file tmpfile_stdout 06:44:06 INFO - Output received: 06:44:06 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) 06:44:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:06 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 0x10761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1243a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e95c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e67a0>, '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 0x13e76a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e7b30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223', '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 06:44:06 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 06:44:06 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 06:44:06 INFO - Using env: {'DISPLAY': ':0', 06:44:06 INFO - 'HOME': '/home/cltbld', 06:44:06 INFO - 'LANG': 'en_US.UTF-8', 06:44:06 INFO - 'LANGUAGE': 'en_US:en', 06:44:06 INFO - 'LOGNAME': 'cltbld', 06:44:06 INFO - 'MAIL': '/var/mail/cltbld', 06:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:06 INFO - 'MOZ_NO_REMOTE': '1', 06:44:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:06 INFO - 'NO_EM_RESTART': '1', 06:44:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:06 INFO - 'PWD': '/builds/slave/test', 06:44:06 INFO - 'SHELL': '/bin/bash', 06:44:06 INFO - 'SHLVL': '1', 06:44:06 INFO - 'TERM': 'linux', 06:44:06 INFO - 'TMOUT': '86400', 06:44:06 INFO - 'USER': 'cltbld', 06:44:06 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223', 06:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:06 INFO - '_': '/tools/buildbot/bin/python'} 06:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:06 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 06:44:06 INFO - Cleaning up... 06:44:06 INFO - Return code: 0 06:44:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:06 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 0x10761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1243a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e95c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e67a0>, '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 0x13e76a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e7b30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223', '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 06:44:06 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 06:44:06 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 06:44:06 INFO - Using env: {'DISPLAY': ':0', 06:44:06 INFO - 'HOME': '/home/cltbld', 06:44:06 INFO - 'LANG': 'en_US.UTF-8', 06:44:06 INFO - 'LANGUAGE': 'en_US:en', 06:44:06 INFO - 'LOGNAME': 'cltbld', 06:44:06 INFO - 'MAIL': '/var/mail/cltbld', 06:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:06 INFO - 'MOZ_NO_REMOTE': '1', 06:44:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:06 INFO - 'NO_EM_RESTART': '1', 06:44:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:06 INFO - 'PWD': '/builds/slave/test', 06:44:06 INFO - 'SHELL': '/bin/bash', 06:44:06 INFO - 'SHLVL': '1', 06:44:06 INFO - 'TERM': 'linux', 06:44:06 INFO - 'TMOUT': '86400', 06:44:06 INFO - 'USER': 'cltbld', 06:44:06 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223', 06:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:06 INFO - '_': '/tools/buildbot/bin/python'} 06:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:06 INFO - Downloading/unpacking psutil>=3.1.1 06:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:44:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:44:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:44:07 INFO - Installing collected packages: psutil 06:44:07 INFO - Running setup.py install for psutil 06:44:07 INFO - building 'psutil._psutil_linux' extension 06:44:07 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 06:44:07 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 06:44:07 INFO - building 'psutil._psutil_posix' extension 06:44:07 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 06:44:08 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 06:44:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:44:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:44:08 INFO - Successfully installed psutil 06:44:08 INFO - Cleaning up... 06:44:08 INFO - Return code: 0 06:44:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:44:08 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')]} 06:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:08 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')]} 06:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:08 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 0x10761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1243a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e95c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e67a0>, '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 0x13e76a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e7b30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223', '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 06:44:08 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 06:44:08 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 06:44:08 INFO - Using env: {'DISPLAY': ':0', 06:44:08 INFO - 'HOME': '/home/cltbld', 06:44:08 INFO - 'LANG': 'en_US.UTF-8', 06:44:08 INFO - 'LANGUAGE': 'en_US:en', 06:44:08 INFO - 'LOGNAME': 'cltbld', 06:44:08 INFO - 'MAIL': '/var/mail/cltbld', 06:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:08 INFO - 'MOZ_NO_REMOTE': '1', 06:44:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:08 INFO - 'NO_EM_RESTART': '1', 06:44:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:08 INFO - 'PWD': '/builds/slave/test', 06:44:08 INFO - 'SHELL': '/bin/bash', 06:44:08 INFO - 'SHLVL': '1', 06:44:08 INFO - 'TERM': 'linux', 06:44:08 INFO - 'TMOUT': '86400', 06:44:08 INFO - 'USER': 'cltbld', 06:44:08 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223', 06:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:08 INFO - '_': '/tools/buildbot/bin/python'} 06:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:44:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:44:09 INFO - Installing collected packages: mozsystemmonitor 06:44:09 INFO - Running setup.py install for mozsystemmonitor 06:44:09 INFO - Successfully installed mozsystemmonitor 06:44:09 INFO - Cleaning up... 06:44:09 INFO - Return code: 0 06:44:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:44: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')]} 06:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44: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')]} 06:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44: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', '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 0x10761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1243a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e95c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e67a0>, '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 0x13e76a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e7b30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223', '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 06:44: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:44: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 jsonschema==2.5.1 06:44:09 INFO - Using env: {'DISPLAY': ':0', 06:44:09 INFO - 'HOME': '/home/cltbld', 06:44:09 INFO - 'LANG': 'en_US.UTF-8', 06:44:09 INFO - 'LANGUAGE': 'en_US:en', 06:44:09 INFO - 'LOGNAME': 'cltbld', 06:44:09 INFO - 'MAIL': '/var/mail/cltbld', 06:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:09 INFO - 'MOZ_NO_REMOTE': '1', 06:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:09 INFO - 'NO_EM_RESTART': '1', 06:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:09 INFO - 'PWD': '/builds/slave/test', 06:44:09 INFO - 'SHELL': '/bin/bash', 06:44:09 INFO - 'SHLVL': '1', 06:44:09 INFO - 'TERM': 'linux', 06:44:09 INFO - 'TMOUT': '86400', 06:44:09 INFO - 'USER': 'cltbld', 06:44:09 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223', 06:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:09 INFO - '_': '/tools/buildbot/bin/python'} 06:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:09 INFO - Downloading/unpacking jsonschema==2.5.1 06:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:44:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:44: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 06:44: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 06:44: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 06:44: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 06:44:11 INFO - Downloading functools32-3.2.3-2.tar.gz 06:44:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:44:11 INFO - warning: no files found matching '*.txt' 06:44:11 INFO - no previously-included directories found matching 'build' 06:44:11 INFO - no previously-included directories found matching 'dist' 06:44:11 INFO - no previously-included directories found matching '.git*' 06:44:11 INFO - Installing collected packages: jsonschema, functools32 06:44:11 INFO - Running setup.py install for functools32 06:44:11 INFO - warning: no files found matching '*.txt' 06:44:11 INFO - no previously-included directories found matching 'build' 06:44:11 INFO - no previously-included directories found matching 'dist' 06:44:11 INFO - no previously-included directories found matching '.git*' 06:44:11 INFO - Successfully installed jsonschema functools32 06:44:11 INFO - Cleaning up... 06:44:11 INFO - Return code: 0 06:44:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:11 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 0x10761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1243a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e95c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e67a0>, '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 0x13e76a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e7b30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223', '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 06:44:11 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 06:44:11 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 06:44:11 INFO - Using env: {'DISPLAY': ':0', 06:44:11 INFO - 'HOME': '/home/cltbld', 06:44:11 INFO - 'LANG': 'en_US.UTF-8', 06:44:11 INFO - 'LANGUAGE': 'en_US:en', 06:44:11 INFO - 'LOGNAME': 'cltbld', 06:44:11 INFO - 'MAIL': '/var/mail/cltbld', 06:44:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:11 INFO - 'MOZ_NO_REMOTE': '1', 06:44:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:11 INFO - 'NO_EM_RESTART': '1', 06:44:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:11 INFO - 'PWD': '/builds/slave/test', 06:44:11 INFO - 'SHELL': '/bin/bash', 06:44:11 INFO - 'SHLVL': '1', 06:44:11 INFO - 'TERM': 'linux', 06:44:11 INFO - 'TMOUT': '86400', 06:44:11 INFO - 'USER': 'cltbld', 06:44:11 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223', 06:44:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:11 INFO - '_': '/tools/buildbot/bin/python'} 06:44:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:44:11 INFO - Cleaning up... 06:44:11 INFO - Return code: 0 06:44:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:11 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 0x10761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1243a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e95c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e67a0>, '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 0x13e76a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e7b30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223', '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 06:44:11 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 06:44:11 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 06:44:11 INFO - Using env: {'DISPLAY': ':0', 06:44:11 INFO - 'HOME': '/home/cltbld', 06:44:11 INFO - 'LANG': 'en_US.UTF-8', 06:44:11 INFO - 'LANGUAGE': 'en_US:en', 06:44:11 INFO - 'LOGNAME': 'cltbld', 06:44:11 INFO - 'MAIL': '/var/mail/cltbld', 06:44:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:11 INFO - 'MOZ_NO_REMOTE': '1', 06:44:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:11 INFO - 'NO_EM_RESTART': '1', 06:44:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:11 INFO - 'PWD': '/builds/slave/test', 06:44:11 INFO - 'SHELL': '/bin/bash', 06:44:11 INFO - 'SHLVL': '1', 06:44:11 INFO - 'TERM': 'linux', 06:44:11 INFO - 'TMOUT': '86400', 06:44:11 INFO - 'USER': 'cltbld', 06:44:11 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223', 06:44:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:11 INFO - '_': '/tools/buildbot/bin/python'} 06:44:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:11 INFO - Downloading/unpacking blobuploader==1.2.4 06:44:11 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 06:44:11 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 06:44:11 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 06:44:11 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 06:44:12 INFO - Downloading blobuploader-1.2.4.tar.gz 06:44:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:44:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:44: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 06:44: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 06:44: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 06:44: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 06:44:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:44:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:44: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 06:44: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 06:44: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 06:44: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 06:44:13 INFO - Downloading docopt-0.6.1.tar.gz 06:44:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:44:13 INFO - Installing collected packages: blobuploader, requests, docopt 06:44:13 INFO - Running setup.py install for blobuploader 06:44:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:44:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:44:13 INFO - Running setup.py install for requests 06:44:13 INFO - Running setup.py install for docopt 06:44:13 INFO - Successfully installed blobuploader requests docopt 06:44:13 INFO - Cleaning up... 06:44:14 INFO - Return code: 0 06:44:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:14 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 0x10761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1243a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e95c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e67a0>, '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 0x13e76a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e7b30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223', '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 06:44:14 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 06:44:14 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 06:44:14 INFO - Using env: {'DISPLAY': ':0', 06:44:14 INFO - 'HOME': '/home/cltbld', 06:44:14 INFO - 'LANG': 'en_US.UTF-8', 06:44:14 INFO - 'LANGUAGE': 'en_US:en', 06:44:14 INFO - 'LOGNAME': 'cltbld', 06:44:14 INFO - 'MAIL': '/var/mail/cltbld', 06:44:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:14 INFO - 'MOZ_NO_REMOTE': '1', 06:44:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:14 INFO - 'NO_EM_RESTART': '1', 06:44:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:14 INFO - 'PWD': '/builds/slave/test', 06:44:14 INFO - 'SHELL': '/bin/bash', 06:44:14 INFO - 'SHLVL': '1', 06:44:14 INFO - 'TERM': 'linux', 06:44:14 INFO - 'TMOUT': '86400', 06:44:14 INFO - 'USER': 'cltbld', 06:44:14 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223', 06:44:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:14 INFO - '_': '/tools/buildbot/bin/python'} 06:44:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:44:14 INFO - Running setup.py (path:/tmp/pip-DFZJbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:44:14 INFO - Running setup.py (path:/tmp/pip-DTepEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:44:14 INFO - Running setup.py (path:/tmp/pip-ZBFjgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:44:14 INFO - Running setup.py (path:/tmp/pip-F50Tqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:44:14 INFO - Running setup.py (path:/tmp/pip-vlO3HF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:44:14 INFO - Running setup.py (path:/tmp/pip-DsEsxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:44:14 INFO - Running setup.py (path:/tmp/pip-k_VVR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:44:14 INFO - Running setup.py (path:/tmp/pip-Rjka_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:44:14 INFO - Running setup.py (path:/tmp/pip-zbzZJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:44:14 INFO - Running setup.py (path:/tmp/pip-kYZcH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:44:14 INFO - Running setup.py (path:/tmp/pip-5NIzlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:44:15 INFO - Running setup.py (path:/tmp/pip-DBOJIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:44:15 INFO - Running setup.py (path:/tmp/pip-jizsox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:44:15 INFO - Running setup.py (path:/tmp/pip-zGQtje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:44:15 INFO - Running setup.py (path:/tmp/pip-OS7xeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:44:15 INFO - Running setup.py (path:/tmp/pip-qPs6Ep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:44:15 INFO - Running setup.py (path:/tmp/pip-IrO0wV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:44:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:44:15 INFO - Running setup.py install for manifestparser 06:44:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:44:15 INFO - Running setup.py install for mozcrash 06:44:15 INFO - Running setup.py install for mozdebug 06:44:15 INFO - Running setup.py install for mozdevice 06:44:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:44:15 INFO - Running setup.py install for mozfile 06:44:15 INFO - Running setup.py install for mozhttpd 06:44:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:44:16 INFO - Running setup.py install for mozinfo 06:44:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:44:16 INFO - Running setup.py install for mozInstall 06:44:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:44:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:44:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:44:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:44:16 INFO - Running setup.py install for mozleak 06:44:16 INFO - Running setup.py install for mozlog 06:44:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:44:16 INFO - Running setup.py install for moznetwork 06:44:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:44:16 INFO - Running setup.py install for mozprocess 06:44:16 INFO - Running setup.py install for mozprofile 06:44:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:44:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:44:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:44:16 INFO - Running setup.py install for mozrunner 06:44:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:44:16 INFO - Running setup.py install for mozscreenshot 06:44:17 INFO - Running setup.py install for moztest 06:44:17 INFO - Running setup.py install for mozversion 06:44:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:44:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:44:17 INFO - Cleaning up... 06:44:17 INFO - Return code: 0 06:44:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:44: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')]} 06:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44: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')]} 06:44:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:17 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 0x10761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1243a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e95c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e67a0>, '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 0x13e76a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e7b30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223', '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 06:44:17 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 06:44:17 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 06:44:17 INFO - Using env: {'DISPLAY': ':0', 06:44:17 INFO - 'HOME': '/home/cltbld', 06:44:17 INFO - 'LANG': 'en_US.UTF-8', 06:44:17 INFO - 'LANGUAGE': 'en_US:en', 06:44:17 INFO - 'LOGNAME': 'cltbld', 06:44:17 INFO - 'MAIL': '/var/mail/cltbld', 06:44:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:17 INFO - 'MOZ_NO_REMOTE': '1', 06:44:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:17 INFO - 'NO_EM_RESTART': '1', 06:44:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:17 INFO - 'PWD': '/builds/slave/test', 06:44:17 INFO - 'SHELL': '/bin/bash', 06:44:17 INFO - 'SHLVL': '1', 06:44:17 INFO - 'TERM': 'linux', 06:44:17 INFO - 'TMOUT': '86400', 06:44:17 INFO - 'USER': 'cltbld', 06:44:17 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223', 06:44:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:17 INFO - '_': '/tools/buildbot/bin/python'} 06:44:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:44:17 INFO - Running setup.py (path:/tmp/pip-xwYrvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:44:17 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)) 06:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:44:17 INFO - Running setup.py (path:/tmp/pip-reXuLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:44:17 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)) 06:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:44:17 INFO - Running setup.py (path:/tmp/pip-wgOR3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:44:17 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)) 06:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:44:17 INFO - Running setup.py (path:/tmp/pip-9wlKDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:44:17 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)) 06:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:44:17 INFO - Running setup.py (path:/tmp/pip-l1cTcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:44:17 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)) 06:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:44:17 INFO - Running setup.py (path:/tmp/pip-yCD1_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:44:17 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)) 06:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:44:17 INFO - Running setup.py (path:/tmp/pip-8dQx3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:44:17 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)) 06:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:44:17 INFO - Running setup.py (path:/tmp/pip-2xI35b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:44:18 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)) 06:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:44:18 INFO - Running setup.py (path:/tmp/pip-UBjekZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:44:18 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)) 06:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:44:18 INFO - Running setup.py (path:/tmp/pip-V7qJm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:44:18 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)) 06:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:44:18 INFO - Running setup.py (path:/tmp/pip-GrB6HU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:44:18 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)) 06:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:44:18 INFO - Running setup.py (path:/tmp/pip-Fr1d8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:44:18 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)) 06:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:44:18 INFO - Running setup.py (path:/tmp/pip-8t1UPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:44:18 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)) 06:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:44:18 INFO - Running setup.py (path:/tmp/pip-ly0dWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:44:18 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)) 06:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:44:18 INFO - Running setup.py (path:/tmp/pip-Yv8Ddr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:44:18 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)) 06:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:44:18 INFO - Running setup.py (path:/tmp/pip-ibLEsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:44:18 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)) 06:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:44:18 INFO - Running setup.py (path:/tmp/pip-TaRev_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:44:18 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)) 06:44:18 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)) 06:44:18 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)) 06:44:18 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)) 06:44:18 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)) 06:44:18 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)) 06:44:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:19 INFO - Downloading blessings-1.6.tar.gz 06:44:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:44:19 INFO - Installing collected packages: blessings 06:44:19 INFO - Running setup.py install for blessings 06:44:19 INFO - Successfully installed blessings 06:44:19 INFO - Cleaning up... 06:44:20 INFO - Return code: 0 06:44:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:44:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:44:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:44:20 INFO - Reading from file tmpfile_stdout 06:44:20 INFO - Current package versions: 06:44:20 INFO - argparse == 1.2.1 06:44:20 INFO - blessings == 1.6 06:44:20 INFO - blobuploader == 1.2.4 06:44:20 INFO - docopt == 0.6.1 06:44:20 INFO - functools32 == 3.2.3-2 06:44:20 INFO - jsonschema == 2.5.1 06:44:20 INFO - manifestparser == 1.1 06:44:20 INFO - mozInstall == 1.12 06:44:20 INFO - mozcrash == 1.0 06:44:20 INFO - mozdebug == 0.1 06:44:20 INFO - mozdevice == 0.50 06:44:20 INFO - mozfile == 1.2 06:44:20 INFO - mozhttpd == 0.7 06:44:20 INFO - mozinfo == 0.9 06:44:20 INFO - mozleak == 0.1 06:44:20 INFO - mozlog == 3.4 06:44:20 INFO - moznetwork == 0.27 06:44:20 INFO - mozprocess == 0.25 06:44:20 INFO - mozprofile == 0.28 06:44:20 INFO - mozrunner == 6.13 06:44:20 INFO - mozscreenshot == 0.1 06:44:20 INFO - mozsystemmonitor == 0.3 06:44:20 INFO - moztest == 0.8 06:44:20 INFO - mozversion == 1.4 06:44:20 INFO - psutil == 3.1.1 06:44:20 INFO - requests == 1.2.3 06:44:20 INFO - wsgiref == 0.1.2 06:44:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:44:20 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')]} 06:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:20 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')]} 06:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:20 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 0x10761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1243a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e95c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e67a0>, '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 0x13e76a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e7b30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223', '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 06:44:20 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 06:44:20 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 06:44:20 INFO - Using env: {'DISPLAY': ':0', 06:44:20 INFO - 'HOME': '/home/cltbld', 06:44:20 INFO - 'LANG': 'en_US.UTF-8', 06:44:20 INFO - 'LANGUAGE': 'en_US:en', 06:44:20 INFO - 'LOGNAME': 'cltbld', 06:44:20 INFO - 'MAIL': '/var/mail/cltbld', 06:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:20 INFO - 'MOZ_NO_REMOTE': '1', 06:44:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:20 INFO - 'NO_EM_RESTART': '1', 06:44:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:20 INFO - 'PWD': '/builds/slave/test', 06:44:20 INFO - 'SHELL': '/bin/bash', 06:44:20 INFO - 'SHLVL': '1', 06:44:20 INFO - 'TERM': 'linux', 06:44:20 INFO - 'TMOUT': '86400', 06:44:20 INFO - 'USER': 'cltbld', 06:44:20 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223', 06:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:20 INFO - '_': '/tools/buildbot/bin/python'} 06:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:20 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)) 06:44:20 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)) 06:44:20 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)) 06:44:20 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)) 06:44:20 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)) 06:44:20 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)) 06:44:20 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)) 06:44:20 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)) 06:44:20 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)) 06:44:20 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)) 06:44:20 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)) 06:44:20 INFO - Cleaning up... 06:44:20 INFO - Return code: 0 06:44:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:44:20 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')]} 06:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:20 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')]} 06:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:20 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 0x10761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1243a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e95c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e67a0>, '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 0x13e76a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e7b30>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223', '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 06:44:20 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 06:44:20 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 06:44:20 INFO - Using env: {'DISPLAY': ':0', 06:44:20 INFO - 'HOME': '/home/cltbld', 06:44:20 INFO - 'LANG': 'en_US.UTF-8', 06:44:20 INFO - 'LANGUAGE': 'en_US:en', 06:44:20 INFO - 'LOGNAME': 'cltbld', 06:44:20 INFO - 'MAIL': '/var/mail/cltbld', 06:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:20 INFO - 'MOZ_NO_REMOTE': '1', 06:44:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:20 INFO - 'NO_EM_RESTART': '1', 06:44:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:20 INFO - 'PWD': '/builds/slave/test', 06:44:20 INFO - 'SHELL': '/bin/bash', 06:44:20 INFO - 'SHLVL': '1', 06:44:20 INFO - 'TERM': 'linux', 06:44:20 INFO - 'TMOUT': '86400', 06:44:20 INFO - 'USER': 'cltbld', 06:44:20 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223', 06:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:20 INFO - '_': '/tools/buildbot/bin/python'} 06:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:44:20 INFO - Cleaning up... 06:44:20 INFO - Return code: 0 06:44:20 INFO - Running post-action listener: _resource_record_post_action 06:44:20 INFO - Running post-action listener: _start_resource_monitoring 06:44:20 INFO - Starting resource monitoring. 06:44:20 INFO - [mozharness: 2017-05-16 13:44:20.720997Z] Finished create-virtualenv step (success) 06:44:20 INFO - [mozharness: 2017-05-16 13:44:20.721514Z] Running install step. 06:44:20 INFO - Running pre-action listener: _resource_record_pre_action 06:44:20 INFO - Running main action method: install 06:44:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:44:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:44:20 INFO - Reading from file tmpfile_stdout 06:44:20 INFO - Detecting whether we're running mozinstall >=1.0... 06:44:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:44:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:44:21 INFO - Reading from file tmpfile_stdout 06:44:21 INFO - Output received: 06:44:21 INFO - Usage: mozinstall [options] installer 06:44:21 INFO - Options: 06:44:21 INFO - -h, --help show this help message and exit 06:44:21 INFO - -d DEST, --destination=DEST 06:44:21 INFO - Directory to install application into. [default: 06:44:21 INFO - "/builds/slave/test"] 06:44:21 INFO - --app=APP Application being installed. [default: firefox] 06:44:21 INFO - mkdir: /builds/slave/test/build/application 06:44:21 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'] 06:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:44:37 INFO - Reading from file tmpfile_stdout 06:44:37 INFO - Output received: 06:44:37 INFO - /builds/slave/test/build/application/firefox/firefox 06:44:37 INFO - Running post-action listener: _resource_record_post_action 06:44:37 INFO - [mozharness: 2017-05-16 13:44:37.356472Z] Finished install step (success) 06:44:37 INFO - [mozharness: 2017-05-16 13:44:37.356754Z] Running run-tests step. 06:44:37 INFO - Running pre-action listener: _resource_record_pre_action 06:44:37 INFO - Running main action method: run_tests 06:44:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:44:37 INFO - Python 2.7.3 06:44:37 INFO - Return code: 0 06:44:37 INFO - grabbing minidump binary from tooltool 06:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:37 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 0x13e67a0>, '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 0x13e76a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e7b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:44:37 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 06:44:37 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 06:44:37 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 06:44:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:44:37 INFO - Return code: 0 06:44:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:44:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:44:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:44:37 INFO - ENV: RUST_BACKTRACE is now 1 06:44:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:44:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:44:37 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/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:44:37 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/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-089 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:44:37 INFO - Using env: {'DISPLAY': ':0', 06:44:37 INFO - 'HOME': '/home/cltbld', 06:44:37 INFO - 'LANG': 'en_US.UTF-8', 06:44:37 INFO - 'LANGUAGE': 'en_US:en', 06:44:37 INFO - 'LOGNAME': 'cltbld', 06:44:37 INFO - 'MAIL': '/var/mail/cltbld', 06:44:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:44:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:37 INFO - 'MOZ_NO_REMOTE': '1', 06:44:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:44:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:37 INFO - 'NO_EM_RESTART': '1', 06:44:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:37 INFO - 'PWD': '/builds/slave/test', 06:44:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:44:37 INFO - 'RUST_BACKTRACE': '1', 06:44:37 INFO - 'SHELL': '/bin/bash', 06:44:37 INFO - 'SHLVL': '1', 06:44:37 INFO - 'TERM': 'linux', 06:44:37 INFO - 'TMOUT': '86400', 06:44:37 INFO - 'USER': 'cltbld', 06:44:37 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223', 06:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:37 INFO - '_': '/tools/buildbot/bin/python'} 06:44:37 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/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:44:37 INFO - mozversion application_buildid: 20170516130508 06:44:37 INFO - mozversion application_changeset: b9a4a6e2292e923684c2d25b78addaca23c6abd5 06:44:37 INFO - mozversion application_display_name: Nightly 06:44:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:44:37 INFO - mozversion application_name: Firefox 06:44:37 INFO - mozversion application_remotingname: firefox 06:44:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:44:37 INFO - mozversion application_vendor: Mozilla 06:44:37 INFO - mozversion application_version: 55.0a1 06:44:37 INFO - mozversion platform_buildid: 20170516130508 06:44:37 INFO - mozversion platform_changeset: b9a4a6e2292e923684c2d25b78addaca23c6abd5 06:44:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:44:37 INFO - mozversion platform_version: 55.0a1 06:44:37 INFO - using testdate: 1494942277 06:44:37 INFO - actual date: 1494942277 06:44:37 INFO - starting webserver on 'localhost:49496' 06:44:37 INFO - SUITE-START | Running 2 tests 06:44:37 INFO - TEST-START | dromaeo_css 06:44:37 INFO - operating with platform_type : linux_ 06:44:37 INFO - Initialising browser for dromaeo_css test... 06:44:37 INFO - TEST-INFO | started process 11439 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy5WevJ/profile http://localhost:49496/getInfo.html) 06:44:38 INFO - PID 11439 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2930: String.localeCompare is deprecated; use String.prototype.localeCompare instead 06:44:41 INFO - PID 11439 | __metrics Screen width/height:1600/1200 06:44:41 INFO - PID 11439 | colorDepth:24 06:44:41 INFO - PID 11439 | Browser inner width/height: 1024/695 06:44:41 INFO - PID 11439 | __metrics 06:44:44 INFO - TEST-INFO | 11439: exit 0 06:44:44 INFO - Browser initialized. 06:44:44 INFO - Running cycle 1/1 for dromaeo_css test... 06:44:44 INFO - TEST-INFO | started process 11626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy5WevJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:44:55 INFO - PID 11626 | RSS: Main: 165629952 06:44:55 INFO - PID 11626 | 06:48:01 INFO - PID 11626 | Cycle 1(1): loaded http://localhost:49496/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49496/tests/dromaeo/cssquery-ext.html) 06:48:02 INFO - PID 11626 | RSS: Main: 171966464 06:48:02 INFO - PID 11626 | 06:51:04 INFO - PID 11626 | Cycle 1(1): loaded http://localhost:49496/tests/dromaeo/cssquery-ext.html (next: http://localhost:49496/tests/dromaeo/cssquery-jquery.html) 06:51:05 INFO - PID 11626 | RSS: Main: 171036672 06:51:05 INFO - PID 11626 | 06:54:07 INFO - PID 11626 | Cycle 1(1): loaded http://localhost:49496/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49496/tests/dromaeo/cssquery-mootools.html) 06:54:07 INFO - PID 11626 | RSS: Main: 173121536 06:54:07 INFO - PID 11626 | 06:57:09 INFO - PID 11626 | Cycle 1(1): loaded http://localhost:49496/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49496/tests/dromaeo/cssquery-prototype.html) 06:57:10 INFO - PID 11626 | RSS: Main: 170848256 06:57:10 INFO - PID 11626 | 07:00:13 INFO - PID 11626 | Cycle 1(1): loaded http://localhost:49496/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49496/tests/dromaeo/cssquery-yui.html) 07:00:13 INFO - PID 11626 | RSS: Main: 171831296 07:00:13 INFO - PID 11626 | 07:03:15 INFO - PID 11626 | Cycle 1(1): loaded http://localhost:49496/tests/dromaeo/cssquery-yui.html (next: http://localhost:49496/tests/dromaeo/cssquery-dojo.html) 07:03:16 INFO - PID 11626 | RSS: Main: 177696768 07:03:16 INFO - PID 11626 | 07:03:16 INFO - PID 11626 | __start_tp_report 07:03:16 INFO - PID 11626 | _x_x_mozilla_page_load 07:03:16 INFO - PID 11626 | _x_x_mozilla_page_load_details 07:03:16 INFO - PID 11626 | |i|pagename|runs| 07:03:16 INFO - PID 11626 | |0;dojo.html;2627.4219671672236;2658.082961378324;2688.542947698892;2692.2461710721004;2699.1092939330015;5066.1640829263215;5111.718855462953;5126.154184559553;5136.64043516954;5151.227315902616;5082.720450375228;5088.974555127228;5162.354705661793;5171.0692075426405;5177.094008548508;4551.7951692173765;4606.401167848175;4608.23964045932;4667.06658668266;4682.578567928886;4627.652926030544;4642.303654451843;4644.860654180363;4713.646476514258;4752.16837053516;4509.4814096379005;4635.130618699145;4650.162970665279;4665.976670116662;4689.155951928651;4527.4567051953645;4596.218642830693;4607.516210797851;4620.353150558891;4627.8611641650805;4502.302143167814;4534.206513860061;4577.29051996941;4613.700109492872;4656.3946686930485;5035.496450354935;5148.2020286855595;5165.535101840853;5173.327467429248;5208.479152084799;5441.537469315113;5508.228847961289;5509.393966663663;5509.807156749494;5524.751386187631;5527.640703354309;5534.723263836832;5536.169574563807;5539.446055394468;5566.025945459528;5103.668261562986;5147.922781158286;5150.330457040561;5155.948440515622;5160.535551800356;5681.119426488901;5691.174779656926;5692.459216374438;5698.544116470673;5702.144678298288;5400.054990376747;5417.620766546304;5447.046766815792;5451.100568406168;5453.045716999589;5493.2034854946605;5525.364583072998;5529.972350138304;5537.280153580089;5542.445755424506;5457.099578569491;5479.369872464637;5491.36849262332;5493.066178749622;5548.223248745179;5475.09660905954;5478.808241711521;5479.0959491683425;5479.342478902558;5489.34127904654;4690.718556886598;4717.150912835654;4722.716637001791;4753.215719406259;4769.570738633471;4058.512978442606;4094.6314831665295;4125.360569111793;4140.565240649688;4169.978355302909;4637.281221410687;4651.418572678415;4657.3246879202325;4696.5303469653445;4704.0356726870905;5480.7533660985355;5535.557155427556;5567.137093750475;5601.411851755588;5607.803726869622;4621.09888571732;4623.56076172763;4628.004978929479;4646.3495110684535;4650.930236046462;4958.826441074545;4963.925541116886;4976.950230497649;4978.153713868651;4979.875503112378;5004.47453017428;5090.236464530276;5094.337736094284;5097.898042039064;5109.948900511096;5437.728113594226;5460.2355670207;5499.807506737245;5520.06158952987;5539.833804985857;5087.771050302671;5107.080725469451;5108.514691104339;5109.616778741683;5144.845654630367;5373.328333958255;5382.542483888757;5408.107662235687;5464.508194262536;5491.450854914637;5387.191921211849;5577.498025177753;5587.525060369751;5591.27313449249;5594.664320140804;5379.838604841861;5387.81142660005;5455.645383050089;5468.152436372368;5491.890162196813;5322.494363035506;5409.756560954688;5412.566994640498;5421.83734487966;5433.972830135824;5269.6838189707205;5325.7337133143965;5326.6537675050995;5334.733263336895;5381.919271210857;5340.118880384693;5347.331583552056;5447.455254474521;5459.890802183854;5509.201165831012;5273.34083239595;5275.208718692227;5275.868103297448;5314.229436731575;5330.440303768049 07:03:16 INFO - PID 11626 | |1;ext.html;684.7534887440521;742.7177672484455;763.7479631721533;1072.2065671403163;1079.1906070447164;32595;33603.66396336036;33660.831695841516;33691.32617347652;33698.15754606136;35058.64941350586;35569;35594.64405355946;35640;35682.64317356832;6900.171979362483;6932.896006559893;7043.366097051265;7044.049053377806;7047.260037696045;7078.186008609025;7081.433485321188;7157.320054594805;7162.749303774369;7178.102737157856;7092.255313192118;7158.570485770844;7167.784966451015;7207.063081799359;7215.494915355927;7080.858382832314;7134.250903655094;7135.999999999948;7142.321479459469;7152.356287934085;6936.445084393287;7027.754028609025;7043.823904402379;7045.506814522985;7073.823154421129;32723.6727632723;32970.835145824356;32972.3405531888;33003;33051.504227436606;3001.9099427017222;3051.7406020488284;3054.7403470705017;3057.8929737459084;3058.0978611309715;24219.757802421926;24301.392465188335;24314.756852431605;24366.634500482505;24414.389640258956;3119.5632611434417;3139.5918530591107;3141.1832923439842;3149.7952633078776;3165.6359518655418;132439;133839;145702.27148864293;151236;151243.24378378148;39122.413163802565;39225.80387098046;39285.803570982534;39333.60666393357;39362;40562.79718601447;40730.79634601808;40780;40858;40993.79503102525;11481.253718508437;11685.357305348287;11687.590934317259;11694.239874408137;11700.239484433485;9257.166854983085;9266.629334826532;9277.072292770668;9294.814103717888;9302.209312208402;12755.61733148007;12869.163504372373;12927.5475358362;12947.870521294855;13136.40886160125;5246.449122842123;5305.681659100466;5330.440303768126;5457.426970168075;5466.617336786387;820.5733018830175;881.1408876345512;890.123228619809;894.4141587260355;898.1602201941075;19539.500431346474;20418;20889.37331880046;20895.268665596934;21055.368338949855;952.2144231009306;960.1118964957386;979.6816034788723;984.1536278800226;986.9901300987042;10812.297200681931;11098.778024439465;11293.548258069584;11296.717582060513;11420;170428;170676;171279;171494.14252928656;171606.14196928937;40381;40676.18647627031;40859;40865.387019194735;40947.59052409497;1123.7808627317759;1187.269829055142;1193.8149586814059;1200.6038007457519;1212.078820096733;19630.705539416635;19746.802531974496;20004.299849505198;21223.363299101053;24580.50838983246;39912.80043599763;40448.39327410032;40839;40840.59159408368;41014.38478422767;157267;158862.20568897543;159077;159685;159901;28973.7102628971;29336.706632933397;29840;30011.399772004876;30194.69805301919;35553.82223088868;35608;36107.09732256609;36380.81809591041;36624.63375366319;27931.720682793726;27992.44015119727;28560.714392855807;29285.121446356643;29544;27016.59475107914;27435.588466172623;27463.450730985667;27951;28798.856005719837;30985.845070774503;31041.68958310388;31064;31098;31128.221794454414;26714.732852671226;26816.32959176036;27411.86294068517;27683.58474622842;28389.858050709616;21613.743981536947;22520.436989075406;22651.093956242225;22661;22830.42923926915 07:03:16 INFO - PID 11626 | |2;jquery.html;410.67966985751127;426.8164689183651;434.99537817410686;441.7879417879418;442.74984633681976;16862.747058794128;17099.914500427494;17252.958660356155;17681.292748290085;17794.28822847086;16982.745258821127;17259.827401726012;17323.653526929455;17403.3038678453;17524.123793810322;5377.731113444332;5393.1370980643205;5471.261379713747;5530.778768849262;5543.722813859311;5332.520073193412;5441.374241962166;5442.836714898559;5445.646033007842;5450.890982180354;5287.233351164079;5357.973210133944;5377.220303056055;5392.649477783951;5419.051665958461;5436.755346009439;5463.69949652767;5476.726163691839;5487.835364939038;5496.367917689437;4818.819389249621;4845.612351011946;4938.777755001033;4956;4964.280179373971;21496.89251553732;21638.675419868716;21754;21767.782322176732;21914.342569722932;1680.3530640703295;1701.9829801701949;1705.2837808120496;1705.8805883588154;1706.0105139019338;14276.785848212285;14706.55880323592;14738.926305368404;14802.481913132988;14923.582259685312;1982.4052784164694;2011.3664195778429;2059.5366042640435;2064.917403303866;2065.5662310914727;80082.59958700169;80604.59697701533;80791;81543.9999999994;82094.17905820925;10580.682579522627;10714.946425267824;10957.17821163416;11104.61133860311;11201.831972520418;15252.38990440392;15262.160581168142;15263.236838158047;15263.847361526243;15264.618384540476;6699.866002679919;6941.652917354112;7019.245188702825;7090.610016449042;7172.928270717331;6097.542684298695;6149.569530132848;6276.466500347522;6277;6294.464970477469;6797.72809087631;6844.315568443116;6847.109875716125;6933.722651094001;6971;2027.5438026443933;2029.4621925189836;2034.3693455028988;2078.449210959097;2094.664853623413;848.8302339532119;884.632877355903;901.6979311930446;903.0878812399393;924.8242833861544;16490.422835200712;16622.25199866009;16624.168791560372;16806.327746889987;17471.475855724348;894.6108442827391;895.2524641923936;898.5776684958059;901.0628945896326;918.7335672654989;8787.253083487847;8933.330000249878;9296.116868897443;9335.113164249386;9336;332605;334366.5633436637;338526;338849;339456.02719863906;70825;73174;73478.6326068377;74798;75746;1020.8723909511459;1031.5976769060073;1062.2298833345917;1063.3407287481812;1070.0369667299337;13762.724745504833;14013.369398377301;14019.228942407857;14135.505257315945;14658.78011829802;35481;35819.64180358267;35948.64051359453;36341.81829090838;36627;44092.33861492016;44480.55519444764;44544.77727611341;46553;47009;8307.875381869157;8414.158584141536;8739.650413983369;8772.956135219283;8777.868331974898;12694.111412201057;13206.537771177962;13513.864861351261;13527.053106282467;13646;10723.731906702395;10798.352098874093;10818.459077045958;11130.610428634958;11409.144314176305;10041.196704263788;10402.895971040192;10737.946310268399;10881;11007.504662290055;11068.778624427627;11357.318560886373;11439.542418303176;11478;11478.196526243417;8408;8429.873551896604;8677.915260592426;8783.902012248469;8806.955965220133;11241.831372529583;11356.772864542829;11433.314001159624;11479.713007174554;11688.70778230551 07:03:16 INFO - PID 11626 | |3;mootools.html;1277.891379232765;1333.553094892042;1336.2249895060866;1348.73025394921;1358.572049804311;9963.302568820167;10078.496075196239;10544.525496352664;10595.894041059588;10614.363138211704;10321.896781032188;10594.894051059488;10626.415547144903;10653.201009924247;10653.520591573379;2305.8962346694357;2309;2321.2688003279;2330.6620540021772;2340.4499942513494;2136.1135128921555;2194.9780502194935;2195.890205489719;2197.3298144066052;2201.1745595401726;2253.1663284584642;2267.4444761033487;2292.0487997481027;2300.66640337151;2306.250468597704;2071.658176400892;2130.382189165148;2142.485803407179;2149.161826887515;2150.64514355132;1767.2577517442705;1820.1172431370774;2146.914123435061;2162.48100455891;2213.856099353537;10256.435896025716;10267.79464410715;10359.896401036043;10382;10388.065074143364;5513.641613295123;5716.942365662324;5718.34239062509;5726.627769195031;5730.971345143247;3277.2789986202997;3481.9825900870333;3493.68556829884;3569.4110471772387;3578.177019285553;1064.6167379743285;1076.4563895232857;1112.327042139502;1121.6522877907876;1126.3016929503679;15031.624209394744;15170.848291517053;15197.544073677807;15215.08709477435;15239.695206095927;4634.72191668501;4716.6698331116495;4899.191633380452;4964.751762411865;4986.576141027981;10253.282270241161;10263.332883362558;10268.845967310497;10290.228232882564;10300.433476158883;5489.066858634042;5495.065838807413;5497.367802702661;5505.724713764296;5528.253685752372;4913.582345500601;5040.445550989388;5123.974380128076;5132.178851383761;5147.253648221062;3766.773993560395;3873.9661677619474;3898.4931958845737;3931.862384816575;3985.4221137935415;1117.6535274064904;1117.6591139702468;1145.5475087340621;1147.7245461089278;1149.5976408257043;648.5622205011598;670.8792417364824;685.4927353758183;695.051255036871;699.5278187223604;4958.826441074545;5032;5150.201718733602;5196.58427325813;6594.3735345143095;816.0859836982618;829.5727700234385;840.2018082821222;841.3269384492381;847.4406891451736;3502.50964864914;3535.9469607955903;3595.7842529447794;3647.562292524861;3699;13055.412506437044;13106.868931310564;13298.202107873558;13594.456221751218;13630.659233519043;12766.553170638983;13186;13254.602361929157;13497.055206135476;13502.32488375597;7398.593077380796;7429.7399591014055;7510.84978300431;7536.962315188389;7603.163651998276;5559.138333558305;5596.804111856066;5632.605717599892;5735;5892.823215303548;11633.767324653629;11908.106891982963;11935.403229838299;12175.14773965814;12196.146269761031;12048.910238595892;12174;12278.324692142018;12352.567660131852;12366.567170149001;7732.961335193288;7947.8807817881625;8079.636416361161;8088.757337279891;8092.352611790925;9673.419594824052;9814.75463113428;9844.60621575129;9847.212223022285;9854.753631159278;8116.391270654606;8269.379796515164;8272.793180170544;8439.198276163756;8633.69782057625;7850.411219158472;8009.519428834288;8052.194780521901;8074.636641351036;8195.221453961864;7454.254574542502;7574.242575742602;7581.279778421042;7613.6573854175585;7618.123915749759;4728;5208.270842082035;5215.6609820361555;5256.264123022856;5521.1442226454965;5051.09080365523;5052.873678158076;5094.872628184176;5238.449962753856;5327.706976116351 07:03:16 INFO - PID 11626 | |4;prototype.html;367.3314567487173;375.5718480931737;380.5965676383036;388.7084686485136;395.74078978269233;5276.736163191835;5472.276232986606;5498.395176530584;5525.668459892409;5533.916991245134;5298.337707786527;5395.973020134904;5429.0227759003365;5434.972825135878;5438.8912221755545;4314.84898028569;4324.027093903862;4326.113146804897;4337.414449049385;4346.456692913386;4275.40144379787;4321.481422229337;4347.804348804311;4351.347297905308;4352.542982986788;4301.225779359714;4301.698881078326;4312.849050283241;4313.2451820931365;4319.2441322768545;4297.806598703066;4309.288967320388;4317.337824937422;4328.567143285678;4343.261645520238;3926.489556357655;3975;3978.423128646359;3981.3629819229072;3984.163325701606;5321;5321.148616221386;5326.813561525367;5345.572354211654;5380.811671591515;5139.4280974722205;5140.1004824155625;5141.2545180948555;5163.096458119851;5167.379914410295;5671.744771485293;5769.019266724625;5795.710214489301;5809.88380232393;5817.301923769175;4434.201843668138;4435.268180750172;4435.977820110911;4438.245498265303;4468.75421851798;5887.735051922674;6028.4272994065495;6037.818865434044;6041.426064523907;6143.1092491588915;4309.762963037063;4340.262155433584;4348.434703488526;4357.869263922024;4361.084172323847;4406.845760398371;4416.624586910084;4420.690551661352;4429.025614364835;4429.737524805415;4928.704277743275;4953.2570114483115;4973.5523802857915;5097.260897169889;5151.871203219949;5732.971335143297;5747.48272655463;5779.190913272145;5790.334111577138;5793.420657934257;1598.3606557377143;1617.4096454793917;1618.8381161883717;1620.586750378646;1624.8862579619313;1164.4396508678412;1177.2112684501406;1182.798924182891;1197.4431889171403;1199.1785626845638;4883.291922671264;4895.31465594817;4901.534354236342;4906.288588154769;4907.337509436252;5902.1441890926435;5906.970465147647;5913.9112913306335;5923.08192230205;5935.139404786368;4683.7892294846815;4829.855104346875;4839.201531747222;4854.563089321978;4886.853394398174;3110.688931106871;3151.2121969507625;3155.5266709993684;3165.635951865519;3169.223540232612;5264.789408423697;5450.863728406822;5478.643888147258;5494.697791621499;5496.532794712414;6106.938930610726;6110.938890611126;6124.418180272867;6132.448079672851;6150.157350517026;5396.541293990055;5428.158635411518;5438.193264714716;5452.754626041838;5462.426445223274;5790.681512516852;5931.466168044896;5968.552358573212;5976.910346344721;5985;5662.150677398258;5856.765729370948;5880.470757631833;5895;5895.115732640138;5433.728313584384;5436.0486914790545;5459.099248624091;5469.234307196916;5481.123020316731;4059.6346328830546;4093.0790572122223;4095.488063992001;4109.3425051991535;4112.532480511669;5880.94119058804;5934.554908381975;5949.940500594938;5967.985442474703;5995.940040599538;5733.8566535836935;5758.625689330348;5763.801090394703;5772.3650398456975;5782.335031471266;5742.5118864895285;5751.396103409082;5753.252077229933;5774.538036957118;5776.021817418951;5460.6177567569885;5608.635438696471;5684.9431505684415;5685.431456854281;5693.800716974886;5826.592138550431;5827.358990510956;5836.854078648068;5839.708014599168;5842.912356314574;5537.473939975695;5578.3584887738425;5645.68948707825;5646;5677.290338707661 07:03:16 INFO - PID 11626 | |5;yui.html;728.4136270302405;751.8609057324395;752.2590248605123;759.5025258455713;768.5119948832489;11745.70635734107;12305.753884922296;12984.805227921577;14149.575512734622;14163.716725665494;13758.793618095737;14044.789328160086;14100.506482273096;14184.787228191559;14212.644683882909;824.9381296402779;832.8459235041537;834.1033389106734;834.3200291762224;838.6100463284572;852.8848605438279;856.3791251342789;857.8027053777635;858.1418581418582;859.1065292096213;894.8165626046678;900.4192295969096;901.1574178143456;907.4963395315597;935.6444551070617;894.4141587260355;897.5018864530183;901.328510259854;902.7246689759621;925.1118925831211;652.8106849013781;655.0796131435341;657.1457105762537;668.3249917583275;683.723092147681;12674.42965066565;13035.41340639664;13082.280474573894;13557;13759.518416855362;14075;14390.496332628412;14548.1998490083;14558.344874480674;14638.634034149125;12222.449989750483;12334.5066197352;12379.93810030944;12393.194442361308;12434.316112613802;3002.279452931303;3035.8026728262594;3054.831984240866;3057.2815388383933;3059.2198989257595;65281;65424;65802.67098664476;66066.66966665184;66842.66578667125;12316.81524777129;12531.686707832378;12614.747705045847;12674.873251267369;12792.360381980863;21185.15259389638;21334.679979800316;21490.57018859645;21513.89243053806;21629.675554866688;6078.544109191828;6256.499480041677;6298.0552917062805;6305.96847015762;6306.716197771111;2792.567152091429;2851.6292881925215;2855.157728470106;2861.9284517887218;2868.139558132552;3303.6861498157637;3346.7322614190807;3377.3751855906735;3386.9661303387143;3462.913427164341;735.2316828913798;741.7181471040969;747.8541684371604;751.6918063593901;751.7256201486418;542.2273260603624;556.1713047559108;559.1026402623811;561.430148399375;566.6373520946597;9332.533373331305;9360.578773955189;9540.427574345422;10118.01518552029;10445.738856528647;552.4751486088152;554.260062816137;558.0763835851672;561.4750208555014;571.5113577890844;4185.309423945076;4214.957850421518;4814.5907597853875;4976.2286845539;5189.221616757441;59745;60504.69747651322;61585.69207154025;62842.37157628365;65159.67420162869;54909;55693.7215313929;56018.15972760412;56460.71769641126;56863;51815.74092129515;51915.22127168095;52259;52479.73760131175;53308.20037699438;9960.850587241051;10360.274780765274;10573.52419141156;10670.57317707314;10854.240203185702;26298.474030519665;26372.8681356592;26704.732952670223;26705.866470667523;27269.863650682415;32838.83580582082;32850;33231.33537329288;33432;33591.976722095125;12936.417861196456;13007.869921301044;13185.736285274432;13247.867521324664;13396.665083372995;13807.654808629864;13883;13883.930580347438;14619.853801462275;14953.551393458214;13643.795343069663;13907.652308691959;13977.44090236379;13990.860091399363;14069.788953165915;13477.056606037484;13500.729985400434;13748.106373085717;13748.381322840696;13993.580192594238;12742.74514509686;12937.159084659466;13144.40850161726;13168.60494185176;13348.332583370986;10188.541515631667;10866.293690910066;11158.49786759614;11224.438778060901;11670.591529296435;11335.979761821476;11576.479058442223;11837.881621184022;11899.702507437383;11918.642440726791 07:03:16 INFO - PID 11626 | __end_tp_report 07:03:16 INFO - PID 11626 | __start_cc_report 07:03:16 INFO - PID 11626 | _x_x_mozilla_cycle_collect,298 07:03:16 INFO - PID 11626 | __end_cc_report 07:03:16 INFO - PID 11626 | __startTimestamp1494943396035__endTimestamp 07:03:16 INFO - PID 11626 | 07:03:16 INFO - PID 11626 | ------- Summary: start ------- 07:03:16 INFO - PID 11626 | Number of tests: 6 07:03:16 INFO - PID 11626 | 07:03:16 INFO - PID 11626 | [#0] dojo.html Cycles:165 Average:5066.70 Median:5173.33 stddev:577.72 (11.2%) stddev-sans-first:546.89 07:03:16 INFO - PID 11626 | Values: 2627.4 2658.1 2688.5 2692.2 2699.1 5066.2 5111.7 5126.2 5136.6 5151.2 5082.7 5089.0 5162.4 5171.1 5177.1 4551.8 4606.4 4608.2 4667.1 4682.6 4627.7 4642.3 4644.9 4713.6 4752.2 4509.5 4635.1 4650.2 4666.0 4689.2 4527.5 4596.2 4607.5 4620.4 4627.9 4502.3 4534.2 4577.3 4613.7 4656.4 5035.5 5148.2 5165.5 5173.3 5208.5 5441.5 5508.2 5509.4 5509.8 5524.8 5527.6 5534.7 5536.2 5539.4 5566.0 5103.7 5147.9 5150.3 5155.9 5160.5 5681.1 5691.2 5692.5 5698.5 5702.1 5400.1 5417.6 5447.0 5451.1 5453.0 5493.2 5525.4 5530.0 5537.3 5542.4 5457.1 5479.4 5491.4 5493.1 5548.2 5475.1 5478.8 5479.1 5479.3 5489.3 4690.7 4717.2 4722.7 4753.2 4769.6 4058.5 4094.6 4125.4 4140.6 4170.0 4637.3 4651.4 4657.3 4696.5 4704.0 5480.8 5535.6 5567.1 5601.4 5607.8 4621.1 4623.6 4628.0 4646.3 4650.9 4958.8 4963.9 4977.0 4978.2 4979.9 5004.5 5090.2 5094.3 5097.9 5109.9 5437.7 5460.2 5499.8 5520.1 5539.8 5087.8 5107.1 5108.5 5109.6 5144.8 5373.3 5382.5 5408.1 5464.5 5491.5 5387.2 5577.5 5587.5 5591.3 5594.7 5379.8 5387.8 5455.6 5468.2 5491.9 5322.5 5409.8 5412.6 5421.8 5434.0 5269.7 5325.7 5326.7 5334.7 5381.9 5340.1 5347.3 5447.5 5459.9 5509.2 5273.3 5275.2 5275.9 5314.2 5330.4 07:03:16 INFO - PID 11626 | 07:03:16 INFO - PID 11626 | [#1] ext.html Cycles:180 Average:30587.83 Median:3157.72 stddev:40801.21 (1292.1%) stddev-sans-first:40853.88 07:03:16 INFO - PID 11626 | Values: 684.8 742.7 763.7 1072.2 1079.2 32595.0 33603.7 33660.8 33691.3 33698.2 35058.6 35569.0 35594.6 35640.0 35682.6 6900.2 6932.9 7043.4 7044.0 7047.3 7078.2 7081.4 7157.3 7162.7 7178.1 7092.3 7158.6 7167.8 7207.1 7215.5 7080.9 7134.3 7136.0 7142.3 7152.4 6936.4 7027.8 7043.8 7045.5 7073.8 32723.7 32970.8 32972.3 33003.0 33051.5 3001.9 3051.7 3054.7 3057.9 3058.1 24219.8 24301.4 24314.8 24366.6 24414.4 3119.6 3139.6 3141.2 3149.8 3165.6 132439.0 133839.0 145702.3 151236.0 151243.2 39122.4 39225.8 39285.8 39333.6 39362.0 40562.8 40730.8 40780.0 40858.0 40993.8 11481.3 11685.4 11687.6 11694.2 11700.2 9257.2 9266.6 9277.1 9294.8 9302.2 12755.6 12869.2 12927.5 12947.9 13136.4 5246.4 5305.7 5330.4 5457.4 5466.6 820.6 881.1 890.1 894.4 898.2 19539.5 20418.0 20889.4 20895.3 21055.4 952.2 960.1 979.7 984.2 987.0 10812.3 11098.8 11293.5 11296.7 11420.0 170428.0 170676.0 171279.0 171494.1 171606.1 40381.0 40676.2 40859.0 40865.4 40947.6 1123.8 1187.3 1193.8 1200.6 1212.1 19630.7 19746.8 20004.3 21223.4 24580.5 39912.8 40448.4 40839.0 40840.6 41014.4 157267.0 158862.2 159077.0 159685.0 159901.0 28973.7 29336.7 29840.0 30011.4 30194.7 35553.8 35608.0 36107.1 36380.8 36624.6 27931.7 27992.4 28560.7 29285.1 29544.0 27016.6 27435.6 27463.5 27951.0 28798.9 30985.8 31041.7 31064.0 31098.0 31128.2 26714.7 26816.3 27411.9 27683.6 28389.9 21613.7 22520.4 22651.1 22661.0 22830.4 07:03:16 INFO - PID 11626 | 07:03:16 INFO - PID 11626 | [#2] jquery.html Cycles:180 Average:23354.26 Median:35650.32 stddev:56041.91 (157.2%) stddev-sans-first:56172.65 07:03:16 INFO - PID 11626 | Values: 410.7 426.8 435.0 441.8 442.7 16862.7 17099.9 17253.0 17681.3 17794.3 16982.7 17259.8 17323.7 17403.3 17524.1 5377.7 5393.1 5471.3 5530.8 5543.7 5332.5 5441.4 5442.8 5445.6 5450.9 5287.2 5358.0 5377.2 5392.6 5419.1 5436.8 5463.7 5476.7 5487.8 5496.4 4818.8 4845.6 4938.8 4956.0 4964.3 21496.9 21638.7 21754.0 21767.8 21914.3 1680.4 1702.0 1705.3 1705.9 1706.0 14276.8 14706.6 14738.9 14802.5 14923.6 1982.4 2011.4 2059.5 2064.9 2065.6 80082.6 80604.6 80791.0 81544.0 82094.2 10580.7 10714.9 10957.2 11104.6 11201.8 15252.4 15262.2 15263.2 15263.8 15264.6 6699.9 6941.7 7019.2 7090.6 7172.9 6097.5 6149.6 6276.5 6277.0 6294.5 6797.7 6844.3 6847.1 6933.7 6971.0 2027.5 2029.5 2034.4 2078.4 2094.7 848.8 884.6 901.7 903.1 924.8 16490.4 16622.3 16624.2 16806.3 17471.5 894.6 895.3 898.6 901.1 918.7 8787.3 8933.3 9296.1 9335.1 9336.0 332605.0 334366.6 338526.0 338849.0 339456.0 70825.0 73174.0 73478.6 74798.0 75746.0 1020.9 1031.6 1062.2 1063.3 1070.0 13762.7 14013.4 14019.2 14135.5 14658.8 35481.0 35819.6 35948.6 36341.8 36627.0 44092.3 44480.6 44544.8 46553.0 47009.0 8307.9 8414.2 8739.7 8773.0 8777.9 12694.1 13206.5 13513.9 13527.1 13646.0 10723.7 10798.4 10818.5 11130.6 11409.1 10041.2 10402.9 10737.9 10881.0 11007.5 11068.8 11357.3 11439.5 11478.0 11478.2 8408.0 8429.9 8677.9 8783.9 8807.0 11241.8 11356.8 11433.3 11479.7 11688.7 07:03:16 INFO - PID 11626 | 07:03:16 INFO - PID 11626 | [#3] mootools.html Cycles:180 Average:6284.34 Median:3586.98 stddev:4062.63 (113.3%) stddev-sans-first:4056.61 07:03:16 INFO - PID 11626 | Values: 1277.9 1333.6 1336.2 1348.7 1358.6 9963.3 10078.5 10544.5 10595.9 10614.4 10321.9 10594.9 10626.4 10653.2 10653.5 2305.9 2309.0 2321.3 2330.7 2340.4 2136.1 2195.0 2195.9 2197.3 2201.2 2253.2 2267.4 2292.0 2300.7 2306.3 2071.7 2130.4 2142.5 2149.2 2150.6 1767.3 1820.1 2146.9 2162.5 2213.9 10256.4 10267.8 10359.9 10382.0 10388.1 5513.6 5716.9 5718.3 5726.6 5731.0 3277.3 3482.0 3493.7 3569.4 3578.2 1064.6 1076.5 1112.3 1121.7 1126.3 15031.6 15170.8 15197.5 15215.1 15239.7 4634.7 4716.7 4899.2 4964.8 4986.6 10253.3 10263.3 10268.8 10290.2 10300.4 5489.1 5495.1 5497.4 5505.7 5528.3 4913.6 5040.4 5124.0 5132.2 5147.3 3766.8 3874.0 3898.5 3931.9 3985.4 1117.7 1117.7 1145.5 1147.7 1149.6 648.6 670.9 685.5 695.1 699.5 4958.8 5032.0 5150.2 5196.6 6594.4 816.1 829.6 840.2 841.3 847.4 3502.5 3535.9 3595.8 3647.6 3699.0 13055.4 13106.9 13298.2 13594.5 13630.7 12766.6 13186.0 13254.6 13497.1 13502.3 7398.6 7429.7 7510.8 7537.0 7603.2 5559.1 5596.8 5632.6 5735.0 5892.8 11633.8 11908.1 11935.4 12175.1 12196.1 12048.9 12174.0 12278.3 12352.6 12366.6 7733.0 7947.9 8079.6 8088.8 8092.4 9673.4 9814.8 9844.6 9847.2 9854.8 8116.4 8269.4 8272.8 8439.2 8633.7 7850.4 8009.5 8052.2 8074.6 8195.2 7454.3 7574.2 7581.3 7613.7 7618.1 4728.0 5208.3 5215.7 5256.3 5521.1 5051.1 5052.9 5094.9 5238.4 5327.7 07:03:16 INFO - PID 11626 | 07:03:16 INFO - PID 11626 | [#4] prototype.html Cycles:180 Average:4812.01 Median:5336.19 stddev:1346.88 (25.2%) stddev-sans-first:1308.69 07:03:16 INFO - PID 11626 | Values: 367.3 375.6 380.6 388.7 395.7 5276.7 5472.3 5498.4 5525.7 5533.9 5298.3 5396.0 5429.0 5435.0 5438.9 4314.8 4324.0 4326.1 4337.4 4346.5 4275.4 4321.5 4347.8 4351.3 4352.5 4301.2 4301.7 4312.8 4313.2 4319.2 4297.8 4309.3 4317.3 4328.6 4343.3 3926.5 3975.0 3978.4 3981.4 3984.2 5321.0 5321.1 5326.8 5345.6 5380.8 5139.4 5140.1 5141.3 5163.1 5167.4 5671.7 5769.0 5795.7 5809.9 5817.3 4434.2 4435.3 4436.0 4438.2 4468.8 5887.7 6028.4 6037.8 6041.4 6143.1 4309.8 4340.3 4348.4 4357.9 4361.1 4406.8 4416.6 4420.7 4429.0 4429.7 4928.7 4953.3 4973.6 5097.3 5151.9 5733.0 5747.5 5779.2 5790.3 5793.4 1598.4 1617.4 1618.8 1620.6 1624.9 1164.4 1177.2 1182.8 1197.4 1199.2 4883.3 4895.3 4901.5 4906.3 4907.3 5902.1 5907.0 5913.9 5923.1 5935.1 4683.8 4829.9 4839.2 4854.6 4886.9 3110.7 3151.2 3155.5 3165.6 3169.2 5264.8 5450.9 5478.6 5494.7 5496.5 6106.9 6110.9 6124.4 6132.4 6150.2 5396.5 5428.2 5438.2 5452.8 5462.4 5790.7 5931.5 5968.6 5976.9 5985.0 5662.2 5856.8 5880.5 5895.0 5895.1 5433.7 5436.0 5459.1 5469.2 5481.1 4059.6 4093.1 4095.5 4109.3 4112.5 5880.9 5934.6 5949.9 5968.0 5995.9 5733.9 5758.6 5763.8 5772.4 5782.3 5742.5 5751.4 5753.3 5774.5 5776.0 5460.6 5608.6 5684.9 5685.4 5693.8 5826.6 5827.4 5836.9 5839.7 5842.9 5537.5 5578.4 5645.7 5646.0 5677.3 07:03:16 INFO - PID 11626 | 07:03:16 INFO - PID 11626 | [#5] yui.html Cycles:180 Average:14867.49 Median:17949.03 stddev:17470.99 (97.3%) stddev-sans-first:17487.74 07:03:16 INFO - PID 11626 | Values: 728.4 751.9 752.3 759.5 768.5 11745.7 12305.8 12984.8 14149.6 14163.7 13758.8 14044.8 14100.5 14184.8 14212.6 824.9 832.8 834.1 834.3 838.6 852.9 856.4 857.8 858.1 859.1 894.8 900.4 901.2 907.5 935.6 894.4 897.5 901.3 902.7 925.1 652.8 655.1 657.1 668.3 683.7 12674.4 13035.4 13082.3 13557.0 13759.5 14075.0 14390.5 14548.2 14558.3 14638.6 12222.4 12334.5 12379.9 12393.2 12434.3 3002.3 3035.8 3054.8 3057.3 3059.2 65281.0 65424.0 65802.7 66066.7 66842.7 12316.8 12531.7 12614.7 12674.9 12792.4 21185.2 21334.7 21490.6 21513.9 21629.7 6078.5 6256.5 6298.1 6306.0 6306.7 2792.6 2851.6 2855.2 2861.9 2868.1 3303.7 3346.7 3377.4 3387.0 3462.9 735.2 741.7 747.9 751.7 751.7 542.2 556.2 559.1 561.4 566.6 9332.5 9360.6 9540.4 10118.0 10445.7 552.5 554.3 558.1 561.5 571.5 4185.3 4215.0 4814.6 4976.2 5189.2 59745.0 60504.7 61585.7 62842.4 65159.7 54909.0 55693.7 56018.2 56460.7 56863.0 51815.7 51915.2 52259.0 52479.7 53308.2 9960.9 10360.3 10573.5 10670.6 10854.2 26298.5 26372.9 26704.7 26705.9 27269.9 32838.8 32850.0 33231.3 33432.0 33592.0 12936.4 13007.9 13185.7 13247.9 13396.7 13807.7 13883.0 13883.9 14619.9 14953.6 13643.8 13907.7 13977.4 13990.9 14069.8 13477.1 13500.7 13748.1 13748.4 13993.6 12742.7 12937.2 13144.4 13168.6 13348.3 10188.5 10866.3 11158.5 11224.4 11670.6 11336.0 11576.5 11837.9 11899.7 11918.6 07:03:16 INFO - PID 11626 | -------- Summary: end -------- 07:03:16 INFO - PID 11626 | 07:03:16 INFO - TEST-INFO | 11626: exit 0 07:03:16 INFO - TEST-OK | dromaeo_css | took 1119217ms 07:03:16 INFO - TEST-START | kraken 07:03:16 INFO - operating with platform_type : linux_ 07:03:16 INFO - Initialising browser for kraken test... 07:03:16 INFO - TEST-INFO | started process 12056 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWRTRSM/profile http://localhost:49496/getInfo.html) 07:03:17 INFO - PID 12056 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2930: String.localeCompare is deprecated; use String.prototype.localeCompare instead 07:03:20 INFO - PID 12056 | __metrics Screen width/height:1600/1200 07:03:20 INFO - PID 12056 | colorDepth:24 07:03:20 INFO - PID 12056 | Browser inner width/height: 1024/695 07:03:20 INFO - PID 12056 | __metrics 07:03:22 INFO - TEST-INFO | 12056: exit 0 07:03:22 INFO - Browser initialized. 07:03:22 INFO - Running cycle 1/1 for kraken test... 07:03:22 INFO - TEST-INFO | started process 12248 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWRTRSM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:03:34 INFO - PID 12248 | RSS: Main: 166711296 07:03:34 INFO - PID 12248 | 07:03:36 INFO - PID 12248 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49496/tests/kraken/driver.html?testName=audio-beat-detection) 07:03:37 INFO - PID 12248 | RSS: Main: 170115072 07:03:37 INFO - PID 12248 | 07:03:40 INFO - PID 12248 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49496/tests/kraken/driver.html?testName=audio-dft) 07:03:41 INFO - PID 12248 | RSS: Main: 170598400 07:03:41 INFO - PID 12248 | 07:03:44 INFO - PID 12248 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49496/tests/kraken/driver.html?testName=audio-fft) 07:03:44 INFO - PID 12248 | RSS: Main: 165285888 07:03:44 INFO - PID 12248 | 07:03:46 INFO - PID 12248 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49496/tests/kraken/driver.html?testName=audio-oscillator) 07:03:47 INFO - PID 12248 | RSS: Main: 165978112 07:03:47 INFO - PID 12248 | 07:03:49 INFO - PID 12248 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49496/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:03:50 INFO - PID 12248 | RSS: Main: 166662144 07:03:50 INFO - PID 12248 | 07:03:53 INFO - PID 12248 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49496/tests/kraken/driver.html?testName=imaging-darkroom) 07:03:54 INFO - PID 12248 | RSS: Main: 170852352 07:03:54 INFO - PID 12248 | 07:03:57 INFO - PID 12248 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49496/tests/kraken/driver.html?testName=imaging-desaturate) 07:03:58 INFO - PID 12248 | RSS: Main: 168247296 07:03:58 INFO - PID 12248 | 07:04:01 INFO - PID 12248 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49496/tests/kraken/driver.html?testName=json-parse-financial) 07:04:01 INFO - PID 12248 | RSS: Main: 168284160 07:04:01 INFO - PID 12248 | 07:04:03 INFO - PID 12248 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49496/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:04:04 INFO - PID 12248 | RSS: Main: 169029632 07:04:04 INFO - PID 12248 | 07:04:05 INFO - PID 12248 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49496/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:04:06 INFO - PID 12248 | RSS: Main: 169041920 07:04:06 INFO - PID 12248 | 07:04:08 INFO - PID 12248 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49496/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:04:09 INFO - PID 12248 | RSS: Main: 168656896 07:04:09 INFO - PID 12248 | 07:04:12 INFO - PID 12248 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49496/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:04:12 INFO - PID 12248 | RSS: Main: 168923136 07:04:12 INFO - PID 12248 | 07:04:16 INFO - PID 12248 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49496/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:04:16 INFO - PID 12248 | RSS: Main: 168906752 07:04:16 INFO - PID 12248 | 07:04:18 INFO - PID 12248 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49496/tests/kraken/driver.html?testName=ai-astar) 07:04:18 INFO - PID 12248 | RSS: Main: 170168320 07:04:18 INFO - PID 12248 | 07:04:18 INFO - PID 12248 | __start_tp_report 07:04:18 INFO - PID 12248 | _x_x_mozilla_page_load 07:04:18 INFO - PID 12248 | _x_x_mozilla_page_load_details 07:04:18 INFO - PID 12248 | |i|pagename|runs| 07:04:18 INFO - PID 12248 | |0;ai-astar;104;111;111;111;110;111;115;111;112;112 07:04:18 INFO - PID 12248 | |1;audio-beat-detection;154;126;124;165;124;135;128;128;151;124 07:04:18 INFO - PID 12248 | |2;audio-dft;163;163;168;163;166;167;174;165;164;162 07:04:18 INFO - PID 12248 | |3;audio-fft;74;74;77;109;75;74;78;75;99;74 07:04:18 INFO - PID 12248 | |4;audio-oscillator;83;83;106;88;88;85;113;87;86;104 07:04:18 INFO - PID 12248 | |5;imaging-gaussian-blur;113;114;115;114;114;113;114;116;114;116 07:04:18 INFO - PID 12248 | |6;imaging-darkroom;150;150;151;151;151;151;149;153;151;151 07:04:18 INFO - PID 12248 | |7;imaging-desaturate;97;95;94;94;94;94;95;94;95;94 07:04:18 INFO - PID 12248 | |8;json-parse-financial;56;56;55;57;56;62;58;57;57;61 07:04:18 INFO - PID 12248 | |9;json-stringify-tinderbox;55;55;56;56;55;55;55;56;55;56 07:04:18 INFO - PID 12248 | |10;stanford-crypto-aes;84;82;82;83;83;81;81;83;82;81 07:04:18 INFO - PID 12248 | |11;stanford-crypto-ccm;143;136;135;141;142;133;136;134;182;135 07:04:18 INFO - PID 12248 | |12;stanford-crypto-pbkdf2;189;194;195;191;187;197;197;196;197;216 07:04:18 INFO - PID 12248 | |13;stanford-crypto-sha256-iterative;73;72;73;76;78;73;79;77;77;74 07:04:18 INFO - PID 12248 | __end_tp_report 07:04:18 INFO - PID 12248 | __start_cc_report 07:04:18 INFO - PID 12248 | _x_x_mozilla_cycle_collect,759 07:04:18 INFO - PID 12248 | __end_cc_report 07:04:18 INFO - PID 12248 | __startTimestamp1494943458789__endTimestamp 07:04:18 INFO - PID 12248 | 07:04:18 INFO - PID 12248 | ------- Summary: start ------- 07:04:18 INFO - PID 12248 | Number of tests: 14 07:04:18 INFO - PID 12248 | 07:04:18 INFO - PID 12248 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:2.74 (2.5%) stddev-sans-first:1.42 07:04:18 INFO - PID 12248 | Values: 104.0 111.0 111.0 111.0 110.0 111.0 115.0 111.0 112.0 112.0 07:04:18 INFO - PID 12248 | 07:04:18 INFO - PID 12248 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:131.50 stddev:15.10 (11.5%) stddev-sans-first:14.52 07:04:18 INFO - PID 12248 | Values: 154.0 126.0 124.0 165.0 124.0 135.0 128.0 128.0 151.0 124.0 07:04:18 INFO - PID 12248 | 07:04:18 INFO - PID 12248 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.50 stddev:3.57 (2.2%) stddev-sans-first:3.67 07:04:18 INFO - PID 12248 | Values: 163.0 163.0 168.0 163.0 166.0 167.0 174.0 165.0 164.0 162.0 07:04:18 INFO - PID 12248 | 07:04:18 INFO - PID 12248 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.00 stddev:12.48 (16.6%) stddev-sans-first:12.98 07:04:18 INFO - PID 12248 | Values: 74.0 74.0 77.0 109.0 75.0 74.0 78.0 75.0 99.0 74.0 07:04:18 INFO - PID 12248 | 07:04:18 INFO - PID 12248 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:85.50 stddev:10.98 (12.8%) stddev-sans-first:11.11 07:04:18 INFO - PID 12248 | Values: 83.0 83.0 106.0 88.0 88.0 85.0 113.0 87.0 86.0 104.0 07:04:18 INFO - PID 12248 | 07:04:18 INFO - PID 12248 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:1.06 (0.9%) stddev-sans-first:1.01 07:04:18 INFO - PID 12248 | Values: 113.0 114.0 115.0 114.0 114.0 113.0 114.0 116.0 114.0 116.0 07:04:18 INFO - PID 12248 | 07:04:18 INFO - PID 12248 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 07:04:18 INFO - PID 12248 | Values: 150.0 150.0 151.0 151.0 151.0 151.0 149.0 153.0 151.0 151.0 07:04:18 INFO - PID 12248 | 07:04:18 INFO - PID 12248 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.50 stddev:0.97 (1.0%) stddev-sans-first:0.50 07:04:18 INFO - PID 12248 | Values: 97.0 95.0 94.0 94.0 94.0 94.0 95.0 94.0 95.0 94.0 07:04:18 INFO - PID 12248 | 07:04:18 INFO - PID 12248 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.00 stddev:2.27 (4.0%) stddev-sans-first:2.35 07:04:18 INFO - PID 12248 | Values: 56.0 56.0 55.0 57.0 56.0 62.0 58.0 57.0 57.0 61.0 07:04:18 INFO - PID 12248 | 07:04:18 INFO - PID 12248 | [#9] json-stringify-tinderbox Cycles:10 Average:55.40 Median:55.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 07:04:18 INFO - PID 12248 | Values: 55.0 55.0 56.0 56.0 55.0 55.0 55.0 56.0 55.0 56.0 07:04:18 INFO - PID 12248 | 07:04:18 INFO - PID 12248 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.50 stddev:1.03 (1.3%) stddev-sans-first:0.87 07:04:18 INFO - PID 12248 | Values: 84.0 82.0 82.0 83.0 83.0 81.0 81.0 83.0 82.0 81.0 07:04:18 INFO - PID 12248 | 07:04:18 INFO - PID 12248 | [#11] stanford-crypto-ccm Cycles:10 Average:141.70 Median:138.50 stddev:14.59 (10.5%) stddev-sans-first:15.47 07:04:18 INFO - PID 12248 | Values: 143.0 136.0 135.0 141.0 142.0 133.0 136.0 134.0 182.0 135.0 07:04:18 INFO - PID 12248 | 07:04:18 INFO - PID 12248 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.90 Median:196.50 stddev:7.91 (4.0%) stddev-sans-first:7.98 07:04:18 INFO - PID 12248 | Values: 189.0 194.0 195.0 191.0 187.0 197.0 197.0 196.0 197.0 216.0 07:04:18 INFO - PID 12248 | 07:04:18 INFO - PID 12248 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.20 Median:76.50 stddev:2.49 (3.2%) stddev-sans-first:2.51 07:04:18 INFO - PID 12248 | Values: 73.0 72.0 73.0 76.0 78.0 73.0 79.0 77.0 77.0 74.0 07:04:18 INFO - PID 12248 | -------- Summary: end -------- 07:04:18 INFO - PID 12248 | 07:04:19 INFO - TEST-INFO | 12248: exit 0 07:04:19 INFO - TEST-OK | kraken | took 63072ms 07:04:19 INFO - SUITE-END | took 1182s 07:04:19 INFO - Completed test suite (00:19:42) 07:04:19 INFO - javascript benchmark 07:04:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6674.767966659852, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2627.4219671672236, 2658.082961378324, 2688.542947698892, 2692.2461710721004, 2699.1092939330015, 5066.1640829263215, 5111.718855462953, 5126.154184559553, 5136.64043516954, 5151.227315902616, 5082.720450375228, 5088.974555127228, 5162.354705661793, 5171.0692075426405, 5177.094008548508, 4551.7951692173765, 4606.401167848175, 4608.23964045932, 4667.06658668266, 4682.578567928886, 4627.652926030544, 4642.303654451843, 4644.860654180363, 4713.646476514258, 4752.16837053516, 4509.4814096379005, 4635.130618699145, 4650.162970665279, 4665.976670116662, 4689.155951928651, 4527.4567051953645, 4596.218642830693, 4607.516210797851, 4620.353150558891, 4627.8611641650805, 4502.302143167814, 4534.206513860061, 4577.29051996941, 4613.700109492872, 4656.3946686930485, 5035.496450354935, 5148.2020286855595, 5165.535101840853, 5173.327467429248, 5208.479152084799, 5441.537469315113, 5508.228847961289, 5509.393966663663, 5509.807156749494, 5524.751386187631, 5527.640703354309, 5534.723263836832, 5536.169574563807, 5539.446055394468, 5566.025945459528, 5103.668261562986, 5147.922781158286, 5150.330457040561, 5155.948440515622, 5160.535551800356, 5681.119426488901, 5691.174779656926, 5692.459216374438, 5698.544116470673, 5702.144678298288, 5400.054990376747, 5417.620766546304, 5447.046766815792, 5451.100568406168, 5453.045716999589, 5493.2034854946605, 5525.364583072998, 5529.972350138304, 5537.280153580089, 5542.445755424506, 5457.099578569491, 5479.369872464637, 5491.36849262332, 5493.066178749622, 5548.223248745179, 5475.09660905954, 5478.808241711521, 5479.0959491683425, 5479.342478902558, 5489.34127904654, 4690.718556886598, 4717.150912835654, 4722.716637001791, 4753.215719406259, 4769.570738633471, 4058.512978442606, 4094.6314831665295, 4125.360569111793, 4140.565240649688, 4169.978355302909, 4637.281221410687, 4651.418572678415, 4657.3246879202325, 4696.5303469653445, 4704.0356726870905, 5480.7533660985355, 5535.557155427556, 5567.137093750475, 5601.411851755588, 5607.803726869622, 4621.09888571732, 4623.56076172763, 4628.004978929479, 4646.3495110684535, 4650.930236046462, 4958.826441074545, 4963.925541116886, 4976.950230497649, 4978.153713868651, 4979.875503112378, 5004.47453017428, 5090.236464530276, 5094.337736094284, 5097.898042039064, 5109.948900511096, 5437.728113594226, 5460.2355670207, 5499.807506737245, 5520.06158952987, 5539.833804985857, 5087.771050302671, 5107.080725469451, 5108.514691104339, 5109.616778741683, 5144.845654630367, 5373.328333958255, 5382.542483888757, 5408.107662235687, 5464.508194262536, 5491.450854914637, 5387.191921211849, 5577.498025177753, 5587.525060369751, 5591.27313449249, 5594.664320140804, 5379.838604841861, 5387.81142660005, 5455.645383050089, 5468.152436372368, 5491.890162196813, 5322.494363035506, 5409.756560954688, 5412.566994640498, 5421.83734487966, 5433.972830135824, 5269.6838189707205, 5325.7337133143965, 5326.6537675050995, 5334.733263336895, 5381.919271210857, 5340.118880384693, 5347.331583552056, 5447.455254474521, 5459.890802183854, 5509.201165831012, 5273.34083239595, 5275.208718692227, 5275.868103297448, 5314.229436731575, 5330.440303768049], "value": 5025.576795257023, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.7534887440521, 742.7177672484455, 763.7479631721533, 1072.2065671403163, 1079.1906070447164, 32595.0, 33603.66396336036, 33660.831695841516, 33691.32617347652, 33698.15754606136, 35058.64941350586, 35569.0, 35594.64405355946, 35640.0, 35682.64317356832, 6900.171979362483, 6932.896006559893, 7043.366097051265, 7044.049053377806, 7047.260037696045, 7078.186008609025, 7081.433485321188, 7157.320054594805, 7162.749303774369, 7178.102737157856, 7092.255313192118, 7158.570485770844, 7167.784966451015, 7207.063081799359, 7215.494915355927, 7080.858382832314, 7134.250903655094, 7135.999999999948, 7142.321479459469, 7152.356287934085, 6936.445084393287, 7027.754028609025, 7043.823904402379, 7045.506814522985, 7073.823154421129, 32723.6727632723, 32970.835145824356, 32972.3405531888, 33003.0, 33051.504227436606, 3001.9099427017222, 3051.7406020488284, 3054.7403470705017, 3057.8929737459084, 3058.0978611309715, 24219.757802421926, 24301.392465188335, 24314.756852431605, 24366.634500482505, 24414.389640258956, 3119.5632611434417, 3139.5918530591107, 3141.1832923439842, 3149.7952633078776, 3165.6359518655418, 132439.0, 133839.0, 145702.27148864293, 151236.0, 151243.24378378148, 39122.413163802565, 39225.80387098046, 39285.803570982534, 39333.60666393357, 39362.0, 40562.79718601447, 40730.79634601808, 40780.0, 40858.0, 40993.79503102525, 11481.253718508437, 11685.357305348287, 11687.590934317259, 11694.239874408137, 11700.239484433485, 9257.166854983085, 9266.629334826532, 9277.072292770668, 9294.814103717888, 9302.209312208402, 12755.61733148007, 12869.163504372373, 12927.5475358362, 12947.870521294855, 13136.40886160125, 5246.449122842123, 5305.681659100466, 5330.440303768126, 5457.426970168075, 5466.617336786387, 820.5733018830175, 881.1408876345512, 890.123228619809, 894.4141587260355, 898.1602201941075, 19539.500431346474, 20418.0, 20889.37331880046, 20895.268665596934, 21055.368338949855, 952.2144231009306, 960.1118964957386, 979.6816034788723, 984.1536278800226, 986.9901300987042, 10812.297200681931, 11098.778024439465, 11293.548258069584, 11296.717582060513, 11420.0, 170428.0, 170676.0, 171279.0, 171494.14252928656, 171606.14196928937, 40381.0, 40676.18647627031, 40859.0, 40865.387019194735, 40947.59052409497, 1123.7808627317759, 1187.269829055142, 1193.8149586814059, 1200.6038007457519, 1212.078820096733, 19630.705539416635, 19746.802531974496, 20004.299849505198, 21223.363299101053, 24580.50838983246, 39912.80043599763, 40448.39327410032, 40839.0, 40840.59159408368, 41014.38478422767, 157267.0, 158862.20568897543, 159077.0, 159685.0, 159901.0, 28973.7102628971, 29336.706632933397, 29840.0, 30011.399772004876, 30194.69805301919, 35553.82223088868, 35608.0, 36107.09732256609, 36380.81809591041, 36624.63375366319, 27931.720682793726, 27992.44015119727, 28560.714392855807, 29285.121446356643, 29544.0, 27016.59475107914, 27435.588466172623, 27463.450730985667, 27951.0, 28798.856005719837, 30985.845070774503, 31041.68958310388, 31064.0, 31098.0, 31128.221794454414, 26714.732852671226, 26816.32959176036, 27411.86294068517, 27683.58474622842, 28389.858050709616, 21613.743981536947, 22520.436989075406, 22651.093956242225, 22661.0, 22830.42923926915], "value": 14621.902674506335, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.67966985751127, 426.8164689183651, 434.99537817410686, 441.7879417879418, 442.74984633681976, 16862.747058794128, 17099.914500427494, 17252.958660356155, 17681.292748290085, 17794.28822847086, 16982.745258821127, 17259.827401726012, 17323.653526929455, 17403.3038678453, 17524.123793810322, 5377.731113444332, 5393.1370980643205, 5471.261379713747, 5530.778768849262, 5543.722813859311, 5332.520073193412, 5441.374241962166, 5442.836714898559, 5445.646033007842, 5450.890982180354, 5287.233351164079, 5357.973210133944, 5377.220303056055, 5392.649477783951, 5419.051665958461, 5436.755346009439, 5463.69949652767, 5476.726163691839, 5487.835364939038, 5496.367917689437, 4818.819389249621, 4845.612351011946, 4938.777755001033, 4956.0, 4964.280179373971, 21496.89251553732, 21638.675419868716, 21754.0, 21767.782322176732, 21914.342569722932, 1680.3530640703295, 1701.9829801701949, 1705.2837808120496, 1705.8805883588154, 1706.0105139019338, 14276.785848212285, 14706.55880323592, 14738.926305368404, 14802.481913132988, 14923.582259685312, 1982.4052784164694, 2011.3664195778429, 2059.5366042640435, 2064.917403303866, 2065.5662310914727, 80082.59958700169, 80604.59697701533, 80791.0, 81543.9999999994, 82094.17905820925, 10580.682579522627, 10714.946425267824, 10957.17821163416, 11104.61133860311, 11201.831972520418, 15252.38990440392, 15262.160581168142, 15263.236838158047, 15263.847361526243, 15264.618384540476, 6699.866002679919, 6941.652917354112, 7019.245188702825, 7090.610016449042, 7172.928270717331, 6097.542684298695, 6149.569530132848, 6276.466500347522, 6277.0, 6294.464970477469, 6797.72809087631, 6844.315568443116, 6847.109875716125, 6933.722651094001, 6971.0, 2027.5438026443933, 2029.4621925189836, 2034.3693455028988, 2078.449210959097, 2094.664853623413, 848.8302339532119, 884.632877355903, 901.6979311930446, 903.0878812399393, 924.8242833861544, 16490.422835200712, 16622.25199866009, 16624.168791560372, 16806.327746889987, 17471.475855724348, 894.6108442827391, 895.2524641923936, 898.5776684958059, 901.0628945896326, 918.7335672654989, 8787.253083487847, 8933.330000249878, 9296.116868897443, 9335.113164249386, 9336.0, 332605.0, 334366.5633436637, 338526.0, 338849.0, 339456.02719863906, 70825.0, 73174.0, 73478.6326068377, 74798.0, 75746.0, 1020.8723909511459, 1031.5976769060073, 1062.2298833345917, 1063.3407287481812, 1070.0369667299337, 13762.724745504833, 14013.369398377301, 14019.228942407857, 14135.505257315945, 14658.78011829802, 35481.0, 35819.64180358267, 35948.64051359453, 36341.81829090838, 36627.0, 44092.33861492016, 44480.55519444764, 44544.77727611341, 46553.0, 47009.0, 8307.875381869157, 8414.158584141536, 8739.650413983369, 8772.956135219283, 8777.868331974898, 12694.111412201057, 13206.537771177962, 13513.864861351261, 13527.053106282467, 13646.0, 10723.731906702395, 10798.352098874093, 10818.459077045958, 11130.610428634958, 11409.144314176305, 10041.196704263788, 10402.895971040192, 10737.946310268399, 10881.0, 11007.504662290055, 11068.778624427627, 11357.318560886373, 11439.542418303176, 11478.0, 11478.196526243417, 8408.0, 8429.873551896604, 8677.915260592426, 8783.902012248469, 8806.955965220133, 11241.831372529583, 11356.772864542829, 11433.314001159624, 11479.713007174554, 11688.70778230551], "value": 8660.00321512373, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1277.891379232765, 1333.553094892042, 1336.2249895060866, 1348.73025394921, 1358.572049804311, 9963.302568820167, 10078.496075196239, 10544.525496352664, 10595.894041059588, 10614.363138211704, 10321.896781032188, 10594.894051059488, 10626.415547144903, 10653.201009924247, 10653.520591573379, 2305.8962346694357, 2309.0, 2321.2688003279, 2330.6620540021772, 2340.4499942513494, 2136.1135128921555, 2194.9780502194935, 2195.890205489719, 2197.3298144066052, 2201.1745595401726, 2253.1663284584642, 2267.4444761033487, 2292.0487997481027, 2300.66640337151, 2306.250468597704, 2071.658176400892, 2130.382189165148, 2142.485803407179, 2149.161826887515, 2150.64514355132, 1767.2577517442705, 1820.1172431370774, 2146.914123435061, 2162.48100455891, 2213.856099353537, 10256.435896025716, 10267.79464410715, 10359.896401036043, 10382.0, 10388.065074143364, 5513.641613295123, 5716.942365662324, 5718.34239062509, 5726.627769195031, 5730.971345143247, 3277.2789986202997, 3481.9825900870333, 3493.68556829884, 3569.4110471772387, 3578.177019285553, 1064.6167379743285, 1076.4563895232857, 1112.327042139502, 1121.6522877907876, 1126.3016929503679, 15031.624209394744, 15170.848291517053, 15197.544073677807, 15215.08709477435, 15239.695206095927, 4634.72191668501, 4716.6698331116495, 4899.191633380452, 4964.751762411865, 4986.576141027981, 10253.282270241161, 10263.332883362558, 10268.845967310497, 10290.228232882564, 10300.433476158883, 5489.066858634042, 5495.065838807413, 5497.367802702661, 5505.724713764296, 5528.253685752372, 4913.582345500601, 5040.445550989388, 5123.974380128076, 5132.178851383761, 5147.253648221062, 3766.773993560395, 3873.9661677619474, 3898.4931958845737, 3931.862384816575, 3985.4221137935415, 1117.6535274064904, 1117.6591139702468, 1145.5475087340621, 1147.7245461089278, 1149.5976408257043, 648.5622205011598, 670.8792417364824, 685.4927353758183, 695.051255036871, 699.5278187223604, 4958.826441074545, 5032.0, 5150.201718733602, 5196.58427325813, 6594.3735345143095, 816.0859836982618, 829.5727700234385, 840.2018082821222, 841.3269384492381, 847.4406891451736, 3502.50964864914, 3535.9469607955903, 3595.7842529447794, 3647.562292524861, 3699.0, 13055.412506437044, 13106.868931310564, 13298.202107873558, 13594.456221751218, 13630.659233519043, 12766.553170638983, 13186.0, 13254.602361929157, 13497.055206135476, 13502.32488375597, 7398.593077380796, 7429.7399591014055, 7510.84978300431, 7536.962315188389, 7603.163651998276, 5559.138333558305, 5596.804111856066, 5632.605717599892, 5735.0, 5892.823215303548, 11633.767324653629, 11908.106891982963, 11935.403229838299, 12175.14773965814, 12196.146269761031, 12048.910238595892, 12174.0, 12278.324692142018, 12352.567660131852, 12366.567170149001, 7732.961335193288, 7947.8807817881625, 8079.636416361161, 8088.757337279891, 8092.352611790925, 9673.419594824052, 9814.75463113428, 9844.60621575129, 9847.212223022285, 9854.753631159278, 8116.391270654606, 8269.379796515164, 8272.793180170544, 8439.198276163756, 8633.69782057625, 7850.411219158472, 8009.519428834288, 8052.194780521901, 8074.636641351036, 8195.221453961864, 7454.254574542502, 7574.242575742602, 7581.279778421042, 7613.6573854175585, 7618.123915749759, 4728.0, 5208.270842082035, 5215.6609820361555, 5256.264123022856, 5521.1442226454965, 5051.09080365523, 5052.873678158076, 5094.872628184176, 5238.449962753856, 5327.706976116351], "value": 4729.570633747051, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.3314567487173, 375.5718480931737, 380.5965676383036, 388.7084686485136, 395.74078978269233, 5276.736163191835, 5472.276232986606, 5498.395176530584, 5525.668459892409, 5533.916991245134, 5298.337707786527, 5395.973020134904, 5429.0227759003365, 5434.972825135878, 5438.8912221755545, 4314.84898028569, 4324.027093903862, 4326.113146804897, 4337.414449049385, 4346.456692913386, 4275.40144379787, 4321.481422229337, 4347.804348804311, 4351.347297905308, 4352.542982986788, 4301.225779359714, 4301.698881078326, 4312.849050283241, 4313.2451820931365, 4319.2441322768545, 4297.806598703066, 4309.288967320388, 4317.337824937422, 4328.567143285678, 4343.261645520238, 3926.489556357655, 3975.0, 3978.423128646359, 3981.3629819229072, 3984.163325701606, 5321.0, 5321.148616221386, 5326.813561525367, 5345.572354211654, 5380.811671591515, 5139.4280974722205, 5140.1004824155625, 5141.2545180948555, 5163.096458119851, 5167.379914410295, 5671.744771485293, 5769.019266724625, 5795.710214489301, 5809.88380232393, 5817.301923769175, 4434.201843668138, 4435.268180750172, 4435.977820110911, 4438.245498265303, 4468.75421851798, 5887.735051922674, 6028.4272994065495, 6037.818865434044, 6041.426064523907, 6143.1092491588915, 4309.762963037063, 4340.262155433584, 4348.434703488526, 4357.869263922024, 4361.084172323847, 4406.845760398371, 4416.624586910084, 4420.690551661352, 4429.025614364835, 4429.737524805415, 4928.704277743275, 4953.2570114483115, 4973.5523802857915, 5097.260897169889, 5151.871203219949, 5732.971335143297, 5747.48272655463, 5779.190913272145, 5790.334111577138, 5793.420657934257, 1598.3606557377143, 1617.4096454793917, 1618.8381161883717, 1620.586750378646, 1624.8862579619313, 1164.4396508678412, 1177.2112684501406, 1182.798924182891, 1197.4431889171403, 1199.1785626845638, 4883.291922671264, 4895.31465594817, 4901.534354236342, 4906.288588154769, 4907.337509436252, 5902.1441890926435, 5906.970465147647, 5913.9112913306335, 5923.08192230205, 5935.139404786368, 4683.7892294846815, 4829.855104346875, 4839.201531747222, 4854.563089321978, 4886.853394398174, 3110.688931106871, 3151.2121969507625, 3155.5266709993684, 3165.635951865519, 3169.223540232612, 5264.789408423697, 5450.863728406822, 5478.643888147258, 5494.697791621499, 5496.532794712414, 6106.938930610726, 6110.938890611126, 6124.418180272867, 6132.448079672851, 6150.157350517026, 5396.541293990055, 5428.158635411518, 5438.193264714716, 5452.754626041838, 5462.426445223274, 5790.681512516852, 5931.466168044896, 5968.552358573212, 5976.910346344721, 5985.0, 5662.150677398258, 5856.765729370948, 5880.470757631833, 5895.0, 5895.115732640138, 5433.728313584384, 5436.0486914790545, 5459.099248624091, 5469.234307196916, 5481.123020316731, 4059.6346328830546, 4093.0790572122223, 4095.488063992001, 4109.3425051991535, 4112.532480511669, 5880.94119058804, 5934.554908381975, 5949.940500594938, 5967.985442474703, 5995.940040599538, 5733.8566535836935, 5758.625689330348, 5763.801090394703, 5772.3650398456975, 5782.335031471266, 5742.5118864895285, 5751.396103409082, 5753.252077229933, 5774.538036957118, 5776.021817418951, 5460.6177567569885, 5608.635438696471, 5684.9431505684415, 5685.431456854281, 5693.800716974886, 5826.592138550431, 5827.358990510956, 5836.854078648068, 5839.708014599168, 5842.912356314574, 5537.473939975695, 5578.3584887738425, 5645.68948707825, 5646.0, 5677.290338707661], "value": 4410.001337668954, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.4136270302405, 751.8609057324395, 752.2590248605123, 759.5025258455713, 768.5119948832489, 11745.70635734107, 12305.753884922296, 12984.805227921577, 14149.575512734622, 14163.716725665494, 13758.793618095737, 14044.789328160086, 14100.506482273096, 14184.787228191559, 14212.644683882909, 824.9381296402779, 832.8459235041537, 834.1033389106734, 834.3200291762224, 838.6100463284572, 852.8848605438279, 856.3791251342789, 857.8027053777635, 858.1418581418582, 859.1065292096213, 894.8165626046678, 900.4192295969096, 901.1574178143456, 907.4963395315597, 935.6444551070617, 894.4141587260355, 897.5018864530183, 901.328510259854, 902.7246689759621, 925.1118925831211, 652.8106849013781, 655.0796131435341, 657.1457105762537, 668.3249917583275, 683.723092147681, 12674.42965066565, 13035.41340639664, 13082.280474573894, 13557.0, 13759.518416855362, 14075.0, 14390.496332628412, 14548.1998490083, 14558.344874480674, 14638.634034149125, 12222.449989750483, 12334.5066197352, 12379.93810030944, 12393.194442361308, 12434.316112613802, 3002.279452931303, 3035.8026728262594, 3054.831984240866, 3057.2815388383933, 3059.2198989257595, 65281.0, 65424.0, 65802.67098664476, 66066.66966665184, 66842.66578667125, 12316.81524777129, 12531.686707832378, 12614.747705045847, 12674.873251267369, 12792.360381980863, 21185.15259389638, 21334.679979800316, 21490.57018859645, 21513.89243053806, 21629.675554866688, 6078.544109191828, 6256.499480041677, 6298.0552917062805, 6305.96847015762, 6306.716197771111, 2792.567152091429, 2851.6292881925215, 2855.157728470106, 2861.9284517887218, 2868.139558132552, 3303.6861498157637, 3346.7322614190807, 3377.3751855906735, 3386.9661303387143, 3462.913427164341, 735.2316828913798, 741.7181471040969, 747.8541684371604, 751.6918063593901, 751.7256201486418, 542.2273260603624, 556.1713047559108, 559.1026402623811, 561.430148399375, 566.6373520946597, 9332.533373331305, 9360.578773955189, 9540.427574345422, 10118.01518552029, 10445.738856528647, 552.4751486088152, 554.260062816137, 558.0763835851672, 561.4750208555014, 571.5113577890844, 4185.309423945076, 4214.957850421518, 4814.5907597853875, 4976.2286845539, 5189.221616757441, 59745.0, 60504.69747651322, 61585.69207154025, 62842.37157628365, 65159.67420162869, 54909.0, 55693.7215313929, 56018.15972760412, 56460.71769641126, 56863.0, 51815.74092129515, 51915.22127168095, 52259.0, 52479.73760131175, 53308.20037699438, 9960.850587241051, 10360.274780765274, 10573.52419141156, 10670.57317707314, 10854.240203185702, 26298.474030519665, 26372.8681356592, 26704.732952670223, 26705.866470667523, 27269.863650682415, 32838.83580582082, 32850.0, 33231.33537329288, 33432.0, 33591.976722095125, 12936.417861196456, 13007.869921301044, 13185.736285274432, 13247.867521324664, 13396.665083372995, 13807.654808629864, 13883.0, 13883.930580347438, 14619.853801462275, 14953.551393458214, 13643.795343069663, 13907.652308691959, 13977.44090236379, 13990.860091399363, 14069.788953165915, 13477.056606037484, 13500.729985400434, 13748.106373085717, 13748.381322840696, 13993.580192594238, 12742.74514509686, 12937.159084659466, 13144.40850161726, 13168.60494185176, 13348.332583370986, 10188.541515631667, 10866.293690910066, 11158.49786759614, 11224.438778060901, 11670.591529296435, 11335.979761821476, 11576.479058442223, 11837.881621184022, 11899.702507437383, 11918.642440726791], "value": 6662.195676487432, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 111.0, 111.0, 110.0, 111.0, 115.0, 111.0, 112.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 124.0, 165.0, 124.0, 135.0, 128.0, 128.0, 151.0, 124.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 168.0, 163.0, 166.0, 167.0, 174.0, 165.0, 164.0, 162.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 77.0, 109.0, 75.0, 74.0, 78.0, 75.0, 99.0, 74.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 106.0, 88.0, 88.0, 85.0, 113.0, 87.0, 86.0, 104.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 115.0, 114.0, 114.0, 113.0, 114.0, 116.0, 114.0, 116.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 151.0, 151.0, 151.0, 149.0, 153.0, 151.0, 151.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 57.0, 56.0, 62.0, 58.0, 57.0, 57.0, 61.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 56.0, 55.0, 55.0, 55.0, 56.0, 55.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 82.0, 83.0, 83.0, 81.0, 81.0, 83.0, 82.0, 81.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 136.0, 135.0, 141.0, 142.0, 133.0, 136.0, 134.0, 182.0, 135.0], "value": 141.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 194.0, 195.0, 191.0, 187.0, 197.0, 197.0, 196.0, 197.0, 216.0], "value": 195.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 73.0, 76.0, 78.0, 73.0, 79.0, 77.0, 77.0, 74.0], "value": 75.2, "unit": "score"}]}]} 07:04:20 INFO - Return code: 0 07:04:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:04:20 INFO - # TBPL SUCCESS # 07:04:20 INFO - Running post-action listener: _resource_record_post_action 07:04:20 INFO - [mozharness: 2017-05-16 14:04:20.088391Z] Finished run-tests step (success) 07:04:20 INFO - Running post-run listener: _resource_record_post_run 07:04:20 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 381624320; Read time: 16; Write time: 201440 07:04:20 INFO - TinderboxPrint: CPU usage
13.3% 07:04:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 07:04:20 INFO - TinderboxPrint: I/O write bytes / time
381,624,320 / 201,440 07:04:20 INFO - TinderboxPrint: CPU idle
8,294.6 (86.7%) 07:04:20 INFO - TinderboxPrint: CPU user
1,217.7 (12.7%) 07:04:20 INFO - TinderboxPrint: Swap in / out
0 / 0 07:04:20 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 95920128; Read time: 0; Write time: 62984 07:04:20 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 285704192; Read time: 0; Write time: 138456 07:04:20 INFO - Running post-run listener: _upload_blobber_files 07:04:20 INFO - Blob upload gear active. 07:04:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:04:20 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 07:04:20 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'] 07:04:20 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 07:04:21 INFO - (blobuploader) - INFO - Open directory for files ... 07:04:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:04:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:04:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:04:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:04:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:04:22 INFO - (blobuploader) - INFO - Done attempting. 07:04:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:04:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:04:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:04:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:04:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:04:23 INFO - (blobuploader) - INFO - Done attempting. 07:04:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:04:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:04:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:04:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:04:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:04:24 INFO - (blobuploader) - INFO - Done attempting. 07:04:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:04:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:04:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:04:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:04:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:04:27 INFO - (blobuploader) - INFO - Done attempting. 07:04:27 INFO - (blobuploader) - INFO - Iteration through files over. 07:04:27 INFO - Return code: 0 07:04:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:04:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:04:27 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6233629b881a08b6c051cb2578367688ef17fc9741313f1a46daae8395a8863363c062d3aa9b4efe756fc0768e4084e88967a43b136c62313bdb7b17bc0bf31c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6bf2e13ede8002fba51b065bfae042cf3722724103f1ae479eb49e5d704f3dabb8a8f711505a1048b5f409ac70d74fd80f7af5d9d8fb5cf9d0ac469edca11c2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5de6a4d5d52d353ef4b47f5d63113c9bbf467d17ca9664971fe9d48a80ddd3ceb1427e562de161df97fe95ca6d0ea1fdb0da2e58885689e004b6373d88b3773e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21ecd5a790fed120a07d5cbf2b915764f08104886bb8c21ac7cc7650bfa200ab96889decd75cef1307689f249d915d1d8e64e2e676cf19bc7405d4c9a66f571d"} 07:04:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:04:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:04:27 INFO - Contents: 07:04:27 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6233629b881a08b6c051cb2578367688ef17fc9741313f1a46daae8395a8863363c062d3aa9b4efe756fc0768e4084e88967a43b136c62313bdb7b17bc0bf31c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6bf2e13ede8002fba51b065bfae042cf3722724103f1ae479eb49e5d704f3dabb8a8f711505a1048b5f409ac70d74fd80f7af5d9d8fb5cf9d0ac469edca11c2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5de6a4d5d52d353ef4b47f5d63113c9bbf467d17ca9664971fe9d48a80ddd3ceb1427e562de161df97fe95ca6d0ea1fdb0da2e58885689e004b6373d88b3773e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21ecd5a790fed120a07d5cbf2b915764f08104886bb8c21ac7cc7650bfa200ab96889decd75cef1307689f249d915d1d8e64e2e676cf19bc7405d4c9a66f571d"} 07:04:27 INFO - Running post-run listener: copy_logs_to_upload_dir 07:04:27 INFO - Copying logs to upload dir... 07:04:27 INFO - mkdir: /builds/slave/test/build/upload/logs 07:04:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.646708 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-05-16 07:04:27.459304) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-16 07:04:27.463677) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6233629b881a08b6c051cb2578367688ef17fc9741313f1a46daae8395a8863363c062d3aa9b4efe756fc0768e4084e88967a43b136c62313bdb7b17bc0bf31c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6bf2e13ede8002fba51b065bfae042cf3722724103f1ae479eb49e5d704f3dabb8a8f711505a1048b5f409ac70d74fd80f7af5d9d8fb5cf9d0ac469edca11c2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5de6a4d5d52d353ef4b47f5d63113c9bbf467d17ca9664971fe9d48a80ddd3ceb1427e562de161df97fe95ca6d0ea1fdb0da2e58885689e004b6373d88b3773e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21ecd5a790fed120a07d5cbf2b915764f08104886bb8c21ac7cc7650bfa200ab96889decd75cef1307689f249d915d1d8e64e2e676cf19bc7405d4c9a66f571d"} build_url:https://queue.taskcluster.net/v1/task/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/SCSWyz1ySLCp7m69hsdlRA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6233629b881a08b6c051cb2578367688ef17fc9741313f1a46daae8395a8863363c062d3aa9b4efe756fc0768e4084e88967a43b136c62313bdb7b17bc0bf31c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6bf2e13ede8002fba51b065bfae042cf3722724103f1ae479eb49e5d704f3dabb8a8f711505a1048b5f409ac70d74fd80f7af5d9d8fb5cf9d0ac469edca11c2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5de6a4d5d52d353ef4b47f5d63113c9bbf467d17ca9664971fe9d48a80ddd3ceb1427e562de161df97fe95ca6d0ea1fdb0da2e58885689e004b6373d88b3773e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21ecd5a790fed120a07d5cbf2b915764f08104886bb8c21ac7cc7650bfa200ab96889decd75cef1307689f249d915d1d8e64e2e676cf19bc7405d4c9a66f571d"}' ========= master_lag: 0.16 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-16 07:04:27.635142) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 07:04:27.635499) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8ec0ee4e6a493f968516bea6000001a5-1494938815.914139-1018802223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 07:04:27.715028) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-16 07:04:27.718381) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-16 07:04:27.718676) ========= ========= Total master_lag: 0.32 =========