builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-077 starttime: 1494596421.5 results: success (0) revision: 030c0a7c878192d8dc1b04c182575c2f7858cdd0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 06:40:21.499048) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 06:40:21.499505) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 06:40:21.499827) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 06:40:21.518397) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:40:21.518711) ========= 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=20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-12 06:40:21-- 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% 46.8M=0s 2017-05-12 06:40:21 (46.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.166817 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:40:21.699120) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:40:21.699433) ========= 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=20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018945 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:40:21.751344) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-12 06:40:21.754710) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 030c0a7c878192d8dc1b04c182575c2f7858cdd0 --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 030c0a7c878192d8dc1b04c182575c2f7858cdd0 --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=20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-12 06:40:21,808 truncating revision to first 12 chars 2017-05-12 06:40:21,808 Setting DEBUG logging. 2017-05-12 06:40:21,808 attempt 1/10 2017-05-12 06:40:21,808 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/030c0a7c8781?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-12 06:40:22,581 unpacking tar archive at: mozilla-central-030c0a7c8781/testing/mozharness/ program finished with exit code 0 elapsedTime=1.078278 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-12 06:40:22.846029) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 06:40:22.846361) ========= script_repo_revision: 030c0a7c878192d8dc1b04c182575c2f7858cdd0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 06:40:22.849775) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 06:40:22.850046) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 06:40:22.861082) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-05-12 06:40:22.861399) ========= /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=20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:40:23 INFO - MultiFileLogger online at 20170512 06:40:23 in /builds/slave/test 06:40:23 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 06:40:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:40:23 INFO - {'append_to_log': False, 06:40:23 INFO - 'base_work_dir': '/builds/slave/test', 06:40:23 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:40:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:40:23 INFO - 'branch': 'Firefox-Non-PGO', 06:40:23 INFO - 'buildbot_json_path': 'buildprops.json', 06:40:23 INFO - 'config_files': ('talos/linux_config.py',), 06:40:23 INFO - 'default_actions': ('clobber', 06:40:23 INFO - 'read-buildbot-config', 06:40:23 INFO - 'download-and-extract', 06:40:23 INFO - 'populate-webroot', 06:40:23 INFO - 'create-virtualenv', 06:40:23 INFO - 'install', 06:40:23 INFO - 'run-tests'), 06:40:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:40:23 INFO - 'download_minidump_stackwalk': True, 06:40:23 INFO - 'download_symbols': 'ondemand', 06:40:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:40:23 INFO - 'tooltool.py': '/tools/tooltool.py', 06:40:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:40:23 INFO - '/tools/misc-python/virtualenv.py')}, 06:40:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:40:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:40:23 INFO - 'gecko_profile': False, 06:40:23 INFO - 'gecko_profile_interval': 0, 06:40:23 INFO - 'installer_path': 'installer.exe', 06:40:23 INFO - 'log_level': 'info', 06:40:23 INFO - 'log_name': 'talos', 06:40:23 INFO - 'log_to_console': True, 06:40:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:40:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:40:23 INFO - 'opt_config_files': (), 06:40:23 INFO - 'pip_index': False, 06:40:23 INFO - 'suite': 'dromaeojs-e10s', 06:40:23 INFO - 'system_bits': '32', 06:40:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:40:23 INFO - 'title': 'talos-linux64-ix-077', 06:40:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:40:23 INFO - 'use_talos_json': True, 06:40:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:40:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:40:23 INFO - 'work_dir': 'build'} 06:40:23 INFO - [mozharness: 2017-05-12 13:40:23.112371Z] Running clobber step. 06:40:23 INFO - Running pre-action listener: _resource_record_pre_action 06:40:23 INFO - Running main action method: clobber 06:40:23 INFO - rmtree: /builds/slave/test/build 06:40:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:40:24 INFO - Running post-action listener: _resource_record_post_action 06:40:24 INFO - [mozharness: 2017-05-12 13:40:24.032158Z] Finished clobber step (success) 06:40:24 INFO - [mozharness: 2017-05-12 13:40:24.032263Z] Running read-buildbot-config step. 06:40:24 INFO - Running pre-action listener: _resource_record_pre_action 06:40:24 INFO - Running main action method: read_buildbot_config 06:40:24 INFO - Using buildbot properties: 06:40:24 INFO - { 06:40:24 INFO - "project": "", 06:40:24 INFO - "product": "firefox", 06:40:24 INFO - "who": "cbook@mozilla.com", 06:40:24 INFO - "installer_path": "public/build/target.tar.bz2", 06:40:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:40:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:40:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 06:40:24 INFO - "stage_platform": "linux64", 06:40:24 INFO - "basedir": "/builds/slave/test", 06:40:24 INFO - "buildnumber": 827, 06:40:24 INFO - "platform": "ubuntu64_hw", 06:40:24 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:40:24 INFO - "slavebuilddir": "test", 06:40:24 INFO - "taskId": "QCrtIYRGQb6Fc62OqCvCfw", 06:40:24 INFO - "branch": "mozilla-central", 06:40:24 INFO - "script_repo_revision": "production", 06:40:24 INFO - "revision": "030c0a7c878192d8dc1b04c182575c2f7858cdd0", 06:40:24 INFO - "slavename": "talos-linux64-ix-077", 06:40:24 INFO - "repo_path": "mozilla-central" 06:40:24 INFO - } 06:40:24 INFO - Finding installer, test and symbols from parent task. 06:40:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QCrtIYRGQb6Fc62OqCvCfw'}, attempt #1 06:40:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QCrtIYRGQb6Fc62OqCvCfw'}, attempt #1 06:40:24 INFO - Task dependencies: A4OXc7j_SrifIR5xeHyHBQ 06:40:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ'}, attempt #1 06:40:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.tar.bz2 06:40:25 INFO - Set test_url: https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/test_packages.json 06:40:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.crashreporter-symbols.zip 06:40:25 INFO - Running post-action listener: _resource_record_post_action 06:40:25 INFO - [mozharness: 2017-05-12 13:40:25.421841Z] Finished read-buildbot-config step (success) 06:40:25 INFO - [mozharness: 2017-05-12 13:40:25.422061Z] Running download-and-extract step. 06:40:25 INFO - Running pre-action listener: _resource_record_pre_action 06:40:25 INFO - Running main action method: download_and_extract 06:40:25 INFO - mkdir: /builds/slave/test/build/tests 06:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:40:25 INFO - trying https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.test_packages.json 06:40:25 INFO - Downloading https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:40:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:40:26 INFO - Downloaded 986 bytes. 06:40:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:40:26 INFO - Using the following test package requirements: 06:40:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:40:26 INFO - u'common': [u'target.common.tests.zip'], 06:40:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:40:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:40:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:40:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:40:26 INFO - u'mozbase': [u'target.common.tests.zip'], 06:40:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:40:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:40:26 INFO - u'web-platform': [u'target.common.tests.zip', 06:40:26 INFO - u'target.web-platform.tests.zip'], 06:40:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:40:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:40:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.common.tests.zip 06:40:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:40:26 INFO - Fetch https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.common.tests.zip into memory 06:40:27 INFO - Content-Length response header: 62447477 06:40:27 INFO - Bytes received: 62447477 06:40:37 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:40:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.common.tests.zip 06:40:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:40:37 INFO - Fetch https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.common.tests.zip into memory 06:40:38 INFO - Content-Length response header: 62447477 06:40:38 INFO - Bytes received: 62447477 06:40:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.talos.tests.zip 06:40:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:40:50 INFO - Fetch https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.talos.tests.zip into memory 06:40:51 INFO - Content-Length response header: 14409411 06:40:51 INFO - Bytes received: 14409411 06:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:40:51 INFO - trying https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.tar.bz2 06:40:51 INFO - Downloading https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:40:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:40:52 INFO - Downloaded 63465738 bytes. 06:40:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.tar.bz2 06:40:52 INFO - mkdir: /builds/slave/test/properties 06:40:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:40:52 INFO - Writing to file /builds/slave/test/properties/build_url 06:40:52 INFO - Contents: 06:40:52 INFO - build_url:https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.tar.bz2 06:40:52 INFO - Running post-action listener: _resource_record_post_action 06:40:52 INFO - Running post-action listener: set_extra_try_arguments 06:40:52 INFO - [mozharness: 2017-05-12 13:40:52.995361Z] Finished download-and-extract step (success) 06:40:52 INFO - [mozharness: 2017-05-12 13:40:52.995458Z] Running populate-webroot step. 06:40:52 INFO - Running pre-action listener: _resource_record_pre_action 06:40:52 INFO - Running main action method: populate_webroot 06:40:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:40:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:40:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:40:53 INFO - '--tppagecycles', 06:40:53 INFO - '7'], 06:40:53 INFO - 'tests': ['tsvgm']}}, 06:40:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:40:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:40:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:40:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:40:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:40:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:40:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:40:53 INFO - 'talos_options': ['--disable-e10s'], 06:40:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:40:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:40:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:40:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:40:53 INFO - 'talos_options': ['--disable-e10s'], 06:40:53 INFO - 'tests': ['damp', 'tps']}, 06:40:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:40:53 INFO - 'tests': ['damp', 'tps']}, 06:40:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:40:53 INFO - 'tests': ['dromaeo_dom']}, 06:40:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:40:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:40:53 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:40:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:40:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:40:53 INFO - 'tests': ['a11yr', 06:40:53 INFO - 'ts_paint', 06:40:53 INFO - 'tpaint', 06:40:53 INFO - 'sessionrestore', 06:40:53 INFO - 'sessionrestore_no_auto_restore', 06:40:53 INFO - 'tabpaint']}, 06:40:53 INFO - 'other-e10s': {'tests': ['a11yr', 06:40:53 INFO - 'ts_paint', 06:40:53 INFO - 'tpaint', 06:40:53 INFO - 'sessionrestore', 06:40:53 INFO - 'sessionrestore_no_auto_restore', 06:40:53 INFO - 'tabpaint']}, 06:40:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:40:53 INFO - 'ts_paint', 06:40:53 INFO - 'tpaint', 06:40:53 INFO - 'sessionrestore', 06:40:53 INFO - 'sessionrestore_no_auto_restore', 06:40:53 INFO - 'tabpaint']}, 06:40:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:40:53 INFO - 'ts_paint', 06:40:53 INFO - 'tpaint', 06:40:53 INFO - 'sessionrestore', 06:40:53 INFO - 'sessionrestore_no_auto_restore', 06:40:53 INFO - 'tabpaint']}, 06:40:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:40:53 INFO - 'tests': ['a11yr', 06:40:53 INFO - 'ts_paint', 06:40:53 INFO - 'tpaint', 06:40:53 INFO - 'sessionrestore', 06:40:53 INFO - 'sessionrestore_no_auto_restore', 06:40:53 INFO - 'tabpaint']}, 06:40:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:40:53 INFO - 'tests': ['a11yr', 06:40:53 INFO - 'ts_paint', 06:40:53 INFO - 'tpaint', 06:40:53 INFO - 'sessionrestore', 06:40:53 INFO - 'sessionrestore_no_auto_restore', 06:40:53 INFO - 'tabpaint']}, 06:40:53 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 06:40:53 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 06:40:53 INFO - 'bloom_basic_ref']}, 06:40:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:40:53 INFO - 'tests': ['tsvgx', 06:40:53 INFO - 'tsvgr_opacity', 06:40:53 INFO - 'tart', 06:40:53 INFO - 'tscrollx', 06:40:53 INFO - 'cart', 06:40:53 INFO - 'tsvg_static']}, 06:40:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:40:53 INFO - 'tsvgr_opacity', 06:40:53 INFO - 'tart', 06:40:53 INFO - 'tscrollx', 06:40:53 INFO - 'cart', 06:40:53 INFO - 'tsvg_static']}, 06:40:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:40:53 INFO - 'talos_options': ['--disable-e10s'], 06:40:53 INFO - 'tests': ['tp5o']}, 06:40:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:40:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:40:53 INFO - 'talos_options': ['--disable-e10s', 06:40:53 INFO - '--xperf_path', 06:40:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:40:53 INFO - 'tests': ['tp5n']}, 06:40:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:40:53 INFO - 'talos_options': ['--xperf_path', 06:40:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:40:53 INFO - 'tests': ['tp5n']}}, 06:40:53 INFO - 'talos.zip': {'path': '', 06:40:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:40:53 INFO - Running post-action listener: _resource_record_post_action 06:40:53 INFO - [mozharness: 2017-05-12 13:40:53.009435Z] Finished populate-webroot step (success) 06:40:53 INFO - [mozharness: 2017-05-12 13:40:53.009526Z] Running create-virtualenv step. 06:40:53 INFO - Running pre-action listener: _resource_record_pre_action 06:40:53 INFO - Running main action method: create_virtualenv 06:40:53 INFO - Creating virtualenv /builds/slave/test/build/venv 06:40:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:40:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:40:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:40:54 INFO - Using real prefix '/usr' 06:40:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:40:55 INFO - Installing distribute.............................................................................................................................................................................................done. 06:40:57 INFO - Installing pip.................done. 06:40:57 INFO - Return code: 0 06:40:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:40:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:40:57 INFO - Reading from file tmpfile_stdout 06:40:57 INFO - Output received: 06:40:57 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:40:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:57 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 0x12f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1668a30>, '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 0x16697f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1669ca0>, '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': '20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:40:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:40:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:40:57 INFO - Using env: {'DISPLAY': ':0', 06:40:57 INFO - 'HOME': '/home/cltbld', 06:40:57 INFO - 'LANG': 'en_US.UTF-8', 06:40:57 INFO - 'LANGUAGE': 'en_US:en', 06:40:57 INFO - 'LOGNAME': 'cltbld', 06:40:57 INFO - 'MAIL': '/var/mail/cltbld', 06:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:57 INFO - 'MOZ_NO_REMOTE': '1', 06:40:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:57 INFO - 'NO_EM_RESTART': '1', 06:40:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:57 INFO - 'PWD': '/builds/slave/test', 06:40:57 INFO - 'SHELL': '/bin/bash', 06:40:57 INFO - 'SHLVL': '1', 06:40:57 INFO - 'TERM': 'linux', 06:40:57 INFO - 'TMOUT': '86400', 06:40:57 INFO - 'USER': 'cltbld', 06:40:57 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798', 06:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:57 INFO - '_': '/tools/buildbot/bin/python'} 06:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:40:57 INFO - Cleaning up... 06:40:57 INFO - Return code: 0 06:40:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:57 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 0x12f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1668a30>, '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 0x16697f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1669ca0>, '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': '20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:40:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:40:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:40:57 INFO - Using env: {'DISPLAY': ':0', 06:40:57 INFO - 'HOME': '/home/cltbld', 06:40:57 INFO - 'LANG': 'en_US.UTF-8', 06:40:57 INFO - 'LANGUAGE': 'en_US:en', 06:40:57 INFO - 'LOGNAME': 'cltbld', 06:40:57 INFO - 'MAIL': '/var/mail/cltbld', 06:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:57 INFO - 'MOZ_NO_REMOTE': '1', 06:40:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:57 INFO - 'NO_EM_RESTART': '1', 06:40:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:57 INFO - 'PWD': '/builds/slave/test', 06:40:57 INFO - 'SHELL': '/bin/bash', 06:40:57 INFO - 'SHLVL': '1', 06:40:57 INFO - 'TERM': 'linux', 06:40:57 INFO - 'TMOUT': '86400', 06:40:57 INFO - 'USER': 'cltbld', 06:40:57 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798', 06:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:57 INFO - '_': '/tools/buildbot/bin/python'} 06:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:57 INFO - Downloading/unpacking psutil>=3.1.1 06:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:40:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:40:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:40:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:40:59 INFO - Installing collected packages: psutil 06:40:59 INFO - Running setup.py install for psutil 06:40:59 INFO - building 'psutil._psutil_linux' extension 06:40:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:41:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:41:00 INFO - building 'psutil._psutil_posix' extension 06:41:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:41:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:41:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:41:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:41:00 INFO - Successfully installed psutil 06:41:00 INFO - Cleaning up... 06:41:00 INFO - Return code: 0 06:41:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:00 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 0x12f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1668a30>, '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 0x16697f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1669ca0>, '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': '20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:41:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:41:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:41:00 INFO - Using env: {'DISPLAY': ':0', 06:41:00 INFO - 'HOME': '/home/cltbld', 06:41:00 INFO - 'LANG': 'en_US.UTF-8', 06:41:00 INFO - 'LANGUAGE': 'en_US:en', 06:41:00 INFO - 'LOGNAME': 'cltbld', 06:41:00 INFO - 'MAIL': '/var/mail/cltbld', 06:41:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:00 INFO - 'MOZ_NO_REMOTE': '1', 06:41:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:00 INFO - 'NO_EM_RESTART': '1', 06:41:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:00 INFO - 'PWD': '/builds/slave/test', 06:41:00 INFO - 'SHELL': '/bin/bash', 06:41:00 INFO - 'SHLVL': '1', 06:41:00 INFO - 'TERM': 'linux', 06:41:00 INFO - 'TMOUT': '86400', 06:41:00 INFO - 'USER': 'cltbld', 06:41:00 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798', 06:41:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:00 INFO - '_': '/tools/buildbot/bin/python'} 06:41:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:41:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:41:01 INFO - Installing collected packages: mozsystemmonitor 06:41:01 INFO - Running setup.py install for mozsystemmonitor 06:41:01 INFO - Successfully installed mozsystemmonitor 06:41:01 INFO - Cleaning up... 06:41:01 INFO - Return code: 0 06:41:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:01 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 0x12f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1668a30>, '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 0x16697f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1669ca0>, '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': '20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:41:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:41:01 INFO - Using env: {'DISPLAY': ':0', 06:41:01 INFO - 'HOME': '/home/cltbld', 06:41:01 INFO - 'LANG': 'en_US.UTF-8', 06:41:01 INFO - 'LANGUAGE': 'en_US:en', 06:41:01 INFO - 'LOGNAME': 'cltbld', 06:41:01 INFO - 'MAIL': '/var/mail/cltbld', 06:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:01 INFO - 'MOZ_NO_REMOTE': '1', 06:41:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:01 INFO - 'NO_EM_RESTART': '1', 06:41:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:01 INFO - 'PWD': '/builds/slave/test', 06:41:01 INFO - 'SHELL': '/bin/bash', 06:41:01 INFO - 'SHLVL': '1', 06:41:01 INFO - 'TERM': 'linux', 06:41:01 INFO - 'TMOUT': '86400', 06:41:01 INFO - 'USER': 'cltbld', 06:41:01 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798', 06:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:01 INFO - '_': '/tools/buildbot/bin/python'} 06:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:02 INFO - Downloading/unpacking jsonschema==2.5.1 06:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:41:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:03 INFO - Downloading functools32-3.2.3-2.tar.gz 06:41:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:41:03 INFO - warning: no files found matching '*.txt' 06:41:03 INFO - no previously-included directories found matching 'build' 06:41:03 INFO - no previously-included directories found matching 'dist' 06:41:03 INFO - no previously-included directories found matching '.git*' 06:41:03 INFO - Installing collected packages: jsonschema, functools32 06:41:03 INFO - Running setup.py install for functools32 06:41:03 INFO - warning: no files found matching '*.txt' 06:41:03 INFO - no previously-included directories found matching 'build' 06:41:03 INFO - no previously-included directories found matching 'dist' 06:41:03 INFO - no previously-included directories found matching '.git*' 06:41:03 INFO - Successfully installed jsonschema functools32 06:41:03 INFO - Cleaning up... 06:41:03 INFO - Return code: 0 06:41:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:03 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 0x12f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1668a30>, '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 0x16697f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1669ca0>, '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': '20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:41:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:41:03 INFO - Using env: {'DISPLAY': ':0', 06:41:03 INFO - 'HOME': '/home/cltbld', 06:41:03 INFO - 'LANG': 'en_US.UTF-8', 06:41:03 INFO - 'LANGUAGE': 'en_US:en', 06:41:03 INFO - 'LOGNAME': 'cltbld', 06:41:03 INFO - 'MAIL': '/var/mail/cltbld', 06:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:03 INFO - 'MOZ_NO_REMOTE': '1', 06:41:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:03 INFO - 'NO_EM_RESTART': '1', 06:41:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:03 INFO - 'PWD': '/builds/slave/test', 06:41:03 INFO - 'SHELL': '/bin/bash', 06:41:03 INFO - 'SHLVL': '1', 06:41:03 INFO - 'TERM': 'linux', 06:41:03 INFO - 'TMOUT': '86400', 06:41:03 INFO - 'USER': 'cltbld', 06:41:03 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798', 06:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:03 INFO - '_': '/tools/buildbot/bin/python'} 06:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:41:03 INFO - Cleaning up... 06:41:03 INFO - Return code: 0 06:41:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:03 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 0x12f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1668a30>, '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 0x16697f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1669ca0>, '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': '20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:41:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:41:03 INFO - Using env: {'DISPLAY': ':0', 06:41:03 INFO - 'HOME': '/home/cltbld', 06:41:03 INFO - 'LANG': 'en_US.UTF-8', 06:41:03 INFO - 'LANGUAGE': 'en_US:en', 06:41:03 INFO - 'LOGNAME': 'cltbld', 06:41:03 INFO - 'MAIL': '/var/mail/cltbld', 06:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:03 INFO - 'MOZ_NO_REMOTE': '1', 06:41:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:03 INFO - 'NO_EM_RESTART': '1', 06:41:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:03 INFO - 'PWD': '/builds/slave/test', 06:41:03 INFO - 'SHELL': '/bin/bash', 06:41:03 INFO - 'SHLVL': '1', 06:41:03 INFO - 'TERM': 'linux', 06:41:03 INFO - 'TMOUT': '86400', 06:41:03 INFO - 'USER': 'cltbld', 06:41:03 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798', 06:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:03 INFO - '_': '/tools/buildbot/bin/python'} 06:41:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:04 INFO - Downloading/unpacking blobuploader==1.2.4 06:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:05 INFO - Downloading blobuploader-1.2.4.tar.gz 06:41:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:41:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:41:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:05 INFO - Downloading docopt-0.6.1.tar.gz 06:41:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:41:05 INFO - Installing collected packages: blobuploader, requests, docopt 06:41:05 INFO - Running setup.py install for blobuploader 06:41:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:41:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:41:05 INFO - Running setup.py install for requests 06:41:06 INFO - Running setup.py install for docopt 06:41:06 INFO - Successfully installed blobuploader requests docopt 06:41:06 INFO - Cleaning up... 06:41:06 INFO - Return code: 0 06:41:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:06 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 0x12f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1668a30>, '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 0x16697f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1669ca0>, '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': '20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:41:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:41:06 INFO - Using env: {'DISPLAY': ':0', 06:41:06 INFO - 'HOME': '/home/cltbld', 06:41:06 INFO - 'LANG': 'en_US.UTF-8', 06:41:06 INFO - 'LANGUAGE': 'en_US:en', 06:41:06 INFO - 'LOGNAME': 'cltbld', 06:41:06 INFO - 'MAIL': '/var/mail/cltbld', 06:41:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:06 INFO - 'MOZ_NO_REMOTE': '1', 06:41:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:06 INFO - 'NO_EM_RESTART': '1', 06:41:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:06 INFO - 'PWD': '/builds/slave/test', 06:41:06 INFO - 'SHELL': '/bin/bash', 06:41:06 INFO - 'SHLVL': '1', 06:41:06 INFO - 'TERM': 'linux', 06:41:06 INFO - 'TMOUT': '86400', 06:41:06 INFO - 'USER': 'cltbld', 06:41:06 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798', 06:41:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:06 INFO - '_': '/tools/buildbot/bin/python'} 06:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:41:06 INFO - Running setup.py (path:/tmp/pip-So3dTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:41:06 INFO - Running setup.py (path:/tmp/pip-UpdRiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:41:06 INFO - Running setup.py (path:/tmp/pip-RH1T2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:41:06 INFO - Running setup.py (path:/tmp/pip-MoWTbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:41:06 INFO - Running setup.py (path:/tmp/pip-GOnvWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:41:06 INFO - Running setup.py (path:/tmp/pip-YaTXYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:41:06 INFO - Running setup.py (path:/tmp/pip-2Dv95y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:41:07 INFO - Running setup.py (path:/tmp/pip-2ZSTew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:41:07 INFO - Running setup.py (path:/tmp/pip-Etp4wF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:41:07 INFO - Running setup.py (path:/tmp/pip-VFBQOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:41:07 INFO - Running setup.py (path:/tmp/pip-YBSzPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:41:07 INFO - Running setup.py (path:/tmp/pip-rbUKKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:41:07 INFO - Running setup.py (path:/tmp/pip-_hgqnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:41:07 INFO - Running setup.py (path:/tmp/pip-wxjN5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:07 INFO - Running setup.py (path:/tmp/pip-OP5mxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:41:07 INFO - Running setup.py (path:/tmp/pip-lxmpda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:41:07 INFO - Running setup.py (path:/tmp/pip-9_jKqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:41:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:41:07 INFO - Running setup.py install for manifestparser 06:41:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:41:07 INFO - Running setup.py install for mozcrash 06:41:07 INFO - Running setup.py install for mozdebug 06:41:08 INFO - Running setup.py install for mozdevice 06:41:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:41:08 INFO - Running setup.py install for mozfile 06:41:08 INFO - Running setup.py install for mozhttpd 06:41:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:41:08 INFO - Running setup.py install for mozinfo 06:41:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:41:08 INFO - Running setup.py install for mozInstall 06:41:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:41:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:41:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:41:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:41:08 INFO - Running setup.py install for mozleak 06:41:08 INFO - Running setup.py install for mozlog 06:41:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:41:08 INFO - Running setup.py install for moznetwork 06:41:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:41:08 INFO - Running setup.py install for mozprocess 06:41:09 INFO - Running setup.py install for mozprofile 06:41:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:41:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:41:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:41:09 INFO - Running setup.py install for mozrunner 06:41:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:41:09 INFO - Running setup.py install for mozscreenshot 06:41:09 INFO - Running setup.py install for moztest 06:41:09 INFO - Running setup.py install for mozversion 06:41:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:41:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:41:09 INFO - Cleaning up... 06:41:09 INFO - Return code: 0 06:41:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:09 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 0x12f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1668a30>, '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 0x16697f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1669ca0>, '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': '20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:41:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:41:09 INFO - Using env: {'DISPLAY': ':0', 06:41:09 INFO - 'HOME': '/home/cltbld', 06:41:09 INFO - 'LANG': 'en_US.UTF-8', 06:41:09 INFO - 'LANGUAGE': 'en_US:en', 06:41:09 INFO - 'LOGNAME': 'cltbld', 06:41:09 INFO - 'MAIL': '/var/mail/cltbld', 06:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:09 INFO - 'MOZ_NO_REMOTE': '1', 06:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:09 INFO - 'NO_EM_RESTART': '1', 06:41:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:09 INFO - 'PWD': '/builds/slave/test', 06:41:09 INFO - 'SHELL': '/bin/bash', 06:41:09 INFO - 'SHLVL': '1', 06:41:09 INFO - 'TERM': 'linux', 06:41:09 INFO - 'TMOUT': '86400', 06:41:09 INFO - 'USER': 'cltbld', 06:41:09 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798', 06:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:09 INFO - '_': '/tools/buildbot/bin/python'} 06:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:41:09 INFO - Running setup.py (path:/tmp/pip-ADlDIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:41:09 INFO - Running setup.py (path:/tmp/pip-z68E00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:41:09 INFO - Running setup.py (path:/tmp/pip-eYkooH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:41:10 INFO - Running setup.py (path:/tmp/pip-BTimBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:41:10 INFO - Running setup.py (path:/tmp/pip-IgY4Tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:41:10 INFO - Running setup.py (path:/tmp/pip-YypSD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:41:10 INFO - Running setup.py (path:/tmp/pip-X2ilng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:41:10 INFO - Running setup.py (path:/tmp/pip-s_4XwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:41:10 INFO - Running setup.py (path:/tmp/pip-UqyZ3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:41:10 INFO - Running setup.py (path:/tmp/pip-DsgaN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:41:10 INFO - Running setup.py (path:/tmp/pip-CAORJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:41:10 INFO - Running setup.py (path:/tmp/pip-JoL0SX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:41:10 INFO - Running setup.py (path:/tmp/pip-PkFAXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:41:10 INFO - Running setup.py (path:/tmp/pip-pMUYvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:10 INFO - Running setup.py (path:/tmp/pip-U4ewl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:41:10 INFO - Running setup.py (path:/tmp/pip-VXP0C1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:41:10 INFO - Running setup.py (path:/tmp/pip-DGndWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:41:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:12 INFO - Downloading blessings-1.6.tar.gz 06:41:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:41:12 INFO - Installing collected packages: blessings 06:41:12 INFO - Running setup.py install for blessings 06:41:12 INFO - Successfully installed blessings 06:41:12 INFO - Cleaning up... 06:41:12 INFO - Return code: 0 06:41:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:41:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:41:12 INFO - Reading from file tmpfile_stdout 06:41:12 INFO - Current package versions: 06:41:12 INFO - argparse == 1.2.1 06:41:12 INFO - blessings == 1.6 06:41:12 INFO - blobuploader == 1.2.4 06:41:12 INFO - docopt == 0.6.1 06:41:12 INFO - functools32 == 3.2.3-2 06:41:12 INFO - jsonschema == 2.5.1 06:41:12 INFO - manifestparser == 1.1 06:41:12 INFO - mozInstall == 1.12 06:41:12 INFO - mozcrash == 1.0 06:41:12 INFO - mozdebug == 0.1 06:41:12 INFO - mozdevice == 0.50 06:41:12 INFO - mozfile == 1.2 06:41:12 INFO - mozhttpd == 0.7 06:41:12 INFO - mozinfo == 0.9 06:41:12 INFO - mozleak == 0.1 06:41:12 INFO - mozlog == 3.4 06:41:12 INFO - moznetwork == 0.27 06:41:12 INFO - mozprocess == 0.25 06:41:12 INFO - mozprofile == 0.28 06:41:12 INFO - mozrunner == 6.13 06:41:12 INFO - mozscreenshot == 0.1 06:41:12 INFO - mozsystemmonitor == 0.3 06:41:12 INFO - moztest == 0.8 06:41:12 INFO - mozversion == 1.4 06:41:12 INFO - psutil == 3.1.1 06:41:12 INFO - requests == 1.2.3 06:41:12 INFO - wsgiref == 0.1.2 06:41:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:41: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')]} 06:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41: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')]} 06:41:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:12 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 0x12f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1668a30>, '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 0x16697f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1669ca0>, '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': '20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:41:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:41:12 INFO - Using env: {'DISPLAY': ':0', 06:41:12 INFO - 'HOME': '/home/cltbld', 06:41:12 INFO - 'LANG': 'en_US.UTF-8', 06:41:12 INFO - 'LANGUAGE': 'en_US:en', 06:41:12 INFO - 'LOGNAME': 'cltbld', 06:41:12 INFO - 'MAIL': '/var/mail/cltbld', 06:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:12 INFO - 'MOZ_NO_REMOTE': '1', 06:41:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:12 INFO - 'NO_EM_RESTART': '1', 06:41:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:12 INFO - 'PWD': '/builds/slave/test', 06:41:12 INFO - 'SHELL': '/bin/bash', 06:41:12 INFO - 'SHLVL': '1', 06:41:12 INFO - 'TERM': 'linux', 06:41:12 INFO - 'TMOUT': '86400', 06:41:12 INFO - 'USER': 'cltbld', 06:41:12 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798', 06:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:12 INFO - '_': '/tools/buildbot/bin/python'} 06:41:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:41:12 INFO - Cleaning up... 06:41:12 INFO - Return code: 0 06:41:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:41: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')]} 06:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41: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')]} 06:41:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1668a30>, '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 0x16697f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1669ca0>, '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': '20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:41: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', 'jsonschema'] in /builds/slave/test/build 06:41: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 jsonschema 06:41:12 INFO - Using env: {'DISPLAY': ':0', 06:41:12 INFO - 'HOME': '/home/cltbld', 06:41:12 INFO - 'LANG': 'en_US.UTF-8', 06:41:12 INFO - 'LANGUAGE': 'en_US:en', 06:41:12 INFO - 'LOGNAME': 'cltbld', 06:41:12 INFO - 'MAIL': '/var/mail/cltbld', 06:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:12 INFO - 'MOZ_NO_REMOTE': '1', 06:41:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:12 INFO - 'NO_EM_RESTART': '1', 06:41:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:12 INFO - 'PWD': '/builds/slave/test', 06:41:12 INFO - 'SHELL': '/bin/bash', 06:41:12 INFO - 'SHLVL': '1', 06:41:12 INFO - 'TERM': 'linux', 06:41:12 INFO - 'TMOUT': '86400', 06:41:12 INFO - 'USER': 'cltbld', 06:41:12 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798', 06:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:12 INFO - '_': '/tools/buildbot/bin/python'} 06:41:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:41:13 INFO - Cleaning up... 06:41:13 INFO - Return code: 0 06:41:13 INFO - Running post-action listener: _resource_record_post_action 06:41:13 INFO - Running post-action listener: _start_resource_monitoring 06:41:13 INFO - Starting resource monitoring. 06:41:13 INFO - [mozharness: 2017-05-12 13:41:13.084050Z] Finished create-virtualenv step (success) 06:41:13 INFO - [mozharness: 2017-05-12 13:41:13.084985Z] Running install step. 06:41:13 INFO - Running pre-action listener: _resource_record_pre_action 06:41:13 INFO - Running main action method: install 06:41:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:41:13 INFO - Reading from file tmpfile_stdout 06:41:13 INFO - Detecting whether we're running mozinstall >=1.0... 06:41:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:41:13 INFO - Reading from file tmpfile_stdout 06:41:13 INFO - Output received: 06:41:13 INFO - Usage: mozinstall [options] installer 06:41:13 INFO - Options: 06:41:13 INFO - -h, --help show this help message and exit 06:41:13 INFO - -d DEST, --destination=DEST 06:41:13 INFO - Directory to install application into. [default: 06:41:13 INFO - "/builds/slave/test"] 06:41:13 INFO - --app=APP Application being installed. [default: firefox] 06:41:13 INFO - mkdir: /builds/slave/test/build/application 06:41:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:41:29 INFO - Reading from file tmpfile_stdout 06:41:29 INFO - Output received: 06:41:29 INFO - /builds/slave/test/build/application/firefox/firefox 06:41:29 INFO - Running post-action listener: _resource_record_post_action 06:41:29 INFO - [mozharness: 2017-05-12 13:41:29.323626Z] Finished install step (success) 06:41:29 INFO - [mozharness: 2017-05-12 13:41:29.323872Z] Running run-tests step. 06:41:29 INFO - Running pre-action listener: _resource_record_pre_action 06:41:29 INFO - Running main action method: run_tests 06:41:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:41:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:41:29 INFO - Python 2.7.3 06:41:29 INFO - Return code: 0 06:41:29 INFO - grabbing minidump binary from tooltool 06:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:29 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 0x1668a30>, '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 0x16697f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1669ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:41:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:41:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:41:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:41:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:41:29 INFO - Return code: 0 06:41:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:41:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:41:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:41:29 INFO - ENV: RUST_BACKTRACE is now 1 06:41:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:41:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:41:29 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/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-077', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:41:29 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/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-077 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:41:29 INFO - Using env: {'DISPLAY': ':0', 06:41:29 INFO - 'HOME': '/home/cltbld', 06:41:29 INFO - 'LANG': 'en_US.UTF-8', 06:41:29 INFO - 'LANGUAGE': 'en_US:en', 06:41:29 INFO - 'LOGNAME': 'cltbld', 06:41:29 INFO - 'MAIL': '/var/mail/cltbld', 06:41:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:41:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:41:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:29 INFO - 'MOZ_NO_REMOTE': '1', 06:41:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:41:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:29 INFO - 'NO_EM_RESTART': '1', 06:41:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:29 INFO - 'PWD': '/builds/slave/test', 06:41:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:41:29 INFO - 'RUST_BACKTRACE': '1', 06:41:29 INFO - 'SHELL': '/bin/bash', 06:41:29 INFO - 'SHLVL': '1', 06:41:29 INFO - 'TERM': 'linux', 06:41:29 INFO - 'TMOUT': '86400', 06:41:29 INFO - 'USER': 'cltbld', 06:41:29 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798', 06:41:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:29 INFO - '_': '/tools/buildbot/bin/python'} 06:41:29 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/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-077', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:41:29 INFO - mozversion application_buildid: 20170512123749 06:41:29 INFO - mozversion application_changeset: 030c0a7c878192d8dc1b04c182575c2f7858cdd0 06:41:29 INFO - mozversion application_display_name: Nightly 06:41:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:41:29 INFO - mozversion application_name: Firefox 06:41:29 INFO - mozversion application_remotingname: firefox 06:41:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:41:29 INFO - mozversion application_vendor: Mozilla 06:41:29 INFO - mozversion application_version: 55.0a1 06:41:29 INFO - mozversion platform_buildid: 20170512123749 06:41:29 INFO - mozversion platform_changeset: 030c0a7c878192d8dc1b04c182575c2f7858cdd0 06:41:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:41:29 INFO - mozversion platform_version: 55.0a1 06:41:29 INFO - using testdate: 1494596489 06:41:29 INFO - actual date: 1494596489 06:41:29 INFO - starting webserver on 'localhost:51061' 06:41:29 INFO - SUITE-START | Running 2 tests 06:41:29 INFO - TEST-START | dromaeo_css 06:41:29 INFO - operating with platform_type : linux_ 06:41:29 INFO - Initialising browser for dromaeo_css test... 06:41:29 INFO - TEST-INFO | started process 3314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTaSXwh/profile http://localhost:51061/getInfo.html) 06:41:34 INFO - PID 3314 | __metrics Screen width/height:1600/1200 06:41:34 INFO - PID 3314 | colorDepth:24 06:41:34 INFO - PID 3314 | Browser inner width/height: 1024/695 06:41:34 INFO - PID 3314 | __metrics 06:41:36 INFO - TEST-INFO | 3314: exit 0 06:41:36 INFO - Browser initialized. 06:41:36 INFO - Running cycle 1/1 for dromaeo_css test... 06:41:36 INFO - TEST-INFO | started process 3484 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTaSXwh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:41:48 INFO - PID 3484 | RSS: Main: 155443200 06:41:48 INFO - PID 3484 | 06:44:53 INFO - PID 3484 | Cycle 1(1): loaded http://localhost:51061/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51061/tests/dromaeo/cssquery-ext.html) 06:44:56 INFO - PID 3484 | RSS: Main: 165392384 06:44:56 INFO - PID 3484 | 06:47:58 INFO - PID 3484 | Cycle 1(1): loaded http://localhost:51061/tests/dromaeo/cssquery-ext.html (next: http://localhost:51061/tests/dromaeo/cssquery-jquery.html) 06:47:59 INFO - PID 3484 | RSS: Main: 161656832 06:47:59 INFO - PID 3484 | 06:51:00 INFO - PID 3484 | Cycle 1(1): loaded http://localhost:51061/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51061/tests/dromaeo/cssquery-mootools.html) 06:51:01 INFO - PID 3484 | RSS: Main: 169414656 06:51:01 INFO - PID 3484 | 06:54:03 INFO - PID 3484 | Cycle 1(1): loaded http://localhost:51061/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51061/tests/dromaeo/cssquery-prototype.html) 06:54:03 INFO - PID 3484 | RSS: Main: 161255424 06:54:03 INFO - PID 3484 | 06:57:06 INFO - PID 3484 | Cycle 1(1): loaded http://localhost:51061/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51061/tests/dromaeo/cssquery-yui.html) 06:57:07 INFO - PID 3484 | RSS: Main: 164290560 06:57:07 INFO - PID 3484 | 07:00:09 INFO - PID 3484 | Cycle 1(1): loaded http://localhost:51061/tests/dromaeo/cssquery-yui.html (next: http://localhost:51061/tests/dromaeo/cssquery-dojo.html) 07:00:09 INFO - PID 3484 | RSS: Main: 170147840 07:00:09 INFO - PID 3484 | 07:00:09 INFO - PID 3484 | __start_tp_report 07:00:09 INFO - PID 3484 | _x_x_mozilla_page_load 07:00:09 INFO - PID 3484 | _x_x_mozilla_page_load_details 07:00:09 INFO - PID 3484 | |i|pagename|runs| 07:00:09 INFO - PID 3484 | |0;dojo.html;2752.105565691151;2761.337279053025;2776.5696317070847;2793.566997115447;2801.1176479408996;5249.737513124338;5350.438203988583;5364.383095943957;5384.865378365543;5392.91910621341;5306.681599104057;5334.146536554152;5378.623496355257;5398.676079435237;5425.240466334706;4464.130455783761;4743.667943243974;4751.928721069186;4760.714357138583;4772.546608072227;4762.119007983534;4813.735244561548;4814.711117332971;4821.083994041156;4846.0792449434675;4680.4383473983;4737.597304229144;4741.739204343759;4745.905081898377;4773.71357718538;4723.622110231173;4729.668923175379;4733.83431579893;4734.644901632391;4746.810127594892;4669.392978912753;4693.507181745902;4694.647901407408;4700.412448443944;4711.693739906895;5234.345706786652;5254.054270231357;5273.499017593323;5288.814891478818;5289.259503669489;5697.259356283698;5733.054046082391;5837.270341207349;5839.678817665027;5840.591158618899;5898.734556944905;5913.852153696192;5927.170196172539;5930.97034514829;5940.910886336708;5406.162044883049;5449.155380915964;5452.236686863842;5452.672839629635;5493.148561972901;6019.157317975487;6023.488003519662;6023.608465449732;6028.638281703112;6031.065184896348;5577.247071645276;5604.131359639263;5682.602217844794;5728.112142617901;5735.8566035849435;5807.854803629859;5814.651120932757;5815.098659707752;5857.648541087463;5877.441643043904;5733.140028995684;5771.538276937835;5776.191333213354;5777.768889244468;5780.682062486603;5633.774649014075;5724.713764311768;5725.456081672318;5742.799002034909;5770.740316685759;4857.392825896763;4864.635152363587;4868.342773725572;4874.512548745097;4877.292792545132;4189.937150942738;4233.25917964355;4237.533871274158;4238.152369526107;4239.894002649959;4839.274108883696;4948.331975183304;4955.306257124005;4956;4964.329815474937;5097.490250974873;5810.854728631818;5864.912026319608;5888.764449422061;5893.410658934073;4996.125678006334;5001.949980500149;5007.198848184273;5007.674501157486;5011.899762004812;5095.057414378278;5215.921761173586;5240.580753539708;5242.449542797951;5245.790168393298;5302.39022512416;5369.704666243316;5398.568114550905;5409.648372855751;5437.782488700408;5806.6806325650805;5814.738336774771;5820.82537523858;5827.155062515827;5860.677662728591;5319.6808191508635;5350.705711185922;5360.785568577213;5364.14173732201;5412.431694672003;5610.747516361856;5678.943210568007;5685.51673107774;5691.032524470933;5691.971540142273;5706.001449746361;5716.571257155813;5717.971410142923;5726.0838265877255;5728.255326807488;5503.284573005483;5519.116941289374;5519.199716041232;5519.862003449946;5527.115661494142;5467.863303417287;5479.835604931699;5523.088690366205;5523.254360661259;5531.7234138292115;5183.611229157753;5245.318108645852;5372.165051453567;5404.864878378072;5417.593680473901;5655.7454914528125;5682.516986056232;5703.914441283467;5723.542116630742;5735.225744524602;5480.753366098455;5484;5490.0941344677685;5497.120460726264;5517.2275881377445 07:00:09 INFO - PID 3484 | |1;ext.html;689.1867596236441;997.6631314039188;1010.6159659329454;1101;1115.1023426141953;30765.38469230614;31926.84036579817;32027.839860800665;32047.19882002945;32047.35905281896;29459.558106628418;29684.257893552673;29729.851350743214;29772.25569360767;29835.403291934148;6198.411150940653;6199;6330.620162790225;6339.04914262862;6866.073080134168;6775.559588626748;6880.4495640348905;6881.415079718205;6881.690323935435;6892.931070689304;6812.216595091553;6870.244273129952;6911.48163887708;6912.758053468129;6933.618650974195;6839.076724642209;6857.759978400782;6874.793756187298;6883.208431030445;6888.207856096563;6467.51493637979;6539.705713242915;6559.737610495575;6577.375149360803;6589.637569933651;30796;30839.38321233585;31012.37975240505;31049.274087109465;31076.378472430424;2951.144168191222;2978.5829983802287;2982.686817884134;2984.4329577380227;3010.9849450752604;23683.763162368326;23731.762682373126;23877.641835372484;23902;23905.16331928374;3090.165655273086;3096.8606412711483;3123.9219019524694;3158.3999040182293;3170.0648308748973;142482.28758856244;142635.28682356625;143416;143604.28197859047;143896.28051859778;35005;36490.08079353645;36545.817270914005;38376.6162338373;38413.615863841565;37896.81051594725;37947.62052379496;38106.809465952494;38156;38245.42631860524;11079.5568177272;11317.603883864025;11318.830217546743;11329;11351.602693905674;8769.298456123495;8807.735767926972;8815.559222038872;8829.470231786114;8830.690925817566;11650.475728592233;11714.598507305982;11806.52773889052;11811.88188118125;11900.345480998629;4942.851714448572;4981.402231732215;5051.979208316629;5078.162103252922;5112.565431938253;858.1547176031604;877.2105105405059;885.4112015509614;891.2379915172435;906.8685040669066;20627.79372206289;24425.214598134502;25109;25178.874105629355;25329;949.4350861237552;955.3933252384786;970.1123472023161;971.5190980464574;975.4342481360794;10908;10978.176636752116;11140.164487663458;11246.268992515461;11299.717507062389;166844;167260.16369918315;167462;167583;168311;37084.44373334402;37424.43863342052;37466.43800342997;37517.624823751416;37594;1138.6868611132004;1201.129181343519;1205.2226314027403;1206.8913797758244;1237.5792230641625;19275.8072419274;19667.114979825656;20115.19539218415;20216.19135234574;20568.074436650088;29094.41811163807;29261.414771704873;29379.85310073436;29394;29427.264318392212;147516;147681.26159369564;147888.26055870083;148191.25904370408;148335;27070.458590828468;27151.185464436097;27469.587956180272;28452.715472845008;28881.566776497948;33743.662563374055;34218.65781342254;34315;34414.13964650904;34903.82548087243;25903.740962590135;26169.476610467304;26661.200163995112;27084.864575677784;27573.586396204475;26051.348716282246;26980.865095674395;27130;27832.63422609101;28420.715792841806;29043.419131616825;29077.273068173465;29427.705722942497;29600.407991840475;29805;26129.080637904466;26445;26596.069137580093;26863.73136268612;27482.587761183197;20373;21865;21984.45038873977;22078.33764987053;22119.66820497726 07:00:09 INFO - PID 3484 | |2;jquery.html;416.6208750037467;423.69855514032037;429.3859780513865;434.81737670178524;439.21380728495996;16939.15304234788;16946.66481543922;17086.658266834685;17472.912635436838;17517.29930802768;17715;17895.105244737744;18473.7228941566;19102.426927192173;19233.61532769344;5563.610547261694;5573.303337082864;5605.495505404513;5677.43225677431;5684.261046064006;5568.52667523261;5648.519875810561;5649.265595472582;5649.6327738697055;5649.830505084854;5403.540699040586;5566.693831839248;5585.1063829787245;5585.469380408855;5611.775528978836;5460.781568737246;5535.58483113766;5561.6663000220115;5565.359983601877;5579.497845193911;5003.924941125886;5057.317262169597;5061.367329083864;5080.415752188509;5085.0338435697095;21997.890010550003;22375.888120559455;23127.653085203736;23236.18673346425;23376.7662323378;1611.1702473226298;1638.573970767597;1640.3028712797134;1658.6848498785191;1658.7594798754233;14466.782998255034;14540.127592344494;14905.776413353808;15091.622709432242;15233.61915952099;1978.3965890403422;2027.1992562937558;2062.95874082519;2064.0917996081826;2073.2950796729033;82138;86590.56704716437;90439;95051.9999999993;98039;11052.613158539412;11324.377159256155;11354;11613.709657258636;11731.706707332214;15991.520254392386;16017.279222435018;16019.279132439067;16027.038377697376;16030.118343490987;7657.310842024244;7868.567228802471;7914.24814642608;8048.396370272253;8058.597070146469;6689.832754181184;6695.397414232742;6885.518013739091;6934.133233345832;7032.050673159058;7067.89398159028;7196.856062878713;7231.132264128339;7253.709851605982;7281.781546553612;2093.905774240163;2095.402810199086;2105.3473423238843;2120.194326156082;2239.3170083124805;830.8047608811925;838.1576515601781;852.6930305090162;871.3203701113142;881.5195718333396;17244.89591873475;17480.91259543694;17560.29758809659;17611.295548178186;18140.90929545344;883.5317281840506;884.8318819424418;887.0597167002998;889.2485849457198;907.1336873285996;9088.818223635622;9413.199878010446;9591.184749296248;9641.42151470914;9731.56207970643;361087;363086;363150;373942;379420;76206.6189669048;79151;79215.20784792193;81196.59401702954;81728.59135704284;1068.529846867376;1082.7888561730545;1103.6302838549177;1108.6507750058868;1115.6039605939936;17255.3960611378;17569.385071522436;17894.28422863123;18406.447806565826;18692.719609206146;38165.618343816204;38715.41926871156;38933.610663893;39555.40666890056;39623.40564891587;48914.75542622264;49182.508174919225;49315;49748.50251497584;50097.24854127118;8257.42198046155;8259.21537453941;8443.535605541754;8512.233898949124;8529.232369086812;9810.411375317504;12460.439280232593;12620;12803.935980320039;13151.342432878126;9789.804203915739;10360.171186305228;10809.729756756144;10845.511951962339;11097.056750176003;9495.382800118246;9982.500874956368;10060.647877324258;10118.08937195656;10174.440405777754;10438.63464778729;10553;10613.469326533797;10845.620403285848;11019.283746556448;8257.463264887763;8383.119772423808;8440.324774017941;8504.362172836938;8519.74440766778;11282.210245282751;11285.605003824827;11497.195196336175;11602.419879006186;11722.355270460206 07:00:09 INFO - PID 3484 | |3;mootools.html;1256.7423678145979;1313.1792629606496;1316.078744878584;1316.690577714237;1318.531921167985;9788.755281117976;10262.127719143873;10300.58797648095;10519.579216831336;10813.297135686194;10543.261971661987;10707.089897358714;10707.143428525718;10725.678229653124;10770.761362443322;2273.2157405695007;2319.7332306784683;2333.731620863597;2335.2994101769486;2345.2026311054237;2261.570301642691;2294.231432470116;2298.321995011476;2298.5058212484314;2318.594246006942;2196.9560608787892;2206.580749657568;2259.8418110732173;2263;2276.0781883337277;2111.767705552388;2128.531723020933;2161.3515945216373;2167;2170.0885628036262;2140.2188201306412;2191.5178660694783;2229.487217939883;2292.426893276681;2304.9654255186188;10114.140298074672;10288.794224115476;10304.278700490968;10308.742281442948;10315.535800888978;5576.581756368248;5768.567357448208;5782.10377391505;5786.218860453827;5790.507806836382;3427.7600567960253;3542.946855797165;3673.0633688409553;3751.1747415568802;3764.9811750941344;1151.8502594662723;1165.7843298989715;1188.5542921404474;1189.4112414354863;1211.9697007574794;15211;15377.000494967791;15555.144467054308;15574.532764016983;15595;5234.895302093937;5366.409694933554;5460.126379779216;5487.2317875497465;5521.5306698930235;12813;12929.159604625669;12943.223406595635;12950.935245323713;12962.416691248916;5924.6149000314845;5961.552883533665;5992.670403127782;6001.729922153513;6009.1587177795145;5155.329807125125;5267.683938963674;5302.151655735064;5309.177077552986;5343.171808369709;4267.957320426756;4294.978525107417;4346.6088052075465;4431.335299705005;4454.799534020977;1271.281725824906;1285.3380509037852;1310.0567591334225;1316.776148054833;1324.1988596898736;683.3132701634925;701.5895701014862;703.6868593475956;719.1980941250469;720.8486217894196;5320.281761962163;5437.700926449004;5460.6177567570685;5467.1799230115;5541.556675465953;541.8130744893006;561.6293246457318;562.5808772464541;566.396787421395;568.0315062817886;3350.6816852398983;3522.8590856365972;3683.8710645127826;3746.213295208037;3777;13366.26485543285;13550.93224533871;13799.379027943767;13833;13835;13166.868331316757;13419.798703019462;13580.117292375964;13634.386452609459;13706.109102908278;7209.855802883913;7234.891476627855;7360.484766066324;7440.218777028443;7449.366803821736;5605.747741351731;5724.055530837365;5825.50483208932;5853.912191317048;6041.124037014696;11928;11932.22440541362;12017.218880772722;12046.337451440255;12139.817902731289;12038.217515861441;12109.939450302692;12226.266424014231;12324.383780811102;12468.438920248793;8336.083030866721;8486.787830304293;8528.616212270339;8569.485830849919;8600.526971016654;9626.133647971716;9712.368696034735;9720.319577629498;9740.220782337254;9758.219342452729;8189.181081891763;8301.377396695392;8404.243618074403;8407.747767566983;8544.57277136153;8168.754937351889;8206.876896846672;8233.259006689426;8308.501489910625;8380.455270407649;7445.478816483011;7525.36034437079;7576.090869095744;7662.9654996574745;7665.846683066419;5225.425203227718;5228.503292187236;5274.261603375454;5319.547838433622;5362;5076.746162691925;5143.794248230029;5357.383900851452;5357.732113394237;5386.811461598825 07:00:09 INFO - PID 3484 | |4;prototype.html;385.88809245318856;390.22345532390534;392.952845658521;396.23526593674205;398.084405866507;5526.58550608704;5558.61089723719;5597.412271711472;5612.354579223391;5681.7727290908415;5433.565314774818;5574.749136288867;5574.804881829137;5584.776608935637;5589.189567512708;4259.850905218318;4350.586059530649;4370.125974805036;4391.0559229765595;4410.955890441102;4382.882364996922;4405.383246345515;4408.735475871442;4411.250087485135;4411.933820992672;4373.846915357964;4382.0797632497215;4382.145481631083;4392.253316936112;4396.692231543793;4341.804618792146;4365.738055716635;4399.182894730297;4410.404595379631;4412.492563355223;3938.8424463021443;3939.940900886489;3965.7620542767236;3970.920581588381;3979.925420136547;5424.484673955968;5455.236266922634;5469.644473109235;5488.313960754906;5489.231507588941;5124.282600435942;5170.121079416508;5191.532762051434;5221;5234.502722241381;5892.882142357172;5913.314705308966;5922.052471604523;5926;5936.168936348915;4481.798319075617;4488.3940668010055;4497.145542346976;4505.346724724896;4506.5493450655;5992.161097446361;6047.365026672224;6174.536909731743;6267.811965641038;6268.091126786636;4340.82636694535;4348.717333373321;4376.431063961664;4392.956070439319;4395.604395604411;4441.378207051015;4441.9333709993725;4450.643948484114;4465.397171381822;4474.619657329164;5008.248762685554;5013.242716505907;5022.698638081727;5024.447310795809;5192.324997750268;5911.793087242012;5932.19915311436;5947.732352044169;5957.195778569924;6009.308929473079;1630.502696677501;1657.411618875306;1658.8507034366964;1662.534490342706;1665.8500734933914;1185.6739396665987;1189.0903458853984;1194.7431302270054;1196.126827415991;1216.635009497165;5122;5144.254083157921;5162.1224391853475;5162.348048624404;5195.558377537876;6093.75624974996;6107.236595425572;6116.938830611637;6124.223975047275;6129.632222066691;4963.329950456714;5034.496550344937;5098.949010509921;5114.769835357418;5117.257997590403;3149.370125974814;3217.6299725531394;3218.2598002459567;3229.6124465064345;3244.0105767741065;5347.545458635982;5550.27846379968;5573.383718721525;5584.832455026356;5624.55003599711;6247;6269.529785266123;6286.654234017173;6299.716512756937;6306.432421082125;5621.8594535136945;5627.437256274504;5641.182028605911;5649.717514124195;5653.321601407857;5822.340632919598;6090.330063693079;6118.21621162379;6125.693715314127;6129.172561704291;5986.2217911671205;5991.281046274301;5998.490128338965;6010.368911264429;6032.245969253843;5407;5559.27729395176;5610.382857885547;5640.984622767777;5643.843012182575;4120.423140760356;4142.689298302579;4158.979205104076;4161.812718427738;4168.166366726606;5990.6705131218205;6081.908771368521;6093.75624974996;6148.466380257625;6149.169862068564;5900.055991041413;5909.674967876636;5917.556183286357;5925.9407405925385;5932.614380065282;5838.591298609056;5877.73628669838;5888.705564721832;5895.64626122434;5903.789723106839;5670.149477578231;5707.889200385716;5724.484796368347;5736.340320863154;5763.5965482417505;5893.44012318829;5923.644581325134;5936.257967754031;5946.970265148647;5948.910766338422;5604.971975140098;5721.256236689203;5732.799352022659;5740.90922724681;5745.052066408995 07:00:09 INFO - PID 3484 | |5;yui.html;723.2839488905985;739.6745432009918;749.7600767754319;750.7372419653123;755.9697612095516;11806.881931180686;12203.145779795417;13149.539766108188;13935.233562154077;14036;14994;15497.612559685986;15508.224588770545;15571.98782079164;15593;856.8800367948477;874.3748220022683;877.6928075173702;879.9648014079429;881.5548148185158;871.8125602995354;879.4415546128223;880.6477409036405;881.6253092435721;883.730462209026;935.3686261773275;946.4321407155686;948.3172116076414;949.8290307744603;950.2635457520443;926.0970553710113;934.4206591912989;934.7663084228943;936.5879013234223;938.1041105744066;683.8392977650249;693.3240090911371;693.6046453521495;693.7329128285646;700.0304578159236;13563.45746170152;13716;13762.518311859138;14313.928430357886;14429.484904085024;15473.226338683133;15577.688446231012;15733.68532629341;15975.201239937956;15985.520434386986;12519.624411267676;12666.303353315563;12764.936175319157;12785.488580456864;12900.290484023375;2857.514222582166;2893.3345330573875;2899.652041754982;2900.44891470622;2907.912762617125;66041.66979165122;66116;66174;67114.66442667755;68105.3189468104;10632.574697012033;10799.78400431987;10893;10912.127029837595;11010;17535.47393578169;17600.823991760175;17642.64714705699;20927.581448371253;21077.578448430944;6210.472109870711;6347.174867267226;6383.1382763326355;6390.9360906391275;6409;2917.0519581136214;2974.018573870661;2980.0463851567292;2982.41842840644;2985.8357790321743;3502.5972013218297;3563.625819288989;3577.3024260269517;3593.4250519916686;3610.693091087287;735.797655644702;754.9018627578489;757.8408534207878;759.5898214963858;761.8285885675679;532.3079996005177;536.975836087377;539.5629540072475;540.3461811208482;541.6939429222476;9772.804543909224;9839.508024598741;9865.753356166153;10278.743031424274;10434.269601127848;583.9182514447981;584.5469760935309;592.4164697772691;593.6378808926552;599.6821684507219;4468.218061839165;4597.057603191338;4625.606823419979;4660.86017419478;4677.2750223715375;61532.69233653803;62754;63533.68233158897;65234.34765652283;65908.6704566474;55448.168277475874;55501.444985550435;56420.153697694564;57365.713171433876;57460.71269643625;51191.48808511942;51476.99999999925;51564.48435515672;51989.48010519922;53935.46064539383;9320.254379649476;9366.157045865904;9449.338546301968;9453;9796.314258001872;26793.19620411391;27583;27827;28070.43859122847;28204.15387538377;32222.677773222906;32723;33011.66988330086;33478.66521334756;33810.49284260787;12049.879501204876;12274.079444041554;12337.876621234032;12433.37833108323;12456.81314780261;16210.18949052519;16574;16650.50048498547;16941.745873811655;17006.744898826775;14060.929695351459;15459.61350966235;15750.606234844221;15853.207339633203;16251.024938503728;15716.76424853651;15855.572998430196;15877.841221587636;15926.362945482515;15928.28322725457;15431.691366172838;15594.9220253898;15653;15929.203539823195;16039.679206415572;9865.852012219966;9970.351927125004;10121.493925303852;10222.080012798884;10312.432816195182;11915.165938384576;12360.320182390054;12560.874391255971;12602.24386536774;12625.936870315956 07:00:09 INFO - PID 3484 | __end_tp_report 07:00:09 INFO - PID 3484 | __start_cc_report 07:00:09 INFO - PID 3484 | _x_x_mozilla_cycle_collect,338 07:00:09 INFO - PID 3484 | __end_cc_report 07:00:09 INFO - PID 3484 | __startTimestamp1494597609581__endTimestamp 07:00:09 INFO - PID 3484 | 07:00:09 INFO - PID 3484 | ------- Summary: start ------- 07:00:09 INFO - PID 3484 | Number of tests: 6 07:00:09 INFO - PID 3484 | 07:00:09 INFO - PID 3484 | [#0] dojo.html Cycles:165 Average:5274.77 Median:5409.65 stddev:622.80 (11.5%) stddev-sans-first:592.44 07:00:09 INFO - PID 3484 | Values: 2752.1 2761.3 2776.6 2793.6 2801.1 5249.7 5350.4 5364.4 5384.9 5392.9 5306.7 5334.1 5378.6 5398.7 5425.2 4464.1 4743.7 4751.9 4760.7 4772.5 4762.1 4813.7 4814.7 4821.1 4846.1 4680.4 4737.6 4741.7 4745.9 4773.7 4723.6 4729.7 4733.8 4734.6 4746.8 4669.4 4693.5 4694.6 4700.4 4711.7 5234.3 5254.1 5273.5 5288.8 5289.3 5697.3 5733.1 5837.3 5839.7 5840.6 5898.7 5913.9 5927.2 5931.0 5940.9 5406.2 5449.2 5452.2 5452.7 5493.1 6019.2 6023.5 6023.6 6028.6 6031.1 5577.2 5604.1 5682.6 5728.1 5735.9 5807.9 5814.7 5815.1 5857.6 5877.4 5733.1 5771.5 5776.2 5777.8 5780.7 5633.8 5724.7 5725.5 5742.8 5770.7 4857.4 4864.6 4868.3 4874.5 4877.3 4189.9 4233.3 4237.5 4238.2 4239.9 4839.3 4948.3 4955.3 4956.0 4964.3 5097.5 5810.9 5864.9 5888.8 5893.4 4996.1 5001.9 5007.2 5007.7 5011.9 5095.1 5215.9 5240.6 5242.4 5245.8 5302.4 5369.7 5398.6 5409.6 5437.8 5806.7 5814.7 5820.8 5827.2 5860.7 5319.7 5350.7 5360.8 5364.1 5412.4 5610.7 5678.9 5685.5 5691.0 5692.0 5706.0 5716.6 5718.0 5726.1 5728.3 5503.3 5519.1 5519.2 5519.9 5527.1 5467.9 5479.8 5523.1 5523.3 5531.7 5183.6 5245.3 5372.2 5404.9 5417.6 5655.7 5682.5 5703.9 5723.5 5735.2 5480.8 5484.0 5490.1 5497.1 5517.2 07:00:09 INFO - PID 3484 | 07:00:09 INFO - PID 3484 | [#1] ext.html Cycles:180 Average:29063.68 Median:29751.05 stddev:39447.85 (132.6%) stddev-sans-first:39500.97 07:00:09 INFO - PID 3484 | Values: 689.2 997.7 1010.6 1101.0 1115.1 30765.4 31926.8 32027.8 32047.2 32047.4 29459.6 29684.3 29729.9 29772.3 29835.4 6198.4 6199.0 6330.6 6339.0 6866.1 6775.6 6880.4 6881.4 6881.7 6892.9 6812.2 6870.2 6911.5 6912.8 6933.6 6839.1 6857.8 6874.8 6883.2 6888.2 6467.5 6539.7 6559.7 6577.4 6589.6 30796.0 30839.4 31012.4 31049.3 31076.4 2951.1 2978.6 2982.7 2984.4 3011.0 23683.8 23731.8 23877.6 23902.0 23905.2 3090.2 3096.9 3123.9 3158.4 3170.1 142482.3 142635.3 143416.0 143604.3 143896.3 35005.0 36490.1 36545.8 38376.6 38413.6 37896.8 37947.6 38106.8 38156.0 38245.4 11079.6 11317.6 11318.8 11329.0 11351.6 8769.3 8807.7 8815.6 8829.5 8830.7 11650.5 11714.6 11806.5 11811.9 11900.3 4942.9 4981.4 5052.0 5078.2 5112.6 858.2 877.2 885.4 891.2 906.9 20627.8 24425.2 25109.0 25178.9 25329.0 949.4 955.4 970.1 971.5 975.4 10908.0 10978.2 11140.2 11246.3 11299.7 166844.0 167260.2 167462.0 167583.0 168311.0 37084.4 37424.4 37466.4 37517.6 37594.0 1138.7 1201.1 1205.2 1206.9 1237.6 19275.8 19667.1 20115.2 20216.2 20568.1 29094.4 29261.4 29379.9 29394.0 29427.3 147516.0 147681.3 147888.3 148191.3 148335.0 27070.5 27151.2 27469.6 28452.7 28881.6 33743.7 34218.7 34315.0 34414.1 34903.8 25903.7 26169.5 26661.2 27084.9 27573.6 26051.3 26980.9 27130.0 27832.6 28420.7 29043.4 29077.3 29427.7 29600.4 29805.0 26129.1 26445.0 26596.1 26863.7 27482.6 20373.0 21865.0 21984.5 22078.3 22119.7 07:00:09 INFO - PID 3484 | 07:00:09 INFO - PID 3484 | [#2] jquery.html Cycles:180 Average:25070.58 Median:20020.01 stddev:61412.43 (306.8%) stddev-sans-first:61556.81 07:00:09 INFO - PID 3484 | Values: 416.6 423.7 429.4 434.8 439.2 16939.2 16946.7 17086.7 17472.9 17517.3 17715.0 17895.1 18473.7 19102.4 19233.6 5563.6 5573.3 5605.5 5677.4 5684.3 5568.5 5648.5 5649.3 5649.6 5649.8 5403.5 5566.7 5585.1 5585.5 5611.8 5460.8 5535.6 5561.7 5565.4 5579.5 5003.9 5057.3 5061.4 5080.4 5085.0 21997.9 22375.9 23127.7 23236.2 23376.8 1611.2 1638.6 1640.3 1658.7 1658.8 14466.8 14540.1 14905.8 15091.6 15233.6 1978.4 2027.2 2063.0 2064.1 2073.3 82138.0 86590.6 90439.0 95052.0 98039.0 11052.6 11324.4 11354.0 11613.7 11731.7 15991.5 16017.3 16019.3 16027.0 16030.1 7657.3 7868.6 7914.2 8048.4 8058.6 6689.8 6695.4 6885.5 6934.1 7032.1 7067.9 7196.9 7231.1 7253.7 7281.8 2093.9 2095.4 2105.3 2120.2 2239.3 830.8 838.2 852.7 871.3 881.5 17244.9 17480.9 17560.3 17611.3 18140.9 883.5 884.8 887.1 889.2 907.1 9088.8 9413.2 9591.2 9641.4 9731.6 361087.0 363086.0 363150.0 373942.0 379420.0 76206.6 79151.0 79215.2 81196.6 81728.6 1068.5 1082.8 1103.6 1108.7 1115.6 17255.4 17569.4 17894.3 18406.4 18692.7 38165.6 38715.4 38933.6 39555.4 39623.4 48914.8 49182.5 49315.0 49748.5 50097.2 8257.4 8259.2 8443.5 8512.2 8529.2 9810.4 12460.4 12620.0 12803.9 13151.3 9789.8 10360.2 10809.7 10845.5 11097.1 9495.4 9982.5 10060.6 10118.1 10174.4 10438.6 10553.0 10613.5 10845.6 11019.3 8257.5 8383.1 8440.3 8504.4 8519.7 11282.2 11285.6 11497.2 11602.4 11722.4 07:00:09 INFO - PID 3484 | 07:00:09 INFO - PID 3484 | [#3] mootools.html Cycles:180 Average:6471.27 Median:3748.69 stddev:4181.10 (111.5%) stddev-sans-first:4174.47 07:00:09 INFO - PID 3484 | Values: 1256.7 1313.2 1316.1 1316.7 1318.5 9788.8 10262.1 10300.6 10519.6 10813.3 10543.3 10707.1 10707.1 10725.7 10770.8 2273.2 2319.7 2333.7 2335.3 2345.2 2261.6 2294.2 2298.3 2298.5 2318.6 2197.0 2206.6 2259.8 2263.0 2276.1 2111.8 2128.5 2161.4 2167.0 2170.1 2140.2 2191.5 2229.5 2292.4 2305.0 10114.1 10288.8 10304.3 10308.7 10315.5 5576.6 5768.6 5782.1 5786.2 5790.5 3427.8 3542.9 3673.1 3751.2 3765.0 1151.9 1165.8 1188.6 1189.4 1212.0 15211.0 15377.0 15555.1 15574.5 15595.0 5234.9 5366.4 5460.1 5487.2 5521.5 12813.0 12929.2 12943.2 12950.9 12962.4 5924.6 5961.6 5992.7 6001.7 6009.2 5155.3 5267.7 5302.2 5309.2 5343.2 4268.0 4295.0 4346.6 4431.3 4454.8 1271.3 1285.3 1310.1 1316.8 1324.2 683.3 701.6 703.7 719.2 720.8 5320.3 5437.7 5460.6 5467.2 5541.6 541.8 561.6 562.6 566.4 568.0 3350.7 3522.9 3683.9 3746.2 3777.0 13366.3 13550.9 13799.4 13833.0 13835.0 13166.9 13419.8 13580.1 13634.4 13706.1 7209.9 7234.9 7360.5 7440.2 7449.4 5605.7 5724.1 5825.5 5853.9 6041.1 11928.0 11932.2 12017.2 12046.3 12139.8 12038.2 12109.9 12226.3 12324.4 12468.4 8336.1 8486.8 8528.6 8569.5 8600.5 9626.1 9712.4 9720.3 9740.2 9758.2 8189.2 8301.4 8404.2 8407.7 8544.6 8168.8 8206.9 8233.3 8308.5 8380.5 7445.5 7525.4 7576.1 7663.0 7665.8 5225.4 5228.5 5274.3 5319.5 5362.0 5076.7 5143.8 5357.4 5357.7 5386.8 07:00:09 INFO - PID 3484 | 07:00:09 INFO - PID 3484 | [#4] prototype.html Cycles:180 Average:4915.80 Median:5478.98 stddev:1387.54 (25.3%) stddev-sans-first:1349.13 07:00:09 INFO - PID 3484 | Values: 385.9 390.2 393.0 396.2 398.1 5526.6 5558.6 5597.4 5612.4 5681.8 5433.6 5574.7 5574.8 5584.8 5589.2 4259.9 4350.6 4370.1 4391.1 4411.0 4382.9 4405.4 4408.7 4411.3 4411.9 4373.8 4382.1 4382.1 4392.3 4396.7 4341.8 4365.7 4399.2 4410.4 4412.5 3938.8 3939.9 3965.8 3970.9 3979.9 5424.5 5455.2 5469.6 5488.3 5489.2 5124.3 5170.1 5191.5 5221.0 5234.5 5892.9 5913.3 5922.1 5926.0 5936.2 4481.8 4488.4 4497.1 4505.3 4506.5 5992.2 6047.4 6174.5 6267.8 6268.1 4340.8 4348.7 4376.4 4393.0 4395.6 4441.4 4441.9 4450.6 4465.4 4474.6 5008.2 5013.2 5022.7 5024.4 5192.3 5911.8 5932.2 5947.7 5957.2 6009.3 1630.5 1657.4 1658.9 1662.5 1665.9 1185.7 1189.1 1194.7 1196.1 1216.6 5122.0 5144.3 5162.1 5162.3 5195.6 6093.8 6107.2 6116.9 6124.2 6129.6 4963.3 5034.5 5098.9 5114.8 5117.3 3149.4 3217.6 3218.3 3229.6 3244.0 5347.5 5550.3 5573.4 5584.8 5624.6 6247.0 6269.5 6286.7 6299.7 6306.4 5621.9 5627.4 5641.2 5649.7 5653.3 5822.3 6090.3 6118.2 6125.7 6129.2 5986.2 5991.3 5998.5 6010.4 6032.2 5407.0 5559.3 5610.4 5641.0 5643.8 4120.4 4142.7 4159.0 4161.8 4168.2 5990.7 6081.9 6093.8 6148.5 6149.2 5900.1 5909.7 5917.6 5925.9 5932.6 5838.6 5877.7 5888.7 5895.6 5903.8 5670.1 5707.9 5724.5 5736.3 5763.6 5893.4 5923.6 5936.3 5947.0 5948.9 5605.0 5721.3 5732.8 5740.9 5745.1 07:00:09 INFO - PID 3484 | 07:00:09 INFO - PID 3484 | [#5] yui.html Cycles:180 Average:15162.04 Median:3533.11 stddev:17693.50 (500.8%) stddev-sans-first:17709.91 07:00:09 INFO - PID 3484 | Values: 723.3 739.7 749.8 750.7 756.0 11806.9 12203.1 13149.5 13935.2 14036.0 14994.0 15497.6 15508.2 15572.0 15593.0 856.9 874.4 877.7 880.0 881.6 871.8 879.4 880.6 881.6 883.7 935.4 946.4 948.3 949.8 950.3 926.1 934.4 934.8 936.6 938.1 683.8 693.3 693.6 693.7 700.0 13563.5 13716.0 13762.5 14313.9 14429.5 15473.2 15577.7 15733.7 15975.2 15985.5 12519.6 12666.3 12764.9 12785.5 12900.3 2857.5 2893.3 2899.7 2900.4 2907.9 66041.7 66116.0 66174.0 67114.7 68105.3 10632.6 10799.8 10893.0 10912.1 11010.0 17535.5 17600.8 17642.6 20927.6 21077.6 6210.5 6347.2 6383.1 6390.9 6409.0 2917.1 2974.0 2980.0 2982.4 2985.8 3502.6 3563.6 3577.3 3593.4 3610.7 735.8 754.9 757.8 759.6 761.8 532.3 537.0 539.6 540.3 541.7 9772.8 9839.5 9865.8 10278.7 10434.3 583.9 584.5 592.4 593.6 599.7 4468.2 4597.1 4625.6 4660.9 4677.3 61532.7 62754.0 63533.7 65234.3 65908.7 55448.2 55501.4 56420.2 57365.7 57460.7 51191.5 51477.0 51564.5 51989.5 53935.5 9320.3 9366.2 9449.3 9453.0 9796.3 26793.2 27583.0 27827.0 28070.4 28204.2 32222.7 32723.0 33011.7 33478.7 33810.5 12049.9 12274.1 12337.9 12433.4 12456.8 16210.2 16574.0 16650.5 16941.7 17006.7 14060.9 15459.6 15750.6 15853.2 16251.0 15716.8 15855.6 15877.8 15926.4 15928.3 15431.7 15594.9 15653.0 15929.2 16039.7 9865.9 9970.4 10121.5 10222.1 10312.4 11915.2 12360.3 12560.9 12602.2 12625.9 07:00:09 INFO - PID 3484 | -------- Summary: end -------- 07:00:09 INFO - PID 3484 | 07:00:10 INFO - TEST-INFO | 3484: exit 0 07:00:10 INFO - TEST-OK | dromaeo_css | took 1120710ms 07:00:10 INFO - TEST-START | kraken 07:00:10 INFO - operating with platform_type : linux_ 07:00:10 INFO - Initialising browser for kraken test... 07:00:10 INFO - TEST-INFO | started process 3905 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMFIBY0/profile http://localhost:51061/getInfo.html) 07:00:14 INFO - PID 3905 | __metrics Screen width/height:1600/1200 07:00:14 INFO - PID 3905 | colorDepth:24 07:00:14 INFO - PID 3905 | Browser inner width/height: 1024/695 07:00:14 INFO - PID 3905 | __metrics 07:00:16 INFO - TEST-INFO | 3905: exit 0 07:00:16 INFO - Browser initialized. 07:00:16 INFO - Running cycle 1/1 for kraken test... 07:00:16 INFO - TEST-INFO | started process 4076 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMFIBY0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:00:28 INFO - PID 4076 | RSS: Main: 155463680 07:00:28 INFO - PID 4076 | 07:00:31 INFO - PID 4076 | Cycle 1(1): loaded http://localhost:51061/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51061/tests/kraken/driver.html?testName=audio-beat-detection) 07:00:32 INFO - PID 4076 | RSS: Main: 162443264 07:00:32 INFO - PID 4076 | 07:00:34 INFO - PID 4076 | Cycle 1(1): loaded http://localhost:51061/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51061/tests/kraken/driver.html?testName=audio-dft) 07:00:35 INFO - PID 4076 | RSS: Main: 161288192 07:00:35 INFO - PID 4076 | 07:00:38 INFO - PID 4076 | Cycle 1(1): loaded http://localhost:51061/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51061/tests/kraken/driver.html?testName=audio-fft) 07:00:38 INFO - PID 4076 | RSS: Main: 158629888 07:00:38 INFO - PID 4076 | 07:00:41 INFO - PID 4076 | Cycle 1(1): loaded http://localhost:51061/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51061/tests/kraken/driver.html?testName=audio-oscillator) 07:00:41 INFO - PID 4076 | RSS: Main: 158994432 07:00:41 INFO - PID 4076 | 07:00:43 INFO - PID 4076 | Cycle 1(1): loaded http://localhost:51061/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51061/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:00:44 INFO - PID 4076 | RSS: Main: 159195136 07:00:44 INFO - PID 4076 | 07:00:47 INFO - PID 4076 | Cycle 1(1): loaded http://localhost:51061/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51061/tests/kraken/driver.html?testName=imaging-darkroom) 07:00:48 INFO - PID 4076 | RSS: Main: 163934208 07:00:48 INFO - PID 4076 | 07:00:51 INFO - PID 4076 | Cycle 1(1): loaded http://localhost:51061/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51061/tests/kraken/driver.html?testName=imaging-desaturate) 07:00:52 INFO - PID 4076 | RSS: Main: 163295232 07:00:52 INFO - PID 4076 | 07:00:55 INFO - PID 4076 | Cycle 1(1): loaded http://localhost:51061/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51061/tests/kraken/driver.html?testName=json-parse-financial) 07:00:55 INFO - PID 4076 | RSS: Main: 164397056 07:00:55 INFO - PID 4076 | 07:00:57 INFO - PID 4076 | Cycle 1(1): loaded http://localhost:51061/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51061/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:00:58 INFO - PID 4076 | RSS: Main: 164474880 07:00:58 INFO - PID 4076 | 07:00:59 INFO - PID 4076 | Cycle 1(1): loaded http://localhost:51061/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51061/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:01:00 INFO - PID 4076 | RSS: Main: 164941824 07:01:00 INFO - PID 4076 | 07:01:02 INFO - PID 4076 | Cycle 1(1): loaded http://localhost:51061/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51061/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:01:03 INFO - PID 4076 | RSS: Main: 165052416 07:01:03 INFO - PID 4076 | 07:01:06 INFO - PID 4076 | Cycle 1(1): loaded http://localhost:51061/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51061/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:01:06 INFO - PID 4076 | RSS: Main: 165158912 07:01:06 INFO - PID 4076 | 07:01:10 INFO - PID 4076 | Cycle 1(1): loaded http://localhost:51061/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51061/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:01:10 INFO - PID 4076 | RSS: Main: 164806656 07:01:10 INFO - PID 4076 | 07:01:12 INFO - PID 4076 | Cycle 1(1): loaded http://localhost:51061/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51061/tests/kraken/driver.html?testName=ai-astar) 07:01:12 INFO - PID 4076 | RSS: Main: 166649856 07:01:12 INFO - PID 4076 | 07:01:12 INFO - PID 4076 | __start_tp_report 07:01:12 INFO - PID 4076 | _x_x_mozilla_page_load 07:01:12 INFO - PID 4076 | _x_x_mozilla_page_load_details 07:01:12 INFO - PID 4076 | |i|pagename|runs| 07:01:12 INFO - PID 4076 | |0;ai-astar;103;113;112;111;112;111;111;111;113;110 07:01:12 INFO - PID 4076 | |1;audio-beat-detection;153;126;124;173;127;128;126;125;146;125 07:01:12 INFO - PID 4076 | |2;audio-dft;164;163;163;166;166;168;166;164;163;166 07:01:12 INFO - PID 4076 | |3;audio-fft;74;75;76;114;77;77;84;78;92;77 07:01:12 INFO - PID 4076 | |4;audio-oscillator;83;83;102;84;83;82;95;84;83;109 07:01:12 INFO - PID 4076 | |5;imaging-gaussian-blur;113;115;114;114;114;114;114;117;114;115 07:01:12 INFO - PID 4076 | |6;imaging-darkroom;150;150;149;151;151;150;150;150;152;150 07:01:12 INFO - PID 4076 | |7;imaging-desaturate;95;95;94;94;95;95;95;95;95;97 07:01:12 INFO - PID 4076 | |8;json-parse-financial;55;54;53;61;56;56;54;55;55;57 07:01:12 INFO - PID 4076 | |9;json-stringify-tinderbox;56;56;56;57;56;55;55;55;55;56 07:01:12 INFO - PID 4076 | |10;stanford-crypto-aes;85;83;82;85;91;83;84;84;84;82 07:01:12 INFO - PID 4076 | |11;stanford-crypto-ccm;143;141;134;145;142;143;135;137;188;137 07:01:12 INFO - PID 4076 | |12;stanford-crypto-pbkdf2;190;206;198;194;195;196;197;194;199;195 07:01:12 INFO - PID 4076 | |13;stanford-crypto-sha256-iterative;74;74;73;74;74;73;72;77;76;76 07:01:12 INFO - PID 4076 | __end_tp_report 07:01:12 INFO - PID 4076 | __start_cc_report 07:01:12 INFO - PID 4076 | _x_x_mozilla_cycle_collect,873 07:01:12 INFO - PID 4076 | __end_cc_report 07:01:12 INFO - PID 4076 | __startTimestamp1494597672743__endTimestamp 07:01:12 INFO - PID 4076 | 07:01:12 INFO - PID 4076 | ------- Summary: start ------- 07:01:12 INFO - PID 4076 | Number of tests: 14 07:01:12 INFO - PID 4076 | 07:01:12 INFO - PID 4076 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:2.87 (2.6%) stddev-sans-first:1.01 07:01:12 INFO - PID 4076 | Values: 103.0 113.0 112.0 111.0 112.0 111.0 111.0 111.0 113.0 110.0 07:01:12 INFO - PID 4076 | 07:01:12 INFO - PID 4076 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:127.50 stddev:16.61 (13.0%) stddev-sans-first:16.34 07:01:12 INFO - PID 4076 | Values: 153.0 126.0 124.0 173.0 127.0 128.0 126.0 125.0 146.0 125.0 07:01:12 INFO - PID 4076 | 07:01:12 INFO - PID 4076 | [#2] audio-dft Cycles:10 Average:164.90 Median:166.00 stddev:1.73 (1.0%) stddev-sans-first:1.80 07:01:12 INFO - PID 4076 | Values: 164.0 163.0 163.0 166.0 166.0 168.0 166.0 164.0 163.0 166.0 07:01:12 INFO - PID 4076 | 07:01:12 INFO - PID 4076 | [#3] audio-fft Cycles:10 Average:82.40 Median:77.00 stddev:12.32 (16.0%) stddev-sans-first:12.69 07:01:12 INFO - PID 4076 | Values: 74.0 75.0 76.0 114.0 77.0 77.0 84.0 78.0 92.0 77.0 07:01:12 INFO - PID 4076 | 07:01:12 INFO - PID 4076 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:83.00 stddev:9.70 (11.7%) stddev-sans-first:10.06 07:01:12 INFO - PID 4076 | Values: 83.0 83.0 102.0 84.0 83.0 82.0 95.0 84.0 83.0 109.0 07:01:12 INFO - PID 4076 | 07:01:12 INFO - PID 4076 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:1.07 (0.9%) stddev-sans-first:1.01 07:01:12 INFO - PID 4076 | Values: 113.0 115.0 114.0 114.0 114.0 114.0 114.0 117.0 114.0 115.0 07:01:12 INFO - PID 4076 | 07:01:12 INFO - PID 4076 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 07:01:12 INFO - PID 4076 | Values: 150.0 150.0 149.0 151.0 151.0 150.0 150.0 150.0 152.0 150.0 07:01:12 INFO - PID 4076 | 07:01:12 INFO - PID 4076 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 07:01:12 INFO - PID 4076 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 97.0 07:01:12 INFO - PID 4076 | 07:01:12 INFO - PID 4076 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.50 stddev:2.22 (4.0%) stddev-sans-first:2.35 07:01:12 INFO - PID 4076 | Values: 55.0 54.0 53.0 61.0 56.0 56.0 54.0 55.0 55.0 57.0 07:01:12 INFO - PID 4076 | 07:01:12 INFO - PID 4076 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:56.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 07:01:12 INFO - PID 4076 | Values: 56.0 56.0 56.0 57.0 56.0 55.0 55.0 55.0 55.0 56.0 07:01:12 INFO - PID 4076 | 07:01:12 INFO - PID 4076 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.00 stddev:2.58 (3.1%) stddev-sans-first:2.73 07:01:12 INFO - PID 4076 | Values: 85.0 83.0 82.0 85.0 91.0 83.0 84.0 84.0 84.0 82.0 07:01:12 INFO - PID 4076 | 07:01:12 INFO - PID 4076 | [#11] stanford-crypto-ccm Cycles:10 Average:144.50 Median:142.50 stddev:15.74 (11.0%) stddev-sans-first:16.68 07:01:12 INFO - PID 4076 | Values: 143.0 141.0 134.0 145.0 142.0 143.0 135.0 137.0 188.0 137.0 07:01:12 INFO - PID 4076 | 07:01:12 INFO - PID 4076 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.40 Median:196.50 stddev:4.20 (2.1%) stddev-sans-first:3.76 07:01:12 INFO - PID 4076 | Values: 190.0 206.0 198.0 194.0 195.0 196.0 197.0 194.0 199.0 195.0 07:01:12 INFO - PID 4076 | 07:01:12 INFO - PID 4076 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:74.00 stddev:1.57 (2.1%) stddev-sans-first:1.66 07:01:12 INFO - PID 4076 | Values: 74.0 74.0 73.0 74.0 74.0 73.0 72.0 77.0 76.0 76.0 07:01:12 INFO - PID 4076 | -------- Summary: end -------- 07:01:12 INFO - PID 4076 | 07:01:13 INFO - TEST-INFO | 4076: exit 0 07:01:13 INFO - TEST-OK | kraken | took 63491ms 07:01:13 INFO - SUITE-END | took 1184s 07:01:14 INFO - Completed test suite (00:19:44) 07:01:14 INFO - javascript benchmark 07:01:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6775.797070264408, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2752.105565691151, 2761.337279053025, 2776.5696317070847, 2793.566997115447, 2801.1176479408996, 5249.737513124338, 5350.438203988583, 5364.383095943957, 5384.865378365543, 5392.91910621341, 5306.681599104057, 5334.146536554152, 5378.623496355257, 5398.676079435237, 5425.240466334706, 4464.130455783761, 4743.667943243974, 4751.928721069186, 4760.714357138583, 4772.546608072227, 4762.119007983534, 4813.735244561548, 4814.711117332971, 4821.083994041156, 4846.0792449434675, 4680.4383473983, 4737.597304229144, 4741.739204343759, 4745.905081898377, 4773.71357718538, 4723.622110231173, 4729.668923175379, 4733.83431579893, 4734.644901632391, 4746.810127594892, 4669.392978912753, 4693.507181745902, 4694.647901407408, 4700.412448443944, 4711.693739906895, 5234.345706786652, 5254.054270231357, 5273.499017593323, 5288.814891478818, 5289.259503669489, 5697.259356283698, 5733.054046082391, 5837.270341207349, 5839.678817665027, 5840.591158618899, 5898.734556944905, 5913.852153696192, 5927.170196172539, 5930.97034514829, 5940.910886336708, 5406.162044883049, 5449.155380915964, 5452.236686863842, 5452.672839629635, 5493.148561972901, 6019.157317975487, 6023.488003519662, 6023.608465449732, 6028.638281703112, 6031.065184896348, 5577.247071645276, 5604.131359639263, 5682.602217844794, 5728.112142617901, 5735.8566035849435, 5807.854803629859, 5814.651120932757, 5815.098659707752, 5857.648541087463, 5877.441643043904, 5733.140028995684, 5771.538276937835, 5776.191333213354, 5777.768889244468, 5780.682062486603, 5633.774649014075, 5724.713764311768, 5725.456081672318, 5742.799002034909, 5770.740316685759, 4857.392825896763, 4864.635152363587, 4868.342773725572, 4874.512548745097, 4877.292792545132, 4189.937150942738, 4233.25917964355, 4237.533871274158, 4238.152369526107, 4239.894002649959, 4839.274108883696, 4948.331975183304, 4955.306257124005, 4956.0, 4964.329815474937, 5097.490250974873, 5810.854728631818, 5864.912026319608, 5888.764449422061, 5893.410658934073, 4996.125678006334, 5001.949980500149, 5007.198848184273, 5007.674501157486, 5011.899762004812, 5095.057414378278, 5215.921761173586, 5240.580753539708, 5242.449542797951, 5245.790168393298, 5302.39022512416, 5369.704666243316, 5398.568114550905, 5409.648372855751, 5437.782488700408, 5806.6806325650805, 5814.738336774771, 5820.82537523858, 5827.155062515827, 5860.677662728591, 5319.6808191508635, 5350.705711185922, 5360.785568577213, 5364.14173732201, 5412.431694672003, 5610.747516361856, 5678.943210568007, 5685.51673107774, 5691.032524470933, 5691.971540142273, 5706.001449746361, 5716.571257155813, 5717.971410142923, 5726.0838265877255, 5728.255326807488, 5503.284573005483, 5519.116941289374, 5519.199716041232, 5519.862003449946, 5527.115661494142, 5467.863303417287, 5479.835604931699, 5523.088690366205, 5523.254360661259, 5531.7234138292115, 5183.611229157753, 5245.318108645852, 5372.165051453567, 5404.864878378072, 5417.593680473901, 5655.7454914528125, 5682.516986056232, 5703.914441283467, 5723.542116630742, 5735.225744524602, 5480.753366098455, 5484.0, 5490.0941344677685, 5497.120460726264, 5517.2275881377445], "value": 5229.664503956275, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.1867596236441, 997.6631314039188, 1010.6159659329454, 1101.0, 1115.1023426141953, 30765.38469230614, 31926.84036579817, 32027.839860800665, 32047.19882002945, 32047.35905281896, 29459.558106628418, 29684.257893552673, 29729.851350743214, 29772.25569360767, 29835.403291934148, 6198.411150940653, 6199.0, 6330.620162790225, 6339.04914262862, 6866.073080134168, 6775.559588626748, 6880.4495640348905, 6881.415079718205, 6881.690323935435, 6892.931070689304, 6812.216595091553, 6870.244273129952, 6911.48163887708, 6912.758053468129, 6933.618650974195, 6839.076724642209, 6857.759978400782, 6874.793756187298, 6883.208431030445, 6888.207856096563, 6467.51493637979, 6539.705713242915, 6559.737610495575, 6577.375149360803, 6589.637569933651, 30796.0, 30839.38321233585, 31012.37975240505, 31049.274087109465, 31076.378472430424, 2951.144168191222, 2978.5829983802287, 2982.686817884134, 2984.4329577380227, 3010.9849450752604, 23683.763162368326, 23731.762682373126, 23877.641835372484, 23902.0, 23905.16331928374, 3090.165655273086, 3096.8606412711483, 3123.9219019524694, 3158.3999040182293, 3170.0648308748973, 142482.28758856244, 142635.28682356625, 143416.0, 143604.28197859047, 143896.28051859778, 35005.0, 36490.08079353645, 36545.817270914005, 38376.6162338373, 38413.615863841565, 37896.81051594725, 37947.62052379496, 38106.809465952494, 38156.0, 38245.42631860524, 11079.5568177272, 11317.603883864025, 11318.830217546743, 11329.0, 11351.602693905674, 8769.298456123495, 8807.735767926972, 8815.559222038872, 8829.470231786114, 8830.690925817566, 11650.475728592233, 11714.598507305982, 11806.52773889052, 11811.88188118125, 11900.345480998629, 4942.851714448572, 4981.402231732215, 5051.979208316629, 5078.162103252922, 5112.565431938253, 858.1547176031604, 877.2105105405059, 885.4112015509614, 891.2379915172435, 906.8685040669066, 20627.79372206289, 24425.214598134502, 25109.0, 25178.874105629355, 25329.0, 949.4350861237552, 955.3933252384786, 970.1123472023161, 971.5190980464574, 975.4342481360794, 10908.0, 10978.176636752116, 11140.164487663458, 11246.268992515461, 11299.717507062389, 166844.0, 167260.16369918315, 167462.0, 167583.0, 168311.0, 37084.44373334402, 37424.43863342052, 37466.43800342997, 37517.624823751416, 37594.0, 1138.6868611132004, 1201.129181343519, 1205.2226314027403, 1206.8913797758244, 1237.5792230641625, 19275.8072419274, 19667.114979825656, 20115.19539218415, 20216.19135234574, 20568.074436650088, 29094.41811163807, 29261.414771704873, 29379.85310073436, 29394.0, 29427.264318392212, 147516.0, 147681.26159369564, 147888.26055870083, 148191.25904370408, 148335.0, 27070.458590828468, 27151.185464436097, 27469.587956180272, 28452.715472845008, 28881.566776497948, 33743.662563374055, 34218.65781342254, 34315.0, 34414.13964650904, 34903.82548087243, 25903.740962590135, 26169.476610467304, 26661.200163995112, 27084.864575677784, 27573.586396204475, 26051.348716282246, 26980.865095674395, 27130.0, 27832.63422609101, 28420.715792841806, 29043.419131616825, 29077.273068173465, 29427.705722942497, 29600.407991840475, 29805.0, 26129.080637904466, 26445.0, 26596.069137580093, 26863.73136268612, 27482.587761183197, 20373.0, 21865.0, 21984.45038873977, 22078.33764987053, 22119.66820497726], "value": 13997.74328421241, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.6208750037467, 423.69855514032037, 429.3859780513865, 434.81737670178524, 439.21380728495996, 16939.15304234788, 16946.66481543922, 17086.658266834685, 17472.912635436838, 17517.29930802768, 17715.0, 17895.105244737744, 18473.7228941566, 19102.426927192173, 19233.61532769344, 5563.610547261694, 5573.303337082864, 5605.495505404513, 5677.43225677431, 5684.261046064006, 5568.52667523261, 5648.519875810561, 5649.265595472582, 5649.6327738697055, 5649.830505084854, 5403.540699040586, 5566.693831839248, 5585.1063829787245, 5585.469380408855, 5611.775528978836, 5460.781568737246, 5535.58483113766, 5561.6663000220115, 5565.359983601877, 5579.497845193911, 5003.924941125886, 5057.317262169597, 5061.367329083864, 5080.415752188509, 5085.0338435697095, 21997.890010550003, 22375.888120559455, 23127.653085203736, 23236.18673346425, 23376.7662323378, 1611.1702473226298, 1638.573970767597, 1640.3028712797134, 1658.6848498785191, 1658.7594798754233, 14466.782998255034, 14540.127592344494, 14905.776413353808, 15091.622709432242, 15233.61915952099, 1978.3965890403422, 2027.1992562937558, 2062.95874082519, 2064.0917996081826, 2073.2950796729033, 82138.0, 86590.56704716437, 90439.0, 95051.9999999993, 98039.0, 11052.613158539412, 11324.377159256155, 11354.0, 11613.709657258636, 11731.706707332214, 15991.520254392386, 16017.279222435018, 16019.279132439067, 16027.038377697376, 16030.118343490987, 7657.310842024244, 7868.567228802471, 7914.24814642608, 8048.396370272253, 8058.597070146469, 6689.832754181184, 6695.397414232742, 6885.518013739091, 6934.133233345832, 7032.050673159058, 7067.89398159028, 7196.856062878713, 7231.132264128339, 7253.709851605982, 7281.781546553612, 2093.905774240163, 2095.402810199086, 2105.3473423238843, 2120.194326156082, 2239.3170083124805, 830.8047608811925, 838.1576515601781, 852.6930305090162, 871.3203701113142, 881.5195718333396, 17244.89591873475, 17480.91259543694, 17560.29758809659, 17611.295548178186, 18140.90929545344, 883.5317281840506, 884.8318819424418, 887.0597167002998, 889.2485849457198, 907.1336873285996, 9088.818223635622, 9413.199878010446, 9591.184749296248, 9641.42151470914, 9731.56207970643, 361087.0, 363086.0, 363150.0, 373942.0, 379420.0, 76206.6189669048, 79151.0, 79215.20784792193, 81196.59401702954, 81728.59135704284, 1068.529846867376, 1082.7888561730545, 1103.6302838549177, 1108.6507750058868, 1115.6039605939936, 17255.3960611378, 17569.385071522436, 17894.28422863123, 18406.447806565826, 18692.719609206146, 38165.618343816204, 38715.41926871156, 38933.610663893, 39555.40666890056, 39623.40564891587, 48914.75542622264, 49182.508174919225, 49315.0, 49748.50251497584, 50097.24854127118, 8257.42198046155, 8259.21537453941, 8443.535605541754, 8512.233898949124, 8529.232369086812, 9810.411375317504, 12460.439280232593, 12620.0, 12803.935980320039, 13151.342432878126, 9789.804203915739, 10360.171186305228, 10809.729756756144, 10845.511951962339, 11097.056750176003, 9495.382800118246, 9982.500874956368, 10060.647877324258, 10118.08937195656, 10174.440405777754, 10438.63464778729, 10553.0, 10613.469326533797, 10845.620403285848, 11019.283746556448, 8257.463264887763, 8383.119772423808, 8440.324774017941, 8504.362172836938, 8519.74440766778, 11282.210245282751, 11285.605003824827, 11497.195196336175, 11602.419879006186, 11722.355270460206], "value": 8923.970046719804, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1256.7423678145979, 1313.1792629606496, 1316.078744878584, 1316.690577714237, 1318.531921167985, 9788.755281117976, 10262.127719143873, 10300.58797648095, 10519.579216831336, 10813.297135686194, 10543.261971661987, 10707.089897358714, 10707.143428525718, 10725.678229653124, 10770.761362443322, 2273.2157405695007, 2319.7332306784683, 2333.731620863597, 2335.2994101769486, 2345.2026311054237, 2261.570301642691, 2294.231432470116, 2298.321995011476, 2298.5058212484314, 2318.594246006942, 2196.9560608787892, 2206.580749657568, 2259.8418110732173, 2263.0, 2276.0781883337277, 2111.767705552388, 2128.531723020933, 2161.3515945216373, 2167.0, 2170.0885628036262, 2140.2188201306412, 2191.5178660694783, 2229.487217939883, 2292.426893276681, 2304.9654255186188, 10114.140298074672, 10288.794224115476, 10304.278700490968, 10308.742281442948, 10315.535800888978, 5576.581756368248, 5768.567357448208, 5782.10377391505, 5786.218860453827, 5790.507806836382, 3427.7600567960253, 3542.946855797165, 3673.0633688409553, 3751.1747415568802, 3764.9811750941344, 1151.8502594662723, 1165.7843298989715, 1188.5542921404474, 1189.4112414354863, 1211.9697007574794, 15211.0, 15377.000494967791, 15555.144467054308, 15574.532764016983, 15595.0, 5234.895302093937, 5366.409694933554, 5460.126379779216, 5487.2317875497465, 5521.5306698930235, 12813.0, 12929.159604625669, 12943.223406595635, 12950.935245323713, 12962.416691248916, 5924.6149000314845, 5961.552883533665, 5992.670403127782, 6001.729922153513, 6009.1587177795145, 5155.329807125125, 5267.683938963674, 5302.151655735064, 5309.177077552986, 5343.171808369709, 4267.957320426756, 4294.978525107417, 4346.6088052075465, 4431.335299705005, 4454.799534020977, 1271.281725824906, 1285.3380509037852, 1310.0567591334225, 1316.776148054833, 1324.1988596898736, 683.3132701634925, 701.5895701014862, 703.6868593475956, 719.1980941250469, 720.8486217894196, 5320.281761962163, 5437.700926449004, 5460.6177567570685, 5467.1799230115, 5541.556675465953, 541.8130744893006, 561.6293246457318, 562.5808772464541, 566.396787421395, 568.0315062817886, 3350.6816852398983, 3522.8590856365972, 3683.8710645127826, 3746.213295208037, 3777.0, 13366.26485543285, 13550.93224533871, 13799.379027943767, 13833.0, 13835.0, 13166.868331316757, 13419.798703019462, 13580.117292375964, 13634.386452609459, 13706.109102908278, 7209.855802883913, 7234.891476627855, 7360.484766066324, 7440.218777028443, 7449.366803821736, 5605.747741351731, 5724.055530837365, 5825.50483208932, 5853.912191317048, 6041.124037014696, 11928.0, 11932.22440541362, 12017.218880772722, 12046.337451440255, 12139.817902731289, 12038.217515861441, 12109.939450302692, 12226.266424014231, 12324.383780811102, 12468.438920248793, 8336.083030866721, 8486.787830304293, 8528.616212270339, 8569.485830849919, 8600.526971016654, 9626.133647971716, 9712.368696034735, 9720.319577629498, 9740.220782337254, 9758.219342452729, 8189.181081891763, 8301.377396695392, 8404.243618074403, 8407.747767566983, 8544.57277136153, 8168.754937351889, 8206.876896846672, 8233.259006689426, 8308.501489910625, 8380.455270407649, 7445.478816483011, 7525.36034437079, 7576.090869095744, 7662.9654996574745, 7665.846683066419, 5225.425203227718, 5228.503292187236, 5274.261603375454, 5319.547838433622, 5362.0, 5076.746162691925, 5143.794248230029, 5357.383900851452, 5357.732113394237, 5386.811461598825], "value": 4836.229655890453, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.88809245318856, 390.22345532390534, 392.952845658521, 396.23526593674205, 398.084405866507, 5526.58550608704, 5558.61089723719, 5597.412271711472, 5612.354579223391, 5681.7727290908415, 5433.565314774818, 5574.749136288867, 5574.804881829137, 5584.776608935637, 5589.189567512708, 4259.850905218318, 4350.586059530649, 4370.125974805036, 4391.0559229765595, 4410.955890441102, 4382.882364996922, 4405.383246345515, 4408.735475871442, 4411.250087485135, 4411.933820992672, 4373.846915357964, 4382.0797632497215, 4382.145481631083, 4392.253316936112, 4396.692231543793, 4341.804618792146, 4365.738055716635, 4399.182894730297, 4410.404595379631, 4412.492563355223, 3938.8424463021443, 3939.940900886489, 3965.7620542767236, 3970.920581588381, 3979.925420136547, 5424.484673955968, 5455.236266922634, 5469.644473109235, 5488.313960754906, 5489.231507588941, 5124.282600435942, 5170.121079416508, 5191.532762051434, 5221.0, 5234.502722241381, 5892.882142357172, 5913.314705308966, 5922.052471604523, 5926.0, 5936.168936348915, 4481.798319075617, 4488.3940668010055, 4497.145542346976, 4505.346724724896, 4506.5493450655, 5992.161097446361, 6047.365026672224, 6174.536909731743, 6267.811965641038, 6268.091126786636, 4340.82636694535, 4348.717333373321, 4376.431063961664, 4392.956070439319, 4395.604395604411, 4441.378207051015, 4441.9333709993725, 4450.643948484114, 4465.397171381822, 4474.619657329164, 5008.248762685554, 5013.242716505907, 5022.698638081727, 5024.447310795809, 5192.324997750268, 5911.793087242012, 5932.19915311436, 5947.732352044169, 5957.195778569924, 6009.308929473079, 1630.502696677501, 1657.411618875306, 1658.8507034366964, 1662.534490342706, 1665.8500734933914, 1185.6739396665987, 1189.0903458853984, 1194.7431302270054, 1196.126827415991, 1216.635009497165, 5122.0, 5144.254083157921, 5162.1224391853475, 5162.348048624404, 5195.558377537876, 6093.75624974996, 6107.236595425572, 6116.938830611637, 6124.223975047275, 6129.632222066691, 4963.329950456714, 5034.496550344937, 5098.949010509921, 5114.769835357418, 5117.257997590403, 3149.370125974814, 3217.6299725531394, 3218.2598002459567, 3229.6124465064345, 3244.0105767741065, 5347.545458635982, 5550.27846379968, 5573.383718721525, 5584.832455026356, 5624.55003599711, 6247.0, 6269.529785266123, 6286.654234017173, 6299.716512756937, 6306.432421082125, 5621.8594535136945, 5627.437256274504, 5641.182028605911, 5649.717514124195, 5653.321601407857, 5822.340632919598, 6090.330063693079, 6118.21621162379, 6125.693715314127, 6129.172561704291, 5986.2217911671205, 5991.281046274301, 5998.490128338965, 6010.368911264429, 6032.245969253843, 5407.0, 5559.27729395176, 5610.382857885547, 5640.984622767777, 5643.843012182575, 4120.423140760356, 4142.689298302579, 4158.979205104076, 4161.812718427738, 4168.166366726606, 5990.6705131218205, 6081.908771368521, 6093.75624974996, 6148.466380257625, 6149.169862068564, 5900.055991041413, 5909.674967876636, 5917.556183286357, 5925.9407405925385, 5932.614380065282, 5838.591298609056, 5877.73628669838, 5888.705564721832, 5895.64626122434, 5903.789723106839, 5670.149477578231, 5707.889200385716, 5724.484796368347, 5736.340320863154, 5763.5965482417505, 5893.44012318829, 5923.644581325134, 5936.257967754031, 5946.970265148647, 5948.910766338422, 5604.971975140098, 5721.256236689203, 5732.799352022659, 5740.90922724681, 5745.052066408995], "value": 4502.276753944931, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.2839488905985, 739.6745432009918, 749.7600767754319, 750.7372419653123, 755.9697612095516, 11806.881931180686, 12203.145779795417, 13149.539766108188, 13935.233562154077, 14036.0, 14994.0, 15497.612559685986, 15508.224588770545, 15571.98782079164, 15593.0, 856.8800367948477, 874.3748220022683, 877.6928075173702, 879.9648014079429, 881.5548148185158, 871.8125602995354, 879.4415546128223, 880.6477409036405, 881.6253092435721, 883.730462209026, 935.3686261773275, 946.4321407155686, 948.3172116076414, 949.8290307744603, 950.2635457520443, 926.0970553710113, 934.4206591912989, 934.7663084228943, 936.5879013234223, 938.1041105744066, 683.8392977650249, 693.3240090911371, 693.6046453521495, 693.7329128285646, 700.0304578159236, 13563.45746170152, 13716.0, 13762.518311859138, 14313.928430357886, 14429.484904085024, 15473.226338683133, 15577.688446231012, 15733.68532629341, 15975.201239937956, 15985.520434386986, 12519.624411267676, 12666.303353315563, 12764.936175319157, 12785.488580456864, 12900.290484023375, 2857.514222582166, 2893.3345330573875, 2899.652041754982, 2900.44891470622, 2907.912762617125, 66041.66979165122, 66116.0, 66174.0, 67114.66442667755, 68105.3189468104, 10632.574697012033, 10799.78400431987, 10893.0, 10912.127029837595, 11010.0, 17535.47393578169, 17600.823991760175, 17642.64714705699, 20927.581448371253, 21077.578448430944, 6210.472109870711, 6347.174867267226, 6383.1382763326355, 6390.9360906391275, 6409.0, 2917.0519581136214, 2974.018573870661, 2980.0463851567292, 2982.41842840644, 2985.8357790321743, 3502.5972013218297, 3563.625819288989, 3577.3024260269517, 3593.4250519916686, 3610.693091087287, 735.797655644702, 754.9018627578489, 757.8408534207878, 759.5898214963858, 761.8285885675679, 532.3079996005177, 536.975836087377, 539.5629540072475, 540.3461811208482, 541.6939429222476, 9772.804543909224, 9839.508024598741, 9865.753356166153, 10278.743031424274, 10434.269601127848, 583.9182514447981, 584.5469760935309, 592.4164697772691, 593.6378808926552, 599.6821684507219, 4468.218061839165, 4597.057603191338, 4625.606823419979, 4660.86017419478, 4677.2750223715375, 61532.69233653803, 62754.0, 63533.68233158897, 65234.34765652283, 65908.6704566474, 55448.168277475874, 55501.444985550435, 56420.153697694564, 57365.713171433876, 57460.71269643625, 51191.48808511942, 51476.99999999925, 51564.48435515672, 51989.48010519922, 53935.46064539383, 9320.254379649476, 9366.157045865904, 9449.338546301968, 9453.0, 9796.314258001872, 26793.19620411391, 27583.0, 27827.0, 28070.43859122847, 28204.15387538377, 32222.677773222906, 32723.0, 33011.66988330086, 33478.66521334756, 33810.49284260787, 12049.879501204876, 12274.079444041554, 12337.876621234032, 12433.37833108323, 12456.81314780261, 16210.18949052519, 16574.0, 16650.50048498547, 16941.745873811655, 17006.744898826775, 14060.929695351459, 15459.61350966235, 15750.606234844221, 15853.207339633203, 16251.024938503728, 15716.76424853651, 15855.572998430196, 15877.841221587636, 15926.362945482515, 15928.28322725457, 15431.691366172838, 15594.9220253898, 15653.0, 15929.203539823195, 16039.679206415572, 9865.852012219966, 9970.351927125004, 10121.493925303852, 10222.080012798884, 10312.432816195182, 11915.165938384576, 12360.320182390054, 12560.874391255971, 12602.24386536774, 12625.936870315956], "value": 6803.07135657946, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 111.0, 112.0, 111.0, 111.0, 111.0, 113.0, 110.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 124.0, 173.0, 127.0, 128.0, 126.0, 125.0, 146.0, 125.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 166.0, 166.0, 168.0, 166.0, 164.0, 163.0, 166.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 114.0, 77.0, 77.0, 84.0, 78.0, 92.0, 77.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 102.0, 84.0, 83.0, 82.0, 95.0, 84.0, 83.0, 109.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 117.0, 114.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 149.0, 151.0, 151.0, 150.0, 150.0, 150.0, 152.0, 150.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 97.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 61.0, 56.0, 56.0, 54.0, 55.0, 55.0, 57.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 57.0, 56.0, 55.0, 55.0, 55.0, 55.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 82.0, 85.0, 91.0, 83.0, 84.0, 84.0, 84.0, 82.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 141.0, 134.0, 145.0, 142.0, 143.0, 135.0, 137.0, 188.0, 137.0], "value": 144.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 206.0, 198.0, 194.0, 195.0, 196.0, 197.0, 194.0, 199.0, 195.0], "value": 196.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 74.0, 74.0, 73.0, 72.0, 77.0, 76.0, 76.0], "value": 74.3, "unit": "score"}]}]} 07:01:14 INFO - Return code: 0 07:01:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:01:14 INFO - # TBPL SUCCESS # 07:01:14 INFO - Running post-action listener: _resource_record_post_action 07:01:14 INFO - [mozharness: 2017-05-12 14:01:14.552366Z] Finished run-tests step (success) 07:01:14 INFO - Running post-run listener: _resource_record_post_run 07:01:14 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 7827456; Write bytes: 379142144; Read time: 1408; Write time: 229772 07:01:14 INFO - TinderboxPrint: CPU usage
13.3% 07:01:14 INFO - TinderboxPrint: I/O read bytes / time
7,827,456 / 1,408 07:01:14 INFO - TinderboxPrint: I/O write bytes / time
379,142,144 / 229,772 07:01:14 INFO - TinderboxPrint: CPU idle
8,311.3 (86.7%) 07:01:14 INFO - TinderboxPrint: CPU user
1,215.5 (12.7%) 07:01:14 INFO - TinderboxPrint: Swap in / out
0 / 0 07:01:14 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 120360960; Read time: 0; Write time: 64448 07:01:14 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 5480448; Write bytes: 258781184; Read time: 976; Write time: 165324 07:01:15 INFO - Running post-run listener: _upload_blobber_files 07:01:15 INFO - Blob upload gear active. 07:01:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:01:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:01:15 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'] 07:01:15 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 07:01:15 INFO - (blobuploader) - INFO - Open directory for files ... 07:01:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:01:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:01:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:01:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:01:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:01:16 INFO - (blobuploader) - INFO - Done attempting. 07:01:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:01:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:01:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:01:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:01:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:01:20 INFO - (blobuploader) - INFO - Done attempting. 07:01:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:01:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:01:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:01:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:01:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:01:21 INFO - (blobuploader) - INFO - Done attempting. 07:01:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:01:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:01:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:01:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:01:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:01:22 INFO - (blobuploader) - INFO - Done attempting. 07:01:22 INFO - (blobuploader) - INFO - Iteration through files over. 07:01:22 INFO - Return code: 0 07:01:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:01:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:01:22 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a24abac2127be66b4bb55bf8061fa420a4c91c4e1b122a1d42e2a7b01f75654b4c4b3048ae6335f2042a0c23fa3129b77edd9ebe0ce4330d803902ecce57277", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3990be4ea03df4d757814faee523d948670a045248f1b8dd65c2bdd758813972ca3bdae8c1751bffa330b9d8ef3a99100743231ceceb1c0c93f9eb0a14bc3c5c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dbedfdb5022b02b0b9436e1f5d4442d466276db9db2dd3712028fa06002a5584871ccd78b3107f68630c513c135a204a141b501a1ad612aeaaff7839d9fded53", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d62d51ad9d045140b5422167f98666889cc6d51547da8851b41c894df5d94e0e638ca3c92efc8e151d747b106e98d4725d5b8e6475bf6d1bc86480eb7f9e586"} 07:01:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:01:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:01:22 INFO - Contents: 07:01:22 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a24abac2127be66b4bb55bf8061fa420a4c91c4e1b122a1d42e2a7b01f75654b4c4b3048ae6335f2042a0c23fa3129b77edd9ebe0ce4330d803902ecce57277", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3990be4ea03df4d757814faee523d948670a045248f1b8dd65c2bdd758813972ca3bdae8c1751bffa330b9d8ef3a99100743231ceceb1c0c93f9eb0a14bc3c5c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dbedfdb5022b02b0b9436e1f5d4442d466276db9db2dd3712028fa06002a5584871ccd78b3107f68630c513c135a204a141b501a1ad612aeaaff7839d9fded53", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d62d51ad9d045140b5422167f98666889cc6d51547da8851b41c894df5d94e0e638ca3c92efc8e151d747b106e98d4725d5b8e6475bf6d1bc86480eb7f9e586"} 07:01:22 INFO - Running post-run listener: copy_logs_to_upload_dir 07:01:22 INFO - Copying logs to upload dir... 07:01:22 INFO - mkdir: /builds/slave/test/build/upload/logs 07:01:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.644911 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-05-12 07:01:22.538767) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 07:01:22.543002) ========= 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=20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a24abac2127be66b4bb55bf8061fa420a4c91c4e1b122a1d42e2a7b01f75654b4c4b3048ae6335f2042a0c23fa3129b77edd9ebe0ce4330d803902ecce57277", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3990be4ea03df4d757814faee523d948670a045248f1b8dd65c2bdd758813972ca3bdae8c1751bffa330b9d8ef3a99100743231ceceb1c0c93f9eb0a14bc3c5c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dbedfdb5022b02b0b9436e1f5d4442d466276db9db2dd3712028fa06002a5584871ccd78b3107f68630c513c135a204a141b501a1ad612aeaaff7839d9fded53", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d62d51ad9d045140b5422167f98666889cc6d51547da8851b41c894df5d94e0e638ca3c92efc8e151d747b106e98d4725d5b8e6475bf6d1bc86480eb7f9e586"} build_url:https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011167 build_url: 'https://queue.taskcluster.net/v1/task/A4OXc7j_SrifIR5xeHyHBQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a24abac2127be66b4bb55bf8061fa420a4c91c4e1b122a1d42e2a7b01f75654b4c4b3048ae6335f2042a0c23fa3129b77edd9ebe0ce4330d803902ecce57277", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3990be4ea03df4d757814faee523d948670a045248f1b8dd65c2bdd758813972ca3bdae8c1751bffa330b9d8ef3a99100743231ceceb1c0c93f9eb0a14bc3c5c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dbedfdb5022b02b0b9436e1f5d4442d466276db9db2dd3712028fa06002a5584871ccd78b3107f68630c513c135a204a141b501a1ad612aeaaff7839d9fded53", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d62d51ad9d045140b5422167f98666889cc6d51547da8851b41c894df5d94e0e638ca3c92efc8e151d747b106e98d4725d5b8e6475bf6d1bc86480eb7f9e586"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 07:01:22.567951) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 07:01:22.568284) ========= 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=20e20d796406ba5117c4a6f1000001ba-1494596420.223324-691243798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004420 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 07:01:22.651369) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 07:01:22.653697) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 07:01:22.653995) ========= ========= Total master_lag: 0.18 =========