builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-013 starttime: 1494981994.63 results: success (0) revision: 985b3ee939338022ef44028b5251f77af19c3638 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-16 17:46:34.626209) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-16 17:46:34.626776) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-16 17:46:34.627055) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-16 17:46:34.710691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 17:46:34.710984) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-16 17:46:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.7M=0s 2017-05-16 17:46:35 (37.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133648 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 17:46:34.883336) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 17:46:34.883622) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015365 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 17:46:34.937136) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-16 17:46:34.937460) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 985b3ee939338022ef44028b5251f77af19c3638 --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 985b3ee939338022ef44028b5251f77af19c3638 --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=9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-16 17:46:35,202 truncating revision to first 12 chars 2017-05-16 17:46:35,202 Setting DEBUG logging. 2017-05-16 17:46:35,202 attempt 1/10 2017-05-16 17:46:35,203 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/985b3ee93933?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-16 17:46:36,275 unpacking tar archive at: mozilla-central-985b3ee93933/testing/mozharness/ program finished with exit code 0 elapsedTime=1.418710 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-16 17:46:36.371480) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-16 17:46:36.374815) ========= script_repo_revision: 985b3ee939338022ef44028b5251f77af19c3638 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-16 17:46:36.375227) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-16 17:46:36.375510) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-16 17:46:36.388477) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-05-16 17:46:36.388788) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:46:36 INFO - MultiFileLogger online at 20170516 17:46:36 in /builds/slave/test 17:46:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:46:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:46:36 INFO - {'append_to_log': False, 17:46:36 INFO - 'base_work_dir': '/builds/slave/test', 17:46:36 INFO - 'blob_upload_branch': 'Firefox', 17:46:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:46:36 INFO - 'branch': 'Firefox', 17:46:36 INFO - 'buildbot_json_path': 'buildprops.json', 17:46:36 INFO - 'config_files': ('talos/linux_config.py',), 17:46:36 INFO - 'default_actions': ('clobber', 17:46:36 INFO - 'read-buildbot-config', 17:46:36 INFO - 'download-and-extract', 17:46:36 INFO - 'populate-webroot', 17:46:36 INFO - 'create-virtualenv', 17:46:36 INFO - 'install', 17:46:36 INFO - 'run-tests'), 17:46:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:46:36 INFO - 'download_minidump_stackwalk': True, 17:46:36 INFO - 'download_symbols': 'ondemand', 17:46:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:46:36 INFO - 'tooltool.py': '/tools/tooltool.py', 17:46:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:46:36 INFO - '/tools/misc-python/virtualenv.py')}, 17:46:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:46:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:46:36 INFO - 'gecko_profile': False, 17:46:36 INFO - 'gecko_profile_interval': 0, 17:46:36 INFO - 'installer_path': 'installer.exe', 17:46:36 INFO - 'log_level': 'info', 17:46:36 INFO - 'log_name': 'talos', 17:46:36 INFO - 'log_to_console': True, 17:46:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:46:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:46:36 INFO - 'opt_config_files': (), 17:46:36 INFO - 'pip_index': False, 17:46:36 INFO - 'suite': 'dromaeojs-e10s', 17:46:36 INFO - 'system_bits': '32', 17:46:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:46:36 INFO - 'title': 'talos-linux64-ix-013', 17:46:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:46:36 INFO - 'use_talos_json': True, 17:46:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:46:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:46:36 INFO - 'work_dir': 'build'} 17:46:36 INFO - [mozharness: 2017-05-17 00:46:36.754119Z] Running clobber step. 17:46:36 INFO - Running pre-action listener: _resource_record_pre_action 17:46:36 INFO - Running main action method: clobber 17:46:36 INFO - rmtree: /builds/slave/test/build 17:46:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:46:38 INFO - Running post-action listener: _resource_record_post_action 17:46:38 INFO - [mozharness: 2017-05-17 00:46:38.195244Z] Finished clobber step (success) 17:46:38 INFO - [mozharness: 2017-05-17 00:46:38.195344Z] Running read-buildbot-config step. 17:46:38 INFO - Running pre-action listener: _resource_record_pre_action 17:46:38 INFO - Running main action method: read_buildbot_config 17:46:38 INFO - Using buildbot properties: 17:46:38 INFO - { 17:46:38 INFO - "project": "", 17:46:38 INFO - "product": "firefox", 17:46:38 INFO - "who": "ryanvm@gmail.com", 17:46:38 INFO - "installer_path": "public/build/target.tar.bz2", 17:46:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 17:46:38 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:46:38 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 17:46:38 INFO - "stage_platform": "linux64-styloseq", 17:46:38 INFO - "basedir": "/builds/slave/test", 17:46:38 INFO - "buildnumber": 3, 17:46:38 INFO - "platform": "ubuntu64_hw_styloseq", 17:46:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:46:38 INFO - "slavebuilddir": "test", 17:46:38 INFO - "taskId": "Xi0ZezvvSZqIrJo6_uylaA", 17:46:38 INFO - "branch": "mozilla-central", 17:46:38 INFO - "script_repo_revision": "production", 17:46:38 INFO - "revision": "985b3ee939338022ef44028b5251f77af19c3638", 17:46:38 INFO - "slavename": "talos-linux64-ix-013", 17:46:38 INFO - "repo_path": "mozilla-central" 17:46:38 INFO - } 17:46:38 INFO - Finding installer, test and symbols from parent task. 17:46:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xi0ZezvvSZqIrJo6_uylaA'}, attempt #1 17:46:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xi0ZezvvSZqIrJo6_uylaA'}, attempt #1 17:46:39 INFO - Task dependencies: BFqzGiotSsi_px9K4nyoVg 17:46:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BFqzGiotSsi_px9K4nyoVg'}, attempt #1 17:46:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/target.tar.bz2 17:46:39 INFO - Set test_url: https://queue.taskcluster.net/v1/task/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/test_packages.json 17:46:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/target.crashreporter-symbols.zip 17:46:39 INFO - Running post-action listener: _resource_record_post_action 17:46:39 INFO - [mozharness: 2017-05-17 00:46:39.732403Z] Finished read-buildbot-config step (success) 17:46:39 INFO - [mozharness: 2017-05-17 00:46:39.732623Z] Running download-and-extract step. 17:46:39 INFO - Running pre-action listener: _resource_record_pre_action 17:46:39 INFO - Running main action method: download_and_extract 17:46:39 INFO - mkdir: /builds/slave/test/build/tests 17:46:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:39 INFO - trying https://queue.taskcluster.net/v1/task/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/target.test_packages.json 17:46:39 INFO - Downloading https://queue.taskcluster.net/v1/task/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:46:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:46:40 INFO - Downloaded 986 bytes. 17:46:40 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:46:40 INFO - Using the following test package requirements: 17:46:40 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:46:40 INFO - u'common': [u'target.common.tests.zip'], 17:46:40 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:46:40 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:46:40 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:46:40 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:46:40 INFO - u'mozbase': [u'target.common.tests.zip'], 17:46:40 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:46:40 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:46:40 INFO - u'web-platform': [u'target.common.tests.zip', 17:46:40 INFO - u'target.web-platform.tests.zip'], 17:46:40 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:46:40 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:46:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/target.common.tests.zip 17:46:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:46:40 INFO - Fetch https://queue.taskcluster.net/v1/task/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/target.common.tests.zip into memory 17:46:41 INFO - Content-Length response header: 62450179 17:46:41 INFO - Bytes received: 62450179 17:46:52 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:46:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/target.common.tests.zip 17:46:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:46:52 INFO - Fetch https://queue.taskcluster.net/v1/task/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/target.common.tests.zip into memory 17:46:54 INFO - Content-Length response header: 62450179 17:46:54 INFO - Bytes received: 62450179 17:47:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/target.talos.tests.zip 17:47:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:47:06 INFO - Fetch https://queue.taskcluster.net/v1/task/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/target.talos.tests.zip into memory 17:47:06 INFO - Content-Length response header: 14410069 17:47:06 INFO - Bytes received: 14410069 17:47: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')]} 17:47:06 INFO - trying https://queue.taskcluster.net/v1/task/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/target.tar.bz2 17:47:06 INFO - Downloading https://queue.taskcluster.net/v1/task/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:47:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:47:09 INFO - Downloaded 65007500 bytes. 17:47:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/target.tar.bz2 17:47:09 INFO - mkdir: /builds/slave/test/properties 17:47:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:47:09 INFO - Writing to file /builds/slave/test/properties/build_url 17:47:09 INFO - Contents: 17:47:09 INFO - build_url:https://queue.taskcluster.net/v1/task/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/target.tar.bz2 17:47:09 INFO - Running post-action listener: _resource_record_post_action 17:47:09 INFO - Running post-action listener: set_extra_try_arguments 17:47:09 INFO - [mozharness: 2017-05-17 00:47:09.012366Z] Finished download-and-extract step (success) 17:47:09 INFO - [mozharness: 2017-05-17 00:47:09.012593Z] Running populate-webroot step. 17:47:09 INFO - Running pre-action listener: _resource_record_pre_action 17:47:09 INFO - Running main action method: populate_webroot 17:47:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:47:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:47:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:47:09 INFO - '--tppagecycles', 17:47:09 INFO - '7'], 17:47:09 INFO - 'tests': ['tsvgm']}}, 17:47:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:47:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:47:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:47:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:47:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:47:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:47:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:47:09 INFO - 'talos_options': ['--disable-e10s'], 17:47:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:47:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:47:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:47:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:47:09 INFO - 'talos_options': ['--disable-e10s'], 17:47:09 INFO - 'tests': ['damp', 'tps']}, 17:47:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:47:09 INFO - 'tests': ['damp', 'tps']}, 17:47:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:47:09 INFO - 'tests': ['dromaeo_dom']}, 17:47:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:47:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:47:09 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:47:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:47:09 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:47:09 INFO - 'tests': ['ts_paint', 'tp5o']}, 17:47:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:47:09 INFO - 'tests': ['a11yr', 17:47:09 INFO - 'ts_paint', 17:47:09 INFO - 'tpaint', 17:47:09 INFO - 'sessionrestore', 17:47:09 INFO - 'sessionrestore_no_auto_restore', 17:47:09 INFO - 'tabpaint']}, 17:47:09 INFO - 'other-e10s': {'tests': ['a11yr', 17:47:09 INFO - 'ts_paint', 17:47:09 INFO - 'tpaint', 17:47:09 INFO - 'sessionrestore', 17:47:09 INFO - 'sessionrestore_no_auto_restore', 17:47:09 INFO - 'tabpaint']}, 17:47:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:47:09 INFO - 'ts_paint', 17:47:09 INFO - 'tpaint', 17:47:09 INFO - 'sessionrestore', 17:47:09 INFO - 'sessionrestore_no_auto_restore', 17:47:09 INFO - 'tabpaint']}, 17:47:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:47:09 INFO - 'ts_paint', 17:47:09 INFO - 'tpaint', 17:47:09 INFO - 'sessionrestore', 17:47:09 INFO - 'sessionrestore_no_auto_restore', 17:47:09 INFO - 'tabpaint']}, 17:47:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:47:09 INFO - 'tests': ['a11yr', 17:47:09 INFO - 'ts_paint', 17:47:09 INFO - 'tpaint', 17:47:09 INFO - 'sessionrestore', 17:47:09 INFO - 'sessionrestore_no_auto_restore', 17:47:09 INFO - 'tabpaint']}, 17:47:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:47:09 INFO - 'tests': ['a11yr', 17:47:09 INFO - 'ts_paint', 17:47:09 INFO - 'tpaint', 17:47:09 INFO - 'sessionrestore', 17:47:09 INFO - 'sessionrestore_no_auto_restore', 17:47:09 INFO - 'tabpaint']}, 17:47:09 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 17:47:09 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 17:47:09 INFO - 'bloom_basic_ref']}, 17:47:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:47:09 INFO - 'tests': ['tsvgx', 17:47:09 INFO - 'tsvgr_opacity', 17:47:09 INFO - 'tart', 17:47:09 INFO - 'tscrollx', 17:47:09 INFO - 'cart', 17:47:09 INFO - 'tsvg_static']}, 17:47:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:47:09 INFO - 'tsvgr_opacity', 17:47:09 INFO - 'tart', 17:47:09 INFO - 'tscrollx', 17:47:09 INFO - 'cart', 17:47:09 INFO - 'tsvg_static']}, 17:47:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:47:09 INFO - 'talos_options': ['--disable-e10s'], 17:47:09 INFO - 'tests': ['tp5o']}, 17:47:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:47:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:47:09 INFO - 'talos_options': ['--disable-e10s', 17:47:09 INFO - '--xperf_path', 17:47:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:47:09 INFO - 'tests': ['tp5n']}, 17:47:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:47:09 INFO - 'talos_options': ['--xperf_path', 17:47:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:47:09 INFO - 'tests': ['tp5n']}}, 17:47:09 INFO - 'talos.zip': {'path': '', 17:47:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:47:09 INFO - Running post-action listener: _resource_record_post_action 17:47:09 INFO - [mozharness: 2017-05-17 00:47:09.029639Z] Finished populate-webroot step (success) 17:47:09 INFO - [mozharness: 2017-05-17 00:47:09.029728Z] Running create-virtualenv step. 17:47:09 INFO - Running pre-action listener: _resource_record_pre_action 17:47:09 INFO - Running main action method: create_virtualenv 17:47:09 INFO - Creating virtualenv /builds/slave/test/build/venv 17:47:09 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 17:47:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:47:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:47:09 INFO - Using real prefix '/usr' 17:47:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:47:09 INFO - Installing distribute.............................................................................................................................................................................................done. 17:47:11 INFO - Installing pip.................done. 17:47:11 INFO - Return code: 0 17:47:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:47:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:47:11 INFO - Reading from file tmpfile_stdout 17:47:11 INFO - Output received: 17:47:11 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) 17:47:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:47: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')]} 17:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47: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')]} 17:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24755c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24727a0>, '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 0x24736a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2473b30>, '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': '9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606', '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 17:47: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', 'pip>=1.5'] in /builds/slave/test/build 17:47: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 pip>=1.5 17:47:11 INFO - Using env: {'DISPLAY': ':0', 17:47:11 INFO - 'HOME': '/home/cltbld', 17:47:11 INFO - 'LANG': 'en_US.UTF-8', 17:47:11 INFO - 'LANGUAGE': 'en_US:en', 17:47:11 INFO - 'LOGNAME': 'cltbld', 17:47:11 INFO - 'MAIL': '/var/mail/cltbld', 17:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:11 INFO - 'MOZ_NO_REMOTE': '1', 17:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:11 INFO - 'NO_EM_RESTART': '1', 17:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:11 INFO - 'PWD': '/builds/slave/test', 17:47:11 INFO - 'SHELL': '/bin/bash', 17:47:11 INFO - 'SHLVL': '1', 17:47:11 INFO - 'TERM': 'linux', 17:47:11 INFO - 'TMOUT': '86400', 17:47:11 INFO - 'USER': 'cltbld', 17:47:11 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606', 17:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:11 INFO - '_': '/tools/buildbot/bin/python'} 17:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:12 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 17:47:12 INFO - Cleaning up... 17:47:12 INFO - Return code: 0 17:47:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24755c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24727a0>, '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 0x24736a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2473b30>, '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': '9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606', '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 17:47:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:47:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:47:12 INFO - Using env: {'DISPLAY': ':0', 17:47:12 INFO - 'HOME': '/home/cltbld', 17:47:12 INFO - 'LANG': 'en_US.UTF-8', 17:47:12 INFO - 'LANGUAGE': 'en_US:en', 17:47:12 INFO - 'LOGNAME': 'cltbld', 17:47:12 INFO - 'MAIL': '/var/mail/cltbld', 17:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:12 INFO - 'MOZ_NO_REMOTE': '1', 17:47:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:12 INFO - 'NO_EM_RESTART': '1', 17:47:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:12 INFO - 'PWD': '/builds/slave/test', 17:47:12 INFO - 'SHELL': '/bin/bash', 17:47:12 INFO - 'SHLVL': '1', 17:47:12 INFO - 'TERM': 'linux', 17:47:12 INFO - 'TMOUT': '86400', 17:47:12 INFO - 'USER': 'cltbld', 17:47:12 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606', 17:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:12 INFO - '_': '/tools/buildbot/bin/python'} 17:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:12 INFO - Downloading/unpacking psutil>=3.1.1 17:47: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 17:47: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 17:47: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 17:47: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 17:47:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:47:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:47:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:47:13 INFO - Installing collected packages: psutil 17:47:13 INFO - Running setup.py install for psutil 17:47:13 INFO - building 'psutil._psutil_linux' extension 17:47:13 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 17:47:13 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 17:47:13 INFO - building 'psutil._psutil_posix' extension 17:47:13 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 17:47:13 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 17:47:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:47:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:47:13 INFO - Successfully installed psutil 17:47:13 INFO - Cleaning up... 17:47:13 INFO - Return code: 0 17:47:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24755c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24727a0>, '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 0x24736a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2473b30>, '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': '9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606', '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 17:47:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:47:13 INFO - Using env: {'DISPLAY': ':0', 17:47:13 INFO - 'HOME': '/home/cltbld', 17:47:13 INFO - 'LANG': 'en_US.UTF-8', 17:47:13 INFO - 'LANGUAGE': 'en_US:en', 17:47:13 INFO - 'LOGNAME': 'cltbld', 17:47:13 INFO - 'MAIL': '/var/mail/cltbld', 17:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:13 INFO - 'MOZ_NO_REMOTE': '1', 17:47:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:13 INFO - 'NO_EM_RESTART': '1', 17:47:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:13 INFO - 'PWD': '/builds/slave/test', 17:47:13 INFO - 'SHELL': '/bin/bash', 17:47:13 INFO - 'SHLVL': '1', 17:47:13 INFO - 'TERM': 'linux', 17:47:13 INFO - 'TMOUT': '86400', 17:47:13 INFO - 'USER': 'cltbld', 17:47:13 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606', 17:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:13 INFO - '_': '/tools/buildbot/bin/python'} 17:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:47:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:47:15 INFO - Installing collected packages: mozsystemmonitor 17:47:15 INFO - Running setup.py install for mozsystemmonitor 17:47:15 INFO - Successfully installed mozsystemmonitor 17:47:15 INFO - Cleaning up... 17:47:15 INFO - Return code: 0 17:47:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24755c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24727a0>, '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 0x24736a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2473b30>, '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': '9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606', '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 17:47:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:47:15 INFO - Using env: {'DISPLAY': ':0', 17:47:15 INFO - 'HOME': '/home/cltbld', 17:47:15 INFO - 'LANG': 'en_US.UTF-8', 17:47:15 INFO - 'LANGUAGE': 'en_US:en', 17:47:15 INFO - 'LOGNAME': 'cltbld', 17:47:15 INFO - 'MAIL': '/var/mail/cltbld', 17:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:15 INFO - 'MOZ_NO_REMOTE': '1', 17:47:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:15 INFO - 'NO_EM_RESTART': '1', 17:47:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:15 INFO - 'PWD': '/builds/slave/test', 17:47:15 INFO - 'SHELL': '/bin/bash', 17:47:15 INFO - 'SHLVL': '1', 17:47:15 INFO - 'TERM': 'linux', 17:47:15 INFO - 'TMOUT': '86400', 17:47:15 INFO - 'USER': 'cltbld', 17:47:15 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606', 17:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:15 INFO - '_': '/tools/buildbot/bin/python'} 17:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:15 INFO - Downloading/unpacking jsonschema==2.5.1 17:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:47:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:16 INFO - Downloading functools32-3.2.3-2.tar.gz 17:47:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:47:16 INFO - warning: no files found matching '*.txt' 17:47:16 INFO - no previously-included directories found matching 'build' 17:47:16 INFO - no previously-included directories found matching 'dist' 17:47:16 INFO - no previously-included directories found matching '.git*' 17:47:16 INFO - Installing collected packages: jsonschema, functools32 17:47:17 INFO - Running setup.py install for functools32 17:47:17 INFO - warning: no files found matching '*.txt' 17:47:17 INFO - no previously-included directories found matching 'build' 17:47:17 INFO - no previously-included directories found matching 'dist' 17:47:17 INFO - no previously-included directories found matching '.git*' 17:47:17 INFO - Successfully installed jsonschema functools32 17:47:17 INFO - Cleaning up... 17:47:17 INFO - Return code: 0 17:47:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:47: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')]} 17:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47: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')]} 17:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:17 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 0x21021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24755c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24727a0>, '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 0x24736a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2473b30>, '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': '9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606', '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 17:47:17 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 17:47:17 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 17:47:17 INFO - Using env: {'DISPLAY': ':0', 17:47:17 INFO - 'HOME': '/home/cltbld', 17:47:17 INFO - 'LANG': 'en_US.UTF-8', 17:47:17 INFO - 'LANGUAGE': 'en_US:en', 17:47:17 INFO - 'LOGNAME': 'cltbld', 17:47:17 INFO - 'MAIL': '/var/mail/cltbld', 17:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:17 INFO - 'MOZ_NO_REMOTE': '1', 17:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:17 INFO - 'NO_EM_RESTART': '1', 17:47:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:17 INFO - 'PWD': '/builds/slave/test', 17:47:17 INFO - 'SHELL': '/bin/bash', 17:47:17 INFO - 'SHLVL': '1', 17:47:17 INFO - 'TERM': 'linux', 17:47:17 INFO - 'TMOUT': '86400', 17:47:17 INFO - 'USER': 'cltbld', 17:47:17 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606', 17:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:17 INFO - '_': '/tools/buildbot/bin/python'} 17:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:47:17 INFO - Cleaning up... 17:47:17 INFO - Return code: 0 17:47:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:47: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')]} 17:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47: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')]} 17:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:17 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 0x21021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24755c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24727a0>, '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 0x24736a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2473b30>, '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': '9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606', '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 17:47:17 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 17:47:17 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 17:47:17 INFO - Using env: {'DISPLAY': ':0', 17:47:17 INFO - 'HOME': '/home/cltbld', 17:47:17 INFO - 'LANG': 'en_US.UTF-8', 17:47:17 INFO - 'LANGUAGE': 'en_US:en', 17:47:17 INFO - 'LOGNAME': 'cltbld', 17:47:17 INFO - 'MAIL': '/var/mail/cltbld', 17:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:17 INFO - 'MOZ_NO_REMOTE': '1', 17:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:17 INFO - 'NO_EM_RESTART': '1', 17:47:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:17 INFO - 'PWD': '/builds/slave/test', 17:47:17 INFO - 'SHELL': '/bin/bash', 17:47:17 INFO - 'SHLVL': '1', 17:47:17 INFO - 'TERM': 'linux', 17:47:17 INFO - 'TMOUT': '86400', 17:47:17 INFO - 'USER': 'cltbld', 17:47:17 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606', 17:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:17 INFO - '_': '/tools/buildbot/bin/python'} 17:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:17 INFO - Downloading/unpacking blobuploader==1.2.4 17:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:18 INFO - Downloading blobuploader-1.2.4.tar.gz 17:47:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:47:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:47: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 17:47: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 17:47: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 17:47: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 17:47:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:47:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:47:19 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 17:47:19 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 17:47:19 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 17:47:19 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 17:47:19 INFO - Downloading docopt-0.6.1.tar.gz 17:47:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:47:19 INFO - Installing collected packages: blobuploader, requests, docopt 17:47:19 INFO - Running setup.py install for blobuploader 17:47:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:47:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:47:19 INFO - Running setup.py install for requests 17:47:19 INFO - Running setup.py install for docopt 17:47:19 INFO - Successfully installed blobuploader requests docopt 17:47:19 INFO - Cleaning up... 17:47:19 INFO - Return code: 0 17:47:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:19 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 0x21021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24755c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24727a0>, '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 0x24736a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2473b30>, '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': '9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606', '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 17:47:19 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 17:47:19 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 17:47:19 INFO - Using env: {'DISPLAY': ':0', 17:47:19 INFO - 'HOME': '/home/cltbld', 17:47:19 INFO - 'LANG': 'en_US.UTF-8', 17:47:19 INFO - 'LANGUAGE': 'en_US:en', 17:47:19 INFO - 'LOGNAME': 'cltbld', 17:47:19 INFO - 'MAIL': '/var/mail/cltbld', 17:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:19 INFO - 'MOZ_NO_REMOTE': '1', 17:47:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:19 INFO - 'NO_EM_RESTART': '1', 17:47:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:19 INFO - 'PWD': '/builds/slave/test', 17:47:19 INFO - 'SHELL': '/bin/bash', 17:47:19 INFO - 'SHLVL': '1', 17:47:19 INFO - 'TERM': 'linux', 17:47:19 INFO - 'TMOUT': '86400', 17:47:19 INFO - 'USER': 'cltbld', 17:47:19 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606', 17:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:19 INFO - '_': '/tools/buildbot/bin/python'} 17:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:47:20 INFO - Running setup.py (path:/tmp/pip-NgRtBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:47:20 INFO - Running setup.py (path:/tmp/pip-azC903-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:47:20 INFO - Running setup.py (path:/tmp/pip-sSq8to-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:47:20 INFO - Running setup.py (path:/tmp/pip-oRwhiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:47:20 INFO - Running setup.py (path:/tmp/pip-xqa7z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:47:20 INFO - Running setup.py (path:/tmp/pip-x5NCdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:47:20 INFO - Running setup.py (path:/tmp/pip-rRC50z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:47:20 INFO - Running setup.py (path:/tmp/pip-wus5kI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:47:20 INFO - Running setup.py (path:/tmp/pip-I2UPu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:47:20 INFO - Running setup.py (path:/tmp/pip-aIggvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:47:20 INFO - Running setup.py (path:/tmp/pip-kzxH0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:47:20 INFO - Running setup.py (path:/tmp/pip-t_yDo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:47:20 INFO - Running setup.py (path:/tmp/pip-30HVTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:47:21 INFO - Running setup.py (path:/tmp/pip-_hDo8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:21 INFO - Running setup.py (path:/tmp/pip-vYpvlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:47:21 INFO - Running setup.py (path:/tmp/pip-URPEsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:47:21 INFO - Running setup.py (path:/tmp/pip-NA1eeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:47:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:47:21 INFO - Running setup.py install for manifestparser 17:47:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:47:21 INFO - Running setup.py install for mozcrash 17:47:21 INFO - Running setup.py install for mozdebug 17:47:21 INFO - Running setup.py install for mozdevice 17:47:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:47:21 INFO - Running setup.py install for mozfile 17:47:21 INFO - Running setup.py install for mozhttpd 17:47:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:47:21 INFO - Running setup.py install for mozinfo 17:47:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:47:21 INFO - Running setup.py install for mozInstall 17:47:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:47:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:47:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:47:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:47:22 INFO - Running setup.py install for mozleak 17:47:22 INFO - Running setup.py install for mozlog 17:47:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:47:22 INFO - Running setup.py install for moznetwork 17:47:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:47:22 INFO - Running setup.py install for mozprocess 17:47:22 INFO - Running setup.py install for mozprofile 17:47:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:47:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:47:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:47:22 INFO - Running setup.py install for mozrunner 17:47:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:47:22 INFO - Running setup.py install for mozscreenshot 17:47:22 INFO - Running setup.py install for moztest 17:47:22 INFO - Running setup.py install for mozversion 17:47:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:47:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:47:23 INFO - Cleaning up... 17:47:23 INFO - Return code: 0 17:47:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:23 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 0x21021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24755c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24727a0>, '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 0x24736a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2473b30>, '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': '9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606', '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 17:47:23 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 17:47:23 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 17:47:23 INFO - Using env: {'DISPLAY': ':0', 17:47:23 INFO - 'HOME': '/home/cltbld', 17:47:23 INFO - 'LANG': 'en_US.UTF-8', 17:47:23 INFO - 'LANGUAGE': 'en_US:en', 17:47:23 INFO - 'LOGNAME': 'cltbld', 17:47:23 INFO - 'MAIL': '/var/mail/cltbld', 17:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:23 INFO - 'MOZ_NO_REMOTE': '1', 17:47:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:23 INFO - 'NO_EM_RESTART': '1', 17:47:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:23 INFO - 'PWD': '/builds/slave/test', 17:47:23 INFO - 'SHELL': '/bin/bash', 17:47:23 INFO - 'SHLVL': '1', 17:47:23 INFO - 'TERM': 'linux', 17:47:23 INFO - 'TMOUT': '86400', 17:47:23 INFO - 'USER': 'cltbld', 17:47:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606', 17:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:23 INFO - '_': '/tools/buildbot/bin/python'} 17:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:47:23 INFO - Running setup.py (path:/tmp/pip-znZKMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:47:23 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)) 17:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:47:23 INFO - Running setup.py (path:/tmp/pip-NkbEq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:47:23 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)) 17:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:47:23 INFO - Running setup.py (path:/tmp/pip-FV9RNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:47:23 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)) 17:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:47:23 INFO - Running setup.py (path:/tmp/pip-XBd9TP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:47:23 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)) 17:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:47:23 INFO - Running setup.py (path:/tmp/pip-mH5Epm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:47:23 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)) 17:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:47:23 INFO - Running setup.py (path:/tmp/pip-cAWyeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:47:23 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)) 17:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:47:23 INFO - Running setup.py (path:/tmp/pip-VhUkPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:47:23 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)) 17:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:47:23 INFO - Running setup.py (path:/tmp/pip-nepORY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:47:23 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)) 17:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:47:23 INFO - Running setup.py (path:/tmp/pip-s3JRGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:47:23 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)) 17:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:47:23 INFO - Running setup.py (path:/tmp/pip-9TL1yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:47:24 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)) 17:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:47:24 INFO - Running setup.py (path:/tmp/pip-9b9DjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:47:24 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)) 17:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:47:24 INFO - Running setup.py (path:/tmp/pip-dIpS6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:47:24 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)) 17:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:47:24 INFO - Running setup.py (path:/tmp/pip-NeBJZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:47:24 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)) 17:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:47:24 INFO - Running setup.py (path:/tmp/pip-8o2r_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:47:24 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)) 17:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:24 INFO - Running setup.py (path:/tmp/pip-Zi46fO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:24 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)) 17:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:47:24 INFO - Running setup.py (path:/tmp/pip-1vldkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:47:24 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)) 17:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:47:24 INFO - Running setup.py (path:/tmp/pip-_eXTmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:47:24 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)) 17:47:24 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)) 17:47:24 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)) 17:47:24 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)) 17:47:24 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)) 17:47:24 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)) 17:47:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:25 INFO - Downloading blessings-1.6.tar.gz 17:47:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:47:25 INFO - Installing collected packages: blessings 17:47:25 INFO - Running setup.py install for blessings 17:47:25 INFO - Successfully installed blessings 17:47:25 INFO - Cleaning up... 17:47:25 INFO - Return code: 0 17:47:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:47:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:47:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:47:26 INFO - Reading from file tmpfile_stdout 17:47:26 INFO - Current package versions: 17:47:26 INFO - argparse == 1.2.1 17:47:26 INFO - blessings == 1.6 17:47:26 INFO - blobuploader == 1.2.4 17:47:26 INFO - docopt == 0.6.1 17:47:26 INFO - functools32 == 3.2.3-2 17:47:26 INFO - jsonschema == 2.5.1 17:47:26 INFO - manifestparser == 1.1 17:47:26 INFO - mozInstall == 1.12 17:47:26 INFO - mozcrash == 1.0 17:47:26 INFO - mozdebug == 0.1 17:47:26 INFO - mozdevice == 0.50 17:47:26 INFO - mozfile == 1.2 17:47:26 INFO - mozhttpd == 0.7 17:47:26 INFO - mozinfo == 0.9 17:47:26 INFO - mozleak == 0.1 17:47:26 INFO - mozlog == 3.4 17:47:26 INFO - moznetwork == 0.27 17:47:26 INFO - mozprocess == 0.25 17:47:26 INFO - mozprofile == 0.28 17:47:26 INFO - mozrunner == 6.13 17:47:26 INFO - mozscreenshot == 0.1 17:47:26 INFO - mozsystemmonitor == 0.3 17:47:26 INFO - moztest == 0.8 17:47:26 INFO - mozversion == 1.4 17:47:26 INFO - psutil == 3.1.1 17:47:26 INFO - requests == 1.2.3 17:47:26 INFO - wsgiref == 0.1.2 17:47:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:47: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')]} 17:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47: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')]} 17:47:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:26 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 0x21021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24755c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24727a0>, '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 0x24736a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2473b30>, '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': '9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606', '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 17:47:26 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 17:47:26 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 17:47:26 INFO - Using env: {'DISPLAY': ':0', 17:47:26 INFO - 'HOME': '/home/cltbld', 17:47:26 INFO - 'LANG': 'en_US.UTF-8', 17:47:26 INFO - 'LANGUAGE': 'en_US:en', 17:47:26 INFO - 'LOGNAME': 'cltbld', 17:47:26 INFO - 'MAIL': '/var/mail/cltbld', 17:47:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:26 INFO - 'MOZ_NO_REMOTE': '1', 17:47:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:26 INFO - 'NO_EM_RESTART': '1', 17:47:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:26 INFO - 'PWD': '/builds/slave/test', 17:47:26 INFO - 'SHELL': '/bin/bash', 17:47:26 INFO - 'SHLVL': '1', 17:47:26 INFO - 'TERM': 'linux', 17:47:26 INFO - 'TMOUT': '86400', 17:47:26 INFO - 'USER': 'cltbld', 17:47:26 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606', 17:47:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:26 INFO - '_': '/tools/buildbot/bin/python'} 17:47:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:26 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)) 17:47:26 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)) 17:47:26 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)) 17:47:26 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)) 17:47:26 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)) 17:47:26 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)) 17:47:26 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)) 17:47:26 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)) 17:47:26 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)) 17:47:26 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)) 17:47:26 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)) 17:47:26 INFO - Cleaning up... 17:47:26 INFO - Return code: 0 17:47:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:47: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')]} 17:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47: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')]} 17:47:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24755c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24727a0>, '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 0x24736a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2473b30>, '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': '9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606', '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 17:47:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:47:26 INFO - Using env: {'DISPLAY': ':0', 17:47:26 INFO - 'HOME': '/home/cltbld', 17:47:26 INFO - 'LANG': 'en_US.UTF-8', 17:47:26 INFO - 'LANGUAGE': 'en_US:en', 17:47:26 INFO - 'LOGNAME': 'cltbld', 17:47:26 INFO - 'MAIL': '/var/mail/cltbld', 17:47:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:26 INFO - 'MOZ_NO_REMOTE': '1', 17:47:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:26 INFO - 'NO_EM_RESTART': '1', 17:47:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:26 INFO - 'PWD': '/builds/slave/test', 17:47:26 INFO - 'SHELL': '/bin/bash', 17:47:26 INFO - 'SHLVL': '1', 17:47:26 INFO - 'TERM': 'linux', 17:47:26 INFO - 'TMOUT': '86400', 17:47:26 INFO - 'USER': 'cltbld', 17:47:26 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606', 17:47:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:26 INFO - '_': '/tools/buildbot/bin/python'} 17:47:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:47:26 INFO - Cleaning up... 17:47:26 INFO - Return code: 0 17:47:26 INFO - Running post-action listener: _resource_record_post_action 17:47:26 INFO - Running post-action listener: _start_resource_monitoring 17:47:26 INFO - Starting resource monitoring. 17:47:26 INFO - [mozharness: 2017-05-17 00:47:26.518050Z] Finished create-virtualenv step (success) 17:47:26 INFO - [mozharness: 2017-05-17 00:47:26.518507Z] Running install step. 17:47:26 INFO - Running pre-action listener: _resource_record_pre_action 17:47:26 INFO - Running main action method: install 17:47:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:47:26 INFO - Reading from file tmpfile_stdout 17:47:26 INFO - Detecting whether we're running mozinstall >=1.0... 17:47:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:47:26 INFO - Reading from file tmpfile_stdout 17:47:26 INFO - Output received: 17:47:26 INFO - Usage: mozinstall [options] installer 17:47:26 INFO - Options: 17:47:26 INFO - -h, --help show this help message and exit 17:47:26 INFO - -d DEST, --destination=DEST 17:47:26 INFO - Directory to install application into. [default: 17:47:26 INFO - "/builds/slave/test"] 17:47:26 INFO - --app=APP Application being installed. [default: firefox] 17:47:26 INFO - mkdir: /builds/slave/test/build/application 17:47:26 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'] 17:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:47:43 INFO - Reading from file tmpfile_stdout 17:47:43 INFO - Output received: 17:47:43 INFO - /builds/slave/test/build/application/firefox/firefox 17:47:43 INFO - Running post-action listener: _resource_record_post_action 17:47:43 INFO - [mozharness: 2017-05-17 00:47:43.400426Z] Finished install step (success) 17:47:43 INFO - [mozharness: 2017-05-17 00:47:43.400703Z] Running run-tests step. 17:47:43 INFO - Running pre-action listener: _resource_record_pre_action 17:47:43 INFO - Running main action method: run_tests 17:47:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:47:43 INFO - Python 2.7.3 17:47:43 INFO - Return code: 0 17:47:43 INFO - grabbing minidump binary from tooltool 17:47:43 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')]} 17:47:43 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 0x24727a0>, '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 0x24736a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2473b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:47:43 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 17:47:43 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 17:47:43 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 17:47:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:47:43 INFO - Return code: 0 17:47:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:47:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:47:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:47:43 INFO - ENV: RUST_BACKTRACE is now 1 17:47:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:47:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:47:43 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/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 17:47:43 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/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 17:47:43 INFO - Using env: {'DISPLAY': ':0', 17:47:43 INFO - 'HOME': '/home/cltbld', 17:47:43 INFO - 'LANG': 'en_US.UTF-8', 17:47:43 INFO - 'LANGUAGE': 'en_US:en', 17:47:43 INFO - 'LOGNAME': 'cltbld', 17:47:43 INFO - 'MAIL': '/var/mail/cltbld', 17:47:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:47:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:43 INFO - 'MOZ_NO_REMOTE': '1', 17:47:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:47:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:43 INFO - 'NO_EM_RESTART': '1', 17:47:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:43 INFO - 'PWD': '/builds/slave/test', 17:47:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:47:43 INFO - 'RUST_BACKTRACE': '1', 17:47:43 INFO - 'SHELL': '/bin/bash', 17:47:43 INFO - 'SHLVL': '1', 17:47:43 INFO - 'TERM': 'linux', 17:47:43 INFO - 'TMOUT': '86400', 17:47:43 INFO - 'USER': 'cltbld', 17:47:43 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606', 17:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:43 INFO - '_': '/tools/buildbot/bin/python'} 17:47:43 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/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 17:47:43 INFO - mozversion application_buildid: 20170517001001 17:47:43 INFO - mozversion application_changeset: 985b3ee939338022ef44028b5251f77af19c3638 17:47:43 INFO - mozversion application_display_name: Nightly 17:47:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:47:43 INFO - mozversion application_name: Firefox 17:47:43 INFO - mozversion application_remotingname: firefox 17:47:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:47:43 INFO - mozversion application_vendor: Mozilla 17:47:43 INFO - mozversion application_version: 55.0a1 17:47:43 INFO - mozversion platform_buildid: 20170517001001 17:47:43 INFO - mozversion platform_changeset: 985b3ee939338022ef44028b5251f77af19c3638 17:47:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:47:43 INFO - mozversion platform_version: 55.0a1 17:47:43 INFO - using testdate: 1494982063 17:47:43 INFO - actual date: 1494982063 17:47:43 INFO - starting webserver on 'localhost:45711' 17:47:43 INFO - SUITE-START | Running 2 tests 17:47:43 INFO - TEST-START | dromaeo_css 17:47:43 INFO - operating with platform_type : linux_ 17:47:43 INFO - Initialising browser for dromaeo_css test... 17:47:43 INFO - TEST-INFO | started process 28608 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQWF1vY/profile http://localhost:45711/getInfo.html) 17:47:44 INFO - PID 28608 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2930: String.localeCompare is deprecated; use String.prototype.localeCompare instead 17:47:47 INFO - PID 28608 | __metrics Screen width/height:1600/1200 17:47:47 INFO - PID 28608 | colorDepth:24 17:47:47 INFO - PID 28608 | Browser inner width/height: 1024/695 17:47:47 INFO - PID 28608 | __metrics 17:47:50 INFO - TEST-INFO | 28608: exit 0 17:47:50 INFO - Browser initialized. 17:47:50 INFO - Running cycle 1/1 for dromaeo_css test... 17:47:50 INFO - TEST-INFO | started process 28796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQWF1vY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:48:01 INFO - PID 28796 | RSS: Main: 165318656 17:48:01 INFO - PID 28796 | 17:51:06 INFO - PID 28796 | Cycle 1(1): loaded http://localhost:45711/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45711/tests/dromaeo/cssquery-ext.html) 17:51:08 INFO - PID 28796 | RSS: Main: 173494272 17:51:08 INFO - PID 28796 | 17:54:10 INFO - PID 28796 | Cycle 1(1): loaded http://localhost:45711/tests/dromaeo/cssquery-ext.html (next: http://localhost:45711/tests/dromaeo/cssquery-jquery.html) 17:54:11 INFO - PID 28796 | RSS: Main: 170835968 17:54:11 INFO - PID 28796 | 17:57:12 INFO - PID 28796 | Cycle 1(1): loaded http://localhost:45711/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45711/tests/dromaeo/cssquery-mootools.html) 17:57:13 INFO - PID 28796 | RSS: Main: 174878720 17:57:13 INFO - PID 28796 | 18:00:15 INFO - PID 28796 | Cycle 1(1): loaded http://localhost:45711/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45711/tests/dromaeo/cssquery-prototype.html) 18:00:15 INFO - PID 28796 | RSS: Main: 169627648 18:00:15 INFO - PID 28796 | 18:03:18 INFO - PID 28796 | Cycle 1(1): loaded http://localhost:45711/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45711/tests/dromaeo/cssquery-yui.html) 18:03:19 INFO - PID 28796 | RSS: Main: 170864640 18:03:19 INFO - PID 28796 | 18:06:21 INFO - PID 28796 | Cycle 1(1): loaded http://localhost:45711/tests/dromaeo/cssquery-yui.html (next: http://localhost:45711/tests/dromaeo/cssquery-dojo.html) 18:06:21 INFO - PID 28796 | RSS: Main: 177635328 18:06:21 INFO - PID 28796 | 18:06:21 INFO - PID 28796 | __start_tp_report 18:06:21 INFO - PID 28796 | _x_x_mozilla_page_load 18:06:21 INFO - PID 28796 | _x_x_mozilla_page_load_details 18:06:21 INFO - PID 28796 | |i|pagename|runs| 18:06:21 INFO - PID 28796 | |0;dojo.html;2697.231289082611;2706.3098909778005;2727.3318037080917;2734.302752798036;2743.8216515926465;5095.71973541456;5157.872241025412;5169.224616307546;5169.250458683488;5216.478352164786;5177.508136727014;5177.870553236162;5263.921041184376;5271.2356708277275;5274.156135018397;4402.185595664812;4654.86035418938;4656.7205967641885;4663.230566956465;4680.695754775946;4692.601128904047;4700.01299727056;4740.478547359788;4765.237561990082;4777.570018698317;4596.655250856199;4625.8149674013;4650.86047418578;4670.0426412585675;4682.391289132391;4635.490096089427;4647.140279048387;4668.253079507296;4698.600618947394;4702.036082603058;4602.550196688033;4651.418572678415;4651.767411629405;4675.625949923998;4686.742229177394;5127.435982041972;5247.711375874325;5248.239005344242;5256.500632439912;5283.339582552181;5540.556755459554;5616.045272303718;5665.603407761459;5665.631733937281;5673.120666296731;5636.408177141423;5636.549076073904;5645.32256129263;5647.407022262644;5650.3219613646215;5204.115300398866;5241.42344342122;5259.868503287448;5270.209468579706;5285.07511185541;5762.337331206881;5789.478946894799;5795.797147099831;5827.562932779973;5834.03738383162;5551.8889622208135;5553.888922221533;5561.4716601922755;5561.944380556223;5562.054450743383;5603.579731520153;5604.439556044363;5637.774489020475;5651.4348565143155;5664.320281566156;5624.803131890364;5630.07103827872;5632.957902787997;5646.181303710939;5647.040003199466;5598;5608.214849921014;5615.129654903497;5615.904898544826;5631.549476041907;4590.288505281686;4662.370579971728;4675.345451636774;4676.228422310281;4678.789454474557;3983.24318379507;4013.0168108812945;4017.8593749218635;4018.9196216075516;4066.044479547304;4822.204336284473;4825.083234185494;4827.9137194131035;4832.855014349575;4871.318015477836;5582.106862901916;5643.01247281724;5649.124385720138;5663.773449061991;5676.8864622707315;4738.19450693383;4782.354382158364;4809.615230781529;4822.252550854623;4823.807047718122;4841.346418233494;4843.346148269939;4869.659123861366;4898.14282500561;4910.238912968495;5243.554297884646;5246.3704355477585;5251.868703282448;5254.553362964114;5256.894862102813;5562.388137304974;5562.666240025612;5638.520725738358;5652.943470565242;5664.745086471201;5244.632875698664;5253.684778913277;5258.1849813279005;5259.342582177228;5297.576193904555;5553.500184983371;5553.777848885999;5570.86072848182;5574.358948720949;5624.7187640616985;5516.806911758069;5648.124540696199;5656.2929633795775;5657.349404818498;5664.0371136906;5393.083175860034;5491.203775452457;5500.28496295479;5503.614746967673;5511.889762204653;5493.615446918678;5499.065158922913;5499.3675727291875;5507.146392309199;5549.112142057252;5388.541973932103;5394.379646340721;5423.566114710892;5432.674039557639;5487.588430867621;5373.623846330719;5423.701696406735;5491.670499770026;5525.834224973257;5539.806106786243;5382.111951527954;5390.541803946709;5392.838214853561;5398.811041613525;5399.487048730364 18:06:21 INFO - PID 28796 | |1;ext.html;655.1810237203496;712.8253577873422;730.6018220070063;1057.238788072588;1074.4681382715557;32578.511322330156;33698.326033479316;33800.83099584499;33873.153171170736;34005.82997085014;34956.650433495655;35301.47047794285;35365;35409.64590354096;35411.4688279676;6927.376536111749;7054.118235220611;7160.570365778044;7187.748428804993;7198.6400679966055;7109.289071092901;7140.250273721236;7169.928300717004;7184.568925864465;7213.819654508653;7165.605891675982;7200.603966781851;7218.530795498302;7224.53040552365;7237.276272372747;7186.640667966633;7199.136103667541;7213.78358649244;7233.059702238728;7239.601821899793;7056.400205982498;7103.964480177566;7107.395871350941;7108.644567771643;7119.644017799089;31827;31989.6801031989;31990;32036.519452208235;32170.839145804122;3079.7844150909445;3082.8150310981414;3086.10502954143;3092.3351479431803;3104.5498402731705;24736.3815904602;24939.62590561143;24986.625200622006;24997.375065623324;25021.49957000868;3061.0357737312675;3077.753779697619;3094.1645755646073;3101.720845123927;3163.43058249515;133976;134012;134325;145564;149771.25114374358;40009.39985900214;40378;40446.59553404487;40459.59540404617;40486.59513404887;41422;41771.37342939858;41879.58120418818;41891.37162942559;42040.36939445911;11687.941560292144;11695.766084678258;11753.118516111326;11768.94115529434;11823.172377933462;9042.728718138467;9058.547072646474;9065.45607263553;9075.773105672411;9158.175764181256;12774.680632984064;12856.29290389019;12990.805137922938;12992.621918301309;13174.407151678197;5338.893222135535;5372.1941708744;5424.755885985141;5472.671639701631;5482.479164479368;859.8710193470904;891.5765011619429;923.7690577355661;933.495912207414;946.9961840449146;19898.50253743668;20943.790562094186;21040.368788936357;21089.472763180736;21132.894335528224;990.3711143423834;991.4150651115876;998.6454808543008;1015.6648306058983;1017.1862509991977;11007.889921100686;11291.887081129247;11353;11355.772884542428;11394.658160255205;168260;168321;168650;168801;169428;40362.394564081565;40655;40754.38868416976;40809.59190408058;40932;1199.4062938845327;1230.8399908011902;1234.697499112723;1248.5193200617646;1252.3425201769144;19250.22999080021;19934.70097948561;20395.694064588748;20513;20865.478363041046;29631.555526666685;29634.110976670734;29740;29751.404971900873;29845.70154298429;147551;147647;148558;148637;148898.25550872178;28751.71248287574;29450.410991780474;29723.405531889675;29770.404591908475;30574.541381879735;35785;36168.27663446769;36318.455223172205;36604.63395366012;36875.26249475049;27477.31306717348;27690.44619107647;27952.860235698692;28164.577531336636;28190.85904570546;26694.466110678066;27171.456570868868;27629.861850690617;27770.583441247993;28729.856350718113;29350.559741603465;30211.395772083997;30528.236794079436;30586.84706576453;30688;26531.204063878115;26802.59796103021;26972.865135674198;27167.45665086727;27513.31216719598;21567.2451464198;22658.546829063656;22737.31788046361;22757.317280481613;22780.20269290567 18:06:21 INFO - PID 28796 | |2;jquery.html;417.1823226476106;422.3263894088927;423.7669281894957;439.71858010873035;447.4317616626884;17264.65470690587;17276.395326163587;17882.552936176602;17941;18033.909830450844;16398.26207820648;16516.66966660666;16532.83467165328;16566.254518546662;16946.491605251864;5418.729063546817;5438.428964958682;5540;5546.306711661043;5588.133839254922;5421.484958928915;5528.585356098289;5536.944630553703;5539.335279766434;5559.3328800543995;5274.314339135907;5483.122700367942;5487.6981766002855;5501.284832971728;5518.227448157261;5448.945510544883;5511.476409741068;5513.8345849624575;5514.448555144473;5538.6399884007615;4813.446453657839;4931.334269873557;4962.15643340633;4986.87532811679;4994.725290109042;21185.894070529703;21194.682079768816;21298.574028519342;21336.893315533478;21695.891520542296;1593.569736171239;1628.096406494395;1629.030726717601;1629.657771867909;1632.0860318221835;14270.215138167398;14968.401263949429;14973.176475293854;15108.773368399483;15123.168225747579;2050.302897015007;2058.711780350752;2114.249441448279;2114.756802967663;2115.4922818523596;81738.18261817365;81876.18123818745;82335.58832205861;83813.58093209495;84572.57713711515;11051.447427628747;11331.943340283246;11461.770764584662;11515.942420287845;11604.593839215755;15592.142432166112;15755.369785208693;15817.915506476356;15844.76232856508;15936.123513206885;7049.588061557602;7282.5690730503065;7373.852522949618;7417.925820741832;7426.777196684108;6526.804195874131;6541.542092053605;6625.86748265032;6635;6672.599644021374;7111.182214045451;7252.528585641917;7277.345038946414;7290.526115802456;7299.671514781848;2074.9832582034996;2086.3607536466384;2126.3727200475896;2150.5698860228017;2203.647416413366;844.8817165596821;860;872.6858331000834;874.6676263020139;902.0708670069838;16880.746788798177;16887.577810554834;17161.828381716274;17197.31210751581;17761.555961101076;873.7902903303288;874.8119154381839;881.9603117859712;883.2536506651869;894.8881389826272;9216.447013179231;9283.675071372469;9734.97782732817;9749.561269742879;9932.553035113437;312894;319015;320074;321426;329159;66628.66685666541;68743;70783.64608177029;71606.64196678983;76207.9999999989;1055.7307886488895;1063.5692544519482;1102.8897110289067;1111.7943180511631;1112.6550769261394;16824.915875421033;17022.829771702123;17513.56216094608;17746.20142093583;18241.817581824012;37742.62257377391;38275.42586861255;38299;39389.212215756095;39802.2039559213;45104;47686.523134769595;47720;48010.27984580164;48120.27819582779;8220.506769593843;8375.664973400995;8518.91481085206;8521.957390213258;8679.305655547414;13023.934880325538;13057.673558161123;13139.408726607135;13219.339033048116;13243.20540767557;10437.425941572983;10647.254692171473;10808.784199239295;10851.891481085087;11362.772744545227;10740.355578664992;10771.6229931952;10947.397893115955;11007;11032;11218.887811121784;11364.886351136383;11556.537738490366;11667.474963626826;11775.705607359541;8478.109798471318;8537.231649151607;8545.102764209669;8718;8742.519161446182;11272.210945234083;11298.435078246219;11466.2546934449;11560;11579.247348922294 18:06:21 INFO - PID 28796 | |3;mootools.html;1258.1570347866927;1321.3591408167038;1338.1435881036132;1339.5579458778604;1340.3298350824582;10092.394456332617;10282.537285822138;10526.736831579214;10584.52369643366;10698;10406.843897341527;10507.947460262707;10565.313254638442;10597.311174773653;10611.84082238767;2292.3810571145823;2298.5517824024323;2330.5338932213626;2330.7669233076726;2332.941676458085;2257.604919139144;2306.688597039395;2310.2722642367685;2312.7455979842202;2313.8727369994645;2264.2188444986455;2270.2281224383705;2318.1770471482632;2320.2575175943703;2328.057136859566;2108.230495869012;2182.039902442928;2199.978000220009;2210.9829478439938;2217.423469897822;2095.4656562576597;2106.4102051425625;2118.8199003084756;2120.3744895255936;2293.793558579719;10398.948005260001;10419.32274402169;10438.321509101885;10467;10467.110295624881;5688.573356998241;5848.795292164754;5885.529157667376;5914.733836977303;5917.763289468416;3451.9795179218186;3623.9275214495824;3659.5242618459697;3740.9251814963823;3742.5883152853166;1169.9590514331958;1176.9764604707857;1191.2316555821533;1223.6696092055183;1248.5318005747845;15045.097294162386;15138.621534461507;15233.086014839146;15241.923790381088;15278;4842.394700662418;5018.096742586369;5022.372203474566;5062.645614806928;5155.922661160085;11151.442427878574;11166.665000050012;11176;11193.16051296156;11198.888011119947;5654.604177707603;5657.858553536113;5690.857728556819;5703.429657034263;5730.054541000772;5037.420696619935;5154.845354639367;5173.71544565045;5175.120229560984;5212.296339994053;3874.535055793323;4028.4762980812307;4054.9797251013556;4084.6323830855367;4161.146964872194;1167.6146871532544;1170.7014711248578;1174.0431548288288;1197.5928184417166;1200.5977997370978;705.4567982653328;716.6130289643534;719.8776208044645;726.6330503095903;734.963251837406;5329;5341.946580534145;5427.348718153847;5484.314460692413;5520.779168833202;531.9654222475526;548.5885585810641;552.917062440629;553.4161459660016;553.8006317725616;3870.303345397799;3884.0484081400236;3929.9214015719526;3941.645251927283;3982.74112182713;13374.197548147142;13496.595102146952;13793;13814.792778108336;13820.861791382158;13616.863831361758;13654.317284135754;13668.65828354299;13690.65773355674;13710.108842925178;7458.70165193397;7564.205758395289;7700.268474494914;7712.460127791113;7751;5789.102689083199;5948.018576934757;5968.373320801254;6101.969490152698;6105.419985101408;11946.402679866145;12161.69595760113;12250.448729807358;12423.62729118128;12473.251604903735;12253.081018923795;12780.61658150257;12812.359382031047;12815.423305951068;12877.742445150858;8480.787980300542;8570.442921210102;8641.827163456821;8643.222110009878;8647.567621618768;9292.070792920924;9375.10936461035;9386;9520.523973801144;9525.761855953378;8118.228768267005;8139.06400763896;8227.794305142419;8238.50568965864;8478.152184781473;8067.757967260992;8124.55314957683;8190.7952301192945;8262.83474330522;8334.166583341617;7359.411247100326;7421.2207718190975;7450.850982980419;7455.0681164854395;7480.738174163878;4903.4606193317995;5241.633085683966;5292.285541451854;5350.411454739898;5378.031954248273;5088.618353623567;5102.336696229615;5169.715665638426;5203.19350500673;5220.738963051908 18:06:21 INFO - PID 28796 | |4;prototype.html;356.49021898684884;381.47166174847837;385.41801879162455;385.4757529759527;390.342273269541;5489.91765123523;5604.691741954191;5622.859428514289;5627.296587926509;5636.0982242841155;5486.506214440699;5491.258680078188;5494.972525137368;5499.120140777476;5501.587380946425;4257.254980378437;4294.763787991659;4304.5695430456935;4317.525072242067;4335.154644844257;4319.69762116652;4324.481062272532;4325.978370108145;4330.740155590659;4334.566543345672;4287.5069367022725;4288.16380805743;4292.227399068166;4307.095509942916;4313.784310784464;4220.645000622588;4273.7008409411355;4310.504292006428;4326.156399502099;4329.718568293051;3864.246471937973;3876.127871228979;3879.1465877506903;3885.436611691317;3888.6111388861173;5371.59713021521;5384.273123128406;5388.272583201257;5389.541888939445;5392.946070539284;4968.701877887338;5027.2207807789855;5047.747612619354;5097.847064588068;5098.974505127488;5777.537796976232;5781.479666830005;5811.302643682785;5832.6500409975115;5855.76576936922;4279.2083464559155;4284.100338928829;4305.806238719265;4307.095509942916;4317.568243175689;5855.795047173328;6061.212042434499;6068.787592434243;6089.299730530957;6090.96954515229;4413.514513403523;4417.337399390053;4424.380586717862;4430.424044874146;4450.599446049871;4474.552544745499;4488.798004089824;4494.5730155635165;4503.301988191835;4510.684252102387;4583.564561366665;4748;4819.59033482151;4819.855404337875;5023.723695196726;5825.330087040044;5828.446297601721;5830;5832.50423713989;5844.473997340175;1412.5479846449039;1444.1768192130594;1444.36447962896;1449.463698431587;1450.840407555168;912.9087091290818;955.9187469065207;959.5154447004218;962.0716009051299;980.1962390839585;5072.568831649277;5089.898202035939;5101.8724531887;5105.366282789546;5121.436641969381;6087.29996050451;6095.725692343855;6122.571420000646;6124.234470691164;6136.95671735806;4978.8755281118265;5090.516400941905;5100.719460429712;5106.285120083191;5123.564497017721;3194.7603929705365;3213.517972304173;3224.339010502841;3227.5320078588475;3242.238074052596;5466.808661696821;5588.888222235532;5599.300087489064;5628.718564071862;5632.3804381518;5998.240809227804;6151.507879369639;6189.381061893865;6205.193324867739;6213.751449942042;5577.107662773937;5578.804741834017;5587.200703521563;5600.467955544135;5625.971870140705;5922.644641321534;6008.609440386361;6019.879602408015;6021.909671355021;6031.215941927521;5886.264216972879;5937.317208521075;5966.940330596639;5969.611975221596;5970.820875373745;5587.636803607753;5594.804181853779;5606.85982850432;5619.606627536196;5621.650803807139;3982.960170398259;4007.9398809017307;4014.7791871446184;4032.737872038308;4087.448194493705;6025.312912384539;6031.09533569968;6032.095185722177;6035.969820150871;6048.758049678139;5837.5329973601165;5839.708014599338;5857.033589457692;5871.6770577616935;5891.3224979127945;5694.202811606461;5796.21751063601;5796.681182535001;5816.516788218977;5828.737706803119;5719.742611582572;5726;5740.68426236561;5762.827115186551;5767.5674324425;5667.4615911488345;5808.215890854681;5831.1544826000845;5848.239728835224;5876.471117599436;5697.886042279214;5713.800016999551;5718.914216286842;5730.828075157752;5733.050762740688 18:06:21 INFO - PID 28796 | |5;yui.html;737.3695490355742;745.9216782237864;761.8933349331091;763.2787016269624;772.9806754831128;11308.773824523505;11909.821352679717;12698.111132220736;13305.534306299282;13306.334683265846;14692.118472891634;14874.181919994397;15279.465218717347;15282.541523754277;15340.309686064125;858.3047731337621;883.8055627761883;887.2813021452644;887.7248053103558;889.4840992224495;882.9779255518599;884.2307192742323;884.9690260840872;891.3136884598855;891.3270480786997;919.7838507950627;922.349743430883;922.6493932305748;925.3013974449282;926.8285367207054;911.7355966769662;912.8767616371771;914.7118657622827;917.6375331743957;918.1048477734222;673.7877568565887;677.1569396101885;677.9322067793231;678.7929681447157;679.7247114918466;12675.845106331946;12729.872701273054;13172.407241674147;14368.425262989467;14522.91078169131;15481.690366192726;15580.454684086117;15669.529914102595;15800.841991580051;16152.273147708382;12436.502539898393;12787.424565894557;12825.551105711349;12930.935345323212;12983.87016129836;3093.6287645482685;3113.657497675254;3115.8286294253808;3124.375124974991;3127.9218019549467;64255;65130.67434662844;65982.3401765981;66501.66749166271;68520.31479685238;12218.327991960528;12477.563285285152;12582.622521324374;12727.10910236293;12729.172603780724;22233.666495002588;22292.44268893258;22518.211862584732;22647.660285095735;22776.430589235402;6198.2871969723155;6343.397377249154;6530.085787989685;6581.80254592363;6592.373724496165;3131.906042818719;3205.7916235444623;3209.0533292678715;3212.8072315661134;3216.565763621881;3514.4552594347915;3608.548931383577;3617.113807117273;4209.852655157055;4336.978315108404;771.3058247577113;789.5578476053429;806.5604245685997;806.9515829050158;807.8384323135397;563.39997902234;579.9623024503394;589.3958692340385;589.5165963909553;590.8109404990448;8726.69456569017;9292.814143717223;9745.317827752131;9774.95112524447;9981.80036399268;575.3958343739057;582.811542657319;590.1354515634616;595.4402861310355;597.4951166264586;4171.457710497677;4335.479742430928;4341.370501277297;4367.039251364695;4396.802143903532;62468.68765656143;62494.375056249766;62787.6860615694;65728.34271657318;65772.67113664497;55276;56233.71883140558;56615.790710346766;57410.712946435;57776.42223577711;49253.50746492489;51171;51651.22523162155;52349.7382513085;52791.472085278656;8546.487210767375;8797.47215167092;8841.248493878093;9104.089591040844;9112.0887911211;26739.197824065308;26785.196444106707;26791.330216744736;26840;27107;32557.511637325933;32566.674333256364;33166.33667326688;33191.66808331886;33629.15927101842;10850.67447976562;11084.889151108386;11098.722531936766;11104.61133860311;12175.817362739388;13391.196528207949;13407.195568265935;13749.518766843112;15310.234488275764;15573.610659733597;12959.546415875398;13997.230152341312;14244.643883902985;14412.279386030867;14489.637759056108;13575.185488870698;13901.65245868821;14139.929300353433;14207.715845682822;14417.062890912057;12481.750364992467;12800.16798908068;12881.613551593467;13160.341982901009;13457.596272111461;9830.164436022733;10228;10369.585216591553;10512.421816799844;10614.416207108374;11110.666679999613;11611.187216894736;11924.940375298069;12180.512779488721;12941.158824676366 18:06:21 INFO - PID 28796 | __end_tp_report 18:06:21 INFO - PID 28796 | __start_cc_report 18:06:21 INFO - PID 28796 | _x_x_mozilla_cycle_collect,272 18:06:21 INFO - PID 28796 | __end_cc_report 18:06:21 INFO - PID 28796 | __startTimestamp1494983181647__endTimestamp 18:06:21 INFO - PID 28796 | 18:06:21 INFO - PID 28796 | ------- Summary: start ------- 18:06:21 INFO - PID 28796 | Number of tests: 6 18:06:21 INFO - PID 28796 | 18:06:21 INFO - PID 28796 | [#0] dojo.html Cycles:165 Average:5147.58 Median:5283.34 stddev:607.42 (11.5%) stddev-sans-first:578.06 18:06:21 INFO - PID 28796 | Values: 2697.2 2706.3 2727.3 2734.3 2743.8 5095.7 5157.9 5169.2 5169.3 5216.5 5177.5 5177.9 5263.9 5271.2 5274.2 4402.2 4654.9 4656.7 4663.2 4680.7 4692.6 4700.0 4740.5 4765.2 4777.6 4596.7 4625.8 4650.9 4670.0 4682.4 4635.5 4647.1 4668.3 4698.6 4702.0 4602.6 4651.4 4651.8 4675.6 4686.7 5127.4 5247.7 5248.2 5256.5 5283.3 5540.6 5616.0 5665.6 5665.6 5673.1 5636.4 5636.5 5645.3 5647.4 5650.3 5204.1 5241.4 5259.9 5270.2 5285.1 5762.3 5789.5 5795.8 5827.6 5834.0 5551.9 5553.9 5561.5 5561.9 5562.1 5603.6 5604.4 5637.8 5651.4 5664.3 5624.8 5630.1 5633.0 5646.2 5647.0 5598.0 5608.2 5615.1 5615.9 5631.5 4590.3 4662.4 4675.3 4676.2 4678.8 3983.2 4013.0 4017.9 4018.9 4066.0 4822.2 4825.1 4827.9 4832.9 4871.3 5582.1 5643.0 5649.1 5663.8 5676.9 4738.2 4782.4 4809.6 4822.3 4823.8 4841.3 4843.3 4869.7 4898.1 4910.2 5243.6 5246.4 5251.9 5254.6 5256.9 5562.4 5562.7 5638.5 5652.9 5664.7 5244.6 5253.7 5258.2 5259.3 5297.6 5553.5 5553.8 5570.9 5574.4 5624.7 5516.8 5648.1 5656.3 5657.3 5664.0 5393.1 5491.2 5500.3 5503.6 5511.9 5493.6 5499.1 5499.4 5507.1 5549.1 5388.5 5394.4 5423.6 5432.7 5487.6 5373.6 5423.7 5491.7 5525.8 5539.8 5382.1 5390.5 5392.8 5398.8 5399.5 18:06:21 INFO - PID 28796 | 18:06:21 INFO - PID 28796 | [#1] ext.html Cycles:180 Average:29822.73 Median:3078.77 stddev:39348.83 (1278.1%) stddev-sans-first:39398.26 18:06:21 INFO - PID 28796 | Values: 655.2 712.8 730.6 1057.2 1074.5 32578.5 33698.3 33800.8 33873.2 34005.8 34956.7 35301.5 35365.0 35409.6 35411.5 6927.4 7054.1 7160.6 7187.7 7198.6 7109.3 7140.3 7169.9 7184.6 7213.8 7165.6 7200.6 7218.5 7224.5 7237.3 7186.6 7199.1 7213.8 7233.1 7239.6 7056.4 7104.0 7107.4 7108.6 7119.6 31827.0 31989.7 31990.0 32036.5 32170.8 3079.8 3082.8 3086.1 3092.3 3104.5 24736.4 24939.6 24986.6 24997.4 25021.5 3061.0 3077.8 3094.2 3101.7 3163.4 133976.0 134012.0 134325.0 145564.0 149771.3 40009.4 40378.0 40446.6 40459.6 40486.6 41422.0 41771.4 41879.6 41891.4 42040.4 11687.9 11695.8 11753.1 11768.9 11823.2 9042.7 9058.5 9065.5 9075.8 9158.2 12774.7 12856.3 12990.8 12992.6 13174.4 5338.9 5372.2 5424.8 5472.7 5482.5 859.9 891.6 923.8 933.5 947.0 19898.5 20943.8 21040.4 21089.5 21132.9 990.4 991.4 998.6 1015.7 1017.2 11007.9 11291.9 11353.0 11355.8 11394.7 168260.0 168321.0 168650.0 168801.0 169428.0 40362.4 40655.0 40754.4 40809.6 40932.0 1199.4 1230.8 1234.7 1248.5 1252.3 19250.2 19934.7 20395.7 20513.0 20865.5 29631.6 29634.1 29740.0 29751.4 29845.7 147551.0 147647.0 148558.0 148637.0 148898.3 28751.7 29450.4 29723.4 29770.4 30574.5 35785.0 36168.3 36318.5 36604.6 36875.3 27477.3 27690.4 27952.9 28164.6 28190.9 26694.5 27171.5 27629.9 27770.6 28729.9 29350.6 30211.4 30528.2 30586.8 30688.0 26531.2 26802.6 26972.9 27167.5 27513.3 21567.2 22658.5 22737.3 22757.3 22780.2 18:06:21 INFO - PID 28796 | 18:06:21 INFO - PID 28796 | [#2] jquery.html Cycles:180 Average:23171.90 Median:38009.02 stddev:53513.53 (140.8%) stddev-sans-first:53636.38 18:06:21 INFO - PID 28796 | Values: 417.2 422.3 423.8 439.7 447.4 17264.7 17276.4 17882.6 17941.0 18033.9 16398.3 16516.7 16532.8 16566.3 16946.5 5418.7 5438.4 5540.0 5546.3 5588.1 5421.5 5528.6 5536.9 5539.3 5559.3 5274.3 5483.1 5487.7 5501.3 5518.2 5448.9 5511.5 5513.8 5514.4 5538.6 4813.4 4931.3 4962.2 4986.9 4994.7 21185.9 21194.7 21298.6 21336.9 21695.9 1593.6 1628.1 1629.0 1629.7 1632.1 14270.2 14968.4 14973.2 15108.8 15123.2 2050.3 2058.7 2114.2 2114.8 2115.5 81738.2 81876.2 82335.6 83813.6 84572.6 11051.4 11331.9 11461.8 11515.9 11604.6 15592.1 15755.4 15817.9 15844.8 15936.1 7049.6 7282.6 7373.9 7417.9 7426.8 6526.8 6541.5 6625.9 6635.0 6672.6 7111.2 7252.5 7277.3 7290.5 7299.7 2075.0 2086.4 2126.4 2150.6 2203.6 844.9 860.0 872.7 874.7 902.1 16880.7 16887.6 17161.8 17197.3 17761.6 873.8 874.8 882.0 883.3 894.9 9216.4 9283.7 9735.0 9749.6 9932.6 312894.0 319015.0 320074.0 321426.0 329159.0 66628.7 68743.0 70783.6 71606.6 76208.0 1055.7 1063.6 1102.9 1111.8 1112.7 16824.9 17022.8 17513.6 17746.2 18241.8 37742.6 38275.4 38299.0 39389.2 39802.2 45104.0 47686.5 47720.0 48010.3 48120.3 8220.5 8375.7 8518.9 8522.0 8679.3 13023.9 13057.7 13139.4 13219.3 13243.2 10437.4 10647.3 10808.8 10851.9 11362.8 10740.4 10771.6 10947.4 11007.0 11032.0 11218.9 11364.9 11556.5 11667.5 11775.7 8478.1 8537.2 8545.1 8718.0 8742.5 11272.2 11298.4 11466.3 11560.0 11579.2 18:06:21 INFO - PID 28796 | 18:06:21 INFO - PID 28796 | [#3] mootools.html Cycles:180 Average:6414.39 Median:3872.42 stddev:4138.45 (106.9%) stddev-sans-first:4131.93 18:06:21 INFO - PID 28796 | Values: 1258.2 1321.4 1338.1 1339.6 1340.3 10092.4 10282.5 10526.7 10584.5 10698.0 10406.8 10507.9 10565.3 10597.3 10611.8 2292.4 2298.6 2330.5 2330.8 2332.9 2257.6 2306.7 2310.3 2312.7 2313.9 2264.2 2270.2 2318.2 2320.3 2328.1 2108.2 2182.0 2200.0 2211.0 2217.4 2095.5 2106.4 2118.8 2120.4 2293.8 10398.9 10419.3 10438.3 10467.0 10467.1 5688.6 5848.8 5885.5 5914.7 5917.8 3452.0 3623.9 3659.5 3740.9 3742.6 1170.0 1177.0 1191.2 1223.7 1248.5 15045.1 15138.6 15233.1 15241.9 15278.0 4842.4 5018.1 5022.4 5062.6 5155.9 11151.4 11166.7 11176.0 11193.2 11198.9 5654.6 5657.9 5690.9 5703.4 5730.1 5037.4 5154.8 5173.7 5175.1 5212.3 3874.5 4028.5 4055.0 4084.6 4161.1 1167.6 1170.7 1174.0 1197.6 1200.6 705.5 716.6 719.9 726.6 735.0 5329.0 5341.9 5427.3 5484.3 5520.8 532.0 548.6 552.9 553.4 553.8 3870.3 3884.0 3929.9 3941.6 3982.7 13374.2 13496.6 13793.0 13814.8 13820.9 13616.9 13654.3 13668.7 13690.7 13710.1 7458.7 7564.2 7700.3 7712.5 7751.0 5789.1 5948.0 5968.4 6102.0 6105.4 11946.4 12161.7 12250.4 12423.6 12473.3 12253.1 12780.6 12812.4 12815.4 12877.7 8480.8 8570.4 8641.8 8643.2 8647.6 9292.1 9375.1 9386.0 9520.5 9525.8 8118.2 8139.1 8227.8 8238.5 8478.2 8067.8 8124.6 8190.8 8262.8 8334.2 7359.4 7421.2 7450.9 7455.1 7480.7 4903.5 5241.6 5292.3 5350.4 5378.0 5088.6 5102.3 5169.7 5203.2 5220.7 18:06:21 INFO - PID 28796 | 18:06:21 INFO - PID 28796 | [#4] prototype.html Cycles:180 Average:4846.13 Median:5500.35 stddev:1407.08 (25.6%) stddev-sans-first:1370.09 18:06:21 INFO - PID 28796 | Values: 356.5 381.5 385.4 385.5 390.3 5489.9 5604.7 5622.9 5627.3 5636.1 5486.5 5491.3 5495.0 5499.1 5501.6 4257.3 4294.8 4304.6 4317.5 4335.2 4319.7 4324.5 4326.0 4330.7 4334.6 4287.5 4288.2 4292.2 4307.1 4313.8 4220.6 4273.7 4310.5 4326.2 4329.7 3864.2 3876.1 3879.1 3885.4 3888.6 5371.6 5384.3 5388.3 5389.5 5392.9 4968.7 5027.2 5047.7 5097.8 5099.0 5777.5 5781.5 5811.3 5832.7 5855.8 4279.2 4284.1 4305.8 4307.1 4317.6 5855.8 6061.2 6068.8 6089.3 6091.0 4413.5 4417.3 4424.4 4430.4 4450.6 4474.6 4488.8 4494.6 4503.3 4510.7 4583.6 4748.0 4819.6 4819.9 5023.7 5825.3 5828.4 5830.0 5832.5 5844.5 1412.5 1444.2 1444.4 1449.5 1450.8 912.9 955.9 959.5 962.1 980.2 5072.6 5089.9 5101.9 5105.4 5121.4 6087.3 6095.7 6122.6 6124.2 6137.0 4978.9 5090.5 5100.7 5106.3 5123.6 3194.8 3213.5 3224.3 3227.5 3242.2 5466.8 5588.9 5599.3 5628.7 5632.4 5998.2 6151.5 6189.4 6205.2 6213.8 5577.1 5578.8 5587.2 5600.5 5626.0 5922.6 6008.6 6019.9 6021.9 6031.2 5886.3 5937.3 5966.9 5969.6 5970.8 5587.6 5594.8 5606.9 5619.6 5621.7 3983.0 4007.9 4014.8 4032.7 4087.4 6025.3 6031.1 6032.1 6036.0 6048.8 5837.5 5839.7 5857.0 5871.7 5891.3 5694.2 5796.2 5796.7 5816.5 5828.7 5719.7 5726.0 5740.7 5762.8 5767.6 5667.5 5808.2 5831.2 5848.2 5876.5 5697.9 5713.8 5718.9 5730.8 5733.1 18:06:21 INFO - PID 28796 | 18:06:21 INFO - PID 28796 | [#5] yui.html Cycles:180 Average:14937.33 Median:3612.83 stddev:17642.54 (488.3%) stddev-sans-first:17659.80 18:06:21 INFO - PID 28796 | Values: 737.4 745.9 761.9 763.3 773.0 11308.8 11909.8 12698.1 13305.5 13306.3 14692.1 14874.2 15279.5 15282.5 15340.3 858.3 883.8 887.3 887.7 889.5 883.0 884.2 885.0 891.3 891.3 919.8 922.3 922.6 925.3 926.8 911.7 912.9 914.7 917.6 918.1 673.8 677.2 677.9 678.8 679.7 12675.8 12729.9 13172.4 14368.4 14522.9 15481.7 15580.5 15669.5 15800.8 16152.3 12436.5 12787.4 12825.6 12930.9 12983.9 3093.6 3113.7 3115.8 3124.4 3127.9 64255.0 65130.7 65982.3 66501.7 68520.3 12218.3 12477.6 12582.6 12727.1 12729.2 22233.7 22292.4 22518.2 22647.7 22776.4 6198.3 6343.4 6530.1 6581.8 6592.4 3131.9 3205.8 3209.1 3212.8 3216.6 3514.5 3608.5 3617.1 4209.9 4337.0 771.3 789.6 806.6 807.0 807.8 563.4 580.0 589.4 589.5 590.8 8726.7 9292.8 9745.3 9775.0 9981.8 575.4 582.8 590.1 595.4 597.5 4171.5 4335.5 4341.4 4367.0 4396.8 62468.7 62494.4 62787.7 65728.3 65772.7 55276.0 56233.7 56615.8 57410.7 57776.4 49253.5 51171.0 51651.2 52349.7 52791.5 8546.5 8797.5 8841.2 9104.1 9112.1 26739.2 26785.2 26791.3 26840.0 27107.0 32557.5 32566.7 33166.3 33191.7 33629.2 10850.7 11084.9 11098.7 11104.6 12175.8 13391.2 13407.2 13749.5 15310.2 15573.6 12959.5 13997.2 14244.6 14412.3 14489.6 13575.2 13901.7 14139.9 14207.7 14417.1 12481.8 12800.2 12881.6 13160.3 13457.6 9830.2 10228.0 10369.6 10512.4 10614.4 11110.7 11611.2 11924.9 12180.5 12941.2 18:06:21 INFO - PID 28796 | -------- Summary: end -------- 18:06:21 INFO - PID 28796 | 18:06:22 INFO - TEST-INFO | 28796: exit 0 18:06:22 INFO - TEST-OK | dromaeo_css | took 1118806ms 18:06:22 INFO - TEST-START | kraken 18:06:22 INFO - operating with platform_type : linux_ 18:06:22 INFO - Initialising browser for kraken test... 18:06:22 INFO - TEST-INFO | started process 29221 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIyVxUQ/profile http://localhost:45711/getInfo.html) 18:06:23 INFO - PID 29221 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2930: String.localeCompare is deprecated; use String.prototype.localeCompare instead 18:06:26 INFO - PID 29221 | __metrics Screen width/height:1600/1200 18:06:26 INFO - PID 29221 | colorDepth:24 18:06:26 INFO - PID 29221 | Browser inner width/height: 1024/695 18:06:26 INFO - PID 29221 | __metrics 18:06:28 INFO - TEST-INFO | 29221: exit 0 18:06:28 INFO - Browser initialized. 18:06:28 INFO - Running cycle 1/1 for kraken test... 18:06:28 INFO - TEST-INFO | started process 29408 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIyVxUQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:06:40 INFO - PID 29408 | RSS: Main: 165076992 18:06:40 INFO - PID 29408 | 18:06:42 INFO - PID 29408 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45711/tests/kraken/driver.html?testName=audio-beat-detection) 18:06:43 INFO - PID 29408 | RSS: Main: 170270720 18:06:43 INFO - PID 29408 | 18:06:46 INFO - PID 29408 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45711/tests/kraken/driver.html?testName=audio-dft) 18:06:47 INFO - PID 29408 | RSS: Main: 169959424 18:06:47 INFO - PID 29408 | 18:06:50 INFO - PID 29408 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45711/tests/kraken/driver.html?testName=audio-fft) 18:06:50 INFO - PID 29408 | RSS: Main: 165068800 18:06:50 INFO - PID 29408 | 18:06:52 INFO - PID 29408 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45711/tests/kraken/driver.html?testName=audio-oscillator) 18:06:53 INFO - PID 29408 | RSS: Main: 165998592 18:06:53 INFO - PID 29408 | 18:06:55 INFO - PID 29408 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45711/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:06:56 INFO - PID 29408 | RSS: Main: 166387712 18:06:56 INFO - PID 29408 | 18:06:59 INFO - PID 29408 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45711/tests/kraken/driver.html?testName=imaging-darkroom) 18:07:00 INFO - PID 29408 | RSS: Main: 169635840 18:07:00 INFO - PID 29408 | 18:07:03 INFO - PID 29408 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45711/tests/kraken/driver.html?testName=imaging-desaturate) 18:07:04 INFO - PID 29408 | RSS: Main: 167206912 18:07:04 INFO - PID 29408 | 18:07:07 INFO - PID 29408 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45711/tests/kraken/driver.html?testName=json-parse-financial) 18:07:07 INFO - PID 29408 | RSS: Main: 168644608 18:07:07 INFO - PID 29408 | 18:07:09 INFO - PID 29408 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45711/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:07:10 INFO - PID 29408 | RSS: Main: 168005632 18:07:10 INFO - PID 29408 | 18:07:11 INFO - PID 29408 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45711/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:07:12 INFO - PID 29408 | RSS: Main: 168599552 18:07:12 INFO - PID 29408 | 18:07:14 INFO - PID 29408 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45711/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:07:15 INFO - PID 29408 | RSS: Main: 168976384 18:07:15 INFO - PID 29408 | 18:07:17 INFO - PID 29408 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45711/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:07:18 INFO - PID 29408 | RSS: Main: 169062400 18:07:18 INFO - PID 29408 | 18:07:22 INFO - PID 29408 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45711/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:07:22 INFO - PID 29408 | RSS: Main: 166969344 18:07:22 INFO - PID 29408 | 18:07:24 INFO - PID 29408 | Cycle 1(1): loaded http://localhost:45711/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45711/tests/kraken/driver.html?testName=ai-astar) 18:07:24 INFO - PID 29408 | RSS: Main: 168566784 18:07:24 INFO - PID 29408 | 18:07:24 INFO - PID 29408 | __start_tp_report 18:07:24 INFO - PID 29408 | _x_x_mozilla_page_load 18:07:24 INFO - PID 29408 | _x_x_mozilla_page_load_details 18:07:24 INFO - PID 29408 | |i|pagename|runs| 18:07:24 INFO - PID 29408 | |0;ai-astar;104;114;115;112;113;112;112;111;113;114 18:07:24 INFO - PID 29408 | |1;audio-beat-detection;151;127;132;176;130;124;122;123;148;124 18:07:24 INFO - PID 29408 | |2;audio-dft;164;162;163;165;163;170;167;164;164;164 18:07:24 INFO - PID 29408 | |3;audio-fft;76;75;74;117;76;74;75;74;99;75 18:07:24 INFO - PID 29408 | |4;audio-oscillator;84;83;108;84;84;87;97;84;83;115 18:07:24 INFO - PID 29408 | |5;imaging-gaussian-blur;114;115;114;114;114;114;115;113;117;114 18:07:24 INFO - PID 29408 | |6;imaging-darkroom;151;151;150;152;150;152;151;154;152;151 18:07:24 INFO - PID 29408 | |7;imaging-desaturate;95;96;95;95;94;98;99;94;94;95 18:07:24 INFO - PID 29408 | |8;json-parse-financial;56;57;57;56;59;58;58;60;57;56 18:07:24 INFO - PID 29408 | |9;json-stringify-tinderbox;56;55;56;61;56;56;56;56;57;56 18:07:24 INFO - PID 29408 | |10;stanford-crypto-aes;84;83;83;92;84;84;83;84;84;83 18:07:24 INFO - PID 29408 | |11;stanford-crypto-ccm;138;135;135;133;136;132;136;138;185;132 18:07:24 INFO - PID 29408 | |12;stanford-crypto-pbkdf2;191;205;195;198;207;206;203;206;203;198 18:07:24 INFO - PID 29408 | |13;stanford-crypto-sha256-iterative;76;75;75;79;74;78;74;72;74;78 18:07:24 INFO - PID 29408 | __end_tp_report 18:07:24 INFO - PID 29408 | __start_cc_report 18:07:24 INFO - PID 29408 | _x_x_mozilla_cycle_collect,747 18:07:24 INFO - PID 29408 | __end_cc_report 18:07:24 INFO - PID 29408 | __startTimestamp1494983244800__endTimestamp 18:07:24 INFO - PID 29408 | 18:07:24 INFO - PID 29408 | ------- Summary: start ------- 18:07:24 INFO - PID 29408 | Number of tests: 14 18:07:24 INFO - PID 29408 | 18:07:24 INFO - PID 29408 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:3.06 (2.7%) stddev-sans-first:1.27 18:07:24 INFO - PID 29408 | Values: 104.0 114.0 115.0 112.0 113.0 112.0 112.0 111.0 113.0 114.0 18:07:24 INFO - PID 29408 | 18:07:24 INFO - PID 29408 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:131.00 stddev:17.49 (13.4%) stddev-sans-first:17.66 18:07:24 INFO - PID 29408 | Values: 151.0 127.0 132.0 176.0 130.0 124.0 122.0 123.0 148.0 124.0 18:07:24 INFO - PID 29408 | 18:07:24 INFO - PID 29408 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:2.32 (1.4%) stddev-sans-first:2.45 18:07:24 INFO - PID 29408 | Values: 164.0 162.0 163.0 165.0 163.0 170.0 167.0 164.0 164.0 164.0 18:07:24 INFO - PID 29408 | 18:07:24 INFO - PID 29408 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.00 stddev:14.62 (19.5%) stddev-sans-first:15.37 18:07:24 INFO - PID 29408 | Values: 76.0 75.0 74.0 117.0 76.0 74.0 75.0 74.0 99.0 75.0 18:07:24 INFO - PID 29408 | 18:07:24 INFO - PID 29408 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:84.00 stddev:11.74 (14.0%) stddev-sans-first:12.19 18:07:24 INFO - PID 29408 | Values: 84.0 83.0 108.0 84.0 84.0 87.0 97.0 84.0 83.0 115.0 18:07:24 INFO - PID 29408 | 18:07:24 INFO - PID 29408 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:1.07 (0.9%) stddev-sans-first:1.13 18:07:24 INFO - PID 29408 | Values: 114.0 115.0 114.0 114.0 114.0 114.0 115.0 113.0 117.0 114.0 18:07:24 INFO - PID 29408 | 18:07:24 INFO - PID 29408 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:151.50 stddev:1.17 (0.8%) stddev-sans-first:1.24 18:07:24 INFO - PID 29408 | Values: 151.0 151.0 150.0 152.0 150.0 152.0 151.0 154.0 152.0 151.0 18:07:24 INFO - PID 29408 | 18:07:24 INFO - PID 29408 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:1.72 (1.8%) stddev-sans-first:1.81 18:07:24 INFO - PID 29408 | Values: 95.0 96.0 95.0 95.0 94.0 98.0 99.0 94.0 94.0 95.0 18:07:24 INFO - PID 29408 | 18:07:24 INFO - PID 29408 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.50 stddev:1.35 (2.3%) stddev-sans-first:1.33 18:07:24 INFO - PID 29408 | Values: 56.0 57.0 57.0 56.0 59.0 58.0 58.0 60.0 57.0 56.0 18:07:24 INFO - PID 29408 | 18:07:24 INFO - PID 29408 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:56.00 stddev:1.65 (2.9%) stddev-sans-first:1.74 18:07:24 INFO - PID 29408 | Values: 56.0 55.0 56.0 61.0 56.0 56.0 56.0 56.0 57.0 56.0 18:07:24 INFO - PID 29408 | 18:07:24 INFO - PID 29408 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:2.72 (3.2%) stddev-sans-first:2.88 18:07:24 INFO - PID 29408 | Values: 84.0 83.0 83.0 92.0 84.0 84.0 83.0 84.0 84.0 83.0 18:07:24 INFO - PID 29408 | 18:07:24 INFO - PID 29408 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:136.00 stddev:15.96 (11.7%) stddev-sans-first:16.91 18:07:24 INFO - PID 29408 | Values: 138.0 135.0 135.0 133.0 136.0 132.0 136.0 138.0 185.0 132.0 18:07:24 INFO - PID 29408 | 18:07:24 INFO - PID 29408 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:201.20 Median:204.00 stddev:5.41 (2.7%) stddev-sans-first:4.30 18:07:24 INFO - PID 29408 | Values: 191.0 205.0 195.0 198.0 207.0 206.0 203.0 206.0 203.0 198.0 18:07:24 INFO - PID 29408 | 18:07:24 INFO - PID 29408 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.50 Median:75.50 stddev:2.22 (2.9%) stddev-sans-first:2.35 18:07:24 INFO - PID 29408 | Values: 76.0 75.0 75.0 79.0 74.0 78.0 74.0 72.0 74.0 78.0 18:07:24 INFO - PID 29408 | -------- Summary: end -------- 18:07:24 INFO - PID 29408 | 18:07:25 INFO - TEST-INFO | 29408: exit 0 18:07:25 INFO - TEST-OK | kraken | took 63451ms 18:07:25 INFO - SUITE-END | took 1182s 18:07:26 INFO - Completed test suite (00:19:42) 18:07:26 INFO - javascript benchmark 18:07:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6726.944314702585, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2697.231289082611, 2706.3098909778005, 2727.3318037080917, 2734.302752798036, 2743.8216515926465, 5095.71973541456, 5157.872241025412, 5169.224616307546, 5169.250458683488, 5216.478352164786, 5177.508136727014, 5177.870553236162, 5263.921041184376, 5271.2356708277275, 5274.156135018397, 4402.185595664812, 4654.86035418938, 4656.7205967641885, 4663.230566956465, 4680.695754775946, 4692.601128904047, 4700.01299727056, 4740.478547359788, 4765.237561990082, 4777.570018698317, 4596.655250856199, 4625.8149674013, 4650.86047418578, 4670.0426412585675, 4682.391289132391, 4635.490096089427, 4647.140279048387, 4668.253079507296, 4698.600618947394, 4702.036082603058, 4602.550196688033, 4651.418572678415, 4651.767411629405, 4675.625949923998, 4686.742229177394, 5127.435982041972, 5247.711375874325, 5248.239005344242, 5256.500632439912, 5283.339582552181, 5540.556755459554, 5616.045272303718, 5665.603407761459, 5665.631733937281, 5673.120666296731, 5636.408177141423, 5636.549076073904, 5645.32256129263, 5647.407022262644, 5650.3219613646215, 5204.115300398866, 5241.42344342122, 5259.868503287448, 5270.209468579706, 5285.07511185541, 5762.337331206881, 5789.478946894799, 5795.797147099831, 5827.562932779973, 5834.03738383162, 5551.8889622208135, 5553.888922221533, 5561.4716601922755, 5561.944380556223, 5562.054450743383, 5603.579731520153, 5604.439556044363, 5637.774489020475, 5651.4348565143155, 5664.320281566156, 5624.803131890364, 5630.07103827872, 5632.957902787997, 5646.181303710939, 5647.040003199466, 5598.0, 5608.214849921014, 5615.129654903497, 5615.904898544826, 5631.549476041907, 4590.288505281686, 4662.370579971728, 4675.345451636774, 4676.228422310281, 4678.789454474557, 3983.24318379507, 4013.0168108812945, 4017.8593749218635, 4018.9196216075516, 4066.044479547304, 4822.204336284473, 4825.083234185494, 4827.9137194131035, 4832.855014349575, 4871.318015477836, 5582.106862901916, 5643.01247281724, 5649.124385720138, 5663.773449061991, 5676.8864622707315, 4738.19450693383, 4782.354382158364, 4809.615230781529, 4822.252550854623, 4823.807047718122, 4841.346418233494, 4843.346148269939, 4869.659123861366, 4898.14282500561, 4910.238912968495, 5243.554297884646, 5246.3704355477585, 5251.868703282448, 5254.553362964114, 5256.894862102813, 5562.388137304974, 5562.666240025612, 5638.520725738358, 5652.943470565242, 5664.745086471201, 5244.632875698664, 5253.684778913277, 5258.1849813279005, 5259.342582177228, 5297.576193904555, 5553.500184983371, 5553.777848885999, 5570.86072848182, 5574.358948720949, 5624.7187640616985, 5516.806911758069, 5648.124540696199, 5656.2929633795775, 5657.349404818498, 5664.0371136906, 5393.083175860034, 5491.203775452457, 5500.28496295479, 5503.614746967673, 5511.889762204653, 5493.615446918678, 5499.065158922913, 5499.3675727291875, 5507.146392309199, 5549.112142057252, 5388.541973932103, 5394.379646340721, 5423.566114710892, 5432.674039557639, 5487.588430867621, 5373.623846330719, 5423.701696406735, 5491.670499770026, 5525.834224973257, 5539.806106786243, 5382.111951527954, 5390.541803946709, 5392.838214853561, 5398.811041613525, 5399.487048730364], "value": 5103.273032957853, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.1810237203496, 712.8253577873422, 730.6018220070063, 1057.238788072588, 1074.4681382715557, 32578.511322330156, 33698.326033479316, 33800.83099584499, 33873.153171170736, 34005.82997085014, 34956.650433495655, 35301.47047794285, 35365.0, 35409.64590354096, 35411.4688279676, 6927.376536111749, 7054.118235220611, 7160.570365778044, 7187.748428804993, 7198.6400679966055, 7109.289071092901, 7140.250273721236, 7169.928300717004, 7184.568925864465, 7213.819654508653, 7165.605891675982, 7200.603966781851, 7218.530795498302, 7224.53040552365, 7237.276272372747, 7186.640667966633, 7199.136103667541, 7213.78358649244, 7233.059702238728, 7239.601821899793, 7056.400205982498, 7103.964480177566, 7107.395871350941, 7108.644567771643, 7119.644017799089, 31827.0, 31989.6801031989, 31990.0, 32036.519452208235, 32170.839145804122, 3079.7844150909445, 3082.8150310981414, 3086.10502954143, 3092.3351479431803, 3104.5498402731705, 24736.3815904602, 24939.62590561143, 24986.625200622006, 24997.375065623324, 25021.49957000868, 3061.0357737312675, 3077.753779697619, 3094.1645755646073, 3101.720845123927, 3163.43058249515, 133976.0, 134012.0, 134325.0, 145564.0, 149771.25114374358, 40009.39985900214, 40378.0, 40446.59553404487, 40459.59540404617, 40486.59513404887, 41422.0, 41771.37342939858, 41879.58120418818, 41891.37162942559, 42040.36939445911, 11687.941560292144, 11695.766084678258, 11753.118516111326, 11768.94115529434, 11823.172377933462, 9042.728718138467, 9058.547072646474, 9065.45607263553, 9075.773105672411, 9158.175764181256, 12774.680632984064, 12856.29290389019, 12990.805137922938, 12992.621918301309, 13174.407151678197, 5338.893222135535, 5372.1941708744, 5424.755885985141, 5472.671639701631, 5482.479164479368, 859.8710193470904, 891.5765011619429, 923.7690577355661, 933.495912207414, 946.9961840449146, 19898.50253743668, 20943.790562094186, 21040.368788936357, 21089.472763180736, 21132.894335528224, 990.3711143423834, 991.4150651115876, 998.6454808543008, 1015.6648306058983, 1017.1862509991977, 11007.889921100686, 11291.887081129247, 11353.0, 11355.772884542428, 11394.658160255205, 168260.0, 168321.0, 168650.0, 168801.0, 169428.0, 40362.394564081565, 40655.0, 40754.38868416976, 40809.59190408058, 40932.0, 1199.4062938845327, 1230.8399908011902, 1234.697499112723, 1248.5193200617646, 1252.3425201769144, 19250.22999080021, 19934.70097948561, 20395.694064588748, 20513.0, 20865.478363041046, 29631.555526666685, 29634.110976670734, 29740.0, 29751.404971900873, 29845.70154298429, 147551.0, 147647.0, 148558.0, 148637.0, 148898.25550872178, 28751.71248287574, 29450.410991780474, 29723.405531889675, 29770.404591908475, 30574.541381879735, 35785.0, 36168.27663446769, 36318.455223172205, 36604.63395366012, 36875.26249475049, 27477.31306717348, 27690.44619107647, 27952.860235698692, 28164.577531336636, 28190.85904570546, 26694.466110678066, 27171.456570868868, 27629.861850690617, 27770.583441247993, 28729.856350718113, 29350.559741603465, 30211.395772083997, 30528.236794079436, 30586.84706576453, 30688.0, 26531.204063878115, 26802.59796103021, 26972.865135674198, 27167.45665086727, 27513.31216719598, 21567.2451464198, 22658.546829063656, 22737.31788046361, 22757.317280481613, 22780.20269290567], "value": 14490.051138163179, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.1823226476106, 422.3263894088927, 423.7669281894957, 439.71858010873035, 447.4317616626884, 17264.65470690587, 17276.395326163587, 17882.552936176602, 17941.0, 18033.909830450844, 16398.26207820648, 16516.66966660666, 16532.83467165328, 16566.254518546662, 16946.491605251864, 5418.729063546817, 5438.428964958682, 5540.0, 5546.306711661043, 5588.133839254922, 5421.484958928915, 5528.585356098289, 5536.944630553703, 5539.335279766434, 5559.3328800543995, 5274.314339135907, 5483.122700367942, 5487.6981766002855, 5501.284832971728, 5518.227448157261, 5448.945510544883, 5511.476409741068, 5513.8345849624575, 5514.448555144473, 5538.6399884007615, 4813.446453657839, 4931.334269873557, 4962.15643340633, 4986.87532811679, 4994.725290109042, 21185.894070529703, 21194.682079768816, 21298.574028519342, 21336.893315533478, 21695.891520542296, 1593.569736171239, 1628.096406494395, 1629.030726717601, 1629.657771867909, 1632.0860318221835, 14270.215138167398, 14968.401263949429, 14973.176475293854, 15108.773368399483, 15123.168225747579, 2050.302897015007, 2058.711780350752, 2114.249441448279, 2114.756802967663, 2115.4922818523596, 81738.18261817365, 81876.18123818745, 82335.58832205861, 83813.58093209495, 84572.57713711515, 11051.447427628747, 11331.943340283246, 11461.770764584662, 11515.942420287845, 11604.593839215755, 15592.142432166112, 15755.369785208693, 15817.915506476356, 15844.76232856508, 15936.123513206885, 7049.588061557602, 7282.5690730503065, 7373.852522949618, 7417.925820741832, 7426.777196684108, 6526.804195874131, 6541.542092053605, 6625.86748265032, 6635.0, 6672.599644021374, 7111.182214045451, 7252.528585641917, 7277.345038946414, 7290.526115802456, 7299.671514781848, 2074.9832582034996, 2086.3607536466384, 2126.3727200475896, 2150.5698860228017, 2203.647416413366, 844.8817165596821, 860.0, 872.6858331000834, 874.6676263020139, 902.0708670069838, 16880.746788798177, 16887.577810554834, 17161.828381716274, 17197.31210751581, 17761.555961101076, 873.7902903303288, 874.8119154381839, 881.9603117859712, 883.2536506651869, 894.8881389826272, 9216.447013179231, 9283.675071372469, 9734.97782732817, 9749.561269742879, 9932.553035113437, 312894.0, 319015.0, 320074.0, 321426.0, 329159.0, 66628.66685666541, 68743.0, 70783.64608177029, 71606.64196678983, 76207.9999999989, 1055.7307886488895, 1063.5692544519482, 1102.8897110289067, 1111.7943180511631, 1112.6550769261394, 16824.915875421033, 17022.829771702123, 17513.56216094608, 17746.20142093583, 18241.817581824012, 37742.62257377391, 38275.42586861255, 38299.0, 39389.212215756095, 39802.2039559213, 45104.0, 47686.523134769595, 47720.0, 48010.27984580164, 48120.27819582779, 8220.506769593843, 8375.664973400995, 8518.91481085206, 8521.957390213258, 8679.305655547414, 13023.934880325538, 13057.673558161123, 13139.408726607135, 13219.339033048116, 13243.20540767557, 10437.425941572983, 10647.254692171473, 10808.784199239295, 10851.891481085087, 11362.772744545227, 10740.355578664992, 10771.6229931952, 10947.397893115955, 11007.0, 11032.0, 11218.887811121784, 11364.886351136383, 11556.537738490366, 11667.474963626826, 11775.705607359541, 8478.109798471318, 8537.231649151607, 8545.102764209669, 8718.0, 8742.519161446182, 11272.210945234083, 11298.435078246219, 11466.2546934449, 11560.0, 11579.247348922294], "value": 8802.87628793596, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1258.1570347866927, 1321.3591408167038, 1338.1435881036132, 1339.5579458778604, 1340.3298350824582, 10092.394456332617, 10282.537285822138, 10526.736831579214, 10584.52369643366, 10698.0, 10406.843897341527, 10507.947460262707, 10565.313254638442, 10597.311174773653, 10611.84082238767, 2292.3810571145823, 2298.5517824024323, 2330.5338932213626, 2330.7669233076726, 2332.941676458085, 2257.604919139144, 2306.688597039395, 2310.2722642367685, 2312.7455979842202, 2313.8727369994645, 2264.2188444986455, 2270.2281224383705, 2318.1770471482632, 2320.2575175943703, 2328.057136859566, 2108.230495869012, 2182.039902442928, 2199.978000220009, 2210.9829478439938, 2217.423469897822, 2095.4656562576597, 2106.4102051425625, 2118.8199003084756, 2120.3744895255936, 2293.793558579719, 10398.948005260001, 10419.32274402169, 10438.321509101885, 10467.0, 10467.110295624881, 5688.573356998241, 5848.795292164754, 5885.529157667376, 5914.733836977303, 5917.763289468416, 3451.9795179218186, 3623.9275214495824, 3659.5242618459697, 3740.9251814963823, 3742.5883152853166, 1169.9590514331958, 1176.9764604707857, 1191.2316555821533, 1223.6696092055183, 1248.5318005747845, 15045.097294162386, 15138.621534461507, 15233.086014839146, 15241.923790381088, 15278.0, 4842.394700662418, 5018.096742586369, 5022.372203474566, 5062.645614806928, 5155.922661160085, 11151.442427878574, 11166.665000050012, 11176.0, 11193.16051296156, 11198.888011119947, 5654.604177707603, 5657.858553536113, 5690.857728556819, 5703.429657034263, 5730.054541000772, 5037.420696619935, 5154.845354639367, 5173.71544565045, 5175.120229560984, 5212.296339994053, 3874.535055793323, 4028.4762980812307, 4054.9797251013556, 4084.6323830855367, 4161.146964872194, 1167.6146871532544, 1170.7014711248578, 1174.0431548288288, 1197.5928184417166, 1200.5977997370978, 705.4567982653328, 716.6130289643534, 719.8776208044645, 726.6330503095903, 734.963251837406, 5329.0, 5341.946580534145, 5427.348718153847, 5484.314460692413, 5520.779168833202, 531.9654222475526, 548.5885585810641, 552.917062440629, 553.4161459660016, 553.8006317725616, 3870.303345397799, 3884.0484081400236, 3929.9214015719526, 3941.645251927283, 3982.74112182713, 13374.197548147142, 13496.595102146952, 13793.0, 13814.792778108336, 13820.861791382158, 13616.863831361758, 13654.317284135754, 13668.65828354299, 13690.65773355674, 13710.108842925178, 7458.70165193397, 7564.205758395289, 7700.268474494914, 7712.460127791113, 7751.0, 5789.102689083199, 5948.018576934757, 5968.373320801254, 6101.969490152698, 6105.419985101408, 11946.402679866145, 12161.69595760113, 12250.448729807358, 12423.62729118128, 12473.251604903735, 12253.081018923795, 12780.61658150257, 12812.359382031047, 12815.423305951068, 12877.742445150858, 8480.787980300542, 8570.442921210102, 8641.827163456821, 8643.222110009878, 8647.567621618768, 9292.070792920924, 9375.10936461035, 9386.0, 9520.523973801144, 9525.761855953378, 8118.228768267005, 8139.06400763896, 8227.794305142419, 8238.50568965864, 8478.152184781473, 8067.757967260992, 8124.55314957683, 8190.7952301192945, 8262.83474330522, 8334.166583341617, 7359.411247100326, 7421.2207718190975, 7450.850982980419, 7455.0681164854395, 7480.738174163878, 4903.4606193317995, 5241.633085683966, 5292.285541451854, 5350.411454739898, 5378.031954248273, 5088.618353623567, 5102.336696229615, 5169.715665638426, 5203.19350500673, 5220.738963051908], "value": 4796.867929671613, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.49021898684884, 381.47166174847837, 385.41801879162455, 385.4757529759527, 390.342273269541, 5489.91765123523, 5604.691741954191, 5622.859428514289, 5627.296587926509, 5636.0982242841155, 5486.506214440699, 5491.258680078188, 5494.972525137368, 5499.120140777476, 5501.587380946425, 4257.254980378437, 4294.763787991659, 4304.5695430456935, 4317.525072242067, 4335.154644844257, 4319.69762116652, 4324.481062272532, 4325.978370108145, 4330.740155590659, 4334.566543345672, 4287.5069367022725, 4288.16380805743, 4292.227399068166, 4307.095509942916, 4313.784310784464, 4220.645000622588, 4273.7008409411355, 4310.504292006428, 4326.156399502099, 4329.718568293051, 3864.246471937973, 3876.127871228979, 3879.1465877506903, 3885.436611691317, 3888.6111388861173, 5371.59713021521, 5384.273123128406, 5388.272583201257, 5389.541888939445, 5392.946070539284, 4968.701877887338, 5027.2207807789855, 5047.747612619354, 5097.847064588068, 5098.974505127488, 5777.537796976232, 5781.479666830005, 5811.302643682785, 5832.6500409975115, 5855.76576936922, 4279.2083464559155, 4284.100338928829, 4305.806238719265, 4307.095509942916, 4317.568243175689, 5855.795047173328, 6061.212042434499, 6068.787592434243, 6089.299730530957, 6090.96954515229, 4413.514513403523, 4417.337399390053, 4424.380586717862, 4430.424044874146, 4450.599446049871, 4474.552544745499, 4488.798004089824, 4494.5730155635165, 4503.301988191835, 4510.684252102387, 4583.564561366665, 4748.0, 4819.59033482151, 4819.855404337875, 5023.723695196726, 5825.330087040044, 5828.446297601721, 5830.0, 5832.50423713989, 5844.473997340175, 1412.5479846449039, 1444.1768192130594, 1444.36447962896, 1449.463698431587, 1450.840407555168, 912.9087091290818, 955.9187469065207, 959.5154447004218, 962.0716009051299, 980.1962390839585, 5072.568831649277, 5089.898202035939, 5101.8724531887, 5105.366282789546, 5121.436641969381, 6087.29996050451, 6095.725692343855, 6122.571420000646, 6124.234470691164, 6136.95671735806, 4978.8755281118265, 5090.516400941905, 5100.719460429712, 5106.285120083191, 5123.564497017721, 3194.7603929705365, 3213.517972304173, 3224.339010502841, 3227.5320078588475, 3242.238074052596, 5466.808661696821, 5588.888222235532, 5599.300087489064, 5628.718564071862, 5632.3804381518, 5998.240809227804, 6151.507879369639, 6189.381061893865, 6205.193324867739, 6213.751449942042, 5577.107662773937, 5578.804741834017, 5587.200703521563, 5600.467955544135, 5625.971870140705, 5922.644641321534, 6008.609440386361, 6019.879602408015, 6021.909671355021, 6031.215941927521, 5886.264216972879, 5937.317208521075, 5966.940330596639, 5969.611975221596, 5970.820875373745, 5587.636803607753, 5594.804181853779, 5606.85982850432, 5619.606627536196, 5621.650803807139, 3982.960170398259, 4007.9398809017307, 4014.7791871446184, 4032.737872038308, 4087.448194493705, 6025.312912384539, 6031.09533569968, 6032.095185722177, 6035.969820150871, 6048.758049678139, 5837.5329973601165, 5839.708014599338, 5857.033589457692, 5871.6770577616935, 5891.3224979127945, 5694.202811606461, 5796.21751063601, 5796.681182535001, 5816.516788218977, 5828.737706803119, 5719.742611582572, 5726.0, 5740.68426236561, 5762.827115186551, 5767.5674324425, 5667.4615911488345, 5808.215890854681, 5831.1544826000845, 5848.239728835224, 5876.471117599436, 5697.886042279214, 5713.800016999551, 5718.914216286842, 5730.828075157752, 5733.050762740688], "value": 4403.774862581054, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.3695490355742, 745.9216782237864, 761.8933349331091, 763.2787016269624, 772.9806754831128, 11308.773824523505, 11909.821352679717, 12698.111132220736, 13305.534306299282, 13306.334683265846, 14692.118472891634, 14874.181919994397, 15279.465218717347, 15282.541523754277, 15340.309686064125, 858.3047731337621, 883.8055627761883, 887.2813021452644, 887.7248053103558, 889.4840992224495, 882.9779255518599, 884.2307192742323, 884.9690260840872, 891.3136884598855, 891.3270480786997, 919.7838507950627, 922.349743430883, 922.6493932305748, 925.3013974449282, 926.8285367207054, 911.7355966769662, 912.8767616371771, 914.7118657622827, 917.6375331743957, 918.1048477734222, 673.7877568565887, 677.1569396101885, 677.9322067793231, 678.7929681447157, 679.7247114918466, 12675.845106331946, 12729.872701273054, 13172.407241674147, 14368.425262989467, 14522.91078169131, 15481.690366192726, 15580.454684086117, 15669.529914102595, 15800.841991580051, 16152.273147708382, 12436.502539898393, 12787.424565894557, 12825.551105711349, 12930.935345323212, 12983.87016129836, 3093.6287645482685, 3113.657497675254, 3115.8286294253808, 3124.375124974991, 3127.9218019549467, 64255.0, 65130.67434662844, 65982.3401765981, 66501.66749166271, 68520.31479685238, 12218.327991960528, 12477.563285285152, 12582.622521324374, 12727.10910236293, 12729.172603780724, 22233.666495002588, 22292.44268893258, 22518.211862584732, 22647.660285095735, 22776.430589235402, 6198.2871969723155, 6343.397377249154, 6530.085787989685, 6581.80254592363, 6592.373724496165, 3131.906042818719, 3205.7916235444623, 3209.0533292678715, 3212.8072315661134, 3216.565763621881, 3514.4552594347915, 3608.548931383577, 3617.113807117273, 4209.852655157055, 4336.978315108404, 771.3058247577113, 789.5578476053429, 806.5604245685997, 806.9515829050158, 807.8384323135397, 563.39997902234, 579.9623024503394, 589.3958692340385, 589.5165963909553, 590.8109404990448, 8726.69456569017, 9292.814143717223, 9745.317827752131, 9774.95112524447, 9981.80036399268, 575.3958343739057, 582.811542657319, 590.1354515634616, 595.4402861310355, 597.4951166264586, 4171.457710497677, 4335.479742430928, 4341.370501277297, 4367.039251364695, 4396.802143903532, 62468.68765656143, 62494.375056249766, 62787.6860615694, 65728.34271657318, 65772.67113664497, 55276.0, 56233.71883140558, 56615.790710346766, 57410.712946435, 57776.42223577711, 49253.50746492489, 51171.0, 51651.22523162155, 52349.7382513085, 52791.472085278656, 8546.487210767375, 8797.47215167092, 8841.248493878093, 9104.089591040844, 9112.0887911211, 26739.197824065308, 26785.196444106707, 26791.330216744736, 26840.0, 27107.0, 32557.511637325933, 32566.674333256364, 33166.33667326688, 33191.66808331886, 33629.15927101842, 10850.67447976562, 11084.889151108386, 11098.722531936766, 11104.61133860311, 12175.817362739388, 13391.196528207949, 13407.195568265935, 13749.518766843112, 15310.234488275764, 15573.610659733597, 12959.546415875398, 13997.230152341312, 14244.643883902985, 14412.279386030867, 14489.637759056108, 13575.185488870698, 13901.65245868821, 14139.929300353433, 14207.715845682822, 14417.062890912057, 12481.750364992467, 12800.16798908068, 12881.613551593467, 13160.341982901009, 13457.596272111461, 9830.164436022733, 10228.0, 10369.585216591553, 10512.421816799844, 10614.416207108374, 11110.666679999613, 11611.187216894736, 11924.940375298069, 12180.512779488721, 12941.158824676366], "value": 6738.297177333614, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1561.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 115.0, 112.0, 113.0, 112.0, 112.0, 111.0, 113.0, 114.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 127.0, 132.0, 176.0, 130.0, 124.0, 122.0, 123.0, 148.0, 124.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 165.0, 163.0, 170.0, 167.0, 164.0, 164.0, 164.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 117.0, 76.0, 74.0, 75.0, 74.0, 99.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 108.0, 84.0, 84.0, 87.0, 97.0, 84.0, 83.0, 115.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 115.0, 113.0, 117.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 150.0, 152.0, 150.0, 152.0, 151.0, 154.0, 152.0, 151.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 94.0, 98.0, 99.0, 94.0, 94.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 56.0, 59.0, 58.0, 58.0, 60.0, 57.0, 56.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 61.0, 56.0, 56.0, 56.0, 56.0, 57.0, 56.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 92.0, 84.0, 84.0, 83.0, 84.0, 84.0, 83.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 135.0, 135.0, 133.0, 136.0, 132.0, 136.0, 138.0, 185.0, 132.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 205.0, 195.0, 198.0, 207.0, 206.0, 203.0, 206.0, 203.0, 198.0], "value": 201.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 79.0, 74.0, 78.0, 74.0, 72.0, 74.0, 78.0], "value": 75.5, "unit": "score"}]}]} 18:07:26 INFO - Return code: 0 18:07:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:07:26 INFO - # TBPL SUCCESS # 18:07:26 INFO - Running post-action listener: _resource_record_post_action 18:07:26 INFO - [mozharness: 2017-05-17 01:07:26.590342Z] Finished run-tests step (success) 18:07:26 INFO - Running post-run listener: _resource_record_post_run 18:07:26 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 32768; Write bytes: 393994240; Read time: 184; Write time: 265684 18:07:26 INFO - TinderboxPrint: CPU usage
13.3% 18:07:26 INFO - TinderboxPrint: I/O read bytes / time
32,768 / 184 18:07:26 INFO - TinderboxPrint: I/O write bytes / time
393,994,240 / 265,684 18:07:26 INFO - TinderboxPrint: CPU idle
8,300.0 (86.7%) 18:07:26 INFO - TinderboxPrint: CPU user
1,218.5 (12.7%) 18:07:26 INFO - TinderboxPrint: Swap in / out
0 / 0 18:07:26 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 104534016; Read time: 0; Write time: 103372 18:07:26 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 32768; Write bytes: 289460224; Read time: 184; Write time: 162312 18:07:27 INFO - Running post-run listener: _upload_blobber_files 18:07:27 INFO - Blob upload gear active. 18:07:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:07:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:07:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:07:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:07:27 INFO - (blobuploader) - INFO - Open directory for files ... 18:07:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:07:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:07:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:28 INFO - (blobuploader) - INFO - Done attempting. 18:07:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:07:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:07:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:29 INFO - (blobuploader) - INFO - Done attempting. 18:07:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:07:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:07:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:32 INFO - (blobuploader) - INFO - Done attempting. 18:07:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:07:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:07:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:33 INFO - (blobuploader) - INFO - Done attempting. 18:07:33 INFO - (blobuploader) - INFO - Iteration through files over. 18:07:33 INFO - Return code: 0 18:07:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:07:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:07:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20cdd2446de5f02bdec50fe7b92125d777ee4ea5465e1529f6db361031e7f6fb858241e75d987fad355c44a802c5abf2c53a69e67bd12cc4b4605b0e35829666", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16932821489a61c1ff32113b41aee79430ecb6fc6dd5016d99c04db3740bbd8f58b18a25af1d14fb272d8f9f25d3b30a9adfa8b2b1e0de245e94533be43f25d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/931ed09c6c6d06ef1d5f633ef0b9f6762a5c72a1129286025c9115de0fa35915753dc3fbe85c0887474ae26977ad520ef21705228eadf01f46a30ec624b0bd44", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd1c43b903648edbf5328143ffea7a29fc6a22530418569010bdb50a90c4fdc87b8ae5acd514a8fdee797039bd1b5634005c93b7a1540bf14c694678e92e81a2"} 18:07:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:07:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:07:33 INFO - Contents: 18:07:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20cdd2446de5f02bdec50fe7b92125d777ee4ea5465e1529f6db361031e7f6fb858241e75d987fad355c44a802c5abf2c53a69e67bd12cc4b4605b0e35829666", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16932821489a61c1ff32113b41aee79430ecb6fc6dd5016d99c04db3740bbd8f58b18a25af1d14fb272d8f9f25d3b30a9adfa8b2b1e0de245e94533be43f25d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/931ed09c6c6d06ef1d5f633ef0b9f6762a5c72a1129286025c9115de0fa35915753dc3fbe85c0887474ae26977ad520ef21705228eadf01f46a30ec624b0bd44", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd1c43b903648edbf5328143ffea7a29fc6a22530418569010bdb50a90c4fdc87b8ae5acd514a8fdee797039bd1b5634005c93b7a1540bf14c694678e92e81a2"} 18:07:33 INFO - Running post-run listener: copy_logs_to_upload_dir 18:07:33 INFO - Copying logs to upload dir... 18:07:33 INFO - mkdir: /builds/slave/test/build/upload/logs 18:07:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.863467 ========= master_lag: -0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-05-16 18:07:33.214853) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-16 18:07:33.222151) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20cdd2446de5f02bdec50fe7b92125d777ee4ea5465e1529f6db361031e7f6fb858241e75d987fad355c44a802c5abf2c53a69e67bd12cc4b4605b0e35829666", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16932821489a61c1ff32113b41aee79430ecb6fc6dd5016d99c04db3740bbd8f58b18a25af1d14fb272d8f9f25d3b30a9adfa8b2b1e0de245e94533be43f25d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/931ed09c6c6d06ef1d5f633ef0b9f6762a5c72a1129286025c9115de0fa35915753dc3fbe85c0887474ae26977ad520ef21705228eadf01f46a30ec624b0bd44", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd1c43b903648edbf5328143ffea7a29fc6a22530418569010bdb50a90c4fdc87b8ae5acd514a8fdee797039bd1b5634005c93b7a1540bf14c694678e92e81a2"} build_url:https://queue.taskcluster.net/v1/task/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011243 build_url: 'https://queue.taskcluster.net/v1/task/BFqzGiotSsi_px9K4nyoVg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20cdd2446de5f02bdec50fe7b92125d777ee4ea5465e1529f6db361031e7f6fb858241e75d987fad355c44a802c5abf2c53a69e67bd12cc4b4605b0e35829666", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16932821489a61c1ff32113b41aee79430ecb6fc6dd5016d99c04db3740bbd8f58b18a25af1d14fb272d8f9f25d3b30a9adfa8b2b1e0de245e94533be43f25d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/931ed09c6c6d06ef1d5f633ef0b9f6762a5c72a1129286025c9115de0fa35915753dc3fbe85c0887474ae26977ad520ef21705228eadf01f46a30ec624b0bd44", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd1c43b903648edbf5328143ffea7a29fc6a22530418569010bdb50a90c4fdc87b8ae5acd514a8fdee797039bd1b5634005c93b7a1540bf14c694678e92e81a2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-16 18:07:33.252474) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 18:07:33.253081) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1494981691.448620-406095606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 18:07:33.338381) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-16 18:07:33.338990) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-16 18:07:33.339584) ========= ========= Total master_lag: 0.15 =========