builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1494597264.63 results: success (0) revision: bcb5e1ff13f807387595d5b6b5dbdb4c3b8ad501 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 06:54:24.626900) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 06:54:24.627411) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 06:54:24.627705) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 06:54:24.642636) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:54:24.643032) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-12 06:54:24-- 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% 40.6M=0s 2017-05-12 06:54:24 (40.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113920 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:54:24.771523) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:54:24.771964) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016181 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:54:24.822690) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-12 06:54:24.823022) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bcb5e1ff13f807387595d5b6b5dbdb4c3b8ad501 --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 bcb5e1ff13f807387595d5b6b5dbdb4c3b8ad501 --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=5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-12 06:54:24,862 truncating revision to first 12 chars 2017-05-12 06:54:24,862 Setting DEBUG logging. 2017-05-12 06:54:24,862 attempt 1/10 2017-05-12 06:54:24,862 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bcb5e1ff13f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-12 06:54:25,898 unpacking tar archive at: mozilla-central-bcb5e1ff13f8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.413804 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-12 06:54:26.251473) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 06:54:26.251806) ========= script_repo_revision: bcb5e1ff13f807387595d5b6b5dbdb4c3b8ad501 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 06:54:26.252217) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 06:54:26.252500) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 06:54:26.263033) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-05-12 06:54:26.263567) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:54:26 INFO - MultiFileLogger online at 20170512 06:54:26 in /builds/slave/test 06:54:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:54:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:54:26 INFO - {'append_to_log': False, 06:54:26 INFO - 'base_work_dir': '/builds/slave/test', 06:54:26 INFO - 'blob_upload_branch': 'Firefox', 06:54:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:54:26 INFO - 'branch': 'Firefox', 06:54:26 INFO - 'buildbot_json_path': 'buildprops.json', 06:54:26 INFO - 'config_files': ('talos/linux_config.py',), 06:54:26 INFO - 'default_actions': ('clobber', 06:54:26 INFO - 'read-buildbot-config', 06:54:26 INFO - 'download-and-extract', 06:54:26 INFO - 'populate-webroot', 06:54:26 INFO - 'create-virtualenv', 06:54:26 INFO - 'install', 06:54:26 INFO - 'run-tests'), 06:54:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:54:26 INFO - 'download_minidump_stackwalk': True, 06:54:26 INFO - 'download_symbols': 'ondemand', 06:54:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:54:26 INFO - 'tooltool.py': '/tools/tooltool.py', 06:54:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:54:26 INFO - '/tools/misc-python/virtualenv.py')}, 06:54:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:54:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:54:26 INFO - 'gecko_profile': False, 06:54:26 INFO - 'gecko_profile_interval': 0, 06:54:26 INFO - 'installer_path': 'installer.exe', 06:54:26 INFO - 'log_level': 'info', 06:54:26 INFO - 'log_name': 'talos', 06:54:26 INFO - 'log_to_console': True, 06:54:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:54:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:54:26 INFO - 'opt_config_files': (), 06:54:26 INFO - 'pip_index': False, 06:54:26 INFO - 'suite': 'dromaeojs', 06:54:26 INFO - 'system_bits': '32', 06:54:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:54:26 INFO - 'title': 'talos-linux64-ix-051', 06:54:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:54:26 INFO - 'use_talos_json': True, 06:54:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:54:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:54:26 INFO - 'work_dir': 'build'} 06:54:26 INFO - [mozharness: 2017-05-12 13:54:26.396500Z] Running clobber step. 06:54:26 INFO - Running pre-action listener: _resource_record_pre_action 06:54:26 INFO - Running main action method: clobber 06:54:26 INFO - rmtree: /builds/slave/test/build 06:54:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:54:27 INFO - Running post-action listener: _resource_record_post_action 06:54:27 INFO - [mozharness: 2017-05-12 13:54:27.380455Z] Finished clobber step (success) 06:54:27 INFO - [mozharness: 2017-05-12 13:54:27.380556Z] Running read-buildbot-config step. 06:54:27 INFO - Running pre-action listener: _resource_record_pre_action 06:54:27 INFO - Running main action method: read_buildbot_config 06:54:27 INFO - Using buildbot properties: 06:54:27 INFO - { 06:54:27 INFO - "project": "", 06:54:27 INFO - "product": "firefox", 06:54:27 INFO - "who": "cbook@mozilla.com", 06:54:27 INFO - "installer_path": "public/build/target.tar.bz2", 06:54:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:54:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:54:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:54:27 INFO - "stage_platform": "linux64-pgo", 06:54:27 INFO - "basedir": "/builds/slave/test", 06:54:27 INFO - "buildnumber": 181, 06:54:27 INFO - "platform": "ubuntu64_hw", 06:54:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:54:27 INFO - "slavebuilddir": "test", 06:54:27 INFO - "taskId": "KxEH0wpaQLK8sOSc7ysdtA", 06:54:27 INFO - "branch": "mozilla-central", 06:54:27 INFO - "script_repo_revision": "production", 06:54:27 INFO - "revision": "bcb5e1ff13f807387595d5b6b5dbdb4c3b8ad501", 06:54:27 INFO - "slavename": "talos-linux64-ix-051", 06:54:27 INFO - "repo_path": "mozilla-central" 06:54:27 INFO - } 06:54:27 INFO - Finding installer, test and symbols from parent task. 06:54:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KxEH0wpaQLK8sOSc7ysdtA'}, attempt #1 06:54:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KxEH0wpaQLK8sOSc7ysdtA'}, attempt #1 06:54:28 INFO - Task dependencies: Qduevg3VRA-EuH7AhLCkaQ 06:54:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ'}, attempt #1 06:54:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/target.tar.bz2 06:54:28 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/test_packages.json 06:54:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/target.crashreporter-symbols.zip 06:54:28 INFO - Running post-action listener: _resource_record_post_action 06:54:28 INFO - [mozharness: 2017-05-12 13:54:28.750649Z] Finished read-buildbot-config step (success) 06:54:28 INFO - [mozharness: 2017-05-12 13:54:28.750867Z] Running download-and-extract step. 06:54:28 INFO - Running pre-action listener: _resource_record_pre_action 06:54:28 INFO - Running main action method: download_and_extract 06:54:28 INFO - mkdir: /builds/slave/test/build/tests 06:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:28 INFO - trying https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/target.test_packages.json 06:54:28 INFO - Downloading https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:54:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:54:29 INFO - Downloaded 986 bytes. 06:54:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:54:29 INFO - Using the following test package requirements: 06:54:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:54:29 INFO - u'common': [u'target.common.tests.zip'], 06:54:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:54:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:54:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:54:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:54:29 INFO - u'mozbase': [u'target.common.tests.zip'], 06:54:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:54:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:54:29 INFO - u'web-platform': [u'target.common.tests.zip', 06:54:29 INFO - u'target.web-platform.tests.zip'], 06:54:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:54:29 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:54:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/target.common.tests.zip 06:54:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:54:29 INFO - Fetch https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/target.common.tests.zip into memory 06:54:30 INFO - Content-Length response header: 60745713 06:54:30 INFO - Bytes received: 60745713 06:54:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:54:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/target.common.tests.zip 06:54:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:54:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/target.common.tests.zip into memory 06:54:41 INFO - Content-Length response header: 60745713 06:54:41 INFO - Bytes received: 60745713 06:54:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/target.talos.tests.zip 06:54:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:54:52 INFO - Fetch https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/target.talos.tests.zip into memory 06:54:53 INFO - Content-Length response header: 14409411 06:54:53 INFO - Bytes received: 14409411 06:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:53 INFO - trying https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/target.tar.bz2 06:54:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:54:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:54:54 INFO - Downloaded 68568121 bytes. 06:54:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/target.tar.bz2 06:54:54 INFO - mkdir: /builds/slave/test/properties 06:54:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:54:54 INFO - Writing to file /builds/slave/test/properties/build_url 06:54:54 INFO - Contents: 06:54:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/target.tar.bz2 06:54:54 INFO - Running post-action listener: _resource_record_post_action 06:54:54 INFO - Running post-action listener: set_extra_try_arguments 06:54:54 INFO - [mozharness: 2017-05-12 13:54:54.496867Z] Finished download-and-extract step (success) 06:54:54 INFO - [mozharness: 2017-05-12 13:54:54.496965Z] Running populate-webroot step. 06:54:54 INFO - Running pre-action listener: _resource_record_pre_action 06:54:54 INFO - Running main action method: populate_webroot 06:54:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:54:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:54:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:54:54 INFO - '--tppagecycles', 06:54:54 INFO - '7'], 06:54:54 INFO - 'tests': ['tsvgm']}}, 06:54:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:54:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:54:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:54:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:54:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:54:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:54:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:54:54 INFO - 'talos_options': ['--disable-e10s'], 06:54:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:54:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:54:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:54:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:54:54 INFO - 'talos_options': ['--disable-e10s'], 06:54:54 INFO - 'tests': ['damp', 'tps']}, 06:54:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:54:54 INFO - 'tests': ['damp', 'tps']}, 06:54:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:54:54 INFO - 'tests': ['dromaeo_dom']}, 06:54:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:54:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:54:54 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:54:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:54:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:54:54 INFO - 'tests': ['a11yr', 06:54:54 INFO - 'ts_paint', 06:54:54 INFO - 'tpaint', 06:54:54 INFO - 'sessionrestore', 06:54:54 INFO - 'sessionrestore_no_auto_restore', 06:54:54 INFO - 'tabpaint']}, 06:54:54 INFO - 'other-e10s': {'tests': ['a11yr', 06:54:54 INFO - 'ts_paint', 06:54:54 INFO - 'tpaint', 06:54:54 INFO - 'sessionrestore', 06:54:54 INFO - 'sessionrestore_no_auto_restore', 06:54:54 INFO - 'tabpaint']}, 06:54:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:54:54 INFO - 'ts_paint', 06:54:54 INFO - 'tpaint', 06:54:54 INFO - 'sessionrestore', 06:54:54 INFO - 'sessionrestore_no_auto_restore', 06:54:54 INFO - 'tabpaint']}, 06:54:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:54:54 INFO - 'ts_paint', 06:54:54 INFO - 'tpaint', 06:54:54 INFO - 'sessionrestore', 06:54:54 INFO - 'sessionrestore_no_auto_restore', 06:54:54 INFO - 'tabpaint']}, 06:54:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:54:54 INFO - 'tests': ['a11yr', 06:54:54 INFO - 'ts_paint', 06:54:54 INFO - 'tpaint', 06:54:54 INFO - 'sessionrestore', 06:54:54 INFO - 'sessionrestore_no_auto_restore', 06:54:54 INFO - 'tabpaint']}, 06:54:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:54:54 INFO - 'tests': ['a11yr', 06:54:54 INFO - 'ts_paint', 06:54:54 INFO - 'tpaint', 06:54:54 INFO - 'sessionrestore', 06:54:54 INFO - 'sessionrestore_no_auto_restore', 06:54:54 INFO - 'tabpaint']}, 06:54:54 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 06:54:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 06:54:54 INFO - 'bloom_basic_ref']}, 06:54:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:54:54 INFO - 'tests': ['tsvgx', 06:54:54 INFO - 'tsvgr_opacity', 06:54:54 INFO - 'tart', 06:54:54 INFO - 'tscrollx', 06:54:54 INFO - 'cart', 06:54:54 INFO - 'tsvg_static']}, 06:54:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:54:54 INFO - 'tsvgr_opacity', 06:54:54 INFO - 'tart', 06:54:54 INFO - 'tscrollx', 06:54:54 INFO - 'cart', 06:54:54 INFO - 'tsvg_static']}, 06:54:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:54:54 INFO - 'talos_options': ['--disable-e10s'], 06:54:54 INFO - 'tests': ['tp5o']}, 06:54:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:54:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:54:54 INFO - 'talos_options': ['--disable-e10s', 06:54:54 INFO - '--xperf_path', 06:54:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:54:54 INFO - 'tests': ['tp5n']}, 06:54:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:54:54 INFO - 'talos_options': ['--xperf_path', 06:54:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:54:54 INFO - 'tests': ['tp5n']}}, 06:54:54 INFO - 'talos.zip': {'path': '', 06:54:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:54:54 INFO - Running post-action listener: _resource_record_post_action 06:54:54 INFO - [mozharness: 2017-05-12 13:54:54.510518Z] Finished populate-webroot step (success) 06:54:54 INFO - [mozharness: 2017-05-12 13:54:54.510607Z] Running create-virtualenv step. 06:54:54 INFO - Running pre-action listener: _resource_record_pre_action 06:54:54 INFO - Running main action method: create_virtualenv 06:54:54 INFO - Creating virtualenv /builds/slave/test/build/venv 06:54:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:54:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:54:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:54:54 INFO - Using real prefix '/usr' 06:54:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:54:55 INFO - Installing distribute.............................................................................................................................................................................................done. 06:54:57 INFO - Installing pip.................done. 06:54:57 INFO - Return code: 0 06:54:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:54:57 INFO - Reading from file tmpfile_stdout 06:54:57 INFO - Output received: 06:54:57 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:54:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1207a30>, '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 0x12087f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1208ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:54:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:54:57 INFO - Using env: {'DISPLAY': ':0', 06:54:57 INFO - 'HOME': '/home/cltbld', 06:54:57 INFO - 'LANG': 'en_US.UTF-8', 06:54:57 INFO - 'LANGUAGE': 'en_US:en', 06:54:57 INFO - 'LOGNAME': 'cltbld', 06:54:57 INFO - 'MAIL': '/var/mail/cltbld', 06:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:57 INFO - 'MOZ_NO_REMOTE': '1', 06:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:57 INFO - 'NO_EM_RESTART': '1', 06:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:57 INFO - 'PWD': '/builds/slave/test', 06:54:57 INFO - 'SHELL': '/bin/bash', 06:54:57 INFO - 'SHLVL': '1', 06:54:57 INFO - 'TERM': 'linux', 06:54:57 INFO - 'TMOUT': '86400', 06:54:57 INFO - 'USER': 'cltbld', 06:54:57 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992', 06:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:57 INFO - '_': '/tools/buildbot/bin/python'} 06:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:54:57 INFO - Cleaning up... 06:54:57 INFO - Return code: 0 06:54:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1207a30>, '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 0x12087f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1208ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:54:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:54:57 INFO - Using env: {'DISPLAY': ':0', 06:54:57 INFO - 'HOME': '/home/cltbld', 06:54:57 INFO - 'LANG': 'en_US.UTF-8', 06:54:57 INFO - 'LANGUAGE': 'en_US:en', 06:54:57 INFO - 'LOGNAME': 'cltbld', 06:54:57 INFO - 'MAIL': '/var/mail/cltbld', 06:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:57 INFO - 'MOZ_NO_REMOTE': '1', 06:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:57 INFO - 'NO_EM_RESTART': '1', 06:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:57 INFO - 'PWD': '/builds/slave/test', 06:54:57 INFO - 'SHELL': '/bin/bash', 06:54:57 INFO - 'SHLVL': '1', 06:54:57 INFO - 'TERM': 'linux', 06:54:57 INFO - 'TMOUT': '86400', 06:54:57 INFO - 'USER': 'cltbld', 06:54:57 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992', 06:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:57 INFO - '_': '/tools/buildbot/bin/python'} 06:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:57 INFO - Downloading/unpacking psutil>=3.1.1 06:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:54:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:58 INFO - Installing collected packages: psutil 06:54:58 INFO - Running setup.py install for psutil 06:54:58 INFO - building 'psutil._psutil_linux' extension 06:54:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:54:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:54:59 INFO - building 'psutil._psutil_posix' extension 06:54:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:54:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:54:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:59 INFO - Successfully installed psutil 06:54:59 INFO - Cleaning up... 06:54:59 INFO - Return code: 0 06:54:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:59 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 0xe981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1207a30>, '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 0x12087f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1208ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:54:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:54:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:54:59 INFO - Using env: {'DISPLAY': ':0', 06:54:59 INFO - 'HOME': '/home/cltbld', 06:54:59 INFO - 'LANG': 'en_US.UTF-8', 06:54:59 INFO - 'LANGUAGE': 'en_US:en', 06:54:59 INFO - 'LOGNAME': 'cltbld', 06:54:59 INFO - 'MAIL': '/var/mail/cltbld', 06:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:59 INFO - 'MOZ_NO_REMOTE': '1', 06:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:59 INFO - 'NO_EM_RESTART': '1', 06:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:59 INFO - 'PWD': '/builds/slave/test', 06:54:59 INFO - 'SHELL': '/bin/bash', 06:54:59 INFO - 'SHLVL': '1', 06:54:59 INFO - 'TERM': 'linux', 06:54:59 INFO - 'TMOUT': '86400', 06:54:59 INFO - 'USER': 'cltbld', 06:54:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992', 06:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:59 INFO - '_': '/tools/buildbot/bin/python'} 06:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:55:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:55:00 INFO - Installing collected packages: mozsystemmonitor 06:55:00 INFO - Running setup.py install for mozsystemmonitor 06:55:00 INFO - Successfully installed mozsystemmonitor 06:55:00 INFO - Cleaning up... 06:55:00 INFO - Return code: 0 06:55:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1207a30>, '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 0x12087f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1208ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:55:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:55:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:55:00 INFO - Using env: {'DISPLAY': ':0', 06:55:00 INFO - 'HOME': '/home/cltbld', 06:55:00 INFO - 'LANG': 'en_US.UTF-8', 06:55:00 INFO - 'LANGUAGE': 'en_US:en', 06:55:00 INFO - 'LOGNAME': 'cltbld', 06:55:00 INFO - 'MAIL': '/var/mail/cltbld', 06:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:00 INFO - 'MOZ_NO_REMOTE': '1', 06:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:00 INFO - 'NO_EM_RESTART': '1', 06:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:00 INFO - 'PWD': '/builds/slave/test', 06:55:00 INFO - 'SHELL': '/bin/bash', 06:55:00 INFO - 'SHLVL': '1', 06:55:00 INFO - 'TERM': 'linux', 06:55:00 INFO - 'TMOUT': '86400', 06:55:00 INFO - 'USER': 'cltbld', 06:55:00 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992', 06:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:00 INFO - '_': '/tools/buildbot/bin/python'} 06:55:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:01 INFO - Downloading/unpacking jsonschema==2.5.1 06:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:55:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:02 INFO - Downloading functools32-3.2.3-2.tar.gz 06:55:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:55:02 INFO - warning: no files found matching '*.txt' 06:55:02 INFO - no previously-included directories found matching 'build' 06:55:02 INFO - no previously-included directories found matching 'dist' 06:55:02 INFO - no previously-included directories found matching '.git*' 06:55:02 INFO - Installing collected packages: jsonschema, functools32 06:55:02 INFO - Running setup.py install for functools32 06:55:02 INFO - warning: no files found matching '*.txt' 06:55:02 INFO - no previously-included directories found matching 'build' 06:55:02 INFO - no previously-included directories found matching 'dist' 06:55:02 INFO - no previously-included directories found matching '.git*' 06:55:02 INFO - Successfully installed jsonschema functools32 06:55:02 INFO - Cleaning up... 06:55:02 INFO - Return code: 0 06:55:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:55: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')]} 06:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55: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')]} 06:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55: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', '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 0xe981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1207a30>, '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 0x12087f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1208ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:55: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:55: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 functools32==3.2.3-2 06:55:02 INFO - Using env: {'DISPLAY': ':0', 06:55:02 INFO - 'HOME': '/home/cltbld', 06:55:02 INFO - 'LANG': 'en_US.UTF-8', 06:55:02 INFO - 'LANGUAGE': 'en_US:en', 06:55:02 INFO - 'LOGNAME': 'cltbld', 06:55:02 INFO - 'MAIL': '/var/mail/cltbld', 06:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:02 INFO - 'MOZ_NO_REMOTE': '1', 06:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:02 INFO - 'NO_EM_RESTART': '1', 06:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:02 INFO - 'PWD': '/builds/slave/test', 06:55:02 INFO - 'SHELL': '/bin/bash', 06:55:02 INFO - 'SHLVL': '1', 06:55:02 INFO - 'TERM': 'linux', 06:55:02 INFO - 'TMOUT': '86400', 06:55:02 INFO - 'USER': 'cltbld', 06:55:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992', 06:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:02 INFO - '_': '/tools/buildbot/bin/python'} 06:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:55:02 INFO - Cleaning up... 06:55:02 INFO - Return code: 0 06:55:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:55: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')]} 06:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55: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')]} 06:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55: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', '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 0xe981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1207a30>, '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 0x12087f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1208ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:55: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:55: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 blobuploader==1.2.4 06:55:02 INFO - Using env: {'DISPLAY': ':0', 06:55:02 INFO - 'HOME': '/home/cltbld', 06:55:02 INFO - 'LANG': 'en_US.UTF-8', 06:55:02 INFO - 'LANGUAGE': 'en_US:en', 06:55:02 INFO - 'LOGNAME': 'cltbld', 06:55:02 INFO - 'MAIL': '/var/mail/cltbld', 06:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:02 INFO - 'MOZ_NO_REMOTE': '1', 06:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:02 INFO - 'NO_EM_RESTART': '1', 06:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:02 INFO - 'PWD': '/builds/slave/test', 06:55:02 INFO - 'SHELL': '/bin/bash', 06:55:02 INFO - 'SHLVL': '1', 06:55:02 INFO - 'TERM': 'linux', 06:55:02 INFO - 'TMOUT': '86400', 06:55:02 INFO - 'USER': 'cltbld', 06:55:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992', 06:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:02 INFO - '_': '/tools/buildbot/bin/python'} 06:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:03 INFO - Downloading/unpacking blobuploader==1.2.4 06:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:04 INFO - Downloading blobuploader-1.2.4.tar.gz 06:55:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:55:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:55:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:04 INFO - Downloading docopt-0.6.1.tar.gz 06:55:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:55:04 INFO - Installing collected packages: blobuploader, requests, docopt 06:55:04 INFO - Running setup.py install for blobuploader 06:55:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:55:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:55:04 INFO - Running setup.py install for requests 06:55:05 INFO - Running setup.py install for docopt 06:55:05 INFO - Successfully installed blobuploader requests docopt 06:55:05 INFO - Cleaning up... 06:55:05 INFO - Return code: 0 06:55:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:05 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 0xe981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1207a30>, '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 0x12087f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1208ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:55:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:55:05 INFO - Using env: {'DISPLAY': ':0', 06:55:05 INFO - 'HOME': '/home/cltbld', 06:55:05 INFO - 'LANG': 'en_US.UTF-8', 06:55:05 INFO - 'LANGUAGE': 'en_US:en', 06:55:05 INFO - 'LOGNAME': 'cltbld', 06:55:05 INFO - 'MAIL': '/var/mail/cltbld', 06:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:05 INFO - 'MOZ_NO_REMOTE': '1', 06:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:05 INFO - 'NO_EM_RESTART': '1', 06:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:05 INFO - 'PWD': '/builds/slave/test', 06:55:05 INFO - 'SHELL': '/bin/bash', 06:55:05 INFO - 'SHLVL': '1', 06:55:05 INFO - 'TERM': 'linux', 06:55:05 INFO - 'TMOUT': '86400', 06:55:05 INFO - 'USER': 'cltbld', 06:55:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992', 06:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:05 INFO - '_': '/tools/buildbot/bin/python'} 06:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:55:05 INFO - Running setup.py (path:/tmp/pip-24akm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:55:05 INFO - Running setup.py (path:/tmp/pip-zew7vZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:55:05 INFO - Running setup.py (path:/tmp/pip-u2_R_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:55:05 INFO - Running setup.py (path:/tmp/pip-sUS7Yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:55:05 INFO - Running setup.py (path:/tmp/pip-_IYXqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:55:05 INFO - Running setup.py (path:/tmp/pip-A1Hwci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:55:05 INFO - Running setup.py (path:/tmp/pip-QD3rr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:55:06 INFO - Running setup.py (path:/tmp/pip-Hm08bW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:55:06 INFO - Running setup.py (path:/tmp/pip-H3BOrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:55:06 INFO - Running setup.py (path:/tmp/pip-IhUgMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:55:06 INFO - Running setup.py (path:/tmp/pip-O1htbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:55:06 INFO - Running setup.py (path:/tmp/pip-XUYMfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:55:06 INFO - Running setup.py (path:/tmp/pip-lQeyZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:55:06 INFO - Running setup.py (path:/tmp/pip-4djfkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:06 INFO - Running setup.py (path:/tmp/pip-ATD1hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:55:06 INFO - Running setup.py (path:/tmp/pip-6uKfwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:55:06 INFO - Running setup.py (path:/tmp/pip-5Fmfid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:55:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:55:06 INFO - Running setup.py install for manifestparser 06:55:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:55:06 INFO - Running setup.py install for mozcrash 06:55:06 INFO - Running setup.py install for mozdebug 06:55:07 INFO - Running setup.py install for mozdevice 06:55:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:55:07 INFO - Running setup.py install for mozfile 06:55:07 INFO - Running setup.py install for mozhttpd 06:55:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:55:07 INFO - Running setup.py install for mozinfo 06:55:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:55:07 INFO - Running setup.py install for mozInstall 06:55:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:55:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:55:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:55:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:55:07 INFO - Running setup.py install for mozleak 06:55:07 INFO - Running setup.py install for mozlog 06:55:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:55:07 INFO - Running setup.py install for moznetwork 06:55:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:55:07 INFO - Running setup.py install for mozprocess 06:55:07 INFO - Running setup.py install for mozprofile 06:55:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:55:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:55:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:55:08 INFO - Running setup.py install for mozrunner 06:55:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:55:08 INFO - Running setup.py install for mozscreenshot 06:55:08 INFO - Running setup.py install for moztest 06:55:08 INFO - Running setup.py install for mozversion 06:55:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:55:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:55:08 INFO - Cleaning up... 06:55:08 INFO - Return code: 0 06:55:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:08 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 0xe981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1207a30>, '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 0x12087f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1208ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:55:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:55:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:55:08 INFO - Using env: {'DISPLAY': ':0', 06:55:08 INFO - 'HOME': '/home/cltbld', 06:55:08 INFO - 'LANG': 'en_US.UTF-8', 06:55:08 INFO - 'LANGUAGE': 'en_US:en', 06:55:08 INFO - 'LOGNAME': 'cltbld', 06:55:08 INFO - 'MAIL': '/var/mail/cltbld', 06:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:08 INFO - 'MOZ_NO_REMOTE': '1', 06:55:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:08 INFO - 'NO_EM_RESTART': '1', 06:55:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:08 INFO - 'PWD': '/builds/slave/test', 06:55:08 INFO - 'SHELL': '/bin/bash', 06:55:08 INFO - 'SHLVL': '1', 06:55:08 INFO - 'TERM': 'linux', 06:55:08 INFO - 'TMOUT': '86400', 06:55:08 INFO - 'USER': 'cltbld', 06:55:08 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992', 06:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:08 INFO - '_': '/tools/buildbot/bin/python'} 06:55:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:55:08 INFO - Running setup.py (path:/tmp/pip-9jQ0ru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:55:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:55:08 INFO - Running setup.py (path:/tmp/pip-VbRFWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:55:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:55:08 INFO - Running setup.py (path:/tmp/pip-srjPdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:55:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:55:08 INFO - Running setup.py (path:/tmp/pip-PwRbUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:55:09 INFO - Running setup.py (path:/tmp/pip-eaYvPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:55:09 INFO - Running setup.py (path:/tmp/pip-LJ1iFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:55:09 INFO - Running setup.py (path:/tmp/pip-9Aqsrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:55:09 INFO - Running setup.py (path:/tmp/pip-b5IsYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:55:09 INFO - Running setup.py (path:/tmp/pip-a4EM5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:55:09 INFO - Running setup.py (path:/tmp/pip-hiZmI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:55:09 INFO - Running setup.py (path:/tmp/pip-Oiw8iR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:55:09 INFO - Running setup.py (path:/tmp/pip-mWIof1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:55:09 INFO - Running setup.py (path:/tmp/pip-1hXckT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:55:09 INFO - Running setup.py (path:/tmp/pip-uz9fDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:09 INFO - Running setup.py (path:/tmp/pip-6Y5bOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:55:09 INFO - Running setup.py (path:/tmp/pip-hJTBtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:55:09 INFO - Running setup.py (path:/tmp/pip-VXzX2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:55:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:11 INFO - Downloading blessings-1.6.tar.gz 06:55:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:55:11 INFO - Installing collected packages: blessings 06:55:11 INFO - Running setup.py install for blessings 06:55:11 INFO - Successfully installed blessings 06:55:11 INFO - Cleaning up... 06:55:11 INFO - Return code: 0 06:55:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:55:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:55:11 INFO - Reading from file tmpfile_stdout 06:55:11 INFO - Current package versions: 06:55:11 INFO - argparse == 1.2.1 06:55:11 INFO - blessings == 1.6 06:55:11 INFO - blobuploader == 1.2.4 06:55:11 INFO - docopt == 0.6.1 06:55:11 INFO - functools32 == 3.2.3-2 06:55:11 INFO - jsonschema == 2.5.1 06:55:11 INFO - manifestparser == 1.1 06:55:11 INFO - mozInstall == 1.12 06:55:11 INFO - mozcrash == 1.0 06:55:11 INFO - mozdebug == 0.1 06:55:11 INFO - mozdevice == 0.50 06:55:11 INFO - mozfile == 1.2 06:55:11 INFO - mozhttpd == 0.7 06:55:11 INFO - mozinfo == 0.9 06:55:11 INFO - mozleak == 0.1 06:55:11 INFO - mozlog == 3.4 06:55:11 INFO - moznetwork == 0.27 06:55:11 INFO - mozprocess == 0.25 06:55:11 INFO - mozprofile == 0.28 06:55:11 INFO - mozrunner == 6.13 06:55:11 INFO - mozscreenshot == 0.1 06:55:11 INFO - mozsystemmonitor == 0.3 06:55:11 INFO - moztest == 0.8 06:55:11 INFO - mozversion == 1.4 06:55:11 INFO - psutil == 3.1.1 06:55:11 INFO - requests == 1.2.3 06:55:11 INFO - wsgiref == 0.1.2 06:55:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:11 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 0xe981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1207a30>, '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 0x12087f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1208ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:55:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:55:11 INFO - Using env: {'DISPLAY': ':0', 06:55:11 INFO - 'HOME': '/home/cltbld', 06:55:11 INFO - 'LANG': 'en_US.UTF-8', 06:55:11 INFO - 'LANGUAGE': 'en_US:en', 06:55:11 INFO - 'LOGNAME': 'cltbld', 06:55:11 INFO - 'MAIL': '/var/mail/cltbld', 06:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:11 INFO - 'MOZ_NO_REMOTE': '1', 06:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:11 INFO - 'NO_EM_RESTART': '1', 06:55:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:11 INFO - 'PWD': '/builds/slave/test', 06:55:11 INFO - 'SHELL': '/bin/bash', 06:55:11 INFO - 'SHLVL': '1', 06:55:11 INFO - 'TERM': 'linux', 06:55:11 INFO - 'TMOUT': '86400', 06:55:11 INFO - 'USER': 'cltbld', 06:55:11 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992', 06:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:11 INFO - '_': '/tools/buildbot/bin/python'} 06:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:55:11 INFO - Cleaning up... 06:55:11 INFO - Return code: 0 06:55:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1207a30>, '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 0x12087f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1208ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:55:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:55:11 INFO - Using env: {'DISPLAY': ':0', 06:55:11 INFO - 'HOME': '/home/cltbld', 06:55:11 INFO - 'LANG': 'en_US.UTF-8', 06:55:11 INFO - 'LANGUAGE': 'en_US:en', 06:55:11 INFO - 'LOGNAME': 'cltbld', 06:55:11 INFO - 'MAIL': '/var/mail/cltbld', 06:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:11 INFO - 'MOZ_NO_REMOTE': '1', 06:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:11 INFO - 'NO_EM_RESTART': '1', 06:55:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:11 INFO - 'PWD': '/builds/slave/test', 06:55:11 INFO - 'SHELL': '/bin/bash', 06:55:11 INFO - 'SHLVL': '1', 06:55:11 INFO - 'TERM': 'linux', 06:55:11 INFO - 'TMOUT': '86400', 06:55:11 INFO - 'USER': 'cltbld', 06:55:11 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992', 06:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:11 INFO - '_': '/tools/buildbot/bin/python'} 06:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:55:11 INFO - Cleaning up... 06:55:11 INFO - Return code: 0 06:55:11 INFO - Running post-action listener: _resource_record_post_action 06:55:11 INFO - Running post-action listener: _start_resource_monitoring 06:55:12 INFO - Starting resource monitoring. 06:55:12 INFO - [mozharness: 2017-05-12 13:55:12.009569Z] Finished create-virtualenv step (success) 06:55:12 INFO - [mozharness: 2017-05-12 13:55:12.010081Z] Running install step. 06:55:12 INFO - Running pre-action listener: _resource_record_pre_action 06:55:12 INFO - Running main action method: install 06:55:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:55:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:55:12 INFO - Reading from file tmpfile_stdout 06:55:12 INFO - Detecting whether we're running mozinstall >=1.0... 06:55:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:55:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:55:12 INFO - Reading from file tmpfile_stdout 06:55:12 INFO - Output received: 06:55:12 INFO - Usage: mozinstall [options] installer 06:55:12 INFO - Options: 06:55:12 INFO - -h, --help show this help message and exit 06:55:12 INFO - -d DEST, --destination=DEST 06:55:12 INFO - Directory to install application into. [default: 06:55:12 INFO - "/builds/slave/test"] 06:55:12 INFO - --app=APP Application being installed. [default: firefox] 06:55:12 INFO - mkdir: /builds/slave/test/build/application 06:55:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:55:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:55:29 INFO - Reading from file tmpfile_stdout 06:55:29 INFO - Output received: 06:55:29 INFO - /builds/slave/test/build/application/firefox/firefox 06:55:29 INFO - Running post-action listener: _resource_record_post_action 06:55:29 INFO - [mozharness: 2017-05-12 13:55:29.421072Z] Finished install step (success) 06:55:29 INFO - [mozharness: 2017-05-12 13:55:29.421319Z] Running run-tests step. 06:55:29 INFO - Running pre-action listener: _resource_record_pre_action 06:55:29 INFO - Running main action method: run_tests 06:55:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:55:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:55:29 INFO - Python 2.7.3 06:55:29 INFO - Return code: 0 06:55:29 INFO - grabbing minidump binary from tooltool 06:55:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1207a30>, '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 0x12087f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1208ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:55:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:55:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:55:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:55:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:55:29 INFO - Return code: 0 06:55:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:55:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:55:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:55:29 INFO - ENV: RUST_BACKTRACE is now 1 06:55:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:55:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:55:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:55:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:55:29 INFO - Using env: {'DISPLAY': ':0', 06:55:29 INFO - 'HOME': '/home/cltbld', 06:55:29 INFO - 'LANG': 'en_US.UTF-8', 06:55:29 INFO - 'LANGUAGE': 'en_US:en', 06:55:29 INFO - 'LOGNAME': 'cltbld', 06:55:29 INFO - 'MAIL': '/var/mail/cltbld', 06:55:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:55:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:55:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:29 INFO - 'MOZ_NO_REMOTE': '1', 06:55:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:55:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:29 INFO - 'NO_EM_RESTART': '1', 06:55:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:29 INFO - 'PWD': '/builds/slave/test', 06:55:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:55:29 INFO - 'RUST_BACKTRACE': '1', 06:55:29 INFO - 'SHELL': '/bin/bash', 06:55:29 INFO - 'SHLVL': '1', 06:55:29 INFO - 'TERM': 'linux', 06:55:29 INFO - 'TMOUT': '86400', 06:55:29 INFO - 'USER': 'cltbld', 06:55:29 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992', 06:55:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:29 INFO - '_': '/tools/buildbot/bin/python'} 06:55:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:55:29 INFO - mozversion application_buildid: 20170512123443 06:55:29 INFO - mozversion application_changeset: bcb5e1ff13f807387595d5b6b5dbdb4c3b8ad501 06:55:29 INFO - mozversion application_display_name: Nightly 06:55:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:55:29 INFO - mozversion application_name: Firefox 06:55:29 INFO - mozversion application_remotingname: firefox 06:55:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:55:29 INFO - mozversion application_vendor: Mozilla 06:55:29 INFO - mozversion application_version: 55.0a1 06:55:29 INFO - mozversion platform_buildid: 20170512123443 06:55:29 INFO - mozversion platform_changeset: bcb5e1ff13f807387595d5b6b5dbdb4c3b8ad501 06:55:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:55:29 INFO - mozversion platform_version: 55.0a1 06:55:29 INFO - using testdate: 1494597329 06:55:29 INFO - actual date: 1494597329 06:55:29 INFO - starting webserver on 'localhost:48513' 06:55:29 INFO - SUITE-START | Running 2 tests 06:55:29 INFO - TEST-START | dromaeo_css 06:55:29 INFO - operating with platform_type : linux_ 06:55:29 INFO - Initialising browser for dromaeo_css test... 06:55:29 INFO - TEST-INFO | started process 6744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL0pWH4/profile http://localhost:48513/getInfo.html) 06:55:33 INFO - PID 6744 | __metrics Screen width/height:1600/1200 06:55:33 INFO - PID 6744 | colorDepth:24 06:55:33 INFO - PID 6744 | Browser inner width/height: 1024/695 06:55:33 INFO - PID 6744 | __metrics 06:55:34 INFO - PID 6744 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:55:34 INFO - PID 6744 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:55:35 INFO - TEST-INFO | 6744: exit 0 06:55:35 INFO - Browser initialized. 06:55:35 INFO - Running cycle 1/1 for dromaeo_css test... 06:55:35 INFO - TEST-INFO | started process 6837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL0pWH4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:55:47 INFO - PID 6837 | RSS: Main: 145104896 06:55:47 INFO - PID 6837 | 06:58:49 INFO - PID 6837 | Cycle 1(1): loaded http://localhost:48513/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48513/tests/dromaeo/cssquery-ext.html) 06:58:51 INFO - PID 6837 | RSS: Main: 302841856 06:58:51 INFO - PID 6837 | 07:01:53 INFO - PID 6837 | Cycle 1(1): loaded http://localhost:48513/tests/dromaeo/cssquery-ext.html (next: http://localhost:48513/tests/dromaeo/cssquery-jquery.html) 07:01:54 INFO - PID 6837 | RSS: Main: 228933632 07:01:54 INFO - PID 6837 | 07:04:55 INFO - PID 6837 | Cycle 1(1): loaded http://localhost:48513/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48513/tests/dromaeo/cssquery-mootools.html) 07:04:56 INFO - PID 6837 | RSS: Main: 227307520 07:04:56 INFO - PID 6837 | 07:07:58 INFO - PID 6837 | Cycle 1(1): loaded http://localhost:48513/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48513/tests/dromaeo/cssquery-prototype.html) 07:07:58 INFO - PID 6837 | RSS: Main: 228073472 07:07:58 INFO - PID 6837 | 07:11:01 INFO - PID 6837 | Cycle 1(1): loaded http://localhost:48513/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48513/tests/dromaeo/cssquery-yui.html) 07:11:02 INFO - PID 6837 | RSS: Main: 178118656 07:11:02 INFO - PID 6837 | 07:14:04 INFO - PID 6837 | Cycle 1(1): loaded http://localhost:48513/tests/dromaeo/cssquery-yui.html (next: http://localhost:48513/tests/dromaeo/cssquery-dojo.html) 07:14:04 INFO - PID 6837 | RSS: Main: 260935680 07:14:04 INFO - PID 6837 | 07:14:04 INFO - PID 6837 | __start_tp_report 07:14:04 INFO - PID 6837 | _x_x_mozilla_page_load 07:14:04 INFO - PID 6837 | _x_x_mozilla_page_load_details 07:14:04 INFO - PID 6837 | |i|pagename|runs| 07:14:04 INFO - PID 6837 | |0;dojo.html;3280.245543524989;3287.424700677382;3294.110590140662;3314.718248948839;3344.8829290974804;5616.297962754656;5741.626794258381;5765.13522971554;5769.365369809318;5791.59458837881;5691.886162276752;5752;5754.395788442205;5809.593328467009;5824.912626310609;4675.8831029224375;4964.900701985958;5049.9747501262445;5050.292958985727;5153.871153221162;5122.948770512285;5171.5862730981435;5174.068667639824;5192.169252919533;5202.947970520303;5007.349044624212;5073.036123136629;5091.694498330112;5175.45657705943;5197.818076367347;5119.129747942859;5122;5133.743312834344;5136.178211486182;5186.7147306898105;5056;5115.923261151086;5122.359705036871;5127.743612819344;5161.329027226474;5488.890222195534;5563.388027316992;5646.378898321182;5714.942850571482;5752.8849423011725;6218.19163508741;6232.8130156095385;6233.189685340922;6239.251289845248;6239.906401403937;6256.468200202989;6261.373862613747;6284.151639528696;6287.622742635456;6292.339304373067;5634.070378387521;5645.774169033275;5792.364474164245;5812.041013232812;5814.563907706896;6211.192544969125;6302.716377763011;6336.17629708135;6350.460210882126;6352.872942541123;5998.550108741862;6082.695865206811;6084.513238940963;6087.726052327655;6145.385461453819;6219.284782250009;6245.656488893154;6261.968690156611;6275.843103922439;6282.685865706788;5994.6403215807195;6069.908951365733;6237.844053898598;6243.188385509946;6248.281447633581;6133.294671112879;6134.846828498841;6173.660448675366;6177.69111544421;6184.350643182491;4716.3868697069165;4717.669763116617;4718.05638872227;4756.453007904066;4757.476677565465;4133.91732165361;4202.957970420257;4204.411382406465;4207.053412982054;4240.215560121387;5741.913871291934;5770.19217309577;5865.120231965239;5875.764969401176;5880.353161152269;6089.604175728564;6154.1999540059505;6162.414570615784;6168.568200225941;6176.4441200292185;5710.571707121982;5712.828615141552;5717.342505611825;5721.77112915487;5739.655620662774;5104.821331253388;5125.308083408692;5191.039657663345;5193.610479214074;5195.558377537876;6281.780137695158;6377.681115944184;6520.18497687789;6523.67381630907;6530.151080359523;6271.278802937721;6273.52948528853;6273.62358258506;6278.811635650938;6286.5599408041;6365.981442969102;6471.514636402195;6484.157059582224;6490.091387205701;6491.5131365148745;6005.039193728982;6056.818295451144;6058.57589968698;6062.484688801501;6129.419919118862;6065.181200537871;6188.195534580475;6228.5951413158;6243.500519958302;6245.9063114052415;5953.910691339547;5981.641101533922;6012.849678758066;6039.063945088518;6139.969300153471;6068.423499767515;6073.453389194994;6076.3012253591405;6087.786927457695;6115.449609535163;5866.7066646668345;6036.69816509164;6053.3946605339115;6072.119542666377;6076.179715738319;5964.821055368346;6038.63768173911;6084.452399284086;6133.938660613337;6139.109829074849;5959.940400595939;5982.4316689914385;5995.160677505066;6001.459868611846;6006.309274433496 07:14:04 INFO - PID 6837 | |1;ext.html;712.5297303779506;772.7874834420534;787.2717736094112;1146.7935771561115;1163.2903928603555;30195.69804301956;34785.478217826756;37762.622373776285;38157.80921095398;38197.23605527895;40976.795116024456;41313;41325.79337103318;41353.37969930453;41519.37720934188;5575.637583557056;7115.18175409828;7182.17404998424;7238.782836514913;7245.239249878766;5672.773089076432;7054.717811287543;7238.782836514887;7239.276072392771;7243.203247642755;7283;7327.963360183192;7343.449241306924;7346.522476039067;7347.044884165051;5644.971775141139;7250.746223882165;7273.745418910313;7294.379977701875;7299.854002919912;5738.196652468658;6718.3953444189765;6818.624975626339;6822.897656535156;6827.52207345486;35509.46735798965;35876.46185307222;35915;35982.820085899664;35991;3519.542459480251;3575.4994300797907;3576.302620988908;3583.140046388874;3585.4621806728937;27875.58186627182;27899.302517437227;27903.720962790314;27952.440951181066;27967;3703.8888833335045;3759.4172903200047;3760.6427389397963;3773.811309434517;3804.334241507725;180123;180175;180399;180585;180818;46056.769716151204;46188.7690561545;46324.305135423;46346;46401;48082.51917480781;48167;48219.276710848666;48226.517734822206;48237;14815.703685926437;14847.925760371345;14954.925225373803;14978.325975331136;14979.251037448084;10671.893281067245;10859.674209773719;12535.31055791922;12541.247525148521;12552.686182845502;15157.393704251926;15368.61578460525;15517.84482155164;15597.220138993232;15729.921350393175;5988.305262631833;6043.305019922677;6092.634441933498;6156.661383623944;6283.905741413882;1081.3674000709516;1109.7225693576606;1113.4265853085506;1124.876263611002;1136.664683918246;27424.45151096967;27470;27600;27817.721822781514;27926.581101283497;1161.2451906260828;1176.1825531255695;1211.9757604847853;1225.522046401904;1234.6851552853964;13465.596032119052;13492;13528;13528.594142175554;13607.523736669169;244086;245917;245924;246517;247143;51342.22986655203;51907.74046129745;51989.7400512995;52102.73948630233;52105.739471302404;1480.141517919604;1518.9088654680534;1529.1283968138055;1530.6862093270852;1535.1863512338477;23780.881095595105;24944.12695555647;25056.31606307356;25262.242132736046;25298.36754081089;39106.4134037984;39301;39385.80307098561;39396.40905386479;39415.408768867914;214368;216835;217137;217316;217318;28269.57595636108;29037;29060.12819615415;34026.319473609896;34302.14244643904;37334.43998339973;38221;38599.228015440094;39481.2103757929;40028.19943601053;29635.259118522208;29855.402891942475;29903.252418689706;30044.699553005066;30650.540241896837;29474.410511790073;30056.398872022;30393.544096838123;30419.391612168074;30442.543361850032;35052.64947350596;35118.29763404769;35222.29555408826;35293.47059794157;35409.29181416306;28130.859345703142;28736.137915862557;28751.281217969718;29329.706702932697;29500;23865.64201537013;24195.63706544368;24313.39216519601;24403;24642.876785615957 07:14:04 INFO - PID 6837 | |2;jquery.html;428.81775245520663;442.63924901205536;443.95782400671936;456.9428821397323;462.92824612185103;18743.34398296058;19637.11632976516;20236.59526809463;20355.28756493523;20368.388948331554;20887.895560522174;21393.0373133209;21890.671639925375;22006.559868802615;22149.335519934386;5479.424660410649;5671.744771485272;5677.9716101419435;5679.318481782192;5680.744366503496;4991.7304165771475;5038.143515602356;5519.69641669708;5531.419200983879;5580.6372585782;5486.643368181056;5497.972510137443;5499.862503437406;5521.668699878;5522.171674248854;5452.454754524555;5527.336719593654;5571.582131340146;5606.719664016824;5606.775728970836;5098.337216161875;5120.871978200575;5125.487451254882;5129.769160387754;5134.64057515974;24007.399815004588;24043;24163.2751017468;24179.51640967171;24338.756612433826;2144.8713077215416;2148.076327179312;2156.353094071788;2182.978170218293;2220.544788318391;15579.376824927103;16216;16278.26747796352;16529.090900000494;16862.072586007765;2184.9890750546306;2222.688823564686;2269.4439862233858;2275.4083938176027;2298.1267118495034;97288.51355743318;97957.5102124492;98377;98802.50598747031;99123.50438247762;12260.509579616893;12294.200876943149;12454.875451245553;12562.937185314198;12647.873521264853;17616.471505854846;17634.470965871045;17656.646867062587;17686.380976665754;17738.11309434523;8663.48019118855;8897.199252067345;9047.366684332033;9059.682911098213;9083.772905677411;8239.917600824036;8242.423030387816;8280.378971577156;8385.454945428528;8453.492790432594;7776.688932442752;7921.32668723165;8035.116137224901;8068.47554908929;8080.757577272691;2180.618391781432;2230.431240033781;2235.6335873297526;2289.610766169755;2317.2584772872856;1053.5364439646685;1071.50175168547;1076.56399158341;1089.536946797608;1109.1293334732197;20466.488337791674;20633.484162895747;20686.79313206879;20711.792882071288;21053.578928421346;1101.8181999969916;1104.2435931387026;1108.2020944919645;1110.9944450277696;1112.3770688414513;10936.835947460795;11390.25963312382;11422.14333924959;11540.24988375753;11591.304521728724;446736;448987.020259593;456607;457978;458409;92366.53816730874;93629.5318523403;94140;95799;96506;1194.498310709504;1253.310679126495;1262.9810552841714;1263.5703860687227;1271.9809202861964;16515.421960231335;17043.257582191563;17258.223379948184;17813.109344532462;18215.089245537405;44559;45584.316235255836;45828.77085614551;46730;48326.5167348322;59724.70137649284;59979.40020599738;60368;61163.69418152881;61408;9561.187299079378;9720.756981075247;9880.258980576342;9911.950440247752;10149.797004060025;15227;15339.079655220723;15371.308291126703;15665.37338506447;15761.842381576496;12045.939770301093;12456.56402025961;12507.187032842836;12547.811782823448;13119.344032798514;12349.259044457362;12489.93755031219;12635.620931372074;12957.870421295667;13169.53906613264;13256.270905099926;13627.591172264847;13854.792178117135;13938.93030534841;14146.646333841736;9656.37233579815;9660.178884794872;9699.612015519582;10032.097111260022;10214.795704086026;12417.565385211474;12749.235045897276;12970.935145324212;13348.399322030338;13465.431660610142 07:14:04 INFO - PID 6837 | |3;mootools.html;1191.225703292859;1326.907116501845;1356.7015256643535;1364.2632978191778;1369.246914197192;8950.55247237638;10449.895501044997;10898;11027.944860275707;11033.503492342834;10725.892741072586;10834.620788272412;10852;10864.348139111658;10873.565057397715;2180.160638154306;2224.644056950888;2225.8441909066373;2227.086894373307;2228.8774117423536;1920.7310976463236;1987.33424302858;2176.064292354287;2272.227442669492;2278.111536500766;2166.7183266175375;2191.189259973812;2191.7698641642637;2193.1885202475105;2193.583219188349;2153.3432303147533;2153.967690484644;2177.0203408466173;2186.3331683836423;2191.6712493126;2122.0875023739786;2132.3709505695856;2154;2169.945751356213;2194.6049711052005;10228;10441.477926103664;10442.68671939843;10445.425501597409;10449.529771160316;5975.52195824333;6174.969125154345;6179.81460556184;6180.196574445294;6181.9690901545655;3756.530433695788;3954.1498577805623;3964;3984.5816189300285;4033.052232725307;1168.1297433412162;1194.199886076331;1300.6423233610737;1300.6863068301084;1309.9148555343872;15851.524454266391;15861.127637979907;15863.20683965797;15872.920635396864;15884.444044458389;5211.166213405837;5229.137192363293;5380.408155102936;5500.724963751796;5510.862228444321;13387.397567109503;13389.330533473287;13407.597772066854;13408.731825363438;13422.798658020138;6368.4586810121655;6369.777057803048;6373.617582944946;6374.681265936684;6379.170707807955;5741.655500669973;5807.128930660435;5810.448007439287;5874.471297583238;5878.706064696748;3918.3730603103936;4043.8584649537124;4357.934630980538;4502.71672573315;4544.318352247124;1280.9679758006125;1322.6627210061565;1323.0540163782941;1348.8313960754906;1356.7557839588771;873.3362644390182;893.9374243802871;900.8513595256841;907.2832462354797;913.862920561921;6606.339366063356;6639.1037209977;6668.733250669919;6748.797536073926;6823.249442561314;969.2246203037682;974.0794948773482;975.7950830325711;979.9563464909849;992.6079198716467;3923.2741942740686;3975.2248311578965;4003.159336539301;4020.4572382727956;4030.1738143680477;13552.322383880766;14022.789658155136;14060.296985150702;14071.226082565558;14091.71816563663;13459.865401345862;13828.585142445743;13843.86156138446;13866.306684665726;13886.513972010931;8493.787655308543;8703.95648021756;8710.82578348442;8712.956435217657;8720.607572659246;6639.203295604559;6669.233038200669;6895.6552172392185;6936.930630693629;7097.751578694721;12303.815442768187;12483.812742808683;12514.74970500603;12635.74728505443;12791.36043197855;12579.371031448209;12658.683532911751;12755.80866287025;12779.04157188196;12927.5475358362;8800.60397282111;8967.730968070968;8976.82046359056;8983.730488085368;8994.415363001384;9909.55407006672;10149.898501014895;10272.537735802056;10279.074883260542;10295.639652612123;8611.526366049928;8687.39188256816;8734.170253825876;8814.118588141135;8843.867341990004;8461.915380846112;8489.787755306166;8581.485110893367;8612.267957223707;8742.868856967023;7751.147373788766;7858.803529911798;7861.921380786348;7865.724699635485;7867.9606601966625;5624.521915637217;5662.745176466987;5664.150377443417;5714.542836573148;5873.73568189424;5544.417836127149;5612.186232996274;5628.831135065954;5704.515116215168;5774.133879918046 07:14:04 INFO - PID 6837 | |4;prototype.html;392.6976228304206;396.9166475040241;415.50139832201364;415.62801292842903;421.59526854219945;5820.301563812343;5848.356680765112;5865.472107510323;5875.266796295093;5901.498372638325;5612.859678508039;5613;5792.71036448177;5803.738831752571;5815.62198457101;4537.773111344428;4548.363229147922;4558.794854231551;4567.634589232854;4573.977130114345;4550.431196100488;4550.49944506104;4551.067031258601;4563.361129441864;4582.656300777455;4470.351798989144;4544.863654090366;4554.453465584118;4558.339040839076;4560.2019646561885;4528;4535.160995215896;4536.523665015192;4550.658700597435;4557.134144512532;4093.5292441369324;4097.631213190827;4113.3957756475;4118.382242663624;4132.33882578789;5491.7254137292975;5635.6055076144685;5673.574481913873;5678.205051292823;5688.943110568883;5359.14253719403;5366.221897824833;5370.89896571202;5372.543333816591;5385.973070134663;6168.814935551941;6176.567640265183;6177.907331390033;6181.3818618138275;6182.505399568024;4522.728636281834;4638.466576343696;4676.134915040694;4730.952690473086;4736.573708366263;6164.815055548341;6270.31026587075;6321.367863213688;6420.807375778734;6494.253160886511;4855.150348688965;4856.854294371175;4872.805087796449;4885.975570122127;4891.559759621651;4628.791704373311;4728.550787675165;4926.926096108561;4937.753112344369;4954.5540901319055;5338.973305133527;5414.592206026461;5437.477506298243;5458.181272809031;5461.699606521679;6195.2255968004;6214.627122372672;6221.191245138193;6240.344763799736;6243.906341404882;1685.848273655377;1713.8457538821565;1723.5691077230692;1733.0554847607832;1737.4700716281402;1211.2853416484318;1227.6317104868504;1241.8571864235728;1252.680566455548;1253.4108968784656;5847.970760146172;5851.151583020438;5859;5894.911576326359;5922.526197904157;6294.748210071546;6352.333005034498;6355.968220158869;6412.935870641234;6413.711382987777;5718.170865224519;5836.270466191726;5852.356240813507;5859.326177489558;5873.324567674772;3339.2486690494443;3355.731541476676;3362.8486718097743;3383.2725963917874;3390.4405773047665;6416.871662566722;6537;6547.5416720830035;6587.50593705474;6635.86728265432;6396.200474940632;6423.389777971085;6434.356564343529;6468.288488266287;6470.611763294218;6407.597151068349;6426.485881129592;6547.607143571401;6562.80311590653;6570.145881035531;6322.747090116344;6328.936710633019;6339.96830015847;6347.333529979471;6369.490440764635;5918.319393269657;6003.759849606142;6120.225134710884;6285.59143655661;6336.968315158395;6469.5794773339585;6470.838229044311;6478.5465017450215;6493;6507.349265073455;4647;4721.56049717429;4730.432348118248;4734.431868175841;4746.715197088186;6203.596766210182;6261.655608941552;6271.122042914087;6283.968580157253;6296.937030629819;6066.514678825772;6082.296956852088;6102.603330783485;6111.755529778759;6117.938820611737;5968.671723055274;6030.547708921761;6103.6032657877095;6105.572609917263;6127.080937859357;6041.124037014696;6060.303065147565;6064.878702426015;6083.117947897618;6100.359462256399;5885.234429670996;6056.727447264796;6078.635281883101;6101.450869421773;6143.232095988002;5884.764609415575;5903.763849445974;5913.940860591339;5921.822345329647;5928.940710593011 07:14:04 INFO - PID 6837 | |5;yui.html;833.4540875726401;842.1157535441113;855.0807881527357;858.665120602965;860.7460799064278;13451.596452106429;14133.293335333243;16564.420245291418;17191.48425547234;17264.65470690587;16858.494245172664;17087.914560427213;17184.398546050892;17982.5504362391;18085;1018.2210608884191;1037.704254287528;1044.0342683018216;1044.0394836750208;1044.8693913260843;740.1488288468278;1031.9896801032007;1033.1063629960106;1034.6689059500964;1034.7413146713322;818.6970820796314;1027.8201314769922;1060.1306928318782;1066.648006157966;1071.0681706914995;1054.562356622001;1055.1400608504046;1055.7255113670424;1055.7413433708791;1055.8046761349137;779.898613180283;780.594091072639;781.0276206123356;781.1056340490107;781.4607920534813;16427.671446571123;16580.502584922473;16703;17493.56266093345;17873.463796086136;16407.1796410179;16541.503754887373;16736.6652666946;16779;17031.148442577945;14512.70974580513;14868.702625947528;14994.325255363536;15056.473023444236;15227.695446091016;3552.573691157052;3574.821258937043;3588.6770190682964;3590.120420496995;3591.084273510264;88896.55551722264;91645.54177229072;92082.07917920803;92134;92747;14551.490697825526;14808.777868331983;15021.399144034334;15036.699266014619;15071.924640376728;26572.46855062888;26707.33231669224;27341.316467088483;27543.586846197322;27572.44855102887;7032.718691252395;7277.272272772786;7289.890651640229;7293.635318234067;7963.800904977422;3874.4575759393706;3992.161646054303;3994.3409337458993;4005.539362973237;4009.659178969762;4269.188854117708;4745.549172828576;4898.559129678346;4918.311436398907;4928.926066109011;916.276141847946;938.1275413865035;944.3436811416;953.6423841059602;957.3633533700012;720.772956518695;724.4928550015011;741.8293792427772;748.8464864702723;760.152430040512;11990.820137697941;12671.239725616493;13324.600261992156;13508.257045862376;13543.729125417436;726.7674344209802;731.0605871455155;738.5199620246882;743.985120297591;756.0322786832862;5436.782528698808;6061.393860613992;6065.60573562717;6141.6007959482495;6452.064450654629;70587;73071;75103;77200.61399693078;83056.58471707723;63128;64008;65661;65720;68486.65756671184;61257.69371153205;61911;62130;62358.688206558676;62501.687491562254;12844.871551284368;13389;13465.192088474723;13636.181829090287;13669.521566745116;31497.8425107873;31518.36963260768;31638.209044774067;32872.671273286964;32987.34025319528;39465.210695786496;39748.60251397449;39970;40494.19011619692;40926.795366022976;14321.14073155614;15441.22793860325;15813.288402021706;15924.203789810232;16190.271437785092;17951.640967180323;18087;18130.818691812914;18163.182656780213;18592.628147437244;16551.08969006716;16662.08358540292;16695.833041669426;16845.494635160965;17003.489895303162;17030.744538832176;17086.231119599895;17096.57258568546;17110;17312.134393280536;17243.7413438796;17297.481075567754;17492.47522574325;17607.119644018003;17660.558486037437;12633.242005479333;12863.421146048637;12989.675258118623;13345.799813003006;13753.312334383441;13943.721125577229;14695.559133226021;14704.55886323412;14928.10431374121;15401.460948866736 07:14:04 INFO - PID 6837 | __end_tp_report 07:14:04 INFO - PID 6837 | __start_cc_report 07:14:04 INFO - PID 6837 | _x_x_mozilla_cycle_collect,1727 07:14:04 INFO - PID 6837 | __end_cc_report 07:14:04 INFO - PID 6837 | __startTimestamp1494598444402__endTimestamp 07:14:04 INFO - PID 6837 | 07:14:04 INFO - PID 6837 | ------- Summary: start ------- 07:14:04 INFO - PID 6837 | Number of tests: 6 07:14:04 INFO - PID 6837 | 07:14:04 INFO - PID 6837 | [#0] dojo.html Cycles:165 Average:5715.06 Median:5995.16 stddev:690.75 (11.5%) stddev-sans-first:665.94 07:14:04 INFO - PID 6837 | Values: 3280.2 3287.4 3294.1 3314.7 3344.9 5616.3 5741.6 5765.1 5769.4 5791.6 5691.9 5752.0 5754.4 5809.6 5824.9 4675.9 4964.9 5050.0 5050.3 5153.9 5122.9 5171.6 5174.1 5192.2 5202.9 5007.3 5073.0 5091.7 5175.5 5197.8 5119.1 5122.0 5133.7 5136.2 5186.7 5056.0 5115.9 5122.4 5127.7 5161.3 5488.9 5563.4 5646.4 5714.9 5752.9 6218.2 6232.8 6233.2 6239.3 6239.9 6256.5 6261.4 6284.2 6287.6 6292.3 5634.1 5645.8 5792.4 5812.0 5814.6 6211.2 6302.7 6336.2 6350.5 6352.9 5998.6 6082.7 6084.5 6087.7 6145.4 6219.3 6245.7 6262.0 6275.8 6282.7 5994.6 6069.9 6237.8 6243.2 6248.3 6133.3 6134.8 6173.7 6177.7 6184.4 4716.4 4717.7 4718.1 4756.5 4757.5 4133.9 4203.0 4204.4 4207.1 4240.2 5741.9 5770.2 5865.1 5875.8 5880.4 6089.6 6154.2 6162.4 6168.6 6176.4 5710.6 5712.8 5717.3 5721.8 5739.7 5104.8 5125.3 5191.0 5193.6 5195.6 6281.8 6377.7 6520.2 6523.7 6530.2 6271.3 6273.5 6273.6 6278.8 6286.6 6366.0 6471.5 6484.2 6490.1 6491.5 6005.0 6056.8 6058.6 6062.5 6129.4 6065.2 6188.2 6228.6 6243.5 6245.9 5953.9 5981.6 6012.8 6039.1 6140.0 6068.4 6073.5 6076.3 6087.8 6115.4 5866.7 6036.7 6053.4 6072.1 6076.2 5964.8 6038.6 6084.5 6133.9 6139.1 5959.9 5982.4 5995.2 6001.5 6006.3 07:14:04 INFO - PID 6837 | 07:14:04 INFO - PID 6837 | [#1] ext.html Cycles:180 Average:37466.86 Median:32338.43 stddev:56080.74 (173.4%) stddev-sans-first:56170.15 07:14:04 INFO - PID 6837 | Values: 712.5 772.8 787.3 1146.8 1163.3 30195.7 34785.5 37762.6 38157.8 38197.2 40976.8 41313.0 41325.8 41353.4 41519.4 5575.6 7115.2 7182.2 7238.8 7245.2 5672.8 7054.7 7238.8 7239.3 7243.2 7283.0 7328.0 7343.4 7346.5 7347.0 5645.0 7250.7 7273.7 7294.4 7299.9 5738.2 6718.4 6818.6 6822.9 6827.5 35509.5 35876.5 35915.0 35982.8 35991.0 3519.5 3575.5 3576.3 3583.1 3585.5 27875.6 27899.3 27903.7 27952.4 27967.0 3703.9 3759.4 3760.6 3773.8 3804.3 180123.0 180175.0 180399.0 180585.0 180818.0 46056.8 46188.8 46324.3 46346.0 46401.0 48082.5 48167.0 48219.3 48226.5 48237.0 14815.7 14847.9 14954.9 14978.3 14979.3 10671.9 10859.7 12535.3 12541.2 12552.7 15157.4 15368.6 15517.8 15597.2 15729.9 5988.3 6043.3 6092.6 6156.7 6283.9 1081.4 1109.7 1113.4 1124.9 1136.7 27424.5 27470.0 27600.0 27817.7 27926.6 1161.2 1176.2 1212.0 1225.5 1234.7 13465.6 13492.0 13528.0 13528.6 13607.5 244086.0 245917.0 245924.0 246517.0 247143.0 51342.2 51907.7 51989.7 52102.7 52105.7 1480.1 1518.9 1529.1 1530.7 1535.2 23780.9 24944.1 25056.3 25262.2 25298.4 39106.4 39301.0 39385.8 39396.4 39415.4 214368.0 216835.0 217137.0 217316.0 217318.0 28269.6 29037.0 29060.1 34026.3 34302.1 37334.4 38221.0 38599.2 39481.2 40028.2 29635.3 29855.4 29903.3 30044.7 30650.5 29474.4 30056.4 30393.5 30419.4 30442.5 35052.6 35118.3 35222.3 35293.5 35409.3 28130.9 28736.1 28751.3 29329.7 29500.0 23865.6 24195.6 24313.4 24403.0 24642.9 07:14:04 INFO - PID 6837 | 07:14:04 INFO - PID 6837 | [#2] jquery.html Cycles:180 Average:29581.93 Median:2226.56 stddev:75363.49 (3384.8%) stddev-sans-first:75543.12 07:14:04 INFO - PID 6837 | Values: 428.8 442.6 444.0 456.9 462.9 18743.3 19637.1 20236.6 20355.3 20368.4 20887.9 21393.0 21890.7 22006.6 22149.3 5479.4 5671.7 5678.0 5679.3 5680.7 4991.7 5038.1 5519.7 5531.4 5580.6 5486.6 5498.0 5499.9 5521.7 5522.2 5452.5 5527.3 5571.6 5606.7 5606.8 5098.3 5120.9 5125.5 5129.8 5134.6 24007.4 24043.0 24163.3 24179.5 24338.8 2144.9 2148.1 2156.4 2183.0 2220.5 15579.4 16216.0 16278.3 16529.1 16862.1 2185.0 2222.7 2269.4 2275.4 2298.1 97288.5 97957.5 98377.0 98802.5 99123.5 12260.5 12294.2 12454.9 12562.9 12647.9 17616.5 17634.5 17656.6 17686.4 17738.1 8663.5 8897.2 9047.4 9059.7 9083.8 8239.9 8242.4 8280.4 8385.5 8453.5 7776.7 7921.3 8035.1 8068.5 8080.8 2180.6 2230.4 2235.6 2289.6 2317.3 1053.5 1071.5 1076.6 1089.5 1109.1 20466.5 20633.5 20686.8 20711.8 21053.6 1101.8 1104.2 1108.2 1111.0 1112.4 10936.8 11390.3 11422.1 11540.2 11591.3 446736.0 448987.0 456607.0 457978.0 458409.0 92366.5 93629.5 94140.0 95799.0 96506.0 1194.5 1253.3 1263.0 1263.6 1272.0 16515.4 17043.3 17258.2 17813.1 18215.1 44559.0 45584.3 45828.8 46730.0 48326.5 59724.7 59979.4 60368.0 61163.7 61408.0 9561.2 9720.8 9880.3 9912.0 10149.8 15227.0 15339.1 15371.3 15665.4 15761.8 12045.9 12456.6 12507.2 12547.8 13119.3 12349.3 12489.9 12635.6 12957.9 13169.5 13256.3 13627.6 13854.8 13938.9 14146.6 9656.4 9660.2 9699.6 10032.1 10214.8 12417.6 12749.2 12970.9 13348.4 13465.4 07:14:04 INFO - PID 6837 | 07:14:04 INFO - PID 6837 | [#3] mootools.html Cycles:180 Average:6788.71 Median:3938.71 stddev:4295.03 (109.0%) stddev-sans-first:4286.48 07:14:04 INFO - PID 6837 | Values: 1191.2 1326.9 1356.7 1364.3 1369.2 8950.6 10449.9 10898.0 11027.9 11033.5 10725.9 10834.6 10852.0 10864.3 10873.6 2180.2 2224.6 2225.8 2227.1 2228.9 1920.7 1987.3 2176.1 2272.2 2278.1 2166.7 2191.2 2191.8 2193.2 2193.6 2153.3 2154.0 2177.0 2186.3 2191.7 2122.1 2132.4 2154.0 2169.9 2194.6 10228.0 10441.5 10442.7 10445.4 10449.5 5975.5 6175.0 6179.8 6180.2 6182.0 3756.5 3954.1 3964.0 3984.6 4033.1 1168.1 1194.2 1300.6 1300.7 1309.9 15851.5 15861.1 15863.2 15872.9 15884.4 5211.2 5229.1 5380.4 5500.7 5510.9 13387.4 13389.3 13407.6 13408.7 13422.8 6368.5 6369.8 6373.6 6374.7 6379.2 5741.7 5807.1 5810.4 5874.5 5878.7 3918.4 4043.9 4357.9 4502.7 4544.3 1281.0 1322.7 1323.1 1348.8 1356.8 873.3 893.9 900.9 907.3 913.9 6606.3 6639.1 6668.7 6748.8 6823.2 969.2 974.1 975.8 980.0 992.6 3923.3 3975.2 4003.2 4020.5 4030.2 13552.3 14022.8 14060.3 14071.2 14091.7 13459.9 13828.6 13843.9 13866.3 13886.5 8493.8 8704.0 8710.8 8713.0 8720.6 6639.2 6669.2 6895.7 6936.9 7097.8 12303.8 12483.8 12514.7 12635.7 12791.4 12579.4 12658.7 12755.8 12779.0 12927.5 8800.6 8967.7 8976.8 8983.7 8994.4 9909.6 10149.9 10272.5 10279.1 10295.6 8611.5 8687.4 8734.2 8814.1 8843.9 8461.9 8489.8 8581.5 8612.3 8742.9 7751.1 7858.8 7861.9 7865.7 7868.0 5624.5 5662.7 5664.2 5714.5 5873.7 5544.4 5612.2 5628.8 5704.5 5774.1 07:14:04 INFO - PID 6837 | 07:14:04 INFO - PID 6837 | [#4] prototype.html Cycles:180 Average:5218.01 Median:5851.75 stddev:1475.23 (25.2%) stddev-sans-first:1434.23 07:14:04 INFO - PID 6837 | Values: 392.7 396.9 415.5 415.6 421.6 5820.3 5848.4 5865.5 5875.3 5901.5 5612.9 5613.0 5792.7 5803.7 5815.6 4537.8 4548.4 4558.8 4567.6 4574.0 4550.4 4550.5 4551.1 4563.4 4582.7 4470.4 4544.9 4554.5 4558.3 4560.2 4528.0 4535.2 4536.5 4550.7 4557.1 4093.5 4097.6 4113.4 4118.4 4132.3 5491.7 5635.6 5673.6 5678.2 5688.9 5359.1 5366.2 5370.9 5372.5 5386.0 6168.8 6176.6 6177.9 6181.4 6182.5 4522.7 4638.5 4676.1 4731.0 4736.6 6164.8 6270.3 6321.4 6420.8 6494.3 4855.2 4856.9 4872.8 4886.0 4891.6 4628.8 4728.6 4926.9 4937.8 4954.6 5339.0 5414.6 5437.5 5458.2 5461.7 6195.2 6214.6 6221.2 6240.3 6243.9 1685.8 1713.8 1723.6 1733.1 1737.5 1211.3 1227.6 1241.9 1252.7 1253.4 5848.0 5851.2 5859.0 5894.9 5922.5 6294.7 6352.3 6356.0 6412.9 6413.7 5718.2 5836.3 5852.4 5859.3 5873.3 3339.2 3355.7 3362.8 3383.3 3390.4 6416.9 6537.0 6547.5 6587.5 6635.9 6396.2 6423.4 6434.4 6468.3 6470.6 6407.6 6426.5 6547.6 6562.8 6570.1 6322.7 6328.9 6340.0 6347.3 6369.5 5918.3 6003.8 6120.2 6285.6 6337.0 6469.6 6470.8 6478.5 6493.0 6507.3 4647.0 4721.6 4730.4 4734.4 4746.7 6203.6 6261.7 6271.1 6284.0 6296.9 6066.5 6082.3 6102.6 6111.8 6117.9 5968.7 6030.5 6103.6 6105.6 6127.1 6041.1 6060.3 6064.9 6083.1 6100.4 5885.2 6056.7 6078.6 6101.5 6143.2 5884.8 5903.8 5913.9 5921.8 5928.9 07:14:04 INFO - PID 6837 | 07:14:04 INFO - PID 6837 | [#5] yui.html Cycles:180 Average:18443.74 Median:18147.00 stddev:21987.17 (121.2%) stddev-sans-first:22009.08 07:14:04 INFO - PID 6837 | Values: 833.5 842.1 855.1 858.7 860.7 13451.6 14133.3 16564.4 17191.5 17264.7 16858.5 17087.9 17184.4 17982.6 18085.0 1018.2 1037.7 1044.0 1044.0 1044.9 740.1 1032.0 1033.1 1034.7 1034.7 818.7 1027.8 1060.1 1066.6 1071.1 1054.6 1055.1 1055.7 1055.7 1055.8 779.9 780.6 781.0 781.1 781.5 16427.7 16580.5 16703.0 17493.6 17873.5 16407.2 16541.5 16736.7 16779.0 17031.1 14512.7 14868.7 14994.3 15056.5 15227.7 3552.6 3574.8 3588.7 3590.1 3591.1 88896.6 91645.5 92082.1 92134.0 92747.0 14551.5 14808.8 15021.4 15036.7 15071.9 26572.5 26707.3 27341.3 27543.6 27572.4 7032.7 7277.3 7289.9 7293.6 7963.8 3874.5 3992.2 3994.3 4005.5 4009.7 4269.2 4745.5 4898.6 4918.3 4928.9 916.3 938.1 944.3 953.6 957.4 720.8 724.5 741.8 748.8 760.2 11990.8 12671.2 13324.6 13508.3 13543.7 726.8 731.1 738.5 744.0 756.0 5436.8 6061.4 6065.6 6141.6 6452.1 70587.0 73071.0 75103.0 77200.6 83056.6 63128.0 64008.0 65661.0 65720.0 68486.7 61257.7 61911.0 62130.0 62358.7 62501.7 12844.9 13389.0 13465.2 13636.2 13669.5 31497.8 31518.4 31638.2 32872.7 32987.3 39465.2 39748.6 39970.0 40494.2 40926.8 14321.1 15441.2 15813.3 15924.2 16190.3 17951.6 18087.0 18130.8 18163.2 18592.6 16551.1 16662.1 16695.8 16845.5 17003.5 17030.7 17086.2 17096.6 17110.0 17312.1 17243.7 17297.5 17492.5 17607.1 17660.6 12633.2 12863.4 12989.7 13345.8 13753.3 13943.7 14695.6 14704.6 14928.1 15401.5 07:14:04 INFO - PID 6837 | -------- Summary: end -------- 07:14:04 INFO - PID 6837 | 07:14:05 INFO - TEST-INFO | 6837: exit 0 07:14:05 INFO - TEST-OK | dromaeo_css | took 1115572ms 07:14:05 INFO - TEST-START | kraken 07:14:05 INFO - operating with platform_type : linux_ 07:14:05 INFO - Initialising browser for kraken test... 07:14:05 INFO - TEST-INFO | started process 7167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphtfyNK/profile http://localhost:48513/getInfo.html) 07:14:08 INFO - PID 7167 | __metrics Screen width/height:1600/1200 07:14:08 INFO - PID 7167 | colorDepth:24 07:14:08 INFO - PID 7167 | Browser inner width/height: 1024/695 07:14:08 INFO - PID 7167 | __metrics 07:14:09 INFO - PID 7167 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:14:09 INFO - PID 7167 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:14:10 INFO - TEST-INFO | 7167: exit 0 07:14:10 INFO - Browser initialized. 07:14:10 INFO - Running cycle 1/1 for kraken test... 07:14:10 INFO - TEST-INFO | started process 7266 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphtfyNK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:14:22 INFO - PID 7266 | RSS: Main: 145215488 07:14:22 INFO - PID 7266 | 07:14:24 INFO - PID 7266 | Cycle 1(1): loaded http://localhost:48513/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48513/tests/kraken/driver.html?testName=audio-beat-detection) 07:14:25 INFO - PID 7266 | RSS: Main: 217407488 07:14:25 INFO - PID 7266 | 07:14:28 INFO - PID 7266 | Cycle 1(1): loaded http://localhost:48513/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48513/tests/kraken/driver.html?testName=audio-dft) 07:14:28 INFO - PID 7266 | RSS: Main: 178933760 07:14:28 INFO - PID 7266 | 07:14:31 INFO - PID 7266 | Cycle 1(1): loaded http://localhost:48513/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48513/tests/kraken/driver.html?testName=audio-fft) 07:14:32 INFO - PID 7266 | RSS: Main: 260513792 07:14:32 INFO - PID 7266 | 07:14:34 INFO - PID 7266 | Cycle 1(1): loaded http://localhost:48513/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48513/tests/kraken/driver.html?testName=audio-oscillator) 07:14:34 INFO - PID 7266 | RSS: Main: 171356160 07:14:34 INFO - PID 7266 | 07:14:36 INFO - PID 7266 | Cycle 1(1): loaded http://localhost:48513/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48513/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:14:37 INFO - PID 7266 | RSS: Main: 174723072 07:14:37 INFO - PID 7266 | 07:14:40 INFO - PID 7266 | Cycle 1(1): loaded http://localhost:48513/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48513/tests/kraken/driver.html?testName=imaging-darkroom) 07:14:41 INFO - PID 7266 | RSS: Main: 234242048 07:14:41 INFO - PID 7266 | 07:14:44 INFO - PID 7266 | Cycle 1(1): loaded http://localhost:48513/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48513/tests/kraken/driver.html?testName=imaging-desaturate) 07:14:45 INFO - PID 7266 | RSS: Main: 254849024 07:14:45 INFO - PID 7266 | 07:14:47 INFO - PID 7266 | Cycle 1(1): loaded http://localhost:48513/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48513/tests/kraken/driver.html?testName=json-parse-financial) 07:14:48 INFO - PID 7266 | RSS: Main: 268619776 07:14:48 INFO - PID 7266 | 07:14:49 INFO - PID 7266 | Cycle 1(1): loaded http://localhost:48513/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48513/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:14:50 INFO - PID 7266 | RSS: Main: 199380992 07:14:50 INFO - PID 7266 | 07:14:52 INFO - PID 7266 | Cycle 1(1): loaded http://localhost:48513/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48513/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:14:52 INFO - PID 7266 | RSS: Main: 203677696 07:14:52 INFO - PID 7266 | 07:14:54 INFO - PID 7266 | Cycle 1(1): loaded http://localhost:48513/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48513/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:14:55 INFO - PID 7266 | RSS: Main: 213225472 07:14:55 INFO - PID 7266 | 07:14:57 INFO - PID 7266 | Cycle 1(1): loaded http://localhost:48513/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48513/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:14:58 INFO - PID 7266 | RSS: Main: 222711808 07:14:58 INFO - PID 7266 | 07:15:01 INFO - PID 7266 | Cycle 1(1): loaded http://localhost:48513/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48513/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:15:02 INFO - PID 7266 | RSS: Main: 218488832 07:15:02 INFO - PID 7266 | 07:15:03 INFO - PID 7266 | Cycle 1(1): loaded http://localhost:48513/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48513/tests/kraken/driver.html?testName=ai-astar) 07:15:03 INFO - PID 7266 | RSS: Main: 267735040 07:15:03 INFO - PID 7266 | 07:15:03 INFO - PID 7266 | __start_tp_report 07:15:03 INFO - PID 7266 | _x_x_mozilla_page_load 07:15:03 INFO - PID 7266 | _x_x_mozilla_page_load_details 07:15:03 INFO - PID 7266 | |i|pagename|runs| 07:15:03 INFO - PID 7266 | |0;ai-astar;107;111;112;110;110;110;110;112;110;110 07:15:03 INFO - PID 7266 | |1;audio-beat-detection;150;122;122;170;118;117;121;119;137;116 07:15:03 INFO - PID 7266 | |2;audio-dft;161;164;161;160;163;160;161;160;160;159 07:15:03 INFO - PID 7266 | |3;audio-fft;74;75;74;111;74;74;76;73;93;75 07:15:03 INFO - PID 7266 | |4;audio-oscillator;83;82;115;82;82;82;97;82;82;106 07:15:03 INFO - PID 7266 | |5;imaging-gaussian-blur;113;113;113;113;114;113;113;113;114;113 07:15:03 INFO - PID 7266 | |6;imaging-darkroom;146;147;147;146;146;147;146;149;147;147 07:15:03 INFO - PID 7266 | |7;imaging-desaturate;94;95;93;94;93;93;93;94;94;94 07:15:03 INFO - PID 7266 | |8;json-parse-financial;48;46;47;47;48;48;47;50;49;47 07:15:03 INFO - PID 7266 | |9;json-stringify-tinderbox;56;54;53;54;55;54;54;55;54;54 07:15:03 INFO - PID 7266 | |10;stanford-crypto-aes;80;79;81;79;80;79;85;79;78;79 07:15:03 INFO - PID 7266 | |11;stanford-crypto-ccm;134;126;123;124;122;123;123;122;170;127 07:15:03 INFO - PID 7266 | |12;stanford-crypto-pbkdf2;187;187;184;186;183;176;183;186;186;185 07:15:03 INFO - PID 7266 | |13;stanford-crypto-sha256-iterative;68;65;65;66;65;67;66;67;66;66 07:15:03 INFO - PID 7266 | __end_tp_report 07:15:03 INFO - PID 7266 | __start_cc_report 07:15:03 INFO - PID 7266 | _x_x_mozilla_cycle_collect,1641 07:15:03 INFO - PID 7266 | __end_cc_report 07:15:03 INFO - PID 7266 | __startTimestamp1494598503911__endTimestamp 07:15:03 INFO - PID 7266 | 07:15:03 INFO - PID 7266 | ------- Summary: start ------- 07:15:03 INFO - PID 7266 | Number of tests: 14 07:15:03 INFO - PID 7266 | 07:15:03 INFO - PID 7266 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.00 stddev:1.40 (1.3%) stddev-sans-first:0.88 07:15:03 INFO - PID 7266 | Values: 107.0 111.0 112.0 110.0 110.0 110.0 110.0 112.0 110.0 110.0 07:15:03 INFO - PID 7266 | 07:15:03 INFO - PID 7266 | [#1] audio-beat-detection Cycles:10 Average:129.20 Median:122.00 stddev:17.89 (14.7%) stddev-sans-first:17.32 07:15:03 INFO - PID 7266 | Values: 150.0 122.0 122.0 170.0 118.0 117.0 121.0 119.0 137.0 116.0 07:15:03 INFO - PID 7266 | 07:15:03 INFO - PID 7266 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.52 (0.9%) stddev-sans-first:1.62 07:15:03 INFO - PID 7266 | Values: 161.0 164.0 161.0 160.0 163.0 160.0 161.0 160.0 160.0 159.0 07:15:03 INFO - PID 7266 | 07:15:03 INFO - PID 7266 | [#3] audio-fft Cycles:10 Average:79.90 Median:74.50 stddev:12.42 (16.7%) stddev-sans-first:12.99 07:15:03 INFO - PID 7266 | Values: 74.0 75.0 74.0 111.0 74.0 74.0 76.0 73.0 93.0 75.0 07:15:03 INFO - PID 7266 | 07:15:03 INFO - PID 7266 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:82.00 stddev:12.28 (15.0%) stddev-sans-first:12.82 07:15:03 INFO - PID 7266 | Values: 83.0 82.0 115.0 82.0 82.0 82.0 97.0 82.0 82.0 106.0 07:15:03 INFO - PID 7266 | 07:15:03 INFO - PID 7266 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:15:03 INFO - PID 7266 | Values: 113.0 113.0 113.0 113.0 114.0 113.0 113.0 113.0 114.0 113.0 07:15:03 INFO - PID 7266 | 07:15:03 INFO - PID 7266 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 07:15:03 INFO - PID 7266 | Values: 146.0 147.0 147.0 146.0 146.0 147.0 146.0 149.0 147.0 147.0 07:15:03 INFO - PID 7266 | 07:15:03 INFO - PID 7266 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 07:15:03 INFO - PID 7266 | Values: 94.0 95.0 93.0 94.0 93.0 93.0 93.0 94.0 94.0 94.0 07:15:03 INFO - PID 7266 | 07:15:03 INFO - PID 7266 | [#8] json-parse-financial Cycles:10 Average:47.70 Median:48.00 stddev:1.16 (2.4%) stddev-sans-first:1.22 07:15:03 INFO - PID 7266 | Values: 48.0 46.0 47.0 47.0 48.0 48.0 47.0 50.0 49.0 47.0 07:15:03 INFO - PID 7266 | 07:15:03 INFO - PID 7266 | [#9] json-stringify-tinderbox Cycles:10 Average:54.30 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.60 07:15:03 INFO - PID 7266 | Values: 56.0 54.0 53.0 54.0 55.0 54.0 54.0 55.0 54.0 54.0 07:15:03 INFO - PID 7266 | 07:15:03 INFO - PID 7266 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.50 stddev:1.97 (2.5%) stddev-sans-first:2.09 07:15:03 INFO - PID 7266 | Values: 80.0 79.0 81.0 79.0 80.0 79.0 85.0 79.0 78.0 79.0 07:15:03 INFO - PID 7266 | 07:15:03 INFO - PID 7266 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:125.00 stddev:14.71 (11.8%) stddev-sans-first:15.51 07:15:03 INFO - PID 7266 | Values: 134.0 126.0 123.0 124.0 122.0 123.0 123.0 122.0 170.0 127.0 07:15:03 INFO - PID 7266 | 07:15:03 INFO - PID 7266 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.30 Median:186.00 stddev:3.27 (1.8%) stddev-sans-first:3.32 07:15:03 INFO - PID 7266 | Values: 187.0 187.0 184.0 186.0 183.0 176.0 183.0 186.0 186.0 185.0 07:15:03 INFO - PID 7266 | 07:15:03 INFO - PID 7266 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:0.99 (1.5%) stddev-sans-first:0.78 07:15:03 INFO - PID 7266 | Values: 68.0 65.0 65.0 66.0 65.0 67.0 66.0 67.0 66.0 66.0 07:15:03 INFO - PID 7266 | -------- Summary: end -------- 07:15:03 INFO - PID 7266 | 07:15:05 INFO - TEST-INFO | 7266: exit 0 07:15:05 INFO - TEST-OK | kraken | took 59853ms 07:15:05 INFO - SUITE-END | took 1175s 07:15:05 INFO - Completed test suite (00:19:35) 07:15:05 INFO - javascript benchmark 07:15:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7607.770727167537, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3280.245543524989, 3287.424700677382, 3294.110590140662, 3314.718248948839, 3344.8829290974804, 5616.297962754656, 5741.626794258381, 5765.13522971554, 5769.365369809318, 5791.59458837881, 5691.886162276752, 5752.0, 5754.395788442205, 5809.593328467009, 5824.912626310609, 4675.8831029224375, 4964.900701985958, 5049.9747501262445, 5050.292958985727, 5153.871153221162, 5122.948770512285, 5171.5862730981435, 5174.068667639824, 5192.169252919533, 5202.947970520303, 5007.349044624212, 5073.036123136629, 5091.694498330112, 5175.45657705943, 5197.818076367347, 5119.129747942859, 5122.0, 5133.743312834344, 5136.178211486182, 5186.7147306898105, 5056.0, 5115.923261151086, 5122.359705036871, 5127.743612819344, 5161.329027226474, 5488.890222195534, 5563.388027316992, 5646.378898321182, 5714.942850571482, 5752.8849423011725, 6218.19163508741, 6232.8130156095385, 6233.189685340922, 6239.251289845248, 6239.906401403937, 6256.468200202989, 6261.373862613747, 6284.151639528696, 6287.622742635456, 6292.339304373067, 5634.070378387521, 5645.774169033275, 5792.364474164245, 5812.041013232812, 5814.563907706896, 6211.192544969125, 6302.716377763011, 6336.17629708135, 6350.460210882126, 6352.872942541123, 5998.550108741862, 6082.695865206811, 6084.513238940963, 6087.726052327655, 6145.385461453819, 6219.284782250009, 6245.656488893154, 6261.968690156611, 6275.843103922439, 6282.685865706788, 5994.6403215807195, 6069.908951365733, 6237.844053898598, 6243.188385509946, 6248.281447633581, 6133.294671112879, 6134.846828498841, 6173.660448675366, 6177.69111544421, 6184.350643182491, 4716.3868697069165, 4717.669763116617, 4718.05638872227, 4756.453007904066, 4757.476677565465, 4133.91732165361, 4202.957970420257, 4204.411382406465, 4207.053412982054, 4240.215560121387, 5741.913871291934, 5770.19217309577, 5865.120231965239, 5875.764969401176, 5880.353161152269, 6089.604175728564, 6154.1999540059505, 6162.414570615784, 6168.568200225941, 6176.4441200292185, 5710.571707121982, 5712.828615141552, 5717.342505611825, 5721.77112915487, 5739.655620662774, 5104.821331253388, 5125.308083408692, 5191.039657663345, 5193.610479214074, 5195.558377537876, 6281.780137695158, 6377.681115944184, 6520.18497687789, 6523.67381630907, 6530.151080359523, 6271.278802937721, 6273.52948528853, 6273.62358258506, 6278.811635650938, 6286.5599408041, 6365.981442969102, 6471.514636402195, 6484.157059582224, 6490.091387205701, 6491.5131365148745, 6005.039193728982, 6056.818295451144, 6058.57589968698, 6062.484688801501, 6129.419919118862, 6065.181200537871, 6188.195534580475, 6228.5951413158, 6243.500519958302, 6245.9063114052415, 5953.910691339547, 5981.641101533922, 6012.849678758066, 6039.063945088518, 6139.969300153471, 6068.423499767515, 6073.453389194994, 6076.3012253591405, 6087.786927457695, 6115.449609535163, 5866.7066646668345, 6036.69816509164, 6053.3946605339115, 6072.119542666377, 6076.179715738319, 5964.821055368346, 6038.63768173911, 6084.452399284086, 6133.938660613337, 6139.109829074849, 5959.940400595939, 5982.4316689914385, 5995.160677505066, 6001.459868611846, 6006.309274433496], "value": 5666.191210403712, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.5297303779506, 772.7874834420534, 787.2717736094112, 1146.7935771561115, 1163.2903928603555, 30195.69804301956, 34785.478217826756, 37762.622373776285, 38157.80921095398, 38197.23605527895, 40976.795116024456, 41313.0, 41325.79337103318, 41353.37969930453, 41519.37720934188, 5575.637583557056, 7115.18175409828, 7182.17404998424, 7238.782836514913, 7245.239249878766, 5672.773089076432, 7054.717811287543, 7238.782836514887, 7239.276072392771, 7243.203247642755, 7283.0, 7327.963360183192, 7343.449241306924, 7346.522476039067, 7347.044884165051, 5644.971775141139, 7250.746223882165, 7273.745418910313, 7294.379977701875, 7299.854002919912, 5738.196652468658, 6718.3953444189765, 6818.624975626339, 6822.897656535156, 6827.52207345486, 35509.46735798965, 35876.46185307222, 35915.0, 35982.820085899664, 35991.0, 3519.542459480251, 3575.4994300797907, 3576.302620988908, 3583.140046388874, 3585.4621806728937, 27875.58186627182, 27899.302517437227, 27903.720962790314, 27952.440951181066, 27967.0, 3703.8888833335045, 3759.4172903200047, 3760.6427389397963, 3773.811309434517, 3804.334241507725, 180123.0, 180175.0, 180399.0, 180585.0, 180818.0, 46056.769716151204, 46188.7690561545, 46324.305135423, 46346.0, 46401.0, 48082.51917480781, 48167.0, 48219.276710848666, 48226.517734822206, 48237.0, 14815.703685926437, 14847.925760371345, 14954.925225373803, 14978.325975331136, 14979.251037448084, 10671.893281067245, 10859.674209773719, 12535.31055791922, 12541.247525148521, 12552.686182845502, 15157.393704251926, 15368.61578460525, 15517.84482155164, 15597.220138993232, 15729.921350393175, 5988.305262631833, 6043.305019922677, 6092.634441933498, 6156.661383623944, 6283.905741413882, 1081.3674000709516, 1109.7225693576606, 1113.4265853085506, 1124.876263611002, 1136.664683918246, 27424.45151096967, 27470.0, 27600.0, 27817.721822781514, 27926.581101283497, 1161.2451906260828, 1176.1825531255695, 1211.9757604847853, 1225.522046401904, 1234.6851552853964, 13465.596032119052, 13492.0, 13528.0, 13528.594142175554, 13607.523736669169, 244086.0, 245917.0, 245924.0, 246517.0, 247143.0, 51342.22986655203, 51907.74046129745, 51989.7400512995, 52102.73948630233, 52105.739471302404, 1480.141517919604, 1518.9088654680534, 1529.1283968138055, 1530.6862093270852, 1535.1863512338477, 23780.881095595105, 24944.12695555647, 25056.31606307356, 25262.242132736046, 25298.36754081089, 39106.4134037984, 39301.0, 39385.80307098561, 39396.40905386479, 39415.408768867914, 214368.0, 216835.0, 217137.0, 217316.0, 217318.0, 28269.57595636108, 29037.0, 29060.12819615415, 34026.319473609896, 34302.14244643904, 37334.43998339973, 38221.0, 38599.228015440094, 39481.2103757929, 40028.19943601053, 29635.259118522208, 29855.402891942475, 29903.252418689706, 30044.699553005066, 30650.540241896837, 29474.410511790073, 30056.398872022, 30393.544096838123, 30419.391612168074, 30442.543361850032, 35052.64947350596, 35118.29763404769, 35222.29555408826, 35293.47059794157, 35409.29181416306, 28130.859345703142, 28736.137915862557, 28751.281217969718, 29329.706702932697, 29500.0, 23865.64201537013, 24195.63706544368, 24313.39216519601, 24403.0, 24642.876785615957], "value": 16713.727343527822, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.81775245520663, 442.63924901205536, 443.95782400671936, 456.9428821397323, 462.92824612185103, 18743.34398296058, 19637.11632976516, 20236.59526809463, 20355.28756493523, 20368.388948331554, 20887.895560522174, 21393.0373133209, 21890.671639925375, 22006.559868802615, 22149.335519934386, 5479.424660410649, 5671.744771485272, 5677.9716101419435, 5679.318481782192, 5680.744366503496, 4991.7304165771475, 5038.143515602356, 5519.69641669708, 5531.419200983879, 5580.6372585782, 5486.643368181056, 5497.972510137443, 5499.862503437406, 5521.668699878, 5522.171674248854, 5452.454754524555, 5527.336719593654, 5571.582131340146, 5606.719664016824, 5606.775728970836, 5098.337216161875, 5120.871978200575, 5125.487451254882, 5129.769160387754, 5134.64057515974, 24007.399815004588, 24043.0, 24163.2751017468, 24179.51640967171, 24338.756612433826, 2144.8713077215416, 2148.076327179312, 2156.353094071788, 2182.978170218293, 2220.544788318391, 15579.376824927103, 16216.0, 16278.26747796352, 16529.090900000494, 16862.072586007765, 2184.9890750546306, 2222.688823564686, 2269.4439862233858, 2275.4083938176027, 2298.1267118495034, 97288.51355743318, 97957.5102124492, 98377.0, 98802.50598747031, 99123.50438247762, 12260.509579616893, 12294.200876943149, 12454.875451245553, 12562.937185314198, 12647.873521264853, 17616.471505854846, 17634.470965871045, 17656.646867062587, 17686.380976665754, 17738.11309434523, 8663.48019118855, 8897.199252067345, 9047.366684332033, 9059.682911098213, 9083.772905677411, 8239.917600824036, 8242.423030387816, 8280.378971577156, 8385.454945428528, 8453.492790432594, 7776.688932442752, 7921.32668723165, 8035.116137224901, 8068.47554908929, 8080.757577272691, 2180.618391781432, 2230.431240033781, 2235.6335873297526, 2289.610766169755, 2317.2584772872856, 1053.5364439646685, 1071.50175168547, 1076.56399158341, 1089.536946797608, 1109.1293334732197, 20466.488337791674, 20633.484162895747, 20686.79313206879, 20711.792882071288, 21053.578928421346, 1101.8181999969916, 1104.2435931387026, 1108.2020944919645, 1110.9944450277696, 1112.3770688414513, 10936.835947460795, 11390.25963312382, 11422.14333924959, 11540.24988375753, 11591.304521728724, 446736.0, 448987.020259593, 456607.0, 457978.0, 458409.0, 92366.53816730874, 93629.5318523403, 94140.0, 95799.0, 96506.0, 1194.498310709504, 1253.310679126495, 1262.9810552841714, 1263.5703860687227, 1271.9809202861964, 16515.421960231335, 17043.257582191563, 17258.223379948184, 17813.109344532462, 18215.089245537405, 44559.0, 45584.316235255836, 45828.77085614551, 46730.0, 48326.5167348322, 59724.70137649284, 59979.40020599738, 60368.0, 61163.69418152881, 61408.0, 9561.187299079378, 9720.756981075247, 9880.258980576342, 9911.950440247752, 10149.797004060025, 15227.0, 15339.079655220723, 15371.308291126703, 15665.37338506447, 15761.842381576496, 12045.939770301093, 12456.56402025961, 12507.187032842836, 12547.811782823448, 13119.344032798514, 12349.259044457362, 12489.93755031219, 12635.620931372074, 12957.870421295667, 13169.53906613264, 13256.270905099926, 13627.591172264847, 13854.792178117135, 13938.93030534841, 14146.646333841736, 9656.37233579815, 9660.178884794872, 9699.612015519582, 10032.097111260022, 10214.795704086026, 12417.565385211474, 12749.235045897276, 12970.935145324212, 13348.399322030338, 13465.431660610142], "value": 10128.98021455432, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1191.225703292859, 1326.907116501845, 1356.7015256643535, 1364.2632978191778, 1369.246914197192, 8950.55247237638, 10449.895501044997, 10898.0, 11027.944860275707, 11033.503492342834, 10725.892741072586, 10834.620788272412, 10852.0, 10864.348139111658, 10873.565057397715, 2180.160638154306, 2224.644056950888, 2225.8441909066373, 2227.086894373307, 2228.8774117423536, 1920.7310976463236, 1987.33424302858, 2176.064292354287, 2272.227442669492, 2278.111536500766, 2166.7183266175375, 2191.189259973812, 2191.7698641642637, 2193.1885202475105, 2193.583219188349, 2153.3432303147533, 2153.967690484644, 2177.0203408466173, 2186.3331683836423, 2191.6712493126, 2122.0875023739786, 2132.3709505695856, 2154.0, 2169.945751356213, 2194.6049711052005, 10228.0, 10441.477926103664, 10442.68671939843, 10445.425501597409, 10449.529771160316, 5975.52195824333, 6174.969125154345, 6179.81460556184, 6180.196574445294, 6181.9690901545655, 3756.530433695788, 3954.1498577805623, 3964.0, 3984.5816189300285, 4033.052232725307, 1168.1297433412162, 1194.199886076331, 1300.6423233610737, 1300.6863068301084, 1309.9148555343872, 15851.524454266391, 15861.127637979907, 15863.20683965797, 15872.920635396864, 15884.444044458389, 5211.166213405837, 5229.137192363293, 5380.408155102936, 5500.724963751796, 5510.862228444321, 13387.397567109503, 13389.330533473287, 13407.597772066854, 13408.731825363438, 13422.798658020138, 6368.4586810121655, 6369.777057803048, 6373.617582944946, 6374.681265936684, 6379.170707807955, 5741.655500669973, 5807.128930660435, 5810.448007439287, 5874.471297583238, 5878.706064696748, 3918.3730603103936, 4043.8584649537124, 4357.934630980538, 4502.71672573315, 4544.318352247124, 1280.9679758006125, 1322.6627210061565, 1323.0540163782941, 1348.8313960754906, 1356.7557839588771, 873.3362644390182, 893.9374243802871, 900.8513595256841, 907.2832462354797, 913.862920561921, 6606.339366063356, 6639.1037209977, 6668.733250669919, 6748.797536073926, 6823.249442561314, 969.2246203037682, 974.0794948773482, 975.7950830325711, 979.9563464909849, 992.6079198716467, 3923.2741942740686, 3975.2248311578965, 4003.159336539301, 4020.4572382727956, 4030.1738143680477, 13552.322383880766, 14022.789658155136, 14060.296985150702, 14071.226082565558, 14091.71816563663, 13459.865401345862, 13828.585142445743, 13843.86156138446, 13866.306684665726, 13886.513972010931, 8493.787655308543, 8703.95648021756, 8710.82578348442, 8712.956435217657, 8720.607572659246, 6639.203295604559, 6669.233038200669, 6895.6552172392185, 6936.930630693629, 7097.751578694721, 12303.815442768187, 12483.812742808683, 12514.74970500603, 12635.74728505443, 12791.36043197855, 12579.371031448209, 12658.683532911751, 12755.80866287025, 12779.04157188196, 12927.5475358362, 8800.60397282111, 8967.730968070968, 8976.82046359056, 8983.730488085368, 8994.415363001384, 9909.55407006672, 10149.898501014895, 10272.537735802056, 10279.074883260542, 10295.639652612123, 8611.526366049928, 8687.39188256816, 8734.170253825876, 8814.118588141135, 8843.867341990004, 8461.915380846112, 8489.787755306166, 8581.485110893367, 8612.267957223707, 8742.868856967023, 7751.147373788766, 7858.803529911798, 7861.921380786348, 7865.724699635485, 7867.9606601966625, 5624.521915637217, 5662.745176466987, 5664.150377443417, 5714.542836573148, 5873.73568189424, 5544.417836127149, 5612.186232996274, 5628.831135065954, 5704.515116215168, 5774.133879918046], "value": 5144.846812625915, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.6976228304206, 396.9166475040241, 415.50139832201364, 415.62801292842903, 421.59526854219945, 5820.301563812343, 5848.356680765112, 5865.472107510323, 5875.266796295093, 5901.498372638325, 5612.859678508039, 5613.0, 5792.71036448177, 5803.738831752571, 5815.62198457101, 4537.773111344428, 4548.363229147922, 4558.794854231551, 4567.634589232854, 4573.977130114345, 4550.431196100488, 4550.49944506104, 4551.067031258601, 4563.361129441864, 4582.656300777455, 4470.351798989144, 4544.863654090366, 4554.453465584118, 4558.339040839076, 4560.2019646561885, 4528.0, 4535.160995215896, 4536.523665015192, 4550.658700597435, 4557.134144512532, 4093.5292441369324, 4097.631213190827, 4113.3957756475, 4118.382242663624, 4132.33882578789, 5491.7254137292975, 5635.6055076144685, 5673.574481913873, 5678.205051292823, 5688.943110568883, 5359.14253719403, 5366.221897824833, 5370.89896571202, 5372.543333816591, 5385.973070134663, 6168.814935551941, 6176.567640265183, 6177.907331390033, 6181.3818618138275, 6182.505399568024, 4522.728636281834, 4638.466576343696, 4676.134915040694, 4730.952690473086, 4736.573708366263, 6164.815055548341, 6270.31026587075, 6321.367863213688, 6420.807375778734, 6494.253160886511, 4855.150348688965, 4856.854294371175, 4872.805087796449, 4885.975570122127, 4891.559759621651, 4628.791704373311, 4728.550787675165, 4926.926096108561, 4937.753112344369, 4954.5540901319055, 5338.973305133527, 5414.592206026461, 5437.477506298243, 5458.181272809031, 5461.699606521679, 6195.2255968004, 6214.627122372672, 6221.191245138193, 6240.344763799736, 6243.906341404882, 1685.848273655377, 1713.8457538821565, 1723.5691077230692, 1733.0554847607832, 1737.4700716281402, 1211.2853416484318, 1227.6317104868504, 1241.8571864235728, 1252.680566455548, 1253.4108968784656, 5847.970760146172, 5851.151583020438, 5859.0, 5894.911576326359, 5922.526197904157, 6294.748210071546, 6352.333005034498, 6355.968220158869, 6412.935870641234, 6413.711382987777, 5718.170865224519, 5836.270466191726, 5852.356240813507, 5859.326177489558, 5873.324567674772, 3339.2486690494443, 3355.731541476676, 3362.8486718097743, 3383.2725963917874, 3390.4405773047665, 6416.871662566722, 6537.0, 6547.5416720830035, 6587.50593705474, 6635.86728265432, 6396.200474940632, 6423.389777971085, 6434.356564343529, 6468.288488266287, 6470.611763294218, 6407.597151068349, 6426.485881129592, 6547.607143571401, 6562.80311590653, 6570.145881035531, 6322.747090116344, 6328.936710633019, 6339.96830015847, 6347.333529979471, 6369.490440764635, 5918.319393269657, 6003.759849606142, 6120.225134710884, 6285.59143655661, 6336.968315158395, 6469.5794773339585, 6470.838229044311, 6478.5465017450215, 6493.0, 6507.349265073455, 4647.0, 4721.56049717429, 4730.432348118248, 4734.431868175841, 4746.715197088186, 6203.596766210182, 6261.655608941552, 6271.122042914087, 6283.968580157253, 6296.937030629819, 6066.514678825772, 6082.296956852088, 6102.603330783485, 6111.755529778759, 6117.938820611737, 5968.671723055274, 6030.547708921761, 6103.6032657877095, 6105.572609917263, 6127.080937859357, 6041.124037014696, 6060.303065147565, 6064.878702426015, 6083.117947897618, 6100.359462256399, 5885.234429670996, 6056.727447264796, 6078.635281883101, 6101.450869421773, 6143.232095988002, 5884.764609415575, 5903.763849445974, 5913.940860591339, 5921.822345329647, 5928.940710593011], "value": 4772.239996523641, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [833.4540875726401, 842.1157535441113, 855.0807881527357, 858.665120602965, 860.7460799064278, 13451.596452106429, 14133.293335333243, 16564.420245291418, 17191.48425547234, 17264.65470690587, 16858.494245172664, 17087.914560427213, 17184.398546050892, 17982.5504362391, 18085.0, 1018.2210608884191, 1037.704254287528, 1044.0342683018216, 1044.0394836750208, 1044.8693913260843, 740.1488288468278, 1031.9896801032007, 1033.1063629960106, 1034.6689059500964, 1034.7413146713322, 818.6970820796314, 1027.8201314769922, 1060.1306928318782, 1066.648006157966, 1071.0681706914995, 1054.562356622001, 1055.1400608504046, 1055.7255113670424, 1055.7413433708791, 1055.8046761349137, 779.898613180283, 780.594091072639, 781.0276206123356, 781.1056340490107, 781.4607920534813, 16427.671446571123, 16580.502584922473, 16703.0, 17493.56266093345, 17873.463796086136, 16407.1796410179, 16541.503754887373, 16736.6652666946, 16779.0, 17031.148442577945, 14512.70974580513, 14868.702625947528, 14994.325255363536, 15056.473023444236, 15227.695446091016, 3552.573691157052, 3574.821258937043, 3588.6770190682964, 3590.120420496995, 3591.084273510264, 88896.55551722264, 91645.54177229072, 92082.07917920803, 92134.0, 92747.0, 14551.490697825526, 14808.777868331983, 15021.399144034334, 15036.699266014619, 15071.924640376728, 26572.46855062888, 26707.33231669224, 27341.316467088483, 27543.586846197322, 27572.44855102887, 7032.718691252395, 7277.272272772786, 7289.890651640229, 7293.635318234067, 7963.800904977422, 3874.4575759393706, 3992.161646054303, 3994.3409337458993, 4005.539362973237, 4009.659178969762, 4269.188854117708, 4745.549172828576, 4898.559129678346, 4918.311436398907, 4928.926066109011, 916.276141847946, 938.1275413865035, 944.3436811416, 953.6423841059602, 957.3633533700012, 720.772956518695, 724.4928550015011, 741.8293792427772, 748.8464864702723, 760.152430040512, 11990.820137697941, 12671.239725616493, 13324.600261992156, 13508.257045862376, 13543.729125417436, 726.7674344209802, 731.0605871455155, 738.5199620246882, 743.985120297591, 756.0322786832862, 5436.782528698808, 6061.393860613992, 6065.60573562717, 6141.6007959482495, 6452.064450654629, 70587.0, 73071.0, 75103.0, 77200.61399693078, 83056.58471707723, 63128.0, 64008.0, 65661.0, 65720.0, 68486.65756671184, 61257.69371153205, 61911.0, 62130.0, 62358.688206558676, 62501.687491562254, 12844.871551284368, 13389.0, 13465.192088474723, 13636.181829090287, 13669.521566745116, 31497.8425107873, 31518.36963260768, 31638.209044774067, 32872.671273286964, 32987.34025319528, 39465.210695786496, 39748.60251397449, 39970.0, 40494.19011619692, 40926.795366022976, 14321.14073155614, 15441.22793860325, 15813.288402021706, 15924.203789810232, 16190.271437785092, 17951.640967180323, 18087.0, 18130.818691812914, 18163.182656780213, 18592.628147437244, 16551.08969006716, 16662.08358540292, 16695.833041669426, 16845.494635160965, 17003.489895303162, 17030.744538832176, 17086.231119599895, 17096.57258568546, 17110.0, 17312.134393280536, 17243.7413438796, 17297.481075567754, 17492.47522574325, 17607.119644018003, 17660.558486037437, 12633.242005479333, 12863.421146048637, 12989.675258118623, 13345.799813003006, 13753.312334383441, 13943.721125577229, 14695.559133226021, 14704.55886323412, 14928.10431374121, 15401.460948866736], "value": 8231.67749417971, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1484.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 112.0, 110.0, 110.0, 110.0, 110.0, 112.0, 110.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 122.0, 122.0, 170.0, 118.0, 117.0, 121.0, 119.0, 137.0, 116.0], "value": 129.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 161.0, 160.0, 163.0, 160.0, 161.0, 160.0, 160.0, 159.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 111.0, 74.0, 74.0, 76.0, 73.0, 93.0, 75.0], "value": 79.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 115.0, 82.0, 82.0, 82.0, 97.0, 82.0, 82.0, 106.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 114.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 149.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 93.0, 94.0, 93.0, 93.0, 93.0, 94.0, 94.0, 94.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 46.0, 47.0, 47.0, 48.0, 48.0, 47.0, 50.0, 49.0, 47.0], "value": 47.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 53.0, 54.0, 55.0, 54.0, 54.0, 55.0, 54.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 81.0, 79.0, 80.0, 79.0, 85.0, 79.0, 78.0, 79.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 126.0, 123.0, 124.0, 122.0, 123.0, 123.0, 122.0, 170.0, 127.0], "value": 129.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 187.0, 184.0, 186.0, 183.0, 176.0, 183.0, 186.0, 186.0, 185.0], "value": 184.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 65.0, 66.0, 65.0, 67.0, 66.0, 67.0, 66.0, 66.0], "value": 66.1, "unit": "score"}]}]} 07:15:05 INFO - Return code: 0 07:15:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:15:05 INFO - # TBPL SUCCESS # 07:15:05 INFO - Running post-action listener: _resource_record_post_action 07:15:05 INFO - [mozharness: 2017-05-12 14:15:05.720989Z] Finished run-tests step (success) 07:15:05 INFO - Running post-run listener: _resource_record_post_run 07:15:05 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 421888; Write bytes: 393076736; Read time: 28; Write time: 234372 07:15:05 INFO - TinderboxPrint: CPU usage
12.9% 07:15:05 INFO - TinderboxPrint: I/O read bytes / time
421,888 / 28 07:15:05 INFO - TinderboxPrint: I/O write bytes / time
393,076,736 / 234,372 07:15:05 INFO - TinderboxPrint: CPU idle
8,295.3 (87.1%) 07:15:05 INFO - TinderboxPrint: CPU user
1,184.2 (12.4%) 07:15:05 INFO - TinderboxPrint: Swap in / out
0 / 0 07:15:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109502464; Read time: 0; Write time: 50060 07:15:05 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 421888; Write bytes: 268128256; Read time: 28; Write time: 153280 07:15:06 INFO - Running post-run listener: _upload_blobber_files 07:15:06 INFO - Blob upload gear active. 07:15:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:15:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:15:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:15:06 INFO - (blobuploader) - INFO - Open directory for files ... 07:15:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:15:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:15:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:08 INFO - (blobuploader) - INFO - Done attempting. 07:15:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:15:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:15:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:08 INFO - (blobuploader) - INFO - Done attempting. 07:15:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:15:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:15:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:09 INFO - (blobuploader) - INFO - Done attempting. 07:15:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:15:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:15:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:12 INFO - (blobuploader) - INFO - Done attempting. 07:15:12 INFO - (blobuploader) - INFO - Iteration through files over. 07:15:12 INFO - Return code: 0 07:15:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:15:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:15:12 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d28f7c14fb7380eccb819997278b51e45b4d4943c2349a2e8196a5697ef15f645f7a812638d4c7dd2ee7447edce9b50d03b21b66136ecc1778e37110832ee00e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72fb61ad3a0b2786a23f60679b696176a8968486163771d69728c1293783850e46b1c5d8b1972c3fca6b0fb11e5e25f3528c72b9cdb394622d3542c6f9ab0fc8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19ede58ddd8d9b0b658f864734e1cabadc1f4cc0b87bfea60737fd406e5a05d12c5dab9b18c181f9b0c8876f3b86531d87dee3ee7c07051a08a997ca57e02434", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f1f68e2a93c85dc21ae2c3fa59d6e063e1a3ebbccd146fe486968544893ca22e520521fc0f0f0871bb2045a838862ec10bb33cb5e9a4c9aba682a1addd161f4"} 07:15:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:15:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:15:12 INFO - Contents: 07:15:12 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d28f7c14fb7380eccb819997278b51e45b4d4943c2349a2e8196a5697ef15f645f7a812638d4c7dd2ee7447edce9b50d03b21b66136ecc1778e37110832ee00e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72fb61ad3a0b2786a23f60679b696176a8968486163771d69728c1293783850e46b1c5d8b1972c3fca6b0fb11e5e25f3528c72b9cdb394622d3542c6f9ab0fc8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19ede58ddd8d9b0b658f864734e1cabadc1f4cc0b87bfea60737fd406e5a05d12c5dab9b18c181f9b0c8876f3b86531d87dee3ee7c07051a08a997ca57e02434", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f1f68e2a93c85dc21ae2c3fa59d6e063e1a3ebbccd146fe486968544893ca22e520521fc0f0f0871bb2045a838862ec10bb33cb5e9a4c9aba682a1addd161f4"} 07:15:12 INFO - Running post-run listener: copy_logs_to_upload_dir 07:15:12 INFO - Copying logs to upload dir... 07:15:12 INFO - mkdir: /builds/slave/test/build/upload/logs 07:15:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.604097 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-05-12 07:15:12.880756) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 07:15:12.885184) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d28f7c14fb7380eccb819997278b51e45b4d4943c2349a2e8196a5697ef15f645f7a812638d4c7dd2ee7447edce9b50d03b21b66136ecc1778e37110832ee00e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72fb61ad3a0b2786a23f60679b696176a8968486163771d69728c1293783850e46b1c5d8b1972c3fca6b0fb11e5e25f3528c72b9cdb394622d3542c6f9ab0fc8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19ede58ddd8d9b0b658f864734e1cabadc1f4cc0b87bfea60737fd406e5a05d12c5dab9b18c181f9b0c8876f3b86531d87dee3ee7c07051a08a997ca57e02434", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f1f68e2a93c85dc21ae2c3fa59d6e063e1a3ebbccd146fe486968544893ca22e520521fc0f0f0871bb2045a838862ec10bb33cb5e9a4c9aba682a1addd161f4"} build_url:https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011172 build_url: 'https://queue.taskcluster.net/v1/task/Qduevg3VRA-EuH7AhLCkaQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d28f7c14fb7380eccb819997278b51e45b4d4943c2349a2e8196a5697ef15f645f7a812638d4c7dd2ee7447edce9b50d03b21b66136ecc1778e37110832ee00e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72fb61ad3a0b2786a23f60679b696176a8968486163771d69728c1293783850e46b1c5d8b1972c3fca6b0fb11e5e25f3528c72b9cdb394622d3542c6f9ab0fc8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19ede58ddd8d9b0b658f864734e1cabadc1f4cc0b87bfea60737fd406e5a05d12c5dab9b18c181f9b0c8876f3b86531d87dee3ee7c07051a08a997ca57e02434", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f1f68e2a93c85dc21ae2c3fa59d6e063e1a3ebbccd146fe486968544893ca22e520521fc0f0f0871bb2045a838862ec10bb33cb5e9a4c9aba682a1addd161f4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 07:15:12.911320) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 07:15:12.911688) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1494597263.731077-230320992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004384 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 07:15:13.006989) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 07:15:13.007540) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 07:15:13.008098) ========= ========= Total master_lag: 0.18 =========