builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-004 starttime: 1489165926.06 results: success (0) revision: edd424223fb1c336294a0cc1ca0e31cbec79ec31 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 09:12:06.060866) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 09:12:06.061359) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 09:12:06.061637) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 09:12:06.080039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 09:12:06.080450) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-10 09:12:06-- 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% 109M=0s 2017-03-10 09:12:06 (109 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126887 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 09:12:06.224531) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 09:12:06.224932) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018892 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 09:12:06.274245) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-10 09:12:06.274595) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev edd424223fb1c336294a0cc1ca0e31cbec79ec31 --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 edd424223fb1c336294a0cc1ca0e31cbec79ec31 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-10 09:12:06,620 truncating revision to first 12 chars 2017-03-10 09:12:06,620 Setting DEBUG logging. 2017-03-10 09:12:06,620 attempt 1/10 2017-03-10 09:12:06,620 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/edd424223fb1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-10 09:12:07,186 unpacking tar archive at: mozilla-central-edd424223fb1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.900948 ========= master_lag: 0.76 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-10 09:12:07.937504) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 09:12:07.937889) ========= script_repo_revision: edd424223fb1c336294a0cc1ca0e31cbec79ec31 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 09:12:07.944340) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 09:12:07.944756) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 09:12:08.213638) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-03-10 09:12:08.214031) ========= /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=c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:12:08 INFO - MultiFileLogger online at 20170310 09:12:08 in /builds/slave/test 09:12:08 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 09:12:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:12:08 INFO - {'append_to_log': False, 09:12:08 INFO - 'base_work_dir': '/builds/slave/test', 09:12:08 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:12:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:12:08 INFO - 'branch': 'Firefox-Non-PGO', 09:12:08 INFO - 'buildbot_json_path': 'buildprops.json', 09:12:08 INFO - 'config_files': ('talos/linux_config.py',), 09:12:08 INFO - 'default_actions': ('clobber', 09:12:08 INFO - 'read-buildbot-config', 09:12:08 INFO - 'download-and-extract', 09:12:08 INFO - 'populate-webroot', 09:12:08 INFO - 'create-virtualenv', 09:12:08 INFO - 'install', 09:12:08 INFO - 'run-tests'), 09:12:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:12:08 INFO - 'download_minidump_stackwalk': True, 09:12:08 INFO - 'download_symbols': 'ondemand', 09:12:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:12:08 INFO - 'tooltool.py': '/tools/tooltool.py', 09:12:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:12:08 INFO - '/tools/misc-python/virtualenv.py')}, 09:12:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:12:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:12:08 INFO - 'gecko_profile': False, 09:12:08 INFO - 'gecko_profile_interval': 0, 09:12:08 INFO - 'installer_path': 'installer.exe', 09:12:08 INFO - 'log_level': 'info', 09:12:08 INFO - 'log_name': 'talos', 09:12:08 INFO - 'log_to_console': True, 09:12:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:12:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:12:08 INFO - 'opt_config_files': (), 09:12:08 INFO - 'pip_index': False, 09:12:08 INFO - 'suite': 'dromaeojs', 09:12:08 INFO - 'system_bits': '32', 09:12:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:12:08 INFO - 'title': 'talos-linux64-ix-004', 09:12:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:12:08 INFO - 'use_talos_json': True, 09:12:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:12:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:12:08 INFO - 'work_dir': 'build'} 09:12:08 INFO - [mozharness: 2017-03-10 17:12:08.664341Z] Running clobber step. 09:12:08 INFO - Running pre-action listener: _resource_record_pre_action 09:12:08 INFO - Running main action method: clobber 09:12:08 INFO - rmtree: /builds/slave/test/build 09:12:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:12:10 INFO - Running post-action listener: _resource_record_post_action 09:12:10 INFO - [mozharness: 2017-03-10 17:12:10.112881Z] Finished clobber step (success) 09:12:10 INFO - [mozharness: 2017-03-10 17:12:10.112977Z] Running read-buildbot-config step. 09:12:10 INFO - Running pre-action listener: _resource_record_pre_action 09:12:10 INFO - Running main action method: read_buildbot_config 09:12:10 INFO - Using buildbot properties: 09:12:10 INFO - { 09:12:10 INFO - "project": "", 09:12:10 INFO - "product": "firefox", 09:12:10 INFO - "who": "ryanvm@gmail.com", 09:12:10 INFO - "installer_path": "public/build/target.tar.bz2", 09:12:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:12:10 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:12:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 09:12:10 INFO - "stage_platform": "linux64", 09:12:10 INFO - "basedir": "/builds/slave/test", 09:12:10 INFO - "buildnumber": 1018, 09:12:10 INFO - "platform": "ubuntu64_hw", 09:12:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:12:10 INFO - "slavebuilddir": "test", 09:12:10 INFO - "taskId": "WbbNObe5TYycdjQkHiddLg", 09:12:10 INFO - "branch": "mozilla-central", 09:12:10 INFO - "script_repo_revision": "production", 09:12:10 INFO - "revision": "edd424223fb1c336294a0cc1ca0e31cbec79ec31", 09:12:10 INFO - "slavename": "talos-linux64-ix-004", 09:12:10 INFO - "repo_path": "mozilla-central" 09:12:10 INFO - } 09:12:10 INFO - Finding installer, test and symbols from parent task. 09:12:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WbbNObe5TYycdjQkHiddLg'}, attempt #1 09:12:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WbbNObe5TYycdjQkHiddLg'}, attempt #1 09:12:11 INFO - Task dependencies: TJxhn-LhQMeWSYhYCNiPlQ 09:12:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TJxhn-LhQMeWSYhYCNiPlQ'}, attempt #1 09:12:11 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/target.tar.bz2 09:12:11 INFO - Set test_url: https://queue.taskcluster.net/v1/task/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/test_packages.json 09:12:11 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/target.crashreporter-symbols.zip 09:12:11 INFO - Running post-action listener: _resource_record_post_action 09:12:11 INFO - [mozharness: 2017-03-10 17:12:11.982936Z] Finished read-buildbot-config step (success) 09:12:11 INFO - [mozharness: 2017-03-10 17:12:11.983152Z] Running download-and-extract step. 09:12:11 INFO - Running pre-action listener: _resource_record_pre_action 09:12:11 INFO - Running main action method: download_and_extract 09:12:11 INFO - mkdir: /builds/slave/test/build/tests 09:12: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')]} 09:12:11 INFO - trying https://queue.taskcluster.net/v1/task/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/target.test_packages.json 09:12:11 INFO - Downloading https://queue.taskcluster.net/v1/task/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:12:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:12:12 INFO - Downloaded 896 bytes. 09:12:12 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:12:12 INFO - Using the following test package requirements: 09:12:12 INFO - {u'common': [u'target.common.tests.zip'], 09:12:12 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:12:12 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:12:12 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:12:12 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:12:12 INFO - u'mozbase': [u'target.common.tests.zip'], 09:12:12 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:12:12 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:12:12 INFO - u'web-platform': [u'target.common.tests.zip', 09:12:12 INFO - u'target.web-platform.tests.zip'], 09:12:12 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:12:12 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:12:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/target.common.tests.zip 09:12:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:12:12 INFO - Fetch https://queue.taskcluster.net/v1/task/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/target.common.tests.zip into memory 09:12:13 INFO - Expected file size: 57498831 09:12:13 INFO - Obtained file size: 57498831 09:12:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:12:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/target.common.tests.zip 09:12:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:12:23 INFO - Fetch https://queue.taskcluster.net/v1/task/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/target.common.tests.zip into memory 09:12:24 INFO - Expected file size: 57498831 09:12:24 INFO - Obtained file size: 57498831 09:12:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/target.talos.tests.zip 09:12:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:12:34 INFO - Fetch https://queue.taskcluster.net/v1/task/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/target.talos.tests.zip into memory 09:12:35 INFO - Expected file size: 14404424 09:12:35 INFO - Obtained file size: 14404424 09:12:35 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')]} 09:12:35 INFO - trying https://queue.taskcluster.net/v1/task/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/target.tar.bz2 09:12:35 INFO - Downloading https://queue.taskcluster.net/v1/task/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:12:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:12:36 INFO - Downloaded 61519856 bytes. 09:12:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/target.tar.bz2 09:12:36 INFO - mkdir: /builds/slave/test/properties 09:12:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:12:36 INFO - Writing to file /builds/slave/test/properties/build_url 09:12:36 INFO - Contents: 09:12:36 INFO - build_url:https://queue.taskcluster.net/v1/task/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/target.tar.bz2 09:12:36 INFO - Running post-action listener: _resource_record_post_action 09:12:36 INFO - Running post-action listener: set_extra_try_arguments 09:12:36 INFO - [mozharness: 2017-03-10 17:12:36.918287Z] Finished download-and-extract step (success) 09:12:36 INFO - [mozharness: 2017-03-10 17:12:36.918383Z] Running populate-webroot step. 09:12:36 INFO - Running pre-action listener: _resource_record_pre_action 09:12:36 INFO - Running main action method: populate_webroot 09:12:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:12:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:12:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:12:36 INFO - '--tppagecycles', 09:12:36 INFO - '7'], 09:12:36 INFO - 'tests': ['tsvgm']}}, 09:12:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:12:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:12:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:12:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:12:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:12:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:12:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:12:36 INFO - 'talos_options': ['--disable-e10s'], 09:12:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:12:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:12:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:12:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:12:36 INFO - 'talos_options': ['--disable-e10s'], 09:12:36 INFO - 'tests': ['damp', 'tps']}, 09:12:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:12:36 INFO - 'tests': ['damp', 'tps']}, 09:12:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:12:36 INFO - 'tests': ['dromaeo_dom']}, 09:12:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:12:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:12:36 INFO - 'tests': ['basic_compositor_video']}, 09:12:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:12:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:12:36 INFO - 'tests': ['a11yr', 09:12:36 INFO - 'ts_paint', 09:12:36 INFO - 'tpaint', 09:12:36 INFO - 'sessionrestore', 09:12:36 INFO - 'sessionrestore_no_auto_restore', 09:12:36 INFO - 'tabpaint']}, 09:12:36 INFO - 'other-e10s': {'tests': ['a11yr', 09:12:36 INFO - 'ts_paint', 09:12:36 INFO - 'tpaint', 09:12:36 INFO - 'sessionrestore', 09:12:36 INFO - 'sessionrestore_no_auto_restore', 09:12:36 INFO - 'tabpaint']}, 09:12:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:12:36 INFO - 'ts_paint', 09:12:36 INFO - 'tpaint', 09:12:36 INFO - 'sessionrestore', 09:12:36 INFO - 'sessionrestore_no_auto_restore', 09:12:36 INFO - 'tabpaint']}, 09:12:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:12:36 INFO - 'ts_paint', 09:12:36 INFO - 'tpaint', 09:12:36 INFO - 'sessionrestore', 09:12:36 INFO - 'sessionrestore_no_auto_restore', 09:12:36 INFO - 'tabpaint']}, 09:12:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:12:36 INFO - 'tests': ['a11yr', 09:12:36 INFO - 'ts_paint', 09:12:36 INFO - 'tpaint', 09:12:36 INFO - 'sessionrestore', 09:12:36 INFO - 'sessionrestore_no_auto_restore', 09:12:36 INFO - 'tabpaint']}, 09:12:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:12:36 INFO - 'tests': ['a11yr', 09:12:36 INFO - 'ts_paint', 09:12:36 INFO - 'tpaint', 09:12:36 INFO - 'sessionrestore', 09:12:36 INFO - 'sessionrestore_no_auto_restore', 09:12:36 INFO - 'tabpaint']}, 09:12:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:12:36 INFO - 'tests': ['tsvgx', 09:12:36 INFO - 'tsvgr_opacity', 09:12:36 INFO - 'tart', 09:12:36 INFO - 'tscrollx', 09:12:36 INFO - 'cart', 09:12:36 INFO - 'tsvg_static']}, 09:12:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:12:36 INFO - 'tsvgr_opacity', 09:12:36 INFO - 'tart', 09:12:36 INFO - 'tscrollx', 09:12:36 INFO - 'cart', 09:12:36 INFO - 'tsvg_static']}, 09:12:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:12:36 INFO - 'talos_options': ['--disable-e10s'], 09:12:36 INFO - 'tests': ['tp5o']}, 09:12:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:12:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:12:36 INFO - 'talos_options': ['--disable-e10s', 09:12:36 INFO - '--xperf_path', 09:12:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:12:36 INFO - 'tests': ['tp5n']}, 09:12:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:12:36 INFO - 'talos_options': ['--xperf_path', 09:12:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:12:36 INFO - 'tests': ['tp5n']}}, 09:12:36 INFO - 'talos.zip': {'path': '', 09:12:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:12:36 INFO - Running post-action listener: _resource_record_post_action 09:12:36 INFO - [mozharness: 2017-03-10 17:12:36.931464Z] Finished populate-webroot step (success) 09:12:36 INFO - [mozharness: 2017-03-10 17:12:36.931557Z] Running create-virtualenv step. 09:12:36 INFO - Running pre-action listener: _resource_record_pre_action 09:12:36 INFO - Running main action method: create_virtualenv 09:12:36 INFO - Creating virtualenv /builds/slave/test/build/venv 09:12:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:12:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:12:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:12:37 INFO - Using real prefix '/usr' 09:12:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:12:37 INFO - Installing distribute.............................................................................................................................................................................................done. 09:12:39 INFO - Installing pip.................done. 09:12:39 INFO - Return code: 0 09:12:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:12:39 INFO - Reading from file tmpfile_stdout 09:12:39 INFO - Output received: 09:12:39 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:12:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:12:39 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')]} 09:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:39 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')]} 09:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:39 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 0x29301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcdb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb290>, '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 0x2bcbb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcc040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:12:39 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 09:12:39 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 09:12:39 INFO - Using env: {'DISPLAY': ':0', 09:12:39 INFO - 'HOME': '/home/cltbld', 09:12:39 INFO - 'LANG': 'en_US.UTF-8', 09:12:39 INFO - 'LANGUAGE': 'en_US:en', 09:12:39 INFO - 'LOGNAME': 'cltbld', 09:12:39 INFO - 'MAIL': '/var/mail/cltbld', 09:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:39 INFO - 'MOZ_NO_REMOTE': '1', 09:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:39 INFO - 'NO_EM_RESTART': '1', 09:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:39 INFO - 'PWD': '/builds/slave/test', 09:12:39 INFO - 'SHELL': '/bin/bash', 09:12:39 INFO - 'SHLVL': '1', 09:12:39 INFO - 'TERM': 'linux', 09:12:39 INFO - 'TMOUT': '86400', 09:12:39 INFO - 'USER': 'cltbld', 09:12:39 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783', 09:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:39 INFO - '_': '/tools/buildbot/bin/python'} 09:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:12:39 INFO - Cleaning up... 09:12:39 INFO - Return code: 0 09:12:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:12:39 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')]} 09:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:39 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')]} 09:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:39 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 0x29301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcdb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb290>, '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 0x2bcbb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcc040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:12:39 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 09:12:39 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 09:12:39 INFO - Using env: {'DISPLAY': ':0', 09:12:39 INFO - 'HOME': '/home/cltbld', 09:12:39 INFO - 'LANG': 'en_US.UTF-8', 09:12:39 INFO - 'LANGUAGE': 'en_US:en', 09:12:39 INFO - 'LOGNAME': 'cltbld', 09:12:39 INFO - 'MAIL': '/var/mail/cltbld', 09:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:39 INFO - 'MOZ_NO_REMOTE': '1', 09:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:39 INFO - 'NO_EM_RESTART': '1', 09:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:39 INFO - 'PWD': '/builds/slave/test', 09:12:39 INFO - 'SHELL': '/bin/bash', 09:12:39 INFO - 'SHLVL': '1', 09:12:39 INFO - 'TERM': 'linux', 09:12:39 INFO - 'TMOUT': '86400', 09:12:39 INFO - 'USER': 'cltbld', 09:12:39 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783', 09:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:39 INFO - '_': '/tools/buildbot/bin/python'} 09:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:40 INFO - Downloading/unpacking psutil>=3.1.1 09:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:40 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 09:12:40 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 09:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:12:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:12:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:12:42 INFO - Installing collected packages: psutil 09:12:42 INFO - Running setup.py install for psutil 09:12:42 INFO - building 'psutil._psutil_linux' extension 09:12:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:12:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:12:42 INFO - building 'psutil._psutil_posix' extension 09:12:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:12:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:12:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:12:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:12:42 INFO - Successfully installed psutil 09:12:42 INFO - Cleaning up... 09:12:42 INFO - Return code: 0 09:12:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:12:42 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')]} 09:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:42 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')]} 09:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:42 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 0x29301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcdb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb290>, '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 0x2bcbb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcc040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:12:42 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 09:12:42 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 09:12:42 INFO - Using env: {'DISPLAY': ':0', 09:12:42 INFO - 'HOME': '/home/cltbld', 09:12:42 INFO - 'LANG': 'en_US.UTF-8', 09:12:42 INFO - 'LANGUAGE': 'en_US:en', 09:12:42 INFO - 'LOGNAME': 'cltbld', 09:12:42 INFO - 'MAIL': '/var/mail/cltbld', 09:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:42 INFO - 'MOZ_NO_REMOTE': '1', 09:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:42 INFO - 'NO_EM_RESTART': '1', 09:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:42 INFO - 'PWD': '/builds/slave/test', 09:12:42 INFO - 'SHELL': '/bin/bash', 09:12:42 INFO - 'SHLVL': '1', 09:12:42 INFO - 'TERM': 'linux', 09:12:42 INFO - 'TMOUT': '86400', 09:12:42 INFO - 'USER': 'cltbld', 09:12:42 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783', 09:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:42 INFO - '_': '/tools/buildbot/bin/python'} 09:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:43 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 09:12:43 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 09:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:12:45 INFO - Installing collected packages: mozsystemmonitor 09:12:45 INFO - Running setup.py install for mozsystemmonitor 09:12:45 INFO - Successfully installed mozsystemmonitor 09:12:45 INFO - Cleaning up... 09:12:45 INFO - Return code: 0 09:12:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:12:45 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')]} 09:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:45 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')]} 09:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:45 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 0x29301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcdb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb290>, '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 0x2bcbb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcc040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:12:45 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 09:12:45 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 09:12:45 INFO - Using env: {'DISPLAY': ':0', 09:12:45 INFO - 'HOME': '/home/cltbld', 09:12:45 INFO - 'LANG': 'en_US.UTF-8', 09:12:45 INFO - 'LANGUAGE': 'en_US:en', 09:12:45 INFO - 'LOGNAME': 'cltbld', 09:12:45 INFO - 'MAIL': '/var/mail/cltbld', 09:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:45 INFO - 'MOZ_NO_REMOTE': '1', 09:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:45 INFO - 'NO_EM_RESTART': '1', 09:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:45 INFO - 'PWD': '/builds/slave/test', 09:12:45 INFO - 'SHELL': '/bin/bash', 09:12:45 INFO - 'SHLVL': '1', 09:12:45 INFO - 'TERM': 'linux', 09:12:45 INFO - 'TMOUT': '86400', 09:12:45 INFO - 'USER': 'cltbld', 09:12:45 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783', 09:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:45 INFO - '_': '/tools/buildbot/bin/python'} 09:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:45 INFO - Downloading/unpacking jsonschema==2.5.1 09:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:45 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 09:12:45 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 09:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:12:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:47 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 09:12:47 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 09:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:47 INFO - Downloading functools32-3.2.3-2.tar.gz 09:12:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:12:47 INFO - warning: no files found matching '*.txt' 09:12:47 INFO - no previously-included directories found matching 'build' 09:12:47 INFO - no previously-included directories found matching 'dist' 09:12:47 INFO - no previously-included directories found matching '.git*' 09:12:47 INFO - Installing collected packages: jsonschema, functools32 09:12:47 INFO - Running setup.py install for functools32 09:12:47 INFO - warning: no files found matching '*.txt' 09:12:47 INFO - no previously-included directories found matching 'build' 09:12:47 INFO - no previously-included directories found matching 'dist' 09:12:47 INFO - no previously-included directories found matching '.git*' 09:12:47 INFO - Successfully installed jsonschema functools32 09:12:47 INFO - Cleaning up... 09:12:48 INFO - Return code: 0 09:12:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:12:48 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')]} 09:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:48 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')]} 09:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:48 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 0x29301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcdb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb290>, '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 0x2bcbb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcc040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:12:48 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 09:12:48 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 09:12:48 INFO - Using env: {'DISPLAY': ':0', 09:12:48 INFO - 'HOME': '/home/cltbld', 09:12:48 INFO - 'LANG': 'en_US.UTF-8', 09:12:48 INFO - 'LANGUAGE': 'en_US:en', 09:12:48 INFO - 'LOGNAME': 'cltbld', 09:12:48 INFO - 'MAIL': '/var/mail/cltbld', 09:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:48 INFO - 'MOZ_NO_REMOTE': '1', 09:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:48 INFO - 'NO_EM_RESTART': '1', 09:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:48 INFO - 'PWD': '/builds/slave/test', 09:12:48 INFO - 'SHELL': '/bin/bash', 09:12:48 INFO - 'SHLVL': '1', 09:12:48 INFO - 'TERM': 'linux', 09:12:48 INFO - 'TMOUT': '86400', 09:12:48 INFO - 'USER': 'cltbld', 09:12:48 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783', 09:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:48 INFO - '_': '/tools/buildbot/bin/python'} 09:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:12:48 INFO - Cleaning up... 09:12:48 INFO - Return code: 0 09:12:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:12:48 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')]} 09:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:48 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')]} 09:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:48 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 0x29301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcdb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb290>, '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 0x2bcbb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcc040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:12:48 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 09:12:48 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 09:12:48 INFO - Using env: {'DISPLAY': ':0', 09:12:48 INFO - 'HOME': '/home/cltbld', 09:12:48 INFO - 'LANG': 'en_US.UTF-8', 09:12:48 INFO - 'LANGUAGE': 'en_US:en', 09:12:48 INFO - 'LOGNAME': 'cltbld', 09:12:48 INFO - 'MAIL': '/var/mail/cltbld', 09:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:48 INFO - 'MOZ_NO_REMOTE': '1', 09:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:48 INFO - 'NO_EM_RESTART': '1', 09:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:48 INFO - 'PWD': '/builds/slave/test', 09:12:48 INFO - 'SHELL': '/bin/bash', 09:12:48 INFO - 'SHLVL': '1', 09:12:48 INFO - 'TERM': 'linux', 09:12:48 INFO - 'TMOUT': '86400', 09:12:48 INFO - 'USER': 'cltbld', 09:12:48 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783', 09:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:48 INFO - '_': '/tools/buildbot/bin/python'} 09:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:48 INFO - Downloading/unpacking blobuploader==1.2.4 09:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:48 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 09:12:48 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 09:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:50 INFO - Downloading blobuploader-1.2.4.tar.gz 09:12:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:12:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:50 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 09:12:50 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 09:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:12:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:51 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 09:12:51 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 09:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:51 INFO - Downloading docopt-0.6.1.tar.gz 09:12:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:12:51 INFO - Installing collected packages: blobuploader, requests, docopt 09:12:51 INFO - Running setup.py install for blobuploader 09:12:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:12:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:12:51 INFO - Running setup.py install for requests 09:12:51 INFO - Running setup.py install for docopt 09:12:51 INFO - Successfully installed blobuploader requests docopt 09:12:51 INFO - Cleaning up... 09:12:52 INFO - Return code: 0 09:12:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12:52 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')]} 09:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:52 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')]} 09:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:52 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 0x29301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcdb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb290>, '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 0x2bcbb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcc040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:12:52 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 09:12:52 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 09:12:52 INFO - Using env: {'DISPLAY': ':0', 09:12:52 INFO - 'HOME': '/home/cltbld', 09:12:52 INFO - 'LANG': 'en_US.UTF-8', 09:12:52 INFO - 'LANGUAGE': 'en_US:en', 09:12:52 INFO - 'LOGNAME': 'cltbld', 09:12:52 INFO - 'MAIL': '/var/mail/cltbld', 09:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:52 INFO - 'MOZ_NO_REMOTE': '1', 09:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:52 INFO - 'NO_EM_RESTART': '1', 09:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:52 INFO - 'PWD': '/builds/slave/test', 09:12:52 INFO - 'SHELL': '/bin/bash', 09:12:52 INFO - 'SHLVL': '1', 09:12:52 INFO - 'TERM': 'linux', 09:12:52 INFO - 'TMOUT': '86400', 09:12:52 INFO - 'USER': 'cltbld', 09:12:52 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783', 09:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:52 INFO - '_': '/tools/buildbot/bin/python'} 09:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:12:52 INFO - Running setup.py (path:/tmp/pip-KMVXf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:12:52 INFO - Running setup.py (path:/tmp/pip-TRs9Kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:12:52 INFO - Running setup.py (path:/tmp/pip-lzmVxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:12:52 INFO - Running setup.py (path:/tmp/pip-31ObK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:12:52 INFO - Running setup.py (path:/tmp/pip-Oh3hVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:12:52 INFO - Running setup.py (path:/tmp/pip-FVrXC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:12:52 INFO - Running setup.py (path:/tmp/pip-ouvEvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:12:52 INFO - Running setup.py (path:/tmp/pip-Qv7FCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:12:52 INFO - Running setup.py (path:/tmp/pip-vqjQvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:12:52 INFO - Running setup.py (path:/tmp/pip-nbzCD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:12:52 INFO - Running setup.py (path:/tmp/pip-I1UuEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:12:53 INFO - Running setup.py (path:/tmp/pip-0tjTiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:12:53 INFO - Running setup.py (path:/tmp/pip-HCJW9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:12:53 INFO - Running setup.py (path:/tmp/pip-gVsGE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:53 INFO - Running setup.py (path:/tmp/pip-tAgvv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:12:53 INFO - Running setup.py (path:/tmp/pip-UAVcsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:12:53 INFO - Running setup.py (path:/tmp/pip-_Y3uNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:12:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:12:53 INFO - Running setup.py install for manifestparser 09:12:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:12:53 INFO - Running setup.py install for mozcrash 09:12:53 INFO - Running setup.py install for mozdebug 09:12:53 INFO - Running setup.py install for mozdevice 09:12:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:12:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:12:53 INFO - Running setup.py install for mozfile 09:12:54 INFO - Running setup.py install for mozhttpd 09:12:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:12:54 INFO - Running setup.py install for mozinfo 09:12:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:12:54 INFO - Running setup.py install for mozInstall 09:12:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:12:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:12:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:12:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:12:54 INFO - Running setup.py install for mozleak 09:12:54 INFO - Running setup.py install for mozlog 09:12:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:12:54 INFO - Running setup.py install for moznetwork 09:12:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:12:54 INFO - Running setup.py install for mozprocess 09:12:54 INFO - Running setup.py install for mozprofile 09:12:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:12:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:12:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:12:54 INFO - Running setup.py install for mozrunner 09:12:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:12:54 INFO - Running setup.py install for mozscreenshot 09:12:55 INFO - Running setup.py install for moztest 09:12:55 INFO - Running setup.py install for mozversion 09:12:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:12:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:12:55 INFO - Cleaning up... 09:12:55 INFO - Return code: 0 09:12:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12:55 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')]} 09:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:55 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')]} 09:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:55 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 0x29301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcdb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb290>, '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 0x2bcbb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcc040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:12:55 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 09:12:55 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 09:12:55 INFO - Using env: {'DISPLAY': ':0', 09:12:55 INFO - 'HOME': '/home/cltbld', 09:12:55 INFO - 'LANG': 'en_US.UTF-8', 09:12:55 INFO - 'LANGUAGE': 'en_US:en', 09:12:55 INFO - 'LOGNAME': 'cltbld', 09:12:55 INFO - 'MAIL': '/var/mail/cltbld', 09:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:55 INFO - 'MOZ_NO_REMOTE': '1', 09:12:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:55 INFO - 'NO_EM_RESTART': '1', 09:12:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:55 INFO - 'PWD': '/builds/slave/test', 09:12:55 INFO - 'SHELL': '/bin/bash', 09:12:55 INFO - 'SHLVL': '1', 09:12:55 INFO - 'TERM': 'linux', 09:12:55 INFO - 'TMOUT': '86400', 09:12:55 INFO - 'USER': 'cltbld', 09:12:55 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783', 09:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:55 INFO - '_': '/tools/buildbot/bin/python'} 09:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:12:55 INFO - Running setup.py (path:/tmp/pip-AXu0ME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:12:55 INFO - Running setup.py (path:/tmp/pip-AroGBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:12:55 INFO - Running setup.py (path:/tmp/pip-Vyv9sK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:12:55 INFO - Running setup.py (path:/tmp/pip-qKgsY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:12:55 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)) 09:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:12:55 INFO - Running setup.py (path:/tmp/pip-griDj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:12:55 INFO - Running setup.py (path:/tmp/pip-G8u5c2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:12:55 INFO - Running setup.py (path:/tmp/pip-6738V_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:12:56 INFO - Running setup.py (path:/tmp/pip-Njhfyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:12:56 INFO - Running setup.py (path:/tmp/pip-6ef0fb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:12:56 INFO - Running setup.py (path:/tmp/pip-Q6CcTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:12:56 INFO - Running setup.py (path:/tmp/pip-3IZRBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:12:56 INFO - Running setup.py (path:/tmp/pip-Ev0xLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:12:56 INFO - Running setup.py (path:/tmp/pip-5USpOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:12:56 INFO - Running setup.py (path:/tmp/pip-NYRsMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:56 INFO - Running setup.py (path:/tmp/pip-FTPV5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:12:56 INFO - Running setup.py (path:/tmp/pip-7SLene-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:12:56 INFO - Running setup.py (path:/tmp/pip-3fsq86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:12:56 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)) 09:12:56 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)) 09:12:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:56 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 09:12:56 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 09:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:58 INFO - Downloading blessings-1.6.tar.gz 09:12:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:12:58 INFO - Installing collected packages: blessings 09:12:58 INFO - Running setup.py install for blessings 09:12:58 INFO - Successfully installed blessings 09:12:58 INFO - Cleaning up... 09:12:59 INFO - Return code: 0 09:12:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:12:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:12:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:12:59 INFO - Reading from file tmpfile_stdout 09:12:59 INFO - Current package versions: 09:12:59 INFO - argparse == 1.2.1 09:12:59 INFO - blessings == 1.6 09:12:59 INFO - blobuploader == 1.2.4 09:12:59 INFO - docopt == 0.6.1 09:12:59 INFO - functools32 == 3.2.3-2 09:12:59 INFO - jsonschema == 2.5.1 09:12:59 INFO - manifestparser == 1.1 09:12:59 INFO - mozInstall == 1.12 09:12:59 INFO - mozcrash == 1.0 09:12:59 INFO - mozdebug == 0.1 09:12:59 INFO - mozdevice == 0.49 09:12:59 INFO - mozfile == 1.2 09:12:59 INFO - mozhttpd == 0.7 09:12:59 INFO - mozinfo == 0.9 09:12:59 INFO - mozleak == 0.1 09:12:59 INFO - mozlog == 3.4 09:12:59 INFO - moznetwork == 0.27 09:12:59 INFO - mozprocess == 0.25 09:12:59 INFO - mozprofile == 0.28 09:12:59 INFO - mozrunner == 6.13 09:12:59 INFO - mozscreenshot == 0.1 09:12:59 INFO - mozsystemmonitor == 0.3 09:12:59 INFO - moztest == 0.8 09:12:59 INFO - mozversion == 1.4 09:12:59 INFO - psutil == 3.1.1 09:12:59 INFO - requests == 1.2.3 09:12:59 INFO - wsgiref == 0.1.2 09:12:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12:59 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')]} 09:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:59 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')]} 09:12:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:59 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 0x29301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcdb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb290>, '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 0x2bcbb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcc040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:12:59 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 09:12:59 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 09:12:59 INFO - Using env: {'DISPLAY': ':0', 09:12:59 INFO - 'HOME': '/home/cltbld', 09:12:59 INFO - 'LANG': 'en_US.UTF-8', 09:12:59 INFO - 'LANGUAGE': 'en_US:en', 09:12:59 INFO - 'LOGNAME': 'cltbld', 09:12:59 INFO - 'MAIL': '/var/mail/cltbld', 09:12:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:59 INFO - 'MOZ_NO_REMOTE': '1', 09:12:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:59 INFO - 'NO_EM_RESTART': '1', 09:12:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:59 INFO - 'PWD': '/builds/slave/test', 09:12:59 INFO - 'SHELL': '/bin/bash', 09:12:59 INFO - 'SHLVL': '1', 09:12:59 INFO - 'TERM': 'linux', 09:12:59 INFO - 'TMOUT': '86400', 09:12:59 INFO - 'USER': 'cltbld', 09:12:59 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783', 09:12:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:59 INFO - '_': '/tools/buildbot/bin/python'} 09:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:12:59 INFO - Cleaning up... 09:12:59 INFO - Return code: 0 09:12:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:12:59 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')]} 09:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:59 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')]} 09:12:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x29301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcdb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb290>, '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 0x2bcbb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcc040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:12:59 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 09:12:59 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 09:12:59 INFO - Using env: {'DISPLAY': ':0', 09:12:59 INFO - 'HOME': '/home/cltbld', 09:12:59 INFO - 'LANG': 'en_US.UTF-8', 09:12:59 INFO - 'LANGUAGE': 'en_US:en', 09:12:59 INFO - 'LOGNAME': 'cltbld', 09:12:59 INFO - 'MAIL': '/var/mail/cltbld', 09:12:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:59 INFO - 'MOZ_NO_REMOTE': '1', 09:12:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:59 INFO - 'NO_EM_RESTART': '1', 09:12:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:59 INFO - 'PWD': '/builds/slave/test', 09:12:59 INFO - 'SHELL': '/bin/bash', 09:12:59 INFO - 'SHLVL': '1', 09:12:59 INFO - 'TERM': 'linux', 09:12:59 INFO - 'TMOUT': '86400', 09:12:59 INFO - 'USER': 'cltbld', 09:12:59 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783', 09:12:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:59 INFO - '_': '/tools/buildbot/bin/python'} 09:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:12:59 INFO - Cleaning up... 09:12:59 INFO - Return code: 0 09:12:59 INFO - Running post-action listener: _resource_record_post_action 09:12:59 INFO - Running post-action listener: _start_resource_monitoring 09:12:59 INFO - Starting resource monitoring. 09:12:59 INFO - [mozharness: 2017-03-10 17:12:59.716535Z] Finished create-virtualenv step (success) 09:12:59 INFO - [mozharness: 2017-03-10 17:12:59.717055Z] Running install step. 09:12:59 INFO - Running pre-action listener: _resource_record_pre_action 09:12:59 INFO - Running main action method: install 09:12:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:12:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:12:59 INFO - Reading from file tmpfile_stdout 09:12:59 INFO - Detecting whether we're running mozinstall >=1.0... 09:12:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:12:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:13:00 INFO - Reading from file tmpfile_stdout 09:13:00 INFO - Output received: 09:13:00 INFO - Usage: mozinstall [options] installer 09:13:00 INFO - Options: 09:13:00 INFO - -h, --help show this help message and exit 09:13:00 INFO - -d DEST, --destination=DEST 09:13:00 INFO - Directory to install application into. [default: 09:13:00 INFO - "/builds/slave/test"] 09:13:00 INFO - --app=APP Application being installed. [default: firefox] 09:13:00 INFO - mkdir: /builds/slave/test/build/application 09:13:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:13:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:13:15 INFO - Reading from file tmpfile_stdout 09:13:15 INFO - Output received: 09:13:15 INFO - /builds/slave/test/build/application/firefox/firefox 09:13:15 INFO - Running post-action listener: _resource_record_post_action 09:13:15 INFO - [mozharness: 2017-03-10 17:13:15.413751Z] Finished install step (success) 09:13:15 INFO - [mozharness: 2017-03-10 17:13:15.413985Z] Running run-tests step. 09:13:15 INFO - Running pre-action listener: _resource_record_pre_action 09:13:15 INFO - Running main action method: run_tests 09:13:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:13:15 INFO - Python 2.7.3 09:13:15 INFO - Return code: 0 09:13:15 INFO - grabbing minidump binary from tooltool 09:13:15 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')]} 09:13:15 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 0x2bcb290>, '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 0x2bcbb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcc040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:13:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:13:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:13:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:13:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:13:15 INFO - Return code: 0 09:13:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:13:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:13:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:13:15 INFO - ENV: RUST_BACKTRACE is now 1 09:13:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:13:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:13:15 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/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:13:15 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/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:13:15 INFO - Using env: {'DISPLAY': ':0', 09:13:15 INFO - 'HOME': '/home/cltbld', 09:13:15 INFO - 'LANG': 'en_US.UTF-8', 09:13:15 INFO - 'LANGUAGE': 'en_US:en', 09:13:15 INFO - 'LOGNAME': 'cltbld', 09:13:15 INFO - 'MAIL': '/var/mail/cltbld', 09:13:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:13:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:15 INFO - 'MOZ_NO_REMOTE': '1', 09:13:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:13:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:15 INFO - 'NO_EM_RESTART': '1', 09:13:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:15 INFO - 'PWD': '/builds/slave/test', 09:13:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:13:15 INFO - 'RUST_BACKTRACE': '1', 09:13:15 INFO - 'SHELL': '/bin/bash', 09:13:15 INFO - 'SHLVL': '1', 09:13:15 INFO - 'TERM': 'linux', 09:13:15 INFO - 'TMOUT': '86400', 09:13:15 INFO - 'USER': 'cltbld', 09:13:15 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783', 09:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:15 INFO - '_': '/tools/buildbot/bin/python'} 09:13:15 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/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:13:15 INFO - mozversion application_buildid: 20170310164349 09:13:15 INFO - mozversion application_changeset: edd424223fb1c336294a0cc1ca0e31cbec79ec31 09:13:15 INFO - mozversion application_display_name: Nightly 09:13:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:13:15 INFO - mozversion application_name: Firefox 09:13:15 INFO - mozversion application_remotingname: firefox 09:13:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:13:15 INFO - mozversion application_vendor: Mozilla 09:13:15 INFO - mozversion application_version: 55.0a1 09:13:15 INFO - mozversion platform_buildid: 20170310164349 09:13:15 INFO - mozversion platform_changeset: edd424223fb1c336294a0cc1ca0e31cbec79ec31 09:13:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:13:15 INFO - mozversion platform_version: 55.0a1 09:13:15 INFO - using testdate: 1489165995 09:13:15 INFO - actual date: 1489165995 09:13:15 INFO - starting webserver on 'localhost:60208' 09:13:15 INFO - SUITE-START | Running 2 tests 09:13:15 INFO - TEST-START | dromaeo_css 09:13:15 INFO - operating with platform_type : linux_ 09:13:15 INFO - Initialising browser for dromaeo_css test... 09:13:15 INFO - TEST-INFO | started process 28967 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkJP5yF/profile http://localhost:60208/getInfo.html) 09:13:19 INFO - PROCESS | 28967 | __metrics Screen width/height:1600/1200 09:13:19 INFO - PROCESS | 28967 | colorDepth:24 09:13:19 INFO - PROCESS | 28967 | Browser inner width/height: 1024/697 09:13:19 INFO - PROCESS | 28967 | __metrics 09:13:20 INFO - PROCESS | 28967 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:13:20 INFO - PROCESS | 28967 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:13:21 INFO - TEST-INFO | 28967: exit 0 09:13:21 INFO - Browser initialized. 09:13:21 INFO - Running cycle 1/1 for dromaeo_css test... 09:13:21 INFO - TEST-INFO | started process 29058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkJP5yF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:13:34 INFO - PROCESS | 29058 | RSS: Main: 148201472 09:13:34 INFO - PROCESS | 29058 | 09:16:39 INFO - PROCESS | 29058 | Cycle 1(1): loaded http://localhost:60208/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60208/tests/dromaeo/cssquery-ext.html) 09:16:42 INFO - PROCESS | 29058 | RSS: Main: 355680256 09:16:42 INFO - PROCESS | 29058 | 09:18:23 INFO - PROCESS | 29058 | ************************* 09:18:23 INFO - PROCESS | 29058 | A coding exception was thrown and uncaught in a Task. 09:18:23 INFO - PROCESS | 29058 | 09:18:23 ERROR - PROCESS | 29058 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:18:23 INFO - PROCESS | 29058 | Full stack: 09:18:23 INFO - PROCESS | 29058 | ************************* 09:19:45 INFO - PROCESS | 29058 | Cycle 1(1): loaded http://localhost:60208/tests/dromaeo/cssquery-ext.html (next: http://localhost:60208/tests/dromaeo/cssquery-jquery.html) 09:19:45 INFO - PROCESS | 29058 | RSS: Main: 239951872 09:19:45 INFO - PROCESS | 29058 | 09:22:48 INFO - PROCESS | 29058 | Cycle 1(1): loaded http://localhost:60208/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60208/tests/dromaeo/cssquery-mootools.html) 09:22:48 INFO - PROCESS | 29058 | RSS: Main: 178671616 09:22:48 INFO - PROCESS | 29058 | 09:25:51 INFO - PROCESS | 29058 | Cycle 1(1): loaded http://localhost:60208/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60208/tests/dromaeo/cssquery-prototype.html) 09:25:51 INFO - PROCESS | 29058 | RSS: Main: 238477312 09:25:51 INFO - PROCESS | 29058 | 09:28:55 INFO - PROCESS | 29058 | Cycle 1(1): loaded http://localhost:60208/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60208/tests/dromaeo/cssquery-yui.html) 09:28:55 INFO - PROCESS | 29058 | RSS: Main: 187092992 09:28:55 INFO - PROCESS | 29058 | 09:31:58 INFO - PROCESS | 29058 | Cycle 1(1): loaded http://localhost:60208/tests/dromaeo/cssquery-yui.html (next: http://localhost:60208/tests/dromaeo/cssquery-dojo.html) 09:31:59 INFO - PROCESS | 29058 | RSS: Main: 278659072 09:31:59 INFO - PROCESS | 29058 | 09:31:59 INFO - PROCESS | 29058 | __start_tp_report 09:31:59 INFO - PROCESS | 29058 | _x_x_mozilla_page_load 09:31:59 INFO - PROCESS | 29058 | _x_x_mozilla_page_load_details 09:31:59 INFO - PROCESS | 29058 | |i|pagename|runs| 09:31:59 INFO - PROCESS | 29058 | |0;dojo.html;2623.934401639959;2655.3759866431374;2674.8261363011397;2686.5298572749775;2692.4749673813612;4857.271409288608;4945.925811112827;4957.033378491191;4992.675476094056;5039.949600503994;4965.131102057135;4973.129702302092;5027.949720502794;5057.039162559111;5115.872103197422;4612.76936153191;4622.537746225367;4631.9768401158035;4636.814527418899;4673.252279635259;4331.220380331539;4680.9297860532115;4710.552497512731;4728.1252968201;4736.81052757891;4495.730256184639;4511.954880451186;4656.464506581752;4684.1334353144775;4711.434627844664;4558.111168322179;4586.816527338902;4589.5410458954175;4594.540545945412;4597.931031034537;4561.361409402686;4565.657575681837;4570.360149579062;4571.542845715435;4581.496035436099;4897.069556784235;4945.381827271591;4950.87622809429;4954.157793175169;4956.430010548797;5326.147816349366;5331.413544510101;5331.866703332409;5339.3058902342445;5341.198820177005;5531.419200983919;5543.223948647193;5543.251661025791;5552.805651802168;5552.972235138839;5062.240663900445;5112.923306150411;5138.794448222104;5151.407588127338;5156.819511317086;5620.044592419298;5622;5624.240727501817;5631.183478395692;5633.436656334334;5121.74391280442;5147.459516750762;5152.072626927189;5360.95461385034;5417.187421886749;5306.893862122736;5311.654742441806;5314.415414304501;5315.176147697113;5315.335583052119;5259.579233661374;5273.578113750891;5281.498257665516;5287.444818294024;5292.470752924677;5268.157094864803;5268.262443257947;5270.025045366543;5277.63056586043;5277.868053298698;4517.390152329459;4518.638508919278;4520.344550040226;4544.091181763661;4578.221702310615;3960;3984.20315936808;4014.297497937849;4025.3156963316305;4034.455348527911;4649.442066951988;4653.650976176733;4666.113438446684;4666.230072038075;4711.057788442326;5321.122014867504;5349.919751203735;5474.233607294982;5482.698451585201;5504.559635229172;4619.538046195354;4625.976870115628;4635.049814787961;4637.721736695809;4642.326862604903;4917.557419832232;4936.827211047596;4938.407391113017;4948.727819969864;4949.381327334083;5069.264956581275;5087.465816089258;5089.770960306795;5095.235714642833;5135.794568217229;5477.178423236546;5478.096114141122;5485.835424937259;5489.258950041853;5490.039243132515;4708.835190768306;4931.580815630568;4967.05625931072;5026.994601079726;5034.798608055783;5307.787688492417;5317.468253174807;5317.867053323698;5318.920216196838;5323.760430780701;5394.811181608625;5396.892062158813;5397.190421436816;5400.324959380077;5405.756740946588;5132.230165475208;5203.713795741271;5241.423443421297;5242.18746094356;5252.5535329497425;5194.272801807825;5201.817936372209;5248.553872920845;5253.579713622978;5325.467453254643;5136.948630513647;5241.89516209666;5243.8164664236565;5250.238715386171;5255.211718242142;5215.087359711959;5215.791368345375;5216.478352164753;5220.0603891298415;5299.6290259681455;5076.340075790124;5109.259157422079;5145.45972672864;5171.379434467888;5175.611829112907 09:31:59 INFO - PROCESS | 29058 | |1;ext.html;702.1574111066719;720.4380583145148;769.8421823526178;773.8374941262334;779.357030449879;24657.753422465794;35293.64706352936;35543.93368198955;38676.41985370222;38867.22265554687;35173.64826351736;35601.64398356022;35671.2865742685;35720.64279357206;35779;7357.852842943138;7452.105747310303;7474.7757567273065;7489.588072656002;7496.550206987571;6567.146270984766;6810.523263371566;9126.45241285525;9362.765930851716;9642.13220810127;9374;9400.20098291646;9411.10594493522;9411.43531388119;9412.435253884754;9309.44143351401;9342.299327550461;9342.906570934272;9343.906560934405;9351.579178936965;9078.954605226998;9126.863097053549;9130.908690913073;9136.406133601295;9140;33503.497447538306;33611.32777344464;33638.1590460238;33658.49512257318;33673.6632633673;3377.493375993596;3406.7104296134858;3416.7095796857298;3435.862565497377;3467.861285548575;24188.637170442456;24209.636855447006;24237.151699690603;24279.271621851374;24710.876445617658;3256.772025958184;3356.3790698720572;3371.2246183377715;3398.932021359584;3483.773554718935;163662;163666;163699;163943;164334;35285.823570882494;42658.14683706308;42868.14263714708;42924.785376073545;42927.35608965868;37991;38087;38110.61889381126;38138.23723525514;43283;12356.073294502949;12370.072244581692;12418.627441176599;12453.813192802116;12482.875171248354;9904.405735655884;9934.45360505179;9941.552630131662;9944.602215911427;9949.204063674888;10494.527746251437;12230.633081007583;12291.877081229251;12361.93819030917;12515.749685006249;4439.689221754446;4517.390152329459;4818.060125232358;5177.430482646906;5260.763265653055;902.6254104546671;920.4109370003204;922.4603606890045;925.3060204846365;955.3360414511848;13452.663683407993;13553.728925421436;13575.117617355038;13647.249401283025;13699.589012329647;979.4573546664033;1001.8096561653263;1011.3527342500805;1021.8160731068479;1023.1712313026472;12258.693532661755;13126.212427254204;13245.271510066847;13616.88211948086;13655.658608534866;243904;244886;245156;245163;246271;43109.137817244104;43306.133877322274;43386;43424;43453.13093738107;1258.811178323259;1293.6701141209119;1294.9611511654666;1302.7068909495476;1309.2537253765643;23689.05243790229;24053.756727024276;24512.877435612707;24732.50534989326;24811.627825582993;17656.91171544134;17688.734668980233;17725.113744312992;17727.290908364037;17797.110144492464;238417;238721;238820;239173;240259;24495.63256551189;24991.250262492154;27205.86397068002;28038.719612803612;29855.850720747127;34635.48046779351;34912.940686660375;35410.291794164485;35773.821130894175;35998.820005899805;29962.550561741155;29986.400271994;30183;30421.543676845307;31378.686213137575;29915.700842991293;30353.69646303509;30512.08463746091;30602.234944125685;31113.533297001017;29707.851460742557;30306.696933031268;30537.847310763304;30632.387352253278;30800;23404.76595234094;25404.745952540237;25442;26268.868655657363;27071.45857082887;21020.159193632084;21413.357599272047;21558.568828623025;21618.6757198639;21720.131194752033 09:31:59 INFO - PROCESS | 29058 | |2;jquery.html;392.81537677291664;392.88802691232985;395.7922090902276;417.7514378944528;425.51916334541966;12617.495300188004;15893.602659933507;17561.297548098075;19595.314164004263;19613.607727845454;13006.479740810357;13396.93301533491;16498;17367.13164341784;18408.723869141973;1673.71546837038;5727.599068065248;6495.123158373606;6744.325567443266;6939.236683964785;6718.798436046926;6840.589564626113;6882.105326307573;6890.345417185385;6893.758718444856;6966.198887127995;6989.301069893021;6996.3003699630135;6997.510174287802;7004.194517630487;6856.348646878539;6916.3429474199875;6927.445804335666;6991.335823096798;6991.615461149635;6562.179727534059;6789.626570538619;6790.422814060761;6793.116894803693;6797.52417330787;22028.11887524513;22036.33890983273;22281.66577501339;22586.322410327717;22643;2308.9653655195184;2345.1909091363623;2365.8580485170946;2388.0209114263243;2404.1345115758313;13505.324733763273;13887.722245555133;14107.153570785786;14833.70332593353;14890.627734306621;1864.1611274926338;1882.1718443884783;1916.9520761980923;1935.9545845243551;1961.4998175465307;90648.54675726645;92162.53918730431;92327.53836230843;92402.53798731031;94622.05377946202;15876.2061896907;16085.517434476984;16137.354505819636;16241.350345986028;16736.6652666946;28768.71231287702;28906.13281601513;28955.855220724185;28960.13119606415;28987.85506072498;6985.196702379189;8129.3090087343235;8238.299744521782;8564.785880353042;8605.289333859813;5935.703214839327;5983.43157400055;5987.461128498369;6003.519718422515;6148.44663980244;8961;8968.775780605538;8969.955150224207;9043.23132533742;9287.349885508085;3357.4292370297107;3357.5467311913067;3644.9635503645154;3695.5565332160313;3765.378712512405;776.1733753552448;802.5144787403536;804.7384600005022;807.6405999330359;827.7930517370658;17864.821351786577;18379.356722514647;19117.235310587697;19221.80778192228;19555.31556395519;793.1988691421591;804.3685706720313;813.0649752784345;813.8819871118654;825.1789469477787;9824.754381140528;10387.584496620051;10708.250422470508;11352.659420217407;11894.98892594122;279857;280098;280323;280414;280551;66846;84786;93162.53418732862;94948.60616726037;95437.52281238549;1079.8434227037035;1153.7404084081015;1173.9471723772622;1210.461344701617;1212.42409855318;16636.251368688198;16807;17496.387626433014;17770.644587107927;18090.638187236444;39010.609893901834;43163.35254971241;43484.56515434805;43611.345829811944;44324.55675443333;51785.74107129591;54636.72681636566;54761;55052.0731774386;55667.44332556622;6392.9041064385;8375.832483350421;10452.804910968782;11210.66368008961;11478.82781758291;13135.277559734306;13570.253636050113;13574.185548867099;13655.795163072364;13803;11471.655850324503;11591.76816463683;11732.706682332668;11831.408429578314;11992.160548761503;11258.7748245033;11376.0330371916;11505.884941150816;11507.079433645456;11596.768064638829;11461.942690286494;11559.537618495166;11817.645470635895;12213.816792748294;12244.693882653006;10867.565297388015;10913.199322112081;11046.944765276123;11488.425578720864;11497.1377146716;11111.11111111093;11326;11376.829347559958;11412.087033037504;11743.17797754149 09:31:59 INFO - PROCESS | 29058 | |3;mootools.html;1483.3176738700197;1489.6648254142813;1508.5323549699594;1511.2066165263236;1514.3185566495074;9445.244380449565;10142.54358553865;10150.54322555485;10166.237532185089;10168.74578135547;9169.724908252763;9432.434053956767;9432.952835235832;9433.481158536279;9452.527373631325;1951.4340841156047;1990.0547240061;1992.9402117936486;1996.5906989067207;1998.060911371653;1940.5633732410236;1954.4722924810292;1966.48871293464;1968.3209292793963;1969.4879331373802;1920.030384655747;1924.028365675332;1924.5669724311988;1926.5954149628524;1930.4208737378801;1815.4281401358596;1839.1264149529;1846.1138653446421;1848.7504186934725;1848.92604295828;1899.259288877339;1900.9049547522568;1921.7597800274966;1934.6034063017048;1963.577830766392;9631.133198012143;9695.466749328783;9707.757306067404;9714.514274286257;9720.368176068532;4627.768611569441;4767.833125840613;4769.35613692154;4771.71369717818;4775.617950563947;2533.7719605235616;2694.1648089092446;2754.256350785277;2763.322985868455;2779.2634951737805;966.1546147121269;1017.3946501831399;1021.6934919524113;1043.2905624175557;1064.7391389109719;12353.258804471761;12583.811242831456;12726.80909786354;13881.097728647606;13911.373988170557;3837.1558257183374;3903.551091624443;3945.1715139820385;3955.4264631628253;3958.089639382958;10520.105791007696;10603.89396106029;10621.150307975344;10632.25574209798;10634.30876992993;3919.8236079375924;4020.115574573589;4351.73889566627;4651.813927442932;4652.906941861143;4386.956130438719;4466.1067786442845;4468.776561171929;4471.19518486669;4479.193745125844;3121.7034381733697;3218.8229647369153;3267.2158681916644;3287.474004159323;3293.5718356613966;825.7894236969535;850.4769566716425;862.2153840005565;863.3395452478859;867.9566021698889;660.1550015979553;683.5215349255541;691.0670594697219;693.3447891742356;733.3949491669395;5159.845204643867;5286.36563612369;5592.580556458201;5915.792947246911;6126.295476020226;910.3127139010005;922.2667978956746;934.4720233068294;941.4445477168504;980.857775622545;3625.873094441682;3685.852565897334;3733.887983360449;3739.8878033659034;3762.4168253920684;11519.654410367702;11786.469608867621;11942;11944.283342999448;11974.101942354358;11824.054075674097;11835.28988260707;11839.467223974942;11847.170698051226;11860.762784744256;8140.470869393471;8440.78898027542;8613.095624959415;8683;8919.152680495343;5590.912031208787;5850.356460789225;5946.762129514771;5948.613340132878;6075.210222671025;10276.845847312146;10600.840987385041;10708.196885233483;10742.355458672504;10905.291156074829;10764.946175269073;10770.569177232823;10974.341539507655;11047.889521104686;11061.557537698724;7832.0601527817025;8028.357731381592;8034.879476807736;8046.959765201136;8051.2351326623875;8777;8812.823743524965;8813.074627164311;8859.335549833659;8863.778405539913;7867.291943725092;7956;7987.440879138405;8041.597920103854;8116.75649730509;7581.355584775356;7689.346405555367;7735.574543400167;7783;7944.364450844034;6356.269029061532;6407.135036769976;6410.262819775786;6415.454686351713;6415.967920160556;4711.220548666004;4879.34128892595;4880.365552478155;4900.166971614905;4921.409430868319;4920.827771027997;4956.752162391938;5009.674371165863;5091.159958606937;5259.342582177228 09:31:59 INFO - PROCESS | 29058 | |4;prototype.html;339.5907930943214;362.322417588927;363.99818000909994;373.54241054707984;376.0354690219586;4652.837150699726;4694.248920172773;4719.504452032538;4737.620990320775;4761.976190119053;4627.097715945383;4651.697524693083;4660.883477913046;4688.179568575494;4710.599599034086;3761.398176291794;3803.353429916921;3804.7717136971733;3813.161104556993;3925.1953349563414;3838.2899163654674;3874;3885.8834234972855;3891.6886649068147;3940.822662980173;3903.687704983609;3905.9258703856526;3927.2145570885796;3930.3318435865826;3935.9606403936023;3920.72576412667;3952.2490726761825;3955.9011024724323;3961.3463778476516;3966.6231707987695;3476.6523347665284;3630.43728222126;3655.744097913147;3657.7073834093208;3673.577538583044;4494.460664720222;4499.75251361175;4523.592876641118;4536.432945881765;4546.4087569350795;4482.708623939434;4484.439445069366;4495.707778994388;4503.099380123988;4515.977420112911;4704.55306745862;4847.878803029917;4884.338035770514;4886.973735515546;4916.336294600219;3973.4635824163947;3976.940345894785;3983.26309632716;4004.8598299059395;4006.4390985262085;4844.498205556289;4961.875953101129;4969.254611808222;5093.668911520739;5122.233993643428;4002.9799851000557;4035.4552135461336;4050.2709512287483;4060.959390406117;4076.286649836267;4109.589041095926;4122.9381559276635;4132.648724858361;4141;4150.402095193373;4136.358864375967;4274.294741367702;4441.311596702451;4471.272523760504;4474.306482495218;4860.562549370574;4879.170541008037;4893.363862697826;4894.608431325557;4914.557689807934;1438.3743071763815;1451.6733734909772;1452.1722618107788;1455.4396557325506;1463.1367493179075;1028.8456731490337;1083.9214981093705;1102.9338239705482;1104.5140138339104;1123.9325640461598;4262.211490874136;4286.6497053428075;4304.849330273425;4332.978335108304;4343.1747967886;5035.697858128451;5036.312835200249;5037.319961805183;5048;5060.2156665716875;4016.8393264269102;4288.678349123828;4296.598068877351;4308.6983911126545;4357.782110894443;2624.3307956470976;2659.7739192168497;2664.9733502665113;2666.2534490342737;2684.6644169478814;4721.6458765592715;4741.668083234141;4743.762811859393;4756.072565849695;4757;4930.975345123252;5114.795408183631;5159.664621799571;5180.922286165635;5192.299039629677;4658.254679251304;4667.13657973276;4710.62315014798;4717.169698181133;4736.076465089274;5020.397552293602;5036.622253331088;5066.670666406671;5119.257707632447;5162.225666150108;4709.5055019223855;4954.20732682769;4977.656032871032;4984.127777638972;4988.201887697951;4517.593416592523;4593.356930029865;4622.95983403745;4728.007118505015;4739.113926580171;4052.2908491013363;4112.848402447319;4145.176122506087;4170.520390155171;4184.748915065105;5061.848144555669;5064.265681476091;5072.467390924047;5078.825733916302;5102.974485127551;4727.7163370197895;4806.8077276909935;4852.2479015752615;4861.319415281792;4924.704517728947;4847.491013443538;4854;4857;4878.804383129056;4893.21708526634;4774.880627984328;4795.729131780151;4814.927776083291;4819.759012049313;4830.53642642262;4607.792649330855;4848.648405523389;4866;4903.215485522299;4929.630277729257;4753.811547113221;4755.286706993978;4766.737829419415;4777.474477807508;4790.7365094920115 09:31:59 INFO - PROCESS | 29058 | |5;yui.html;660.5772305724335;672.7880717573964;677.6577828196762;678.3758941773568;699.0946723992432;12504.437300321497;13796;13938;13948.302584870755;13951.860481395182;12369.505219791197;12757.489700411996;13008.674783130426;13157.934210328958;13184.143030702997;823.6293667849477;843.6541018182546;847.2290215903529;847.6651722569582;848.1899785704637;841.6044459104211;842.4313588327885;864.8097418567905;876.7457437343163;877.0834477970504;905.1717678324359;905.6241659711212;906.3112034853493;906.5467266366817;906.9841777209501;899.8560230363111;899.9460032398044;899.95050272235;899.9730008099734;900.275278400887;674.2482132422314;674.2919934069208;674.4840197249108;674.5244602555186;674.9325067493261;12663.430145643468;12697.238165709994;13285.800712989312;13304.06871518994;13319.26744029078;13593.184408935496;14108.365123569463;14256.429742810275;14257.71484570313;14329.49846755369;9362.719118426457;9465.100815422524;9642.566084526214;9808.264380171444;9831.754206144831;3123;3131.9217019574694;3167.319026409333;3172.698593633601;3209.4383482890635;63377;63534.364656353304;63798.681006595136;64002.359976400105;64958.350416495705;10164.4917754112;10333.121684656888;10688.86222755452;10813.783724325469;10858.891411085788;18216;18290;18519.35182268614;19179.61640767177;20012;6206.648768949757;6368.140301059298;6378;6396.968015159894;6439.259485159173;3479;3546.627604101584;3600.0639833642917;3651.2879988402005;3654.9634503655157;2746.231055304518;2818.070036887822;2826.1804076817903;2841.6732075811547;2998.835064071497;515.6055617452652;520.6043407010624;521.0386836287045;526.3447008474474;532.2096686420663;609.2939768647768;613.8404014956144;621.8476473263988;627.4948666323562;634.8539835837784;8743.038265790758;9100.726978190532;9177.128172823572;9211.63153473867;9465.574049167804;580.4601720400068;587.5857520448074;589.4253103224407;598.1088178613921;603.6528995827417;4044.130511939947;4120.567340429212;4242.300020496584;4471.575200355961;4499.10017996402;58672.706636466544;61474;61803.38196617976;63386.366136338045;63386.6830665853;55506.444935550935;56203.43796561982;56264;56306.71846640741;56588.717056414454;49010.754946226465;49134.75432622814;49912.75043624759;50102.49897501051;50327.74836125796;8957.820843583222;9035.774105647148;9207;9281.67514137002;9779.755506112404;29408.705912940597;32168;32760;33185.66814331922;33323.666763332054;44173;44627.77686111549;44630.776846115565;44807;45160.41938532267;11869.050475962074;12114.75770484603;12246.203996740183;12261.938690306491;12304.507819687113;12801.871981280441;13050.934745326213;13063.412146453242;13324.067315287837;13952.651183720489;12041.217320874115;12415.130940834055;12528.123031387715;12547.560835371083;12725.681857953256;11677;12076.51693932268;12293.75412491763;12306.507739690313;12455.93772031134;10856.185786065918;10947.781044379228;11236.831447528457;11527.002979225294;11631;9653.420794752337;10147;10352.948235258775;10549.89450105489;10682.62610808618;10017.849732253877;10250.231232657432;10342;10352.585896564053;10357.482125893524 09:31:59 INFO - PROCESS | 29058 | __end_tp_report 09:31:59 INFO - PROCESS | 29058 | __start_cc_report 09:31:59 INFO - PROCESS | 29058 | _x_x_mozilla_cycle_collect,2657 09:31:59 INFO - PROCESS | 29058 | __end_cc_report 09:31:59 INFO - PROCESS | 29058 | __startTimestamp1489167119138__endTimestamp 09:31:59 INFO - PROCESS | 29058 | 09:31:59 INFO - PROCESS | 29058 | ------- Summary: start ------- 09:31:59 INFO - PROCESS | 29058 | Number of tests: 6 09:31:59 INFO - PROCESS | 29058 | 09:31:59 INFO - PROCESS | 29058 | [#0] dojo.html Cycles:165 Average:4965.34 Median:5115.87 stddev:545.77 (10.7%) stddev-sans-first:515.61 09:31:59 INFO - PROCESS | 29058 | Values: 2623.9 2655.4 2674.8 2686.5 2692.5 4857.3 4945.9 4957.0 4992.7 5039.9 4965.1 4973.1 5027.9 5057.0 5115.9 4612.8 4622.5 4632.0 4636.8 4673.3 4331.2 4680.9 4710.6 4728.1 4736.8 4495.7 4512.0 4656.5 4684.1 4711.4 4558.1 4586.8 4589.5 4594.5 4597.9 4561.4 4565.7 4570.4 4571.5 4581.5 4897.1 4945.4 4950.9 4954.2 4956.4 5326.1 5331.4 5331.9 5339.3 5341.2 5531.4 5543.2 5543.3 5552.8 5553.0 5062.2 5112.9 5138.8 5151.4 5156.8 5620.0 5622.0 5624.2 5631.2 5633.4 5121.7 5147.5 5152.1 5361.0 5417.2 5306.9 5311.7 5314.4 5315.2 5315.3 5259.6 5273.6 5281.5 5287.4 5292.5 5268.2 5268.3 5270.0 5277.6 5277.9 4517.4 4518.6 4520.3 4544.1 4578.2 3960.0 3984.2 4014.3 4025.3 4034.5 4649.4 4653.7 4666.1 4666.2 4711.1 5321.1 5349.9 5474.2 5482.7 5504.6 4619.5 4626.0 4635.0 4637.7 4642.3 4917.6 4936.8 4938.4 4948.7 4949.4 5069.3 5087.5 5089.8 5095.2 5135.8 5477.2 5478.1 5485.8 5489.3 5490.0 4708.8 4931.6 4967.1 5027.0 5034.8 5307.8 5317.5 5317.9 5318.9 5323.8 5394.8 5396.9 5397.2 5400.3 5405.8 5132.2 5203.7 5241.4 5242.2 5252.6 5194.3 5201.8 5248.6 5253.6 5325.5 5136.9 5241.9 5243.8 5250.2 5255.2 5215.1 5215.8 5216.5 5220.1 5299.6 5076.3 5109.3 5145.5 5171.4 5175.6 09:31:59 INFO - PROCESS | 29058 | 09:31:59 INFO - PROCESS | 29058 | [#1] ext.html Cycles:180 Average:35080.00 Median:18380.13 stddev:57187.89 (311.1%) stddev-sans-first:57290.07 09:31:59 INFO - PROCESS | 29058 | Values: 702.2 720.4 769.8 773.8 779.4 24657.8 35293.6 35543.9 38676.4 38867.2 35173.6 35601.6 35671.3 35720.6 35779.0 7357.9 7452.1 7474.8 7489.6 7496.6 6567.1 6810.5 9126.5 9362.8 9642.1 9374.0 9400.2 9411.1 9411.4 9412.4 9309.4 9342.3 9342.9 9343.9 9351.6 9079.0 9126.9 9130.9 9136.4 9140.0 33503.5 33611.3 33638.2 33658.5 33673.7 3377.5 3406.7 3416.7 3435.9 3467.9 24188.6 24209.6 24237.2 24279.3 24710.9 3256.8 3356.4 3371.2 3398.9 3483.8 163662.0 163666.0 163699.0 163943.0 164334.0 35285.8 42658.1 42868.1 42924.8 42927.4 37991.0 38087.0 38110.6 38138.2 43283.0 12356.1 12370.1 12418.6 12453.8 12482.9 9904.4 9934.5 9941.6 9944.6 9949.2 10494.5 12230.6 12291.9 12361.9 12515.7 4439.7 4517.4 4818.1 5177.4 5260.8 902.6 920.4 922.5 925.3 955.3 13452.7 13553.7 13575.1 13647.2 13699.6 979.5 1001.8 1011.4 1021.8 1023.2 12258.7 13126.2 13245.3 13616.9 13655.7 243904.0 244886.0 245156.0 245163.0 246271.0 43109.1 43306.1 43386.0 43424.0 43453.1 1258.8 1293.7 1295.0 1302.7 1309.3 23689.1 24053.8 24512.9 24732.5 24811.6 17656.9 17688.7 17725.1 17727.3 17797.1 238417.0 238721.0 238820.0 239173.0 240259.0 24495.6 24991.3 27205.9 28038.7 29855.9 34635.5 34912.9 35410.3 35773.8 35998.8 29962.6 29986.4 30183.0 30421.5 31378.7 29915.7 30353.7 30512.1 30602.2 31113.5 29707.9 30306.7 30537.8 30632.4 30800.0 23404.8 25404.7 25442.0 26268.9 27071.5 21020.2 21413.4 21558.6 21618.7 21720.1 09:31:59 INFO - PROCESS | 29058 | 09:31:59 INFO - PROCESS | 29058 | [#2] jquery.html Cycles:180 Average:24062.80 Median:280368.50 stddev:48213.90 (17.2%) stddev-sans-first:48316.40 09:31:59 INFO - PROCESS | 29058 | Values: 392.8 392.9 395.8 417.8 425.5 12617.5 15893.6 17561.3 19595.3 19613.6 13006.5 13396.9 16498.0 17367.1 18408.7 1673.7 5727.6 6495.1 6744.3 6939.2 6718.8 6840.6 6882.1 6890.3 6893.8 6966.2 6989.3 6996.3 6997.5 7004.2 6856.3 6916.3 6927.4 6991.3 6991.6 6562.2 6789.6 6790.4 6793.1 6797.5 22028.1 22036.3 22281.7 22586.3 22643.0 2309.0 2345.2 2365.9 2388.0 2404.1 13505.3 13887.7 14107.2 14833.7 14890.6 1864.2 1882.2 1917.0 1936.0 1961.5 90648.5 92162.5 92327.5 92402.5 94622.1 15876.2 16085.5 16137.4 16241.4 16736.7 28768.7 28906.1 28955.9 28960.1 28987.9 6985.2 8129.3 8238.3 8564.8 8605.3 5935.7 5983.4 5987.5 6003.5 6148.4 8961.0 8968.8 8970.0 9043.2 9287.3 3357.4 3357.5 3645.0 3695.6 3765.4 776.2 802.5 804.7 807.6 827.8 17864.8 18379.4 19117.2 19221.8 19555.3 793.2 804.4 813.1 813.9 825.2 9824.8 10387.6 10708.3 11352.7 11895.0 279857.0 280098.0 280323.0 280414.0 280551.0 66846.0 84786.0 93162.5 94948.6 95437.5 1079.8 1153.7 1173.9 1210.5 1212.4 16636.3 16807.0 17496.4 17770.6 18090.6 39010.6 43163.4 43484.6 43611.3 44324.6 51785.7 54636.7 54761.0 55052.1 55667.4 6392.9 8375.8 10452.8 11210.7 11478.8 13135.3 13570.3 13574.2 13655.8 13803.0 11471.7 11591.8 11732.7 11831.4 11992.2 11258.8 11376.0 11505.9 11507.1 11596.8 11461.9 11559.5 11817.6 12213.8 12244.7 10867.6 10913.2 11046.9 11488.4 11497.1 11111.1 11326.0 11376.8 11412.1 11743.2 09:31:59 INFO - PROCESS | 29058 | 09:31:59 INFO - PROCESS | 29058 | [#3] mootools.html Cycles:180 Average:5797.00 Median:4369.35 stddev:3727.47 (85.3%) stddev-sans-first:3723.83 09:31:59 INFO - PROCESS | 29058 | Values: 1483.3 1489.7 1508.5 1511.2 1514.3 9445.2 10142.5 10150.5 10166.2 10168.7 9169.7 9432.4 9433.0 9433.5 9452.5 1951.4 1990.1 1992.9 1996.6 1998.1 1940.6 1954.5 1966.5 1968.3 1969.5 1920.0 1924.0 1924.6 1926.6 1930.4 1815.4 1839.1 1846.1 1848.8 1848.9 1899.3 1900.9 1921.8 1934.6 1963.6 9631.1 9695.5 9707.8 9714.5 9720.4 4627.8 4767.8 4769.4 4771.7 4775.6 2533.8 2694.2 2754.3 2763.3 2779.3 966.2 1017.4 1021.7 1043.3 1064.7 12353.3 12583.8 12726.8 13881.1 13911.4 3837.2 3903.6 3945.2 3955.4 3958.1 10520.1 10603.9 10621.2 10632.3 10634.3 3919.8 4020.1 4351.7 4651.8 4652.9 4387.0 4466.1 4468.8 4471.2 4479.2 3121.7 3218.8 3267.2 3287.5 3293.6 825.8 850.5 862.2 863.3 868.0 660.2 683.5 691.1 693.3 733.4 5159.8 5286.4 5592.6 5915.8 6126.3 910.3 922.3 934.5 941.4 980.9 3625.9 3685.9 3733.9 3739.9 3762.4 11519.7 11786.5 11942.0 11944.3 11974.1 11824.1 11835.3 11839.5 11847.2 11860.8 8140.5 8440.8 8613.1 8683.0 8919.2 5590.9 5850.4 5946.8 5948.6 6075.2 10276.8 10600.8 10708.2 10742.4 10905.3 10764.9 10770.6 10974.3 11047.9 11061.6 7832.1 8028.4 8034.9 8047.0 8051.2 8777.0 8812.8 8813.1 8859.3 8863.8 7867.3 7956.0 7987.4 8041.6 8116.8 7581.4 7689.3 7735.6 7783.0 7944.4 6356.3 6407.1 6410.3 6415.5 6416.0 4711.2 4879.3 4880.4 4900.2 4921.4 4920.8 4956.8 5009.7 5091.2 5259.3 09:31:59 INFO - PROCESS | 29058 | 09:31:59 INFO - PROCESS | 29058 | [#4] prototype.html Cycles:180 Average:4181.71 Median:4569.88 stddev:1105.59 (24.2%) stddev-sans-first:1070.42 09:31:59 INFO - PROCESS | 29058 | Values: 339.6 362.3 364.0 373.5 376.0 4652.8 4694.2 4719.5 4737.6 4762.0 4627.1 4651.7 4660.9 4688.2 4710.6 3761.4 3803.4 3804.8 3813.2 3925.2 3838.3 3874.0 3885.9 3891.7 3940.8 3903.7 3905.9 3927.2 3930.3 3936.0 3920.7 3952.2 3955.9 3961.3 3966.6 3476.7 3630.4 3655.7 3657.7 3673.6 4494.5 4499.8 4523.6 4536.4 4546.4 4482.7 4484.4 4495.7 4503.1 4516.0 4704.6 4847.9 4884.3 4887.0 4916.3 3973.5 3976.9 3983.3 4004.9 4006.4 4844.5 4961.9 4969.3 5093.7 5122.2 4003.0 4035.5 4050.3 4061.0 4076.3 4109.6 4122.9 4132.6 4141.0 4150.4 4136.4 4274.3 4441.3 4471.3 4474.3 4860.6 4879.2 4893.4 4894.6 4914.6 1438.4 1451.7 1452.2 1455.4 1463.1 1028.8 1083.9 1102.9 1104.5 1123.9 4262.2 4286.6 4304.8 4333.0 4343.2 5035.7 5036.3 5037.3 5048.0 5060.2 4016.8 4288.7 4296.6 4308.7 4357.8 2624.3 2659.8 2665.0 2666.3 2684.7 4721.6 4741.7 4743.8 4756.1 4757.0 4931.0 5114.8 5159.7 5180.9 5192.3 4658.3 4667.1 4710.6 4717.2 4736.1 5020.4 5036.6 5066.7 5119.3 5162.2 4709.5 4954.2 4977.7 4984.1 4988.2 4517.6 4593.4 4623.0 4728.0 4739.1 4052.3 4112.8 4145.2 4170.5 4184.7 5061.8 5064.3 5072.5 5078.8 5103.0 4727.7 4806.8 4852.2 4861.3 4924.7 4847.5 4854.0 4857.0 4878.8 4893.2 4774.9 4795.7 4814.9 4819.8 4830.5 4607.8 4848.6 4866.0 4903.2 4929.6 4753.8 4755.3 4766.7 4777.5 4790.7 09:31:59 INFO - PROCESS | 29058 | 09:31:59 INFO - PROCESS | 29058 | [#5] yui.html Cycles:180 Average:14670.32 Median:24639.29 stddev:17785.53 (72.2%) stddev-sans-first:17804.31 09:31:59 INFO - PROCESS | 29058 | Values: 660.6 672.8 677.7 678.4 699.1 12504.4 13796.0 13938.0 13948.3 13951.9 12369.5 12757.5 13008.7 13157.9 13184.1 823.6 843.7 847.2 847.7 848.2 841.6 842.4 864.8 876.7 877.1 905.2 905.6 906.3 906.5 907.0 899.9 899.9 900.0 900.0 900.3 674.2 674.3 674.5 674.5 674.9 12663.4 12697.2 13285.8 13304.1 13319.3 13593.2 14108.4 14256.4 14257.7 14329.5 9362.7 9465.1 9642.6 9808.3 9831.8 3123.0 3131.9 3167.3 3172.7 3209.4 63377.0 63534.4 63798.7 64002.4 64958.4 10164.5 10333.1 10688.9 10813.8 10858.9 18216.0 18290.0 18519.4 19179.6 20012.0 6206.6 6368.1 6378.0 6397.0 6439.3 3479.0 3546.6 3600.1 3651.3 3655.0 2746.2 2818.1 2826.2 2841.7 2998.8 515.6 520.6 521.0 526.3 532.2 609.3 613.8 621.8 627.5 634.9 8743.0 9100.7 9177.1 9211.6 9465.6 580.5 587.6 589.4 598.1 603.7 4044.1 4120.6 4242.3 4471.6 4499.1 58672.7 61474.0 61803.4 63386.4 63386.7 55506.4 56203.4 56264.0 56306.7 56588.7 49010.8 49134.8 49912.8 50102.5 50327.7 8957.8 9035.8 9207.0 9281.7 9779.8 29408.7 32168.0 32760.0 33185.7 33323.7 44173.0 44627.8 44630.8 44807.0 45160.4 11869.1 12114.8 12246.2 12261.9 12304.5 12801.9 13050.9 13063.4 13324.1 13952.7 12041.2 12415.1 12528.1 12547.6 12725.7 11677.0 12076.5 12293.8 12306.5 12455.9 10856.2 10947.8 11236.8 11527.0 11631.0 9653.4 10147.0 10352.9 10549.9 10682.6 10017.8 10250.2 10342.0 10352.6 10357.5 09:31:59 INFO - PROCESS | 29058 | -------- Summary: end -------- 09:31:59 INFO - PROCESS | 29058 | 09:31:59 INFO - TEST-INFO | 29058: exit 0 09:31:59 INFO - TEST-OK | dromaeo_css | took 1124252ms 09:31:59 INFO - TEST-START | kraken 09:31:59 INFO - operating with platform_type : linux_ 09:31:59 INFO - Initialising browser for kraken test... 09:31:59 INFO - TEST-INFO | started process 29384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBC6nbU/profile http://localhost:60208/getInfo.html) 09:32:04 INFO - PROCESS | 29384 | __metrics Screen width/height:1600/1200 09:32:04 INFO - PROCESS | 29384 | colorDepth:24 09:32:04 INFO - PROCESS | 29384 | Browser inner width/height: 1024/697 09:32:04 INFO - PROCESS | 29384 | __metrics 09:32:05 INFO - PROCESS | 29384 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:32:05 INFO - PROCESS | 29384 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:32:06 INFO - TEST-INFO | 29384: exit 0 09:32:06 INFO - Browser initialized. 09:32:06 INFO - Running cycle 1/1 for kraken test... 09:32:06 INFO - TEST-INFO | started process 29475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBC6nbU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:32:18 INFO - PROCESS | 29475 | RSS: Main: 148676608 09:32:18 INFO - PROCESS | 29475 | 09:32:21 INFO - PROCESS | 29475 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60208/tests/kraken/driver.html?testName=audio-beat-detection) 09:32:22 INFO - PROCESS | 29475 | RSS: Main: 202194944 09:32:22 INFO - PROCESS | 29475 | 09:32:24 INFO - PROCESS | 29475 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60208/tests/kraken/driver.html?testName=audio-dft) 09:32:25 INFO - PROCESS | 29475 | RSS: Main: 182898688 09:32:25 INFO - PROCESS | 29475 | 09:32:28 INFO - PROCESS | 29475 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60208/tests/kraken/driver.html?testName=audio-fft) 09:32:29 INFO - PROCESS | 29475 | RSS: Main: 264581120 09:32:29 INFO - PROCESS | 29475 | 09:32:31 INFO - PROCESS | 29475 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60208/tests/kraken/driver.html?testName=audio-oscillator) 09:32:31 INFO - PROCESS | 29475 | RSS: Main: 176099328 09:32:31 INFO - PROCESS | 29475 | 09:32:34 INFO - PROCESS | 29475 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60208/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:32:34 INFO - PROCESS | 29475 | RSS: Main: 178941952 09:32:34 INFO - PROCESS | 29475 | 09:32:37 INFO - PROCESS | 29475 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60208/tests/kraken/driver.html?testName=imaging-darkroom) 09:32:38 INFO - PROCESS | 29475 | RSS: Main: 218177536 09:32:38 INFO - PROCESS | 29475 | 09:32:42 INFO - PROCESS | 29475 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60208/tests/kraken/driver.html?testName=imaging-desaturate) 09:32:42 INFO - PROCESS | 29475 | RSS: Main: 213819392 09:32:42 INFO - PROCESS | 29475 | 09:32:45 INFO - PROCESS | 29475 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60208/tests/kraken/driver.html?testName=json-parse-financial) 09:32:46 INFO - PROCESS | 29475 | RSS: Main: 215461888 09:32:46 INFO - PROCESS | 29475 | 09:32:47 INFO - PROCESS | 29475 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60208/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:32:48 INFO - PROCESS | 29475 | RSS: Main: 179261440 09:32:48 INFO - PROCESS | 29475 | 09:32:50 INFO - PROCESS | 29475 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60208/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:32:50 INFO - PROCESS | 29475 | RSS: Main: 186646528 09:32:50 INFO - PROCESS | 29475 | 09:32:53 INFO - PROCESS | 29475 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60208/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:32:53 INFO - PROCESS | 29475 | RSS: Main: 196059136 09:32:53 INFO - PROCESS | 29475 | 09:32:56 INFO - PROCESS | 29475 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60208/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:32:57 INFO - PROCESS | 29475 | RSS: Main: 204959744 09:32:57 INFO - PROCESS | 29475 | 09:33:00 INFO - PROCESS | 29475 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60208/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:33:00 INFO - PROCESS | 29475 | RSS: Main: 200925184 09:33:00 INFO - PROCESS | 29475 | 09:33:02 INFO - PROCESS | 29475 | Cycle 1(1): loaded http://localhost:60208/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60208/tests/kraken/driver.html?testName=ai-astar) 09:33:03 INFO - PROCESS | 29475 | RSS: Main: 253149184 09:33:03 INFO - PROCESS | 29475 | 09:33:03 INFO - PROCESS | 29475 | __start_tp_report 09:33:03 INFO - PROCESS | 29475 | _x_x_mozilla_page_load 09:33:03 INFO - PROCESS | 29475 | _x_x_mozilla_page_load_details 09:33:03 INFO - PROCESS | 29475 | |i|pagename|runs| 09:33:03 INFO - PROCESS | 29475 | |0;ai-astar;108;119;117;118;117;117;115;116;115;116 09:33:03 INFO - PROCESS | 29475 | |1;audio-beat-detection;155;132;127;170;125;133;131;123;148;126 09:33:03 INFO - PROCESS | 29475 | |2;audio-dft;163;163;164;164;162;162;164;162;161;163 09:33:03 INFO - PROCESS | 29475 | |3;audio-fft;75;77;75;116;77;78;79;75;92;76 09:33:03 INFO - PROCESS | 29475 | |4;audio-oscillator;84;86;109;84;85;85;111;84;84;117 09:33:03 INFO - PROCESS | 29475 | |5;imaging-gaussian-blur;114;114;113;113;113;114;113;114;113;114 09:33:03 INFO - PROCESS | 29475 | |6;imaging-darkroom;148;150;149;149;149;149;149;150;149;149 09:33:03 INFO - PROCESS | 29475 | |7;imaging-desaturate;97;93;95;95;94;94;95;94;95;94 09:33:03 INFO - PROCESS | 29475 | |8;json-parse-financial;66;66;66;65;69;67;66;67;67;69 09:33:03 INFO - PROCESS | 29475 | |9;json-stringify-tinderbox;56;55;55;55;55;55;56;55;55;55 09:33:03 INFO - PROCESS | 29475 | |10;stanford-crypto-aes;89;85;88;86;85;83;85;85;85;91 09:33:03 INFO - PROCESS | 29475 | |11;stanford-crypto-ccm;135;133;135;131;132;133;133;131;178;139 09:33:03 INFO - PROCESS | 29475 | |12;stanford-crypto-pbkdf2;184;187;181;179;180;182;181;182;178;176 09:33:03 INFO - PROCESS | 29475 | |13;stanford-crypto-sha256-iterative;68;69;68;67;67;68;69;71;66;66 09:33:03 INFO - PROCESS | 29475 | __end_tp_report 09:33:03 INFO - PROCESS | 29475 | __start_cc_report 09:33:03 INFO - PROCESS | 29475 | _x_x_mozilla_cycle_collect,2031 09:33:03 INFO - PROCESS | 29475 | __end_cc_report 09:33:03 INFO - PROCESS | 29475 | __startTimestamp1489167183020__endTimestamp 09:33:03 INFO - PROCESS | 29475 | 09:33:03 INFO - PROCESS | 29475 | ------- Summary: start ------- 09:33:03 INFO - PROCESS | 29475 | Number of tests: 14 09:33:03 INFO - PROCESS | 29475 | 09:33:03 INFO - PROCESS | 29475 | [#0] ai-astar Cycles:10 Average:115.80 Median:117.00 stddev:3.01 (2.6%) stddev-sans-first:1.32 09:33:03 INFO - PROCESS | 29475 | Values: 108.0 119.0 117.0 118.0 117.0 117.0 115.0 116.0 115.0 116.0 09:33:03 INFO - PROCESS | 29475 | 09:33:03 INFO - PROCESS | 29475 | [#1] audio-beat-detection Cycles:10 Average:137.00 Median:132.50 stddev:15.53 (11.7%) stddev-sans-first:15.05 09:33:03 INFO - PROCESS | 29475 | Values: 155.0 132.0 127.0 170.0 125.0 133.0 131.0 123.0 148.0 126.0 09:33:03 INFO - PROCESS | 29475 | 09:33:03 INFO - PROCESS | 29475 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 09:33:03 INFO - PROCESS | 29475 | Values: 163.0 163.0 164.0 164.0 162.0 162.0 164.0 162.0 161.0 163.0 09:33:03 INFO - PROCESS | 29475 | 09:33:03 INFO - PROCESS | 29475 | [#3] audio-fft Cycles:10 Average:82.00 Median:77.00 stddev:12.97 (16.8%) stddev-sans-first:13.51 09:33:03 INFO - PROCESS | 29475 | Values: 75.0 77.0 75.0 116.0 77.0 78.0 79.0 75.0 92.0 76.0 09:33:03 INFO - PROCESS | 29475 | 09:33:03 INFO - PROCESS | 29475 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:84.00 stddev:13.57 (16.2%) stddev-sans-first:14.00 09:33:03 INFO - PROCESS | 29475 | Values: 84.0 86.0 109.0 84.0 85.0 85.0 111.0 84.0 84.0 117.0 09:33:03 INFO - PROCESS | 29475 | 09:33:03 INFO - PROCESS | 29475 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:33:03 INFO - PROCESS | 29475 | Values: 114.0 114.0 113.0 113.0 113.0 114.0 113.0 114.0 113.0 114.0 09:33:03 INFO - PROCESS | 29475 | 09:33:03 INFO - PROCESS | 29475 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 09:33:03 INFO - PROCESS | 29475 | Values: 148.0 150.0 149.0 149.0 149.0 149.0 149.0 150.0 149.0 149.0 09:33:03 INFO - PROCESS | 29475 | 09:33:03 INFO - PROCESS | 29475 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:1.07 (1.1%) stddev-sans-first:0.71 09:33:03 INFO - PROCESS | 29475 | Values: 97.0 93.0 95.0 95.0 94.0 94.0 95.0 94.0 95.0 94.0 09:33:03 INFO - PROCESS | 29475 | 09:33:03 INFO - PROCESS | 29475 | [#8] json-parse-financial Cycles:10 Average:66.80 Median:67.00 stddev:1.32 (2.0%) stddev-sans-first:1.36 09:33:03 INFO - PROCESS | 29475 | Values: 66.0 66.0 66.0 65.0 69.0 67.0 66.0 67.0 67.0 69.0 09:33:03 INFO - PROCESS | 29475 | 09:33:03 INFO - PROCESS | 29475 | [#9] json-stringify-tinderbox Cycles:10 Average:55.20 Median:55.00 stddev:0.42 (0.8%) stddev-sans-first:0.33 09:33:03 INFO - PROCESS | 29475 | Values: 56.0 55.0 55.0 55.0 55.0 55.0 56.0 55.0 55.0 55.0 09:33:03 INFO - PROCESS | 29475 | 09:33:03 INFO - PROCESS | 29475 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:85.50 stddev:2.39 (2.8%) stddev-sans-first:2.32 09:33:03 INFO - PROCESS | 29475 | Values: 89.0 85.0 88.0 86.0 85.0 83.0 85.0 85.0 85.0 91.0 09:33:03 INFO - PROCESS | 29475 | 09:33:03 INFO - PROCESS | 29475 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:134.00 stddev:14.25 (10.6%) stddev-sans-first:15.07 09:33:03 INFO - PROCESS | 29475 | Values: 135.0 133.0 135.0 131.0 132.0 133.0 133.0 131.0 178.0 139.0 09:33:03 INFO - PROCESS | 29475 | 09:33:03 INFO - PROCESS | 29475 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.00 Median:181.50 stddev:3.09 (1.7%) stddev-sans-first:3.08 09:33:03 INFO - PROCESS | 29475 | Values: 184.0 187.0 181.0 179.0 180.0 182.0 181.0 182.0 178.0 176.0 09:33:03 INFO - PROCESS | 29475 | 09:33:03 INFO - PROCESS | 29475 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.52 (2.2%) stddev-sans-first:1.62 09:33:03 INFO - PROCESS | 29475 | Values: 68.0 69.0 68.0 67.0 67.0 68.0 69.0 71.0 66.0 66.0 09:33:03 INFO - PROCESS | 29475 | -------- Summary: end -------- 09:33:03 INFO - PROCESS | 29475 | 09:33:04 INFO - TEST-INFO | 29475: exit 0 09:33:04 INFO - TEST-OK | kraken | took 64299ms 09:33:04 INFO - SUITE-END | took 1188s 09:33:04 INFO - Completed test suite (00:19:48) 09:33:04 INFO - javascript benchmark 09:33:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6549.407082674216, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2623.934401639959, 2655.3759866431374, 2674.8261363011397, 2686.5298572749775, 2692.4749673813612, 4857.271409288608, 4945.925811112827, 4957.033378491191, 4992.675476094056, 5039.949600503994, 4965.131102057135, 4973.129702302092, 5027.949720502794, 5057.039162559111, 5115.872103197422, 4612.76936153191, 4622.537746225367, 4631.9768401158035, 4636.814527418899, 4673.252279635259, 4331.220380331539, 4680.9297860532115, 4710.552497512731, 4728.1252968201, 4736.81052757891, 4495.730256184639, 4511.954880451186, 4656.464506581752, 4684.1334353144775, 4711.434627844664, 4558.111168322179, 4586.816527338902, 4589.5410458954175, 4594.540545945412, 4597.931031034537, 4561.361409402686, 4565.657575681837, 4570.360149579062, 4571.542845715435, 4581.496035436099, 4897.069556784235, 4945.381827271591, 4950.87622809429, 4954.157793175169, 4956.430010548797, 5326.147816349366, 5331.413544510101, 5331.866703332409, 5339.3058902342445, 5341.198820177005, 5531.419200983919, 5543.223948647193, 5543.251661025791, 5552.805651802168, 5552.972235138839, 5062.240663900445, 5112.923306150411, 5138.794448222104, 5151.407588127338, 5156.819511317086, 5620.044592419298, 5622.0, 5624.240727501817, 5631.183478395692, 5633.436656334334, 5121.74391280442, 5147.459516750762, 5152.072626927189, 5360.95461385034, 5417.187421886749, 5306.893862122736, 5311.654742441806, 5314.415414304501, 5315.176147697113, 5315.335583052119, 5259.579233661374, 5273.578113750891, 5281.498257665516, 5287.444818294024, 5292.470752924677, 5268.157094864803, 5268.262443257947, 5270.025045366543, 5277.63056586043, 5277.868053298698, 4517.390152329459, 4518.638508919278, 4520.344550040226, 4544.091181763661, 4578.221702310615, 3960.0, 3984.20315936808, 4014.297497937849, 4025.3156963316305, 4034.455348527911, 4649.442066951988, 4653.650976176733, 4666.113438446684, 4666.230072038075, 4711.057788442326, 5321.122014867504, 5349.919751203735, 5474.233607294982, 5482.698451585201, 5504.559635229172, 4619.538046195354, 4625.976870115628, 4635.049814787961, 4637.721736695809, 4642.326862604903, 4917.557419832232, 4936.827211047596, 4938.407391113017, 4948.727819969864, 4949.381327334083, 5069.264956581275, 5087.465816089258, 5089.770960306795, 5095.235714642833, 5135.794568217229, 5477.178423236546, 5478.096114141122, 5485.835424937259, 5489.258950041853, 5490.039243132515, 4708.835190768306, 4931.580815630568, 4967.05625931072, 5026.994601079726, 5034.798608055783, 5307.787688492417, 5317.468253174807, 5317.867053323698, 5318.920216196838, 5323.760430780701, 5394.811181608625, 5396.892062158813, 5397.190421436816, 5400.324959380077, 5405.756740946588, 5132.230165475208, 5203.713795741271, 5241.423443421297, 5242.18746094356, 5252.5535329497425, 5194.272801807825, 5201.817936372209, 5248.553872920845, 5253.579713622978, 5325.467453254643, 5136.948630513647, 5241.89516209666, 5243.8164664236565, 5250.238715386171, 5255.211718242142, 5215.087359711959, 5215.791368345375, 5216.478352164753, 5220.0603891298415, 5299.6290259681455, 5076.340075790124, 5109.259157422079, 5145.45972672864, 5171.379434467888, 5175.611829112907], "value": 4928.025738511928, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.1574111066719, 720.4380583145148, 769.8421823526178, 773.8374941262334, 779.357030449879, 24657.753422465794, 35293.64706352936, 35543.93368198955, 38676.41985370222, 38867.22265554687, 35173.64826351736, 35601.64398356022, 35671.2865742685, 35720.64279357206, 35779.0, 7357.852842943138, 7452.105747310303, 7474.7757567273065, 7489.588072656002, 7496.550206987571, 6567.146270984766, 6810.523263371566, 9126.45241285525, 9362.765930851716, 9642.13220810127, 9374.0, 9400.20098291646, 9411.10594493522, 9411.43531388119, 9412.435253884754, 9309.44143351401, 9342.299327550461, 9342.906570934272, 9343.906560934405, 9351.579178936965, 9078.954605226998, 9126.863097053549, 9130.908690913073, 9136.406133601295, 9140.0, 33503.497447538306, 33611.32777344464, 33638.1590460238, 33658.49512257318, 33673.6632633673, 3377.493375993596, 3406.7104296134858, 3416.7095796857298, 3435.862565497377, 3467.861285548575, 24188.637170442456, 24209.636855447006, 24237.151699690603, 24279.271621851374, 24710.876445617658, 3256.772025958184, 3356.3790698720572, 3371.2246183377715, 3398.932021359584, 3483.773554718935, 163662.0, 163666.0, 163699.0, 163943.0, 164334.0, 35285.823570882494, 42658.14683706308, 42868.14263714708, 42924.785376073545, 42927.35608965868, 37991.0, 38087.0, 38110.61889381126, 38138.23723525514, 43283.0, 12356.073294502949, 12370.072244581692, 12418.627441176599, 12453.813192802116, 12482.875171248354, 9904.405735655884, 9934.45360505179, 9941.552630131662, 9944.602215911427, 9949.204063674888, 10494.527746251437, 12230.633081007583, 12291.877081229251, 12361.93819030917, 12515.749685006249, 4439.689221754446, 4517.390152329459, 4818.060125232358, 5177.430482646906, 5260.763265653055, 902.6254104546671, 920.4109370003204, 922.4603606890045, 925.3060204846365, 955.3360414511848, 13452.663683407993, 13553.728925421436, 13575.117617355038, 13647.249401283025, 13699.589012329647, 979.4573546664033, 1001.8096561653263, 1011.3527342500805, 1021.8160731068479, 1023.1712313026472, 12258.693532661755, 13126.212427254204, 13245.271510066847, 13616.88211948086, 13655.658608534866, 243904.0, 244886.0, 245156.0, 245163.0, 246271.0, 43109.137817244104, 43306.133877322274, 43386.0, 43424.0, 43453.13093738107, 1258.811178323259, 1293.6701141209119, 1294.9611511654666, 1302.7068909495476, 1309.2537253765643, 23689.05243790229, 24053.756727024276, 24512.877435612707, 24732.50534989326, 24811.627825582993, 17656.91171544134, 17688.734668980233, 17725.113744312992, 17727.290908364037, 17797.110144492464, 238417.0, 238721.0, 238820.0, 239173.0, 240259.0, 24495.63256551189, 24991.250262492154, 27205.86397068002, 28038.719612803612, 29855.850720747127, 34635.48046779351, 34912.940686660375, 35410.291794164485, 35773.821130894175, 35998.820005899805, 29962.550561741155, 29986.400271994, 30183.0, 30421.543676845307, 31378.686213137575, 29915.700842991293, 30353.69646303509, 30512.08463746091, 30602.234944125685, 31113.533297001017, 29707.851460742557, 30306.696933031268, 30537.847310763304, 30632.387352253278, 30800.0, 23404.76595234094, 25404.745952540237, 25442.0, 26268.868655657363, 27071.45857082887, 21020.159193632084, 21413.357599272047, 21558.568828623025, 21618.6757198639, 21720.131194752033], "value": 15111.442708038758, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.81537677291664, 392.88802691232985, 395.7922090902276, 417.7514378944528, 425.51916334541966, 12617.495300188004, 15893.602659933507, 17561.297548098075, 19595.314164004263, 19613.607727845454, 13006.479740810357, 13396.93301533491, 16498.0, 17367.13164341784, 18408.723869141973, 1673.71546837038, 5727.599068065248, 6495.123158373606, 6744.325567443266, 6939.236683964785, 6718.798436046926, 6840.589564626113, 6882.105326307573, 6890.345417185385, 6893.758718444856, 6966.198887127995, 6989.301069893021, 6996.3003699630135, 6997.510174287802, 7004.194517630487, 6856.348646878539, 6916.3429474199875, 6927.445804335666, 6991.335823096798, 6991.615461149635, 6562.179727534059, 6789.626570538619, 6790.422814060761, 6793.116894803693, 6797.52417330787, 22028.11887524513, 22036.33890983273, 22281.66577501339, 22586.322410327717, 22643.0, 2308.9653655195184, 2345.1909091363623, 2365.8580485170946, 2388.0209114263243, 2404.1345115758313, 13505.324733763273, 13887.722245555133, 14107.153570785786, 14833.70332593353, 14890.627734306621, 1864.1611274926338, 1882.1718443884783, 1916.9520761980923, 1935.9545845243551, 1961.4998175465307, 90648.54675726645, 92162.53918730431, 92327.53836230843, 92402.53798731031, 94622.05377946202, 15876.2061896907, 16085.517434476984, 16137.354505819636, 16241.350345986028, 16736.6652666946, 28768.71231287702, 28906.13281601513, 28955.855220724185, 28960.13119606415, 28987.85506072498, 6985.196702379189, 8129.3090087343235, 8238.299744521782, 8564.785880353042, 8605.289333859813, 5935.703214839327, 5983.43157400055, 5987.461128498369, 6003.519718422515, 6148.44663980244, 8961.0, 8968.775780605538, 8969.955150224207, 9043.23132533742, 9287.349885508085, 3357.4292370297107, 3357.5467311913067, 3644.9635503645154, 3695.5565332160313, 3765.378712512405, 776.1733753552448, 802.5144787403536, 804.7384600005022, 807.6405999330359, 827.7930517370658, 17864.821351786577, 18379.356722514647, 19117.235310587697, 19221.80778192228, 19555.31556395519, 793.1988691421591, 804.3685706720313, 813.0649752784345, 813.8819871118654, 825.1789469477787, 9824.754381140528, 10387.584496620051, 10708.250422470508, 11352.659420217407, 11894.98892594122, 279857.0, 280098.0, 280323.0, 280414.0, 280551.0, 66846.0, 84786.0, 93162.53418732862, 94948.60616726037, 95437.52281238549, 1079.8434227037035, 1153.7404084081015, 1173.9471723772622, 1210.461344701617, 1212.42409855318, 16636.251368688198, 16807.0, 17496.387626433014, 17770.644587107927, 18090.638187236444, 39010.609893901834, 43163.35254971241, 43484.56515434805, 43611.345829811944, 44324.55675443333, 51785.74107129591, 54636.72681636566, 54761.0, 55052.0731774386, 55667.44332556622, 6392.9041064385, 8375.832483350421, 10452.804910968782, 11210.66368008961, 11478.82781758291, 13135.277559734306, 13570.253636050113, 13574.185548867099, 13655.795163072364, 13803.0, 11471.655850324503, 11591.76816463683, 11732.706682332668, 11831.408429578314, 11992.160548761503, 11258.7748245033, 11376.0330371916, 11505.884941150816, 11507.079433645456, 11596.768064638829, 11461.942690286494, 11559.537618495166, 11817.645470635895, 12213.816792748294, 12244.693882653006, 10867.565297388015, 10913.199322112081, 11046.944765276123, 11488.425578720864, 11497.1377146716, 11111.11111111093, 11326.0, 11376.829347559958, 11412.087033037504, 11743.17797754149], "value": 9824.39874527814, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1483.3176738700197, 1489.6648254142813, 1508.5323549699594, 1511.2066165263236, 1514.3185566495074, 9445.244380449565, 10142.54358553865, 10150.54322555485, 10166.237532185089, 10168.74578135547, 9169.724908252763, 9432.434053956767, 9432.952835235832, 9433.481158536279, 9452.527373631325, 1951.4340841156047, 1990.0547240061, 1992.9402117936486, 1996.5906989067207, 1998.060911371653, 1940.5633732410236, 1954.4722924810292, 1966.48871293464, 1968.3209292793963, 1969.4879331373802, 1920.030384655747, 1924.028365675332, 1924.5669724311988, 1926.5954149628524, 1930.4208737378801, 1815.4281401358596, 1839.1264149529, 1846.1138653446421, 1848.7504186934725, 1848.92604295828, 1899.259288877339, 1900.9049547522568, 1921.7597800274966, 1934.6034063017048, 1963.577830766392, 9631.133198012143, 9695.466749328783, 9707.757306067404, 9714.514274286257, 9720.368176068532, 4627.768611569441, 4767.833125840613, 4769.35613692154, 4771.71369717818, 4775.617950563947, 2533.7719605235616, 2694.1648089092446, 2754.256350785277, 2763.322985868455, 2779.2634951737805, 966.1546147121269, 1017.3946501831399, 1021.6934919524113, 1043.2905624175557, 1064.7391389109719, 12353.258804471761, 12583.811242831456, 12726.80909786354, 13881.097728647606, 13911.373988170557, 3837.1558257183374, 3903.551091624443, 3945.1715139820385, 3955.4264631628253, 3958.089639382958, 10520.105791007696, 10603.89396106029, 10621.150307975344, 10632.25574209798, 10634.30876992993, 3919.8236079375924, 4020.115574573589, 4351.73889566627, 4651.813927442932, 4652.906941861143, 4386.956130438719, 4466.1067786442845, 4468.776561171929, 4471.19518486669, 4479.193745125844, 3121.7034381733697, 3218.8229647369153, 3267.2158681916644, 3287.474004159323, 3293.5718356613966, 825.7894236969535, 850.4769566716425, 862.2153840005565, 863.3395452478859, 867.9566021698889, 660.1550015979553, 683.5215349255541, 691.0670594697219, 693.3447891742356, 733.3949491669395, 5159.845204643867, 5286.36563612369, 5592.580556458201, 5915.792947246911, 6126.295476020226, 910.3127139010005, 922.2667978956746, 934.4720233068294, 941.4445477168504, 980.857775622545, 3625.873094441682, 3685.852565897334, 3733.887983360449, 3739.8878033659034, 3762.4168253920684, 11519.654410367702, 11786.469608867621, 11942.0, 11944.283342999448, 11974.101942354358, 11824.054075674097, 11835.28988260707, 11839.467223974942, 11847.170698051226, 11860.762784744256, 8140.470869393471, 8440.78898027542, 8613.095624959415, 8683.0, 8919.152680495343, 5590.912031208787, 5850.356460789225, 5946.762129514771, 5948.613340132878, 6075.210222671025, 10276.845847312146, 10600.840987385041, 10708.196885233483, 10742.355458672504, 10905.291156074829, 10764.946175269073, 10770.569177232823, 10974.341539507655, 11047.889521104686, 11061.557537698724, 7832.0601527817025, 8028.357731381592, 8034.879476807736, 8046.959765201136, 8051.2351326623875, 8777.0, 8812.823743524965, 8813.074627164311, 8859.335549833659, 8863.778405539913, 7867.291943725092, 7956.0, 7987.440879138405, 8041.597920103854, 8116.75649730509, 7581.355584775356, 7689.346405555367, 7735.574543400167, 7783.0, 7944.364450844034, 6356.269029061532, 6407.135036769976, 6410.262819775786, 6415.454686351713, 6415.967920160556, 4711.220548666004, 4879.34128892595, 4880.365552478155, 4900.166971614905, 4921.409430868319, 4920.827771027997, 4956.752162391938, 5009.674371165863, 5091.159958606937, 5259.342582177228], "value": 4360.265088286727, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.5907930943214, 362.322417588927, 363.99818000909994, 373.54241054707984, 376.0354690219586, 4652.837150699726, 4694.248920172773, 4719.504452032538, 4737.620990320775, 4761.976190119053, 4627.097715945383, 4651.697524693083, 4660.883477913046, 4688.179568575494, 4710.599599034086, 3761.398176291794, 3803.353429916921, 3804.7717136971733, 3813.161104556993, 3925.1953349563414, 3838.2899163654674, 3874.0, 3885.8834234972855, 3891.6886649068147, 3940.822662980173, 3903.687704983609, 3905.9258703856526, 3927.2145570885796, 3930.3318435865826, 3935.9606403936023, 3920.72576412667, 3952.2490726761825, 3955.9011024724323, 3961.3463778476516, 3966.6231707987695, 3476.6523347665284, 3630.43728222126, 3655.744097913147, 3657.7073834093208, 3673.577538583044, 4494.460664720222, 4499.75251361175, 4523.592876641118, 4536.432945881765, 4546.4087569350795, 4482.708623939434, 4484.439445069366, 4495.707778994388, 4503.099380123988, 4515.977420112911, 4704.55306745862, 4847.878803029917, 4884.338035770514, 4886.973735515546, 4916.336294600219, 3973.4635824163947, 3976.940345894785, 3983.26309632716, 4004.8598299059395, 4006.4390985262085, 4844.498205556289, 4961.875953101129, 4969.254611808222, 5093.668911520739, 5122.233993643428, 4002.9799851000557, 4035.4552135461336, 4050.2709512287483, 4060.959390406117, 4076.286649836267, 4109.589041095926, 4122.9381559276635, 4132.648724858361, 4141.0, 4150.402095193373, 4136.358864375967, 4274.294741367702, 4441.311596702451, 4471.272523760504, 4474.306482495218, 4860.562549370574, 4879.170541008037, 4893.363862697826, 4894.608431325557, 4914.557689807934, 1438.3743071763815, 1451.6733734909772, 1452.1722618107788, 1455.4396557325506, 1463.1367493179075, 1028.8456731490337, 1083.9214981093705, 1102.9338239705482, 1104.5140138339104, 1123.9325640461598, 4262.211490874136, 4286.6497053428075, 4304.849330273425, 4332.978335108304, 4343.1747967886, 5035.697858128451, 5036.312835200249, 5037.319961805183, 5048.0, 5060.2156665716875, 4016.8393264269102, 4288.678349123828, 4296.598068877351, 4308.6983911126545, 4357.782110894443, 2624.3307956470976, 2659.7739192168497, 2664.9733502665113, 2666.2534490342737, 2684.6644169478814, 4721.6458765592715, 4741.668083234141, 4743.762811859393, 4756.072565849695, 4757.0, 4930.975345123252, 5114.795408183631, 5159.664621799571, 5180.922286165635, 5192.299039629677, 4658.254679251304, 4667.13657973276, 4710.62315014798, 4717.169698181133, 4736.076465089274, 5020.397552293602, 5036.622253331088, 5066.670666406671, 5119.257707632447, 5162.225666150108, 4709.5055019223855, 4954.20732682769, 4977.656032871032, 4984.127777638972, 4988.201887697951, 4517.593416592523, 4593.356930029865, 4622.95983403745, 4728.007118505015, 4739.113926580171, 4052.2908491013363, 4112.848402447319, 4145.176122506087, 4170.520390155171, 4184.748915065105, 5061.848144555669, 5064.265681476091, 5072.467390924047, 5078.825733916302, 5102.974485127551, 4727.7163370197895, 4806.8077276909935, 4852.2479015752615, 4861.319415281792, 4924.704517728947, 4847.491013443538, 4854.0, 4857.0, 4878.804383129056, 4893.21708526634, 4774.880627984328, 4795.729131780151, 4814.927776083291, 4819.759012049313, 4830.53642642262, 4607.792649330855, 4848.648405523389, 4866.0, 4903.215485522299, 4929.630277729257, 4753.811547113221, 4755.286706993978, 4766.737829419415, 4777.474477807508, 4790.7365094920115], "value": 3860.123556086362, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.5772305724335, 672.7880717573964, 677.6577828196762, 678.3758941773568, 699.0946723992432, 12504.437300321497, 13796.0, 13938.0, 13948.302584870755, 13951.860481395182, 12369.505219791197, 12757.489700411996, 13008.674783130426, 13157.934210328958, 13184.143030702997, 823.6293667849477, 843.6541018182546, 847.2290215903529, 847.6651722569582, 848.1899785704637, 841.6044459104211, 842.4313588327885, 864.8097418567905, 876.7457437343163, 877.0834477970504, 905.1717678324359, 905.6241659711212, 906.3112034853493, 906.5467266366817, 906.9841777209501, 899.8560230363111, 899.9460032398044, 899.95050272235, 899.9730008099734, 900.275278400887, 674.2482132422314, 674.2919934069208, 674.4840197249108, 674.5244602555186, 674.9325067493261, 12663.430145643468, 12697.238165709994, 13285.800712989312, 13304.06871518994, 13319.26744029078, 13593.184408935496, 14108.365123569463, 14256.429742810275, 14257.71484570313, 14329.49846755369, 9362.719118426457, 9465.100815422524, 9642.566084526214, 9808.264380171444, 9831.754206144831, 3123.0, 3131.9217019574694, 3167.319026409333, 3172.698593633601, 3209.4383482890635, 63377.0, 63534.364656353304, 63798.681006595136, 64002.359976400105, 64958.350416495705, 10164.4917754112, 10333.121684656888, 10688.86222755452, 10813.783724325469, 10858.891411085788, 18216.0, 18290.0, 18519.35182268614, 19179.61640767177, 20012.0, 6206.648768949757, 6368.140301059298, 6378.0, 6396.968015159894, 6439.259485159173, 3479.0, 3546.627604101584, 3600.0639833642917, 3651.2879988402005, 3654.9634503655157, 2746.231055304518, 2818.070036887822, 2826.1804076817903, 2841.6732075811547, 2998.835064071497, 515.6055617452652, 520.6043407010624, 521.0386836287045, 526.3447008474474, 532.2096686420663, 609.2939768647768, 613.8404014956144, 621.8476473263988, 627.4948666323562, 634.8539835837784, 8743.038265790758, 9100.726978190532, 9177.128172823572, 9211.63153473867, 9465.574049167804, 580.4601720400068, 587.5857520448074, 589.4253103224407, 598.1088178613921, 603.6528995827417, 4044.130511939947, 4120.567340429212, 4242.300020496584, 4471.575200355961, 4499.10017996402, 58672.706636466544, 61474.0, 61803.38196617976, 63386.366136338045, 63386.6830665853, 55506.444935550935, 56203.43796561982, 56264.0, 56306.71846640741, 56588.717056414454, 49010.754946226465, 49134.75432622814, 49912.75043624759, 50102.49897501051, 50327.74836125796, 8957.820843583222, 9035.774105647148, 9207.0, 9281.67514137002, 9779.755506112404, 29408.705912940597, 32168.0, 32760.0, 33185.66814331922, 33323.666763332054, 44173.0, 44627.77686111549, 44630.776846115565, 44807.0, 45160.41938532267, 11869.050475962074, 12114.75770484603, 12246.203996740183, 12261.938690306491, 12304.507819687113, 12801.871981280441, 13050.934745326213, 13063.412146453242, 13324.067315287837, 13952.651183720489, 12041.217320874115, 12415.130940834055, 12528.123031387715, 12547.560835371083, 12725.681857953256, 11677.0, 12076.51693932268, 12293.75412491763, 12306.507739690313, 12455.93772031134, 10856.185786065918, 10947.781044379228, 11236.831447528457, 11527.002979225294, 11631.0, 9653.420794752337, 10147.0, 10352.948235258775, 10549.89450105489, 10682.62610808618, 10017.849732253877, 10250.231232657432, 10342.0, 10352.585896564053, 10357.482125893524], "value": 6408.698790916811, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 119.0, 117.0, 118.0, 117.0, 117.0, 115.0, 116.0, 115.0, 116.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 132.0, 127.0, 170.0, 125.0, 133.0, 131.0, 123.0, 148.0, 126.0], "value": 137.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 164.0, 162.0, 162.0, 164.0, 162.0, 161.0, 163.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 116.0, 77.0, 78.0, 79.0, 75.0, 92.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 109.0, 84.0, 85.0, 85.0, 111.0, 84.0, 84.0, 117.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 113.0, 113.0, 114.0, 113.0, 114.0, 113.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 149.0, 149.0, 149.0, 149.0, 149.0, 150.0, 149.0, 149.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 93.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 69.0, 67.0, 66.0, 67.0, 67.0, 69.0], "value": 66.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 55.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 88.0, 86.0, 85.0, 83.0, 85.0, 85.0, 85.0, 91.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 135.0, 131.0, 132.0, 133.0, 133.0, 131.0, 178.0, 139.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 187.0, 181.0, 179.0, 180.0, 182.0, 181.0, 182.0, 178.0, 176.0], "value": 181.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 67.0, 67.0, 68.0, 69.0, 71.0, 66.0, 66.0], "value": 67.9, "unit": "score"}]}]} 09:33:04 INFO - Return code: 0 09:33:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:33:04 ERROR - # TBPL SUCCESS # 09:33:04 INFO - Running post-action listener: _resource_record_post_action 09:33:04 INFO - [mozharness: 2017-03-10 17:33:04.818701Z] Finished run-tests step (success) 09:33:04 INFO - Running post-run listener: _resource_record_post_run 09:33:04 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 360710144; Read time: 36; Write time: 228272 09:33:04 INFO - TinderboxPrint: CPU usage
13.2% 09:33:04 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 36 09:33:04 INFO - TinderboxPrint: I/O write bytes / time
360,710,144 / 228,272 09:33:04 INFO - TinderboxPrint: CPU idle
8,343.5 (86.7%) 09:33:04 INFO - TinderboxPrint: CPU user
1,226.2 (12.7%) 09:33:04 INFO - TinderboxPrint: Swap in / out
0 / 0 09:33:04 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105566208; Read time: 0; Write time: 95264 09:33:04 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 255143936; Read time: 36; Write time: 133008 09:33:05 INFO - Running post-run listener: _upload_blobber_files 09:33:05 INFO - Blob upload gear active. 09:33:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:33:05 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 09:33:05 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'] 09:33:05 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 09:33:05 INFO - (blobuploader) - INFO - Open directory for files ... 09:33:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:33:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:33:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:33:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:06 INFO - (blobuploader) - INFO - Done attempting. 09:33:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:33:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:33:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:33:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:07 INFO - (blobuploader) - INFO - Done attempting. 09:33:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:33:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:33:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:33:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:08 INFO - (blobuploader) - INFO - Done attempting. 09:33:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:33:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:33:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:33:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:12 INFO - (blobuploader) - INFO - Done attempting. 09:33:12 INFO - (blobuploader) - INFO - Iteration through files over. 09:33:12 INFO - Return code: 0 09:33:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:33:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:33:12 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad57668ce89a8e72dbb1bc743ee4bf2e641ef942a95444d418cdeb61ed4c755dddad77c6783e355f8987239b998b40cf4f738764e57a377e18b8b25126c96f9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/80dcd68a4c5bb6fafff6805b2de3a7042a2756dafae76bb65a84ddfd25ba08ba7b9a559fdbedd0696da45de61c4021d440a13457116de275fb45c0645dc19d8b", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e87133a8dfa30f2c50452faeeb653e2d2a1743efbef33b9220a5d33eb3d7e72978d7ae75b16865afe974fda5b559122272f8e54cdd06b8eef6c50d4108dec17", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/96f99f4adac5ab2e97a84333308b37880831a5fb7547eb956acf41d60ea37f2b24b8fee0f05b6851c4feab50c933408efe5a44d6eb69430f6527a33af59f3727"} 09:33:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:33:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:33:12 INFO - Contents: 09:33:12 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad57668ce89a8e72dbb1bc743ee4bf2e641ef942a95444d418cdeb61ed4c755dddad77c6783e355f8987239b998b40cf4f738764e57a377e18b8b25126c96f9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/80dcd68a4c5bb6fafff6805b2de3a7042a2756dafae76bb65a84ddfd25ba08ba7b9a559fdbedd0696da45de61c4021d440a13457116de275fb45c0645dc19d8b", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e87133a8dfa30f2c50452faeeb653e2d2a1743efbef33b9220a5d33eb3d7e72978d7ae75b16865afe974fda5b559122272f8e54cdd06b8eef6c50d4108dec17", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/96f99f4adac5ab2e97a84333308b37880831a5fb7547eb956acf41d60ea37f2b24b8fee0f05b6851c4feab50c933408efe5a44d6eb69430f6527a33af59f3727"} 09:33:12 INFO - Running post-run listener: copy_logs_to_upload_dir 09:33:12 INFO - Copying logs to upload dir... 09:33:12 INFO - mkdir: /builds/slave/test/build/upload/logs 09:33:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.472690 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-03-10 09:33:12.703346) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 09:33:12.706774) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad57668ce89a8e72dbb1bc743ee4bf2e641ef942a95444d418cdeb61ed4c755dddad77c6783e355f8987239b998b40cf4f738764e57a377e18b8b25126c96f9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/80dcd68a4c5bb6fafff6805b2de3a7042a2756dafae76bb65a84ddfd25ba08ba7b9a559fdbedd0696da45de61c4021d440a13457116de275fb45c0645dc19d8b", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e87133a8dfa30f2c50452faeeb653e2d2a1743efbef33b9220a5d33eb3d7e72978d7ae75b16865afe974fda5b559122272f8e54cdd06b8eef6c50d4108dec17", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/96f99f4adac5ab2e97a84333308b37880831a5fb7547eb956acf41d60ea37f2b24b8fee0f05b6851c4feab50c933408efe5a44d6eb69430f6527a33af59f3727"} build_url:https://queue.taskcluster.net/v1/task/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011419 build_url: 'https://queue.taskcluster.net/v1/task/TJxhn-LhQMeWSYhYCNiPlQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad57668ce89a8e72dbb1bc743ee4bf2e641ef942a95444d418cdeb61ed4c755dddad77c6783e355f8987239b998b40cf4f738764e57a377e18b8b25126c96f9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/80dcd68a4c5bb6fafff6805b2de3a7042a2756dafae76bb65a84ddfd25ba08ba7b9a559fdbedd0696da45de61c4021d440a13457116de275fb45c0645dc19d8b", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e87133a8dfa30f2c50452faeeb653e2d2a1743efbef33b9220a5d33eb3d7e72978d7ae75b16865afe974fda5b559122272f8e54cdd06b8eef6c50d4108dec17", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/96f99f4adac5ab2e97a84333308b37880831a5fb7547eb956acf41d60ea37f2b24b8fee0f05b6851c4feab50c933408efe5a44d6eb69430f6527a33af59f3727"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 09:33:12.732457) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 09:33:12.732800) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1489165925.625826-1564335783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004419 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 09:33:12.815648) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 09:33:12.815971) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 09:33:12.816287) ========= ========= Total master_lag: 0.92 =========