builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1494780457.87 results: success (0) revision: 3a801856dea979b0c3f630e1b0ec58106cdcb380 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-14 09:47:37.866755) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-14 09:47:37.867107) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-14 09:47:37.867375) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-14 09:47:37.890528) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 09:47:37.890863) ========= 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=0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-14 09:47:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.0M=0s 2017-05-14 09:47:38 (50.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136638 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 09:47:38.040869) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 09:47:38.041165) ========= 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=0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020381 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 09:47:38.132880) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-14 09:47:38.133203) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3a801856dea979b0c3f630e1b0ec58106cdcb380 --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 3a801856dea979b0c3f630e1b0ec58106cdcb380 --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=0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-14 09:47:39,077 truncating revision to first 12 chars 2017-05-14 09:47:39,077 Setting DEBUG logging. 2017-05-14 09:47:39,077 attempt 1/10 2017-05-14 09:47:39,077 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3a801856dea9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-14 09:47:39,858 unpacking tar archive at: mozilla-central-3a801856dea9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.110922 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-14 09:47:39.260319) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-14 09:47:39.263655) ========= script_repo_revision: 3a801856dea979b0c3f630e1b0ec58106cdcb380 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-14 09:47:39.264023) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-14 09:47:39.264285) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-14 09:47:39.274834) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-05-14 09:47:39.275173) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:47:40 INFO - MultiFileLogger online at 20170514 09:47:40 in /builds/slave/test 09:47:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:47:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:47:40 INFO - {'append_to_log': False, 09:47:40 INFO - 'base_work_dir': '/builds/slave/test', 09:47:40 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:47:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:47:40 INFO - 'branch': 'Firefox-Non-PGO', 09:47:40 INFO - 'buildbot_json_path': 'buildprops.json', 09:47:40 INFO - 'config_files': ('talos/linux_config.py',), 09:47:40 INFO - 'default_actions': ('clobber', 09:47:40 INFO - 'read-buildbot-config', 09:47:40 INFO - 'download-and-extract', 09:47:40 INFO - 'populate-webroot', 09:47:40 INFO - 'create-virtualenv', 09:47:40 INFO - 'install', 09:47:40 INFO - 'run-tests'), 09:47:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:47:40 INFO - 'download_minidump_stackwalk': True, 09:47:40 INFO - 'download_symbols': 'ondemand', 09:47:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:47:40 INFO - 'tooltool.py': '/tools/tooltool.py', 09:47:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:47:40 INFO - '/tools/misc-python/virtualenv.py')}, 09:47:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:47:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:47:40 INFO - 'gecko_profile': False, 09:47:40 INFO - 'gecko_profile_interval': 0, 09:47:40 INFO - 'installer_path': 'installer.exe', 09:47:40 INFO - 'log_level': 'info', 09:47:40 INFO - 'log_name': 'talos', 09:47:40 INFO - 'log_to_console': True, 09:47:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:47:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:47:40 INFO - 'opt_config_files': (), 09:47:40 INFO - 'pip_index': False, 09:47:40 INFO - 'suite': 'dromaeojs-e10s', 09:47:40 INFO - 'system_bits': '32', 09:47:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:47:40 INFO - 'title': 'talos-linux64-ix-017', 09:47:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:47:40 INFO - 'use_talos_json': True, 09:47:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:47:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:47:40 INFO - 'work_dir': 'build'} 09:47:40 INFO - [mozharness: 2017-05-14 16:47:40.317501Z] Running clobber step. 09:47:40 INFO - Running pre-action listener: _resource_record_pre_action 09:47:40 INFO - Running main action method: clobber 09:47:40 INFO - rmtree: /builds/slave/test/build 09:47:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:47:41 INFO - Running post-action listener: _resource_record_post_action 09:47:41 INFO - [mozharness: 2017-05-14 16:47:41.316568Z] Finished clobber step (success) 09:47:41 INFO - [mozharness: 2017-05-14 16:47:41.316668Z] Running read-buildbot-config step. 09:47:41 INFO - Running pre-action listener: _resource_record_pre_action 09:47:41 INFO - Running main action method: read_buildbot_config 09:47:41 INFO - Using buildbot properties: 09:47:41 INFO - { 09:47:41 INFO - "project": "", 09:47:41 INFO - "product": "firefox", 09:47:41 INFO - "who": "archaeopteryx@coole-files.de", 09:47:41 INFO - "installer_path": "public/build/target.tar.bz2", 09:47:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:47:41 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:47:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:47:41 INFO - "stage_platform": "linux64", 09:47:41 INFO - "basedir": "/builds/slave/test", 09:47:41 INFO - "buildnumber": 828, 09:47:41 INFO - "platform": "ubuntu64_hw", 09:47:41 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:47:41 INFO - "slavebuilddir": "test", 09:47:41 INFO - "taskId": "U7mkOgR1TGuMwxKP2T-R-Q", 09:47:41 INFO - "branch": "mozilla-central", 09:47:41 INFO - "script_repo_revision": "production", 09:47:41 INFO - "revision": "3a801856dea979b0c3f630e1b0ec58106cdcb380", 09:47:41 INFO - "slavename": "talos-linux64-ix-017", 09:47:41 INFO - "repo_path": "mozilla-central" 09:47:41 INFO - } 09:47:41 INFO - Finding installer, test and symbols from parent task. 09:47:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U7mkOgR1TGuMwxKP2T-R-Q'}, attempt #1 09:47:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U7mkOgR1TGuMwxKP2T-R-Q'}, attempt #1 09:47:42 INFO - Task dependencies: al5NQ0HdTNaEGRhH0IMFdA 09:47:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA'}, attempt #1 09:47:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/target.tar.bz2 09:47:42 INFO - Set test_url: https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/test_packages.json 09:47:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/target.crashreporter-symbols.zip 09:47:42 INFO - Running post-action listener: _resource_record_post_action 09:47:42 INFO - [mozharness: 2017-05-14 16:47:42.670288Z] Finished read-buildbot-config step (success) 09:47:42 INFO - [mozharness: 2017-05-14 16:47:42.670506Z] Running download-and-extract step. 09:47:42 INFO - Running pre-action listener: _resource_record_pre_action 09:47:42 INFO - Running main action method: download_and_extract 09:47:42 INFO - mkdir: /builds/slave/test/build/tests 09:47:42 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')]} 09:47:42 INFO - trying https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/target.test_packages.json 09:47:42 INFO - Downloading https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:47:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:47:43 INFO - Downloaded 986 bytes. 09:47:43 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:47:43 INFO - Using the following test package requirements: 09:47:43 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:47:43 INFO - u'common': [u'target.common.tests.zip'], 09:47:43 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:47:43 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:47:43 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:47:43 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:47:43 INFO - u'mozbase': [u'target.common.tests.zip'], 09:47:43 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:47:43 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:47:43 INFO - u'web-platform': [u'target.common.tests.zip', 09:47:43 INFO - u'target.web-platform.tests.zip'], 09:47:43 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:47:43 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:47:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/target.common.tests.zip 09:47:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:47:43 INFO - Fetch https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/target.common.tests.zip into memory 09:47:44 INFO - Content-Length response header: 62451895 09:47:44 INFO - Bytes received: 62451895 09:47:54 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:47:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/target.common.tests.zip 09:47:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:47:54 INFO - Fetch https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/target.common.tests.zip into memory 09:47:56 INFO - Content-Length response header: 62451895 09:47:56 INFO - Bytes received: 62451895 09:48:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/target.talos.tests.zip 09:48:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:48:07 INFO - Fetch https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/target.talos.tests.zip into memory 09:48:08 INFO - Content-Length response header: 14409411 09:48:08 INFO - Bytes received: 14409411 09:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:08 INFO - trying https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/target.tar.bz2 09:48:08 INFO - Downloading https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:48:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:48:09 INFO - Downloaded 63453268 bytes. 09:48:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/target.tar.bz2 09:48:09 INFO - mkdir: /builds/slave/test/properties 09:48:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:48:09 INFO - Writing to file /builds/slave/test/properties/build_url 09:48:09 INFO - Contents: 09:48:09 INFO - build_url:https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/target.tar.bz2 09:48:09 INFO - Running post-action listener: _resource_record_post_action 09:48:09 INFO - Running post-action listener: set_extra_try_arguments 09:48:09 INFO - [mozharness: 2017-05-14 16:48:09.983137Z] Finished download-and-extract step (success) 09:48:09 INFO - [mozharness: 2017-05-14 16:48:09.983234Z] Running populate-webroot step. 09:48:09 INFO - Running pre-action listener: _resource_record_pre_action 09:48:09 INFO - Running main action method: populate_webroot 09:48:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:48:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:48:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:48:09 INFO - '--tppagecycles', 09:48:09 INFO - '7'], 09:48:09 INFO - 'tests': ['tsvgm']}}, 09:48:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:48:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:48:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:48:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:48:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:48:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:48:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:48:09 INFO - 'talos_options': ['--disable-e10s'], 09:48:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:48:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:48:09 INFO - 'talos_options': ['--disable-e10s'], 09:48:09 INFO - 'tests': ['damp', 'tps']}, 09:48:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:48:09 INFO - 'tests': ['damp', 'tps']}, 09:48:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:48:09 INFO - 'tests': ['dromaeo_dom']}, 09:48:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:48:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:48:09 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:48:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:48:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:48:09 INFO - 'tests': ['a11yr', 09:48:09 INFO - 'ts_paint', 09:48:09 INFO - 'tpaint', 09:48:09 INFO - 'sessionrestore', 09:48:09 INFO - 'sessionrestore_no_auto_restore', 09:48:09 INFO - 'tabpaint']}, 09:48:09 INFO - 'other-e10s': {'tests': ['a11yr', 09:48:09 INFO - 'ts_paint', 09:48:09 INFO - 'tpaint', 09:48:09 INFO - 'sessionrestore', 09:48:09 INFO - 'sessionrestore_no_auto_restore', 09:48:09 INFO - 'tabpaint']}, 09:48:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:48:09 INFO - 'ts_paint', 09:48:09 INFO - 'tpaint', 09:48:09 INFO - 'sessionrestore', 09:48:09 INFO - 'sessionrestore_no_auto_restore', 09:48:09 INFO - 'tabpaint']}, 09:48:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:48:09 INFO - 'ts_paint', 09:48:09 INFO - 'tpaint', 09:48:09 INFO - 'sessionrestore', 09:48:09 INFO - 'sessionrestore_no_auto_restore', 09:48:09 INFO - 'tabpaint']}, 09:48:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:48:09 INFO - 'tests': ['a11yr', 09:48:09 INFO - 'ts_paint', 09:48:09 INFO - 'tpaint', 09:48:09 INFO - 'sessionrestore', 09:48:09 INFO - 'sessionrestore_no_auto_restore', 09:48:09 INFO - 'tabpaint']}, 09:48:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:48:09 INFO - 'tests': ['a11yr', 09:48:09 INFO - 'ts_paint', 09:48:09 INFO - 'tpaint', 09:48:09 INFO - 'sessionrestore', 09:48:09 INFO - 'sessionrestore_no_auto_restore', 09:48:09 INFO - 'tabpaint']}, 09:48:09 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:48:09 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:48:09 INFO - 'bloom_basic_ref']}, 09:48:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:48:09 INFO - 'tests': ['tsvgx', 09:48:09 INFO - 'tsvgr_opacity', 09:48:09 INFO - 'tart', 09:48:09 INFO - 'tscrollx', 09:48:09 INFO - 'cart', 09:48:09 INFO - 'tsvg_static']}, 09:48:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:48:09 INFO - 'tsvgr_opacity', 09:48:09 INFO - 'tart', 09:48:09 INFO - 'tscrollx', 09:48:09 INFO - 'cart', 09:48:09 INFO - 'tsvg_static']}, 09:48:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:48:09 INFO - 'talos_options': ['--disable-e10s'], 09:48:09 INFO - 'tests': ['tp5o']}, 09:48:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:48:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:48:09 INFO - 'talos_options': ['--disable-e10s', 09:48:09 INFO - '--xperf_path', 09:48:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:09 INFO - 'tests': ['tp5n']}, 09:48:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:48:09 INFO - 'talos_options': ['--xperf_path', 09:48:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:09 INFO - 'tests': ['tp5n']}}, 09:48:09 INFO - 'talos.zip': {'path': '', 09:48:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:48:09 INFO - Running post-action listener: _resource_record_post_action 09:48:09 INFO - [mozharness: 2017-05-14 16:48:09.996894Z] Finished populate-webroot step (success) 09:48:09 INFO - [mozharness: 2017-05-14 16:48:09.996984Z] Running create-virtualenv step. 09:48:09 INFO - Running pre-action listener: _resource_record_pre_action 09:48:09 INFO - Running main action method: create_virtualenv 09:48:09 INFO - Creating virtualenv /builds/slave/test/build/venv 09:48: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 09:48:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:48:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:48:10 INFO - Using real prefix '/usr' 09:48:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:48:10 INFO - Installing distribute.............................................................................................................................................................................................done. 09:48:12 INFO - Installing pip.................done. 09:48:12 INFO - Return code: 0 09:48:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:48:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:48:12 INFO - Reading from file tmpfile_stdout 09:48:12 INFO - Output received: 09:48:12 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) 09:48:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:48: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')]} 09:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48: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')]} 09:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1005770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1002a30>, '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 0x10037f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1003ca0>, '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': '0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546', '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 09:48: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', 'pip>=1.5'] in /builds/slave/test/build 09:48: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 pip>=1.5 09:48:12 INFO - Using env: {'DISPLAY': ':0', 09:48:12 INFO - 'HOME': '/home/cltbld', 09:48:12 INFO - 'LANG': 'en_US.UTF-8', 09:48:12 INFO - 'LANGUAGE': 'en_US:en', 09:48:12 INFO - 'LOGNAME': 'cltbld', 09:48:12 INFO - 'MAIL': '/var/mail/cltbld', 09:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:12 INFO - 'MOZ_NO_REMOTE': '1', 09:48:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:12 INFO - 'NO_EM_RESTART': '1', 09:48:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:12 INFO - 'PWD': '/builds/slave/test', 09:48:12 INFO - 'SHELL': '/bin/bash', 09:48:12 INFO - 'SHLVL': '1', 09:48:12 INFO - 'TERM': 'linux', 09:48:12 INFO - 'TMOUT': '86400', 09:48:12 INFO - 'USER': 'cltbld', 09:48:12 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546', 09:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:12 INFO - '_': '/tools/buildbot/bin/python'} 09:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48: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 09:48:12 INFO - Cleaning up... 09:48:12 INFO - Return code: 0 09:48:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:48: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')]} 09:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48: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')]} 09:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48: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 0xc931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1005770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1002a30>, '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 0x10037f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1003ca0>, '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': '0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546', '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 09:48: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 09:48: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 09:48:12 INFO - Using env: {'DISPLAY': ':0', 09:48:12 INFO - 'HOME': '/home/cltbld', 09:48:12 INFO - 'LANG': 'en_US.UTF-8', 09:48:12 INFO - 'LANGUAGE': 'en_US:en', 09:48:12 INFO - 'LOGNAME': 'cltbld', 09:48:12 INFO - 'MAIL': '/var/mail/cltbld', 09:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:13 INFO - 'MOZ_NO_REMOTE': '1', 09:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:13 INFO - 'NO_EM_RESTART': '1', 09:48:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:13 INFO - 'PWD': '/builds/slave/test', 09:48:13 INFO - 'SHELL': '/bin/bash', 09:48:13 INFO - 'SHLVL': '1', 09:48:13 INFO - 'TERM': 'linux', 09:48:13 INFO - 'TMOUT': '86400', 09:48:13 INFO - 'USER': 'cltbld', 09:48:13 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546', 09:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:13 INFO - '_': '/tools/buildbot/bin/python'} 09:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:13 INFO - Downloading/unpacking psutil>=3.1.1 09:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:48:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:14 INFO - Installing collected packages: psutil 09:48:14 INFO - Running setup.py install for psutil 09:48:14 INFO - building 'psutil._psutil_linux' extension 09:48:14 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 09:48:14 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 09:48:14 INFO - building 'psutil._psutil_posix' extension 09:48:14 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 09:48:14 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 09:48:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:14 INFO - Successfully installed psutil 09:48:14 INFO - Cleaning up... 09:48:14 INFO - Return code: 0 09:48:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:14 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 0xc931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1005770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1002a30>, '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 0x10037f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1003ca0>, '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': '0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546', '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 09:48:14 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 09:48:14 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 09:48:14 INFO - Using env: {'DISPLAY': ':0', 09:48:14 INFO - 'HOME': '/home/cltbld', 09:48:14 INFO - 'LANG': 'en_US.UTF-8', 09:48:14 INFO - 'LANGUAGE': 'en_US:en', 09:48:14 INFO - 'LOGNAME': 'cltbld', 09:48:14 INFO - 'MAIL': '/var/mail/cltbld', 09:48:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:14 INFO - 'MOZ_NO_REMOTE': '1', 09:48:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:14 INFO - 'NO_EM_RESTART': '1', 09:48:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:14 INFO - 'PWD': '/builds/slave/test', 09:48:14 INFO - 'SHELL': '/bin/bash', 09:48:14 INFO - 'SHLVL': '1', 09:48:14 INFO - 'TERM': 'linux', 09:48:14 INFO - 'TMOUT': '86400', 09:48:14 INFO - 'USER': 'cltbld', 09:48:14 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546', 09:48:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:14 INFO - '_': '/tools/buildbot/bin/python'} 09:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:48: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 09:48: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 09:48: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 09:48: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 09:48:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:48:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:48:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:48:16 INFO - Installing collected packages: mozsystemmonitor 09:48:16 INFO - Running setup.py install for mozsystemmonitor 09:48:16 INFO - Successfully installed mozsystemmonitor 09:48:16 INFO - Cleaning up... 09:48:16 INFO - Return code: 0 09:48:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:48:16 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')]} 09:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:16 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')]} 09:48:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:16 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 0xc931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1005770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1002a30>, '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 0x10037f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1003ca0>, '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': '0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546', '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 09:48:16 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 09:48:16 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 09:48:16 INFO - Using env: {'DISPLAY': ':0', 09:48:16 INFO - 'HOME': '/home/cltbld', 09:48:16 INFO - 'LANG': 'en_US.UTF-8', 09:48:16 INFO - 'LANGUAGE': 'en_US:en', 09:48:16 INFO - 'LOGNAME': 'cltbld', 09:48:16 INFO - 'MAIL': '/var/mail/cltbld', 09:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:16 INFO - 'MOZ_NO_REMOTE': '1', 09:48:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:16 INFO - 'NO_EM_RESTART': '1', 09:48:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:16 INFO - 'PWD': '/builds/slave/test', 09:48:16 INFO - 'SHELL': '/bin/bash', 09:48:16 INFO - 'SHLVL': '1', 09:48:16 INFO - 'TERM': 'linux', 09:48:16 INFO - 'TMOUT': '86400', 09:48:16 INFO - 'USER': 'cltbld', 09:48:16 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546', 09:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:16 INFO - '_': '/tools/buildbot/bin/python'} 09:48:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:16 INFO - Downloading/unpacking jsonschema==2.5.1 09:48: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 09:48: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 09:48: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 09:48: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 09:48:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:48:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:48: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 09:48: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 09:48: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 09:48: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 09:48:17 INFO - Downloading functools32-3.2.3-2.tar.gz 09:48:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:48:17 INFO - warning: no files found matching '*.txt' 09:48:17 INFO - no previously-included directories found matching 'build' 09:48:17 INFO - no previously-included directories found matching 'dist' 09:48:17 INFO - no previously-included directories found matching '.git*' 09:48:17 INFO - Installing collected packages: jsonschema, functools32 09:48:17 INFO - Running setup.py install for functools32 09:48:18 INFO - warning: no files found matching '*.txt' 09:48:18 INFO - no previously-included directories found matching 'build' 09:48:18 INFO - no previously-included directories found matching 'dist' 09:48:18 INFO - no previously-included directories found matching '.git*' 09:48:18 INFO - Successfully installed jsonschema functools32 09:48:18 INFO - Cleaning up... 09:48:18 INFO - Return code: 0 09:48:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:48:18 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')]} 09:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:18 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')]} 09:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:18 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 0xc931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1005770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1002a30>, '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 0x10037f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1003ca0>, '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': '0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546', '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 09:48:18 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 09:48:18 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 09:48:18 INFO - Using env: {'DISPLAY': ':0', 09:48:18 INFO - 'HOME': '/home/cltbld', 09:48:18 INFO - 'LANG': 'en_US.UTF-8', 09:48:18 INFO - 'LANGUAGE': 'en_US:en', 09:48:18 INFO - 'LOGNAME': 'cltbld', 09:48:18 INFO - 'MAIL': '/var/mail/cltbld', 09:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:18 INFO - 'MOZ_NO_REMOTE': '1', 09:48:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:18 INFO - 'NO_EM_RESTART': '1', 09:48:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:18 INFO - 'PWD': '/builds/slave/test', 09:48:18 INFO - 'SHELL': '/bin/bash', 09:48:18 INFO - 'SHLVL': '1', 09:48:18 INFO - 'TERM': 'linux', 09:48:18 INFO - 'TMOUT': '86400', 09:48:18 INFO - 'USER': 'cltbld', 09:48:18 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546', 09:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:18 INFO - '_': '/tools/buildbot/bin/python'} 09:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:48:18 INFO - Cleaning up... 09:48:18 INFO - Return code: 0 09:48:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:48:18 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')]} 09:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:18 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')]} 09:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:18 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 0xc931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1005770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1002a30>, '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 0x10037f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1003ca0>, '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': '0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546', '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 09:48:18 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 09:48:18 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 09:48:18 INFO - Using env: {'DISPLAY': ':0', 09:48:18 INFO - 'HOME': '/home/cltbld', 09:48:18 INFO - 'LANG': 'en_US.UTF-8', 09:48:18 INFO - 'LANGUAGE': 'en_US:en', 09:48:18 INFO - 'LOGNAME': 'cltbld', 09:48:18 INFO - 'MAIL': '/var/mail/cltbld', 09:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:18 INFO - 'MOZ_NO_REMOTE': '1', 09:48:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:18 INFO - 'NO_EM_RESTART': '1', 09:48:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:18 INFO - 'PWD': '/builds/slave/test', 09:48:18 INFO - 'SHELL': '/bin/bash', 09:48:18 INFO - 'SHLVL': '1', 09:48:18 INFO - 'TERM': 'linux', 09:48:18 INFO - 'TMOUT': '86400', 09:48:18 INFO - 'USER': 'cltbld', 09:48:18 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546', 09:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:18 INFO - '_': '/tools/buildbot/bin/python'} 09:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:18 INFO - Downloading/unpacking blobuploader==1.2.4 09:48: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 09:48: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 09:48: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 09:48: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 09:48:19 INFO - Downloading blobuploader-1.2.4.tar.gz 09:48:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:48:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:48: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 09:48: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 09:48: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 09:48: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 09:48:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:48:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:48:20 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 09:48:20 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 09:48:20 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 09:48:20 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 09:48:20 INFO - Downloading docopt-0.6.1.tar.gz 09:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:48:20 INFO - Installing collected packages: blobuploader, requests, docopt 09:48:20 INFO - Running setup.py install for blobuploader 09:48:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:48:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:48:20 INFO - Running setup.py install for requests 09:48:20 INFO - Running setup.py install for docopt 09:48:20 INFO - Successfully installed blobuploader requests docopt 09:48:20 INFO - Cleaning up... 09:48:20 INFO - Return code: 0 09:48:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:20 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 0xc931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1005770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1002a30>, '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 0x10037f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1003ca0>, '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': '0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546', '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 09:48:20 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 09:48:20 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 09:48:20 INFO - Using env: {'DISPLAY': ':0', 09:48:20 INFO - 'HOME': '/home/cltbld', 09:48:20 INFO - 'LANG': 'en_US.UTF-8', 09:48:20 INFO - 'LANGUAGE': 'en_US:en', 09:48:20 INFO - 'LOGNAME': 'cltbld', 09:48:20 INFO - 'MAIL': '/var/mail/cltbld', 09:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:20 INFO - 'MOZ_NO_REMOTE': '1', 09:48:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:20 INFO - 'NO_EM_RESTART': '1', 09:48:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:20 INFO - 'PWD': '/builds/slave/test', 09:48:20 INFO - 'SHELL': '/bin/bash', 09:48:20 INFO - 'SHLVL': '1', 09:48:20 INFO - 'TERM': 'linux', 09:48:20 INFO - 'TMOUT': '86400', 09:48:20 INFO - 'USER': 'cltbld', 09:48:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546', 09:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:20 INFO - '_': '/tools/buildbot/bin/python'} 09:48:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:21 INFO - Running setup.py (path:/tmp/pip-wd6u11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:21 INFO - Running setup.py (path:/tmp/pip-iGHxOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:21 INFO - Running setup.py (path:/tmp/pip-a6KPJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:21 INFO - Running setup.py (path:/tmp/pip-BfKxOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:21 INFO - Running setup.py (path:/tmp/pip-7tCzAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:21 INFO - Running setup.py (path:/tmp/pip-GB8A40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:21 INFO - Running setup.py (path:/tmp/pip-bFvCqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:21 INFO - Running setup.py (path:/tmp/pip-L6Z2Hm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:21 INFO - Running setup.py (path:/tmp/pip-M9MgTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:21 INFO - Running setup.py (path:/tmp/pip-Xv0hJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:21 INFO - Running setup.py (path:/tmp/pip-AbBXjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:21 INFO - Running setup.py (path:/tmp/pip-SDGKC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:21 INFO - Running setup.py (path:/tmp/pip-qVOYqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:21 INFO - Running setup.py (path:/tmp/pip-Grav1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:21 INFO - Running setup.py (path:/tmp/pip-NBGKho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:22 INFO - Running setup.py (path:/tmp/pip-97snAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:22 INFO - Running setup.py (path:/tmp/pip-2u56JP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:48:22 INFO - Running setup.py install for manifestparser 09:48:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:48:22 INFO - Running setup.py install for mozcrash 09:48:22 INFO - Running setup.py install for mozdebug 09:48:22 INFO - Running setup.py install for mozdevice 09:48:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:48:22 INFO - Running setup.py install for mozfile 09:48:22 INFO - Running setup.py install for mozhttpd 09:48:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:48:22 INFO - Running setup.py install for mozinfo 09:48:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:48:22 INFO - Running setup.py install for mozInstall 09:48:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:48:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:48:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:48:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:48:22 INFO - Running setup.py install for mozleak 09:48:23 INFO - Running setup.py install for mozlog 09:48:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:48:23 INFO - Running setup.py install for moznetwork 09:48:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:48:23 INFO - Running setup.py install for mozprocess 09:48:23 INFO - Running setup.py install for mozprofile 09:48:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:48:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:48:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:48:23 INFO - Running setup.py install for mozrunner 09:48:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:48:23 INFO - Running setup.py install for mozscreenshot 09:48:23 INFO - Running setup.py install for moztest 09:48:23 INFO - Running setup.py install for mozversion 09:48:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:48:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:48:23 INFO - Cleaning up... 09:48:23 INFO - Return code: 0 09:48:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48: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')]} 09:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48: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')]} 09:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48: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 0xc931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1005770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1002a30>, '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 0x10037f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1003ca0>, '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': '0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546', '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 09:48: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 09:48: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 09:48:23 INFO - Using env: {'DISPLAY': ':0', 09:48:23 INFO - 'HOME': '/home/cltbld', 09:48:23 INFO - 'LANG': 'en_US.UTF-8', 09:48:23 INFO - 'LANGUAGE': 'en_US:en', 09:48:23 INFO - 'LOGNAME': 'cltbld', 09:48:23 INFO - 'MAIL': '/var/mail/cltbld', 09:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:23 INFO - 'MOZ_NO_REMOTE': '1', 09:48:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:23 INFO - 'NO_EM_RESTART': '1', 09:48:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:23 INFO - 'PWD': '/builds/slave/test', 09:48:23 INFO - 'SHELL': '/bin/bash', 09:48:23 INFO - 'SHLVL': '1', 09:48:23 INFO - 'TERM': 'linux', 09:48:23 INFO - 'TMOUT': '86400', 09:48:23 INFO - 'USER': 'cltbld', 09:48:23 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546', 09:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:23 INFO - '_': '/tools/buildbot/bin/python'} 09:48:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:24 INFO - Running setup.py (path:/tmp/pip-5ak2VW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:24 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)) 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:24 INFO - Running setup.py (path:/tmp/pip-DqC2HM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:24 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)) 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:24 INFO - Running setup.py (path:/tmp/pip-tTtSbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:24 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)) 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:24 INFO - Running setup.py (path:/tmp/pip-rqqUFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:24 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)) 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:24 INFO - Running setup.py (path:/tmp/pip-PGYSqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:24 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)) 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:24 INFO - Running setup.py (path:/tmp/pip-ab6OUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:24 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)) 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:24 INFO - Running setup.py (path:/tmp/pip-0zb1kA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:24 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)) 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:24 INFO - Running setup.py (path:/tmp/pip-7afesY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:24 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)) 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:24 INFO - Running setup.py (path:/tmp/pip-beDrLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:24 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)) 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:24 INFO - Running setup.py (path:/tmp/pip-foqsqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48: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)) 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:24 INFO - Running setup.py (path:/tmp/pip-kCNoKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48: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)) 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:24 INFO - Running setup.py (path:/tmp/pip-yWJuRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:25 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)) 09:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:25 INFO - Running setup.py (path:/tmp/pip-Bo5vbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:25 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)) 09:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:25 INFO - Running setup.py (path:/tmp/pip-Gy_9_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:25 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)) 09:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:25 INFO - Running setup.py (path:/tmp/pip-WiSsTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:25 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)) 09:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:25 INFO - Running setup.py (path:/tmp/pip-8ZxtgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:25 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)) 09:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:25 INFO - Running setup.py (path:/tmp/pip-_eHPPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:25 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)) 09:48:25 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)) 09:48:25 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)) 09:48:25 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)) 09:48:25 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)) 09:48:25 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)) 09:48:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:48:25 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 09:48:25 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 09:48:25 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 09:48:25 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 09:48:26 INFO - Downloading blessings-1.6.tar.gz 09:48:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:48:26 INFO - Installing collected packages: blessings 09:48:26 INFO - Running setup.py install for blessings 09:48:26 INFO - Successfully installed blessings 09:48:26 INFO - Cleaning up... 09:48:26 INFO - Return code: 0 09:48:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:48:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:26 INFO - Reading from file tmpfile_stdout 09:48:26 INFO - Current package versions: 09:48:26 INFO - argparse == 1.2.1 09:48:26 INFO - blessings == 1.6 09:48:26 INFO - blobuploader == 1.2.4 09:48:26 INFO - docopt == 0.6.1 09:48:26 INFO - functools32 == 3.2.3-2 09:48:26 INFO - jsonschema == 2.5.1 09:48:26 INFO - manifestparser == 1.1 09:48:26 INFO - mozInstall == 1.12 09:48:26 INFO - mozcrash == 1.0 09:48:26 INFO - mozdebug == 0.1 09:48:26 INFO - mozdevice == 0.50 09:48:26 INFO - mozfile == 1.2 09:48:26 INFO - mozhttpd == 0.7 09:48:26 INFO - mozinfo == 0.9 09:48:26 INFO - mozleak == 0.1 09:48:26 INFO - mozlog == 3.4 09:48:26 INFO - moznetwork == 0.27 09:48:26 INFO - mozprocess == 0.25 09:48:26 INFO - mozprofile == 0.28 09:48:26 INFO - mozrunner == 6.13 09:48:26 INFO - mozscreenshot == 0.1 09:48:26 INFO - mozsystemmonitor == 0.3 09:48:26 INFO - moztest == 0.8 09:48:26 INFO - mozversion == 1.4 09:48:26 INFO - psutil == 3.1.1 09:48:26 INFO - requests == 1.2.3 09:48:26 INFO - wsgiref == 0.1.2 09:48:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48: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')]} 09:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48: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')]} 09:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48: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 0xc931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1005770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1002a30>, '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 0x10037f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1003ca0>, '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': '0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546', '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 09:48: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 09:48: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 09:48:26 INFO - Using env: {'DISPLAY': ':0', 09:48:26 INFO - 'HOME': '/home/cltbld', 09:48:26 INFO - 'LANG': 'en_US.UTF-8', 09:48:26 INFO - 'LANGUAGE': 'en_US:en', 09:48:26 INFO - 'LOGNAME': 'cltbld', 09:48:26 INFO - 'MAIL': '/var/mail/cltbld', 09:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:26 INFO - 'MOZ_NO_REMOTE': '1', 09:48:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:26 INFO - 'NO_EM_RESTART': '1', 09:48:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:26 INFO - 'PWD': '/builds/slave/test', 09:48:26 INFO - 'SHELL': '/bin/bash', 09:48:26 INFO - 'SHLVL': '1', 09:48:26 INFO - 'TERM': 'linux', 09:48:26 INFO - 'TMOUT': '86400', 09:48:26 INFO - 'USER': 'cltbld', 09:48:26 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546', 09:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:26 INFO - '_': '/tools/buildbot/bin/python'} 09:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:27 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)) 09:48:27 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)) 09:48:27 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)) 09:48:27 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)) 09:48:27 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)) 09:48:27 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)) 09:48:27 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)) 09:48:27 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)) 09:48:27 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)) 09:48:27 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)) 09:48:27 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)) 09:48:27 INFO - Cleaning up... 09:48:27 INFO - Return code: 0 09:48:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1005770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1002a30>, '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 0x10037f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1003ca0>, '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': '0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546', '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 09:48:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:48:27 INFO - Using env: {'DISPLAY': ':0', 09:48:27 INFO - 'HOME': '/home/cltbld', 09:48:27 INFO - 'LANG': 'en_US.UTF-8', 09:48:27 INFO - 'LANGUAGE': 'en_US:en', 09:48:27 INFO - 'LOGNAME': 'cltbld', 09:48:27 INFO - 'MAIL': '/var/mail/cltbld', 09:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:27 INFO - 'MOZ_NO_REMOTE': '1', 09:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:27 INFO - 'NO_EM_RESTART': '1', 09:48:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:27 INFO - 'PWD': '/builds/slave/test', 09:48:27 INFO - 'SHELL': '/bin/bash', 09:48:27 INFO - 'SHLVL': '1', 09:48:27 INFO - 'TERM': 'linux', 09:48:27 INFO - 'TMOUT': '86400', 09:48:27 INFO - 'USER': 'cltbld', 09:48:27 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546', 09:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:27 INFO - '_': '/tools/buildbot/bin/python'} 09:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:48:27 INFO - Cleaning up... 09:48:27 INFO - Return code: 0 09:48:27 INFO - Running post-action listener: _resource_record_post_action 09:48:27 INFO - Running post-action listener: _start_resource_monitoring 09:48:27 INFO - Starting resource monitoring. 09:48:27 INFO - [mozharness: 2017-05-14 16:48:27.452561Z] Finished create-virtualenv step (success) 09:48:27 INFO - [mozharness: 2017-05-14 16:48:27.453022Z] Running install step. 09:48:27 INFO - Running pre-action listener: _resource_record_pre_action 09:48:27 INFO - Running main action method: install 09:48:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:27 INFO - Reading from file tmpfile_stdout 09:48:27 INFO - Detecting whether we're running mozinstall >=1.0... 09:48:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:48:27 INFO - Reading from file tmpfile_stdout 09:48:27 INFO - Output received: 09:48:27 INFO - Usage: mozinstall [options] installer 09:48:27 INFO - Options: 09:48:27 INFO - -h, --help show this help message and exit 09:48:27 INFO - -d DEST, --destination=DEST 09:48:27 INFO - Directory to install application into. [default: 09:48:27 INFO - "/builds/slave/test"] 09:48:27 INFO - --app=APP Application being installed. [default: firefox] 09:48:27 INFO - mkdir: /builds/slave/test/build/application 09:48:27 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'] 09:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:48:43 INFO - Reading from file tmpfile_stdout 09:48:43 INFO - Output received: 09:48:43 INFO - /builds/slave/test/build/application/firefox/firefox 09:48:43 INFO - Running post-action listener: _resource_record_post_action 09:48:43 INFO - [mozharness: 2017-05-14 16:48:43.652729Z] Finished install step (success) 09:48:43 INFO - [mozharness: 2017-05-14 16:48:43.652973Z] Running run-tests step. 09:48:43 INFO - Running pre-action listener: _resource_record_pre_action 09:48:43 INFO - Running main action method: run_tests 09:48:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:48:43 INFO - Python 2.7.3 09:48:43 INFO - Return code: 0 09:48:43 INFO - grabbing minidump binary from tooltool 09:48: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')]} 09:48: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 0x1002a30>, '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 0x10037f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1003ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:48: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 09:48: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 09:48: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 09:48:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:48:43 INFO - Return code: 0 09:48:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:48:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:48:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:48:43 INFO - ENV: RUST_BACKTRACE is now 1 09:48:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:48:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:48:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 09:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 09:48:43 INFO - Using env: {'DISPLAY': ':0', 09:48:43 INFO - 'HOME': '/home/cltbld', 09:48:43 INFO - 'LANG': 'en_US.UTF-8', 09:48:43 INFO - 'LANGUAGE': 'en_US:en', 09:48:43 INFO - 'LOGNAME': 'cltbld', 09:48:43 INFO - 'MAIL': '/var/mail/cltbld', 09:48:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:48:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:43 INFO - 'MOZ_NO_REMOTE': '1', 09:48:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:48:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:43 INFO - 'NO_EM_RESTART': '1', 09:48:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:43 INFO - 'PWD': '/builds/slave/test', 09:48:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:48:43 INFO - 'RUST_BACKTRACE': '1', 09:48:43 INFO - 'SHELL': '/bin/bash', 09:48:43 INFO - 'SHLVL': '1', 09:48:43 INFO - 'TERM': 'linux', 09:48:43 INFO - 'TMOUT': '86400', 09:48:43 INFO - 'USER': 'cltbld', 09:48:43 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546', 09:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:43 INFO - '_': '/tools/buildbot/bin/python'} 09:48:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 09:48:43 INFO - mozversion application_buildid: 20170514160121 09:48:43 INFO - mozversion application_changeset: 3a801856dea979b0c3f630e1b0ec58106cdcb380 09:48:43 INFO - mozversion application_display_name: Nightly 09:48:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:48:43 INFO - mozversion application_name: Firefox 09:48:43 INFO - mozversion application_remotingname: firefox 09:48:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:48:43 INFO - mozversion application_vendor: Mozilla 09:48:43 INFO - mozversion application_version: 55.0a1 09:48:43 INFO - mozversion platform_buildid: 20170514160121 09:48:43 INFO - mozversion platform_changeset: 3a801856dea979b0c3f630e1b0ec58106cdcb380 09:48:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:48:43 INFO - mozversion platform_version: 55.0a1 09:48:43 INFO - using testdate: 1494780523 09:48:43 INFO - actual date: 1494780523 09:48:43 INFO - starting webserver on 'localhost:57431' 09:48:43 INFO - SUITE-START | Running 2 tests 09:48:43 INFO - TEST-START | dromaeo_css 09:48:43 INFO - operating with platform_type : linux_ 09:48:43 INFO - Initialising browser for dromaeo_css test... 09:48:43 INFO - TEST-INFO | started process 7361 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbeKrvc/profile http://localhost:57431/getInfo.html) 09:48:48 INFO - PID 7361 | __metrics Screen width/height:1600/1200 09:48:48 INFO - PID 7361 | colorDepth:24 09:48:48 INFO - PID 7361 | Browser inner width/height: 1024/695 09:48:48 INFO - PID 7361 | __metrics 09:48:50 INFO - TEST-INFO | 7361: exit 0 09:48:50 INFO - Browser initialized. 09:48:50 INFO - Running cycle 1/1 for dromaeo_css test... 09:48:50 INFO - TEST-INFO | started process 7536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbeKrvc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:49:02 INFO - PID 7536 | RSS: Main: 156774400 09:49:02 INFO - PID 7536 | 09:52:07 INFO - PID 7536 | Cycle 1(1): loaded http://localhost:57431/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57431/tests/dromaeo/cssquery-ext.html) 09:52:09 INFO - PID 7536 | RSS: Main: 167620608 09:52:09 INFO - PID 7536 | 09:55:11 INFO - PID 7536 | Cycle 1(1): loaded http://localhost:57431/tests/dromaeo/cssquery-ext.html (next: http://localhost:57431/tests/dromaeo/cssquery-jquery.html) 09:55:11 INFO - PID 7536 | RSS: Main: 160751616 09:55:11 INFO - PID 7536 | 09:58:13 INFO - PID 7536 | Cycle 1(1): loaded http://localhost:57431/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57431/tests/dromaeo/cssquery-mootools.html) 09:58:14 INFO - PID 7536 | RSS: Main: 169394176 09:58:14 INFO - PID 7536 | 10:01:16 INFO - PID 7536 | Cycle 1(1): loaded http://localhost:57431/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57431/tests/dromaeo/cssquery-prototype.html) 10:01:16 INFO - PID 7536 | RSS: Main: 161452032 10:01:16 INFO - PID 7536 | 10:04:19 INFO - PID 7536 | Cycle 1(1): loaded http://localhost:57431/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57431/tests/dromaeo/cssquery-yui.html) 10:04:20 INFO - PID 7536 | RSS: Main: 165601280 10:04:20 INFO - PID 7536 | 10:07:22 INFO - PID 7536 | Cycle 1(1): loaded http://localhost:57431/tests/dromaeo/cssquery-yui.html (next: http://localhost:57431/tests/dromaeo/cssquery-dojo.html) 10:07:22 INFO - PID 7536 | RSS: Main: 169086976 10:07:22 INFO - PID 7536 | 10:07:22 INFO - PID 7536 | __start_tp_report 10:07:22 INFO - PID 7536 | _x_x_mozilla_page_load 10:07:22 INFO - PID 7536 | _x_x_mozilla_page_load_details 10:07:22 INFO - PID 7536 | |i|pagename|runs| 10:07:22 INFO - PID 7536 | |0;dojo.html;2703.52688279551;2759.8758055887483;2764.7097054809246;2788.5120103981803;2800.5799130130476;5237.607179461536;5266.34170728659;5327.813526526573;5332.946670533303;5339.786408543659;5307.442718514559;5353.143497040474;5368.275282836816;5427.891442171154;5451.836444906649;4460.219461594208;4683.344331793552;4705.176594096037;4780.11567859947;4824.686395384307;4798.83204087857;4837.080954618629;4848.733319667434;4854.927176092361;4855.271709243606;4696.506866778973;4732.810687572493;4750.477447480775;4761.119192949315;4787.593054590364;4740.312654665088;4748.905021899577;4771.761411929424;4802.015586804697;4827.9034419311765;4684.180268453007;4711.411073615798;4720.740359280238;4737;4767.547083027107;5216.973915130438;5294.92057619136;5377.4084850666395;5378.46215378463;5416.620836541444;5800.042992906166;5845.2401187845735;5876.647401155944;5880.4119588041285;5901.055831067051;5842.474177324061;5858.384869588717;5862.97068514659;5872.853178670567;5875.236219291507;5290.232916227125;5393.865153371119;5398.78404863801;5421.701806400686;5424.75588598518;5875.941240587625;5953.732082056318;5969.641821490724;5971.223740913653;5977.252843394575;5681.715914204273;5707.229524014205;5731.111677689964;5737.913931291034;5782.277215348082;5812.82561523155;5813.476787089182;5819.418058194146;5821.912671309934;5826.329972053268;5764.971175144097;5771.5671324649975;5784.566157538202;5789.189513468118;5795.855103622359;5633.26767520228;5711.428857114255;5714.685692286964;5715.799947001919;5719.084946408555;4784.330193772875;4786.138495070921;4799.136155492045;4804.591609713144;4810.086083644096;4146.419501269825;4154.982029402755;4175.206710724952;4182.874513764592;4183.874483765492;4919.188333924933;4922.778474968635;4930.630202734809;4933.358663373739;4933.777979990909;5804.65172089676;5805.216295800097;5805.709714514342;5806;5810.983077961424;4838.903221935541;4927.7536123193695;4958.950410495849;4992.625553083533;4999.825006124768;5153.742312884416;5181.740912954413;5203.375594928557;5218.7912483500995;5228.869278268074;5408.486193811582;5408.918866217088;5420.945790542123;5421.051316019681;5421.566274698093;5744.827655170351;5772.307323121252;5821.185034095315;5831.970840145942;5833.533317334518;5356.1697936819855;5365.839024829262;5394.838154855361;5395.973020134874;5423;5742.339630942328;5746.195532625519;5750.913736293875;5754.251947246831;5755.856103597276;5705.686187259575;5798.275215598051;5838.970805145947;5859.44335288147;5874.735636896265;5589.105743081088;5650.943490565041;5661.433856614306;5700.116481945305;5701.771929122789;5618.775248989995;5653.3216014076925;5653.491185793298;5668.574856885833;5670.461306175906;5373.9731301343245;5501.807436739695;5565.7217139143695;5567.8886422272135;5600.411956744483;5509.889802204014;5604.299462567179;5608.298962629671;5631.155326701028;5657.717114144359;5463.508284254436;5464;5469.878674871721;5480.561555075664;5512.7519261634125 10:07:22 INFO - PID 7536 | |1;ext.html;720.1106633307863;742.543335848453;1032.53535908841;1048.072455876549;1163.8196079607665;32632.67367326329;33560.832195838986;33628.15929601761;33634;33638.32723345535;30652.386952260997;30980.225494362654;31017.06948791534;31039.68960310402;31062.37875242494;6269.404406581368;6275.215598050244;6957.304269573053;6970.581765094111;6992.580445173306;6936.410405115571;7017.473689473284;7026.4730145239055;7029.89455158173;7031.156261248658;6946;6958.269381714923;6986;6988.860222795541;7000;6971.511994160411;6993.860122797541;7014.964925175393;7022.508424410294;7027.718891244344;6841.247462779091;6907.758228461979;6922.203946546111;6937.7224911003495;6942.965285173593;30875.22811929697;31179.220519486968;31192.844035779905;31236.531452028237;31268.530972035438;2984.910452686423;3011.26224075103;3033.8179709217297;3042.0113463124353;3044.360684256309;24423.511529769305;24434.511309773705;24442.26673199807;24528.386790330205;24590.877045614656;3113.470709979309;3120.4851199552045;3136.8745250190195;3138.7489000879873;3150.401423729484;142355;142418;142881.2855935724;143056.13887722293;143086.41481511144;33239.33521329608;33540.83229583885;38823.41764873529;39598.208035839125;39814.2037159261;40677;40853.38719919204;40881.386779198336;40989.79505102456;41039.794801025804;10976.396298203676;11152.498137583665;11211.887881121085;11215.551377944954;11219.495122719498;8650.783730406665;8671.696490622799;8676.175763302475;8698.34762392823;8794.956025219833;12347.69130771738;12386.380680965916;12502.124851260325;12565;12695.365231738377;5065.8733531662;5167.814070602823;5207.583393328525;5246.816361427408;5304.92042619361;855.2217482091268;880.5421180985851;886.6409104312635;886.6542048601051;915.5468043318467;20608.48478788042;24099.277021689377;25732.871335643576;26137.477250454886;26152.8692356537;926.3145272498302;937.2782957122977;942.1991307388802;950.6387572722459;957.7701351675687;10613.73465663349;11131.387773672364;11133.777324453466;11151.944240278746;11222.326660400402;172959;173114;173241;174913;175752;40267;40461.1907761849;40569.391459128135;40652.18695626071;40659.59340406558;1183.4556104191995;1207.4001947419529;1210.5036934856666;1211.1340391620033;1218.1959906461693;19037.809621903605;19422.611547768684;20164.29424970119;20174.59650807005;20405.387838364873;30101.548476772427;30113.3977320448;30392.088237352913;30422.847885760428;30467.542986854773;154248;156005.3792200102;156068;156238.21880890522;156403;28688.282792930342;28917.132486025454;29025.7097429023;29989;30032;36031.81984090063;36813;36880.81559592185;37135.44296835495;37872.24255514929;27324;28009.85995070093;28346.2913427166;28362.2909427266;28538.714612853604;27474.450510989267;27815.860920695268;27970.860145699142;28076;29251.414971700873;30819.845900770353;30990.69009309968;31026.84486577643;31237.531437028007;31248.843755781076;26710.465790683687;26775.464490709688;27304;27374;28579.142625721262;21425.357239282846;22394.88802555977;22661;22663.660045099667;22820.087196511955 10:07:22 INFO - PID 7536 | |2;jquery.html;414.8658709607939;417.8349551926987;429.8388104460828;436.82526989204314;443.23320655266366;16751;16881.66236675266;16987.541347277536;17340.47978560645;17553.297868085276;17773.28906843728;17968.820311796877;19046.428607141806;19464.513387165327;19619;5457.5633949284065;5499.065158922993;5510.393856675782;5532.502074813266;5559.499645031946;5409.377921539014;5561.5272701820395;5587.497125258726;5587.8603034924045;5605.383407825136;5305.363356397218;5489.533389661883;5506.614536982413;5507.531859791922;5546.334439867222;5488.91766623501;5588.329400471929;5593.972030139864;5616.719164041802;5632.690202038886;5004.699718016931;5020.397552293712;5034.798608055673;5046.142155833517;5071.873203169914;21795.455113622127;22198.667019994715;22594.54810903773;22719.091236350527;22879.885600572055;1622.6349071458944;1670;1673.2303140555236;1676.1451659653542;1676.1870492810976;14524;14735.189564573944;14934;15225.847741522553;15233.771493427608;1805.1064722962217;1891.1206289075647;1896.4500294914458;1927.5277556998485;1933.8452923766065;78144.21855781483;85814.57092714559;87794;91738.54130729371;101534;11128.610498632508;11503.424828758529;11530.192886498033;11564.537418503165;11643.476043578059;15754.133522656135;15755.527334179764;15774.921125394529;15777.211139442981;15826.129562873923;7120.786376408716;7259.128904531384;7324.597147156957;7452.503411357147;7457.179710231871;5896.380880007623;5918.526517878559;6143.201383820075;6442.838929026718;6580.934190658128;7021.1574611047;7093.6453177341955;7167.283271672895;7267.800812865924;7336;2123.4054464749893;2150.182930486405;2153.6984822124914;2164.4480657432255;2310.595645761985;845.399766166029;874.1258741258741;882.5013867165031;892.7324595527417;908.0692290402391;16945.915270423815;17223.741643875353;18018;18049.7292540612;18238.08809559517;864.2006144316482;867.3668222197831;882.8940527136784;889.0842432294746;900.1763386501409;9252.629894804268;9510.714678559654;9744.220462362993;9813.558389872473;9940.25448091396;343469;347057;348067;348133;355904;62095;71802.64098679474;72102.27897720956;73181;76551;1079.5304042741432;1115.5203262597;1143.7998350288833;1143.9199256052163;1149.143887803575;16964.321427142775;17736.55658608545;17786.733199001766;18873.245070197037;19219.615607688047;37026.25947481089;38149.61850381461;38575;38699.6130038696;39474.80262598669;45096;45520.54479455163;46276.53723462857;46438;47313;8392.20274073962;8473.364497662576;8600.39797214189;8650.826983460422;8662.566871656267;12715.173513721578;12960.416781244678;13005.674858128623;13408.32958352098;13491.865081349453;10403.427811470441;10559.524821382902;11092.724336701383;11267.26762760418;11371;10353.585856565653;10688.946555267174;10697.358158510515;10733.087687546646;10839.67480975572;9623.23109686907;9766.267529935141;10048.84926726085;11444.656660300205;11512.251703639571;8543.444676096035;8597.52713600758;8605;8634.438761480484;8718.607662655322;11158.721031974266;11253.549858005588;11369.772604548029;11603.419829008348;11811.881881181078 10:07:22 INFO - PID 7536 | |3;mootools.html;1242.6955395927998;1277.4315429633812;1292.1019891175636;1297.7404519096178;1298.5065675043486;9302.488363140024;9584.712458626234;9598.328117031811;10040.648577299797;10477.528511216995;10020.098191162793;10122.493875306242;10176.898231017687;10212.795744085113;10229.181665466764;2198.38445235334;2214.745304290011;2230.6765518999737;2236.206146817881;2237.9328620141423;2063.998960504154;2118.491562025118;2132.6694362373855;2134.6157691615504;2135.711678923341;2185.7704940981207;2214.258223495131;2225.8219342452567;2248.4491299631613;2253.7070180876544;2073.9792602073935;2115.5345823918715;2119.6290649136417;2122.490602255463;2122.9893850530725;1886.7264246684292;2115.6509175985943;2120.7879212078824;2127.8829664368454;2131.5630295789483;10218.182545396425;10261.640842570549;10288.691339259834;10308.948455257676;10313.123384512326;5502.422245664187;5701.401352857932;5716.3426205986425;5721.656700597978;5736.2256095427;3305.413401567237;3380.847861846198;3440.690337869579;3490.5636795400574;3578.8568457261676;1029.794041191757;1041.661465017449;1078.3152698036724;1085.0722632149557;1088.2871719024051;14835.332410041574;14902.254887255702;14912.328945197383;14923.925380373028;14934;4487.41663583732;4687.296905464208;4787.257975013878;4857.101436234308;4866.221404575322;10574.15406767472;10585.84121238182;10594.470276486145;10624.468776561296;10676.83984740214;5323.22813192085;5368.516833484927;5382.381026181961;5405.810796622178;5409.053415652245;4740.099381117577;4955.950440495621;4986.476419975923;4997.000599880039;5133.6919784813035;3779.7543159694533;3889.124946886984;3901.3562762144497;3908.394198899175;3998.280309544252;1137.766757814646;1139.8176291793438;1139.8746137924823;1153.901918336934;1161.4018780328138;664.9501287403464;690.9412699920463;692.1693967239333;710.3358359933479;712.383788023356;5115.948840511622;5185.351831021122;5206.557442617344;5401.108817045222;5408.242846001563;514.5574805667123;526.3026489900897;526.5761062344773;529.5366554265019;531.0626743797201;3131.264152924061;3180.0936733030976;3191.7446604271604;3215.6141263048585;3711;12399.25604463735;13188.27464489443;13407.262600556867;13508.594742157751;13577.456901724017;12970.80543791844;13267;13303;13313.467461301632;13492.797608035888;7553.244675532513;7594.848103037908;7680.270374314431;7688.231176882379;7694.345980591713;5530.253415788817;5621.494065534122;5660.094384898396;5713.942860571341;5799.623024503394;11914.463849126983;11920.344381058778;11984.46069926838;12105.69735756613;12196.085293603193;11755.764884702086;12077.75844483123;12161;12342.568010119603;12365.814512782496;7867.724629637935;8014.799630009296;8072.192780721881;8095.595220239083;8115.878261825959;9513.238940884574;9983.650572229937;9993.400395976265;10077.395356278646;10089.545970431494;8281.875771863548;8497.702580409656;8643.783905402415;8881;8972.865407019031;8165.469244499089;8328.250457458858;8415.915840841513;8667.17661822126;8787.077356877437;7104.715811367488;7188.101487314086;7192.784216473514;7246.130464344102;7252.020977168015;5130.256112863689;5153.6907785532985;5156.504613661996;5178.8964220716125;5457.69982650958;5249.396319423316;5337.492938170868;5407.161889907071;5423.240746295601;5463.180522921434 10:07:22 INFO - PID 7536 | |4;prototype.html;378.0982357078369;381.51928570001826;382.2736800079848;382.5982718145946;387.63368616657255;5440.863978400542;5471.972640136803;5550.972245138773;5576.721163941807;5657.151427285909;5372.973135134329;5500.862478438041;5508.64193827401;5527.778888844441;5532.502074813266;4138.606832350937;4254.404383386328;4373.781310934456;4377.912441751163;4382.583654552828;4364.650827933758;4376.912461750779;4387.517373088957;4392.428984232045;4398.582134697199;4316.848700448674;4352.956470435302;4364.25807612705;4372.234858899696;4383.4739831220295;4300.935485967681;4301.913961720779;4321.092570560186;4342.131573685244;4353.804078816445;3914.3149948758855;3917.1186483041374;3932.2135572885536;3945.5659877413464;3958.0896393829294;5454.372747134091;5464.972675136599;5473.452654734495;5482.396936337;5488.259085023511;5014;5150.27896094547;5179.223116532513;5186.092433824066;5237.79048838046;5888.705564721789;5916.171735956969;5916.3787802281;5920.585559010871;5957.1957785698805;4399.538048504893;4406;4428.070105277896;4438.778061096932;4455.509893911667;6100.23747031621;6273.309935907047;6298.716557754912;6299.96850015747;6320.873582528369;4538.751843243069;4554.772261386984;4554.908901821945;4559.110973360229;4563.680542362069;4581.83163293358;4646.838290427393;4654.532373381785;4659.906801863944;4678.111158879802;5106.770195341219;5123.103456895028;5124.846254612367;5153.804641122528;5166.715830629351;5901.468867801918;5904.586678932519;5924.851878703067;5929.132323318141;5931.6441013539325;1548.8528589783953;1573.5515378117182;1605.5825485373887;1638.2873450049028;1638.860696840758;1141.4635121492886;1158.5134243617701;1167.2646232873235;1167.6613782003294;1169.5263418315596;5052.141136006814;5071.3153724247495;5080.949190508121;5083.87290317745;5093.439721630618;6051.364606716319;6064.332923378425;6065.423784740443;6067.2112625359305;6094.628708540543;4916.918277978839;5083.008813281374;5100.132977393852;5103.948960510422;5149.871253218699;3218.9839050804594;3227.370662720794;3248.9928122282167;3250.593675790526;3258.185453636591;5462.918056229159;5606.187102870143;5616.1014237721765;5620.915686264628;5629.7185140742795;6115.755369785159;6219;6285.842853928597;6300.464460520815;6319.8104056878365;5624.353199382042;5629.155626656035;5636.718164091861;5641.689707066151;5645;6046.3046749624355;6126.479249263863;6130.7241174146375;6142.262928448615;6161.630302181883;5962.403759624003;5976.7908123215475;6028.698565071817;6053.636781793107;6060.757569697163;5576.107822748503;5640.435956404327;5645.548356131581;5658.490735833795;5674.233978412862;4022.0950286185375;4051.47330846988;4068.5385341867745;4088.6933479988525;4128.47246518778;6112.358202388685;6129.264488261437;6149.877002460015;6165.352637972948;6179.70226252492;5922.792702255572;5935.495482884004;5942.257217847769;5949.25634295713;5954.612950158225;5730.312362516358;5834.562407819515;5878.2064421302575;5878.3239927408895;5903.881922361615;5762.884742305214;5779.537636988946;5795.1017592273265;5801.709914504342;5821.417858214145;5776.774865474811;5905.557083218861;5915.053591425351;5934.881302374015;5936.942474625657;5753.417810102255;5768.625039372428;5780;5782.335031471434;5784.537237021113 10:07:22 INFO - PID 7536 | |5;yui.html;709.2446544430182;722.1190148019415;722.238038868993;722.2452537098732;742.3578604507103;12250.142490025703;12772.872271277285;13090.21458712478;14356.712865742691;14380;15196.164210968393;15300.617484562892;15747.527574172764;15765.132917689523;15862.286197121128;817.6198067898426;823.6334831000207;826.9627866745981;830.2320353672859;830.8546004449228;877.1754550722333;883.2580632268892;883.5891310540597;883.9911600884005;885.3359980014989;903.4714691905243;912.0514664748687;913.4336711239041;916.3081873185736;916.5646317998963;907.8320510705507;912.115248209236;913.5934509143434;915.199200699388;917.4266083697689;673.1148539670367;676.7800464848943;677.6002158726375;677.6239187251074;679.4496457869142;13825.585232443043;14092.577222683336;14411.351489183013;14516.419343226258;14635.121892686473;15381.230938453033;15440.768388474182;15563.455279065292;15608.29762660683;15717.921410392875;11697.590584329508;11884.10869184806;11991.760164796655;12006.099542534257;12144.757104857941;2937.251000994754;2962.126172779014;2981.5378616314506;2998.895038673636;3002.054352878836;68389.3161068393;68709.9999999995;68836.6558167206;69536;70615.29384706139;11781.76436471283;11966.521339146511;12136.817947730791;12233.082518810947;12273.140880138482;21604.45988850291;21944.231951881608;23056.88471557665;23305.766942330698;23307.7669223309;5936.465718085393;6034;6104.236970378703;6113.449789518964;6119;2874.1664917174203;2969.0647446054422;3001.354708737588;3004.128802647208;3007.5338322560037;3456.4815277708544;3521.9471707924404;3525.982370088133;3568.6431356864105;3590.6588874056924;738.3059923671732;764.81262090787;769.6190385759085;773.1302284929454;774.013133255093;548.0901703172714;550.9779608815602;568.6360729133276;580.4108829538022;601.0863487498978;10652.520636571373;10719;11391.943040284745;11644.94177529124;11805.822912656316;492.5173330136486;494.18952917215796;497.6516438492997;568.2896379525592;568.5394830187562;4199.853005144805;4391.341298805205;4395.274779661384;4549.727016378962;4552.11233809404;56441;57587;58928;62253.37746622566;62255;53827;53857;54239.45760542423;54919;55170.72414637901;48096.7595162022;49409.0118197634;49477;50439.243411348856;50584.747076264386;8311.501309921425;8588.871166932626;8638.740837774876;8693.174148455886;8842.911570884466;25000;25226;25538.616920745833;25793.613095803954;25955.480890382463;30560.235994100327;30851;31000.379992400478;31530.527042094847;31884;11015.724606884893;11433.59982400612;11446.427678616203;11495.942520287344;11574.305541667527;13736.519221827188;13947.651308716957;14079.366428510946;15166.696666066837;15261.931664783358;12704.30126343023;13047.804282935575;13589.320533973065;13717.794233086712;13903.513377031755;13617.795733063815;13683.24742139192;13936.372863221382;14091.718165636836;14260.50088246948;13024.934875325564;13057;13061.477540898637;13290;13330.266835323762;9492.145706886413;9520.714378568655;9980.301378903407;10120.59517619287;10159;11120.221584489009;11734.706632333919;11789.587364442203;11929.940350298193;12012.819807703067 10:07:22 INFO - PID 7536 | __end_tp_report 10:07:22 INFO - PID 7536 | __start_cc_report 10:07:22 INFO - PID 7536 | _x_x_mozilla_cycle_collect,377 10:07:22 INFO - PID 7536 | __end_cc_report 10:07:22 INFO - PID 7536 | __startTimestamp1494781642610__endTimestamp 10:07:22 INFO - PID 7536 | 10:07:22 INFO - PID 7536 | ------- Summary: start ------- 10:07:22 INFO - PID 7536 | Number of tests: 6 10:07:22 INFO - PID 7536 | 10:07:22 INFO - PID 7536 | [#0] dojo.html Cycles:165 Average:5290.07 Median:5423.00 stddev:632.65 (11.7%) stddev-sans-first:601.17 10:07:22 INFO - PID 7536 | Values: 2703.5 2759.9 2764.7 2788.5 2800.6 5237.6 5266.3 5327.8 5332.9 5339.8 5307.4 5353.1 5368.3 5427.9 5451.8 4460.2 4683.3 4705.2 4780.1 4824.7 4798.8 4837.1 4848.7 4854.9 4855.3 4696.5 4732.8 4750.5 4761.1 4787.6 4740.3 4748.9 4771.8 4802.0 4827.9 4684.2 4711.4 4720.7 4737.0 4767.5 5217.0 5294.9 5377.4 5378.5 5416.6 5800.0 5845.2 5876.6 5880.4 5901.1 5842.5 5858.4 5863.0 5872.9 5875.2 5290.2 5393.9 5398.8 5421.7 5424.8 5875.9 5953.7 5969.6 5971.2 5977.3 5681.7 5707.2 5731.1 5737.9 5782.3 5812.8 5813.5 5819.4 5821.9 5826.3 5765.0 5771.6 5784.6 5789.2 5795.9 5633.3 5711.4 5714.7 5715.8 5719.1 4784.3 4786.1 4799.1 4804.6 4810.1 4146.4 4155.0 4175.2 4182.9 4183.9 4919.2 4922.8 4930.6 4933.4 4933.8 5804.7 5805.2 5805.7 5806.0 5811.0 4838.9 4927.8 4959.0 4992.6 4999.8 5153.7 5181.7 5203.4 5218.8 5228.9 5408.5 5408.9 5420.9 5421.1 5421.6 5744.8 5772.3 5821.2 5832.0 5833.5 5356.2 5365.8 5394.8 5396.0 5423.0 5742.3 5746.2 5750.9 5754.3 5755.9 5705.7 5798.3 5839.0 5859.4 5874.7 5589.1 5650.9 5661.4 5700.1 5701.8 5618.8 5653.3 5653.5 5668.6 5670.5 5374.0 5501.8 5565.7 5567.9 5600.4 5509.9 5604.3 5608.3 5631.2 5657.7 5463.5 5464.0 5469.9 5480.6 5512.8 10:07:22 INFO - PID 7536 | 10:07:22 INFO - PID 7536 | [#1] ext.html Cycles:180 Average:30063.75 Median:30927.73 stddev:40746.13 (131.7%) stddev-sans-first:40800.85 10:07:22 INFO - PID 7536 | Values: 720.1 742.5 1032.5 1048.1 1163.8 32632.7 33560.8 33628.2 33634.0 33638.3 30652.4 30980.2 31017.1 31039.7 31062.4 6269.4 6275.2 6957.3 6970.6 6992.6 6936.4 7017.5 7026.5 7029.9 7031.2 6946.0 6958.3 6986.0 6988.9 7000.0 6971.5 6993.9 7015.0 7022.5 7027.7 6841.2 6907.8 6922.2 6937.7 6943.0 30875.2 31179.2 31192.8 31236.5 31268.5 2984.9 3011.3 3033.8 3042.0 3044.4 24423.5 24434.5 24442.3 24528.4 24590.9 3113.5 3120.5 3136.9 3138.7 3150.4 142355.0 142418.0 142881.3 143056.1 143086.4 33239.3 33540.8 38823.4 39598.2 39814.2 40677.0 40853.4 40881.4 40989.8 41039.8 10976.4 11152.5 11211.9 11215.6 11219.5 8650.8 8671.7 8676.2 8698.3 8795.0 12347.7 12386.4 12502.1 12565.0 12695.4 5065.9 5167.8 5207.6 5246.8 5304.9 855.2 880.5 886.6 886.7 915.5 20608.5 24099.3 25732.9 26137.5 26152.9 926.3 937.3 942.2 950.6 957.8 10613.7 11131.4 11133.8 11151.9 11222.3 172959.0 173114.0 173241.0 174913.0 175752.0 40267.0 40461.2 40569.4 40652.2 40659.6 1183.5 1207.4 1210.5 1211.1 1218.2 19037.8 19422.6 20164.3 20174.6 20405.4 30101.5 30113.4 30392.1 30422.8 30467.5 154248.0 156005.4 156068.0 156238.2 156403.0 28688.3 28917.1 29025.7 29989.0 30032.0 36031.8 36813.0 36880.8 37135.4 37872.2 27324.0 28009.9 28346.3 28362.3 28538.7 27474.5 27815.9 27970.9 28076.0 29251.4 30819.8 30990.7 31026.8 31237.5 31248.8 26710.5 26775.5 27304.0 27374.0 28579.1 21425.4 22394.9 22661.0 22663.7 22820.1 10:07:22 INFO - PID 7536 | 10:07:22 INFO - PID 7536 | [#2] jquery.html Cycles:180 Average:24162.89 Median:38362.31 stddev:58070.74 (151.4%) stddev-sans-first:58206.27 10:07:22 INFO - PID 7536 | Values: 414.9 417.8 429.8 436.8 443.2 16751.0 16881.7 16987.5 17340.5 17553.3 17773.3 17968.8 19046.4 19464.5 19619.0 5457.6 5499.1 5510.4 5532.5 5559.5 5409.4 5561.5 5587.5 5587.9 5605.4 5305.4 5489.5 5506.6 5507.5 5546.3 5488.9 5588.3 5594.0 5616.7 5632.7 5004.7 5020.4 5034.8 5046.1 5071.9 21795.5 22198.7 22594.5 22719.1 22879.9 1622.6 1670.0 1673.2 1676.1 1676.2 14524.0 14735.2 14934.0 15225.8 15233.8 1805.1 1891.1 1896.5 1927.5 1933.8 78144.2 85814.6 87794.0 91738.5 101534.0 11128.6 11503.4 11530.2 11564.5 11643.5 15754.1 15755.5 15774.9 15777.2 15826.1 7120.8 7259.1 7324.6 7452.5 7457.2 5896.4 5918.5 6143.2 6442.8 6580.9 7021.2 7093.6 7167.3 7267.8 7336.0 2123.4 2150.2 2153.7 2164.4 2310.6 845.4 874.1 882.5 892.7 908.1 16945.9 17223.7 18018.0 18049.7 18238.1 864.2 867.4 882.9 889.1 900.2 9252.6 9510.7 9744.2 9813.6 9940.3 343469.0 347057.0 348067.0 348133.0 355904.0 62095.0 71802.6 72102.3 73181.0 76551.0 1079.5 1115.5 1143.8 1143.9 1149.1 16964.3 17736.6 17786.7 18873.2 19219.6 37026.3 38149.6 38575.0 38699.6 39474.8 45096.0 45520.5 46276.5 46438.0 47313.0 8392.2 8473.4 8600.4 8650.8 8662.6 12715.2 12960.4 13005.7 13408.3 13491.9 10403.4 10559.5 11092.7 11267.3 11371.0 10353.6 10688.9 10697.4 10733.1 10839.7 9623.2 9766.3 10048.8 11444.7 11512.3 8543.4 8597.5 8605.0 8634.4 8718.6 11158.7 11253.5 11369.8 11603.4 11811.9 10:07:22 INFO - PID 7536 | 10:07:22 INFO - PID 7536 | [#3] mootools.html Cycles:180 Average:6241.28 Median:3465.63 stddev:4061.53 (117.2%) stddev-sans-first:4055.56 10:07:22 INFO - PID 7536 | Values: 1242.7 1277.4 1292.1 1297.7 1298.5 9302.5 9584.7 9598.3 10040.6 10477.5 10020.1 10122.5 10176.9 10212.8 10229.2 2198.4 2214.7 2230.7 2236.2 2237.9 2064.0 2118.5 2132.7 2134.6 2135.7 2185.8 2214.3 2225.8 2248.4 2253.7 2074.0 2115.5 2119.6 2122.5 2123.0 1886.7 2115.7 2120.8 2127.9 2131.6 10218.2 10261.6 10288.7 10308.9 10313.1 5502.4 5701.4 5716.3 5721.7 5736.2 3305.4 3380.8 3440.7 3490.6 3578.9 1029.8 1041.7 1078.3 1085.1 1088.3 14835.3 14902.3 14912.3 14923.9 14934.0 4487.4 4687.3 4787.3 4857.1 4866.2 10574.2 10585.8 10594.5 10624.5 10676.8 5323.2 5368.5 5382.4 5405.8 5409.1 4740.1 4956.0 4986.5 4997.0 5133.7 3779.8 3889.1 3901.4 3908.4 3998.3 1137.8 1139.8 1139.9 1153.9 1161.4 665.0 690.9 692.2 710.3 712.4 5115.9 5185.4 5206.6 5401.1 5408.2 514.6 526.3 526.6 529.5 531.1 3131.3 3180.1 3191.7 3215.6 3711.0 12399.3 13188.3 13407.3 13508.6 13577.5 12970.8 13267.0 13303.0 13313.5 13492.8 7553.2 7594.8 7680.3 7688.2 7694.3 5530.3 5621.5 5660.1 5713.9 5799.6 11914.5 11920.3 11984.5 12105.7 12196.1 11755.8 12077.8 12161.0 12342.6 12365.8 7867.7 8014.8 8072.2 8095.6 8115.9 9513.2 9983.7 9993.4 10077.4 10089.5 8281.9 8497.7 8643.8 8881.0 8972.9 8165.5 8328.3 8415.9 8667.2 8787.1 7104.7 7188.1 7192.8 7246.1 7252.0 5130.3 5153.7 5156.5 5178.9 5457.7 5249.4 5337.5 5407.2 5423.2 5463.2 10:07:22 INFO - PID 7536 | 10:07:22 INFO - PID 7536 | [#4] prototype.html Cycles:180 Average:4920.23 Median:5472.71 stddev:1399.32 (25.6%) stddev-sans-first:1361.08 10:07:22 INFO - PID 7536 | Values: 378.1 381.5 382.3 382.6 387.6 5440.9 5472.0 5551.0 5576.7 5657.2 5373.0 5500.9 5508.6 5527.8 5532.5 4138.6 4254.4 4373.8 4377.9 4382.6 4364.7 4376.9 4387.5 4392.4 4398.6 4316.8 4353.0 4364.3 4372.2 4383.5 4300.9 4301.9 4321.1 4342.1 4353.8 3914.3 3917.1 3932.2 3945.6 3958.1 5454.4 5465.0 5473.5 5482.4 5488.3 5014.0 5150.3 5179.2 5186.1 5237.8 5888.7 5916.2 5916.4 5920.6 5957.2 4399.5 4406.0 4428.1 4438.8 4455.5 6100.2 6273.3 6298.7 6300.0 6320.9 4538.8 4554.8 4554.9 4559.1 4563.7 4581.8 4646.8 4654.5 4659.9 4678.1 5106.8 5123.1 5124.8 5153.8 5166.7 5901.5 5904.6 5924.9 5929.1 5931.6 1548.9 1573.6 1605.6 1638.3 1638.9 1141.5 1158.5 1167.3 1167.7 1169.5 5052.1 5071.3 5080.9 5083.9 5093.4 6051.4 6064.3 6065.4 6067.2 6094.6 4916.9 5083.0 5100.1 5103.9 5149.9 3219.0 3227.4 3249.0 3250.6 3258.2 5462.9 5606.2 5616.1 5620.9 5629.7 6115.8 6219.0 6285.8 6300.5 6319.8 5624.4 5629.2 5636.7 5641.7 5645.0 6046.3 6126.5 6130.7 6142.3 6161.6 5962.4 5976.8 6028.7 6053.6 6060.8 5576.1 5640.4 5645.5 5658.5 5674.2 4022.1 4051.5 4068.5 4088.7 4128.5 6112.4 6129.3 6149.9 6165.4 6179.7 5922.8 5935.5 5942.3 5949.3 5954.6 5730.3 5834.6 5878.2 5878.3 5903.9 5762.9 5779.5 5795.1 5801.7 5821.4 5776.8 5905.6 5915.1 5934.9 5936.9 5753.4 5768.6 5780.0 5782.3 5784.5 10:07:22 INFO - PID 7536 | 10:07:22 INFO - PID 7536 | [#5] yui.html Cycles:180 Average:14703.03 Median:31707.26 stddev:17271.85 (54.5%) stddev-sans-first:17288.33 10:07:22 INFO - PID 7536 | Values: 709.2 722.1 722.2 722.2 742.4 12250.1 12772.9 13090.2 14356.7 14380.0 15196.2 15300.6 15747.5 15765.1 15862.3 817.6 823.6 827.0 830.2 830.9 877.2 883.3 883.6 884.0 885.3 903.5 912.1 913.4 916.3 916.6 907.8 912.1 913.6 915.2 917.4 673.1 676.8 677.6 677.6 679.4 13825.6 14092.6 14411.4 14516.4 14635.1 15381.2 15440.8 15563.5 15608.3 15717.9 11697.6 11884.1 11991.8 12006.1 12144.8 2937.3 2962.1 2981.5 2998.9 3002.1 68389.3 68710.0 68836.7 69536.0 70615.3 11781.8 11966.5 12136.8 12233.1 12273.1 21604.5 21944.2 23056.9 23305.8 23307.8 5936.5 6034.0 6104.2 6113.4 6119.0 2874.2 2969.1 3001.4 3004.1 3007.5 3456.5 3521.9 3526.0 3568.6 3590.7 738.3 764.8 769.6 773.1 774.0 548.1 551.0 568.6 580.4 601.1 10652.5 10719.0 11391.9 11644.9 11805.8 492.5 494.2 497.7 568.3 568.5 4199.9 4391.3 4395.3 4549.7 4552.1 56441.0 57587.0 58928.0 62253.4 62255.0 53827.0 53857.0 54239.5 54919.0 55170.7 48096.8 49409.0 49477.0 50439.2 50584.7 8311.5 8588.9 8638.7 8693.2 8842.9 25000.0 25226.0 25538.6 25793.6 25955.5 30560.2 30851.0 31000.4 31530.5 31884.0 11015.7 11433.6 11446.4 11495.9 11574.3 13736.5 13947.7 14079.4 15166.7 15261.9 12704.3 13047.8 13589.3 13717.8 13903.5 13617.8 13683.2 13936.4 14091.7 14260.5 13024.9 13057.0 13061.5 13290.0 13330.3 9492.1 9520.7 9980.3 10120.6 10159.0 11120.2 11734.7 11789.6 11929.9 12012.8 10:07:22 INFO - PID 7536 | -------- Summary: end -------- 10:07:22 INFO - PID 7536 | 10:07:23 INFO - TEST-INFO | 7536: exit 0 10:07:23 INFO - TEST-OK | dromaeo_css | took 1119536ms 10:07:23 INFO - TEST-START | kraken 10:07:23 INFO - operating with platform_type : linux_ 10:07:23 INFO - Initialising browser for kraken test... 10:07:23 INFO - TEST-INFO | started process 7956 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbQqLWI/profile http://localhost:57431/getInfo.html) 10:07:27 INFO - PID 7956 | __metrics Screen width/height:1600/1200 10:07:27 INFO - PID 7956 | colorDepth:24 10:07:27 INFO - PID 7956 | Browser inner width/height: 1024/695 10:07:27 INFO - PID 7956 | __metrics 10:07:29 INFO - TEST-INFO | 7956: exit 0 10:07:29 INFO - Browser initialized. 10:07:29 INFO - Running cycle 1/1 for kraken test... 10:07:29 INFO - TEST-INFO | started process 8125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbQqLWI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:07:40 INFO - PID 8125 | RSS: Main: 158994432 10:07:40 INFO - PID 8125 | 10:07:43 INFO - PID 8125 | Cycle 1(1): loaded http://localhost:57431/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57431/tests/kraken/driver.html?testName=audio-beat-detection) 10:07:44 INFO - PID 8125 | RSS: Main: 163868672 10:07:44 INFO - PID 8125 | 10:07:47 INFO - PID 8125 | Cycle 1(1): loaded http://localhost:57431/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57431/tests/kraken/driver.html?testName=audio-dft) 10:07:47 INFO - PID 8125 | RSS: Main: 162103296 10:07:47 INFO - PID 8125 | 10:07:50 INFO - PID 8125 | Cycle 1(1): loaded http://localhost:57431/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57431/tests/kraken/driver.html?testName=audio-fft) 10:07:51 INFO - PID 8125 | RSS: Main: 158670848 10:07:51 INFO - PID 8125 | 10:07:53 INFO - PID 8125 | Cycle 1(1): loaded http://localhost:57431/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57431/tests/kraken/driver.html?testName=audio-oscillator) 10:07:54 INFO - PID 8125 | RSS: Main: 160116736 10:07:54 INFO - PID 8125 | 10:07:56 INFO - PID 8125 | Cycle 1(1): loaded http://localhost:57431/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57431/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:07:56 INFO - PID 8125 | RSS: Main: 160546816 10:07:56 INFO - PID 8125 | 10:08:00 INFO - PID 8125 | Cycle 1(1): loaded http://localhost:57431/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57431/tests/kraken/driver.html?testName=imaging-darkroom) 10:08:00 INFO - PID 8125 | RSS: Main: 164868096 10:08:00 INFO - PID 8125 | 10:08:04 INFO - PID 8125 | Cycle 1(1): loaded http://localhost:57431/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57431/tests/kraken/driver.html?testName=imaging-desaturate) 10:08:04 INFO - PID 8125 | RSS: Main: 163581952 10:08:04 INFO - PID 8125 | 10:08:07 INFO - PID 8125 | Cycle 1(1): loaded http://localhost:57431/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57431/tests/kraken/driver.html?testName=json-parse-financial) 10:08:08 INFO - PID 8125 | RSS: Main: 164388864 10:08:08 INFO - PID 8125 | 10:08:09 INFO - PID 8125 | Cycle 1(1): loaded http://localhost:57431/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57431/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:08:10 INFO - PID 8125 | RSS: Main: 164683776 10:08:10 INFO - PID 8125 | 10:08:12 INFO - PID 8125 | Cycle 1(1): loaded http://localhost:57431/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57431/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:08:13 INFO - PID 8125 | RSS: Main: 164728832 10:08:13 INFO - PID 8125 | 10:08:15 INFO - PID 8125 | Cycle 1(1): loaded http://localhost:57431/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57431/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:08:15 INFO - PID 8125 | RSS: Main: 164696064 10:08:15 INFO - PID 8125 | 10:08:18 INFO - PID 8125 | Cycle 1(1): loaded http://localhost:57431/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57431/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:08:19 INFO - PID 8125 | RSS: Main: 164892672 10:08:19 INFO - PID 8125 | 10:08:22 INFO - PID 8125 | Cycle 1(1): loaded http://localhost:57431/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57431/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:08:23 INFO - PID 8125 | RSS: Main: 164884480 10:08:23 INFO - PID 8125 | 10:08:24 INFO - PID 8125 | Cycle 1(1): loaded http://localhost:57431/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57431/tests/kraken/driver.html?testName=ai-astar) 10:08:25 INFO - PID 8125 | RSS: Main: 166047744 10:08:25 INFO - PID 8125 | 10:08:25 INFO - PID 8125 | __start_tp_report 10:08:25 INFO - PID 8125 | _x_x_mozilla_page_load 10:08:25 INFO - PID 8125 | _x_x_mozilla_page_load_details 10:08:25 INFO - PID 8125 | |i|pagename|runs| 10:08:25 INFO - PID 8125 | |0;ai-astar;104;113;111;111;111;111;119;111;111;111 10:08:25 INFO - PID 8125 | |1;audio-beat-detection;149;124;125;167;124;135;124;125;150;126 10:08:25 INFO - PID 8125 | |2;audio-dft;164;165;165;165;166;168;172;164;165;164 10:08:25 INFO - PID 8125 | |3;audio-fft;77;80;78;113;76;76;75;80;101;78 10:08:25 INFO - PID 8125 | |4;audio-oscillator;84;83;116;84;84;84;118;84;85;104 10:08:25 INFO - PID 8125 | |5;imaging-gaussian-blur;114;116;115;114;114;115;114;115;115;114 10:08:25 INFO - PID 8125 | |6;imaging-darkroom;150;150;149;152;150;151;151;151;151;151 10:08:25 INFO - PID 8125 | |7;imaging-desaturate;98;94;94;95;94;94;95;96;95;95 10:08:25 INFO - PID 8125 | |8;json-parse-financial;56;56;55;57;58;59;58;57;56;57 10:08:25 INFO - PID 8125 | |9;json-stringify-tinderbox;55;55;55;55;56;55;55;55;55;56 10:08:25 INFO - PID 8125 | |10;stanford-crypto-aes;82;82;80;83;81;80;82;82;80;81 10:08:25 INFO - PID 8125 | |11;stanford-crypto-ccm;133;147;131;135;149;132;136;139;174;134 10:08:25 INFO - PID 8125 | |12;stanford-crypto-pbkdf2;180;186;200;193;193;204;195;188;190;191 10:08:25 INFO - PID 8125 | |13;stanford-crypto-sha256-iterative;74;73;78;75;73;72;73;71;72;71 10:08:25 INFO - PID 8125 | __end_tp_report 10:08:25 INFO - PID 8125 | __start_cc_report 10:08:25 INFO - PID 8125 | _x_x_mozilla_cycle_collect,867 10:08:25 INFO - PID 8125 | __end_cc_report 10:08:25 INFO - PID 8125 | __startTimestamp1494781705200__endTimestamp 10:08:25 INFO - PID 8125 | 10:08:25 INFO - PID 8125 | ------- Summary: start ------- 10:08:25 INFO - PID 8125 | Number of tests: 14 10:08:25 INFO - PID 8125 | 10:08:25 INFO - PID 8125 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:3.59 (3.2%) stddev-sans-first:2.67 10:08:25 INFO - PID 8125 | Values: 104.0 113.0 111.0 111.0 111.0 111.0 119.0 111.0 111.0 111.0 10:08:25 INFO - PID 8125 | 10:08:25 INFO - PID 8125 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:130.50 stddev:15.23 (11.7%) stddev-sans-first:15.28 10:08:25 INFO - PID 8125 | Values: 149.0 124.0 125.0 167.0 124.0 135.0 124.0 125.0 150.0 126.0 10:08:25 INFO - PID 8125 | 10:08:25 INFO - PID 8125 | [#2] audio-dft Cycles:10 Average:165.80 Median:165.00 stddev:2.49 (1.5%) stddev-sans-first:2.55 10:08:25 INFO - PID 8125 | Values: 164.0 165.0 165.0 165.0 166.0 168.0 172.0 164.0 165.0 164.0 10:08:25 INFO - PID 8125 | 10:08:25 INFO - PID 8125 | [#3] audio-fft Cycles:10 Average:83.40 Median:77.50 stddev:12.86 (16.6%) stddev-sans-first:13.43 10:08:25 INFO - PID 8125 | Values: 77.0 80.0 78.0 113.0 76.0 76.0 75.0 80.0 101.0 78.0 10:08:25 INFO - PID 8125 | 10:08:25 INFO - PID 8125 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:84.00 stddev:14.31 (17.0%) stddev-sans-first:14.83 10:08:25 INFO - PID 8125 | Values: 84.0 83.0 116.0 84.0 84.0 84.0 118.0 84.0 85.0 104.0 10:08:25 INFO - PID 8125 | 10:08:25 INFO - PID 8125 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:115.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 10:08:25 INFO - PID 8125 | Values: 114.0 116.0 115.0 114.0 114.0 115.0 114.0 115.0 115.0 114.0 10:08:25 INFO - PID 8125 | 10:08:25 INFO - PID 8125 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.84 (0.6%) stddev-sans-first:0.87 10:08:25 INFO - PID 8125 | Values: 150.0 150.0 149.0 152.0 150.0 151.0 151.0 151.0 151.0 151.0 10:08:25 INFO - PID 8125 | 10:08:25 INFO - PID 8125 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:1.25 (1.3%) stddev-sans-first:0.71 10:08:25 INFO - PID 8125 | Values: 98.0 94.0 94.0 95.0 94.0 94.0 95.0 96.0 95.0 95.0 10:08:25 INFO - PID 8125 | 10:08:25 INFO - PID 8125 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.00 stddev:1.20 (2.1%) stddev-sans-first:1.22 10:08:25 INFO - PID 8125 | Values: 56.0 56.0 55.0 57.0 58.0 59.0 58.0 57.0 56.0 57.0 10:08:25 INFO - PID 8125 | 10:08:25 INFO - PID 8125 | [#9] json-stringify-tinderbox Cycles:10 Average:55.20 Median:55.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 10:08:25 INFO - PID 8125 | Values: 55.0 55.0 55.0 55.0 56.0 55.0 55.0 55.0 55.0 56.0 10:08:25 INFO - PID 8125 | 10:08:25 INFO - PID 8125 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:82.00 stddev:1.06 (1.3%) stddev-sans-first:1.09 10:08:25 INFO - PID 8125 | Values: 82.0 82.0 80.0 83.0 81.0 80.0 82.0 82.0 80.0 81.0 10:08:25 INFO - PID 8125 | 10:08:25 INFO - PID 8125 | [#11] stanford-crypto-ccm Cycles:10 Average:141.00 Median:137.50 stddev:13.11 (9.5%) stddev-sans-first:13.59 10:08:25 INFO - PID 8125 | Values: 133.0 147.0 131.0 135.0 149.0 132.0 136.0 139.0 174.0 134.0 10:08:25 INFO - PID 8125 | 10:08:25 INFO - PID 8125 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.00 Median:193.00 stddev:6.83 (3.5%) stddev-sans-first:5.70 10:08:25 INFO - PID 8125 | Values: 180.0 186.0 200.0 193.0 193.0 204.0 195.0 188.0 190.0 191.0 10:08:25 INFO - PID 8125 | 10:08:25 INFO - PID 8125 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:73.00 stddev:2.10 (2.9%) stddev-sans-first:2.20 10:08:25 INFO - PID 8125 | Values: 74.0 73.0 78.0 75.0 73.0 72.0 73.0 71.0 72.0 71.0 10:08:25 INFO - PID 8125 | -------- Summary: end -------- 10:08:25 INFO - PID 8125 | 10:08:26 INFO - TEST-INFO | 8125: exit 0 10:08:26 INFO - TEST-OK | kraken | took 62973ms 10:08:26 INFO - SUITE-END | took 1182s 10:08:26 INFO - Completed test suite (00:19:42) 10:08:26 INFO - javascript benchmark 10:08:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6716.802433408453, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2703.52688279551, 2759.8758055887483, 2764.7097054809246, 2788.5120103981803, 2800.5799130130476, 5237.607179461536, 5266.34170728659, 5327.813526526573, 5332.946670533303, 5339.786408543659, 5307.442718514559, 5353.143497040474, 5368.275282836816, 5427.891442171154, 5451.836444906649, 4460.219461594208, 4683.344331793552, 4705.176594096037, 4780.11567859947, 4824.686395384307, 4798.83204087857, 4837.080954618629, 4848.733319667434, 4854.927176092361, 4855.271709243606, 4696.506866778973, 4732.810687572493, 4750.477447480775, 4761.119192949315, 4787.593054590364, 4740.312654665088, 4748.905021899577, 4771.761411929424, 4802.015586804697, 4827.9034419311765, 4684.180268453007, 4711.411073615798, 4720.740359280238, 4737.0, 4767.547083027107, 5216.973915130438, 5294.92057619136, 5377.4084850666395, 5378.46215378463, 5416.620836541444, 5800.042992906166, 5845.2401187845735, 5876.647401155944, 5880.4119588041285, 5901.055831067051, 5842.474177324061, 5858.384869588717, 5862.97068514659, 5872.853178670567, 5875.236219291507, 5290.232916227125, 5393.865153371119, 5398.78404863801, 5421.701806400686, 5424.75588598518, 5875.941240587625, 5953.732082056318, 5969.641821490724, 5971.223740913653, 5977.252843394575, 5681.715914204273, 5707.229524014205, 5731.111677689964, 5737.913931291034, 5782.277215348082, 5812.82561523155, 5813.476787089182, 5819.418058194146, 5821.912671309934, 5826.329972053268, 5764.971175144097, 5771.5671324649975, 5784.566157538202, 5789.189513468118, 5795.855103622359, 5633.26767520228, 5711.428857114255, 5714.685692286964, 5715.799947001919, 5719.084946408555, 4784.330193772875, 4786.138495070921, 4799.136155492045, 4804.591609713144, 4810.086083644096, 4146.419501269825, 4154.982029402755, 4175.206710724952, 4182.874513764592, 4183.874483765492, 4919.188333924933, 4922.778474968635, 4930.630202734809, 4933.358663373739, 4933.777979990909, 5804.65172089676, 5805.216295800097, 5805.709714514342, 5806.0, 5810.983077961424, 4838.903221935541, 4927.7536123193695, 4958.950410495849, 4992.625553083533, 4999.825006124768, 5153.742312884416, 5181.740912954413, 5203.375594928557, 5218.7912483500995, 5228.869278268074, 5408.486193811582, 5408.918866217088, 5420.945790542123, 5421.051316019681, 5421.566274698093, 5744.827655170351, 5772.307323121252, 5821.185034095315, 5831.970840145942, 5833.533317334518, 5356.1697936819855, 5365.839024829262, 5394.838154855361, 5395.973020134874, 5423.0, 5742.339630942328, 5746.195532625519, 5750.913736293875, 5754.251947246831, 5755.856103597276, 5705.686187259575, 5798.275215598051, 5838.970805145947, 5859.44335288147, 5874.735636896265, 5589.105743081088, 5650.943490565041, 5661.433856614306, 5700.116481945305, 5701.771929122789, 5618.775248989995, 5653.3216014076925, 5653.491185793298, 5668.574856885833, 5670.461306175906, 5373.9731301343245, 5501.807436739695, 5565.7217139143695, 5567.8886422272135, 5600.411956744483, 5509.889802204014, 5604.299462567179, 5608.298962629671, 5631.155326701028, 5657.717114144359, 5463.508284254436, 5464.0, 5469.878674871721, 5480.561555075664, 5512.7519261634125], "value": 5243.207434378552, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.1106633307863, 742.543335848453, 1032.53535908841, 1048.072455876549, 1163.8196079607665, 32632.67367326329, 33560.832195838986, 33628.15929601761, 33634.0, 33638.32723345535, 30652.386952260997, 30980.225494362654, 31017.06948791534, 31039.68960310402, 31062.37875242494, 6269.404406581368, 6275.215598050244, 6957.304269573053, 6970.581765094111, 6992.580445173306, 6936.410405115571, 7017.473689473284, 7026.4730145239055, 7029.89455158173, 7031.156261248658, 6946.0, 6958.269381714923, 6986.0, 6988.860222795541, 7000.0, 6971.511994160411, 6993.860122797541, 7014.964925175393, 7022.508424410294, 7027.718891244344, 6841.247462779091, 6907.758228461979, 6922.203946546111, 6937.7224911003495, 6942.965285173593, 30875.22811929697, 31179.220519486968, 31192.844035779905, 31236.531452028237, 31268.530972035438, 2984.910452686423, 3011.26224075103, 3033.8179709217297, 3042.0113463124353, 3044.360684256309, 24423.511529769305, 24434.511309773705, 24442.26673199807, 24528.386790330205, 24590.877045614656, 3113.470709979309, 3120.4851199552045, 3136.8745250190195, 3138.7489000879873, 3150.401423729484, 142355.0, 142418.0, 142881.2855935724, 143056.13887722293, 143086.41481511144, 33239.33521329608, 33540.83229583885, 38823.41764873529, 39598.208035839125, 39814.2037159261, 40677.0, 40853.38719919204, 40881.386779198336, 40989.79505102456, 41039.794801025804, 10976.396298203676, 11152.498137583665, 11211.887881121085, 11215.551377944954, 11219.495122719498, 8650.783730406665, 8671.696490622799, 8676.175763302475, 8698.34762392823, 8794.956025219833, 12347.69130771738, 12386.380680965916, 12502.124851260325, 12565.0, 12695.365231738377, 5065.8733531662, 5167.814070602823, 5207.583393328525, 5246.816361427408, 5304.92042619361, 855.2217482091268, 880.5421180985851, 886.6409104312635, 886.6542048601051, 915.5468043318467, 20608.48478788042, 24099.277021689377, 25732.871335643576, 26137.477250454886, 26152.8692356537, 926.3145272498302, 937.2782957122977, 942.1991307388802, 950.6387572722459, 957.7701351675687, 10613.73465663349, 11131.387773672364, 11133.777324453466, 11151.944240278746, 11222.326660400402, 172959.0, 173114.0, 173241.0, 174913.0, 175752.0, 40267.0, 40461.1907761849, 40569.391459128135, 40652.18695626071, 40659.59340406558, 1183.4556104191995, 1207.4001947419529, 1210.5036934856666, 1211.1340391620033, 1218.1959906461693, 19037.809621903605, 19422.611547768684, 20164.29424970119, 20174.59650807005, 20405.387838364873, 30101.548476772427, 30113.3977320448, 30392.088237352913, 30422.847885760428, 30467.542986854773, 154248.0, 156005.3792200102, 156068.0, 156238.21880890522, 156403.0, 28688.282792930342, 28917.132486025454, 29025.7097429023, 29989.0, 30032.0, 36031.81984090063, 36813.0, 36880.81559592185, 37135.44296835495, 37872.24255514929, 27324.0, 28009.85995070093, 28346.2913427166, 28362.2909427266, 28538.714612853604, 27474.450510989267, 27815.860920695268, 27970.860145699142, 28076.0, 29251.414971700873, 30819.845900770353, 30990.69009309968, 31026.84486577643, 31237.531437028007, 31248.843755781076, 26710.465790683687, 26775.464490709688, 27304.0, 27374.0, 28579.142625721262, 21425.357239282846, 22394.88802555977, 22661.0, 22663.660045099667, 22820.087196511955], "value": 14353.825758037872, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.8658709607939, 417.8349551926987, 429.8388104460828, 436.82526989204314, 443.23320655266366, 16751.0, 16881.66236675266, 16987.541347277536, 17340.47978560645, 17553.297868085276, 17773.28906843728, 17968.820311796877, 19046.428607141806, 19464.513387165327, 19619.0, 5457.5633949284065, 5499.065158922993, 5510.393856675782, 5532.502074813266, 5559.499645031946, 5409.377921539014, 5561.5272701820395, 5587.497125258726, 5587.8603034924045, 5605.383407825136, 5305.363356397218, 5489.533389661883, 5506.614536982413, 5507.531859791922, 5546.334439867222, 5488.91766623501, 5588.329400471929, 5593.972030139864, 5616.719164041802, 5632.690202038886, 5004.699718016931, 5020.397552293712, 5034.798608055673, 5046.142155833517, 5071.873203169914, 21795.455113622127, 22198.667019994715, 22594.54810903773, 22719.091236350527, 22879.885600572055, 1622.6349071458944, 1670.0, 1673.2303140555236, 1676.1451659653542, 1676.1870492810976, 14524.0, 14735.189564573944, 14934.0, 15225.847741522553, 15233.771493427608, 1805.1064722962217, 1891.1206289075647, 1896.4500294914458, 1927.5277556998485, 1933.8452923766065, 78144.21855781483, 85814.57092714559, 87794.0, 91738.54130729371, 101534.0, 11128.610498632508, 11503.424828758529, 11530.192886498033, 11564.537418503165, 11643.476043578059, 15754.133522656135, 15755.527334179764, 15774.921125394529, 15777.211139442981, 15826.129562873923, 7120.786376408716, 7259.128904531384, 7324.597147156957, 7452.503411357147, 7457.179710231871, 5896.380880007623, 5918.526517878559, 6143.201383820075, 6442.838929026718, 6580.934190658128, 7021.1574611047, 7093.6453177341955, 7167.283271672895, 7267.800812865924, 7336.0, 2123.4054464749893, 2150.182930486405, 2153.6984822124914, 2164.4480657432255, 2310.595645761985, 845.399766166029, 874.1258741258741, 882.5013867165031, 892.7324595527417, 908.0692290402391, 16945.915270423815, 17223.741643875353, 18018.0, 18049.7292540612, 18238.08809559517, 864.2006144316482, 867.3668222197831, 882.8940527136784, 889.0842432294746, 900.1763386501409, 9252.629894804268, 9510.714678559654, 9744.220462362993, 9813.558389872473, 9940.25448091396, 343469.0, 347057.0, 348067.0, 348133.0, 355904.0, 62095.0, 71802.64098679474, 72102.27897720956, 73181.0, 76551.0, 1079.5304042741432, 1115.5203262597, 1143.7998350288833, 1143.9199256052163, 1149.143887803575, 16964.321427142775, 17736.55658608545, 17786.733199001766, 18873.245070197037, 19219.615607688047, 37026.25947481089, 38149.61850381461, 38575.0, 38699.6130038696, 39474.80262598669, 45096.0, 45520.54479455163, 46276.53723462857, 46438.0, 47313.0, 8392.20274073962, 8473.364497662576, 8600.39797214189, 8650.826983460422, 8662.566871656267, 12715.173513721578, 12960.416781244678, 13005.674858128623, 13408.32958352098, 13491.865081349453, 10403.427811470441, 10559.524821382902, 11092.724336701383, 11267.26762760418, 11371.0, 10353.585856565653, 10688.946555267174, 10697.358158510515, 10733.087687546646, 10839.67480975572, 9623.23109686907, 9766.267529935141, 10048.84926726085, 11444.656660300205, 11512.251703639571, 8543.444676096035, 8597.52713600758, 8605.0, 8634.438761480484, 8718.607662655322, 11158.721031974266, 11253.549858005588, 11369.772604548029, 11603.419829008348, 11811.881881181078], "value": 8855.982708850894, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1242.6955395927998, 1277.4315429633812, 1292.1019891175636, 1297.7404519096178, 1298.5065675043486, 9302.488363140024, 9584.712458626234, 9598.328117031811, 10040.648577299797, 10477.528511216995, 10020.098191162793, 10122.493875306242, 10176.898231017687, 10212.795744085113, 10229.181665466764, 2198.38445235334, 2214.745304290011, 2230.6765518999737, 2236.206146817881, 2237.9328620141423, 2063.998960504154, 2118.491562025118, 2132.6694362373855, 2134.6157691615504, 2135.711678923341, 2185.7704940981207, 2214.258223495131, 2225.8219342452567, 2248.4491299631613, 2253.7070180876544, 2073.9792602073935, 2115.5345823918715, 2119.6290649136417, 2122.490602255463, 2122.9893850530725, 1886.7264246684292, 2115.6509175985943, 2120.7879212078824, 2127.8829664368454, 2131.5630295789483, 10218.182545396425, 10261.640842570549, 10288.691339259834, 10308.948455257676, 10313.123384512326, 5502.422245664187, 5701.401352857932, 5716.3426205986425, 5721.656700597978, 5736.2256095427, 3305.413401567237, 3380.847861846198, 3440.690337869579, 3490.5636795400574, 3578.8568457261676, 1029.794041191757, 1041.661465017449, 1078.3152698036724, 1085.0722632149557, 1088.2871719024051, 14835.332410041574, 14902.254887255702, 14912.328945197383, 14923.925380373028, 14934.0, 4487.41663583732, 4687.296905464208, 4787.257975013878, 4857.101436234308, 4866.221404575322, 10574.15406767472, 10585.84121238182, 10594.470276486145, 10624.468776561296, 10676.83984740214, 5323.22813192085, 5368.516833484927, 5382.381026181961, 5405.810796622178, 5409.053415652245, 4740.099381117577, 4955.950440495621, 4986.476419975923, 4997.000599880039, 5133.6919784813035, 3779.7543159694533, 3889.124946886984, 3901.3562762144497, 3908.394198899175, 3998.280309544252, 1137.766757814646, 1139.8176291793438, 1139.8746137924823, 1153.901918336934, 1161.4018780328138, 664.9501287403464, 690.9412699920463, 692.1693967239333, 710.3358359933479, 712.383788023356, 5115.948840511622, 5185.351831021122, 5206.557442617344, 5401.108817045222, 5408.242846001563, 514.5574805667123, 526.3026489900897, 526.5761062344773, 529.5366554265019, 531.0626743797201, 3131.264152924061, 3180.0936733030976, 3191.7446604271604, 3215.6141263048585, 3711.0, 12399.25604463735, 13188.27464489443, 13407.262600556867, 13508.594742157751, 13577.456901724017, 12970.80543791844, 13267.0, 13303.0, 13313.467461301632, 13492.797608035888, 7553.244675532513, 7594.848103037908, 7680.270374314431, 7688.231176882379, 7694.345980591713, 5530.253415788817, 5621.494065534122, 5660.094384898396, 5713.942860571341, 5799.623024503394, 11914.463849126983, 11920.344381058778, 11984.46069926838, 12105.69735756613, 12196.085293603193, 11755.764884702086, 12077.75844483123, 12161.0, 12342.568010119603, 12365.814512782496, 7867.724629637935, 8014.799630009296, 8072.192780721881, 8095.595220239083, 8115.878261825959, 9513.238940884574, 9983.650572229937, 9993.400395976265, 10077.395356278646, 10089.545970431494, 8281.875771863548, 8497.702580409656, 8643.783905402415, 8881.0, 8972.865407019031, 8165.469244499089, 8328.250457458858, 8415.915840841513, 8667.17661822126, 8787.077356877437, 7104.715811367488, 7188.101487314086, 7192.784216473514, 7246.130464344102, 7252.020977168015, 5130.256112863689, 5153.6907785532985, 5156.504613661996, 5178.8964220716125, 5457.69982650958, 5249.396319423316, 5337.492938170868, 5407.161889907071, 5423.240746295601, 5463.180522921434], "value": 4631.726372636252, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.0982357078369, 381.51928570001826, 382.2736800079848, 382.5982718145946, 387.63368616657255, 5440.863978400542, 5471.972640136803, 5550.972245138773, 5576.721163941807, 5657.151427285909, 5372.973135134329, 5500.862478438041, 5508.64193827401, 5527.778888844441, 5532.502074813266, 4138.606832350937, 4254.404383386328, 4373.781310934456, 4377.912441751163, 4382.583654552828, 4364.650827933758, 4376.912461750779, 4387.517373088957, 4392.428984232045, 4398.582134697199, 4316.848700448674, 4352.956470435302, 4364.25807612705, 4372.234858899696, 4383.4739831220295, 4300.935485967681, 4301.913961720779, 4321.092570560186, 4342.131573685244, 4353.804078816445, 3914.3149948758855, 3917.1186483041374, 3932.2135572885536, 3945.5659877413464, 3958.0896393829294, 5454.372747134091, 5464.972675136599, 5473.452654734495, 5482.396936337, 5488.259085023511, 5014.0, 5150.27896094547, 5179.223116532513, 5186.092433824066, 5237.79048838046, 5888.705564721789, 5916.171735956969, 5916.3787802281, 5920.585559010871, 5957.1957785698805, 4399.538048504893, 4406.0, 4428.070105277896, 4438.778061096932, 4455.509893911667, 6100.23747031621, 6273.309935907047, 6298.716557754912, 6299.96850015747, 6320.873582528369, 4538.751843243069, 4554.772261386984, 4554.908901821945, 4559.110973360229, 4563.680542362069, 4581.83163293358, 4646.838290427393, 4654.532373381785, 4659.906801863944, 4678.111158879802, 5106.770195341219, 5123.103456895028, 5124.846254612367, 5153.804641122528, 5166.715830629351, 5901.468867801918, 5904.586678932519, 5924.851878703067, 5929.132323318141, 5931.6441013539325, 1548.8528589783953, 1573.5515378117182, 1605.5825485373887, 1638.2873450049028, 1638.860696840758, 1141.4635121492886, 1158.5134243617701, 1167.2646232873235, 1167.6613782003294, 1169.5263418315596, 5052.141136006814, 5071.3153724247495, 5080.949190508121, 5083.87290317745, 5093.439721630618, 6051.364606716319, 6064.332923378425, 6065.423784740443, 6067.2112625359305, 6094.628708540543, 4916.918277978839, 5083.008813281374, 5100.132977393852, 5103.948960510422, 5149.871253218699, 3218.9839050804594, 3227.370662720794, 3248.9928122282167, 3250.593675790526, 3258.185453636591, 5462.918056229159, 5606.187102870143, 5616.1014237721765, 5620.915686264628, 5629.7185140742795, 6115.755369785159, 6219.0, 6285.842853928597, 6300.464460520815, 6319.8104056878365, 5624.353199382042, 5629.155626656035, 5636.718164091861, 5641.689707066151, 5645.0, 6046.3046749624355, 6126.479249263863, 6130.7241174146375, 6142.262928448615, 6161.630302181883, 5962.403759624003, 5976.7908123215475, 6028.698565071817, 6053.636781793107, 6060.757569697163, 5576.107822748503, 5640.435956404327, 5645.548356131581, 5658.490735833795, 5674.233978412862, 4022.0950286185375, 4051.47330846988, 4068.5385341867745, 4088.6933479988525, 4128.47246518778, 6112.358202388685, 6129.264488261437, 6149.877002460015, 6165.352637972948, 6179.70226252492, 5922.792702255572, 5935.495482884004, 5942.257217847769, 5949.25634295713, 5954.612950158225, 5730.312362516358, 5834.562407819515, 5878.2064421302575, 5878.3239927408895, 5903.881922361615, 5762.884742305214, 5779.537636988946, 5795.1017592273265, 5801.709914504342, 5821.417858214145, 5776.774865474811, 5905.557083218861, 5915.053591425351, 5934.881302374015, 5936.942474625657, 5753.417810102255, 5768.625039372428, 5780.0, 5782.335031471434, 5784.537237021113], "value": 4496.69711467414, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.2446544430182, 722.1190148019415, 722.238038868993, 722.2452537098732, 742.3578604507103, 12250.142490025703, 12772.872271277285, 13090.21458712478, 14356.712865742691, 14380.0, 15196.164210968393, 15300.617484562892, 15747.527574172764, 15765.132917689523, 15862.286197121128, 817.6198067898426, 823.6334831000207, 826.9627866745981, 830.2320353672859, 830.8546004449228, 877.1754550722333, 883.2580632268892, 883.5891310540597, 883.9911600884005, 885.3359980014989, 903.4714691905243, 912.0514664748687, 913.4336711239041, 916.3081873185736, 916.5646317998963, 907.8320510705507, 912.115248209236, 913.5934509143434, 915.199200699388, 917.4266083697689, 673.1148539670367, 676.7800464848943, 677.6002158726375, 677.6239187251074, 679.4496457869142, 13825.585232443043, 14092.577222683336, 14411.351489183013, 14516.419343226258, 14635.121892686473, 15381.230938453033, 15440.768388474182, 15563.455279065292, 15608.29762660683, 15717.921410392875, 11697.590584329508, 11884.10869184806, 11991.760164796655, 12006.099542534257, 12144.757104857941, 2937.251000994754, 2962.126172779014, 2981.5378616314506, 2998.895038673636, 3002.054352878836, 68389.3161068393, 68709.9999999995, 68836.6558167206, 69536.0, 70615.29384706139, 11781.76436471283, 11966.521339146511, 12136.817947730791, 12233.082518810947, 12273.140880138482, 21604.45988850291, 21944.231951881608, 23056.88471557665, 23305.766942330698, 23307.7669223309, 5936.465718085393, 6034.0, 6104.236970378703, 6113.449789518964, 6119.0, 2874.1664917174203, 2969.0647446054422, 3001.354708737588, 3004.128802647208, 3007.5338322560037, 3456.4815277708544, 3521.9471707924404, 3525.982370088133, 3568.6431356864105, 3590.6588874056924, 738.3059923671732, 764.81262090787, 769.6190385759085, 773.1302284929454, 774.013133255093, 548.0901703172714, 550.9779608815602, 568.6360729133276, 580.4108829538022, 601.0863487498978, 10652.520636571373, 10719.0, 11391.943040284745, 11644.94177529124, 11805.822912656316, 492.5173330136486, 494.18952917215796, 497.6516438492997, 568.2896379525592, 568.5394830187562, 4199.853005144805, 4391.341298805205, 4395.274779661384, 4549.727016378962, 4552.11233809404, 56441.0, 57587.0, 58928.0, 62253.37746622566, 62255.0, 53827.0, 53857.0, 54239.45760542423, 54919.0, 55170.72414637901, 48096.7595162022, 49409.0118197634, 49477.0, 50439.243411348856, 50584.747076264386, 8311.501309921425, 8588.871166932626, 8638.740837774876, 8693.174148455886, 8842.911570884466, 25000.0, 25226.0, 25538.616920745833, 25793.613095803954, 25955.480890382463, 30560.235994100327, 30851.0, 31000.379992400478, 31530.527042094847, 31884.0, 11015.724606884893, 11433.59982400612, 11446.427678616203, 11495.942520287344, 11574.305541667527, 13736.519221827188, 13947.651308716957, 14079.366428510946, 15166.696666066837, 15261.931664783358, 12704.30126343023, 13047.804282935575, 13589.320533973065, 13717.794233086712, 13903.513377031755, 13617.795733063815, 13683.24742139192, 13936.372863221382, 14091.718165636836, 14260.50088246948, 13024.934875325564, 13057.0, 13061.477540898637, 13290.0, 13330.266835323762, 9492.145706886413, 9520.714378568655, 9980.301378903407, 10120.59517619287, 10159.0, 11120.221584489009, 11734.706632333919, 11789.587364442203, 11929.940350298193, 12012.819807703067], "value": 6614.656150693748, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 111.0, 111.0, 111.0, 111.0, 119.0, 111.0, 111.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 124.0, 125.0, 167.0, 124.0, 135.0, 124.0, 125.0, 150.0, 126.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 165.0, 165.0, 166.0, 168.0, 172.0, 164.0, 165.0, 164.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 78.0, 113.0, 76.0, 76.0, 75.0, 80.0, 101.0, 78.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 116.0, 84.0, 84.0, 84.0, 118.0, 84.0, 85.0, 104.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 115.0, 114.0, 114.0, 115.0, 114.0, 115.0, 115.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 149.0, 152.0, 150.0, 151.0, 151.0, 151.0, 151.0, 151.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 96.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 57.0, 58.0, 59.0, 58.0, 57.0, 56.0, 57.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 55.0, 55.0, 55.0, 56.0], "value": 55.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 80.0, 83.0, 81.0, 80.0, 82.0, 82.0, 80.0, 81.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 147.0, 131.0, 135.0, 149.0, 132.0, 136.0, 139.0, 174.0, 134.0], "value": 141.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 186.0, 200.0, 193.0, 193.0, 204.0, 195.0, 188.0, 190.0, 191.0], "value": 192.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 78.0, 75.0, 73.0, 72.0, 73.0, 71.0, 72.0, 71.0], "value": 73.2, "unit": "score"}]}]} 10:08:26 INFO - Return code: 0 10:08:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:08:26 INFO - # TBPL SUCCESS # 10:08:26 INFO - Running post-action listener: _resource_record_post_action 10:08:26 INFO - [mozharness: 2017-05-14 17:08:26.984484Z] Finished run-tests step (success) 10:08:26 INFO - Running post-run listener: _resource_record_post_run 10:08:27 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 372011008; Read time: 248; Write time: 303420 10:08:27 INFO - TinderboxPrint: CPU usage
13.3% 10:08:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 248 10:08:27 INFO - TinderboxPrint: I/O write bytes / time
372,011,008 / 303,420 10:08:27 INFO - TinderboxPrint: CPU idle
8,298.6 (86.7%) 10:08:27 INFO - TinderboxPrint: CPU user
1,215.1 (12.7%) 10:08:27 INFO - TinderboxPrint: Swap in / out
0 / 0 10:08:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 30543872; Read time: 0; Write time: 6508 10:08:27 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 293031936; Read time: 0; Write time: 265560 10:08:27 INFO - Running post-run listener: _upload_blobber_files 10:08:27 INFO - Blob upload gear active. 10:08:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:08: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 10:08: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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:08: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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:08:28 INFO - (blobuploader) - INFO - Open directory for files ... 10:08:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:08:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:08:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:28 INFO - (blobuploader) - INFO - Done attempting. 10:08:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:08:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:08:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:29 INFO - (blobuploader) - INFO - Done attempting. 10:08:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:08:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:08:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:30 INFO - (blobuploader) - INFO - Done attempting. 10:08:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:08:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:08:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:34 INFO - (blobuploader) - INFO - Done attempting. 10:08:34 INFO - (blobuploader) - INFO - Iteration through files over. 10:08:34 INFO - Return code: 0 10:08:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:08:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:08:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2a1b3c05ed4be9e4a6eabb4dd6eadfb0d1936bf14bcbed50228a3c0619748e2b3010ceab22e666511aa0d50ad84bb040ba158ea40ea15dee9fb6106ed1564b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/49a02edd69637e4320a510b9e3f41ccabe2f1a1f00ca6eed714b56c7927b3bf4bf321ca2a9d0bf416347cdcb1a3e3c3d525c4d76d16f56a5afb64cf7dd83f5ef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ea9e678b406754c4dc9a7f5368f1dfef05ad857c849ecf983a70953a7c470264b80bf87db0f1917205988e03fae6b3cb93b46e0c79230e40c119d223a59f2d19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23e7ac911e19b0e93217ef6ccb3479208ad78dde925ffe7de62b79bd9a1ac5a4acff5e52fde753a2fe1e164e2478f7f590df8e060a2bb1f53bf777b767dd7b2c"} 10:08:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:08:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:08:34 INFO - Contents: 10:08:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2a1b3c05ed4be9e4a6eabb4dd6eadfb0d1936bf14bcbed50228a3c0619748e2b3010ceab22e666511aa0d50ad84bb040ba158ea40ea15dee9fb6106ed1564b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/49a02edd69637e4320a510b9e3f41ccabe2f1a1f00ca6eed714b56c7927b3bf4bf321ca2a9d0bf416347cdcb1a3e3c3d525c4d76d16f56a5afb64cf7dd83f5ef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ea9e678b406754c4dc9a7f5368f1dfef05ad857c849ecf983a70953a7c470264b80bf87db0f1917205988e03fae6b3cb93b46e0c79230e40c119d223a59f2d19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23e7ac911e19b0e93217ef6ccb3479208ad78dde925ffe7de62b79bd9a1ac5a4acff5e52fde753a2fe1e164e2478f7f590df8e060a2bb1f53bf777b767dd7b2c"} 10:08:34 INFO - Running post-run listener: copy_logs_to_upload_dir 10:08:34 INFO - Copying logs to upload dir... 10:08:34 INFO - mkdir: /builds/slave/test/build/upload/logs 10:08:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.950325 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-05-14 10:08:33.246852) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-14 10:08:33.253961) ========= 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=0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546 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-Non-PGO/sha512/b2a1b3c05ed4be9e4a6eabb4dd6eadfb0d1936bf14bcbed50228a3c0619748e2b3010ceab22e666511aa0d50ad84bb040ba158ea40ea15dee9fb6106ed1564b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/49a02edd69637e4320a510b9e3f41ccabe2f1a1f00ca6eed714b56c7927b3bf4bf321ca2a9d0bf416347cdcb1a3e3c3d525c4d76d16f56a5afb64cf7dd83f5ef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ea9e678b406754c4dc9a7f5368f1dfef05ad857c849ecf983a70953a7c470264b80bf87db0f1917205988e03fae6b3cb93b46e0c79230e40c119d223a59f2d19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23e7ac911e19b0e93217ef6ccb3479208ad78dde925ffe7de62b79bd9a1ac5a4acff5e52fde753a2fe1e164e2478f7f590df8e060a2bb1f53bf777b767dd7b2c"} build_url:https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011288 build_url: 'https://queue.taskcluster.net/v1/task/al5NQ0HdTNaEGRhH0IMFdA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2a1b3c05ed4be9e4a6eabb4dd6eadfb0d1936bf14bcbed50228a3c0619748e2b3010ceab22e666511aa0d50ad84bb040ba158ea40ea15dee9fb6106ed1564b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/49a02edd69637e4320a510b9e3f41ccabe2f1a1f00ca6eed714b56c7927b3bf4bf321ca2a9d0bf416347cdcb1a3e3c3d525c4d76d16f56a5afb64cf7dd83f5ef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ea9e678b406754c4dc9a7f5368f1dfef05ad857c849ecf983a70953a7c470264b80bf87db0f1917205988e03fae6b3cb93b46e0c79230e40c119d223a59f2d19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23e7ac911e19b0e93217ef6ccb3479208ad78dde925ffe7de62b79bd9a1ac5a4acff5e52fde753a2fe1e164e2478f7f590df8e060a2bb1f53bf777b767dd7b2c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-14 10:08:33.281607) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 10:08:33.281893) ========= 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=0333a256a5e4f052382dd180000001b1-1494759427.636029-99487546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-14 10:08:33.361087) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-14 10:08:33.361380) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-14 10:08:33.364666) ========= ========= Total master_lag: 0.21 =========