builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-060 starttime: 1487806118.84 results: success (0) revision: 32dcdde1fc64fc39a9065dc4218265dbc727673f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 15:28:38.837828) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 15:28:38.838785) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 15:28:38.839484) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 15:28:38.854315) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 15:28:38.854947) ========= 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=337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-22 15:28:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 46.5M=0s 2017-02-22 15:28:39 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.153893 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 15:28:39.024029) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 15:28:39.024423) ========= 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=337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016437 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 15:28:39.077973) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-22 15:28:39.078744) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 32dcdde1fc64fc39a9065dc4218265dbc727673f --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 32dcdde1fc64fc39a9065dc4218265dbc727673f --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=337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-22 15:28:39,260 truncating revision to first 12 chars 2017-02-22 15:28:39,260 Setting DEBUG logging. 2017-02-22 15:28:39,260 attempt 1/10 2017-02-22 15:28:39,260 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/32dcdde1fc64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-22 15:28:40,551 unpacking tar archive at: mozilla-central-32dcdde1fc64/testing/mozharness/ program finished with exit code 0 elapsedTime=1.581618 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-22 15:28:40.675444) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 15:28:40.675793) ========= script_repo_revision: 32dcdde1fc64fc39a9065dc4218265dbc727673f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 15:28:40.676207) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 15:28:40.676506) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 15:28:40.685187) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-22 15:28:40.685503) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:28:40 INFO - MultiFileLogger online at 20170222 15:28:40 in /builds/slave/test 15:28:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:28:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:28:40 INFO - {'append_to_log': False, 15:28:40 INFO - 'base_work_dir': '/builds/slave/test', 15:28:40 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:28:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:28:40 INFO - 'branch': 'Firefox-Non-PGO', 15:28:40 INFO - 'buildbot_json_path': 'buildprops.json', 15:28:40 INFO - 'config_files': ('talos/linux_config.py',), 15:28:40 INFO - 'default_actions': ('clobber', 15:28:40 INFO - 'read-buildbot-config', 15:28:40 INFO - 'download-and-extract', 15:28:40 INFO - 'populate-webroot', 15:28:40 INFO - 'create-virtualenv', 15:28:40 INFO - 'install', 15:28:40 INFO - 'run-tests'), 15:28:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:28:40 INFO - 'download_minidump_stackwalk': True, 15:28:40 INFO - 'download_symbols': 'ondemand', 15:28:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:28:40 INFO - 'tooltool.py': '/tools/tooltool.py', 15:28:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:28:40 INFO - '/tools/misc-python/virtualenv.py')}, 15:28:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:28:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:28:40 INFO - 'gecko_profile': False, 15:28:40 INFO - 'gecko_profile_interval': 0, 15:28:40 INFO - 'installer_path': 'installer.exe', 15:28:40 INFO - 'log_level': 'info', 15:28:40 INFO - 'log_name': 'talos', 15:28:40 INFO - 'log_to_console': True, 15:28:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:28:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:28:40 INFO - 'opt_config_files': (), 15:28:40 INFO - 'pip_index': False, 15:28:40 INFO - 'suite': 'dromaeojs', 15:28:40 INFO - 'system_bits': '32', 15:28:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:28:40 INFO - 'title': 'talos-linux64-ix-060', 15:28:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:28:40 INFO - 'use_talos_json': True, 15:28:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:28:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:28:40 INFO - 'work_dir': 'build'} 15:28:40 INFO - [mozharness: 2017-02-22 23:28:40.970854Z] Running clobber step. 15:28:40 INFO - Running pre-action listener: _resource_record_pre_action 15:28:40 INFO - Running main action method: clobber 15:28:40 INFO - rmtree: /builds/slave/test/build 15:28:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:28:41 INFO - Running post-action listener: _resource_record_post_action 15:28:41 INFO - [mozharness: 2017-02-22 23:28:41.945253Z] Finished clobber step (success) 15:28:41 INFO - [mozharness: 2017-02-22 23:28:41.945678Z] Running read-buildbot-config step. 15:28:41 INFO - Running pre-action listener: _resource_record_pre_action 15:28:41 INFO - Running main action method: read_buildbot_config 15:28:41 INFO - Using buildbot properties: 15:28:41 INFO - { 15:28:41 INFO - "project": "", 15:28:41 INFO - "product": "firefox", 15:28:41 INFO - "who": "kwierso@gmail.com", 15:28:41 INFO - "installer_path": "public/build/target.tar.bz2", 15:28:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:28:41 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 15:28:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 15:28:41 INFO - "stage_platform": "linux64", 15:28:41 INFO - "basedir": "/builds/slave/test", 15:28:41 INFO - "buildnumber": 464, 15:28:41 INFO - "platform": "ubuntu64_hw", 15:28:41 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:28:41 INFO - "slavebuilddir": "test", 15:28:41 INFO - "taskId": "Y-q0S923Qg2od50EYBwy5Q", 15:28:41 INFO - "branch": "mozilla-central", 15:28:41 INFO - "script_repo_revision": "production", 15:28:41 INFO - "revision": "32dcdde1fc64fc39a9065dc4218265dbc727673f", 15:28:41 INFO - "slavename": "talos-linux64-ix-060", 15:28:41 INFO - "repo_path": "mozilla-central" 15:28:41 INFO - } 15:28:41 INFO - Finding installer, test and symbols from parent task. 15:28:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y-q0S923Qg2od50EYBwy5Q'}, attempt #1 15:28:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y-q0S923Qg2od50EYBwy5Q'}, attempt #1 15:28:42 INFO - Task dependencies: MXrDdCsmRqSDuUYHfL6ADQ 15:28:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ'}, attempt #1 15:28:43 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/target.tar.bz2 15:28:43 INFO - Set test_url: https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/test_packages.json 15:28:43 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/target.crashreporter-symbols.zip 15:28:43 INFO - Running post-action listener: _resource_record_post_action 15:28:43 INFO - [mozharness: 2017-02-22 23:28:43.424322Z] Finished read-buildbot-config step (success) 15:28:43 INFO - [mozharness: 2017-02-22 23:28:43.424539Z] Running download-and-extract step. 15:28:43 INFO - Running pre-action listener: _resource_record_pre_action 15:28:43 INFO - Running main action method: download_and_extract 15:28:43 INFO - mkdir: /builds/slave/test/build/tests 15:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:28:43 INFO - trying https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/target.test_packages.json 15:28:43 INFO - Downloading https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:28:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:28:43 INFO - Downloaded 896 bytes. 15:28:43 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:28:44 INFO - Using the following test package requirements: 15:28:44 INFO - {u'common': [u'target.common.tests.zip'], 15:28:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:28:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:28:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:28:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:28:44 INFO - u'mozbase': [u'target.common.tests.zip'], 15:28:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:28:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:28:44 INFO - u'web-platform': [u'target.common.tests.zip', 15:28:44 INFO - u'target.web-platform.tests.zip'], 15:28:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:28:44 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:28:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/target.common.tests.zip 15:28:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:28:44 INFO - Fetch https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/target.common.tests.zip into memory 15:28:45 INFO - Expected file size: 57198300 15:28:45 INFO - Obtained file size: 57198300 15:28:54 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:28:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/target.common.tests.zip 15:28:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:28:54 INFO - Fetch https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/target.common.tests.zip into memory 15:28:55 INFO - Expected file size: 57198300 15:28:55 INFO - Obtained file size: 57198300 15:29:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/target.talos.tests.zip 15:29:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:29:06 INFO - Fetch https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/target.talos.tests.zip into memory 15:29:07 INFO - Expected file size: 14404319 15:29:07 INFO - Obtained file size: 14404319 15:29:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:29:07 INFO - trying https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/target.tar.bz2 15:29:07 INFO - Downloading https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:29:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:29:08 INFO - Downloaded 61609732 bytes. 15:29:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/target.tar.bz2 15:29:08 INFO - mkdir: /builds/slave/test/properties 15:29:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:29:08 INFO - Writing to file /builds/slave/test/properties/build_url 15:29:08 INFO - Contents: 15:29:08 INFO - build_url:https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/target.tar.bz2 15:29:08 INFO - Running post-action listener: _resource_record_post_action 15:29:08 INFO - Running post-action listener: set_extra_try_arguments 15:29:08 INFO - [mozharness: 2017-02-22 23:29:08.884084Z] Finished download-and-extract step (success) 15:29:08 INFO - [mozharness: 2017-02-22 23:29:08.884179Z] Running populate-webroot step. 15:29:08 INFO - Running pre-action listener: _resource_record_pre_action 15:29:08 INFO - Running main action method: populate_webroot 15:29:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:29:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:29:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:29:08 INFO - '--tppagecycles', 15:29:08 INFO - '7'], 15:29:08 INFO - 'tests': ['tsvgm']}}, 15:29:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:29:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:29:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:29:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:29:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:29:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:29:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:29:08 INFO - 'talos_options': ['--disable-e10s'], 15:29:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:29:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:29:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:29:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:29:08 INFO - 'talos_options': ['--disable-e10s'], 15:29:08 INFO - 'tests': ['damp', 'tps']}, 15:29:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:29:08 INFO - 'tests': ['damp', 'tps']}, 15:29:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:29:08 INFO - 'tests': ['dromaeo_dom']}, 15:29:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:29:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:29:08 INFO - 'tests': ['basic_compositor_video']}, 15:29:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:29:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:29:08 INFO - 'tests': ['a11yr', 15:29:08 INFO - 'ts_paint', 15:29:08 INFO - 'tpaint', 15:29:08 INFO - 'sessionrestore', 15:29:08 INFO - 'sessionrestore_no_auto_restore', 15:29:08 INFO - 'tabpaint']}, 15:29:08 INFO - 'other-e10s': {'tests': ['a11yr', 15:29:08 INFO - 'ts_paint', 15:29:08 INFO - 'tpaint', 15:29:08 INFO - 'sessionrestore', 15:29:08 INFO - 'sessionrestore_no_auto_restore', 15:29:08 INFO - 'tabpaint']}, 15:29:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:29:08 INFO - 'ts_paint', 15:29:08 INFO - 'tpaint', 15:29:08 INFO - 'sessionrestore', 15:29:08 INFO - 'sessionrestore_no_auto_restore', 15:29:08 INFO - 'tabpaint']}, 15:29:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:29:08 INFO - 'ts_paint', 15:29:08 INFO - 'tpaint', 15:29:08 INFO - 'sessionrestore', 15:29:08 INFO - 'sessionrestore_no_auto_restore', 15:29:08 INFO - 'tabpaint']}, 15:29:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:29:08 INFO - 'tests': ['a11yr', 15:29:08 INFO - 'ts_paint', 15:29:08 INFO - 'tpaint', 15:29:08 INFO - 'sessionrestore', 15:29:08 INFO - 'sessionrestore_no_auto_restore', 15:29:08 INFO - 'tabpaint']}, 15:29:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:29:08 INFO - 'tests': ['a11yr', 15:29:08 INFO - 'ts_paint', 15:29:08 INFO - 'tpaint', 15:29:08 INFO - 'sessionrestore', 15:29:08 INFO - 'sessionrestore_no_auto_restore', 15:29:08 INFO - 'tabpaint']}, 15:29:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:29:08 INFO - 'tests': ['tsvgx', 15:29:08 INFO - 'tsvgr_opacity', 15:29:08 INFO - 'tart', 15:29:08 INFO - 'tscrollx', 15:29:08 INFO - 'cart', 15:29:08 INFO - 'tsvg_static']}, 15:29:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:29:08 INFO - 'tsvgr_opacity', 15:29:08 INFO - 'tart', 15:29:08 INFO - 'tscrollx', 15:29:08 INFO - 'cart', 15:29:08 INFO - 'tsvg_static']}, 15:29:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:29:08 INFO - 'talos_options': ['--disable-e10s'], 15:29:08 INFO - 'tests': ['tp5o']}, 15:29:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:29:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:29:08 INFO - 'talos_options': ['--disable-e10s', 15:29:08 INFO - '--xperf_path', 15:29:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:29:08 INFO - 'tests': ['tp5n']}, 15:29:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:29:08 INFO - 'talos_options': ['--xperf_path', 15:29:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:29:08 INFO - 'tests': ['tp5n']}}, 15:29:08 INFO - 'talos.zip': {'path': '', 15:29:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:29:08 INFO - Running post-action listener: _resource_record_post_action 15:29:08 INFO - [mozharness: 2017-02-22 23:29:08.897237Z] Finished populate-webroot step (success) 15:29:08 INFO - [mozharness: 2017-02-22 23:29:08.897341Z] Running create-virtualenv step. 15:29:08 INFO - Running pre-action listener: _resource_record_pre_action 15:29:08 INFO - Running main action method: create_virtualenv 15:29:08 INFO - Creating virtualenv /builds/slave/test/build/venv 15:29:08 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 15:29:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:29:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:29:08 INFO - Using real prefix '/usr' 15:29:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:29:09 INFO - Installing distribute.............................................................................................................................................................................................done. 15:29:11 INFO - Installing pip.................done. 15:29:11 INFO - Return code: 0 15:29:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:29:11 INFO - Reading from file tmpfile_stdout 15:29:11 INFO - Output received: 15:29:11 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:29:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1b041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f290>, '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 0x1d9fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da0040>, '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': '337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463', '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 15:29:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:29:11 INFO - Using env: {'DISPLAY': ':0', 15:29:11 INFO - 'HOME': '/home/cltbld', 15:29:11 INFO - 'LANG': 'en_US.UTF-8', 15:29:11 INFO - 'LANGUAGE': 'en_US:en', 15:29:11 INFO - 'LOGNAME': 'cltbld', 15:29:11 INFO - 'MAIL': '/var/mail/cltbld', 15:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:11 INFO - 'MOZ_NO_REMOTE': '1', 15:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:11 INFO - 'NO_EM_RESTART': '1', 15:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:11 INFO - 'PWD': '/builds/slave/test', 15:29:11 INFO - 'SHELL': '/bin/bash', 15:29:11 INFO - 'SHLVL': '1', 15:29:11 INFO - 'TERM': 'linux', 15:29:11 INFO - 'TMOUT': '86400', 15:29:11 INFO - 'USER': 'cltbld', 15:29:11 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463', 15:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:11 INFO - '_': '/tools/buildbot/bin/python'} 15:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:11 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 15:29:11 INFO - Cleaning up... 15:29:11 INFO - Return code: 0 15:29:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1b041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f290>, '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 0x1d9fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da0040>, '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': '337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463', '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 15:29:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:29:11 INFO - Using env: {'DISPLAY': ':0', 15:29:11 INFO - 'HOME': '/home/cltbld', 15:29:11 INFO - 'LANG': 'en_US.UTF-8', 15:29:11 INFO - 'LANGUAGE': 'en_US:en', 15:29:11 INFO - 'LOGNAME': 'cltbld', 15:29:11 INFO - 'MAIL': '/var/mail/cltbld', 15:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:11 INFO - 'MOZ_NO_REMOTE': '1', 15:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:11 INFO - 'NO_EM_RESTART': '1', 15:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:11 INFO - 'PWD': '/builds/slave/test', 15:29:11 INFO - 'SHELL': '/bin/bash', 15:29:11 INFO - 'SHLVL': '1', 15:29:11 INFO - 'TERM': 'linux', 15:29:11 INFO - 'TMOUT': '86400', 15:29:11 INFO - 'USER': 'cltbld', 15:29:11 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463', 15:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:11 INFO - '_': '/tools/buildbot/bin/python'} 15:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:12 INFO - Downloading/unpacking psutil>=3.1.1 15:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:29:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:29:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:29:14 INFO - Installing collected packages: psutil 15:29:14 INFO - Running setup.py install for psutil 15:29:14 INFO - building 'psutil._psutil_linux' extension 15:29:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:29:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:29:14 INFO - building 'psutil._psutil_posix' extension 15:29:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:29:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:29:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:29:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:29:14 INFO - Successfully installed psutil 15:29:14 INFO - Cleaning up... 15:29:14 INFO - Return code: 0 15:29:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:29:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1b041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f290>, '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 0x1d9fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da0040>, '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': '337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463', '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 15:29:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:29:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:29:14 INFO - Using env: {'DISPLAY': ':0', 15:29:14 INFO - 'HOME': '/home/cltbld', 15:29:14 INFO - 'LANG': 'en_US.UTF-8', 15:29:14 INFO - 'LANGUAGE': 'en_US:en', 15:29:14 INFO - 'LOGNAME': 'cltbld', 15:29:14 INFO - 'MAIL': '/var/mail/cltbld', 15:29:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:14 INFO - 'MOZ_NO_REMOTE': '1', 15:29:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:14 INFO - 'NO_EM_RESTART': '1', 15:29:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:14 INFO - 'PWD': '/builds/slave/test', 15:29:14 INFO - 'SHELL': '/bin/bash', 15:29:14 INFO - 'SHLVL': '1', 15:29:14 INFO - 'TERM': 'linux', 15:29:14 INFO - 'TMOUT': '86400', 15:29:14 INFO - 'USER': 'cltbld', 15:29:14 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463', 15:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:14 INFO - '_': '/tools/buildbot/bin/python'} 15:29:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:29:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:29:17 INFO - Installing collected packages: mozsystemmonitor 15:29:17 INFO - Running setup.py install for mozsystemmonitor 15:29:17 INFO - Successfully installed mozsystemmonitor 15:29:17 INFO - Cleaning up... 15:29:17 INFO - Return code: 0 15:29:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1b041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f290>, '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 0x1d9fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da0040>, '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': '337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463', '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 15:29:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:29:17 INFO - Using env: {'DISPLAY': ':0', 15:29:17 INFO - 'HOME': '/home/cltbld', 15:29:17 INFO - 'LANG': 'en_US.UTF-8', 15:29:17 INFO - 'LANGUAGE': 'en_US:en', 15:29:17 INFO - 'LOGNAME': 'cltbld', 15:29:17 INFO - 'MAIL': '/var/mail/cltbld', 15:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:17 INFO - 'MOZ_NO_REMOTE': '1', 15:29:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:17 INFO - 'NO_EM_RESTART': '1', 15:29:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:17 INFO - 'PWD': '/builds/slave/test', 15:29:17 INFO - 'SHELL': '/bin/bash', 15:29:17 INFO - 'SHLVL': '1', 15:29:17 INFO - 'TERM': 'linux', 15:29:17 INFO - 'TMOUT': '86400', 15:29:17 INFO - 'USER': 'cltbld', 15:29:17 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463', 15:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:17 INFO - '_': '/tools/buildbot/bin/python'} 15:29:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:17 INFO - Downloading/unpacking jsonschema==2.5.1 15:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:29:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:19 INFO - Downloading functools32-3.2.3-2.tar.gz 15:29:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:29:19 INFO - warning: no files found matching '*.txt' 15:29:19 INFO - no previously-included directories found matching 'build' 15:29:19 INFO - no previously-included directories found matching 'dist' 15:29:19 INFO - no previously-included directories found matching '.git*' 15:29:19 INFO - Installing collected packages: jsonschema, functools32 15:29:19 INFO - Running setup.py install for functools32 15:29:19 INFO - warning: no files found matching '*.txt' 15:29:19 INFO - no previously-included directories found matching 'build' 15:29:19 INFO - no previously-included directories found matching 'dist' 15:29:19 INFO - no previously-included directories found matching '.git*' 15:29:19 INFO - Successfully installed jsonschema functools32 15:29:19 INFO - Cleaning up... 15:29:19 INFO - Return code: 0 15:29:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:29:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:19 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1b041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f290>, '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 0x1d9fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da0040>, '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': '337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463', '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 15:29:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:29:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:29:19 INFO - Using env: {'DISPLAY': ':0', 15:29:19 INFO - 'HOME': '/home/cltbld', 15:29:19 INFO - 'LANG': 'en_US.UTF-8', 15:29:19 INFO - 'LANGUAGE': 'en_US:en', 15:29:19 INFO - 'LOGNAME': 'cltbld', 15:29:19 INFO - 'MAIL': '/var/mail/cltbld', 15:29:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:19 INFO - 'MOZ_NO_REMOTE': '1', 15:29:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:19 INFO - 'NO_EM_RESTART': '1', 15:29:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:19 INFO - 'PWD': '/builds/slave/test', 15:29:19 INFO - 'SHELL': '/bin/bash', 15:29:19 INFO - 'SHLVL': '1', 15:29:19 INFO - 'TERM': 'linux', 15:29:19 INFO - 'TMOUT': '86400', 15:29:19 INFO - 'USER': 'cltbld', 15:29:19 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463', 15:29:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:19 INFO - '_': '/tools/buildbot/bin/python'} 15:29:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:29:20 INFO - Cleaning up... 15:29:20 INFO - Return code: 0 15:29:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:29:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:29:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:20 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1b041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f290>, '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 0x1d9fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da0040>, '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': '337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463', '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 15:29:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:29:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:29:20 INFO - Using env: {'DISPLAY': ':0', 15:29:20 INFO - 'HOME': '/home/cltbld', 15:29:20 INFO - 'LANG': 'en_US.UTF-8', 15:29:20 INFO - 'LANGUAGE': 'en_US:en', 15:29:20 INFO - 'LOGNAME': 'cltbld', 15:29:20 INFO - 'MAIL': '/var/mail/cltbld', 15:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:20 INFO - 'MOZ_NO_REMOTE': '1', 15:29:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:20 INFO - 'NO_EM_RESTART': '1', 15:29:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:20 INFO - 'PWD': '/builds/slave/test', 15:29:20 INFO - 'SHELL': '/bin/bash', 15:29:20 INFO - 'SHLVL': '1', 15:29:20 INFO - 'TERM': 'linux', 15:29:20 INFO - 'TMOUT': '86400', 15:29:20 INFO - 'USER': 'cltbld', 15:29:20 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463', 15:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:20 INFO - '_': '/tools/buildbot/bin/python'} 15:29:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:20 INFO - Downloading/unpacking blobuploader==1.2.4 15:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:22 INFO - Downloading blobuploader-1.2.4.tar.gz 15:29:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:29:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:29:22 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 15:29:22 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 15:29:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:22 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 15:29:22 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 15:29:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:29:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:29:22 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 15:29:22 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 15:29:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:22 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 15:29:22 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 15:29:23 INFO - Downloading docopt-0.6.1.tar.gz 15:29:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:29:23 INFO - Installing collected packages: blobuploader, requests, docopt 15:29:23 INFO - Running setup.py install for blobuploader 15:29:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:29:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:29:23 INFO - Running setup.py install for requests 15:29:23 INFO - Running setup.py install for docopt 15:29:23 INFO - Successfully installed blobuploader requests docopt 15:29:23 INFO - Cleaning up... 15:29:23 INFO - Return code: 0 15:29:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:29:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:29:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:23 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1b041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f290>, '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 0x1d9fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da0040>, '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': '337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463', '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 15:29:23 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:29:23 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:29:23 INFO - Using env: {'DISPLAY': ':0', 15:29:23 INFO - 'HOME': '/home/cltbld', 15:29:23 INFO - 'LANG': 'en_US.UTF-8', 15:29:23 INFO - 'LANGUAGE': 'en_US:en', 15:29:23 INFO - 'LOGNAME': 'cltbld', 15:29:23 INFO - 'MAIL': '/var/mail/cltbld', 15:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:23 INFO - 'MOZ_NO_REMOTE': '1', 15:29:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:23 INFO - 'NO_EM_RESTART': '1', 15:29:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:23 INFO - 'PWD': '/builds/slave/test', 15:29:23 INFO - 'SHELL': '/bin/bash', 15:29:23 INFO - 'SHLVL': '1', 15:29:23 INFO - 'TERM': 'linux', 15:29:23 INFO - 'TMOUT': '86400', 15:29:23 INFO - 'USER': 'cltbld', 15:29:23 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463', 15:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:23 INFO - '_': '/tools/buildbot/bin/python'} 15:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:29:24 INFO - Running setup.py (path:/tmp/pip-IafyUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:29:24 INFO - Running setup.py (path:/tmp/pip-PP5EfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:29:24 INFO - Running setup.py (path:/tmp/pip-7jqIKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:29:24 INFO - Running setup.py (path:/tmp/pip-qglXWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:29:24 INFO - Running setup.py (path:/tmp/pip-ORCISn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:29:24 INFO - Running setup.py (path:/tmp/pip-ahP180-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:29:24 INFO - Running setup.py (path:/tmp/pip-u9vmTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:29:24 INFO - Running setup.py (path:/tmp/pip-3aGwmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:29:24 INFO - Running setup.py (path:/tmp/pip-Bwfy5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:29:24 INFO - Running setup.py (path:/tmp/pip-RDvz8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:29:24 INFO - Running setup.py (path:/tmp/pip-bk4Ay8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:29:24 INFO - Running setup.py (path:/tmp/pip-ZADics-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:29:24 INFO - Running setup.py (path:/tmp/pip-_kbn8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:29:24 INFO - Running setup.py (path:/tmp/pip-knEOGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:29:25 INFO - Running setup.py (path:/tmp/pip-w0Q5Jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:29:25 INFO - Running setup.py (path:/tmp/pip-IcDOJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:29:25 INFO - Running setup.py (path:/tmp/pip-tzyf1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:29:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:29:25 INFO - Running setup.py install for manifestparser 15:29:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:29:25 INFO - Running setup.py install for mozcrash 15:29:25 INFO - Running setup.py install for mozdebug 15:29:25 INFO - Running setup.py install for mozdevice 15:29:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:29:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:29:25 INFO - Running setup.py install for mozfile 15:29:25 INFO - Running setup.py install for mozhttpd 15:29:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:29:25 INFO - Running setup.py install for mozinfo 15:29:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:29:25 INFO - Running setup.py install for mozInstall 15:29:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:29:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:29:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:29:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:29:26 INFO - Running setup.py install for mozleak 15:29:26 INFO - Running setup.py install for mozlog 15:29:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:29:26 INFO - Running setup.py install for moznetwork 15:29:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:29:26 INFO - Running setup.py install for mozprocess 15:29:26 INFO - Running setup.py install for mozprofile 15:29:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:29:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:29:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:29:26 INFO - Running setup.py install for mozrunner 15:29:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:29:26 INFO - Running setup.py install for mozscreenshot 15:29:26 INFO - Running setup.py install for moztest 15:29:26 INFO - Running setup.py install for mozversion 15:29:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:29:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:29:27 INFO - Cleaning up... 15:29:27 INFO - Return code: 0 15:29:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:29:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:27 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1b041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f290>, '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 0x1d9fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da0040>, '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': '337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463', '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 15:29:27 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:29:27 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:29:27 INFO - Using env: {'DISPLAY': ':0', 15:29:27 INFO - 'HOME': '/home/cltbld', 15:29:27 INFO - 'LANG': 'en_US.UTF-8', 15:29:27 INFO - 'LANGUAGE': 'en_US:en', 15:29:27 INFO - 'LOGNAME': 'cltbld', 15:29:27 INFO - 'MAIL': '/var/mail/cltbld', 15:29:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:27 INFO - 'MOZ_NO_REMOTE': '1', 15:29:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:27 INFO - 'NO_EM_RESTART': '1', 15:29:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:27 INFO - 'PWD': '/builds/slave/test', 15:29:27 INFO - 'SHELL': '/bin/bash', 15:29:27 INFO - 'SHLVL': '1', 15:29:27 INFO - 'TERM': 'linux', 15:29:27 INFO - 'TMOUT': '86400', 15:29:27 INFO - 'USER': 'cltbld', 15:29:27 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463', 15:29:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:27 INFO - '_': '/tools/buildbot/bin/python'} 15:29:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:29:27 INFO - Running setup.py (path:/tmp/pip-ZTFfVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:29:27 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)) 15:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:29:27 INFO - Running setup.py (path:/tmp/pip-dNrrDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:29:27 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)) 15:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:29:27 INFO - Running setup.py (path:/tmp/pip-K5IEPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:29:27 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)) 15:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:29:27 INFO - Running setup.py (path:/tmp/pip-8qHnmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 15:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:29:27 INFO - Running setup.py (path:/tmp/pip-ETK9nB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:29:27 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)) 15:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:29:27 INFO - Running setup.py (path:/tmp/pip-BLO9XJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:29:27 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)) 15:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:29:27 INFO - Running setup.py (path:/tmp/pip-tF75dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:29:27 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)) 15:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:29:27 INFO - Running setup.py (path:/tmp/pip-FcRtyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:29:27 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)) 15:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:29:27 INFO - Running setup.py (path:/tmp/pip-Dj8s0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:29:27 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)) 15:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:29:27 INFO - Running setup.py (path:/tmp/pip-tI2_A2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:29:28 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)) 15:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:29:28 INFO - Running setup.py (path:/tmp/pip-MSCxRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:29:28 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)) 15:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:29:28 INFO - Running setup.py (path:/tmp/pip-8BrPN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:29:28 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)) 15:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:29:28 INFO - Running setup.py (path:/tmp/pip-OV72m4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:29:28 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)) 15:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:29:28 INFO - Running setup.py (path:/tmp/pip-eW6cOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:29:28 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)) 15:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:29:28 INFO - Running setup.py (path:/tmp/pip-tYUkDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:29:28 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)) 15:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:29:28 INFO - Running setup.py (path:/tmp/pip-X_MClj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:29:28 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)) 15:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:29:28 INFO - Running setup.py (path:/tmp/pip-fb88Z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:29:28 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)) 15:29:28 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)) 15:29:28 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)) 15:29:28 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)) 15:29:28 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:29:28 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:29:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:29:28 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 15:29:28 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 15:29:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:28 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 15:29:28 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 15:29:30 INFO - Downloading blessings-1.6.tar.gz 15:29:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:29:30 INFO - Installing collected packages: blessings 15:29:30 INFO - Running setup.py install for blessings 15:29:30 INFO - Successfully installed blessings 15:29:30 INFO - Cleaning up... 15:29:30 INFO - Return code: 0 15:29:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:29:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:29:30 INFO - Reading from file tmpfile_stdout 15:29:30 INFO - Current package versions: 15:29:30 INFO - argparse == 1.2.1 15:29:30 INFO - blessings == 1.6 15:29:30 INFO - blobuploader == 1.2.4 15:29:30 INFO - docopt == 0.6.1 15:29:30 INFO - functools32 == 3.2.3-2 15:29:30 INFO - jsonschema == 2.5.1 15:29:30 INFO - manifestparser == 1.1 15:29:30 INFO - mozInstall == 1.12 15:29:30 INFO - mozcrash == 1.0 15:29:30 INFO - mozdebug == 0.1 15:29:30 INFO - mozdevice == 0.49 15:29:30 INFO - mozfile == 1.2 15:29:30 INFO - mozhttpd == 0.7 15:29:30 INFO - mozinfo == 0.9 15:29:30 INFO - mozleak == 0.1 15:29:30 INFO - mozlog == 3.4 15:29:30 INFO - moznetwork == 0.27 15:29:30 INFO - mozprocess == 0.25 15:29:30 INFO - mozprofile == 0.28 15:29:30 INFO - mozrunner == 6.13 15:29:30 INFO - mozscreenshot == 0.1 15:29:30 INFO - mozsystemmonitor == 0.3 15:29:30 INFO - moztest == 0.8 15:29:30 INFO - mozversion == 1.4 15:29:30 INFO - psutil == 3.1.1 15:29:30 INFO - requests == 1.2.3 15:29:30 INFO - wsgiref == 0.1.2 15:29:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:29:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:31 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1b041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f290>, '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 0x1d9fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da0040>, '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': '337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463', '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 15:29:31 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:29:31 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:29:31 INFO - Using env: {'DISPLAY': ':0', 15:29:31 INFO - 'HOME': '/home/cltbld', 15:29:31 INFO - 'LANG': 'en_US.UTF-8', 15:29:31 INFO - 'LANGUAGE': 'en_US:en', 15:29:31 INFO - 'LOGNAME': 'cltbld', 15:29:31 INFO - 'MAIL': '/var/mail/cltbld', 15:29:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:31 INFO - 'MOZ_NO_REMOTE': '1', 15:29:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:31 INFO - 'NO_EM_RESTART': '1', 15:29:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:31 INFO - 'PWD': '/builds/slave/test', 15:29:31 INFO - 'SHELL': '/bin/bash', 15:29:31 INFO - 'SHLVL': '1', 15:29:31 INFO - 'TERM': 'linux', 15:29:31 INFO - 'TMOUT': '86400', 15:29:31 INFO - 'USER': 'cltbld', 15:29:31 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463', 15:29:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:31 INFO - '_': '/tools/buildbot/bin/python'} 15:29:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:31 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)) 15:29:31 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)) 15:29:31 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)) 15:29:31 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)) 15:29:31 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)) 15:29:31 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)) 15:29:31 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)) 15:29:31 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)) 15:29:31 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)) 15:29:31 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)) 15:29:31 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)) 15:29:31 INFO - Cleaning up... 15:29:31 INFO - Return code: 0 15:29:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:29:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:29:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:31 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1b041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f290>, '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 0x1d9fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da0040>, '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': '337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463', '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 15:29:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:29:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:29:31 INFO - Using env: {'DISPLAY': ':0', 15:29:31 INFO - 'HOME': '/home/cltbld', 15:29:31 INFO - 'LANG': 'en_US.UTF-8', 15:29:31 INFO - 'LANGUAGE': 'en_US:en', 15:29:31 INFO - 'LOGNAME': 'cltbld', 15:29:31 INFO - 'MAIL': '/var/mail/cltbld', 15:29:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:31 INFO - 'MOZ_NO_REMOTE': '1', 15:29:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:31 INFO - 'NO_EM_RESTART': '1', 15:29:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:31 INFO - 'PWD': '/builds/slave/test', 15:29:31 INFO - 'SHELL': '/bin/bash', 15:29:31 INFO - 'SHLVL': '1', 15:29:31 INFO - 'TERM': 'linux', 15:29:31 INFO - 'TMOUT': '86400', 15:29:31 INFO - 'USER': 'cltbld', 15:29:31 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463', 15:29:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:31 INFO - '_': '/tools/buildbot/bin/python'} 15:29:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:29:31 INFO - Cleaning up... 15:29:31 INFO - Return code: 0 15:29:31 INFO - Running post-action listener: _resource_record_post_action 15:29:31 INFO - Running post-action listener: _start_resource_monitoring 15:29:31 INFO - Starting resource monitoring. 15:29:31 INFO - [mozharness: 2017-02-22 23:29:31.547867Z] Finished create-virtualenv step (success) 15:29:31 INFO - [mozharness: 2017-02-22 23:29:31.548328Z] Running install step. 15:29:31 INFO - Running pre-action listener: _resource_record_pre_action 15:29:31 INFO - Running main action method: install 15:29:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:29:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:29:31 INFO - Reading from file tmpfile_stdout 15:29:31 INFO - Detecting whether we're running mozinstall >=1.0... 15:29:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:29:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:29:31 INFO - Reading from file tmpfile_stdout 15:29:31 INFO - Output received: 15:29:31 INFO - Usage: mozinstall [options] installer 15:29:31 INFO - Options: 15:29:31 INFO - -h, --help show this help message and exit 15:29:31 INFO - -d DEST, --destination=DEST 15:29:31 INFO - Directory to install application into. [default: 15:29:31 INFO - "/builds/slave/test"] 15:29:31 INFO - --app=APP Application being installed. [default: firefox] 15:29:31 INFO - mkdir: /builds/slave/test/build/application 15:29:31 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'] 15:29:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:29:47 INFO - Reading from file tmpfile_stdout 15:29:47 INFO - Output received: 15:29:47 INFO - /builds/slave/test/build/application/firefox/firefox 15:29:47 INFO - Running post-action listener: _resource_record_post_action 15:29:47 INFO - [mozharness: 2017-02-22 23:29:47.263814Z] Finished install step (success) 15:29:47 INFO - [mozharness: 2017-02-22 23:29:47.264091Z] Running run-tests step. 15:29:47 INFO - Running pre-action listener: _resource_record_pre_action 15:29:47 INFO - Running main action method: run_tests 15:29:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:29:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:29:47 INFO - Python 2.7.3 15:29:47 INFO - Return code: 0 15:29:47 INFO - grabbing minidump binary from tooltool 15:29:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:29:47 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 0x1d9f290>, '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 0x1d9fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da0040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:29:47 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 15:29:47 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 15:29:47 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 15:29:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:29:47 INFO - Return code: 0 15:29:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:29:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:29:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:29:47 INFO - ENV: RUST_BACKTRACE is now 1 15:29:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:29:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:29:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 15:29:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 15:29:47 INFO - Using env: {'DISPLAY': ':0', 15:29:47 INFO - 'HOME': '/home/cltbld', 15:29:47 INFO - 'LANG': 'en_US.UTF-8', 15:29:47 INFO - 'LANGUAGE': 'en_US:en', 15:29:47 INFO - 'LOGNAME': 'cltbld', 15:29:47 INFO - 'MAIL': '/var/mail/cltbld', 15:29:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:29:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:29:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:47 INFO - 'MOZ_NO_REMOTE': '1', 15:29:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:29:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:47 INFO - 'NO_EM_RESTART': '1', 15:29:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:47 INFO - 'PWD': '/builds/slave/test', 15:29:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:29:47 INFO - 'RUST_BACKTRACE': '1', 15:29:47 INFO - 'SHELL': '/bin/bash', 15:29:47 INFO - 'SHLVL': '1', 15:29:47 INFO - 'TERM': 'linux', 15:29:47 INFO - 'TMOUT': '86400', 15:29:47 INFO - 'USER': 'cltbld', 15:29:47 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463', 15:29:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:47 INFO - '_': '/tools/buildbot/bin/python'} 15:29:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 15:29:47 INFO - mozversion application_buildid: 20170222230118 15:29:47 INFO - mozversion application_changeset: 32dcdde1fc64fc39a9065dc4218265dbc727673f 15:29:47 INFO - mozversion application_display_name: Nightly 15:29:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:29:47 INFO - mozversion application_name: Firefox 15:29:47 INFO - mozversion application_remotingname: firefox 15:29:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:29:47 INFO - mozversion application_vendor: Mozilla 15:29:47 INFO - mozversion application_version: 54.0a1 15:29:47 INFO - mozversion platform_buildid: 20170222230118 15:29:47 INFO - mozversion platform_changeset: 32dcdde1fc64fc39a9065dc4218265dbc727673f 15:29:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:29:47 INFO - mozversion platform_version: 54.0a1 15:29:47 INFO - using testdate: 1487806187 15:29:47 INFO - actual date: 1487806187 15:29:47 INFO - starting webserver on 'localhost:42421' 15:29:47 INFO - SUITE-START | Running 2 tests 15:29:47 INFO - TEST-START | dromaeo_css 15:29:47 INFO - operating with platform_type : linux_ 15:29:47 INFO - Initialising browser for dromaeo_css test... 15:29:47 INFO - TEST-INFO | started process 13192 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa96cY4/profile http://localhost:42421/getInfo.html) 15:29:51 INFO - PROCESS | 13192 | __metrics Screen width/height:1600/1200 15:29:51 INFO - PROCESS | 13192 | colorDepth:24 15:29:51 INFO - PROCESS | 13192 | Browser inner width/height: 1024/697 15:29:51 INFO - PROCESS | 13192 | __metrics 15:29:52 INFO - PROCESS | 13192 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:29:52 INFO - PROCESS | 13192 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:29:53 INFO - PROCESS | 13192 | console.error: PushService: 15:29:53 INFO - PROCESS | 13192 | stateChangeProcessEnqueue: Error transitioning state 15:29:53 INFO - PROCESS | 13192 | UnknownError 15:29:53 INFO - TEST-INFO | 13192: exit 0 15:29:53 INFO - Browser initialized. 15:29:53 INFO - Running cycle 1/1 for dromaeo_css test... 15:29:53 INFO - TEST-INFO | started process 13282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa96cY4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:30:05 INFO - PROCESS | 13282 | RSS: Main: 146989056 15:30:05 INFO - PROCESS | 13282 | 15:33:11 INFO - PROCESS | 13282 | Cycle 1(1): loaded http://localhost:42421/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42421/tests/dromaeo/cssquery-ext.html) 15:33:12 INFO - PROCESS | 13282 | RSS: Main: 293879808 15:33:12 INFO - PROCESS | 13282 | 15:34:55 INFO - PROCESS | 13282 | ************************* 15:34:55 INFO - PROCESS | 13282 | A coding exception was thrown and uncaught in a Task. 15:34:55 INFO - PROCESS | 13282 | 15:34:55 ERROR - PROCESS | 13282 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:34:55 INFO - PROCESS | 13282 | Full stack: 15:34:55 INFO - PROCESS | 13282 | ************************* 15:36:15 INFO - PROCESS | 13282 | Cycle 1(1): loaded http://localhost:42421/tests/dromaeo/cssquery-ext.html (next: http://localhost:42421/tests/dromaeo/cssquery-jquery.html) 15:36:16 INFO - PROCESS | 13282 | RSS: Main: 247894016 15:36:16 INFO - PROCESS | 13282 | 15:39:18 INFO - PROCESS | 13282 | Cycle 1(1): loaded http://localhost:42421/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42421/tests/dromaeo/cssquery-mootools.html) 15:39:19 INFO - PROCESS | 13282 | RSS: Main: 223084544 15:39:19 INFO - PROCESS | 13282 | 15:42:21 INFO - PROCESS | 13282 | Cycle 1(1): loaded http://localhost:42421/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42421/tests/dromaeo/cssquery-prototype.html) 15:42:21 INFO - PROCESS | 13282 | RSS: Main: 183537664 15:42:21 INFO - PROCESS | 13282 | 15:45:25 INFO - PROCESS | 13282 | Cycle 1(1): loaded http://localhost:42421/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42421/tests/dromaeo/cssquery-yui.html) 15:45:25 INFO - PROCESS | 13282 | RSS: Main: 191275008 15:45:25 INFO - PROCESS | 13282 | 15:48:28 INFO - PROCESS | 13282 | Cycle 1(1): loaded http://localhost:42421/tests/dromaeo/cssquery-yui.html (next: http://localhost:42421/tests/dromaeo/cssquery-dojo.html) 15:48:29 INFO - PROCESS | 13282 | RSS: Main: 272637952 15:48:29 INFO - PROCESS | 13282 | 15:48:29 INFO - PROCESS | 13282 | __start_tp_report 15:48:29 INFO - PROCESS | 13282 | _x_x_mozilla_page_load 15:48:29 INFO - PROCESS | 13282 | _x_x_mozilla_page_load_details 15:48:29 INFO - PROCESS | 13282 | |i|pagename|runs| 15:48:29 INFO - PROCESS | 13282 | |0;dojo.html;2540.9364765880855;2565.3073670109084;2590.184092011017;2596.10434400132;2602.4534847681975;4477.149341625097;4554.612857907082;4659.184642687529;4686.578207961283;4706.411698537683;4650.604698600623;4653.464851542074;4704.270838020104;4708.835190768324;4742;4134.049168691203;4237.915241695165;4314.913701725964;4379.737215767048;4459.9331010034875;4380.737155770648;4424.623906967911;4449.977750111261;4462.486814016397;4469.44131983502;4208.284591619432;4249.128928569636;4250.659947204216;4350.695451318409;4366.366876802846;4293.162833247518;4299.806508707115;4303.2469317869245;4307.375430562551;4307.483102027745;4248.766317852517;4267.97866010668;4272.380504826814;4272.401863739048;4342.869713908588;4678.345031695565;4684.648651351128;4689.9765501172615;4726.76366181693;4745.976270118662;5046.949530504685;5059.772310246048;5070.08738427083;5075.137226671474;5118.846434606968;4857.417109946829;4922.335484709554;4929.65492415531;4991.825286115005;5097.2608971699265;4621.353010578522;4660.39414876064;4669.229577119737;4669.953300466952;4670.159371313196;5011.198208286657;5068;5079.644424890223;5080.110980578384;5082.567981721595;4868.659193856467;4891.6575839691595;4892.926606100911;4933.851984440401;4936.531029552187;4945.851624451272;4968.90062198754;4973.055119527278;4977.303177555145;5017.4731653175895;4781.6891902026255;4946.159152944008;4946.604271658259;4952.777125029383;4998.850034498971;4830.686005409637;4886.682365646222;4896.877578060506;4897.510248975145;4903.632227582945;4164.292070348048;4167.666586673119;4167.937480937789;4168.708190426702;4178.770167640748;3671.908202294964;3671.9816400918357;3688.6311368863435;3704.8888533344043;3716.479692843004;4318.589733975267;4321.783910804447;4329.264025115738;4339.717918335298;4370.213361594943;4795.184818580849;4809.254565542346;4827.686200396963;4996.625253106032;5056.6207534434325;4223.493180818322;4226.725262857904;4230.598093181143;4235.957640423557;4236.0257140857775;4399.252127138394;4401.977990110029;4405.581469760367;4408.735475871394;4410.07388448423;4597.3333866589155;4602.631789456902;4605.378273932976;4607.101615185007;4610.170169369546;4858.805647774191;4883.536064073907;4893.192623217129;4897.995910838341;4960.801567937242;4674.813007479663;4712.69367491112;4713.646476514206;4743.667943244078;4752.7623618818225;4941.802327906844;4947.802087916443;4951.059298733229;4954.30639710448;5000.824971125993;4873.707577545359;4929.605631549396;4936;5014.323066386137;5069.822556210515;4848.8302909398;4859.538343857328;4872.025594880967;4912.852614421573;4966.329545511454;4896.314515967696;4898.191798353374;4915;4915.18899381598;4961.5286547777905;4678.906421871611;4878.438979517401;4883.926741098815;4884.731339776346;4918.92621610669;4808.591269741971;4854.126257273725;4861.319415281792;4863.610911127172;4866.610671146371;4759.428868535798;4805.255185446262;4813.9037219254715;4857.6599638025;4931.408231012301 15:48:29 INFO - PROCESS | 13282 | |1;ext.html;539.9028174928512;546.5327145290777;570.6205373426671;575.4102045403461;581.7992792486591;26684.866575667118;29394;37403.625963740385;38933.221335573275;39063.41404878929;40406.59593404065;40683.186336273255;40684.372625095035;40714.7964260179;40719;7498.850022999537;7685.808699651563;7689.500182488148;7692.653830577638;7697.422693297997;6934.965325173367;7106.3959563437165;7372.041634587496;9586.424814511152;9805.411675299505;9863.753406164831;9925.75185620358;9930.602775888956;9938.701838944844;9941.602335906555;9814.46020468874;9869.753256168653;9881;9891.505424728735;9893.802123957552;9629.951850240774;9698.612055517771;9702.660406885796;9709.514524273829;9712.465814380206;36621.63378366209;36894.077648058745;37005.81497092524;37009.81495092534;37050;3456.6370531094126;3486.4073107571776;3513.508108864761;3541.964580354215;3561.6438356164435;27029.1891243263;27256;27315.863420682967;27371.58942615862;27823;3329.433996220648;3374.4769560718128;3398.796072235674;3415.6072051714123;3518.3842827505086;236647;238595;239404;239444.80277598675;240014;47046.29430558544;47415.28877066847;47426.59740934998;47446.76276618595;47485.050298993825;40645.79677101596;41408;47864;48616;48624;12218.083643726755;12414;12432.813507797391;12440.688982775502;12443.440045197987;9025.638974440948;9067.773305667279;9117.133872282122;9223.815523689489;9237.90762092384;15615.687686246438;15706.371745130295;15720.29258683362;15730.764038539432;15737.921310393604;6564.638944857983;6646.767363142363;6724.159480064992;6740.460763138937;6804.149481314836;749.6214411722154;773.8723110686674;777.5606782168057;779.2986312318958;781.8123650323881;26169.869150654507;26998.19005429801;27488;27578.724212757617;27789.166325010283;898.4250079948838;911.8449863523217;912.6121398405651;921.1019256225127;926.5182105305338;14083.155010699391;14261.572152835432;14329.35517901676;14522.273886305642;14619;320035;320501;322127;322345;323856;48891.511084889404;49483;49538.559987201435;49575.50424495709;49629.751851240515;1117.519466629341;1171.683645415733;1172.261475270574;1173.3194747046864;1178.1458442629025;24463.776811159725;25639.230823075337;26133;26209.344766380993;26339.473210536064;40272.597274028056;40567.79716101401;40684.59315406926;40687.59312406838;40786.1842763149;214090;214310;214347;214798;215043;21574.89212553927;23957.52084958326;25236.74763252344;25318.42994541198;25498.362540936625;38943.26124208761;39975.400368993905;40136;40495.59504405036;40586.391204131374;31214.37571248517;31740.841295794296;32377.35245295128;32690.673093268764;32842.17894552655;31039.844800775852;33719.831400842835;34470;34572.654273456945;35692.643073568936;30987.380252395276;31120.688793111778;31309.8434507826;31332;32139.196520087185;23571.17500887461;25854.482910342063;26212.73787262103;26397.73602263953;27524;21591.352259432242;21964.231251906105;22043.559128817655;22055.22806701758;22063.889680551496 15:48:29 INFO - PROCESS | 13282 | |2;jquery.html;360.7943472220835;383.3253473885961;384.11461581055664;384.6922462030375;411.41578957879807;16077.437289694863;16904.492865214048;18021.4593562193;18042.278308867662;18181.7272740909;17374.13129343534;17409.390671326506;17801.7329740054;17900;17919;4705.458872229703;4879.70721756694;4900.313956046157;4904;4905.288733133693;4678.812847486097;4734.124187025412;4778.976105119469;4815.951840481585;4821.059893320804;4803.207470767319;4806.735629540374;4808.182608956486;4810.591099756525;4820.975895120537;4646.279826626878;4806.110869489138;4806.44725856524;4807.879803004917;4808.615310775147;4749.643776716725;4759.785809638574;4763.618910487153;4764.237721964504;4777.5700186982995;12823.61529154127;12853.67865803353;12869.356532173353;12988.350582470934;13015.544455944091;2017.465371676507;2027.9087441065187;2056.897155142237;2099.4331530486834;2162.5782972320403;9297.395669281475;9361.29790265726;9721.076497732774;11585.710357241052;13382.197068175941;1688.4681325382587;1692.9407470738588;1709.333359989605;1720.664470428267;1734.7658066161032;62116.689416552625;63780;63921.68039159821;72102.63948680223;73884.63057684731;9956.651517197008;10020.949895250476;10037;10126.443045632413;10253.384796912209;13966;13967.720645587031;13969.371378288002;13969.860301396857;13977.58067257984;6661.2006559213205;6791.185057793096;6850.451963842881;6948.513604047668;6963.512554121265;6378.266499352634;6417.7753778617525;6532.6733663316645;6556.541042127101;6575.112359831457;4081.8163182656854;4198.433211516467;4237.894052648647;4308.633766129914;4337.219300525936;1783.5006198264507;1793.75784269122;1817.37300631282;1845.427917345627;1855.7958624551288;814.3078383374085;825.5542007315983;831.7005877883956;854.2141230068352;857.7984173719171;16708.74936875948;17134.657306854042;17731.822681773276;17952.74330796858;17976.03129551288;802.8474589827914;804.5414113955106;806.9556174410346;818.7093581778502;828.7223780033636;9348.485833279236;9862.802743945082;9872.802543949081;9923.255755818342;10060.38430008203;427308;428478;429829;497097;498926;90074.54962725144;91798;92532.76135335231;93473;94386;907.6188001039579;931.7996630724291;951.6050838901916;955.145145095136;967.3373738988815;15377.461788837338;15625.296861641025;16159.838401616304;16304.309858733164;16543.75184372211;33094.17264568309;34231;36044.27911441704;37116;37265.441018384205;51974.740126299126;52243.73878130585;52566.474335256156;52993.470065298854;53756;7940.245676660708;7986.161453047346;8024.197580242163;8099.190080991853;8222.62998165072;10126;12140.696482588006;12283.508659653513;12448.62654120378;12487.875121248671;9698.56356463975;10286.588536458457;10381.844272336071;10464.947675261576;10897.455127243447;10451.320664156805;10468.790624187626;10757.408342541235;10780.784384312426;10935.070519005974;10131.442770647685;10462.110720588531;10656.200784941006;10826.67519974402;11002.944985275022;7799.415043871846;7990;8008.679652813822;8092.71675491355;8121.269085782308;9739;10361.533730981973;10461;10707.785844282915;11047.281926674741 15:48:29 INFO - PROCESS | 13282 | |3;mootools.html;1209.8790120987908;1346.8585798491158;1355.0785465883198;1369.6781256404745;1379.0208951644327;6411.070394792752;7228.349448549629;7303.8539229215385;7358.448116391279;7633.198514156017;7479.850402991937;7554.546727196358;7556.357709594691;7559.886601700979;7571.886421703679;1702.5658457093487;2006.7190593316911;2045.5602045560202;2048.8873111978837;2049.2520230115974;1751.4745576327114;2034.7863474335204;2101.5271563898077;2104.705341252226;2127.297991662748;2057.156565808019;2067.4211220858183;2068.48287928018;2076.563921576463;2080.781517940617;1942.805719428053;1988.8508361872773;1992.232990298731;1999.490130016851;2000.4898750818593;1991.9004049797452;2062.6802845558964;2063.370671945056;2064.0917996081675;2086.5826834633135;7337.88993165103;7393.519421237603;7398.297161769623;7400.222976587488;7405.518641288299;4409.691321607489;4537.069900670354;4541.250693635546;4542.364069030338;4543.386642803212;2637.4197676511135;2714.185744276709;2752.3669556002033;2780.5829125631117;2780.638516992798;998;1023.1150055202271;1037.2842738510478;1048.7011201807525;1054.9894501055044;9944.900550994469;10005.849912251322;10024.19806415485;10041.04610062043;10052.798944021151;3896.922061558753;4105.8973525662095;4175.812088456027;4179.477565304337;4183.435236243129;8755.430896991675;8763.079876612992;8772.342074344322;8774.692885749097;8782.121787821294;4655.580997710223;4660.953390466119;4661.370714953506;4662.137504561667;4664.160451118763;3153.668864769212;3373.4602463605706;4115.8971025723995;4178.39413285072;4182.519010313792;3523.559555055618;3543.2204914918675;3552.307300076512;3611.819409029538;3640;1126.1047467263545;1140.5166044341277;1141.2182654881433;1144.673767976123;1154.0940361815933;769.5305863423307;784.372501998399;790.6916302641974;797;801.3188789528971;4996.275540046673;5100.285959965608;5123.666961647481;5175.844724658266;5283.339582552181;546.7621584610707;558.4582954534095;560.4731552340787;564.3087218157724;572.3846864620549;3381.1040074380307;3405.3189362127673;3426.674465925783;3451.7583769135917;3491.965080349215;8568.528730919734;8830.55847207637;8879.866801997976;8912.68805591814;8914.153155450222;8821.382503224713;8840.513771742615;8849.247813935888;8972.102789721106;8986.640534378683;6576.967115164393;6943.409810166192;7018.719251229893;7033.085698859116;7040.225575186828;4799.488161229202;5002.024605201951;5103.7192954387865;5118.923216151835;5245.552380857561;7572.507786993828;7748.7675369739;7796.4932279401655;7799.727009554638;8044.597770111588;8048.695652173913;8097.149799270992;8149;8180.059293181361;8188.672453101809;6243.250809902841;6355.745770169141;6371.872562548816;6414.102025716496;6439.581427207217;7001;7015.438764898694;7050.400715939202;7054.823629409306;7084.46866485026;6367.426931575995;6376.39424254695;6418.871622567616;6448.709808058555;6646.8005959821285;6264.123022776724;6269.12232287471;6280.277768056732;6323.841903952438;6350.587211831216;5766.365699772938;5807.361190268983;5834.27071616048;5843.328017277898;5864.354920958605;4289.292266775947;4375.649948004216;4389.122175564964;4410.206162890582;4435.379046933367;4331.891702707458;4358.084802191575;4454.665900057574;4506.571875671806;4587.0596527712405 15:48:29 INFO - PROCESS | 13282 | |4;prototype.html;343.0463311992658;359.12732061091555;363.2299525006984;370.0563562914567;370.87946417414344;4740.597049250813;4744.288356746485;4744.976275118628;4758.714477131374;4760.143174228638;4563.7489938053395;4637.466691330498;4692.694974826634;4698.271767875985;4724.716517008973;3722.218334149818;3753.1555400035045;3758.2859256741267;3759.5750740772187;3792.6207379262128;3743.3262012837677;3756.1736417988;3760.172761992371;3764.943525847101;3765.8305376258136;3740.7568508047025;3741.8877433677035;3743.66307032367;3743.7753734775865;3757.8872633820893;3643.6902863256655;3704.5552234628517;3736.271427071722;3761.4357846322996;3763.811809409532;3275.2139486523065;3277.4100661880852;3281.1140991932284;3289.9506507402407;3302.9009129726146;4704.776758042899;4712.363830882821;4714.787834547454;4717.481077081518;4722.4970765494345;4272.914541709149;4281.015366465699;4291.291936830419;4303.806328715215;4308.956910430887;4813.903721925577;5034.572061374787;5051.217061355459;5061.215511595708;5062.696238225718;3581.158427769472;3597.37046016946;3605.080704420356;3613.421852503613;3614.1868079682126;5047.4447810740785;5066.594672426234;5173.353330833608;5317.304473390995;5353.143497040455;3599.6220396858475;3626.165981824195;3626.2928728897614;3632.473291372789;3658.6158453362546;3684.9447258291148;3686.170611612419;3688.8524459021337;3697.7226707997006;3721.6092310307567;4067.247559201557;4136.6483848872585;4280.293751530962;4285.46431696038;4293.175400454857;4792.268407007972;5028.949710502921;5063.000229818475;5082;5092.363454568179;1244.258038745763;1244.3031902134833;1250.6810763255312;1254.1659796235401;1256.158373889478;816.7794695432319;854.9572521373907;863.0592654007162;871.7210492642421;879.6569337958201;4293.527711951683;4319.565945073674;4320.071184695243;4327.333976419039;4339.8969736638455;5017.638182417789;5030.270610761419;5043.571296439771;5060.949390506122;5070.797168113234;4290.249206388869;4296.634786043159;4337.8481753138485;4354.690435269218;4360.236958532308;2500.4124030852736;2655.588383800514;2677.5314319994313;2678.169767372121;2680.6783186017415;4738.099761045391;4740.312654665055;4767.642426818003;4769.904601907942;4795.304680821261;4877.244027175793;5159.819406320761;5164.218344671082;5174.456682048331;5174.689518628894;4701.224297990793;4711.057788442326;4716.95283047172;4724.4094488188975;4735.318961768591;4993.450720420678;5029.00774039446;5032.521910418504;5053.59571234293;5065.620078494054;4897.142999975062;4939.246567468497;4942.827001054946;4954.133026720381;4983.380401369497;4673.485916549109;4780.521947805191;4872.634552408513;4875.146849301429;4876.317315575751;3603.189282411541;3657.8353974070696;3725.4970578971493;3732.3654978654235;3735.9252814944093;5229.869253268699;5238;5242.868928276671;5245.947540524546;5254.264402983509;4904.190808516555;5067.594592432522;5068.2904393384215;5071.044585223532;5077.390713114302;4975.328330675313;4986.32684587576;5043.747812609281;5045.68812108847;5047.1419858623385;4963.404391473046;4984.451710311935;4986.877952460667;4993.20380586858;4993.400791904995;4830.975845120893;4935.851924442272;4964.751762411793;4986.700797952134;5008.173651347633;4935.753212339297;4940.505949405031;4943.431505376928;4944.3572335596145;4945.357103576512 15:48:29 INFO - PROCESS | 13282 | |5;yui.html;601.0235252112509;614.7878981751294;622.4273668225231;627.1063734178794;629.5184184099162;12519.937400312998;12991.675208119801;13062.738745225113;13193.670158246048;13368.933155334222;12837.807432888514;12902.935485322583;12936.159149655266;12994.090413671047;13058.542950996693;811.7199566149669;829.1252728371566;832.0473058348188;832.3341326938455;832.8792325112855;808.2846680687604;829.5105887526358;832.1553623072556;836.6277006732007;839.6137776622761;856.5503110866782;858.2490320969152;858.5835869603237;859.2610355094614;860.1269711243093;855.9529225892574;857.9356548258875;858.9828203435897;859.0035558751849;859.0679113162226;633.3444884544474;633.4014356433172;633.7813454358239;634.1312402009231;634.4290138875003;13714.519991800338;14028.158310501403;14057.78913316301;14107.294635268196;14151.858481415156;12772;13144.40850161745;13198;13384.665383365396;13687.315634218348;10546.630867919586;10655.84016239757;10706.732331691692;11011.339319640847;11025.393603351813;3127.2650927032128;3130.0922732407575;3192.4413227685063;3230.1117192772176;3296.719778818803;57886;58589.41410585882;58693.41306586922;59527;59736;9820.950895245622;9880.752981175528;9931.106200441995;9939.403635781877;10045.19638428924;17137.143142842808;18235.90882045608;18281.177347019417;18312.63374732498;18350;6547.116139321226;6560.343965603497;6710.530262881649;6814.1482314710665;6836.829079273058;3341.2482191506715;3348.3805495982833;3366.882159124419;3393.6945674888884;3399.3201359728155;2976.136920293091;3049.6340439147443;3063.0963865659683;3066.9693303066683;3079.39951709419;504.22601306994324;512.2546694559408;512.8538366565585;524.0043916558569;524.5646113725675;613.6287546034674;622.287480834442;641.6246495800009;644.4554351572914;658.9176352955881;8508.829823403497;8625.870611940825;9067;9176.495292758962;9395.718128456158;591.4499515450586;620.6183197333607;621.2513920725515;624.3756243756244;627.7928283666379;4170.186813571385;4269.4449721536;4282.657387409;4348.913021739548;4407.338899165086;57058.71470642703;57235.713821430625;59108.40891591115;60731.39268607346;60917.69541152266;35591.64408355884;43738.78130609327;44309.556904430545;46733.29900051502;52285.73857130766;45127.54872451299;45776.54223457789;46406;46487;47651.285230721565;9565.186959108276;9839.803203936024;9974.650887218913;9998.200143988319;10002;31488;31500;32416.513752293264;32861.54953729824;33178.5023224647;36527.45208821817;39263.803680981415;39502;39823.60176398199;39984.60092394466;10925.125989920945;11088.944555277172;11292.040176585082;11524.43038663892;11606.941965290458;12842.709242858924;13053.738925221633;13110.213387196798;13186.736265274449;13381.063325567506;11952.940235298767;12088.335141567299;12152.392380380768;12241.571544995883;12961.611151665466;11520.53917843277;11567.942160289482;11768.235064720766;12181.634550963485;12455.190412623151;11889.702757430787;11934.582289619822;12015.639530814089;12197.939010304892;12514.18657787241;8872.512011839412;9118;9372.203362714246;9581.904180958101;9585.376950498196;9187.265018798347;9471.715848524555;9565.808683826424;9567;9588.520573971413 15:48:29 INFO - PROCESS | 13282 | __end_tp_report 15:48:29 INFO - PROCESS | 13282 | __start_cc_report 15:48:29 INFO - PROCESS | 13282 | _x_x_mozilla_cycle_collect,1703 15:48:29 INFO - PROCESS | 13282 | __end_cc_report 15:48:29 INFO - PROCESS | 13282 | __startTimestamp1487807309049__endTimestamp 15:48:29 INFO - PROCESS | 13282 | 15:48:29 INFO - PROCESS | 13282 | ------- Summary: start ------- 15:48:29 INFO - PROCESS | 13282 | Number of tests: 6 15:48:29 INFO - PROCESS | 13282 | 15:48:29 INFO - PROCESS | 13282 | [#0] dojo.html Cycles:165 Average:4602.05 Median:4742.00 stddev:483.06 (10.2%) stddev-sans-first:456.68 15:48:29 INFO - PROCESS | 13282 | Values: 2540.9 2565.3 2590.2 2596.1 2602.5 4477.1 4554.6 4659.2 4686.6 4706.4 4650.6 4653.5 4704.3 4708.8 4742.0 4134.0 4237.9 4314.9 4379.7 4459.9 4380.7 4424.6 4450.0 4462.5 4469.4 4208.3 4249.1 4250.7 4350.7 4366.4 4293.2 4299.8 4303.2 4307.4 4307.5 4248.8 4268.0 4272.4 4272.4 4342.9 4678.3 4684.6 4690.0 4726.8 4746.0 5046.9 5059.8 5070.1 5075.1 5118.8 4857.4 4922.3 4929.7 4991.8 5097.3 4621.4 4660.4 4669.2 4670.0 4670.2 5011.2 5068.0 5079.6 5080.1 5082.6 4868.7 4891.7 4892.9 4933.9 4936.5 4945.9 4968.9 4973.1 4977.3 5017.5 4781.7 4946.2 4946.6 4952.8 4998.9 4830.7 4886.7 4896.9 4897.5 4903.6 4164.3 4167.7 4167.9 4168.7 4178.8 3671.9 3672.0 3688.6 3704.9 3716.5 4318.6 4321.8 4329.3 4339.7 4370.2 4795.2 4809.3 4827.7 4996.6 5056.6 4223.5 4226.7 4230.6 4236.0 4236.0 4399.3 4402.0 4405.6 4408.7 4410.1 4597.3 4602.6 4605.4 4607.1 4610.2 4858.8 4883.5 4893.2 4898.0 4960.8 4674.8 4712.7 4713.6 4743.7 4752.8 4941.8 4947.8 4951.1 4954.3 5000.8 4873.7 4929.6 4936.0 5014.3 5069.8 4848.8 4859.5 4872.0 4912.9 4966.3 4896.3 4898.2 4915.0 4915.2 4961.5 4678.9 4878.4 4883.9 4884.7 4918.9 4808.6 4854.1 4861.3 4863.6 4866.6 4759.4 4805.3 4813.9 4857.7 4931.4 15:48:29 INFO - PROCESS | 13282 | 15:48:29 INFO - PROCESS | 13282 | [#1] ext.html Cycles:180 Average:40935.18 Median:19627.14 stddev:68656.87 (349.8%) stddev-sans-first:68782.48 15:48:29 INFO - PROCESS | 13282 | Values: 539.9 546.5 570.6 575.4 581.8 26684.9 29394.0 37403.6 38933.2 39063.4 40406.6 40683.2 40684.4 40714.8 40719.0 7498.9 7685.8 7689.5 7692.7 7697.4 6935.0 7106.4 7372.0 9586.4 9805.4 9863.8 9925.8 9930.6 9938.7 9941.6 9814.5 9869.8 9881.0 9891.5 9893.8 9630.0 9698.6 9702.7 9709.5 9712.5 36621.6 36894.1 37005.8 37009.8 37050.0 3456.6 3486.4 3513.5 3542.0 3561.6 27029.2 27256.0 27315.9 27371.6 27823.0 3329.4 3374.5 3398.8 3415.6 3518.4 236647.0 238595.0 239404.0 239444.8 240014.0 47046.3 47415.3 47426.6 47446.8 47485.1 40645.8 41408.0 47864.0 48616.0 48624.0 12218.1 12414.0 12432.8 12440.7 12443.4 9025.6 9067.8 9117.1 9223.8 9237.9 15615.7 15706.4 15720.3 15730.8 15737.9 6564.6 6646.8 6724.2 6740.5 6804.1 749.6 773.9 777.6 779.3 781.8 26169.9 26998.2 27488.0 27578.7 27789.2 898.4 911.8 912.6 921.1 926.5 14083.2 14261.6 14329.4 14522.3 14619.0 320035.0 320501.0 322127.0 322345.0 323856.0 48891.5 49483.0 49538.6 49575.5 49629.8 1117.5 1171.7 1172.3 1173.3 1178.1 24463.8 25639.2 26133.0 26209.3 26339.5 40272.6 40567.8 40684.6 40687.6 40786.2 214090.0 214310.0 214347.0 214798.0 215043.0 21574.9 23957.5 25236.7 25318.4 25498.4 38943.3 39975.4 40136.0 40495.6 40586.4 31214.4 31740.8 32377.4 32690.7 32842.2 31039.8 33719.8 34470.0 34572.7 35692.6 30987.4 31120.7 31309.8 31332.0 32139.2 23571.2 25854.5 26212.7 26397.7 27524.0 21591.4 21964.2 22043.6 22055.2 22063.9 15:48:29 INFO - PROCESS | 13282 | 15:48:29 INFO - PROCESS | 13282 | [#2] jquery.html Cycles:180 Average:26401.29 Median:217068.82 stddev:75530.95 (34.8%) stddev-sans-first:75717.52 15:48:29 INFO - PROCESS | 13282 | Values: 360.8 383.3 384.1 384.7 411.4 16077.4 16904.5 18021.5 18042.3 18181.7 17374.1 17409.4 17801.7 17900.0 17919.0 4705.5 4879.7 4900.3 4904.0 4905.3 4678.8 4734.1 4779.0 4816.0 4821.1 4803.2 4806.7 4808.2 4810.6 4821.0 4646.3 4806.1 4806.4 4807.9 4808.6 4749.6 4759.8 4763.6 4764.2 4777.6 12823.6 12853.7 12869.4 12988.4 13015.5 2017.5 2027.9 2056.9 2099.4 2162.6 9297.4 9361.3 9721.1 11585.7 13382.2 1688.5 1692.9 1709.3 1720.7 1734.8 62116.7 63780.0 63921.7 72102.6 73884.6 9956.7 10020.9 10037.0 10126.4 10253.4 13966.0 13967.7 13969.4 13969.9 13977.6 6661.2 6791.2 6850.5 6948.5 6963.5 6378.3 6417.8 6532.7 6556.5 6575.1 4081.8 4198.4 4237.9 4308.6 4337.2 1783.5 1793.8 1817.4 1845.4 1855.8 814.3 825.6 831.7 854.2 857.8 16708.7 17134.7 17731.8 17952.7 17976.0 802.8 804.5 807.0 818.7 828.7 9348.5 9862.8 9872.8 9923.3 10060.4 427308.0 428478.0 429829.0 497097.0 498926.0 90074.5 91798.0 92532.8 93473.0 94386.0 907.6 931.8 951.6 955.1 967.3 15377.5 15625.3 16159.8 16304.3 16543.8 33094.2 34231.0 36044.3 37116.0 37265.4 51974.7 52243.7 52566.5 52993.5 53756.0 7940.2 7986.2 8024.2 8099.2 8222.6 10126.0 12140.7 12283.5 12448.6 12487.9 9698.6 10286.6 10381.8 10464.9 10897.5 10451.3 10468.8 10757.4 10780.8 10935.1 10131.4 10462.1 10656.2 10826.7 11002.9 7799.4 7990.0 8008.7 8092.7 8121.3 9739.0 10361.5 10461.0 10707.8 11047.3 15:48:29 INFO - PROCESS | 13282 | 15:48:29 INFO - PROCESS | 13282 | [#3] mootools.html Cycles:180 Average:4840.05 Median:5051.16 stddev:2676.06 (53.0%) stddev-sans-first:2669.66 15:48:29 INFO - PROCESS | 13282 | Values: 1209.9 1346.9 1355.1 1369.7 1379.0 6411.1 7228.3 7303.9 7358.4 7633.2 7479.9 7554.5 7556.4 7559.9 7571.9 1702.6 2006.7 2045.6 2048.9 2049.3 1751.5 2034.8 2101.5 2104.7 2127.3 2057.2 2067.4 2068.5 2076.6 2080.8 1942.8 1988.9 1992.2 1999.5 2000.5 1991.9 2062.7 2063.4 2064.1 2086.6 7337.9 7393.5 7398.3 7400.2 7405.5 4409.7 4537.1 4541.3 4542.4 4543.4 2637.4 2714.2 2752.4 2780.6 2780.6 998.0 1023.1 1037.3 1048.7 1055.0 9944.9 10005.8 10024.2 10041.0 10052.8 3896.9 4105.9 4175.8 4179.5 4183.4 8755.4 8763.1 8772.3 8774.7 8782.1 4655.6 4661.0 4661.4 4662.1 4664.2 3153.7 3373.5 4115.9 4178.4 4182.5 3523.6 3543.2 3552.3 3611.8 3640.0 1126.1 1140.5 1141.2 1144.7 1154.1 769.5 784.4 790.7 797.0 801.3 4996.3 5100.3 5123.7 5175.8 5283.3 546.8 558.5 560.5 564.3 572.4 3381.1 3405.3 3426.7 3451.8 3492.0 8568.5 8830.6 8879.9 8912.7 8914.2 8821.4 8840.5 8849.2 8972.1 8986.6 6577.0 6943.4 7018.7 7033.1 7040.2 4799.5 5002.0 5103.7 5118.9 5245.6 7572.5 7748.8 7796.5 7799.7 8044.6 8048.7 8097.1 8149.0 8180.1 8188.7 6243.3 6355.7 6371.9 6414.1 6439.6 7001.0 7015.4 7050.4 7054.8 7084.5 6367.4 6376.4 6418.9 6448.7 6646.8 6264.1 6269.1 6280.3 6323.8 6350.6 5766.4 5807.4 5834.3 5843.3 5864.4 4289.3 4375.6 4389.1 4410.2 4435.4 4331.9 4358.1 4454.7 4506.6 4587.1 15:48:29 INFO - PROCESS | 13282 | 15:48:29 INFO - PROCESS | 13282 | [#4] prototype.html Cycles:180 Average:4141.11 Median:4717.22 stddev:1192.70 (25.3%) stddev-sans-first:1161.47 15:48:29 INFO - PROCESS | 13282 | Values: 343.0 359.1 363.2 370.1 370.9 4740.6 4744.3 4745.0 4758.7 4760.1 4563.7 4637.5 4692.7 4698.3 4724.7 3722.2 3753.2 3758.3 3759.6 3792.6 3743.3 3756.2 3760.2 3764.9 3765.8 3740.8 3741.9 3743.7 3743.8 3757.9 3643.7 3704.6 3736.3 3761.4 3763.8 3275.2 3277.4 3281.1 3290.0 3302.9 4704.8 4712.4 4714.8 4717.5 4722.5 4272.9 4281.0 4291.3 4303.8 4309.0 4813.9 5034.6 5051.2 5061.2 5062.7 3581.2 3597.4 3605.1 3613.4 3614.2 5047.4 5066.6 5173.4 5317.3 5353.1 3599.6 3626.2 3626.3 3632.5 3658.6 3684.9 3686.2 3688.9 3697.7 3721.6 4067.2 4136.6 4280.3 4285.5 4293.2 4792.3 5028.9 5063.0 5082.0 5092.4 1244.3 1244.3 1250.7 1254.2 1256.2 816.8 855.0 863.1 871.7 879.7 4293.5 4319.6 4320.1 4327.3 4339.9 5017.6 5030.3 5043.6 5060.9 5070.8 4290.2 4296.6 4337.8 4354.7 4360.2 2500.4 2655.6 2677.5 2678.2 2680.7 4738.1 4740.3 4767.6 4769.9 4795.3 4877.2 5159.8 5164.2 5174.5 5174.7 4701.2 4711.1 4717.0 4724.4 4735.3 4993.5 5029.0 5032.5 5053.6 5065.6 4897.1 4939.2 4942.8 4954.1 4983.4 4673.5 4780.5 4872.6 4875.1 4876.3 3603.2 3657.8 3725.5 3732.4 3735.9 5229.9 5238.0 5242.9 5245.9 5254.3 4904.2 5067.6 5068.3 5071.0 5077.4 4975.3 4986.3 5043.7 5045.7 5047.1 4963.4 4984.5 4986.9 4993.2 4993.4 4831.0 4935.9 4964.8 4986.7 5008.2 4935.8 4940.5 4943.4 4944.4 4945.4 15:48:29 INFO - PROCESS | 13282 | 15:48:29 INFO - PROCESS | 13282 | [#5] yui.html Cycles:180 Average:13814.63 Median:45452.05 stddev:16072.47 (35.4%) stddev-sans-first:16086.93 15:48:29 INFO - PROCESS | 13282 | Values: 601.0 614.8 622.4 627.1 629.5 12519.9 12991.7 13062.7 13193.7 13368.9 12837.8 12902.9 12936.2 12994.1 13058.5 811.7 829.1 832.0 832.3 832.9 808.3 829.5 832.2 836.6 839.6 856.6 858.2 858.6 859.3 860.1 856.0 857.9 859.0 859.0 859.1 633.3 633.4 633.8 634.1 634.4 13714.5 14028.2 14057.8 14107.3 14151.9 12772.0 13144.4 13198.0 13384.7 13687.3 10546.6 10655.8 10706.7 11011.3 11025.4 3127.3 3130.1 3192.4 3230.1 3296.7 57886.0 58589.4 58693.4 59527.0 59736.0 9821.0 9880.8 9931.1 9939.4 10045.2 17137.1 18235.9 18281.2 18312.6 18350.0 6547.1 6560.3 6710.5 6814.1 6836.8 3341.2 3348.4 3366.9 3393.7 3399.3 2976.1 3049.6 3063.1 3067.0 3079.4 504.2 512.3 512.9 524.0 524.6 613.6 622.3 641.6 644.5 658.9 8508.8 8625.9 9067.0 9176.5 9395.7 591.4 620.6 621.3 624.4 627.8 4170.2 4269.4 4282.7 4348.9 4407.3 57058.7 57235.7 59108.4 60731.4 60917.7 35591.6 43738.8 44309.6 46733.3 52285.7 45127.5 45776.5 46406.0 46487.0 47651.3 9565.2 9839.8 9974.7 9998.2 10002.0 31488.0 31500.0 32416.5 32861.5 33178.5 36527.5 39263.8 39502.0 39823.6 39984.6 10925.1 11088.9 11292.0 11524.4 11606.9 12842.7 13053.7 13110.2 13186.7 13381.1 11952.9 12088.3 12152.4 12241.6 12961.6 11520.5 11567.9 11768.2 12181.6 12455.2 11889.7 11934.6 12015.6 12197.9 12514.2 8872.5 9118.0 9372.2 9581.9 9585.4 9187.3 9471.7 9565.8 9567.0 9588.5 15:48:29 INFO - PROCESS | 13282 | -------- Summary: end -------- 15:48:29 INFO - PROCESS | 13282 | 15:48:29 INFO - TEST-INFO | 13282: exit 0 15:48:29 INFO - TEST-OK | dromaeo_css | took 1122373ms 15:48:29 INFO - TEST-START | kraken 15:48:29 INFO - operating with platform_type : linux_ 15:48:29 INFO - Initialising browser for kraken test... 15:48:29 INFO - TEST-INFO | started process 13606 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWDzukd/profile http://localhost:42421/getInfo.html) 15:48:33 INFO - PROCESS | 13606 | __metrics Screen width/height:1600/1200 15:48:33 INFO - PROCESS | 13606 | colorDepth:24 15:48:33 INFO - PROCESS | 13606 | Browser inner width/height: 1024/697 15:48:33 INFO - PROCESS | 13606 | __metrics 15:48:34 INFO - PROCESS | 13606 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:48:34 INFO - PROCESS | 13606 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:48:35 INFO - TEST-INFO | 13606: exit 0 15:48:35 INFO - Browser initialized. 15:48:35 INFO - Running cycle 1/1 for kraken test... 15:48:35 INFO - TEST-INFO | started process 13695 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWDzukd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:48:48 INFO - PROCESS | 13695 | RSS: Main: 147877888 15:48:48 INFO - PROCESS | 13695 | 15:48:50 INFO - PROCESS | 13695 | Cycle 1(1): loaded http://localhost:42421/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42421/tests/kraken/driver.html?testName=audio-beat-detection) 15:48:51 INFO - PROCESS | 13695 | RSS: Main: 202641408 15:48:51 INFO - PROCESS | 13695 | 15:48:54 INFO - PROCESS | 13695 | Cycle 1(1): loaded http://localhost:42421/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42421/tests/kraken/driver.html?testName=audio-dft) 15:48:55 INFO - PROCESS | 13695 | RSS: Main: 181694464 15:48:55 INFO - PROCESS | 13695 | 15:48:58 INFO - PROCESS | 13695 | Cycle 1(1): loaded http://localhost:42421/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42421/tests/kraken/driver.html?testName=audio-fft) 15:48:58 INFO - PROCESS | 13695 | RSS: Main: 264101888 15:48:58 INFO - PROCESS | 13695 | 15:49:01 INFO - PROCESS | 13695 | Cycle 1(1): loaded http://localhost:42421/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42421/tests/kraken/driver.html?testName=audio-oscillator) 15:49:01 INFO - PROCESS | 13695 | RSS: Main: 173723648 15:49:01 INFO - PROCESS | 13695 | 15:49:03 INFO - PROCESS | 13695 | Cycle 1(1): loaded http://localhost:42421/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42421/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:49:04 INFO - PROCESS | 13695 | RSS: Main: 178675712 15:49:04 INFO - PROCESS | 13695 | 15:49:07 INFO - PROCESS | 13695 | Cycle 1(1): loaded http://localhost:42421/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42421/tests/kraken/driver.html?testName=imaging-darkroom) 15:49:08 INFO - PROCESS | 13695 | RSS: Main: 217878528 15:49:08 INFO - PROCESS | 13695 | 15:49:11 INFO - PROCESS | 13695 | Cycle 1(1): loaded http://localhost:42421/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42421/tests/kraken/driver.html?testName=imaging-desaturate) 15:49:12 INFO - PROCESS | 13695 | RSS: Main: 211959808 15:49:12 INFO - PROCESS | 13695 | 15:49:15 INFO - PROCESS | 13695 | Cycle 1(1): loaded http://localhost:42421/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42421/tests/kraken/driver.html?testName=json-parse-financial) 15:49:15 INFO - PROCESS | 13695 | RSS: Main: 213602304 15:49:15 INFO - PROCESS | 13695 | 15:49:17 INFO - PROCESS | 13695 | Cycle 1(1): loaded http://localhost:42421/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42421/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:49:18 INFO - PROCESS | 13695 | RSS: Main: 176664576 15:49:18 INFO - PROCESS | 13695 | 15:49:19 INFO - PROCESS | 13695 | Cycle 1(1): loaded http://localhost:42421/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42421/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:49:20 INFO - PROCESS | 13695 | RSS: Main: 185053184 15:49:20 INFO - PROCESS | 13695 | 15:49:22 INFO - PROCESS | 13695 | Cycle 1(1): loaded http://localhost:42421/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42421/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:49:23 INFO - PROCESS | 13695 | RSS: Main: 193339392 15:49:23 INFO - PROCESS | 13695 | 15:49:26 INFO - PROCESS | 13695 | Cycle 1(1): loaded http://localhost:42421/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42421/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:49:27 INFO - PROCESS | 13695 | RSS: Main: 202121216 15:49:27 INFO - PROCESS | 13695 | 15:49:30 INFO - PROCESS | 13695 | Cycle 1(1): loaded http://localhost:42421/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42421/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:49:30 INFO - PROCESS | 13695 | RSS: Main: 198836224 15:49:30 INFO - PROCESS | 13695 | 15:49:32 INFO - PROCESS | 13695 | Cycle 1(1): loaded http://localhost:42421/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42421/tests/kraken/driver.html?testName=ai-astar) 15:49:32 INFO - PROCESS | 13695 | RSS: Main: 250396672 15:49:32 INFO - PROCESS | 13695 | 15:49:32 INFO - PROCESS | 13695 | __start_tp_report 15:49:32 INFO - PROCESS | 13695 | _x_x_mozilla_page_load 15:49:32 INFO - PROCESS | 13695 | _x_x_mozilla_page_load_details 15:49:32 INFO - PROCESS | 13695 | |i|pagename|runs| 15:49:32 INFO - PROCESS | 13695 | |0;ai-astar;115;115;114;118;116;117;114;113;114;114 15:49:32 INFO - PROCESS | 13695 | |1;audio-beat-detection;151;131;134;162;126;126;126;125;152;126 15:49:32 INFO - PROCESS | 13695 | |2;audio-dft;163;161;162;164;163;163;165;164;164;162 15:49:32 INFO - PROCESS | 13695 | |3;audio-fft;79;78;77;102;79;77;78;78;108;77 15:49:32 INFO - PROCESS | 13695 | |4;audio-oscillator;84;84;108;85;85;85;100;84;85;105 15:49:32 INFO - PROCESS | 13695 | |5;imaging-gaussian-blur;114;113;114;113;114;113;115;114;113;112 15:49:32 INFO - PROCESS | 13695 | |6;imaging-darkroom;149;150;150;149;148;149;148;148;148;149 15:49:32 INFO - PROCESS | 13695 | |7;imaging-desaturate;95;95;95;95;96;95;96;96;97;95 15:49:32 INFO - PROCESS | 13695 | |8;json-parse-financial;64;63;64;65;66;66;66;65;65;64 15:49:32 INFO - PROCESS | 13695 | |9;json-stringify-tinderbox;66;65;66;65;65;65;65;67;66;67 15:49:32 INFO - PROCESS | 13695 | |10;stanford-crypto-aes;87;87;89;88;87;88;88;90;87;87 15:49:32 INFO - PROCESS | 13695 | |11;stanford-crypto-ccm;145;139;137;134;137;146;137;146;189;139 15:49:32 INFO - PROCESS | 13695 | |12;stanford-crypto-pbkdf2;188;188;188;192;184;193;192;194;184;188 15:49:32 INFO - PROCESS | 13695 | |13;stanford-crypto-sha256-iterative;75;78;70;84;70;69;70;72;73;73 15:49:32 INFO - PROCESS | 13695 | __end_tp_report 15:49:32 INFO - PROCESS | 13695 | __start_cc_report 15:49:32 INFO - PROCESS | 13695 | _x_x_mozilla_cycle_collect,2033 15:49:32 INFO - PROCESS | 13695 | __end_cc_report 15:49:32 INFO - PROCESS | 13695 | __startTimestamp1487807372935__endTimestamp 15:49:32 INFO - PROCESS | 13695 | 15:49:32 INFO - PROCESS | 13695 | ------- Summary: start ------- 15:49:32 INFO - PROCESS | 13695 | Number of tests: 14 15:49:32 INFO - PROCESS | 13695 | 15:49:32 INFO - PROCESS | 13695 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.00 stddev:1.56 (1.4%) stddev-sans-first:1.66 15:49:32 INFO - PROCESS | 13695 | Values: 115.0 115.0 114.0 118.0 116.0 117.0 114.0 113.0 114.0 114.0 15:49:32 INFO - PROCESS | 13695 | 15:49:32 INFO - PROCESS | 13695 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:132.50 stddev:13.77 (10.4%) stddev-sans-first:13.48 15:49:32 INFO - PROCESS | 13695 | Values: 151.0 131.0 134.0 162.0 126.0 126.0 126.0 125.0 152.0 126.0 15:49:32 INFO - PROCESS | 13695 | 15:49:32 INFO - PROCESS | 13695 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.50 stddev:1.20 (0.7%) stddev-sans-first:1.27 15:49:32 INFO - PROCESS | 13695 | Values: 163.0 161.0 162.0 164.0 163.0 163.0 165.0 164.0 164.0 162.0 15:49:32 INFO - PROCESS | 13695 | 15:49:32 INFO - PROCESS | 13695 | [#3] audio-fft Cycles:10 Average:83.30 Median:78.00 stddev:11.55 (14.8%) stddev-sans-first:12.14 15:49:32 INFO - PROCESS | 13695 | Values: 79.0 78.0 77.0 102.0 79.0 77.0 78.0 78.0 108.0 77.0 15:49:32 INFO - PROCESS | 13695 | 15:49:32 INFO - PROCESS | 13695 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:84.50 stddev:9.74 (11.5%) stddev-sans-first:10.05 15:49:32 INFO - PROCESS | 13695 | Values: 84.0 84.0 108.0 85.0 85.0 85.0 100.0 84.0 85.0 105.0 15:49:32 INFO - PROCESS | 13695 | 15:49:32 INFO - PROCESS | 13695 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 15:49:32 INFO - PROCESS | 13695 | Values: 114.0 113.0 114.0 113.0 114.0 113.0 115.0 114.0 113.0 112.0 15:49:32 INFO - PROCESS | 13695 | 15:49:32 INFO - PROCESS | 13695 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 15:49:32 INFO - PROCESS | 13695 | Values: 149.0 150.0 150.0 149.0 148.0 149.0 148.0 148.0 148.0 149.0 15:49:32 INFO - PROCESS | 13695 | 15:49:32 INFO - PROCESS | 13695 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 15:49:32 INFO - PROCESS | 13695 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 97.0 95.0 15:49:32 INFO - PROCESS | 13695 | 15:49:32 INFO - PROCESS | 13695 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:65.00 stddev:1.03 (1.6%) stddev-sans-first:1.05 15:49:32 INFO - PROCESS | 13695 | Values: 64.0 63.0 64.0 65.0 66.0 66.0 66.0 65.0 65.0 64.0 15:49:32 INFO - PROCESS | 13695 | 15:49:32 INFO - PROCESS | 13695 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 15:49:32 INFO - PROCESS | 13695 | Values: 66.0 65.0 66.0 65.0 65.0 65.0 65.0 67.0 66.0 67.0 15:49:32 INFO - PROCESS | 13695 | 15:49:32 INFO - PROCESS | 13695 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:88.00 stddev:1.03 (1.2%) stddev-sans-first:1.05 15:49:32 INFO - PROCESS | 13695 | Values: 87.0 87.0 89.0 88.0 87.0 88.0 88.0 90.0 87.0 87.0 15:49:32 INFO - PROCESS | 13695 | 15:49:32 INFO - PROCESS | 13695 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:142.00 stddev:16.07 (11.3%) stddev-sans-first:17.04 15:49:32 INFO - PROCESS | 13695 | Values: 145.0 139.0 137.0 134.0 137.0 146.0 137.0 146.0 189.0 139.0 15:49:32 INFO - PROCESS | 13695 | 15:49:32 INFO - PROCESS | 13695 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.10 Median:190.00 stddev:3.54 (1.9%) stddev-sans-first:3.73 15:49:32 INFO - PROCESS | 13695 | Values: 188.0 188.0 188.0 192.0 184.0 193.0 192.0 194.0 184.0 188.0 15:49:32 INFO - PROCESS | 13695 | 15:49:32 INFO - PROCESS | 13695 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:73.00 stddev:4.62 (6.3%) stddev-sans-first:4.87 15:49:32 INFO - PROCESS | 13695 | Values: 75.0 78.0 70.0 84.0 70.0 69.0 70.0 72.0 73.0 73.0 15:49:32 INFO - PROCESS | 13695 | -------- Summary: end -------- 15:49:32 INFO - PROCESS | 13695 | 15:49:34 INFO - TEST-INFO | 13695: exit 0 15:49:34 INFO - TEST-OK | kraken | took 64238ms 15:49:34 INFO - SUITE-END | took 1186s 15:49:34 INFO - Completed test suite (00:19:47) 15:49:34 INFO - javascript benchmark 15:49:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6194.362262623198, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2540.9364765880855, 2565.3073670109084, 2590.184092011017, 2596.10434400132, 2602.4534847681975, 4477.149341625097, 4554.612857907082, 4659.184642687529, 4686.578207961283, 4706.411698537683, 4650.604698600623, 4653.464851542074, 4704.270838020104, 4708.835190768324, 4742.0, 4134.049168691203, 4237.915241695165, 4314.913701725964, 4379.737215767048, 4459.9331010034875, 4380.737155770648, 4424.623906967911, 4449.977750111261, 4462.486814016397, 4469.44131983502, 4208.284591619432, 4249.128928569636, 4250.659947204216, 4350.695451318409, 4366.366876802846, 4293.162833247518, 4299.806508707115, 4303.2469317869245, 4307.375430562551, 4307.483102027745, 4248.766317852517, 4267.97866010668, 4272.380504826814, 4272.401863739048, 4342.869713908588, 4678.345031695565, 4684.648651351128, 4689.9765501172615, 4726.76366181693, 4745.976270118662, 5046.949530504685, 5059.772310246048, 5070.08738427083, 5075.137226671474, 5118.846434606968, 4857.417109946829, 4922.335484709554, 4929.65492415531, 4991.825286115005, 5097.2608971699265, 4621.353010578522, 4660.39414876064, 4669.229577119737, 4669.953300466952, 4670.159371313196, 5011.198208286657, 5068.0, 5079.644424890223, 5080.110980578384, 5082.567981721595, 4868.659193856467, 4891.6575839691595, 4892.926606100911, 4933.851984440401, 4936.531029552187, 4945.851624451272, 4968.90062198754, 4973.055119527278, 4977.303177555145, 5017.4731653175895, 4781.6891902026255, 4946.159152944008, 4946.604271658259, 4952.777125029383, 4998.850034498971, 4830.686005409637, 4886.682365646222, 4896.877578060506, 4897.510248975145, 4903.632227582945, 4164.292070348048, 4167.666586673119, 4167.937480937789, 4168.708190426702, 4178.770167640748, 3671.908202294964, 3671.9816400918357, 3688.6311368863435, 3704.8888533344043, 3716.479692843004, 4318.589733975267, 4321.783910804447, 4329.264025115738, 4339.717918335298, 4370.213361594943, 4795.184818580849, 4809.254565542346, 4827.686200396963, 4996.625253106032, 5056.6207534434325, 4223.493180818322, 4226.725262857904, 4230.598093181143, 4235.957640423557, 4236.0257140857775, 4399.252127138394, 4401.977990110029, 4405.581469760367, 4408.735475871394, 4410.07388448423, 4597.3333866589155, 4602.631789456902, 4605.378273932976, 4607.101615185007, 4610.170169369546, 4858.805647774191, 4883.536064073907, 4893.192623217129, 4897.995910838341, 4960.801567937242, 4674.813007479663, 4712.69367491112, 4713.646476514206, 4743.667943244078, 4752.7623618818225, 4941.802327906844, 4947.802087916443, 4951.059298733229, 4954.30639710448, 5000.824971125993, 4873.707577545359, 4929.605631549396, 4936.0, 5014.323066386137, 5069.822556210515, 4848.8302909398, 4859.538343857328, 4872.025594880967, 4912.852614421573, 4966.329545511454, 4896.314515967696, 4898.191798353374, 4915.0, 4915.18899381598, 4961.5286547777905, 4678.906421871611, 4878.438979517401, 4883.926741098815, 4884.731339776346, 4918.92621610669, 4808.591269741971, 4854.126257273725, 4861.319415281792, 4863.610911127172, 4866.610671146371, 4759.428868535798, 4805.255185446262, 4813.9037219254715, 4857.6599638025, 4931.408231012301], "value": 4570.962752253515, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.9028174928512, 546.5327145290777, 570.6205373426671, 575.4102045403461, 581.7992792486591, 26684.866575667118, 29394.0, 37403.625963740385, 38933.221335573275, 39063.41404878929, 40406.59593404065, 40683.186336273255, 40684.372625095035, 40714.7964260179, 40719.0, 7498.850022999537, 7685.808699651563, 7689.500182488148, 7692.653830577638, 7697.422693297997, 6934.965325173367, 7106.3959563437165, 7372.041634587496, 9586.424814511152, 9805.411675299505, 9863.753406164831, 9925.75185620358, 9930.602775888956, 9938.701838944844, 9941.602335906555, 9814.46020468874, 9869.753256168653, 9881.0, 9891.505424728735, 9893.802123957552, 9629.951850240774, 9698.612055517771, 9702.660406885796, 9709.514524273829, 9712.465814380206, 36621.63378366209, 36894.077648058745, 37005.81497092524, 37009.81495092534, 37050.0, 3456.6370531094126, 3486.4073107571776, 3513.508108864761, 3541.964580354215, 3561.6438356164435, 27029.1891243263, 27256.0, 27315.863420682967, 27371.58942615862, 27823.0, 3329.433996220648, 3374.4769560718128, 3398.796072235674, 3415.6072051714123, 3518.3842827505086, 236647.0, 238595.0, 239404.0, 239444.80277598675, 240014.0, 47046.29430558544, 47415.28877066847, 47426.59740934998, 47446.76276618595, 47485.050298993825, 40645.79677101596, 41408.0, 47864.0, 48616.0, 48624.0, 12218.083643726755, 12414.0, 12432.813507797391, 12440.688982775502, 12443.440045197987, 9025.638974440948, 9067.773305667279, 9117.133872282122, 9223.815523689489, 9237.90762092384, 15615.687686246438, 15706.371745130295, 15720.29258683362, 15730.764038539432, 15737.921310393604, 6564.638944857983, 6646.767363142363, 6724.159480064992, 6740.460763138937, 6804.149481314836, 749.6214411722154, 773.8723110686674, 777.5606782168057, 779.2986312318958, 781.8123650323881, 26169.869150654507, 26998.19005429801, 27488.0, 27578.724212757617, 27789.166325010283, 898.4250079948838, 911.8449863523217, 912.6121398405651, 921.1019256225127, 926.5182105305338, 14083.155010699391, 14261.572152835432, 14329.35517901676, 14522.273886305642, 14619.0, 320035.0, 320501.0, 322127.0, 322345.0, 323856.0, 48891.511084889404, 49483.0, 49538.559987201435, 49575.50424495709, 49629.751851240515, 1117.519466629341, 1171.683645415733, 1172.261475270574, 1173.3194747046864, 1178.1458442629025, 24463.776811159725, 25639.230823075337, 26133.0, 26209.344766380993, 26339.473210536064, 40272.597274028056, 40567.79716101401, 40684.59315406926, 40687.59312406838, 40786.1842763149, 214090.0, 214310.0, 214347.0, 214798.0, 215043.0, 21574.89212553927, 23957.52084958326, 25236.74763252344, 25318.42994541198, 25498.362540936625, 38943.26124208761, 39975.400368993905, 40136.0, 40495.59504405036, 40586.391204131374, 31214.37571248517, 31740.841295794296, 32377.35245295128, 32690.673093268764, 32842.17894552655, 31039.844800775852, 33719.831400842835, 34470.0, 34572.654273456945, 35692.643073568936, 30987.380252395276, 31120.688793111778, 31309.8434507826, 31332.0, 32139.196520087185, 23571.17500887461, 25854.482910342063, 26212.73787262103, 26397.73602263953, 27524.0, 21591.352259432242, 21964.231251906105, 22043.559128817655, 22055.22806701758, 22063.889680551496], "value": 16547.273165120943, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.7943472220835, 383.3253473885961, 384.11461581055664, 384.6922462030375, 411.41578957879807, 16077.437289694863, 16904.492865214048, 18021.4593562193, 18042.278308867662, 18181.7272740909, 17374.13129343534, 17409.390671326506, 17801.7329740054, 17900.0, 17919.0, 4705.458872229703, 4879.70721756694, 4900.313956046157, 4904.0, 4905.288733133693, 4678.812847486097, 4734.124187025412, 4778.976105119469, 4815.951840481585, 4821.059893320804, 4803.207470767319, 4806.735629540374, 4808.182608956486, 4810.591099756525, 4820.975895120537, 4646.279826626878, 4806.110869489138, 4806.44725856524, 4807.879803004917, 4808.615310775147, 4749.643776716725, 4759.785809638574, 4763.618910487153, 4764.237721964504, 4777.5700186982995, 12823.61529154127, 12853.67865803353, 12869.356532173353, 12988.350582470934, 13015.544455944091, 2017.465371676507, 2027.9087441065187, 2056.897155142237, 2099.4331530486834, 2162.5782972320403, 9297.395669281475, 9361.29790265726, 9721.076497732774, 11585.710357241052, 13382.197068175941, 1688.4681325382587, 1692.9407470738588, 1709.333359989605, 1720.664470428267, 1734.7658066161032, 62116.689416552625, 63780.0, 63921.68039159821, 72102.63948680223, 73884.63057684731, 9956.651517197008, 10020.949895250476, 10037.0, 10126.443045632413, 10253.384796912209, 13966.0, 13967.720645587031, 13969.371378288002, 13969.860301396857, 13977.58067257984, 6661.2006559213205, 6791.185057793096, 6850.451963842881, 6948.513604047668, 6963.512554121265, 6378.266499352634, 6417.7753778617525, 6532.6733663316645, 6556.541042127101, 6575.112359831457, 4081.8163182656854, 4198.433211516467, 4237.894052648647, 4308.633766129914, 4337.219300525936, 1783.5006198264507, 1793.75784269122, 1817.37300631282, 1845.427917345627, 1855.7958624551288, 814.3078383374085, 825.5542007315983, 831.7005877883956, 854.2141230068352, 857.7984173719171, 16708.74936875948, 17134.657306854042, 17731.822681773276, 17952.74330796858, 17976.03129551288, 802.8474589827914, 804.5414113955106, 806.9556174410346, 818.7093581778502, 828.7223780033636, 9348.485833279236, 9862.802743945082, 9872.802543949081, 9923.255755818342, 10060.38430008203, 427308.0, 428478.0, 429829.0, 497097.0, 498926.0, 90074.54962725144, 91798.0, 92532.76135335231, 93473.0, 94386.0, 907.6188001039579, 931.7996630724291, 951.6050838901916, 955.145145095136, 967.3373738988815, 15377.461788837338, 15625.296861641025, 16159.838401616304, 16304.309858733164, 16543.75184372211, 33094.17264568309, 34231.0, 36044.27911441704, 37116.0, 37265.441018384205, 51974.740126299126, 52243.73878130585, 52566.474335256156, 52993.470065298854, 53756.0, 7940.245676660708, 7986.161453047346, 8024.197580242163, 8099.190080991853, 8222.62998165072, 10126.0, 12140.696482588006, 12283.508659653513, 12448.62654120378, 12487.875121248671, 9698.56356463975, 10286.588536458457, 10381.844272336071, 10464.947675261576, 10897.455127243447, 10451.320664156805, 10468.790624187626, 10757.408342541235, 10780.784384312426, 10935.070519005974, 10131.442770647685, 10462.110720588531, 10656.200784941006, 10826.67519974402, 11002.944985275022, 7799.415043871846, 7990.0, 8008.679652813822, 8092.71675491355, 8121.269085782308, 9739.0, 10361.533730981973, 10461.0, 10707.785844282915, 11047.281926674741], "value": 8147.308126623264, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1209.8790120987908, 1346.8585798491158, 1355.0785465883198, 1369.6781256404745, 1379.0208951644327, 6411.070394792752, 7228.349448549629, 7303.8539229215385, 7358.448116391279, 7633.198514156017, 7479.850402991937, 7554.546727196358, 7556.357709594691, 7559.886601700979, 7571.886421703679, 1702.5658457093487, 2006.7190593316911, 2045.5602045560202, 2048.8873111978837, 2049.2520230115974, 1751.4745576327114, 2034.7863474335204, 2101.5271563898077, 2104.705341252226, 2127.297991662748, 2057.156565808019, 2067.4211220858183, 2068.48287928018, 2076.563921576463, 2080.781517940617, 1942.805719428053, 1988.8508361872773, 1992.232990298731, 1999.490130016851, 2000.4898750818593, 1991.9004049797452, 2062.6802845558964, 2063.370671945056, 2064.0917996081675, 2086.5826834633135, 7337.88993165103, 7393.519421237603, 7398.297161769623, 7400.222976587488, 7405.518641288299, 4409.691321607489, 4537.069900670354, 4541.250693635546, 4542.364069030338, 4543.386642803212, 2637.4197676511135, 2714.185744276709, 2752.3669556002033, 2780.5829125631117, 2780.638516992798, 998.0, 1023.1150055202271, 1037.2842738510478, 1048.7011201807525, 1054.9894501055044, 9944.900550994469, 10005.849912251322, 10024.19806415485, 10041.04610062043, 10052.798944021151, 3896.922061558753, 4105.8973525662095, 4175.812088456027, 4179.477565304337, 4183.435236243129, 8755.430896991675, 8763.079876612992, 8772.342074344322, 8774.692885749097, 8782.121787821294, 4655.580997710223, 4660.953390466119, 4661.370714953506, 4662.137504561667, 4664.160451118763, 3153.668864769212, 3373.4602463605706, 4115.8971025723995, 4178.39413285072, 4182.519010313792, 3523.559555055618, 3543.2204914918675, 3552.307300076512, 3611.819409029538, 3640.0, 1126.1047467263545, 1140.5166044341277, 1141.2182654881433, 1144.673767976123, 1154.0940361815933, 769.5305863423307, 784.372501998399, 790.6916302641974, 797.0, 801.3188789528971, 4996.275540046673, 5100.285959965608, 5123.666961647481, 5175.844724658266, 5283.339582552181, 546.7621584610707, 558.4582954534095, 560.4731552340787, 564.3087218157724, 572.3846864620549, 3381.1040074380307, 3405.3189362127673, 3426.674465925783, 3451.7583769135917, 3491.965080349215, 8568.528730919734, 8830.55847207637, 8879.866801997976, 8912.68805591814, 8914.153155450222, 8821.382503224713, 8840.513771742615, 8849.247813935888, 8972.102789721106, 8986.640534378683, 6576.967115164393, 6943.409810166192, 7018.719251229893, 7033.085698859116, 7040.225575186828, 4799.488161229202, 5002.024605201951, 5103.7192954387865, 5118.923216151835, 5245.552380857561, 7572.507786993828, 7748.7675369739, 7796.4932279401655, 7799.727009554638, 8044.597770111588, 8048.695652173913, 8097.149799270992, 8149.0, 8180.059293181361, 8188.672453101809, 6243.250809902841, 6355.745770169141, 6371.872562548816, 6414.102025716496, 6439.581427207217, 7001.0, 7015.438764898694, 7050.400715939202, 7054.823629409306, 7084.46866485026, 6367.426931575995, 6376.39424254695, 6418.871622567616, 6448.709808058555, 6646.8005959821285, 6264.123022776724, 6269.12232287471, 6280.277768056732, 6323.841903952438, 6350.587211831216, 5766.365699772938, 5807.361190268983, 5834.27071616048, 5843.328017277898, 5864.354920958605, 4289.292266775947, 4375.649948004216, 4389.122175564964, 4410.206162890582, 4435.379046933367, 4331.891702707458, 4358.084802191575, 4454.665900057574, 4506.571875671806, 4587.0596527712405], "value": 3886.482031468673, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.0463311992658, 359.12732061091555, 363.2299525006984, 370.0563562914567, 370.87946417414344, 4740.597049250813, 4744.288356746485, 4744.976275118628, 4758.714477131374, 4760.143174228638, 4563.7489938053395, 4637.466691330498, 4692.694974826634, 4698.271767875985, 4724.716517008973, 3722.218334149818, 3753.1555400035045, 3758.2859256741267, 3759.5750740772187, 3792.6207379262128, 3743.3262012837677, 3756.1736417988, 3760.172761992371, 3764.943525847101, 3765.8305376258136, 3740.7568508047025, 3741.8877433677035, 3743.66307032367, 3743.7753734775865, 3757.8872633820893, 3643.6902863256655, 3704.5552234628517, 3736.271427071722, 3761.4357846322996, 3763.811809409532, 3275.2139486523065, 3277.4100661880852, 3281.1140991932284, 3289.9506507402407, 3302.9009129726146, 4704.776758042899, 4712.363830882821, 4714.787834547454, 4717.481077081518, 4722.4970765494345, 4272.914541709149, 4281.015366465699, 4291.291936830419, 4303.806328715215, 4308.956910430887, 4813.903721925577, 5034.572061374787, 5051.217061355459, 5061.215511595708, 5062.696238225718, 3581.158427769472, 3597.37046016946, 3605.080704420356, 3613.421852503613, 3614.1868079682126, 5047.4447810740785, 5066.594672426234, 5173.353330833608, 5317.304473390995, 5353.143497040455, 3599.6220396858475, 3626.165981824195, 3626.2928728897614, 3632.473291372789, 3658.6158453362546, 3684.9447258291148, 3686.170611612419, 3688.8524459021337, 3697.7226707997006, 3721.6092310307567, 4067.247559201557, 4136.6483848872585, 4280.293751530962, 4285.46431696038, 4293.175400454857, 4792.268407007972, 5028.949710502921, 5063.000229818475, 5082.0, 5092.363454568179, 1244.258038745763, 1244.3031902134833, 1250.6810763255312, 1254.1659796235401, 1256.158373889478, 816.7794695432319, 854.9572521373907, 863.0592654007162, 871.7210492642421, 879.6569337958201, 4293.527711951683, 4319.565945073674, 4320.071184695243, 4327.333976419039, 4339.8969736638455, 5017.638182417789, 5030.270610761419, 5043.571296439771, 5060.949390506122, 5070.797168113234, 4290.249206388869, 4296.634786043159, 4337.8481753138485, 4354.690435269218, 4360.236958532308, 2500.4124030852736, 2655.588383800514, 2677.5314319994313, 2678.169767372121, 2680.6783186017415, 4738.099761045391, 4740.312654665055, 4767.642426818003, 4769.904601907942, 4795.304680821261, 4877.244027175793, 5159.819406320761, 5164.218344671082, 5174.456682048331, 5174.689518628894, 4701.224297990793, 4711.057788442326, 4716.95283047172, 4724.4094488188975, 4735.318961768591, 4993.450720420678, 5029.00774039446, 5032.521910418504, 5053.59571234293, 5065.620078494054, 4897.142999975062, 4939.246567468497, 4942.827001054946, 4954.133026720381, 4983.380401369497, 4673.485916549109, 4780.521947805191, 4872.634552408513, 4875.146849301429, 4876.317315575751, 3603.189282411541, 3657.8353974070696, 3725.4970578971493, 3732.3654978654235, 3735.9252814944093, 5229.869253268699, 5238.0, 5242.868928276671, 5245.947540524546, 5254.264402983509, 4904.190808516555, 5067.594592432522, 5068.2904393384215, 5071.044585223532, 5077.390713114302, 4975.328330675313, 4986.32684587576, 5043.747812609281, 5045.68812108847, 5047.1419858623385, 4963.404391473046, 4984.451710311935, 4986.877952460667, 4993.20380586858, 4993.400791904995, 4830.975845120893, 4935.851924442272, 4964.751762411793, 4986.700797952134, 5008.173651347633, 4935.753212339297, 4940.505949405031, 4943.431505376928, 4944.3572335596145, 4945.357103576512], "value": 3778.6767301620416, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.0235252112509, 614.7878981751294, 622.4273668225231, 627.1063734178794, 629.5184184099162, 12519.937400312998, 12991.675208119801, 13062.738745225113, 13193.670158246048, 13368.933155334222, 12837.807432888514, 12902.935485322583, 12936.159149655266, 12994.090413671047, 13058.542950996693, 811.7199566149669, 829.1252728371566, 832.0473058348188, 832.3341326938455, 832.8792325112855, 808.2846680687604, 829.5105887526358, 832.1553623072556, 836.6277006732007, 839.6137776622761, 856.5503110866782, 858.2490320969152, 858.5835869603237, 859.2610355094614, 860.1269711243093, 855.9529225892574, 857.9356548258875, 858.9828203435897, 859.0035558751849, 859.0679113162226, 633.3444884544474, 633.4014356433172, 633.7813454358239, 634.1312402009231, 634.4290138875003, 13714.519991800338, 14028.158310501403, 14057.78913316301, 14107.294635268196, 14151.858481415156, 12772.0, 13144.40850161745, 13198.0, 13384.665383365396, 13687.315634218348, 10546.630867919586, 10655.84016239757, 10706.732331691692, 11011.339319640847, 11025.393603351813, 3127.2650927032128, 3130.0922732407575, 3192.4413227685063, 3230.1117192772176, 3296.719778818803, 57886.0, 58589.41410585882, 58693.41306586922, 59527.0, 59736.0, 9820.950895245622, 9880.752981175528, 9931.106200441995, 9939.403635781877, 10045.19638428924, 17137.143142842808, 18235.90882045608, 18281.177347019417, 18312.63374732498, 18350.0, 6547.116139321226, 6560.343965603497, 6710.530262881649, 6814.1482314710665, 6836.829079273058, 3341.2482191506715, 3348.3805495982833, 3366.882159124419, 3393.6945674888884, 3399.3201359728155, 2976.136920293091, 3049.6340439147443, 3063.0963865659683, 3066.9693303066683, 3079.39951709419, 504.22601306994324, 512.2546694559408, 512.8538366565585, 524.0043916558569, 524.5646113725675, 613.6287546034674, 622.287480834442, 641.6246495800009, 644.4554351572914, 658.9176352955881, 8508.829823403497, 8625.870611940825, 9067.0, 9176.495292758962, 9395.718128456158, 591.4499515450586, 620.6183197333607, 621.2513920725515, 624.3756243756244, 627.7928283666379, 4170.186813571385, 4269.4449721536, 4282.657387409, 4348.913021739548, 4407.338899165086, 57058.71470642703, 57235.713821430625, 59108.40891591115, 60731.39268607346, 60917.69541152266, 35591.64408355884, 43738.78130609327, 44309.556904430545, 46733.29900051502, 52285.73857130766, 45127.54872451299, 45776.54223457789, 46406.0, 46487.0, 47651.285230721565, 9565.186959108276, 9839.803203936024, 9974.650887218913, 9998.200143988319, 10002.0, 31488.0, 31500.0, 32416.513752293264, 32861.54953729824, 33178.5023224647, 36527.45208821817, 39263.803680981415, 39502.0, 39823.60176398199, 39984.60092394466, 10925.125989920945, 11088.944555277172, 11292.040176585082, 11524.43038663892, 11606.941965290458, 12842.709242858924, 13053.738925221633, 13110.213387196798, 13186.736265274449, 13381.063325567506, 11952.940235298767, 12088.335141567299, 12152.392380380768, 12241.571544995883, 12961.611151665466, 11520.53917843277, 11567.942160289482, 11768.235064720766, 12181.634550963485, 12455.190412623151, 11889.702757430787, 11934.582289619822, 12015.639530814089, 12197.939010304892, 12514.18657787241, 8872.512011839412, 9118.0, 9372.203362714246, 9581.904180958101, 9585.376950498196, 9187.265018798347, 9471.715848524555, 9565.808683826424, 9567.0, 9588.520573971413], "value": 6241.439995936103, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1571.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 118.0, 116.0, 117.0, 114.0, 113.0, 114.0, 114.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 131.0, 134.0, 162.0, 126.0, 126.0, 126.0, 125.0, 152.0, 126.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 164.0, 163.0, 163.0, 165.0, 164.0, 164.0, 162.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 77.0, 102.0, 79.0, 77.0, 78.0, 78.0, 108.0, 77.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 108.0, 85.0, 85.0, 85.0, 100.0, 84.0, 85.0, 105.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 113.0, 114.0, 113.0, 115.0, 114.0, 113.0, 112.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 150.0, 149.0, 148.0, 149.0, 148.0, 148.0, 148.0, 149.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 97.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 67.0, 66.0, 67.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 89.0, 88.0, 87.0, 88.0, 88.0, 90.0, 87.0, 87.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 139.0, 137.0, 134.0, 137.0, 146.0, 137.0, 146.0, 189.0, 139.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 188.0, 188.0, 192.0, 184.0, 193.0, 192.0, 194.0, 184.0, 188.0], "value": 189.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 70.0, 84.0, 70.0, 69.0, 70.0, 72.0, 73.0, 73.0], "value": 73.4, "unit": "score"}]}]} 15:49:34 INFO - Return code: 0 15:49:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:49:34 ERROR - # TBPL SUCCESS # 15:49:34 INFO - Running post-action listener: _resource_record_post_action 15:49:34 INFO - [mozharness: 2017-02-22 23:49:34.717497Z] Finished run-tests step (success) 15:49:34 INFO - Running post-run listener: _resource_record_post_run 15:49:34 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 367681536; Read time: 16; Write time: 228356 15:49:34 INFO - TinderboxPrint: CPU usage
13.1% 15:49:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 15:49:34 INFO - TinderboxPrint: I/O write bytes / time
367,681,536 / 228,356 15:49:34 INFO - TinderboxPrint: CPU idle
8,341.0 (86.9%) 15:49:34 INFO - TinderboxPrint: CPU user
1,215.4 (12.7%) 15:49:34 INFO - TinderboxPrint: Swap in / out
0 / 0 15:49:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 112398336; Read time: 0; Write time: 98796 15:49:34 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 255283200; Read time: 16; Write time: 129560 15:49:35 INFO - Running post-run listener: _upload_blobber_files 15:49:35 INFO - Blob upload gear active. 15:49:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:49:35 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 15:49:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:49:35 INFO - (blobuploader) - INFO - Open directory for files ... 15:49:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:49:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:49:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:49:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:49:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:49:36 INFO - (blobuploader) - INFO - Done attempting. 15:49:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:49:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:49:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:49:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:49:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:49:37 INFO - (blobuploader) - INFO - Done attempting. 15:49:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:49:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:49:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:49:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:49:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:49:38 INFO - (blobuploader) - INFO - Done attempting. 15:49:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:49:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:49:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:49:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:49:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:49:41 INFO - (blobuploader) - INFO - Done attempting. 15:49:41 INFO - (blobuploader) - INFO - Iteration through files over. 15:49:41 INFO - Return code: 0 15:49:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:49:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:49:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/47df0e27552e4b126b8de7a2f70ee5049fc7f72fcc7072e82db4eedc3e95d4123a64f1b4a4fa44039fe52fd0060dda2ce5c1099bdd8f6ee9c6af727822339be2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ae38cf203888e52e2c667bb00d47057a0dff7e8e3d9a9a19b1e45140208b6532306684a9bade1206c5afa75be3796168dda53c6e031ab180dc406f9c0499f731", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6adf2c9a6f34974c89e713fd99c63dd4716a42a6c18f630a324ebd05bef1bceb076a257d9e8b36e2a6b34d29b7590f442751393383858835efc2a387c0631f9b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/26d988562b41418863fc78a5df316e7215dcbfa7d3b2b7d2450c0721a15653eb7e84a0094db8cf16e61885b66e4f2a25a8e3286a806663d7e756101d40f5f1a9"} 15:49:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:49:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:49:41 INFO - Contents: 15:49:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/47df0e27552e4b126b8de7a2f70ee5049fc7f72fcc7072e82db4eedc3e95d4123a64f1b4a4fa44039fe52fd0060dda2ce5c1099bdd8f6ee9c6af727822339be2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ae38cf203888e52e2c667bb00d47057a0dff7e8e3d9a9a19b1e45140208b6532306684a9bade1206c5afa75be3796168dda53c6e031ab180dc406f9c0499f731", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6adf2c9a6f34974c89e713fd99c63dd4716a42a6c18f630a324ebd05bef1bceb076a257d9e8b36e2a6b34d29b7590f442751393383858835efc2a387c0631f9b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/26d988562b41418863fc78a5df316e7215dcbfa7d3b2b7d2450c0721a15653eb7e84a0094db8cf16e61885b66e4f2a25a8e3286a806663d7e756101d40f5f1a9"} 15:49:41 INFO - Running post-run listener: copy_logs_to_upload_dir 15:49:41 INFO - Copying logs to upload dir... 15:49:41 INFO - mkdir: /builds/slave/test/build/upload/logs 15:49:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.647529 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-22 15:49:41.343986) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 15:49:41.347586) ========= 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=337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/47df0e27552e4b126b8de7a2f70ee5049fc7f72fcc7072e82db4eedc3e95d4123a64f1b4a4fa44039fe52fd0060dda2ce5c1099bdd8f6ee9c6af727822339be2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ae38cf203888e52e2c667bb00d47057a0dff7e8e3d9a9a19b1e45140208b6532306684a9bade1206c5afa75be3796168dda53c6e031ab180dc406f9c0499f731", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6adf2c9a6f34974c89e713fd99c63dd4716a42a6c18f630a324ebd05bef1bceb076a257d9e8b36e2a6b34d29b7590f442751393383858835efc2a387c0631f9b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/26d988562b41418863fc78a5df316e7215dcbfa7d3b2b7d2450c0721a15653eb7e84a0094db8cf16e61885b66e4f2a25a8e3286a806663d7e756101d40f5f1a9"} build_url:https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/MXrDdCsmRqSDuUYHfL6ADQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/47df0e27552e4b126b8de7a2f70ee5049fc7f72fcc7072e82db4eedc3e95d4123a64f1b4a4fa44039fe52fd0060dda2ce5c1099bdd8f6ee9c6af727822339be2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ae38cf203888e52e2c667bb00d47057a0dff7e8e3d9a9a19b1e45140208b6532306684a9bade1206c5afa75be3796168dda53c6e031ab180dc406f9c0499f731", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6adf2c9a6f34974c89e713fd99c63dd4716a42a6c18f630a324ebd05bef1bceb076a257d9e8b36e2a6b34d29b7590f442751393383858835efc2a387c0631f9b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/26d988562b41418863fc78a5df316e7215dcbfa7d3b2b7d2450c0721a15653eb7e84a0094db8cf16e61885b66e4f2a25a8e3286a806663d7e756101d40f5f1a9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 15:49:41.372218) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 15:49:41.372533) ========= 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=337fe3f4b1febe37b85fccc40000019e-1487806118.396724-1116370463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004404 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 15:49:41.457845) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 15:49:41.458157) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 15:49:41.458448) ========= ========= Total master_lag: 0.17 =========