builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-004 starttime: 1495812987.5 results: success (0) revision: 9104506c0a5eaac89b6c22c804c83ccee7d6e662 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:27.504952) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:27.505458) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:27.505735) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:27.527841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:27.528222) ========= 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=c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-26 08:36:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2017-05-26 08:36:27 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.147185 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:27.688395) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:27.688705) ========= 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=c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018545 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:27.741775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-26 08:36:27.742149) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9104506c0a5eaac89b6c22c804c83ccee7d6e662 --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 9104506c0a5eaac89b6c22c804c83ccee7d6e662 --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=c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-26 08:36:27,702 truncating revision to first 12 chars 2017-05-26 08:36:27,702 Setting DEBUG logging. 2017-05-26 08:36:27,702 attempt 1/10 2017-05-26 08:36:27,702 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9104506c0a5e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-26 08:36:28,817 unpacking tar archive at: mozilla-central-9104506c0a5e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.511709 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-26 08:36:29.390632) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:29.390958) ========= script_repo_revision: 9104506c0a5eaac89b6c22c804c83ccee7d6e662 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:29.391346) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:29.391622) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-26 08:36:29.407813) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2017-05-26 08:36:29.408179) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:36:29 INFO - MultiFileLogger online at 20170526 08:36:29 in /builds/slave/test 08:36:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:36:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:36:29 INFO - {'append_to_log': False, 08:36:29 INFO - 'base_work_dir': '/builds/slave/test', 08:36:29 INFO - 'blob_upload_branch': 'Firefox', 08:36:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:36:29 INFO - 'branch': 'Firefox', 08:36:29 INFO - 'buildbot_json_path': 'buildprops.json', 08:36:29 INFO - 'config_files': ('talos/linux_config.py',), 08:36:29 INFO - 'default_actions': ('clobber', 08:36:29 INFO - 'read-buildbot-config', 08:36:29 INFO - 'download-and-extract', 08:36:29 INFO - 'populate-webroot', 08:36:29 INFO - 'create-virtualenv', 08:36:29 INFO - 'install', 08:36:29 INFO - 'run-tests'), 08:36:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:36:29 INFO - 'download_minidump_stackwalk': True, 08:36:29 INFO - 'download_symbols': 'ondemand', 08:36:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:36:29 INFO - 'tooltool.py': '/tools/tooltool.py', 08:36:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:36:29 INFO - '/tools/misc-python/virtualenv.py')}, 08:36:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:36:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:36:29 INFO - 'gecko_profile': False, 08:36:29 INFO - 'gecko_profile_interval': 0, 08:36:29 INFO - 'installer_path': 'installer.exe', 08:36:29 INFO - 'log_level': 'info', 08:36:29 INFO - 'log_name': 'talos', 08:36:29 INFO - 'log_to_console': True, 08:36:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:36:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:36:29 INFO - 'opt_config_files': (), 08:36:29 INFO - 'pip_index': False, 08:36:29 INFO - 'suite': 'dromaeojs-e10s', 08:36:29 INFO - 'system_bits': '32', 08:36:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:36:29 INFO - 'title': 'talos-linux64-ix-004', 08:36:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:36:29 INFO - 'use_talos_json': True, 08:36:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:36:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:36:29 INFO - 'work_dir': 'build'} 08:36:29 INFO - [mozharness: 2017-05-26 15:36:29.463731Z] Running clobber step. 08:36:29 INFO - Running pre-action listener: _resource_record_pre_action 08:36:29 INFO - Running main action method: clobber 08:36:29 INFO - rmtree: /builds/slave/test/build 08:36:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:36:30 INFO - Running post-action listener: _resource_record_post_action 08:36:30 INFO - [mozharness: 2017-05-26 15:36:30.487216Z] Finished clobber step (success) 08:36:30 INFO - [mozharness: 2017-05-26 15:36:30.487317Z] Running read-buildbot-config step. 08:36:30 INFO - Running pre-action listener: _resource_record_pre_action 08:36:30 INFO - Running main action method: read_buildbot_config 08:36:30 INFO - Using buildbot properties: 08:36:30 INFO - { 08:36:30 INFO - "project": "", 08:36:30 INFO - "product": "firefox", 08:36:30 INFO - "who": "cbook@mozilla.com", 08:36:30 INFO - "installer_path": "public/build/target.tar.bz2", 08:36:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 08:36:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:36:30 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 08:36:30 INFO - "stage_platform": "linux64-stylosequential", 08:36:30 INFO - "basedir": "/builds/slave/test", 08:36:30 INFO - "buildnumber": 26, 08:36:30 INFO - "platform": "ubuntu64_hw_styloseq", 08:36:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:36:30 INFO - "slavebuilddir": "test", 08:36:30 INFO - "taskId": "XiFGzeRMQG2HxRpfRYUDFw", 08:36:30 INFO - "branch": "mozilla-central", 08:36:30 INFO - "script_repo_revision": "production", 08:36:30 INFO - "revision": "9104506c0a5eaac89b6c22c804c83ccee7d6e662", 08:36:30 INFO - "slavename": "talos-linux64-ix-004", 08:36:30 INFO - "repo_path": "mozilla-central" 08:36:30 INFO - } 08:36:30 INFO - Finding installer, test and symbols from parent task. 08:36:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XiFGzeRMQG2HxRpfRYUDFw'}, attempt #1 08:36:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XiFGzeRMQG2HxRpfRYUDFw'}, attempt #1 08:36:31 INFO - Task dependencies: Gr7t4aqqQ4283WRlslzqMw 08:36:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw'}, attempt #1 08:36:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.tar.bz2 08:36:31 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/test_packages.json 08:36:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.crashreporter-symbols.zip 08:36:31 INFO - Running post-action listener: _resource_record_post_action 08:36:31 INFO - [mozharness: 2017-05-26 15:36:31.844506Z] Finished read-buildbot-config step (success) 08:36:31 INFO - [mozharness: 2017-05-26 15:36:31.844726Z] Running download-and-extract step. 08:36:31 INFO - Running pre-action listener: _resource_record_pre_action 08:36:31 INFO - Running main action method: download_and_extract 08:36:31 INFO - mkdir: /builds/slave/test/build/tests 08:36:31 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')]} 08:36:31 INFO - trying https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.test_packages.json 08:36:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:36:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:36:32 INFO - Downloaded 986 bytes. 08:36:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:36:32 INFO - Using the following test package requirements: 08:36:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:36:32 INFO - u'common': [u'target.common.tests.zip'], 08:36:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:36:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:36:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:36:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:36:32 INFO - u'mozbase': [u'target.common.tests.zip'], 08:36:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:36:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:36:32 INFO - u'web-platform': [u'target.common.tests.zip', 08:36:32 INFO - u'target.web-platform.tests.zip'], 08:36:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:36:32 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:36:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.common.tests.zip 08:36:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:36:32 INFO - Fetch https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.common.tests.zip into memory 08:36:33 INFO - Content-Length response header: 63525236 08:36:33 INFO - Bytes received: 63525236 08:36:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:36:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.common.tests.zip 08:36:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:36:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.common.tests.zip into memory 08:36:45 INFO - Content-Length response header: 63525236 08:36:45 INFO - Bytes received: 63525236 08:36:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.talos.tests.zip 08:36:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:36:57 INFO - Fetch https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.talos.tests.zip into memory 08:36:58 INFO - Content-Length response header: 14411888 08:36:58 INFO - Bytes received: 14411888 08:36:58 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')]} 08:36:58 INFO - trying https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.tar.bz2 08:36:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:36:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:36:59 INFO - Downloaded 55889332 bytes. 08:36:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.tar.bz2 08:36:59 INFO - mkdir: /builds/slave/test/properties 08:36:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:36:59 INFO - Writing to file /builds/slave/test/properties/build_url 08:36:59 INFO - Contents: 08:36:59 INFO - build_url:https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.tar.bz2 08:36:59 INFO - Running post-action listener: _resource_record_post_action 08:36:59 INFO - Running post-action listener: set_extra_try_arguments 08:36:59 INFO - [mozharness: 2017-05-26 15:36:59.663740Z] Finished download-and-extract step (success) 08:36:59 INFO - [mozharness: 2017-05-26 15:36:59.663852Z] Running populate-webroot step. 08:36:59 INFO - Running pre-action listener: _resource_record_pre_action 08:36:59 INFO - Running main action method: populate_webroot 08:36:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:36:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:36:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:36:59 INFO - '--tppagecycles', 08:36:59 INFO - '7'], 08:36:59 INFO - 'tests': ['tsvgm']}}, 08:36:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:36:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:36:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:36:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:36:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:36:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:36:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:36:59 INFO - 'talos_options': ['--disable-e10s'], 08:36:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:36:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:36:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:36:59 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:36:59 INFO - 'talos_options': ['--disable-e10s'], 08:36:59 INFO - 'tests': ['damp', 'tps']}, 08:36:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:36:59 INFO - 'tests': ['damp', 'tps']}, 08:36:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:36:59 INFO - 'tests': ['dromaeo_dom']}, 08:36:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:36:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:36:59 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:36:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:36:59 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:36:59 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:36:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:36:59 INFO - 'tests': ['a11yr', 08:36:59 INFO - 'ts_paint', 08:36:59 INFO - 'tpaint', 08:36:59 INFO - 'sessionrestore', 08:36:59 INFO - 'sessionrestore_no_auto_restore', 08:36:59 INFO - 'tabpaint']}, 08:36:59 INFO - 'other-e10s': {'tests': ['a11yr', 08:36:59 INFO - 'ts_paint', 08:36:59 INFO - 'tpaint', 08:36:59 INFO - 'sessionrestore', 08:36:59 INFO - 'sessionrestore_no_auto_restore', 08:36:59 INFO - 'tabpaint']}, 08:36:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:36:59 INFO - 'ts_paint', 08:36:59 INFO - 'tpaint', 08:36:59 INFO - 'sessionrestore', 08:36:59 INFO - 'sessionrestore_no_auto_restore', 08:36:59 INFO - 'tabpaint']}, 08:36:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:36:59 INFO - 'ts_paint', 08:36:59 INFO - 'tpaint', 08:36:59 INFO - 'sessionrestore', 08:36:59 INFO - 'sessionrestore_no_auto_restore', 08:36:59 INFO - 'tabpaint']}, 08:36:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:36:59 INFO - 'tests': ['a11yr', 08:36:59 INFO - 'ts_paint', 08:36:59 INFO - 'tpaint', 08:36:59 INFO - 'sessionrestore', 08:36:59 INFO - 'sessionrestore_no_auto_restore', 08:36:59 INFO - 'tabpaint']}, 08:36:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:36:59 INFO - 'tests': ['a11yr', 08:36:59 INFO - 'ts_paint', 08:36:59 INFO - 'tpaint', 08:36:59 INFO - 'sessionrestore', 08:36:59 INFO - 'sessionrestore_no_auto_restore', 08:36:59 INFO - 'tabpaint']}, 08:36:59 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:36:59 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:36:59 INFO - 'bloom_basic_ref']}, 08:36:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:36:59 INFO - 'tests': ['tsvgx', 08:36:59 INFO - 'tsvgr_opacity', 08:36:59 INFO - 'tart', 08:36:59 INFO - 'tscrollx', 08:36:59 INFO - 'cart', 08:36:59 INFO - 'tsvg_static']}, 08:36:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:36:59 INFO - 'tsvgr_opacity', 08:36:59 INFO - 'tart', 08:36:59 INFO - 'tscrollx', 08:36:59 INFO - 'cart', 08:36:59 INFO - 'tsvg_static']}, 08:36:59 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:36:59 INFO - 'talos_options': ['--disable-e10s'], 08:36:59 INFO - 'tests': ['tp5o']}, 08:36:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:36:59 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:36:59 INFO - 'talos_options': ['--disable-e10s', 08:36:59 INFO - '--xperf_path', 08:36:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:36:59 INFO - 'tests': ['tp5n']}, 08:36:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:36:59 INFO - 'talos_options': ['--xperf_path', 08:36:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:36:59 INFO - 'tests': ['tp5n']}}, 08:36:59 INFO - 'talos.zip': {'path': '', 08:36:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:36:59 INFO - Running post-action listener: _resource_record_post_action 08:36:59 INFO - [mozharness: 2017-05-26 15:36:59.679217Z] Finished populate-webroot step (success) 08:36:59 INFO - [mozharness: 2017-05-26 15:36:59.679306Z] Running create-virtualenv step. 08:36:59 INFO - Running pre-action listener: _resource_record_pre_action 08:36:59 INFO - Running main action method: create_virtualenv 08:36:59 INFO - Creating virtualenv /builds/slave/test/build/venv 08:36:59 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 08:36:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:36:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:36:59 INFO - Using real prefix '/usr' 08:36:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:37:00 INFO - Installing distribute.............................................................................................................................................................................................done. 08:37:02 INFO - Installing pip.................done. 08:37:02 INFO - Return code: 0 08:37:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:37:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:37:02 INFO - Reading from file tmpfile_stdout 08:37:02 INFO - Output received: 08:37:02 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) 08:37:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:37:02 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')]} 08:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:02 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')]} 08:37:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:02 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 0x260a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297d5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297a7a0>, '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 0x297b6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297bb30>, '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': 'c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671', '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 08:37:02 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 08:37:02 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 08:37:02 INFO - Using env: {'DISPLAY': ':0', 08:37:02 INFO - 'HOME': '/home/cltbld', 08:37:02 INFO - 'LANG': 'en_US.UTF-8', 08:37:02 INFO - 'LANGUAGE': 'en_US:en', 08:37:02 INFO - 'LOGNAME': 'cltbld', 08:37:02 INFO - 'MAIL': '/var/mail/cltbld', 08:37:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:02 INFO - 'MOZ_NO_REMOTE': '1', 08:37:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:02 INFO - 'NO_EM_RESTART': '1', 08:37:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:02 INFO - 'PWD': '/builds/slave/test', 08:37:02 INFO - 'SHELL': '/bin/bash', 08:37:02 INFO - 'SHLVL': '1', 08:37:02 INFO - 'TERM': 'linux', 08:37:02 INFO - 'TMOUT': '86400', 08:37:02 INFO - 'USER': 'cltbld', 08:37:02 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671', 08:37:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:02 INFO - '_': '/tools/buildbot/bin/python'} 08:37:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:02 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 08:37:02 INFO - Cleaning up... 08:37:02 INFO - Return code: 0 08:37:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:37:02 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')]} 08:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:02 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')]} 08:37:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:02 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 0x260a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297d5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297a7a0>, '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 0x297b6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297bb30>, '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': 'c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671', '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 08:37:02 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 08:37:02 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 08:37:02 INFO - Using env: {'DISPLAY': ':0', 08:37:02 INFO - 'HOME': '/home/cltbld', 08:37:02 INFO - 'LANG': 'en_US.UTF-8', 08:37:02 INFO - 'LANGUAGE': 'en_US:en', 08:37:02 INFO - 'LOGNAME': 'cltbld', 08:37:02 INFO - 'MAIL': '/var/mail/cltbld', 08:37:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:02 INFO - 'MOZ_NO_REMOTE': '1', 08:37:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:02 INFO - 'NO_EM_RESTART': '1', 08:37:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:02 INFO - 'PWD': '/builds/slave/test', 08:37:02 INFO - 'SHELL': '/bin/bash', 08:37:02 INFO - 'SHLVL': '1', 08:37:02 INFO - 'TERM': 'linux', 08:37:02 INFO - 'TMOUT': '86400', 08:37:02 INFO - 'USER': 'cltbld', 08:37:02 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671', 08:37:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:02 INFO - '_': '/tools/buildbot/bin/python'} 08:37:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:02 INFO - Downloading/unpacking psutil>=3.1.1 08:37: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 08:37: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 08:37: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 08:37: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 08:37:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:37:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:37:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:37:04 INFO - Installing collected packages: psutil 08:37:04 INFO - Running setup.py install for psutil 08:37:04 INFO - building 'psutil._psutil_linux' extension 08:37:04 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 08:37:04 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 08:37:04 INFO - building 'psutil._psutil_posix' extension 08:37:04 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 08:37:04 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 08:37:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:37:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:37:04 INFO - Successfully installed psutil 08:37:04 INFO - Cleaning up... 08:37:04 INFO - Return code: 0 08:37:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:37:04 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')]} 08:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:04 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')]} 08:37:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:04 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 0x260a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297d5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297a7a0>, '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 0x297b6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297bb30>, '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': 'c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671', '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 08:37:04 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 08:37:04 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 08:37:04 INFO - Using env: {'DISPLAY': ':0', 08:37:04 INFO - 'HOME': '/home/cltbld', 08:37:04 INFO - 'LANG': 'en_US.UTF-8', 08:37:04 INFO - 'LANGUAGE': 'en_US:en', 08:37:04 INFO - 'LOGNAME': 'cltbld', 08:37:04 INFO - 'MAIL': '/var/mail/cltbld', 08:37:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:04 INFO - 'MOZ_NO_REMOTE': '1', 08:37:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:04 INFO - 'NO_EM_RESTART': '1', 08:37:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:04 INFO - 'PWD': '/builds/slave/test', 08:37:04 INFO - 'SHELL': '/bin/bash', 08:37:04 INFO - 'SHLVL': '1', 08:37:04 INFO - 'TERM': 'linux', 08:37:04 INFO - 'TMOUT': '86400', 08:37:04 INFO - 'USER': 'cltbld', 08:37:04 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671', 08:37:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:04 INFO - '_': '/tools/buildbot/bin/python'} 08:37:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:37: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 08:37: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 08:37: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 08:37: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 08:37:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:37:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:37:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:37:06 INFO - Installing collected packages: mozsystemmonitor 08:37:06 INFO - Running setup.py install for mozsystemmonitor 08:37:06 INFO - Successfully installed mozsystemmonitor 08:37:06 INFO - Cleaning up... 08:37:06 INFO - Return code: 0 08:37:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:37: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')]} 08:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37: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')]} 08:37:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x260a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297d5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297a7a0>, '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 0x297b6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297bb30>, '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': 'c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671', '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 08:37:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:37:06 INFO - Using env: {'DISPLAY': ':0', 08:37:06 INFO - 'HOME': '/home/cltbld', 08:37:06 INFO - 'LANG': 'en_US.UTF-8', 08:37:06 INFO - 'LANGUAGE': 'en_US:en', 08:37:06 INFO - 'LOGNAME': 'cltbld', 08:37:06 INFO - 'MAIL': '/var/mail/cltbld', 08:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:06 INFO - 'MOZ_NO_REMOTE': '1', 08:37:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:06 INFO - 'NO_EM_RESTART': '1', 08:37:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:06 INFO - 'PWD': '/builds/slave/test', 08:37:06 INFO - 'SHELL': '/bin/bash', 08:37:06 INFO - 'SHLVL': '1', 08:37:06 INFO - 'TERM': 'linux', 08:37:06 INFO - 'TMOUT': '86400', 08:37:06 INFO - 'USER': 'cltbld', 08:37:06 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671', 08:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:06 INFO - '_': '/tools/buildbot/bin/python'} 08:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:06 INFO - Downloading/unpacking jsonschema==2.5.1 08:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:37:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:37:07 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 08:37:07 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 08:37:07 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 08:37:07 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 08:37:07 INFO - Downloading functools32-3.2.3-2.tar.gz 08:37:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:37:07 INFO - warning: no files found matching '*.txt' 08:37:07 INFO - no previously-included directories found matching 'build' 08:37:07 INFO - no previously-included directories found matching 'dist' 08:37:07 INFO - no previously-included directories found matching '.git*' 08:37:07 INFO - Installing collected packages: jsonschema, functools32 08:37:07 INFO - Running setup.py install for functools32 08:37:07 INFO - warning: no files found matching '*.txt' 08:37:07 INFO - no previously-included directories found matching 'build' 08:37:07 INFO - no previously-included directories found matching 'dist' 08:37:07 INFO - no previously-included directories found matching '.git*' 08:37:07 INFO - Successfully installed jsonschema functools32 08:37:07 INFO - Cleaning up... 08:37:07 INFO - Return code: 0 08:37:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:37:07 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')]} 08:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:07 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')]} 08:37:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x260a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297d5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297a7a0>, '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 0x297b6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297bb30>, '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': 'c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671', '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 08:37:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:37:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:37:08 INFO - Using env: {'DISPLAY': ':0', 08:37:08 INFO - 'HOME': '/home/cltbld', 08:37:08 INFO - 'LANG': 'en_US.UTF-8', 08:37:08 INFO - 'LANGUAGE': 'en_US:en', 08:37:08 INFO - 'LOGNAME': 'cltbld', 08:37:08 INFO - 'MAIL': '/var/mail/cltbld', 08:37:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:08 INFO - 'MOZ_NO_REMOTE': '1', 08:37:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:08 INFO - 'NO_EM_RESTART': '1', 08:37:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:08 INFO - 'PWD': '/builds/slave/test', 08:37:08 INFO - 'SHELL': '/bin/bash', 08:37:08 INFO - 'SHLVL': '1', 08:37:08 INFO - 'TERM': 'linux', 08:37:08 INFO - 'TMOUT': '86400', 08:37:08 INFO - 'USER': 'cltbld', 08:37:08 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671', 08:37:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:08 INFO - '_': '/tools/buildbot/bin/python'} 08:37:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:37:08 INFO - Cleaning up... 08:37:08 INFO - Return code: 0 08:37:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x260a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297d5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297a7a0>, '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 0x297b6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297bb30>, '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': 'c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671', '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 08:37:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:37:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:37:08 INFO - Using env: {'DISPLAY': ':0', 08:37:08 INFO - 'HOME': '/home/cltbld', 08:37:08 INFO - 'LANG': 'en_US.UTF-8', 08:37:08 INFO - 'LANGUAGE': 'en_US:en', 08:37:08 INFO - 'LOGNAME': 'cltbld', 08:37:08 INFO - 'MAIL': '/var/mail/cltbld', 08:37:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:08 INFO - 'MOZ_NO_REMOTE': '1', 08:37:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:08 INFO - 'NO_EM_RESTART': '1', 08:37:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:08 INFO - 'PWD': '/builds/slave/test', 08:37:08 INFO - 'SHELL': '/bin/bash', 08:37:08 INFO - 'SHLVL': '1', 08:37:08 INFO - 'TERM': 'linux', 08:37:08 INFO - 'TMOUT': '86400', 08:37:08 INFO - 'USER': 'cltbld', 08:37:08 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671', 08:37:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:08 INFO - '_': '/tools/buildbot/bin/python'} 08:37:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:08 INFO - Downloading/unpacking blobuploader==1.2.4 08:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:09 INFO - Downloading blobuploader-1.2.4.tar.gz 08:37:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:37:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:37:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:10 INFO - Downloading docopt-0.6.1.tar.gz 08:37:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:37:10 INFO - Installing collected packages: blobuploader, requests, docopt 08:37:10 INFO - Running setup.py install for blobuploader 08:37:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:37:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:37:10 INFO - Running setup.py install for requests 08:37:10 INFO - Running setup.py install for docopt 08:37:10 INFO - Successfully installed blobuploader requests docopt 08:37:10 INFO - Cleaning up... 08:37:10 INFO - Return code: 0 08:37:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:10 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 0x260a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297d5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297a7a0>, '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 0x297b6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297bb30>, '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': 'c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671', '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 08:37:10 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 08:37:10 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 08:37:10 INFO - Using env: {'DISPLAY': ':0', 08:37:10 INFO - 'HOME': '/home/cltbld', 08:37:10 INFO - 'LANG': 'en_US.UTF-8', 08:37:10 INFO - 'LANGUAGE': 'en_US:en', 08:37:10 INFO - 'LOGNAME': 'cltbld', 08:37:10 INFO - 'MAIL': '/var/mail/cltbld', 08:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:10 INFO - 'MOZ_NO_REMOTE': '1', 08:37:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:10 INFO - 'NO_EM_RESTART': '1', 08:37:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:10 INFO - 'PWD': '/builds/slave/test', 08:37:10 INFO - 'SHELL': '/bin/bash', 08:37:10 INFO - 'SHLVL': '1', 08:37:10 INFO - 'TERM': 'linux', 08:37:10 INFO - 'TMOUT': '86400', 08:37:10 INFO - 'USER': 'cltbld', 08:37:10 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671', 08:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:10 INFO - '_': '/tools/buildbot/bin/python'} 08:37:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:37:11 INFO - Running setup.py (path:/tmp/pip-i0R8L2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:37:11 INFO - Running setup.py (path:/tmp/pip-eZrNod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:37:11 INFO - Running setup.py (path:/tmp/pip-Sq8RRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:37:11 INFO - Running setup.py (path:/tmp/pip-tc0erA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:37:11 INFO - Running setup.py (path:/tmp/pip-eWh7kB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:37:11 INFO - Running setup.py (path:/tmp/pip-Yu0tK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:37:11 INFO - Running setup.py (path:/tmp/pip-4SOrAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:37:11 INFO - Running setup.py (path:/tmp/pip-aYaHm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:37:11 INFO - Running setup.py (path:/tmp/pip-BzY9gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:37:11 INFO - Running setup.py (path:/tmp/pip-apunAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:37:11 INFO - Running setup.py (path:/tmp/pip-pXRe96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:37:11 INFO - Running setup.py (path:/tmp/pip-yDHyKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:37:11 INFO - Running setup.py (path:/tmp/pip-Mxvq7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:37:11 INFO - Running setup.py (path:/tmp/pip-Mr_SQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:37:12 INFO - Running setup.py (path:/tmp/pip-effq30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:37:12 INFO - Running setup.py (path:/tmp/pip-R6Evsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:37:12 INFO - Running setup.py (path:/tmp/pip-FNcDDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:37:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:37:12 INFO - Running setup.py install for manifestparser 08:37:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:37:12 INFO - Running setup.py install for mozcrash 08:37:12 INFO - Running setup.py install for mozdebug 08:37:12 INFO - Running setup.py install for mozdevice 08:37:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:37:12 INFO - Running setup.py install for mozfile 08:37:12 INFO - Running setup.py install for mozhttpd 08:37:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:37:12 INFO - Running setup.py install for mozinfo 08:37:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:37:12 INFO - Running setup.py install for mozInstall 08:37:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:37:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:37:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:37:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:37:13 INFO - Running setup.py install for mozleak 08:37:13 INFO - Running setup.py install for mozlog 08:37:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:37:13 INFO - Running setup.py install for moznetwork 08:37:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:37:13 INFO - Running setup.py install for mozprocess 08:37:13 INFO - Running setup.py install for mozprofile 08:37:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:37:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:37:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:37:13 INFO - Running setup.py install for mozrunner 08:37:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:37:13 INFO - Running setup.py install for mozscreenshot 08:37:13 INFO - Running setup.py install for moztest 08:37:13 INFO - Running setup.py install for mozversion 08:37:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:37:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:37:14 INFO - Cleaning up... 08:37:14 INFO - Return code: 0 08:37:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:14 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 0x260a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297d5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297a7a0>, '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 0x297b6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297bb30>, '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': 'c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671', '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 08:37:14 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 08:37:14 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 08:37:14 INFO - Using env: {'DISPLAY': ':0', 08:37:14 INFO - 'HOME': '/home/cltbld', 08:37:14 INFO - 'LANG': 'en_US.UTF-8', 08:37:14 INFO - 'LANGUAGE': 'en_US:en', 08:37:14 INFO - 'LOGNAME': 'cltbld', 08:37:14 INFO - 'MAIL': '/var/mail/cltbld', 08:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:14 INFO - 'MOZ_NO_REMOTE': '1', 08:37:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:14 INFO - 'NO_EM_RESTART': '1', 08:37:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:14 INFO - 'PWD': '/builds/slave/test', 08:37:14 INFO - 'SHELL': '/bin/bash', 08:37:14 INFO - 'SHLVL': '1', 08:37:14 INFO - 'TERM': 'linux', 08:37:14 INFO - 'TMOUT': '86400', 08:37:14 INFO - 'USER': 'cltbld', 08:37:14 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671', 08:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:14 INFO - '_': '/tools/buildbot/bin/python'} 08:37:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:37:14 INFO - Running setup.py (path:/tmp/pip-dMq16p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:37:14 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)) 08:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:37:14 INFO - Running setup.py (path:/tmp/pip-WLKJav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:37:14 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)) 08:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:37:14 INFO - Running setup.py (path:/tmp/pip-uLzDSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:37:14 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)) 08:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:37:14 INFO - Running setup.py (path:/tmp/pip-3gH1XW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 08:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:37:14 INFO - Running setup.py (path:/tmp/pip-rQLIaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:37:14 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)) 08:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:37:14 INFO - Running setup.py (path:/tmp/pip-OxFsjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:37:14 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)) 08:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:37:14 INFO - Running setup.py (path:/tmp/pip-R6__mG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:37:14 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)) 08:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:37:14 INFO - Running setup.py (path:/tmp/pip-vr64W2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:37:14 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)) 08:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:37:14 INFO - Running setup.py (path:/tmp/pip-l3vwJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:37:14 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)) 08:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:37:14 INFO - Running setup.py (path:/tmp/pip-3UTnUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:37:14 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)) 08:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:37:14 INFO - Running setup.py (path:/tmp/pip-lIUILU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:37:15 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)) 08:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:37:15 INFO - Running setup.py (path:/tmp/pip-ZjzNZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:37:15 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)) 08:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:37:15 INFO - Running setup.py (path:/tmp/pip-V_vX29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:37:15 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)) 08:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:37:15 INFO - Running setup.py (path:/tmp/pip-nSN6Sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:37:15 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)) 08:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:37:15 INFO - Running setup.py (path:/tmp/pip-YM8RJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:37:15 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)) 08:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:37:15 INFO - Running setup.py (path:/tmp/pip-YaP1n8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:37:15 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)) 08:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:37:15 INFO - Running setup.py (path:/tmp/pip-iXte4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:37:15 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)) 08:37:15 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)) 08:37:15 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)) 08:37:15 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)) 08:37:15 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:37:15 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:37:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:16 INFO - Downloading blessings-1.6.tar.gz 08:37:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:37:16 INFO - Installing collected packages: blessings 08:37:16 INFO - Running setup.py install for blessings 08:37:16 INFO - Successfully installed blessings 08:37:16 INFO - Cleaning up... 08:37:16 INFO - Return code: 0 08:37:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:37:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:37:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:37:17 INFO - Reading from file tmpfile_stdout 08:37:17 INFO - Current package versions: 08:37:17 INFO - argparse == 1.2.1 08:37:17 INFO - blessings == 1.6 08:37:17 INFO - blobuploader == 1.2.4 08:37:17 INFO - docopt == 0.6.1 08:37:17 INFO - functools32 == 3.2.3-2 08:37:17 INFO - jsonschema == 2.5.1 08:37:17 INFO - manifestparser == 1.1 08:37:17 INFO - mozInstall == 1.12 08:37:17 INFO - mozcrash == 1.0 08:37:17 INFO - mozdebug == 0.1 08:37:17 INFO - mozdevice == 0.51 08:37:17 INFO - mozfile == 1.2 08:37:17 INFO - mozhttpd == 0.7 08:37:17 INFO - mozinfo == 0.9 08:37:17 INFO - mozleak == 0.1 08:37:17 INFO - mozlog == 3.4 08:37:17 INFO - moznetwork == 0.27 08:37:17 INFO - mozprocess == 0.25 08:37:17 INFO - mozprofile == 0.28 08:37:17 INFO - mozrunner == 6.13 08:37:17 INFO - mozscreenshot == 0.1 08:37:17 INFO - mozsystemmonitor == 0.3 08:37:17 INFO - moztest == 0.8 08:37:17 INFO - mozversion == 1.4 08:37:17 INFO - psutil == 3.1.1 08:37:17 INFO - requests == 1.2.3 08:37:17 INFO - wsgiref == 0.1.2 08:37:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:37:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:17 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 0x260a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297d5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297a7a0>, '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 0x297b6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297bb30>, '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': 'c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671', '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 08:37:17 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 08:37:17 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 08:37:17 INFO - Using env: {'DISPLAY': ':0', 08:37:17 INFO - 'HOME': '/home/cltbld', 08:37:17 INFO - 'LANG': 'en_US.UTF-8', 08:37:17 INFO - 'LANGUAGE': 'en_US:en', 08:37:17 INFO - 'LOGNAME': 'cltbld', 08:37:17 INFO - 'MAIL': '/var/mail/cltbld', 08:37:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:17 INFO - 'MOZ_NO_REMOTE': '1', 08:37:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:17 INFO - 'NO_EM_RESTART': '1', 08:37:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:17 INFO - 'PWD': '/builds/slave/test', 08:37:17 INFO - 'SHELL': '/bin/bash', 08:37:17 INFO - 'SHLVL': '1', 08:37:17 INFO - 'TERM': 'linux', 08:37:17 INFO - 'TMOUT': '86400', 08:37:17 INFO - 'USER': 'cltbld', 08:37:17 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671', 08:37:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:17 INFO - '_': '/tools/buildbot/bin/python'} 08:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:17 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)) 08:37:17 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)) 08:37:17 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)) 08:37:17 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)) 08:37:17 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)) 08:37:17 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)) 08:37:17 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)) 08:37:17 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)) 08:37:17 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)) 08:37:17 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:18 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:37:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:37:18 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)) 08:37:18 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)) 08:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:37:18 INFO - Installing collected packages: marionette-driver 08:37:18 INFO - Running setup.py install for marionette-driver 08:37:18 INFO - Successfully installed marionette-driver 08:37:18 INFO - Cleaning up... 08:37:18 INFO - Return code: 0 08:37:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297d5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297a7a0>, '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 0x297b6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297bb30>, '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': 'c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671', '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 08:37:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:37:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:37:18 INFO - Using env: {'DISPLAY': ':0', 08:37:18 INFO - 'HOME': '/home/cltbld', 08:37:18 INFO - 'LANG': 'en_US.UTF-8', 08:37:18 INFO - 'LANGUAGE': 'en_US:en', 08:37:18 INFO - 'LOGNAME': 'cltbld', 08:37:18 INFO - 'MAIL': '/var/mail/cltbld', 08:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:18 INFO - 'MOZ_NO_REMOTE': '1', 08:37:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:18 INFO - 'NO_EM_RESTART': '1', 08:37:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:18 INFO - 'PWD': '/builds/slave/test', 08:37:18 INFO - 'SHELL': '/bin/bash', 08:37:18 INFO - 'SHLVL': '1', 08:37:18 INFO - 'TERM': 'linux', 08:37:18 INFO - 'TMOUT': '86400', 08:37:18 INFO - 'USER': 'cltbld', 08:37:18 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671', 08:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:18 INFO - '_': '/tools/buildbot/bin/python'} 08:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:37:18 INFO - Cleaning up... 08:37:18 INFO - Return code: 0 08:37:18 INFO - Running post-action listener: _resource_record_post_action 08:37:18 INFO - Running post-action listener: _start_resource_monitoring 08:37:18 INFO - Starting resource monitoring. 08:37:18 INFO - [mozharness: 2017-05-26 15:37:18.820954Z] Finished create-virtualenv step (success) 08:37:18 INFO - [mozharness: 2017-05-26 15:37:18.821535Z] Running install step. 08:37:18 INFO - Running pre-action listener: _resource_record_pre_action 08:37:18 INFO - Running main action method: install 08:37:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:37:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:37:19 INFO - Reading from file tmpfile_stdout 08:37:19 INFO - Detecting whether we're running mozinstall >=1.0... 08:37:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:37:19 INFO - Reading from file tmpfile_stdout 08:37:19 INFO - Output received: 08:37:19 INFO - Usage: mozinstall [options] installer 08:37:19 INFO - Options: 08:37:19 INFO - -h, --help show this help message and exit 08:37:19 INFO - -d DEST, --destination=DEST 08:37:19 INFO - Directory to install application into. [default: 08:37:19 INFO - "/builds/slave/test"] 08:37:19 INFO - --app=APP Application being installed. [default: firefox] 08:37:19 INFO - mkdir: /builds/slave/test/build/application 08:37:19 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'] 08:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:37:35 INFO - Reading from file tmpfile_stdout 08:37:35 INFO - Output received: 08:37:35 INFO - /builds/slave/test/build/application/firefox/firefox 08:37:35 INFO - Running post-action listener: _resource_record_post_action 08:37:35 INFO - [mozharness: 2017-05-26 15:37:35.094356Z] Finished install step (success) 08:37:35 INFO - [mozharness: 2017-05-26 15:37:35.094592Z] Running run-tests step. 08:37:35 INFO - Running pre-action listener: _resource_record_pre_action 08:37:35 INFO - Running main action method: run_tests 08:37:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:37:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:37:35 INFO - Python 2.7.3 08:37:35 INFO - Return code: 0 08:37:35 INFO - grabbing minidump binary from tooltool 08:37:35 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')]} 08:37:35 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 0x297a7a0>, '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 0x297b6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297bb30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:37:35 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 08:37:35 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 08:37:35 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 08:37:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:37:35 INFO - Return code: 0 08:37:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:37:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:37:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:37:35 INFO - ENV: RUST_BACKTRACE is now 1 08:37:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:37:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:37:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 08:37:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 08:37:35 INFO - Using env: {'DISPLAY': ':0', 08:37:35 INFO - 'HOME': '/home/cltbld', 08:37:35 INFO - 'LANG': 'en_US.UTF-8', 08:37:35 INFO - 'LANGUAGE': 'en_US:en', 08:37:35 INFO - 'LOGNAME': 'cltbld', 08:37:35 INFO - 'MAIL': '/var/mail/cltbld', 08:37:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:37:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:35 INFO - 'MOZ_NO_REMOTE': '1', 08:37:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:37:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:35 INFO - 'NO_EM_RESTART': '1', 08:37:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:35 INFO - 'PWD': '/builds/slave/test', 08:37:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:37:35 INFO - 'RUST_BACKTRACE': '1', 08:37:35 INFO - 'SHELL': '/bin/bash', 08:37:35 INFO - 'SHLVL': '1', 08:37:35 INFO - 'TERM': 'linux', 08:37:35 INFO - 'TMOUT': '86400', 08:37:35 INFO - 'USER': 'cltbld', 08:37:35 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671', 08:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:35 INFO - '_': '/tools/buildbot/bin/python'} 08:37:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 08:37:35 INFO - mozversion application_buildid: 20170526145708 08:37:35 INFO - mozversion application_changeset: 9104506c0a5eaac89b6c22c804c83ccee7d6e662 08:37:35 INFO - mozversion application_display_name: Nightly 08:37:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:37:35 INFO - mozversion application_name: Firefox 08:37:35 INFO - mozversion application_remotingname: firefox 08:37:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:37:35 INFO - mozversion application_vendor: Mozilla 08:37:35 INFO - mozversion application_version: 55.0a1 08:37:35 INFO - mozversion platform_buildid: 20170526145708 08:37:35 INFO - mozversion platform_changeset: 9104506c0a5eaac89b6c22c804c83ccee7d6e662 08:37:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:37:35 INFO - mozversion platform_version: 55.0a1 08:37:35 INFO - using testdate: 1495813055 08:37:35 INFO - actual date: 1495813055 08:37:35 INFO - starting webserver on 'localhost:49919' 08:37:35 INFO - SUITE-START | Running 2 tests 08:37:35 INFO - TEST-START | dromaeo_css 08:37:35 INFO - operating with platform_type : linux_ 08:37:35 INFO - Initialising browser for dromaeo_css test... 08:37:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49919/getInfo.html -profile /tmp/tmpCXulVV/profile 08:37:35 INFO - TEST-INFO | started process 25308 (/builds/slave/test/build/application/firefox/firefox http://localhost:49919/getInfo.html) 08:38:10 INFO - TEST-INFO | 25308: killed by SIGTERM 08:38:10 INFO - Browser initialized. 08:38:10 INFO - Running cycle 1/1 for dromaeo_css test... 08:38:10 INFO - TEST-INFO | started process 25532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCXulVV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:38:22 INFO - PID 25532 | RSS: Main: 172220416 08:38:22 INFO - PID 25532 | 08:41:27 INFO - PID 25532 | Cycle 1(1): loaded http://localhost:49919/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49919/tests/dromaeo/cssquery-ext.html) 08:41:28 INFO - PID 25532 | RSS: Main: 170987520 08:41:28 INFO - PID 25532 | 08:44:30 INFO - PID 25532 | Cycle 1(1): loaded http://localhost:49919/tests/dromaeo/cssquery-ext.html (next: http://localhost:49919/tests/dromaeo/cssquery-jquery.html) 08:44:31 INFO - PID 25532 | RSS: Main: 176459776 08:44:31 INFO - PID 25532 | 08:47:33 INFO - PID 25532 | Cycle 1(1): loaded http://localhost:49919/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49919/tests/dromaeo/cssquery-mootools.html) 08:47:33 INFO - PID 25532 | RSS: Main: 176738304 08:47:33 INFO - PID 25532 | 08:50:35 INFO - PID 25532 | Cycle 1(1): loaded http://localhost:49919/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49919/tests/dromaeo/cssquery-prototype.html) 08:50:36 INFO - PID 25532 | RSS: Main: 179687424 08:50:36 INFO - PID 25532 | 08:53:39 INFO - PID 25532 | Cycle 1(1): loaded http://localhost:49919/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49919/tests/dromaeo/cssquery-yui.html) 08:53:39 INFO - PID 25532 | RSS: Main: 179716096 08:53:39 INFO - PID 25532 | 08:56:41 INFO - PID 25532 | Cycle 1(1): loaded http://localhost:49919/tests/dromaeo/cssquery-yui.html (next: http://localhost:49919/tests/dromaeo/cssquery-dojo.html) 08:56:41 INFO - PID 25532 | RSS: Main: 175939584 08:56:41 INFO - PID 25532 | 08:56:41 INFO - PID 25532 | __start_tp_report 08:56:41 INFO - PID 25532 | _x_x_mozilla_page_load 08:56:41 INFO - PID 25532 | _x_x_mozilla_page_load_details 08:56:41 INFO - PID 25532 | |i|pagename|runs| 08:56:41 INFO - PID 25532 | |0;dojo.html;2708.4447688223913;2737.288305040689;2737.603047558104;2758.503469375513;2779.9722002779977;5256.027634887549;5314.043472175012;5364.678119312839;5384.246205531229;5393.217983392406;5313.282706834576;5326.067938110835;5345.572354211664;5416.295881535405;5445.891082178354;4676.97661511692;4677.812887484513;4689.038747056862;4707.12918110149;4727.243641017438;4662.696924699901;4745.857624271277;4758.476567577563;4770.117528257266;4799;4620.537946205386;4663.44038715353;4668.533146685304;4673.065386922629;4765.070811191819;4675.859724208279;4702.764861756898;4743.596794272491;4774.618030557547;4787.234042553209;4702.600278976257;4716.103940251342;4721.24460086388;4730.935539503618;4780.952190478086;5292.708901010443;5300.575953923677;5355.518003379676;5359.464053594648;5393.083175860113;5661.7735290588325;5747.396523365028;5778.508826749731;5854;5868.354481007086;5839.124131380285;5840.912386314209;5868.559858010623;5888.322842873082;5920.171176035358;5418.891622167574;5426.9185962210595;5429.67421954684;5446.400895901447;5446.809361672323;5864.912026319608;5954.583179177416;5966.194563733927;5974.581779275496;5979.521638268928;5668.773249069991;5710.71446427677;5728.283964504437;5739.282589676291;5764.308283006066;5658.575606829504;5738.340090889517;5738.426157384311;5753.1370294456165;5772.62477938941;5693.686847223443;5698.00284950132;5725.055365864669;5729;5733.312002559636;5688.345840228344;5697.629654072555;5702.657840529581;5752.309722833287;5773.278340207474;4802.111609352281;4804.519548045238;4812.951870481321;4854.296127061556;4857.587105096036;4112.773797441109;4127.422160897477;4164.604362585549;4165.396017577435;4188.308929026676;4831.371921650163;4831.710097394168;4847.927281090787;4923;4938.802447902043;5831.708414579339;5850.3272123705465;5868;5868.178455016301;5888.381719919433;4862.95137048632;4876.853694389174;4884.584810291094;4886.193778026657;4921.434035086011;4961.7519124044375;5089.440161582223;5130.230465430215;5142.485751424828;5144.897102058013;5274.760431298719;5364.275822763877;5376.112941364631;5391.622586418913;5453.863653408696;5699.857503562444;5792.160136780228;5828.446297601721;5876.324222714272;5889.6171748837905;5331.093714068696;5331.120365139708;5357.598180136428;5390.51485366319;5426.972865135807;5661.971690141523;5702;5703.942960570507;5707.600467967202;5756.30924289088;5724.513416359489;5797.971010144923;5799.072148456226;5812.94187058141;5813.505852002627;5609.943900561106;5610.859728506657;5683.090705487102;5704.657720536781;5712.11462223356;5705.7432415542235;5708.058170401837;5708.372079071381;5716.9428305718075;5750.424957504383;5561.054620714407;5611.242482264842;5623.156526521055;5634.042212823748;5648;5543.307086614173;5548.445155484419;5671.744771485211;5689.857753556194;5724.885502289848;5531.502164805026;5549.694766787866;5554.08357620988;5565.332160140809;5569.025420551468 08:56:41 INFO - PID 25532 | |1;ext.html;679.4768028617964;733.4792297468797;746.7274444827636;1052.0426411965113;1062.0706881478707;32193.19517012073;32891.83554082226;32923.341533169325;32936.17659558512;33008.66991330086;33955.83022084886;34012.14969625755;34066;34179.31641367171;34520.65479345206;6576.6382848943285;6767.627780472072;6839.316068393171;6996.70560946224;6998.965005174992;6795.490338224628;6906.171259448874;6912.239653638096;6915;6918.377346038856;6896.793096207097;6939.548929319603;6940.618265995394;6946.861062778741;6952.965235173817;6825.692843822015;6842;6845.110135682379;6870.587764734132;6872.862542749117;6733.562318449334;6774.695138718769;6783.050372947791;6797.2523022467485;6801.285864984205;31279.68720312813;31495.055148345586;31498.685013149803;31580.684193158235;31637.683623163703;3036.089173248039;3068.202267410467;3070.8003979741247;3073.738732207765;3083.1367217179;24499.632505512433;24589.262322130366;24596.385090372703;24614.384640383956;24699;2967.198856308806;2974.9851250743823;2976.3154474470775;2998;3001.729844314022;148863;153431;153582.23208883885;154019;154136;38834.80582597069;38897.222055559294;38981.61018389837;39003.60996390056;39042.609573903894;40213.39679904804;40220.79889600533;40293.79853100716;40356.19287614231;40407.39388909169;12456.875431245753;12535.498580056696;12576.937115314548;12603.621891343275;12661;10087.344322619007;10095.192384609214;10106.545205465773;10108.595656173671;10108.646197383056;12478.75042499145;12553.309567973849;12579.622611321674;12580.937095314464;12766.234025958287;5329.520343169133;5337.386200586982;5344.251804747339;5388.865278368072;5456.181572764117;859.282499113235;900.6397441023512;909.4452384045727;909.6406919266852;931.2875650127658;20666.17335306601;21274.149034038775;21345.466363341042;21511.901072646302;21769.346919592437;962.9181519570775;981.4945303168873;991.9702408927744;996.4419924842111;1001.0440029771696;10843.186760992958;11085.445727713583;11121.277116987532;11391.601293954673;11526.769464610828;157975;160393.19803400908;161090;161504.19247903686;176082;43618.56381436208;43886;44072.55927440685;44107.77946110249;44313.11373772571;1193.2065176657425;1239.1387985350095;1241.4475558376437;1245.302630526908;1247.2017908538542;24146;24582.631260531463;25099.372515687253;25539;25563.616545751458;29818.55272170876;29932.401351972403;29950;30060.398792024476;30159.69840301569;157287.41700664148;158697;159015;159558.40441595434;159870;28802.567961480174;28829.423411532072;28877.7112228875;30327.848360758057;30460.695393046673;36732;36909.81545092365;37091.6290837099;37094.62905370912;37265.62734372621;26320.736792632593;26773.866130669223;27036.59445108364;27992.160235192976;28410.715892840806;27300.286279899254;27490;27691.307717306423;28596.571051433828;28983.13050608485;30471.390572188877;30508;30997.380052399276;31102.066937991898;31105.37789244157;26750.866245668647;26980.865095674395;27278.454430910875;27482.312942176606;28049.158525244275;19607.509812254808;21408.78591214068;21620.67568986498;21821.56356872822;21884.23405180811 08:56:41 INFO - PID 25532 | |2;jquery.html;409.1285561753465;413.72280572016746;428.51791734298916;436.6245029274824;441.24987521213944;13165.539206127787;17423.564410889736;17877.821221787777;18185.909070454647;18200.90899545502;18426.72359914599;18599.814001859977;19020.429387118373;19166.904165479187;19376.321828735996;5354.9196762048605;5358.732063396834;5371.865703357418;5567.8886422271535;5598.776048958037;5209.062368773619;5235.397929238148;5270.499302566269;5273.314469119009;5281;5152.845414637567;5208.791648334062;5220.060389129955;5224.973875130638;5255.947440525584;5168.664036837594;5304.045271851065;5306;5311.336082989607;5328.3605967284175;4780.067886762083;4794.113089078532;4820.951790482085;4845.757712114416;4864.416270047617;22451.32646020622;23140.19009334682;23190.53618927612;23285.417864553354;23313.067477300887;1586.8413158684154;1611.371565089616;1613.1127879666253;1633.0936330336658;1633.3711521064356;14709.485168019068;14837.925810370987;14994.250287485582;15341.769873451907;15378;1991.6912878503856;2042.6221149087467;2069.6585063464663;2076.418602791221;2081.2299449203742;91065;92523.53738231333;92806.53596732041;93039;95262.5236873818;10972.396518191417;10987.340759554452;11087.390193539271;11292.435378231055;11540.307581545134;15353.6161595961;15495.845041549666;15506.224688765516;15568.532944011698;15570.676492498038;7668.5782281975025;7820.765377038698;7971.681132754741;7973.641186146638;8021.5187088774865;7119;7143.92856071443;7170.211276759553;7383.520071195355;7404.703811847574;6930.475295434996;7046.823829404306;7160.391366733782;7189.712411503586;7311.561306321638;2014.8891810950538;2041.3773798991451;2045.1121818852953;2065.514604068043;2121.628714974873;825.2325337436122;849.163573879728;877.7015814623059;882.3117967984982;887.1616322575104;16898.74651880223;16950.660986780196;17009.064501452292;17307;17718.46844594664;867.4925168776336;869.1569177897429;874.8915114573847;876.7983363826355;881.9955900220586;9170.44977301364;9216.235129461269;9517.619295228113;9521.23830093591;9589.465685490288;350553;355368;357650;358216;358692;77101.22898771052;77519.61240193763;78746;79147.60426197833;79647.60176199197;998.9300748947504;1005.5826831864695;1042.8070806900748;1047.539082803564;1052.5368837711383;14458.493952711604;14732.337044832793;14843.367229604952;14907.478238261609;15537.378504859678;39103.60896391114;39752.80123599479;39783.204335913695;40227.19545609013;40587.594124059564;47787.84954677118;48972;49555.25667115068;50443.243351349025;51536.484635154666;8114.7278761946745;8267.421280510307;8274.420790544604;8290.295324897452;8299.834003319778;12893.806592901301;13128.409221584861;13237.735245295233;13351.732965340832;13505.257210853497;10464.058234758908;10540.156787456832;10993.560257589927;11069;11189.608363707232;10052.195824334181;10294.897051029693;10367.688969330931;10382.636607718694;10495.370277783357;10742.3017503862;10924.945375273073;11027.61403350879;11288.604898828502;11485.310881347146;8074.500136948828;8150.673973041249;8191.590420479071;8204.343652507905;8256.669733210845;10732;10770.299930504492;10868.836967445653;10891.618793342512;11243.49404276826 08:56:41 INFO - PID 25532 | |3;mootools.html;1266.5693664154187;1302.8501722301937;1324.7284306717124;1324.7747882859912;1325.9801102983452;10439.68680939572;10876.401797901111;10936.890631093687;10966.506507207176;11288.943555282232;10929.672109836698;11074.947879951413;11079.279846809972;11085;11115.554977852868;2235.10595761695;2247;2262.321303608919;2265.6035193841094;2266.795988361047;2186.049068655132;2227.6324406472913;2243.057915675412;2248.55028994201;2250.696156018933;2135.3273718778537;2176.260071575664;2183.0721943174167;2183.9235626753066;2196.121551379445;2133.9359819205447;2141.9464513387134;2142.464383904024;2149.924752633666;2157.687135365371;2058.1355830551206;2072.0882811562865;2105.599936012168;2171.4896999205175;2178;10536.631217907414;10653.094486968617;10670.893291067068;10673.199510036779;10694.197935154816;5707.429257074301;5900.763969441217;5912.586118971673;5917.260342457193;5921.052631578927;3232.6527497579627;3362.8150451725146;3397.065806903097;3402.727781777452;3424.126847653832;973.5181085362791;978.6476868327396;1000.1398797034544;1047.3035431438084;1065.403374110493;16020.19899005045;16144.59638509035;16212.75680864788;16262.837371626369;16286.10426426558;4784;4818.4217893852265;4964.726940018334;4967.279744437036;4980.601551875914;11549.480273387719;11565.421728913689;11567.363794991355;11614.303141811519;11618.128640352008;5567.888642227133;5791.8552036199435;5793.2179155814265;5799.594028417971;5802.100674395476;5051.1413059779925;5232.502912223333;5330.093884039723;5368.4631536846;5380.596455265871;3871.2064026874423;4053.2704113259897;4058.776767277769;4071.3485842265095;4147.854825081168;1139.0716565998684;1154.8094564396781;1158.7740390623917;1162.7151347919814;1173.565780661161;710.928907109285;716.3409663109951;728.8505856299552;733.4865594084163;741.658836935016;5564.610477266552;5670.943290567124;5672.716364181774;5774.769009239667;5806.477417032487;502.0836972525156;519.1693290734794;519.4753299167792;520.5081198267601;520.9114450543417;3374.0721301642243;3705.184859330943;3871.399933010388;3877.43777152317;3896.7272290939363;13492.5277615283;13668.794968075486;13868.306584670727;13892.930535347461;14123.929380353033;13529.458821647024;13864.584062478141;14047.648808779657;14084.15495070299;14091.647708807157;7687;7874.094479134858;7908.130105688369;7910.52536847791;7914.2085791420395;6016.608920420159;6386.552941294251;6398.392152745481;6429.132067170872;6441.194850643669;12474.251544907334;12507.124501285187;12632;12779.808302875279;12803.871961280269;12679.746405072032;12900.645432229856;12947.676308092374;12953.352332383154;13013.804792927924;8817.559122044;8949.418287811532;8955.238804701674;8961.731148065308;8997.190252877272;10024.949875250577;10066.94966525192;10125.544350504393;10181.796364072528;10220.59117635316;8616;8626.482411055356;8680.869786953075;8724.127587241479;8857.64569417242;7844.80387990282;7978.361731061385;7987.600619968862;8021.438499304993;8116.188381162073;7372.778816635509;7632.923670763222;7666.884996724942;7725.188855170126;7761.4178936578855;4903;5293.311869456946;5336.199570064521;5399.271098401666;5432.158015507603;5071.264666623245;5076.213186956028;5157.381114266312;5172.1465958118;5187.481251874782 08:56:41 INFO - PID 25532 | |4;prototype.html;379.40433519374557;383.61255132316353;385.955615104263;388.13252380928617;396.21944768805463;5490.835274941748;5501.972490137548;5506.284183056202;5506.394296627378;5513.751881165347;5305.973470132653;5362.51737343639;5374.973125134369;5375.274337964373;5392.487713667205;4236.4704411948505;4240.385144154088;4242.109157077018;4251.5110762262275;4252.9792849716;4232.619064284214;4235.216484950294;4244.172386384656;4248.044190057228;4248.9575104249025;4115;4203.47456567929;4206.894827629303;4211.410402543646;4234.343676730096;4171.0823618803815;4180.79096045198;4182.477190351206;4218.936715949232;4226.344916537942;3764.849406023783;3769.340365436065;3800.467934489174;3809.7142714296538;3813.809309534512;5188.377394712658;5306.3632364116165;5307.310049693554;5327.547158491533;5340.49265319794;4990.176620857555;5047.823326183566;5048.671836330626;5055.368078990126;5082.161443361841;5803.767849286023;5810.331811841608;5814.563907706939;5815.534757219412;5828.88342233153;4213.5786421357925;4275.0594869128745;4297.613214810682;4324.654027677778;4328.199283132631;5900.1739756434135;5957.8808423831715;5994.760209591611;6027.849303767397;6177.382261773787;4169.249535083653;4182.498100227992;4194;4199.514403045526;4212.831486740557;4120.743173332163;4239.682023848162;4240.660747140221;4242.44848169736;4250.511191212988;4844.370231869905;4870.9269360959615;4881.975590122027;4923.950760492421;4924.704517728876;5861.6225187081;5869.765209391662;5871.3541510433815;5890.1164825276555;5903.173555702205;1415.3206460898825;1442.6898216883421;1459.0880699562774;1461.5030889497623;1468.7943687883705;977.6724797192878;992.8957459466652;1000.2498126405196;1005.9647912323034;1006.6527048168371;5059.443461219263;5062.7468626568525;5064.82273120439;5065.873353166126;5103.2855400244;6028.879422411527;6030.221084780001;6037.1246169305205;6054.547908097227;6058.212432383762;4902.852914412573;4962.156433406258;4975;4982.177940639826;5020.648554601143;3163.3989541987407;3197.3125777957853;3204.013511622809;3209.4864821628894;3213.2006076596713;5514.779408823602;5556.277683901067;5574.470425309589;5587.608867379326;5590.664560126405;5866.413358664185;6160.691965401712;6166.414190651881;6213.2233470816145;6248.28144763349;5584.553235741131;5588.357338905997;5610.607257492018;5612.35457922336;5636.464535869086;5677.347105082803;5974;5980.43185897339;6036.879262414815;6083.209182806207;5798.420157984167;5911.704414779329;5958.34458209588;5972.970135149297;5992.520598352208;5563.888722225452;5565.248691426606;5565.972170139124;5595.972020139873;5640.943590564206;4169.791510424528;4223.28204205292;4223.450951376301;4227.40014890846;4236.343366778155;5926.4666180044005;6064.787732429344;6077.301110372364;6137.202163718688;6155.322914479493;5852.209951656472;5869.4717475427415;5895.494414873748;5900.793472228452;5909.468147866713;5711.5169437338955;5875.500582450369;5883.441073098049;5889.793857214977;5903.140510739104;5733.455321744427;5744.4829965303325;5748.913766293593;5749.195112684311;5786.768529258782;5829.47534721877;5878.794242201502;5906;5917.260342457193;5956.315023772148;5600.047991841316;5629.8592535186945;5649.12438572022;5665.3201615806365;5790.218320526675 08:56:41 INFO - PID 25532 | |5;yui.html;687.5565260407037;689.6965335252487;694.9895751563724;738.9667464964076;771.1401787007488;10575.682729518108;10961.671149865497;13136.080474366787;13732.244726540037;13745.518906838262;14292.85707142931;14689.265536723175;14725.705485890276;14755.409783608642;14904.403823847033;850.9021462531795;898.1467605774541;904.9683261085863;910.622091831889;910.8406028944942;909.2089881802808;912.0241341764282;912.4160537256162;915.1306259053893;919.650532797536;933.0902370189079;938.3994243684048;939.6992962252082;941.8963913969458;944.7826999790018;926.2266007883426;927.6289484206337;934.7055677461578;935.1069728409353;944.5466176235377;686.4405509509734;686.7218776395567;694.2987582541618;697.4211404534225;698.2389195776628;13690;13844.515441959484;13887.02790804634;13911.652208694763;13925.442982280696;15036.323365448472;15422.768658470131;15488.303026363841;15531.378744850306;15825.841741582552;12905.354732263444;13011.479540818356;13157.934210328984;13369;13516.391762370717;3040.3159289159985;3068.6317641882893;3071.339661972664;3072.38552289543;3075.8000729952482;82526;85832.57083714604;85967.42097737078;86702.56648716716;87683;11656.825147622792;11778.587749428729;11857.288562686266;12119.697007574881;12132.69668258283;20463;20912.26807061776;21110.155593776384;21251.574968500852;21256.574868502852;6546.3453654635105;6562.967185164043;6575.309592492815;6605.801825945229;6633.535652504375;2963.5850980862697;3068.202267410489;3114.5016797312323;3168.904932852018;3189.5056266278766;3623.474596183539;3713.814309284525;3723.8510459581853;3725.701943844486;3757.3800322946954;652.4128284543948;675.5203805298294;732.3335764454428;745.7650839985387;748.3451979517922;603.3966033966034;617.8023032629605;621.1986537366837;645.132297060453;645.554567348528;9790.1678357339;10245.590176392861;10248.538815753309;10612.946935265429;10988.120950323955;600.129811772931;601.6600620649319;608.8051823416464;612.3478495402383;617.2685367839125;4383.342498625232;4777.8327758528285;4874.805007799649;4912.89459871526;5028.094942910238;82203;83648;84337.57831210805;84452.15547844565;86503.26993460096;72931;73215.63392183112;74604;75030.62484687542;75452.24547754561;68533;68779.65610171917;69478.65260673664;70537;71509.64245178844;9105.544722763703;9284.860727089233;9488.478133702713;9576.808463830544;9782.9021709782;29257.414851703274;29576;29676.851615741783;29822.403551929274;30161.245968850955;36861.81569092137;37247;37559.685411011575;38023.809880950415;38348.23303533858;12616.243025418504;12772.233665980071;13127.934360328138;13199;13262.602121936357;14301.070430421989;14320.498782542561;14438.422463101359;14564.635884102981;14609.342579584158;13041.608751737464;13354.866451335361;13501.72996540044;13570.185788852701;13599.320033998458;12101.394930253628;12307.20003199789;12393.75212495727;12417.875821241672;12510;12879.35603219854;12926.547570834975;12967.935160324138;13001.4149363277;13105.737885242432;9068.455892646462;9108.225800807006;9477.668281610111;9565.952170239105;9705.563249653642;10513.526891289757;10817.188710846875;10819.513121909691;10976.835347469954;11027.724306892393 08:56:41 INFO - PID 25532 | __end_tp_report 08:56:41 INFO - PID 25532 | __start_cc_report 08:56:41 INFO - PID 25532 | _x_x_mozilla_cycle_collect,333 08:56:41 INFO - PID 25532 | __end_cc_report 08:56:41 INFO - PID 25532 | __startTimestamp1495814201947__endTimestamp 08:56:41 INFO - PID 25532 | 08:56:41 INFO - PID 25532 | ------- Summary: start ------- 08:56:41 INFO - PID 25532 | Number of tests: 6 08:56:41 INFO - PID 25532 | 08:56:41 INFO - PID 25532 | [#0] dojo.html Cycles:165 Average:5280.21 Median:5446.40 stddev:641.89 (11.8%) stddev-sans-first:611.33 08:56:41 INFO - PID 25532 | Values: 2708.4 2737.3 2737.6 2758.5 2780.0 5256.0 5314.0 5364.7 5384.2 5393.2 5313.3 5326.1 5345.6 5416.3 5445.9 4677.0 4677.8 4689.0 4707.1 4727.2 4662.7 4745.9 4758.5 4770.1 4799.0 4620.5 4663.4 4668.5 4673.1 4765.1 4675.9 4702.8 4743.6 4774.6 4787.2 4702.6 4716.1 4721.2 4730.9 4781.0 5292.7 5300.6 5355.5 5359.5 5393.1 5661.8 5747.4 5778.5 5854.0 5868.4 5839.1 5840.9 5868.6 5888.3 5920.2 5418.9 5426.9 5429.7 5446.4 5446.8 5864.9 5954.6 5966.2 5974.6 5979.5 5668.8 5710.7 5728.3 5739.3 5764.3 5658.6 5738.3 5738.4 5753.1 5772.6 5693.7 5698.0 5725.1 5729.0 5733.3 5688.3 5697.6 5702.7 5752.3 5773.3 4802.1 4804.5 4813.0 4854.3 4857.6 4112.8 4127.4 4164.6 4165.4 4188.3 4831.4 4831.7 4847.9 4923.0 4938.8 5831.7 5850.3 5868.0 5868.2 5888.4 4863.0 4876.9 4884.6 4886.2 4921.4 4961.8 5089.4 5130.2 5142.5 5144.9 5274.8 5364.3 5376.1 5391.6 5453.9 5699.9 5792.2 5828.4 5876.3 5889.6 5331.1 5331.1 5357.6 5390.5 5427.0 5662.0 5702.0 5703.9 5707.6 5756.3 5724.5 5798.0 5799.1 5812.9 5813.5 5609.9 5610.9 5683.1 5704.7 5712.1 5705.7 5708.1 5708.4 5716.9 5750.4 5561.1 5611.2 5623.2 5634.0 5648.0 5543.3 5548.4 5671.7 5689.9 5724.9 5531.5 5549.7 5554.1 5565.3 5569.0 08:56:41 INFO - PID 25532 | 08:56:41 INFO - PID 25532 | [#1] ext.html Cycles:180 Average:30417.29 Median:30243.77 stddev:40829.45 (135.0%) stddev-sans-first:40882.93 08:56:41 INFO - PID 25532 | Values: 679.5 733.5 746.7 1052.0 1062.1 32193.2 32891.8 32923.3 32936.2 33008.7 33955.8 34012.1 34066.0 34179.3 34520.7 6576.6 6767.6 6839.3 6996.7 6999.0 6795.5 6906.2 6912.2 6915.0 6918.4 6896.8 6939.5 6940.6 6946.9 6953.0 6825.7 6842.0 6845.1 6870.6 6872.9 6733.6 6774.7 6783.1 6797.3 6801.3 31279.7 31495.1 31498.7 31580.7 31637.7 3036.1 3068.2 3070.8 3073.7 3083.1 24499.6 24589.3 24596.4 24614.4 24699.0 2967.2 2975.0 2976.3 2998.0 3001.7 148863.0 153431.0 153582.2 154019.0 154136.0 38834.8 38897.2 38981.6 39003.6 39042.6 40213.4 40220.8 40293.8 40356.2 40407.4 12456.9 12535.5 12576.9 12603.6 12661.0 10087.3 10095.2 10106.5 10108.6 10108.6 12478.8 12553.3 12579.6 12580.9 12766.2 5329.5 5337.4 5344.3 5388.9 5456.2 859.3 900.6 909.4 909.6 931.3 20666.2 21274.1 21345.5 21511.9 21769.3 962.9 981.5 992.0 996.4 1001.0 10843.2 11085.4 11121.3 11391.6 11526.8 157975.0 160393.2 161090.0 161504.2 176082.0 43618.6 43886.0 44072.6 44107.8 44313.1 1193.2 1239.1 1241.4 1245.3 1247.2 24146.0 24582.6 25099.4 25539.0 25563.6 29818.6 29932.4 29950.0 30060.4 30159.7 157287.4 158697.0 159015.0 159558.4 159870.0 28802.6 28829.4 28877.7 30327.8 30460.7 36732.0 36909.8 37091.6 37094.6 37265.6 26320.7 26773.9 27036.6 27992.2 28410.7 27300.3 27490.0 27691.3 28596.6 28983.1 30471.4 30508.0 30997.4 31102.1 31105.4 26750.9 26980.9 27278.5 27482.3 28049.2 19607.5 21408.8 21620.7 21821.6 21884.2 08:56:41 INFO - PID 25532 | 08:56:41 INFO - PID 25532 | [#2] jquery.html Cycles:180 Average:24700.07 Median:39768.00 stddev:59601.12 (149.9%) stddev-sans-first:59740.41 08:56:41 INFO - PID 25532 | Values: 409.1 413.7 428.5 436.6 441.2 13165.5 17423.6 17877.8 18185.9 18200.9 18426.7 18599.8 19020.4 19166.9 19376.3 5354.9 5358.7 5371.9 5567.9 5598.8 5209.1 5235.4 5270.5 5273.3 5281.0 5152.8 5208.8 5220.1 5225.0 5255.9 5168.7 5304.0 5306.0 5311.3 5328.4 4780.1 4794.1 4821.0 4845.8 4864.4 22451.3 23140.2 23190.5 23285.4 23313.1 1586.8 1611.4 1613.1 1633.1 1633.4 14709.5 14837.9 14994.3 15341.8 15378.0 1991.7 2042.6 2069.7 2076.4 2081.2 91065.0 92523.5 92806.5 93039.0 95262.5 10972.4 10987.3 11087.4 11292.4 11540.3 15353.6 15495.8 15506.2 15568.5 15570.7 7668.6 7820.8 7971.7 7973.6 8021.5 7119.0 7143.9 7170.2 7383.5 7404.7 6930.5 7046.8 7160.4 7189.7 7311.6 2014.9 2041.4 2045.1 2065.5 2121.6 825.2 849.2 877.7 882.3 887.2 16898.7 16950.7 17009.1 17307.0 17718.5 867.5 869.2 874.9 876.8 882.0 9170.4 9216.2 9517.6 9521.2 9589.5 350553.0 355368.0 357650.0 358216.0 358692.0 77101.2 77519.6 78746.0 79147.6 79647.6 998.9 1005.6 1042.8 1047.5 1052.5 14458.5 14732.3 14843.4 14907.5 15537.4 39103.6 39752.8 39783.2 40227.2 40587.6 47787.8 48972.0 49555.3 50443.2 51536.5 8114.7 8267.4 8274.4 8290.3 8299.8 12893.8 13128.4 13237.7 13351.7 13505.3 10464.1 10540.2 10993.6 11069.0 11189.6 10052.2 10294.9 10367.7 10382.6 10495.4 10742.3 10924.9 11027.6 11288.6 11485.3 8074.5 8150.7 8191.6 8204.3 8256.7 10732.0 10770.3 10868.8 10891.6 11243.5 08:56:41 INFO - PID 25532 | 08:56:41 INFO - PID 25532 | [#3] mootools.html Cycles:180 Average:6553.25 Median:3385.57 stddev:4339.36 (128.2%) stddev-sans-first:4333.36 08:56:41 INFO - PID 25532 | Values: 1266.6 1302.9 1324.7 1324.8 1326.0 10439.7 10876.4 10936.9 10966.5 11288.9 10929.7 11074.9 11079.3 11085.0 11115.6 2235.1 2247.0 2262.3 2265.6 2266.8 2186.0 2227.6 2243.1 2248.6 2250.7 2135.3 2176.3 2183.1 2183.9 2196.1 2133.9 2141.9 2142.5 2149.9 2157.7 2058.1 2072.1 2105.6 2171.5 2178.0 10536.6 10653.1 10670.9 10673.2 10694.2 5707.4 5900.8 5912.6 5917.3 5921.1 3232.7 3362.8 3397.1 3402.7 3424.1 973.5 978.6 1000.1 1047.3 1065.4 16020.2 16144.6 16212.8 16262.8 16286.1 4784.0 4818.4 4964.7 4967.3 4980.6 11549.5 11565.4 11567.4 11614.3 11618.1 5567.9 5791.9 5793.2 5799.6 5802.1 5051.1 5232.5 5330.1 5368.5 5380.6 3871.2 4053.3 4058.8 4071.3 4147.9 1139.1 1154.8 1158.8 1162.7 1173.6 710.9 716.3 728.9 733.5 741.7 5564.6 5670.9 5672.7 5774.8 5806.5 502.1 519.2 519.5 520.5 520.9 3374.1 3705.2 3871.4 3877.4 3896.7 13492.5 13668.8 13868.3 13892.9 14123.9 13529.5 13864.6 14047.6 14084.2 14091.6 7687.0 7874.1 7908.1 7910.5 7914.2 6016.6 6386.6 6398.4 6429.1 6441.2 12474.3 12507.1 12632.0 12779.8 12803.9 12679.7 12900.6 12947.7 12953.4 13013.8 8817.6 8949.4 8955.2 8961.7 8997.2 10024.9 10066.9 10125.5 10181.8 10220.6 8616.0 8626.5 8680.9 8724.1 8857.6 7844.8 7978.4 7987.6 8021.4 8116.2 7372.8 7632.9 7666.9 7725.2 7761.4 4903.0 5293.3 5336.2 5399.3 5432.2 5071.3 5076.2 5157.4 5172.1 5187.5 08:56:41 INFO - PID 25532 | 08:56:41 INFO - PID 25532 | [#4] prototype.html Cycles:180 Average:4816.31 Median:5375.12 stddev:1407.41 (26.2%) stddev-sans-first:1371.39 08:56:41 INFO - PID 25532 | Values: 379.4 383.6 386.0 388.1 396.2 5490.8 5502.0 5506.3 5506.4 5513.8 5306.0 5362.5 5375.0 5375.3 5392.5 4236.5 4240.4 4242.1 4251.5 4253.0 4232.6 4235.2 4244.2 4248.0 4249.0 4115.0 4203.5 4206.9 4211.4 4234.3 4171.1 4180.8 4182.5 4218.9 4226.3 3764.8 3769.3 3800.5 3809.7 3813.8 5188.4 5306.4 5307.3 5327.5 5340.5 4990.2 5047.8 5048.7 5055.4 5082.2 5803.8 5810.3 5814.6 5815.5 5828.9 4213.6 4275.1 4297.6 4324.7 4328.2 5900.2 5957.9 5994.8 6027.8 6177.4 4169.2 4182.5 4194.0 4199.5 4212.8 4120.7 4239.7 4240.7 4242.4 4250.5 4844.4 4870.9 4882.0 4924.0 4924.7 5861.6 5869.8 5871.4 5890.1 5903.2 1415.3 1442.7 1459.1 1461.5 1468.8 977.7 992.9 1000.2 1006.0 1006.7 5059.4 5062.7 5064.8 5065.9 5103.3 6028.9 6030.2 6037.1 6054.5 6058.2 4902.9 4962.2 4975.0 4982.2 5020.6 3163.4 3197.3 3204.0 3209.5 3213.2 5514.8 5556.3 5574.5 5587.6 5590.7 5866.4 6160.7 6166.4 6213.2 6248.3 5584.6 5588.4 5610.6 5612.4 5636.5 5677.3 5974.0 5980.4 6036.9 6083.2 5798.4 5911.7 5958.3 5973.0 5992.5 5563.9 5565.2 5566.0 5596.0 5640.9 4169.8 4223.3 4223.5 4227.4 4236.3 5926.5 6064.8 6077.3 6137.2 6155.3 5852.2 5869.5 5895.5 5900.8 5909.5 5711.5 5875.5 5883.4 5889.8 5903.1 5733.5 5744.5 5748.9 5749.2 5786.8 5829.5 5878.8 5906.0 5917.3 5956.3 5600.0 5629.9 5649.1 5665.3 5790.2 08:56:41 INFO - PID 25532 | 08:56:41 INFO - PID 25532 | [#5] yui.html Cycles:180 Average:17175.55 Median:20658.53 stddev:23312.29 (112.8%) stddev-sans-first:23344.81 08:56:41 INFO - PID 25532 | Values: 687.6 689.7 695.0 739.0 771.1 10575.7 10961.7 13136.1 13732.2 13745.5 14292.9 14689.3 14725.7 14755.4 14904.4 850.9 898.1 905.0 910.6 910.8 909.2 912.0 912.4 915.1 919.7 933.1 938.4 939.7 941.9 944.8 926.2 927.6 934.7 935.1 944.5 686.4 686.7 694.3 697.4 698.2 13690.0 13844.5 13887.0 13911.7 13925.4 15036.3 15422.8 15488.3 15531.4 15825.8 12905.4 13011.5 13157.9 13369.0 13516.4 3040.3 3068.6 3071.3 3072.4 3075.8 82526.0 85832.6 85967.4 86702.6 87683.0 11656.8 11778.6 11857.3 12119.7 12132.7 20463.0 20912.3 21110.2 21251.6 21256.6 6546.3 6563.0 6575.3 6605.8 6633.5 2963.6 3068.2 3114.5 3168.9 3189.5 3623.5 3713.8 3723.9 3725.7 3757.4 652.4 675.5 732.3 745.8 748.3 603.4 617.8 621.2 645.1 645.6 9790.2 10245.6 10248.5 10612.9 10988.1 600.1 601.7 608.8 612.3 617.3 4383.3 4777.8 4874.8 4912.9 5028.1 82203.0 83648.0 84337.6 84452.2 86503.3 72931.0 73215.6 74604.0 75030.6 75452.2 68533.0 68779.7 69478.7 70537.0 71509.6 9105.5 9284.9 9488.5 9576.8 9782.9 29257.4 29576.0 29676.9 29822.4 30161.2 36861.8 37247.0 37559.7 38023.8 38348.2 12616.2 12772.2 13127.9 13199.0 13262.6 14301.1 14320.5 14438.4 14564.6 14609.3 13041.6 13354.9 13501.7 13570.2 13599.3 12101.4 12307.2 12393.8 12417.9 12510.0 12879.4 12926.5 12967.9 13001.4 13105.7 9068.5 9108.2 9477.7 9566.0 9705.6 10513.5 10817.2 10819.5 10976.8 11027.7 08:56:41 INFO - PID 25532 | -------- Summary: end -------- 08:56:41 INFO - PID 25532 | 08:56:42 INFO - TEST-INFO | 25532: exit 0 08:56:42 INFO - TEST-OK | dromaeo_css | took 1147363ms 08:56:42 INFO - TEST-START | kraken 08:56:42 INFO - operating with platform_type : linux_ 08:56:42 INFO - Initialising browser for kraken test... 08:56:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49919/getInfo.html -profile /tmp/tmpk_TkxA/profile 08:56:42 INFO - TEST-INFO | started process 25947 (/builds/slave/test/build/application/firefox/firefox http://localhost:49919/getInfo.html) 08:57:17 INFO - TEST-INFO | 25947: killed by SIGTERM 08:57:17 INFO - Browser initialized. 08:57:17 INFO - Running cycle 1/1 for kraken test... 08:57:17 INFO - TEST-INFO | started process 26170 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk_TkxA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:57:29 INFO - PID 26170 | RSS: Main: 172593152 08:57:29 INFO - PID 26170 | 08:57:32 INFO - PID 26170 | Cycle 1(1): loaded http://localhost:49919/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49919/tests/kraken/driver.html?testName=audio-beat-detection) 08:57:33 INFO - PID 26170 | RSS: Main: 178831360 08:57:33 INFO - PID 26170 | 08:57:36 INFO - PID 26170 | Cycle 1(1): loaded http://localhost:49919/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49919/tests/kraken/driver.html?testName=audio-dft) 08:57:36 INFO - PID 26170 | RSS: Main: 177496064 08:57:36 INFO - PID 26170 | 08:57:39 INFO - PID 26170 | Cycle 1(1): loaded http://localhost:49919/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49919/tests/kraken/driver.html?testName=audio-fft) 08:57:40 INFO - PID 26170 | RSS: Main: 175456256 08:57:40 INFO - PID 26170 | 08:57:42 INFO - PID 26170 | Cycle 1(1): loaded http://localhost:49919/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49919/tests/kraken/driver.html?testName=audio-oscillator) 08:57:42 INFO - PID 26170 | RSS: Main: 175775744 08:57:42 INFO - PID 26170 | 08:57:45 INFO - PID 26170 | Cycle 1(1): loaded http://localhost:49919/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49919/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:57:45 INFO - PID 26170 | RSS: Main: 176136192 08:57:45 INFO - PID 26170 | 08:57:48 INFO - PID 26170 | Cycle 1(1): loaded http://localhost:49919/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49919/tests/kraken/driver.html?testName=imaging-darkroom) 08:57:49 INFO - PID 26170 | RSS: Main: 178249728 08:57:49 INFO - PID 26170 | 08:57:53 INFO - PID 26170 | Cycle 1(1): loaded http://localhost:49919/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49919/tests/kraken/driver.html?testName=imaging-desaturate) 08:57:53 INFO - PID 26170 | RSS: Main: 175882240 08:57:53 INFO - PID 26170 | 08:57:56 INFO - PID 26170 | Cycle 1(1): loaded http://localhost:49919/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49919/tests/kraken/driver.html?testName=json-parse-financial) 08:57:57 INFO - PID 26170 | RSS: Main: 176685056 08:57:57 INFO - PID 26170 | 08:57:58 INFO - PID 26170 | Cycle 1(1): loaded http://localhost:49919/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49919/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:57:59 INFO - PID 26170 | RSS: Main: 176631808 08:57:59 INFO - PID 26170 | 08:58:01 INFO - PID 26170 | Cycle 1(1): loaded http://localhost:49919/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49919/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:58:01 INFO - PID 26170 | RSS: Main: 176152576 08:58:01 INFO - PID 26170 | 08:58:04 INFO - PID 26170 | Cycle 1(1): loaded http://localhost:49919/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49919/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:58:05 INFO - PID 26170 | RSS: Main: 176410624 08:58:05 INFO - PID 26170 | 08:58:07 INFO - PID 26170 | Cycle 1(1): loaded http://localhost:49919/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49919/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:58:08 INFO - PID 26170 | RSS: Main: 176418816 08:58:08 INFO - PID 26170 | 08:58:11 INFO - PID 26170 | Cycle 1(1): loaded http://localhost:49919/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49919/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:58:12 INFO - PID 26170 | RSS: Main: 176156672 08:58:12 INFO - PID 26170 | 08:58:14 INFO - PID 26170 | Cycle 1(1): loaded http://localhost:49919/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49919/tests/kraken/driver.html?testName=ai-astar) 08:58:14 INFO - PID 26170 | RSS: Main: 177905664 08:58:14 INFO - PID 26170 | 08:58:14 INFO - PID 26170 | __start_tp_report 08:58:14 INFO - PID 26170 | _x_x_mozilla_page_load 08:58:14 INFO - PID 26170 | _x_x_mozilla_page_load_details 08:58:14 INFO - PID 26170 | |i|pagename|runs| 08:58:14 INFO - PID 26170 | |0;ai-astar;104;111;110;110;110;111;110;112;111;112 08:58:14 INFO - PID 26170 | |1;audio-beat-detection;152;125;125;176;131;123;123;123;144;124 08:58:14 INFO - PID 26170 | |2;audio-dft;168;165;164;166;169;170;167;165;164;162 08:58:14 INFO - PID 26170 | |3;audio-fft;73;73;74;104;75;75;75;73;100;74 08:58:14 INFO - PID 26170 | |4;audio-oscillator;85;83;103;85;86;85;100;83;83;102 08:58:14 INFO - PID 26170 | |5;imaging-gaussian-blur;113;115;114;114;114;117;118;119;115;114 08:58:14 INFO - PID 26170 | |6;imaging-darkroom;150;151;150;151;152;149;151;150;151;151 08:58:14 INFO - PID 26170 | |7;imaging-desaturate;95;95;95;95;94;94;95;94;95;95 08:58:14 INFO - PID 26170 | |8;json-parse-financial;54;54;56;56;56;55;58;56;56;55 08:58:14 INFO - PID 26170 | |9;json-stringify-tinderbox;56;56;60;56;57;57;57;56;57;57 08:58:14 INFO - PID 26170 | |10;stanford-crypto-aes;89;87;86;88;88;93;89;90;146;88 08:58:14 INFO - PID 26170 | |11;stanford-crypto-ccm;137;136;135;136;132;137;131;139;138;138 08:58:14 INFO - PID 26170 | |12;stanford-crypto-pbkdf2;197;210;207;194;211;192;194;209;209;200 08:58:14 INFO - PID 26170 | |13;stanford-crypto-sha256-iterative;78;75;74;73;73;76;74;76;71;73 08:58:14 INFO - PID 26170 | __end_tp_report 08:58:14 INFO - PID 26170 | __start_cc_report 08:58:14 INFO - PID 26170 | _x_x_mozilla_cycle_collect,903 08:58:14 INFO - PID 26170 | __end_cc_report 08:58:14 INFO - PID 26170 | __startTimestamp1495814294414__endTimestamp 08:58:14 INFO - PID 26170 | 08:58:14 INFO - PID 26170 | ------- Summary: start ------- 08:58:14 INFO - PID 26170 | Number of tests: 14 08:58:14 INFO - PID 26170 | 08:58:14 INFO - PID 26170 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.28 (2.1%) stddev-sans-first:0.83 08:58:14 INFO - PID 26170 | Values: 104.0 111.0 110.0 110.0 110.0 111.0 110.0 112.0 111.0 112.0 08:58:14 INFO - PID 26170 | 08:58:14 INFO - PID 26170 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:128.00 stddev:17.70 (13.8%) stddev-sans-first:17.61 08:58:14 INFO - PID 26170 | Values: 152.0 125.0 125.0 176.0 131.0 123.0 123.0 123.0 144.0 124.0 08:58:14 INFO - PID 26170 | 08:58:14 INFO - PID 26170 | [#2] audio-dft Cycles:10 Average:166.00 Median:166.50 stddev:2.49 (1.5%) stddev-sans-first:2.54 08:58:14 INFO - PID 26170 | Values: 168.0 165.0 164.0 166.0 169.0 170.0 167.0 165.0 164.0 162.0 08:58:14 INFO - PID 26170 | 08:58:14 INFO - PID 26170 | [#3] audio-fft Cycles:10 Average:79.60 Median:74.00 stddev:11.87 (16.0%) stddev-sans-first:12.35 08:58:14 INFO - PID 26170 | Values: 73.0 73.0 74.0 104.0 75.0 75.0 75.0 73.0 100.0 74.0 08:58:14 INFO - PID 26170 | 08:58:14 INFO - PID 26170 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:84.00 stddev:8.49 (10.1%) stddev-sans-first:8.85 08:58:14 INFO - PID 26170 | Values: 85.0 83.0 103.0 85.0 86.0 85.0 100.0 83.0 83.0 102.0 08:58:14 INFO - PID 26170 | 08:58:14 INFO - PID 26170 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:2.00 (1.7%) stddev-sans-first:1.94 08:58:14 INFO - PID 26170 | Values: 113.0 115.0 114.0 114.0 114.0 117.0 118.0 119.0 115.0 114.0 08:58:14 INFO - PID 26170 | 08:58:14 INFO - PID 26170 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.84 (0.6%) stddev-sans-first:0.87 08:58:14 INFO - PID 26170 | Values: 150.0 151.0 150.0 151.0 152.0 149.0 151.0 150.0 151.0 151.0 08:58:14 INFO - PID 26170 | 08:58:14 INFO - PID 26170 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:58:14 INFO - PID 26170 | Values: 95.0 95.0 95.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 08:58:14 INFO - PID 26170 | 08:58:14 INFO - PID 26170 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.17 (2.1%) stddev-sans-first:1.09 08:58:14 INFO - PID 26170 | Values: 54.0 54.0 56.0 56.0 56.0 55.0 58.0 56.0 56.0 55.0 08:58:14 INFO - PID 26170 | 08:58:14 INFO - PID 26170 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:57.00 stddev:1.20 (2.1%) stddev-sans-first:1.22 08:58:14 INFO - PID 26170 | Values: 56.0 56.0 60.0 56.0 57.0 57.0 57.0 56.0 57.0 57.0 08:58:14 INFO - PID 26170 | 08:58:14 INFO - PID 26170 | [#10] stanford-crypto-aes Cycles:10 Average:94.40 Median:88.50 stddev:18.23 (20.6%) stddev-sans-first:19.23 08:58:14 INFO - PID 26170 | Values: 89.0 87.0 86.0 88.0 88.0 93.0 89.0 90.0 146.0 88.0 08:58:14 INFO - PID 26170 | 08:58:14 INFO - PID 26170 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:137.00 stddev:2.60 (1.9%) stddev-sans-first:2.73 08:58:14 INFO - PID 26170 | Values: 137.0 136.0 135.0 136.0 132.0 137.0 131.0 139.0 138.0 138.0 08:58:14 INFO - PID 26170 | 08:58:14 INFO - PID 26170 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:202.30 Median:208.00 stddev:7.63 (3.7%) stddev-sans-first:7.85 08:58:14 INFO - PID 26170 | Values: 197.0 210.0 207.0 194.0 211.0 192.0 194.0 209.0 209.0 200.0 08:58:14 INFO - PID 26170 | 08:58:14 INFO - PID 26170 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:74.50 stddev:2.00 (2.7%) stddev-sans-first:1.62 08:58:14 INFO - PID 26170 | Values: 78.0 75.0 74.0 73.0 73.0 76.0 74.0 76.0 71.0 73.0 08:58:14 INFO - PID 26170 | -------- Summary: end -------- 08:58:14 INFO - PID 26170 | 08:58:15 INFO - TEST-INFO | 26170: exit 0 08:58:15 INFO - TEST-OK | kraken | took 92755ms 08:58:15 INFO - SUITE-END | took 1240s 08:58:15 INFO - Completed test suite (00:20:40) 08:58:15 INFO - javascript benchmark 08:58:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6794.9740135046695, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2708.4447688223913, 2737.288305040689, 2737.603047558104, 2758.503469375513, 2779.9722002779977, 5256.027634887549, 5314.043472175012, 5364.678119312839, 5384.246205531229, 5393.217983392406, 5313.282706834576, 5326.067938110835, 5345.572354211664, 5416.295881535405, 5445.891082178354, 4676.97661511692, 4677.812887484513, 4689.038747056862, 4707.12918110149, 4727.243641017438, 4662.696924699901, 4745.857624271277, 4758.476567577563, 4770.117528257266, 4799.0, 4620.537946205386, 4663.44038715353, 4668.533146685304, 4673.065386922629, 4765.070811191819, 4675.859724208279, 4702.764861756898, 4743.596794272491, 4774.618030557547, 4787.234042553209, 4702.600278976257, 4716.103940251342, 4721.24460086388, 4730.935539503618, 4780.952190478086, 5292.708901010443, 5300.575953923677, 5355.518003379676, 5359.464053594648, 5393.083175860113, 5661.7735290588325, 5747.396523365028, 5778.508826749731, 5854.0, 5868.354481007086, 5839.124131380285, 5840.912386314209, 5868.559858010623, 5888.322842873082, 5920.171176035358, 5418.891622167574, 5426.9185962210595, 5429.67421954684, 5446.400895901447, 5446.809361672323, 5864.912026319608, 5954.583179177416, 5966.194563733927, 5974.581779275496, 5979.521638268928, 5668.773249069991, 5710.71446427677, 5728.283964504437, 5739.282589676291, 5764.308283006066, 5658.575606829504, 5738.340090889517, 5738.426157384311, 5753.1370294456165, 5772.62477938941, 5693.686847223443, 5698.00284950132, 5725.055365864669, 5729.0, 5733.312002559636, 5688.345840228344, 5697.629654072555, 5702.657840529581, 5752.309722833287, 5773.278340207474, 4802.111609352281, 4804.519548045238, 4812.951870481321, 4854.296127061556, 4857.587105096036, 4112.773797441109, 4127.422160897477, 4164.604362585549, 4165.396017577435, 4188.308929026676, 4831.371921650163, 4831.710097394168, 4847.927281090787, 4923.0, 4938.802447902043, 5831.708414579339, 5850.3272123705465, 5868.0, 5868.178455016301, 5888.381719919433, 4862.95137048632, 4876.853694389174, 4884.584810291094, 4886.193778026657, 4921.434035086011, 4961.7519124044375, 5089.440161582223, 5130.230465430215, 5142.485751424828, 5144.897102058013, 5274.760431298719, 5364.275822763877, 5376.112941364631, 5391.622586418913, 5453.863653408696, 5699.857503562444, 5792.160136780228, 5828.446297601721, 5876.324222714272, 5889.6171748837905, 5331.093714068696, 5331.120365139708, 5357.598180136428, 5390.51485366319, 5426.972865135807, 5661.971690141523, 5702.0, 5703.942960570507, 5707.600467967202, 5756.30924289088, 5724.513416359489, 5797.971010144923, 5799.072148456226, 5812.94187058141, 5813.505852002627, 5609.943900561106, 5610.859728506657, 5683.090705487102, 5704.657720536781, 5712.11462223356, 5705.7432415542235, 5708.058170401837, 5708.372079071381, 5716.9428305718075, 5750.424957504383, 5561.054620714407, 5611.242482264842, 5623.156526521055, 5634.042212823748, 5648.0, 5543.307086614173, 5548.445155484419, 5671.744771485211, 5689.857753556194, 5724.885502289848, 5531.502164805026, 5549.694766787866, 5554.08357620988, 5565.332160140809, 5569.025420551468], "value": 5231.953643263152, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.4768028617964, 733.4792297468797, 746.7274444827636, 1052.0426411965113, 1062.0706881478707, 32193.19517012073, 32891.83554082226, 32923.341533169325, 32936.17659558512, 33008.66991330086, 33955.83022084886, 34012.14969625755, 34066.0, 34179.31641367171, 34520.65479345206, 6576.6382848943285, 6767.627780472072, 6839.316068393171, 6996.70560946224, 6998.965005174992, 6795.490338224628, 6906.171259448874, 6912.239653638096, 6915.0, 6918.377346038856, 6896.793096207097, 6939.548929319603, 6940.618265995394, 6946.861062778741, 6952.965235173817, 6825.692843822015, 6842.0, 6845.110135682379, 6870.587764734132, 6872.862542749117, 6733.562318449334, 6774.695138718769, 6783.050372947791, 6797.2523022467485, 6801.285864984205, 31279.68720312813, 31495.055148345586, 31498.685013149803, 31580.684193158235, 31637.683623163703, 3036.089173248039, 3068.202267410467, 3070.8003979741247, 3073.738732207765, 3083.1367217179, 24499.632505512433, 24589.262322130366, 24596.385090372703, 24614.384640383956, 24699.0, 2967.198856308806, 2974.9851250743823, 2976.3154474470775, 2998.0, 3001.729844314022, 148863.0, 153431.0, 153582.23208883885, 154019.0, 154136.0, 38834.80582597069, 38897.222055559294, 38981.61018389837, 39003.60996390056, 39042.609573903894, 40213.39679904804, 40220.79889600533, 40293.79853100716, 40356.19287614231, 40407.39388909169, 12456.875431245753, 12535.498580056696, 12576.937115314548, 12603.621891343275, 12661.0, 10087.344322619007, 10095.192384609214, 10106.545205465773, 10108.595656173671, 10108.646197383056, 12478.75042499145, 12553.309567973849, 12579.622611321674, 12580.937095314464, 12766.234025958287, 5329.520343169133, 5337.386200586982, 5344.251804747339, 5388.865278368072, 5456.181572764117, 859.282499113235, 900.6397441023512, 909.4452384045727, 909.6406919266852, 931.2875650127658, 20666.17335306601, 21274.149034038775, 21345.466363341042, 21511.901072646302, 21769.346919592437, 962.9181519570775, 981.4945303168873, 991.9702408927744, 996.4419924842111, 1001.0440029771696, 10843.186760992958, 11085.445727713583, 11121.277116987532, 11391.601293954673, 11526.769464610828, 157975.0, 160393.19803400908, 161090.0, 161504.19247903686, 176082.0, 43618.56381436208, 43886.0, 44072.55927440685, 44107.77946110249, 44313.11373772571, 1193.2065176657425, 1239.1387985350095, 1241.4475558376437, 1245.302630526908, 1247.2017908538542, 24146.0, 24582.631260531463, 25099.372515687253, 25539.0, 25563.616545751458, 29818.55272170876, 29932.401351972403, 29950.0, 30060.398792024476, 30159.69840301569, 157287.41700664148, 158697.0, 159015.0, 159558.40441595434, 159870.0, 28802.567961480174, 28829.423411532072, 28877.7112228875, 30327.848360758057, 30460.695393046673, 36732.0, 36909.81545092365, 37091.6290837099, 37094.62905370912, 37265.62734372621, 26320.736792632593, 26773.866130669223, 27036.59445108364, 27992.160235192976, 28410.715892840806, 27300.286279899254, 27490.0, 27691.307717306423, 28596.571051433828, 28983.13050608485, 30471.390572188877, 30508.0, 30997.380052399276, 31102.066937991898, 31105.37789244157, 26750.866245668647, 26980.865095674395, 27278.454430910875, 27482.312942176606, 28049.158525244275, 19607.509812254808, 21408.78591214068, 21620.67568986498, 21821.56356872822, 21884.23405180811], "value": 14540.517056752244, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.1285561753465, 413.72280572016746, 428.51791734298916, 436.6245029274824, 441.24987521213944, 13165.539206127787, 17423.564410889736, 17877.821221787777, 18185.909070454647, 18200.90899545502, 18426.72359914599, 18599.814001859977, 19020.429387118373, 19166.904165479187, 19376.321828735996, 5354.9196762048605, 5358.732063396834, 5371.865703357418, 5567.8886422271535, 5598.776048958037, 5209.062368773619, 5235.397929238148, 5270.499302566269, 5273.314469119009, 5281.0, 5152.845414637567, 5208.791648334062, 5220.060389129955, 5224.973875130638, 5255.947440525584, 5168.664036837594, 5304.045271851065, 5306.0, 5311.336082989607, 5328.3605967284175, 4780.067886762083, 4794.113089078532, 4820.951790482085, 4845.757712114416, 4864.416270047617, 22451.32646020622, 23140.19009334682, 23190.53618927612, 23285.417864553354, 23313.067477300887, 1586.8413158684154, 1611.371565089616, 1613.1127879666253, 1633.0936330336658, 1633.3711521064356, 14709.485168019068, 14837.925810370987, 14994.250287485582, 15341.769873451907, 15378.0, 1991.6912878503856, 2042.6221149087467, 2069.6585063464663, 2076.418602791221, 2081.2299449203742, 91065.0, 92523.53738231333, 92806.53596732041, 93039.0, 95262.5236873818, 10972.396518191417, 10987.340759554452, 11087.390193539271, 11292.435378231055, 11540.307581545134, 15353.6161595961, 15495.845041549666, 15506.224688765516, 15568.532944011698, 15570.676492498038, 7668.5782281975025, 7820.765377038698, 7971.681132754741, 7973.641186146638, 8021.5187088774865, 7119.0, 7143.92856071443, 7170.211276759553, 7383.520071195355, 7404.703811847574, 6930.475295434996, 7046.823829404306, 7160.391366733782, 7189.712411503586, 7311.561306321638, 2014.8891810950538, 2041.3773798991451, 2045.1121818852953, 2065.514604068043, 2121.628714974873, 825.2325337436122, 849.163573879728, 877.7015814623059, 882.3117967984982, 887.1616322575104, 16898.74651880223, 16950.660986780196, 17009.064501452292, 17307.0, 17718.46844594664, 867.4925168776336, 869.1569177897429, 874.8915114573847, 876.7983363826355, 881.9955900220586, 9170.44977301364, 9216.235129461269, 9517.619295228113, 9521.23830093591, 9589.465685490288, 350553.0, 355368.0, 357650.0, 358216.0, 358692.0, 77101.22898771052, 77519.61240193763, 78746.0, 79147.60426197833, 79647.60176199197, 998.9300748947504, 1005.5826831864695, 1042.8070806900748, 1047.539082803564, 1052.5368837711383, 14458.493952711604, 14732.337044832793, 14843.367229604952, 14907.478238261609, 15537.378504859678, 39103.60896391114, 39752.80123599479, 39783.204335913695, 40227.19545609013, 40587.594124059564, 47787.84954677118, 48972.0, 49555.25667115068, 50443.243351349025, 51536.484635154666, 8114.7278761946745, 8267.421280510307, 8274.420790544604, 8290.295324897452, 8299.834003319778, 12893.806592901301, 13128.409221584861, 13237.735245295233, 13351.732965340832, 13505.257210853497, 10464.058234758908, 10540.156787456832, 10993.560257589927, 11069.0, 11189.608363707232, 10052.195824334181, 10294.897051029693, 10367.688969330931, 10382.636607718694, 10495.370277783357, 10742.3017503862, 10924.945375273073, 11027.61403350879, 11288.604898828502, 11485.310881347146, 8074.500136948828, 8150.673973041249, 8191.590420479071, 8204.343652507905, 8256.669733210845, 10732.0, 10770.299930504492, 10868.836967445653, 10891.618793342512, 11243.49404276826], "value": 8803.157777619039, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1266.5693664154187, 1302.8501722301937, 1324.7284306717124, 1324.7747882859912, 1325.9801102983452, 10439.68680939572, 10876.401797901111, 10936.890631093687, 10966.506507207176, 11288.943555282232, 10929.672109836698, 11074.947879951413, 11079.279846809972, 11085.0, 11115.554977852868, 2235.10595761695, 2247.0, 2262.321303608919, 2265.6035193841094, 2266.795988361047, 2186.049068655132, 2227.6324406472913, 2243.057915675412, 2248.55028994201, 2250.696156018933, 2135.3273718778537, 2176.260071575664, 2183.0721943174167, 2183.9235626753066, 2196.121551379445, 2133.9359819205447, 2141.9464513387134, 2142.464383904024, 2149.924752633666, 2157.687135365371, 2058.1355830551206, 2072.0882811562865, 2105.599936012168, 2171.4896999205175, 2178.0, 10536.631217907414, 10653.094486968617, 10670.893291067068, 10673.199510036779, 10694.197935154816, 5707.429257074301, 5900.763969441217, 5912.586118971673, 5917.260342457193, 5921.052631578927, 3232.6527497579627, 3362.8150451725146, 3397.065806903097, 3402.727781777452, 3424.126847653832, 973.5181085362791, 978.6476868327396, 1000.1398797034544, 1047.3035431438084, 1065.403374110493, 16020.19899005045, 16144.59638509035, 16212.75680864788, 16262.837371626369, 16286.10426426558, 4784.0, 4818.4217893852265, 4964.726940018334, 4967.279744437036, 4980.601551875914, 11549.480273387719, 11565.421728913689, 11567.363794991355, 11614.303141811519, 11618.128640352008, 5567.888642227133, 5791.8552036199435, 5793.2179155814265, 5799.594028417971, 5802.100674395476, 5051.1413059779925, 5232.502912223333, 5330.093884039723, 5368.4631536846, 5380.596455265871, 3871.2064026874423, 4053.2704113259897, 4058.776767277769, 4071.3485842265095, 4147.854825081168, 1139.0716565998684, 1154.8094564396781, 1158.7740390623917, 1162.7151347919814, 1173.565780661161, 710.928907109285, 716.3409663109951, 728.8505856299552, 733.4865594084163, 741.658836935016, 5564.610477266552, 5670.943290567124, 5672.716364181774, 5774.769009239667, 5806.477417032487, 502.0836972525156, 519.1693290734794, 519.4753299167792, 520.5081198267601, 520.9114450543417, 3374.0721301642243, 3705.184859330943, 3871.399933010388, 3877.43777152317, 3896.7272290939363, 13492.5277615283, 13668.794968075486, 13868.306584670727, 13892.930535347461, 14123.929380353033, 13529.458821647024, 13864.584062478141, 14047.648808779657, 14084.15495070299, 14091.647708807157, 7687.0, 7874.094479134858, 7908.130105688369, 7910.52536847791, 7914.2085791420395, 6016.608920420159, 6386.552941294251, 6398.392152745481, 6429.132067170872, 6441.194850643669, 12474.251544907334, 12507.124501285187, 12632.0, 12779.808302875279, 12803.871961280269, 12679.746405072032, 12900.645432229856, 12947.676308092374, 12953.352332383154, 13013.804792927924, 8817.559122044, 8949.418287811532, 8955.238804701674, 8961.731148065308, 8997.190252877272, 10024.949875250577, 10066.94966525192, 10125.544350504393, 10181.796364072528, 10220.59117635316, 8616.0, 8626.482411055356, 8680.869786953075, 8724.127587241479, 8857.64569417242, 7844.80387990282, 7978.361731061385, 7987.600619968862, 8021.438499304993, 8116.188381162073, 7372.778816635509, 7632.923670763222, 7666.884996724942, 7725.188855170126, 7761.4178936578855, 4903.0, 5293.311869456946, 5336.199570064521, 5399.271098401666, 5432.158015507603, 5071.264666623245, 5076.213186956028, 5157.381114266312, 5172.1465958118, 5187.481251874782], "value": 4807.829425767653, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.40433519374557, 383.61255132316353, 385.955615104263, 388.13252380928617, 396.21944768805463, 5490.835274941748, 5501.972490137548, 5506.284183056202, 5506.394296627378, 5513.751881165347, 5305.973470132653, 5362.51737343639, 5374.973125134369, 5375.274337964373, 5392.487713667205, 4236.4704411948505, 4240.385144154088, 4242.109157077018, 4251.5110762262275, 4252.9792849716, 4232.619064284214, 4235.216484950294, 4244.172386384656, 4248.044190057228, 4248.9575104249025, 4115.0, 4203.47456567929, 4206.894827629303, 4211.410402543646, 4234.343676730096, 4171.0823618803815, 4180.79096045198, 4182.477190351206, 4218.936715949232, 4226.344916537942, 3764.849406023783, 3769.340365436065, 3800.467934489174, 3809.7142714296538, 3813.809309534512, 5188.377394712658, 5306.3632364116165, 5307.310049693554, 5327.547158491533, 5340.49265319794, 4990.176620857555, 5047.823326183566, 5048.671836330626, 5055.368078990126, 5082.161443361841, 5803.767849286023, 5810.331811841608, 5814.563907706939, 5815.534757219412, 5828.88342233153, 4213.5786421357925, 4275.0594869128745, 4297.613214810682, 4324.654027677778, 4328.199283132631, 5900.1739756434135, 5957.8808423831715, 5994.760209591611, 6027.849303767397, 6177.382261773787, 4169.249535083653, 4182.498100227992, 4194.0, 4199.514403045526, 4212.831486740557, 4120.743173332163, 4239.682023848162, 4240.660747140221, 4242.44848169736, 4250.511191212988, 4844.370231869905, 4870.9269360959615, 4881.975590122027, 4923.950760492421, 4924.704517728876, 5861.6225187081, 5869.765209391662, 5871.3541510433815, 5890.1164825276555, 5903.173555702205, 1415.3206460898825, 1442.6898216883421, 1459.0880699562774, 1461.5030889497623, 1468.7943687883705, 977.6724797192878, 992.8957459466652, 1000.2498126405196, 1005.9647912323034, 1006.6527048168371, 5059.443461219263, 5062.7468626568525, 5064.82273120439, 5065.873353166126, 5103.2855400244, 6028.879422411527, 6030.221084780001, 6037.1246169305205, 6054.547908097227, 6058.212432383762, 4902.852914412573, 4962.156433406258, 4975.0, 4982.177940639826, 5020.648554601143, 3163.3989541987407, 3197.3125777957853, 3204.013511622809, 3209.4864821628894, 3213.2006076596713, 5514.779408823602, 5556.277683901067, 5574.470425309589, 5587.608867379326, 5590.664560126405, 5866.413358664185, 6160.691965401712, 6166.414190651881, 6213.2233470816145, 6248.28144763349, 5584.553235741131, 5588.357338905997, 5610.607257492018, 5612.35457922336, 5636.464535869086, 5677.347105082803, 5974.0, 5980.43185897339, 6036.879262414815, 6083.209182806207, 5798.420157984167, 5911.704414779329, 5958.34458209588, 5972.970135149297, 5992.520598352208, 5563.888722225452, 5565.248691426606, 5565.972170139124, 5595.972020139873, 5640.943590564206, 4169.791510424528, 4223.28204205292, 4223.450951376301, 4227.40014890846, 4236.343366778155, 5926.4666180044005, 6064.787732429344, 6077.301110372364, 6137.202163718688, 6155.322914479493, 5852.209951656472, 5869.4717475427415, 5895.494414873748, 5900.793472228452, 5909.468147866713, 5711.5169437338955, 5875.500582450369, 5883.441073098049, 5889.793857214977, 5903.140510739104, 5733.455321744427, 5744.4829965303325, 5748.913766293593, 5749.195112684311, 5786.768529258782, 5829.47534721877, 5878.794242201502, 5906.0, 5917.260342457193, 5956.315023772148, 5600.047991841316, 5629.8592535186945, 5649.12438572022, 5665.3201615806365, 5790.218320526675], "value": 4381.724889730925, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.5565260407037, 689.6965335252487, 694.9895751563724, 738.9667464964076, 771.1401787007488, 10575.682729518108, 10961.671149865497, 13136.080474366787, 13732.244726540037, 13745.518906838262, 14292.85707142931, 14689.265536723175, 14725.705485890276, 14755.409783608642, 14904.403823847033, 850.9021462531795, 898.1467605774541, 904.9683261085863, 910.622091831889, 910.8406028944942, 909.2089881802808, 912.0241341764282, 912.4160537256162, 915.1306259053893, 919.650532797536, 933.0902370189079, 938.3994243684048, 939.6992962252082, 941.8963913969458, 944.7826999790018, 926.2266007883426, 927.6289484206337, 934.7055677461578, 935.1069728409353, 944.5466176235377, 686.4405509509734, 686.7218776395567, 694.2987582541618, 697.4211404534225, 698.2389195776628, 13690.0, 13844.515441959484, 13887.02790804634, 13911.652208694763, 13925.442982280696, 15036.323365448472, 15422.768658470131, 15488.303026363841, 15531.378744850306, 15825.841741582552, 12905.354732263444, 13011.479540818356, 13157.934210328984, 13369.0, 13516.391762370717, 3040.3159289159985, 3068.6317641882893, 3071.339661972664, 3072.38552289543, 3075.8000729952482, 82526.0, 85832.57083714604, 85967.42097737078, 86702.56648716716, 87683.0, 11656.825147622792, 11778.587749428729, 11857.288562686266, 12119.697007574881, 12132.69668258283, 20463.0, 20912.26807061776, 21110.155593776384, 21251.574968500852, 21256.574868502852, 6546.3453654635105, 6562.967185164043, 6575.309592492815, 6605.801825945229, 6633.535652504375, 2963.5850980862697, 3068.202267410489, 3114.5016797312323, 3168.904932852018, 3189.5056266278766, 3623.474596183539, 3713.814309284525, 3723.8510459581853, 3725.701943844486, 3757.3800322946954, 652.4128284543948, 675.5203805298294, 732.3335764454428, 745.7650839985387, 748.3451979517922, 603.3966033966034, 617.8023032629605, 621.1986537366837, 645.132297060453, 645.554567348528, 9790.1678357339, 10245.590176392861, 10248.538815753309, 10612.946935265429, 10988.120950323955, 600.129811772931, 601.6600620649319, 608.8051823416464, 612.3478495402383, 617.2685367839125, 4383.342498625232, 4777.8327758528285, 4874.805007799649, 4912.89459871526, 5028.094942910238, 82203.0, 83648.0, 84337.57831210805, 84452.15547844565, 86503.26993460096, 72931.0, 73215.63392183112, 74604.0, 75030.62484687542, 75452.24547754561, 68533.0, 68779.65610171917, 69478.65260673664, 70537.0, 71509.64245178844, 9105.544722763703, 9284.860727089233, 9488.478133702713, 9576.808463830544, 9782.9021709782, 29257.414851703274, 29576.0, 29676.851615741783, 29822.403551929274, 30161.245968850955, 36861.81569092137, 37247.0, 37559.685411011575, 38023.809880950415, 38348.23303533858, 12616.243025418504, 12772.233665980071, 13127.934360328138, 13199.0, 13262.602121936357, 14301.070430421989, 14320.498782542561, 14438.422463101359, 14564.635884102981, 14609.342579584158, 13041.608751737464, 13354.866451335361, 13501.72996540044, 13570.185788852701, 13599.320033998458, 12101.394930253628, 12307.20003199789, 12393.75212495727, 12417.875821241672, 12510.0, 12879.35603219854, 12926.547570834975, 12967.935160324138, 13001.4149363277, 13105.737885242432, 9068.455892646462, 9108.225800807006, 9477.668281610111, 9565.952170239105, 9705.563249653642, 10513.526891289757, 10817.188710846875, 10819.513121909691, 10976.835347469954, 11027.724306892393], "value": 6976.217367968251, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1559.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 110.0, 110.0, 110.0, 111.0, 110.0, 112.0, 111.0, 112.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 125.0, 176.0, 131.0, 123.0, 123.0, 123.0, 144.0, 124.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 164.0, 166.0, 169.0, 170.0, 167.0, 165.0, 164.0, 162.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 104.0, 75.0, 75.0, 75.0, 73.0, 100.0, 74.0], "value": 79.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 103.0, 85.0, 86.0, 85.0, 100.0, 83.0, 83.0, 102.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 114.0, 114.0, 117.0, 118.0, 119.0, 115.0, 114.0], "value": 115.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 151.0, 152.0, 149.0, 151.0, 150.0, 151.0, 151.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 56.0, 56.0, 56.0, 55.0, 58.0, 56.0, 56.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 60.0, 56.0, 57.0, 57.0, 57.0, 56.0, 57.0, 57.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 86.0, 88.0, 88.0, 93.0, 89.0, 90.0, 146.0, 88.0], "value": 94.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 135.0, 136.0, 132.0, 137.0, 131.0, 139.0, 138.0, 138.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 210.0, 207.0, 194.0, 211.0, 192.0, 194.0, 209.0, 209.0, 200.0], "value": 202.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 74.0, 73.0, 73.0, 76.0, 74.0, 76.0, 71.0, 73.0], "value": 74.3, "unit": "score"}]}]} 08:58:15 INFO - Return code: 0 08:58:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:58:15 INFO - # TBPL SUCCESS # 08:58:15 INFO - Running post-action listener: _resource_record_post_action 08:58:15 INFO - [mozharness: 2017-05-26 15:58:15.700330Z] Finished run-tests step (success) 08:58:15 INFO - Running post-run listener: _resource_record_post_run 08:58:15 INFO - Total resource usage - Wall time: 1256s; CPU: 13.0%; Read bytes: 4096; Write bytes: 408915968; Read time: 228; Write time: 315476 08:58:15 INFO - TinderboxPrint: CPU usage
12.7% 08:58:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 228 08:58:15 INFO - TinderboxPrint: I/O write bytes / time
408,915,968 / 315,476 08:58:15 INFO - TinderboxPrint: CPU idle
8,752.2 (87.3%) 08:58:15 INFO - TinderboxPrint: CPU user
1,219.3 (12.2%) 08:58:15 INFO - TinderboxPrint: Swap in / out
0 / 0 08:58:15 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99340288; Read time: 0; Write time: 98564 08:58:15 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 4096; Write bytes: 309575680; Read time: 228; Write time: 216912 08:58:16 INFO - Running post-run listener: _upload_blobber_files 08:58:16 INFO - Blob upload gear active. 08:58:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:58:16 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 08:58:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:58:16 INFO - (blobuploader) - INFO - Open directory for files ... 08:58:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:58:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:58:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:17 INFO - (blobuploader) - INFO - Done attempting. 08:58:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:58:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:58:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:18 INFO - (blobuploader) - INFO - Done attempting. 08:58:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:58:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:58:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:19 INFO - (blobuploader) - INFO - Done attempting. 08:58:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:58:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:58:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:22 INFO - (blobuploader) - INFO - Done attempting. 08:58:22 INFO - (blobuploader) - INFO - Iteration through files over. 08:58:22 INFO - Return code: 0 08:58:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:58:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:58:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e49592f2ce59104e668dc197a7801fac24f1440b8441012a3a9e526ce3d3a332c5c4e3b301f8d4688034af4beaed2d42e59e9fa72729f75317a5d1df5cb15756", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2411a092bc53dc188b1aa381c31948fe508a5b9c72fbf439ec343efb09cdb5ffa3b9caaa71d924649355b30c829f6cfcca29ea846e193d92beb6d64fcb08dae0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21ba81f469414a242fbd00cc7c3c5da851e4058ce620438e098d4d3dc4b615b27c62f9514f4d3c01d00c0ea095ffd55b2ee2e14e4689472e17fe48f784191fc4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28ae911044c6d242dae5c11fe2fd231ca263da93d12eff62bc47688ccdda1fa0674b2819a30ebde4daf06be2eebe2a8bc43bc7fdae0aa51d23eb1245159a0d4f"} 08:58:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:58:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:58:22 INFO - Contents: 08:58:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e49592f2ce59104e668dc197a7801fac24f1440b8441012a3a9e526ce3d3a332c5c4e3b301f8d4688034af4beaed2d42e59e9fa72729f75317a5d1df5cb15756", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2411a092bc53dc188b1aa381c31948fe508a5b9c72fbf439ec343efb09cdb5ffa3b9caaa71d924649355b30c829f6cfcca29ea846e193d92beb6d64fcb08dae0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21ba81f469414a242fbd00cc7c3c5da851e4058ce620438e098d4d3dc4b615b27c62f9514f4d3c01d00c0ea095ffd55b2ee2e14e4689472e17fe48f784191fc4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28ae911044c6d242dae5c11fe2fd231ca263da93d12eff62bc47688ccdda1fa0674b2819a30ebde4daf06be2eebe2a8bc43bc7fdae0aa51d23eb1245159a0d4f"} 08:58:22 INFO - Running post-run listener: copy_logs_to_upload_dir 08:58:22 INFO - Copying logs to upload dir... 08:58:22 INFO - mkdir: /builds/slave/test/build/upload/logs 08:58:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1312.890078 ========= master_lag: 0.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2017-05-26 08:58:22.455219) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-26 08:58:22.460252) ========= 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=c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e49592f2ce59104e668dc197a7801fac24f1440b8441012a3a9e526ce3d3a332c5c4e3b301f8d4688034af4beaed2d42e59e9fa72729f75317a5d1df5cb15756", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2411a092bc53dc188b1aa381c31948fe508a5b9c72fbf439ec343efb09cdb5ffa3b9caaa71d924649355b30c829f6cfcca29ea846e193d92beb6d64fcb08dae0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21ba81f469414a242fbd00cc7c3c5da851e4058ce620438e098d4d3dc4b615b27c62f9514f4d3c01d00c0ea095ffd55b2ee2e14e4689472e17fe48f784191fc4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28ae911044c6d242dae5c11fe2fd231ca263da93d12eff62bc47688ccdda1fa0674b2819a30ebde4daf06be2eebe2a8bc43bc7fdae0aa51d23eb1245159a0d4f"} build_url:https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011407 build_url: 'https://queue.taskcluster.net/v1/task/Gr7t4aqqQ4283WRlslzqMw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e49592f2ce59104e668dc197a7801fac24f1440b8441012a3a9e526ce3d3a332c5c4e3b301f8d4688034af4beaed2d42e59e9fa72729f75317a5d1df5cb15756", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2411a092bc53dc188b1aa381c31948fe508a5b9c72fbf439ec343efb09cdb5ffa3b9caaa71d924649355b30c829f6cfcca29ea846e193d92beb6d64fcb08dae0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21ba81f469414a242fbd00cc7c3c5da851e4058ce620438e098d4d3dc4b615b27c62f9514f4d3c01d00c0ea095ffd55b2ee2e14e4689472e17fe48f784191fc4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28ae911044c6d242dae5c11fe2fd231ca263da93d12eff62bc47688ccdda1fa0674b2819a30ebde4daf06be2eebe2a8bc43bc7fdae0aa51d23eb1245159a0d4f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-26 08:58:22.488430) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 08:58:22.488755) ========= 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=c6927cf182745ad25b1d38b9000001fe-1495812598.605410-212329671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 08:58:22.567687) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-26 08:58:22.568010) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-26 08:58:22.568311) ========= ========= Total master_lag: 0.43 =========