builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-034 starttime: 1484214293.63 results: success (0) revision: 97d6f73643940256c0eb61e384c49bf6f6c49847 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 01:44:53.630811) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 01:44:53.631186) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 01:44:53.631455) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 01:44:53.669852) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 01:44:53.670102) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-12 01:44:53-- 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% 223M=0s 2017-01-12 01:44:53 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093377 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 01:44:53.779112) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 01:44:53.779512) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021578 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 01:44:53.829645) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-12 01:44:53.829950) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 97d6f73643940256c0eb61e384c49bf6f6c49847 --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 97d6f73643940256c0eb61e384c49bf6f6c49847 --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=d6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-12 01:44:53,996 truncating revision to first 12 chars 2017-01-12 01:44:53,996 Setting DEBUG logging. 2017-01-12 01:44:53,996 attempt 1/10 2017-01-12 01:44:53,996 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/97d6f7364394?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 01:44:54,787 unpacking tar archive at: mozilla-central-97d6f7364394/testing/mozharness/ program finished with exit code 0 elapsedTime=1.158839 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-12 01:44:55.002168) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 01:44:55.002483) ========= script_repo_revision: 97d6f73643940256c0eb61e384c49bf6f6c49847 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 01:44:55.002853) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 01:44:55.003124) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 01:44:55.013552) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-01-12 01:44:55.013880) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:44:55 INFO - MultiFileLogger online at 20170112 01:44:55 in /builds/slave/test 01:44:55 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 01:44:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:44:55 INFO - {'append_to_log': False, 01:44:55 INFO - 'base_work_dir': '/builds/slave/test', 01:44:55 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 01:44:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:44:55 INFO - 'branch': 'Firefox-Non-PGO', 01:44:55 INFO - 'buildbot_json_path': 'buildprops.json', 01:44:55 INFO - 'config_files': ('talos/linux_config.py',), 01:44:55 INFO - 'default_actions': ('clobber', 01:44:55 INFO - 'read-buildbot-config', 01:44:55 INFO - 'download-and-extract', 01:44:55 INFO - 'populate-webroot', 01:44:55 INFO - 'create-virtualenv', 01:44:55 INFO - 'install', 01:44:55 INFO - 'run-tests'), 01:44:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:44:55 INFO - 'download_minidump_stackwalk': True, 01:44:55 INFO - 'download_symbols': 'ondemand', 01:44:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:44:55 INFO - 'tooltool.py': '/tools/tooltool.py', 01:44:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:44:55 INFO - '/tools/misc-python/virtualenv.py')}, 01:44:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:44:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:44:55 INFO - 'installer_path': 'installer.exe', 01:44:55 INFO - 'log_level': 'info', 01:44:55 INFO - 'log_name': 'talos', 01:44:55 INFO - 'log_to_console': True, 01:44:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:44:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:44:55 INFO - 'opt_config_files': (), 01:44:55 INFO - 'pip_index': False, 01:44:55 INFO - 'sps_profile': False, 01:44:55 INFO - 'sps_profile_interval': 0, 01:44:55 INFO - 'suite': 'dromaeojs', 01:44:55 INFO - 'system_bits': '32', 01:44:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:44:55 INFO - 'title': 'talos-linux64-ix-034', 01:44:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:44:55 INFO - 'use_talos_json': True, 01:44:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:44:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:44:55 INFO - 'work_dir': 'build'} 01:44:55 INFO - [mozharness: 2017-01-12 09:44:55.269890Z] Running clobber step. 01:44:55 INFO - Running pre-action listener: _resource_record_pre_action 01:44:55 INFO - Running main action method: clobber 01:44:55 INFO - rmtree: /builds/slave/test/build 01:44:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:44:55 INFO - Running post-action listener: _resource_record_post_action 01:44:55 INFO - [mozharness: 2017-01-12 09:44:55.725135Z] Finished clobber step (success) 01:44:55 INFO - [mozharness: 2017-01-12 09:44:55.725253Z] Running read-buildbot-config step. 01:44:55 INFO - Running pre-action listener: _resource_record_pre_action 01:44:55 INFO - Running main action method: read_buildbot_config 01:44:55 INFO - Using buildbot properties: 01:44:55 INFO - { 01:44:55 INFO - "project": "", 01:44:55 INFO - "product": "firefox", 01:44:55 INFO - "who": "cbook@mozilla.com", 01:44:55 INFO - "installer_path": "public/build/target.tar.bz2", 01:44:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 01:44:55 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 01:44:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 01:44:55 INFO - "stage_platform": "linux64", 01:44:55 INFO - "basedir": "/builds/slave/test", 01:44:55 INFO - "buildnumber": 382, 01:44:55 INFO - "platform": "ubuntu64_hw", 01:44:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:44:55 INFO - "slavebuilddir": "test", 01:44:55 INFO - "taskId": "Xo8mAB-VSwGM0qdfueQjeg", 01:44:55 INFO - "branch": "mozilla-central", 01:44:55 INFO - "script_repo_revision": "production", 01:44:55 INFO - "revision": "97d6f73643940256c0eb61e384c49bf6f6c49847", 01:44:55 INFO - "slavename": "talos-linux64-ix-034", 01:44:55 INFO - "repo_path": "mozilla-central" 01:44:55 INFO - } 01:44:55 INFO - Finding installer, test and symbols from parent task. 01:44:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xo8mAB-VSwGM0qdfueQjeg'}, attempt #1 01:44:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xo8mAB-VSwGM0qdfueQjeg'}, attempt #1 01:44:56 INFO - Task dependencies: dYPnyWojQpW0oS1w5JiqRg 01:44:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dYPnyWojQpW0oS1w5JiqRg'}, attempt #1 01:44:57 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/target.tar.bz2 01:44:57 INFO - Set test_url: https://queue.taskcluster.net/v1/task/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/test_packages.json 01:44:57 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/target.crashreporter-symbols.zip 01:44:57 INFO - Running post-action listener: _resource_record_post_action 01:44:57 INFO - [mozharness: 2017-01-12 09:44:57.126518Z] Finished read-buildbot-config step (success) 01:44:57 INFO - [mozharness: 2017-01-12 09:44:57.126735Z] Running download-and-extract step. 01:44:57 INFO - Running pre-action listener: _resource_record_pre_action 01:44:57 INFO - Running main action method: download_and_extract 01:44:57 INFO - mkdir: /builds/slave/test/build/tests 01:44:57 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')]} 01:44:57 INFO - trying https://queue.taskcluster.net/v1/task/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/target.test_packages.json 01:44:57 INFO - Downloading https://queue.taskcluster.net/v1/task/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:44:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:44:57 INFO - Downloaded 896 bytes. 01:44:57 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:44:57 INFO - Using the following test package requirements: 01:44:57 INFO - {u'common': [u'target.common.tests.zip'], 01:44:57 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:44:57 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:44:57 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:44:57 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:44:57 INFO - u'mozbase': [u'target.common.tests.zip'], 01:44:57 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:44:57 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:44:57 INFO - u'web-platform': [u'target.common.tests.zip', 01:44:57 INFO - u'target.web-platform.tests.zip'], 01:44:57 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:44:57 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 01:44:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/target.common.tests.zip 01:44:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:44:57 INFO - Fetch https://queue.taskcluster.net/v1/task/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/target.common.tests.zip into memory 01:44:58 INFO - Expected file size: 20260791 01:44:58 INFO - Obtained file size: 20260791 01:45:02 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 01:45:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/target.common.tests.zip 01:45:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:45:02 INFO - Fetch https://queue.taskcluster.net/v1/task/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/target.common.tests.zip into memory 01:45:03 INFO - Expected file size: 20260791 01:45:03 INFO - Obtained file size: 20260791 01:45:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/target.talos.tests.zip 01:45:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:45:07 INFO - Fetch https://queue.taskcluster.net/v1/task/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/target.talos.tests.zip into memory 01:45:08 INFO - Expected file size: 14403532 01:45:08 INFO - Obtained file size: 14403532 01:45:08 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')]} 01:45:08 INFO - trying https://queue.taskcluster.net/v1/task/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/target.tar.bz2 01:45:08 INFO - Downloading https://queue.taskcluster.net/v1/task/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:45:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:45:09 INFO - Downloaded 55991709 bytes. 01:45:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/target.tar.bz2 01:45:09 INFO - mkdir: /builds/slave/test/properties 01:45:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:45:09 INFO - Writing to file /builds/slave/test/properties/build_url 01:45:09 INFO - Contents: 01:45:09 INFO - build_url:https://queue.taskcluster.net/v1/task/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/target.tar.bz2 01:45:09 INFO - Running post-action listener: _resource_record_post_action 01:45:09 INFO - Running post-action listener: set_extra_try_arguments 01:45:09 INFO - [mozharness: 2017-01-12 09:45:09.911761Z] Finished download-and-extract step (success) 01:45:09 INFO - [mozharness: 2017-01-12 09:45:09.911858Z] Running populate-webroot step. 01:45:09 INFO - Running pre-action listener: _resource_record_pre_action 01:45:09 INFO - Running main action method: populate_webroot 01:45:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:45:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:45:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:45:09 INFO - '--tppagecycles', 01:45:09 INFO - '7'], 01:45:09 INFO - 'tests': ['tsvgm']}}, 01:45:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:45:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:45:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:45:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:45:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:45:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:45:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:45:09 INFO - 'talos_options': ['--disable-e10s'], 01:45:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:45:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:45:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:45:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:45:09 INFO - 'talos_options': ['--disable-e10s'], 01:45:09 INFO - 'tests': ['damp', 'tps']}, 01:45:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:45:09 INFO - 'tests': ['damp', 'tps']}, 01:45:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:45:09 INFO - 'tests': ['dromaeo_dom']}, 01:45:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:45:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:45:09 INFO - 'tests': ['basic_compositor_video']}, 01:45:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:45:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:45:09 INFO - 'tests': ['a11yr', 01:45:09 INFO - 'ts_paint', 01:45:09 INFO - 'tpaint', 01:45:09 INFO - 'sessionrestore', 01:45:09 INFO - 'sessionrestore_no_auto_restore', 01:45:09 INFO - 'tabpaint']}, 01:45:09 INFO - 'other-e10s': {'tests': ['a11yr', 01:45:09 INFO - 'ts_paint', 01:45:09 INFO - 'tpaint', 01:45:09 INFO - 'sessionrestore', 01:45:09 INFO - 'sessionrestore_no_auto_restore', 01:45:09 INFO - 'tabpaint']}, 01:45:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:45:09 INFO - 'ts_paint', 01:45:09 INFO - 'tpaint', 01:45:09 INFO - 'sessionrestore', 01:45:09 INFO - 'sessionrestore_no_auto_restore', 01:45:09 INFO - 'tabpaint']}, 01:45:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:45:09 INFO - 'ts_paint', 01:45:09 INFO - 'tpaint', 01:45:09 INFO - 'sessionrestore', 01:45:09 INFO - 'sessionrestore_no_auto_restore', 01:45:09 INFO - 'tabpaint']}, 01:45:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:45:09 INFO - 'tests': ['a11yr', 01:45:09 INFO - 'ts_paint', 01:45:09 INFO - 'tpaint', 01:45:09 INFO - 'sessionrestore', 01:45:09 INFO - 'sessionrestore_no_auto_restore', 01:45:09 INFO - 'tabpaint']}, 01:45:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:45:09 INFO - 'tests': ['a11yr', 01:45:09 INFO - 'ts_paint', 01:45:09 INFO - 'tpaint', 01:45:09 INFO - 'sessionrestore', 01:45:09 INFO - 'sessionrestore_no_auto_restore', 01:45:09 INFO - 'tabpaint']}, 01:45:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:45:09 INFO - 'tests': ['tsvgx', 01:45:09 INFO - 'tsvgr_opacity', 01:45:09 INFO - 'tart', 01:45:09 INFO - 'tscrollx', 01:45:09 INFO - 'cart', 01:45:09 INFO - 'tsvg_static']}, 01:45:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:45:09 INFO - 'tsvgr_opacity', 01:45:09 INFO - 'tart', 01:45:09 INFO - 'tscrollx', 01:45:09 INFO - 'cart', 01:45:09 INFO - 'tsvg_static']}, 01:45:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:45:09 INFO - 'talos_options': ['--disable-e10s'], 01:45:09 INFO - 'tests': ['tp5o']}, 01:45:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:45:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:45:09 INFO - 'talos_options': ['--disable-e10s', 01:45:09 INFO - '--xperf_path', 01:45:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:45:09 INFO - 'tests': ['tp5n']}, 01:45:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:45:09 INFO - 'talos_options': ['--xperf_path', 01:45:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:45:09 INFO - 'tests': ['tp5n']}}, 01:45:09 INFO - 'talos.zip': {'path': '', 01:45:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:45:09 INFO - Running post-action listener: _resource_record_post_action 01:45:09 INFO - [mozharness: 2017-01-12 09:45:09.924905Z] Finished populate-webroot step (success) 01:45:09 INFO - [mozharness: 2017-01-12 09:45:09.924998Z] Running create-virtualenv step. 01:45:09 INFO - Running pre-action listener: _resource_record_pre_action 01:45:09 INFO - Running main action method: create_virtualenv 01:45:09 INFO - Creating virtualenv /builds/slave/test/build/venv 01:45:09 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 01:45:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:45:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:45:10 INFO - Using real prefix '/usr' 01:45:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:45:10 INFO - Installing distribute.............................................................................................................................................................................................done. 01:45:12 INFO - Installing pip.................done. 01:45:12 INFO - Return code: 0 01:45:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:45:12 INFO - Reading from file tmpfile_stdout 01:45:12 INFO - Output received: 01:45:12 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) 01:45:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:45:12 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')]} 01:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:12 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')]} 01:45:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x18a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c18630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca1850>, '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 0x1c166d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c16b60>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745', '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 01:45:12 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 01:45:12 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 01:45:12 INFO - Using env: {'DISPLAY': ':0', 01:45:12 INFO - 'HOME': '/home/cltbld', 01:45:12 INFO - 'LANG': 'en_US.UTF-8', 01:45:12 INFO - 'LANGUAGE': 'en_US:en', 01:45:12 INFO - 'LOGNAME': 'cltbld', 01:45:12 INFO - 'MAIL': '/var/mail/cltbld', 01:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:12 INFO - 'MOZ_NO_REMOTE': '1', 01:45:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:12 INFO - 'NO_EM_RESTART': '1', 01:45:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:12 INFO - 'PWD': '/builds/slave/test', 01:45:12 INFO - 'SHELL': '/bin/bash', 01:45:12 INFO - 'SHLVL': '1', 01:45:12 INFO - 'TERM': 'linux', 01:45:12 INFO - 'TMOUT': '86400', 01:45:12 INFO - 'USER': 'cltbld', 01:45:12 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745', 01:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:12 INFO - '_': '/tools/buildbot/bin/python'} 01:45:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:12 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 01:45:12 INFO - Cleaning up... 01:45:12 INFO - Return code: 0 01:45:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:45:12 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')]} 01:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:12 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')]} 01:45:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x18a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c18630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca1850>, '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 0x1c166d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c16b60>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745', '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 01:45:12 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 01:45:12 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 01:45:12 INFO - Using env: {'DISPLAY': ':0', 01:45:12 INFO - 'HOME': '/home/cltbld', 01:45:12 INFO - 'LANG': 'en_US.UTF-8', 01:45:12 INFO - 'LANGUAGE': 'en_US:en', 01:45:12 INFO - 'LOGNAME': 'cltbld', 01:45:12 INFO - 'MAIL': '/var/mail/cltbld', 01:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:12 INFO - 'MOZ_NO_REMOTE': '1', 01:45:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:12 INFO - 'NO_EM_RESTART': '1', 01:45:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:12 INFO - 'PWD': '/builds/slave/test', 01:45:12 INFO - 'SHELL': '/bin/bash', 01:45:12 INFO - 'SHLVL': '1', 01:45:12 INFO - 'TERM': 'linux', 01:45:12 INFO - 'TMOUT': '86400', 01:45:12 INFO - 'USER': 'cltbld', 01:45:12 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745', 01:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:12 INFO - '_': '/tools/buildbot/bin/python'} 01:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:13 INFO - Downloading/unpacking psutil>=3.1.1 01:45:13 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 01:45:13 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 01:45:13 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 01:45:13 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 01:45:13 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 01:45:13 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 01:45:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:45:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:45:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:45:15 INFO - Installing collected packages: psutil 01:45:15 INFO - Running setup.py install for psutil 01:45:15 INFO - building 'psutil._psutil_linux' extension 01:45:15 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 01:45:15 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 01:45:15 INFO - building 'psutil._psutil_posix' extension 01:45:15 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 01:45:15 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 01:45:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:45:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:45:15 INFO - Successfully installed psutil 01:45:15 INFO - Cleaning up... 01:45:15 INFO - Return code: 0 01:45:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:45: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')]} 01:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45: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')]} 01:45:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:15 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 0x18a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c18630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca1850>, '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 0x1c166d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c16b60>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745', '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 01:45:15 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 01:45:15 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 01:45:15 INFO - Using env: {'DISPLAY': ':0', 01:45:15 INFO - 'HOME': '/home/cltbld', 01:45:15 INFO - 'LANG': 'en_US.UTF-8', 01:45:15 INFO - 'LANGUAGE': 'en_US:en', 01:45:15 INFO - 'LOGNAME': 'cltbld', 01:45:15 INFO - 'MAIL': '/var/mail/cltbld', 01:45:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:15 INFO - 'MOZ_NO_REMOTE': '1', 01:45:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:15 INFO - 'NO_EM_RESTART': '1', 01:45:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:15 INFO - 'PWD': '/builds/slave/test', 01:45:15 INFO - 'SHELL': '/bin/bash', 01:45:15 INFO - 'SHLVL': '1', 01:45:15 INFO - 'TERM': 'linux', 01:45:15 INFO - 'TMOUT': '86400', 01:45:15 INFO - 'USER': 'cltbld', 01:45:15 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745', 01:45:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:15 INFO - '_': '/tools/buildbot/bin/python'} 01:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:45:16 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 01:45:16 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 01:45:16 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 01:45:16 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 01:45:16 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 01:45:16 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 01:45:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:45:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:45:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:45:18 INFO - Installing collected packages: mozsystemmonitor 01:45:18 INFO - Running setup.py install for mozsystemmonitor 01:45:18 INFO - Successfully installed mozsystemmonitor 01:45:18 INFO - Cleaning up... 01:45:18 INFO - Return code: 0 01:45:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:45:18 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')]} 01:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:18 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')]} 01:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x18a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c18630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca1850>, '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 0x1c166d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c16b60>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745', '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 01:45:18 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 01:45:18 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 01:45:18 INFO - Using env: {'DISPLAY': ':0', 01:45:18 INFO - 'HOME': '/home/cltbld', 01:45:18 INFO - 'LANG': 'en_US.UTF-8', 01:45:18 INFO - 'LANGUAGE': 'en_US:en', 01:45:18 INFO - 'LOGNAME': 'cltbld', 01:45:18 INFO - 'MAIL': '/var/mail/cltbld', 01:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:18 INFO - 'MOZ_NO_REMOTE': '1', 01:45:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:18 INFO - 'NO_EM_RESTART': '1', 01:45:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:18 INFO - 'PWD': '/builds/slave/test', 01:45:18 INFO - 'SHELL': '/bin/bash', 01:45:18 INFO - 'SHLVL': '1', 01:45:18 INFO - 'TERM': 'linux', 01:45:18 INFO - 'TMOUT': '86400', 01:45:18 INFO - 'USER': 'cltbld', 01:45:18 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745', 01:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:18 INFO - '_': '/tools/buildbot/bin/python'} 01:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:18 INFO - Downloading/unpacking jsonschema==2.5.1 01:45:18 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 01:45:18 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 01:45:18 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 01:45:18 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 01:45:18 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 01:45:18 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 01:45:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:45:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:20 INFO - Downloading functools32-3.2.3-2.tar.gz 01:45:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:45:20 INFO - warning: no files found matching '*.txt' 01:45:20 INFO - no previously-included directories found matching 'build' 01:45:20 INFO - no previously-included directories found matching 'dist' 01:45:20 INFO - no previously-included directories found matching '.git*' 01:45:20 INFO - Installing collected packages: jsonschema, functools32 01:45:20 INFO - Running setup.py install for functools32 01:45:20 INFO - warning: no files found matching '*.txt' 01:45:20 INFO - no previously-included directories found matching 'build' 01:45:20 INFO - no previously-included directories found matching 'dist' 01:45:20 INFO - no previously-included directories found matching '.git*' 01:45:20 INFO - Successfully installed jsonschema functools32 01:45:20 INFO - Cleaning up... 01:45:20 INFO - Return code: 0 01:45:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:45:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c18630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca1850>, '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 0x1c166d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c16b60>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745', '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 01:45:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:45:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:45:20 INFO - Using env: {'DISPLAY': ':0', 01:45:20 INFO - 'HOME': '/home/cltbld', 01:45:20 INFO - 'LANG': 'en_US.UTF-8', 01:45:20 INFO - 'LANGUAGE': 'en_US:en', 01:45:20 INFO - 'LOGNAME': 'cltbld', 01:45:20 INFO - 'MAIL': '/var/mail/cltbld', 01:45:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:20 INFO - 'MOZ_NO_REMOTE': '1', 01:45:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:20 INFO - 'NO_EM_RESTART': '1', 01:45:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:20 INFO - 'PWD': '/builds/slave/test', 01:45:20 INFO - 'SHELL': '/bin/bash', 01:45:20 INFO - 'SHLVL': '1', 01:45:20 INFO - 'TERM': 'linux', 01:45:20 INFO - 'TMOUT': '86400', 01:45:20 INFO - 'USER': 'cltbld', 01:45:20 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745', 01:45:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:20 INFO - '_': '/tools/buildbot/bin/python'} 01:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:45:21 INFO - Cleaning up... 01:45:21 INFO - Return code: 0 01:45:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:45:21 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')]} 01:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:21 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')]} 01:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:21 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 0x18a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c18630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca1850>, '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 0x1c166d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c16b60>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745', '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 01:45:21 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 01:45:21 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 01:45:21 INFO - Using env: {'DISPLAY': ':0', 01:45:21 INFO - 'HOME': '/home/cltbld', 01:45:21 INFO - 'LANG': 'en_US.UTF-8', 01:45:21 INFO - 'LANGUAGE': 'en_US:en', 01:45:21 INFO - 'LOGNAME': 'cltbld', 01:45:21 INFO - 'MAIL': '/var/mail/cltbld', 01:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:21 INFO - 'MOZ_NO_REMOTE': '1', 01:45:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:21 INFO - 'NO_EM_RESTART': '1', 01:45:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:21 INFO - 'PWD': '/builds/slave/test', 01:45:21 INFO - 'SHELL': '/bin/bash', 01:45:21 INFO - 'SHLVL': '1', 01:45:21 INFO - 'TERM': 'linux', 01:45:21 INFO - 'TMOUT': '86400', 01:45:21 INFO - 'USER': 'cltbld', 01:45:21 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745', 01:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:21 INFO - '_': '/tools/buildbot/bin/python'} 01:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:21 INFO - Downloading/unpacking blobuploader==1.2.4 01:45:21 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 01:45:21 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 01:45:21 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 01:45:21 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 01:45:21 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 01:45:21 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 01:45:23 INFO - Downloading blobuploader-1.2.4.tar.gz 01:45:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:45:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:45:23 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 01:45:23 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 01:45:23 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 01:45:23 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 01:45:23 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 01:45:23 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 01:45:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:45:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:45:24 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 01:45:24 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 01:45:24 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 01:45:24 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 01:45:24 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 01:45:24 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 01:45:24 INFO - Downloading docopt-0.6.1.tar.gz 01:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:45:24 INFO - Installing collected packages: blobuploader, requests, docopt 01:45:24 INFO - Running setup.py install for blobuploader 01:45:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:45:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:45:24 INFO - Running setup.py install for requests 01:45:24 INFO - Running setup.py install for docopt 01:45:24 INFO - Successfully installed blobuploader requests docopt 01:45:24 INFO - Cleaning up... 01:45:25 INFO - Return code: 0 01:45:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:45:25 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')]} 01:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:25 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')]} 01:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:25 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 0x18a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c18630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca1850>, '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 0x1c166d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c16b60>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745', '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 01:45:25 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 01:45:25 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 01:45:25 INFO - Using env: {'DISPLAY': ':0', 01:45:25 INFO - 'HOME': '/home/cltbld', 01:45:25 INFO - 'LANG': 'en_US.UTF-8', 01:45:25 INFO - 'LANGUAGE': 'en_US:en', 01:45:25 INFO - 'LOGNAME': 'cltbld', 01:45:25 INFO - 'MAIL': '/var/mail/cltbld', 01:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:25 INFO - 'MOZ_NO_REMOTE': '1', 01:45:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:25 INFO - 'NO_EM_RESTART': '1', 01:45:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:25 INFO - 'PWD': '/builds/slave/test', 01:45:25 INFO - 'SHELL': '/bin/bash', 01:45:25 INFO - 'SHLVL': '1', 01:45:25 INFO - 'TERM': 'linux', 01:45:25 INFO - 'TMOUT': '86400', 01:45:25 INFO - 'USER': 'cltbld', 01:45:25 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745', 01:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:25 INFO - '_': '/tools/buildbot/bin/python'} 01:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:45:25 INFO - Running setup.py (path:/tmp/pip-3OsqZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:45:25 INFO - Running setup.py (path:/tmp/pip-zOOJed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:45:25 INFO - Running setup.py (path:/tmp/pip-grRKPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:45:25 INFO - Running setup.py (path:/tmp/pip-MQ6vWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:45:25 INFO - Running setup.py (path:/tmp/pip-OcjhV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:45:25 INFO - Running setup.py (path:/tmp/pip-iHRW5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:45:25 INFO - Running setup.py (path:/tmp/pip-NcHu9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:45:25 INFO - Running setup.py (path:/tmp/pip-ZIMgBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:45:25 INFO - Running setup.py (path:/tmp/pip-75auAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:45:25 INFO - Running setup.py (path:/tmp/pip-Y5bG1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:45:25 INFO - Running setup.py (path:/tmp/pip-kvDQjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:45:26 INFO - Running setup.py (path:/tmp/pip-yjNMZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:45:26 INFO - Running setup.py (path:/tmp/pip-iexEgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:45:26 INFO - Running setup.py (path:/tmp/pip-om5AmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:45:26 INFO - Running setup.py (path:/tmp/pip-9XxOxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:45:26 INFO - Running setup.py (path:/tmp/pip-YAVifR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:45:26 INFO - Running setup.py (path:/tmp/pip-rKMiwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:45:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:45:26 INFO - Running setup.py install for manifestparser 01:45:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:45:26 INFO - Running setup.py install for mozcrash 01:45:26 INFO - Running setup.py install for mozdebug 01:45:26 INFO - Running setup.py install for mozdevice 01:45:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:45:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:45:26 INFO - Running setup.py install for mozfile 01:45:26 INFO - Running setup.py install for mozhttpd 01:45:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:45:27 INFO - Running setup.py install for mozinfo 01:45:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:45:27 INFO - Running setup.py install for mozInstall 01:45:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:45:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:45:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:45:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:45:27 INFO - Running setup.py install for mozleak 01:45:27 INFO - Running setup.py install for mozlog 01:45:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:45:27 INFO - Running setup.py install for moznetwork 01:45:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:45:27 INFO - Running setup.py install for mozprocess 01:45:27 INFO - Running setup.py install for mozprofile 01:45:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:45:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:45:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:45:27 INFO - Running setup.py install for mozrunner 01:45:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:45:27 INFO - Running setup.py install for mozscreenshot 01:45:28 INFO - Running setup.py install for moztest 01:45:28 INFO - Running setup.py install for mozversion 01:45:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:45:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:45:28 INFO - Cleaning up... 01:45:28 INFO - Return code: 0 01:45:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:45:28 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')]} 01:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:28 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')]} 01:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:28 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 0x18a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c18630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca1850>, '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 0x1c166d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c16b60>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745', '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 01:45:28 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 01:45:28 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 01:45:28 INFO - Using env: {'DISPLAY': ':0', 01:45:28 INFO - 'HOME': '/home/cltbld', 01:45:28 INFO - 'LANG': 'en_US.UTF-8', 01:45:28 INFO - 'LANGUAGE': 'en_US:en', 01:45:28 INFO - 'LOGNAME': 'cltbld', 01:45:28 INFO - 'MAIL': '/var/mail/cltbld', 01:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:28 INFO - 'MOZ_NO_REMOTE': '1', 01:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:28 INFO - 'NO_EM_RESTART': '1', 01:45:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:28 INFO - 'PWD': '/builds/slave/test', 01:45:28 INFO - 'SHELL': '/bin/bash', 01:45:28 INFO - 'SHLVL': '1', 01:45:28 INFO - 'TERM': 'linux', 01:45:28 INFO - 'TMOUT': '86400', 01:45:28 INFO - 'USER': 'cltbld', 01:45:28 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745', 01:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:28 INFO - '_': '/tools/buildbot/bin/python'} 01:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:45:28 INFO - Running setup.py (path:/tmp/pip-rglkxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:45:28 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)) 01:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:45:28 INFO - Running setup.py (path:/tmp/pip-sOP2yF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:45:28 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)) 01:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:45:28 INFO - Running setup.py (path:/tmp/pip-2uBMSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:45:28 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)) 01:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:45:28 INFO - Running setup.py (path:/tmp/pip-TQ3FQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:45:28 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)) 01:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:45:28 INFO - Running setup.py (path:/tmp/pip-U1JBID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:45:28 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)) 01:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:45:28 INFO - Running setup.py (path:/tmp/pip-l5lReS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:45:28 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)) 01:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:45:28 INFO - Running setup.py (path:/tmp/pip-hdh3bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:45:29 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)) 01:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:45:29 INFO - Running setup.py (path:/tmp/pip-Z5oZzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:45:29 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)) 01:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:45:29 INFO - Running setup.py (path:/tmp/pip-oZzoW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:45:29 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)) 01:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:45:29 INFO - Running setup.py (path:/tmp/pip-7mPBZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:45:29 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)) 01:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:45:29 INFO - Running setup.py (path:/tmp/pip-wiodSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:45:29 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)) 01:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:45:29 INFO - Running setup.py (path:/tmp/pip-phbthH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 01:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:45:29 INFO - Running setup.py (path:/tmp/pip-ddMdWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:45:29 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)) 01:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:45:29 INFO - Running setup.py (path:/tmp/pip-sMniI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:45:29 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)) 01:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:45:29 INFO - Running setup.py (path:/tmp/pip-JZ1RWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:45:29 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)) 01:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:45:29 INFO - Running setup.py (path:/tmp/pip-CbYUBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:45:29 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)) 01:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:45:29 INFO - Running setup.py (path:/tmp/pip-sP_Jjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:45:29 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)) 01:45:29 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)) 01:45:29 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)) 01:45:29 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)) 01:45:29 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)) 01:45:29 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)) 01:45:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:45:29 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 01:45:29 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 01:45:29 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 01:45:29 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 01:45:29 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 01:45:29 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 01:45:31 INFO - Downloading blessings-1.6.tar.gz 01:45:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:45:31 INFO - Installing collected packages: blessings 01:45:31 INFO - Running setup.py install for blessings 01:45:31 INFO - Successfully installed blessings 01:45:31 INFO - Cleaning up... 01:45:32 INFO - Return code: 0 01:45:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:45:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:45:32 INFO - Reading from file tmpfile_stdout 01:45:32 INFO - Current package versions: 01:45:32 INFO - argparse == 1.2.1 01:45:32 INFO - blessings == 1.6 01:45:32 INFO - blobuploader == 1.2.4 01:45:32 INFO - docopt == 0.6.1 01:45:32 INFO - functools32 == 3.2.3-2 01:45:32 INFO - jsonschema == 2.5.1 01:45:32 INFO - manifestparser == 1.1 01:45:32 INFO - mozInstall == 1.12 01:45:32 INFO - mozcrash == 1.0 01:45:32 INFO - mozdebug == 0.1 01:45:32 INFO - mozdevice == 0.49 01:45:32 INFO - mozfile == 1.2 01:45:32 INFO - mozhttpd == 0.7 01:45:32 INFO - mozinfo == 0.9 01:45:32 INFO - mozleak == 0.1 01:45:32 INFO - mozlog == 3.4 01:45:32 INFO - moznetwork == 0.27 01:45:32 INFO - mozprocess == 0.24 01:45:32 INFO - mozprofile == 0.28 01:45:32 INFO - mozrunner == 6.13 01:45:32 INFO - mozscreenshot == 0.1 01:45:32 INFO - mozsystemmonitor == 0.3 01:45:32 INFO - moztest == 0.8 01:45:32 INFO - mozversion == 1.4 01:45:32 INFO - psutil == 3.1.1 01:45:32 INFO - requests == 1.2.3 01:45:32 INFO - wsgiref == 0.1.2 01:45:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:45:32 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')]} 01:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:32 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')]} 01:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:32 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 0x18a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c18630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca1850>, '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 0x1c166d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c16b60>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745', '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 01:45:32 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 01:45:32 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 01:45:32 INFO - Using env: {'DISPLAY': ':0', 01:45:32 INFO - 'HOME': '/home/cltbld', 01:45:32 INFO - 'LANG': 'en_US.UTF-8', 01:45:32 INFO - 'LANGUAGE': 'en_US:en', 01:45:32 INFO - 'LOGNAME': 'cltbld', 01:45:32 INFO - 'MAIL': '/var/mail/cltbld', 01:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:32 INFO - 'MOZ_NO_REMOTE': '1', 01:45:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:32 INFO - 'NO_EM_RESTART': '1', 01:45:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:32 INFO - 'PWD': '/builds/slave/test', 01:45:32 INFO - 'SHELL': '/bin/bash', 01:45:32 INFO - 'SHLVL': '1', 01:45:32 INFO - 'TERM': 'linux', 01:45:32 INFO - 'TMOUT': '86400', 01:45:32 INFO - 'USER': 'cltbld', 01:45:32 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745', 01:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:32 INFO - '_': '/tools/buildbot/bin/python'} 01:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:32 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)) 01:45:32 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)) 01:45:32 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)) 01:45:32 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)) 01:45:32 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)) 01:45:32 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)) 01:45:32 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)) 01:45:32 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)) 01:45:32 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)) 01:45:32 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)) 01:45:32 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)) 01:45:32 INFO - Cleaning up... 01:45:32 INFO - Return code: 0 01:45:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:45:32 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')]} 01:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:32 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')]} 01:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:32 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 0x18a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c18630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca1850>, '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 0x1c166d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c16b60>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745', '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 01:45:32 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 01:45:32 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 01:45:32 INFO - Using env: {'DISPLAY': ':0', 01:45:32 INFO - 'HOME': '/home/cltbld', 01:45:32 INFO - 'LANG': 'en_US.UTF-8', 01:45:32 INFO - 'LANGUAGE': 'en_US:en', 01:45:32 INFO - 'LOGNAME': 'cltbld', 01:45:32 INFO - 'MAIL': '/var/mail/cltbld', 01:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:32 INFO - 'MOZ_NO_REMOTE': '1', 01:45:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:32 INFO - 'NO_EM_RESTART': '1', 01:45:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:32 INFO - 'PWD': '/builds/slave/test', 01:45:32 INFO - 'SHELL': '/bin/bash', 01:45:32 INFO - 'SHLVL': '1', 01:45:32 INFO - 'TERM': 'linux', 01:45:32 INFO - 'TMOUT': '86400', 01:45:32 INFO - 'USER': 'cltbld', 01:45:32 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745', 01:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:32 INFO - '_': '/tools/buildbot/bin/python'} 01:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:45:32 INFO - Cleaning up... 01:45:32 INFO - Return code: 0 01:45:32 INFO - Running post-action listener: _resource_record_post_action 01:45:32 INFO - Running post-action listener: _start_resource_monitoring 01:45:32 INFO - Starting resource monitoring. 01:45:32 INFO - [mozharness: 2017-01-12 09:45:32.748841Z] Finished create-virtualenv step (success) 01:45:32 INFO - [mozharness: 2017-01-12 09:45:32.749409Z] Running install step. 01:45:32 INFO - Running pre-action listener: _resource_record_pre_action 01:45:32 INFO - Running main action method: install 01:45:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:45:32 INFO - Reading from file tmpfile_stdout 01:45:32 INFO - Detecting whether we're running mozinstall >=1.0... 01:45:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:45:33 INFO - Reading from file tmpfile_stdout 01:45:33 INFO - Output received: 01:45:33 INFO - Usage: mozinstall [options] installer 01:45:33 INFO - Options: 01:45:33 INFO - -h, --help show this help message and exit 01:45:33 INFO - -d DEST, --destination=DEST 01:45:33 INFO - Directory to install application into. [default: 01:45:33 INFO - "/builds/slave/test"] 01:45:33 INFO - --app=APP Application being installed. [default: firefox] 01:45:33 INFO - mkdir: /builds/slave/test/build/application 01:45:33 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'] 01:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:45:49 INFO - Reading from file tmpfile_stdout 01:45:49 INFO - Output received: 01:45:49 INFO - /builds/slave/test/build/application/firefox/firefox 01:45:49 INFO - Running post-action listener: _resource_record_post_action 01:45:49 INFO - [mozharness: 2017-01-12 09:45:49.206864Z] Finished install step (success) 01:45:49 INFO - [mozharness: 2017-01-12 09:45:49.207137Z] Running run-tests step. 01:45:49 INFO - Running pre-action listener: _resource_record_pre_action 01:45:49 INFO - Running main action method: run_tests 01:45:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:45:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:45:49 INFO - Python 2.7.3 01:45:49 INFO - Return code: 0 01:45:49 INFO - grabbing minidump binary from tooltool 01:45:49 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')]} 01:45:49 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 0x1ca1850>, '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 0x1c166d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c16b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:45:49 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 01:45:49 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 01:45:49 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 01:45:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:45:49 INFO - Return code: 0 01:45:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:45:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:45:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:45:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:45:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:45:49 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/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 01:45:49 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/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 01:45:49 INFO - Using env: {'DISPLAY': ':0', 01:45:49 INFO - 'HOME': '/home/cltbld', 01:45:49 INFO - 'LANG': 'en_US.UTF-8', 01:45:49 INFO - 'LANGUAGE': 'en_US:en', 01:45:49 INFO - 'LOGNAME': 'cltbld', 01:45:49 INFO - 'MAIL': '/var/mail/cltbld', 01:45:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:45:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:49 INFO - 'MOZ_NO_REMOTE': '1', 01:45:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:45:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:49 INFO - 'NO_EM_RESTART': '1', 01:45:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:49 INFO - 'PWD': '/builds/slave/test', 01:45:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:45:49 INFO - 'SHELL': '/bin/bash', 01:45:49 INFO - 'SHLVL': '1', 01:45:49 INFO - 'TERM': 'linux', 01:45:49 INFO - 'TMOUT': '86400', 01:45:49 INFO - 'USER': 'cltbld', 01:45:49 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745', 01:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:49 INFO - '_': '/tools/buildbot/bin/python'} 01:45:49 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/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 01:45:49 INFO - mozversion application_buildid: 20170112091459 01:45:49 INFO - mozversion application_changeset: 97d6f73643940256c0eb61e384c49bf6f6c49847 01:45:49 INFO - mozversion application_display_name: Nightly 01:45:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:45:49 INFO - mozversion application_name: Firefox 01:45:49 INFO - mozversion application_remotingname: firefox 01:45:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:45:49 INFO - mozversion application_vendor: Mozilla 01:45:49 INFO - mozversion application_version: 53.0a1 01:45:49 INFO - mozversion platform_buildid: 20170112091459 01:45:49 INFO - mozversion platform_changeset: 97d6f73643940256c0eb61e384c49bf6f6c49847 01:45:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:45:49 INFO - mozversion platform_version: 53.0a1 01:45:49 INFO - using testdate: 1484214349 01:45:49 INFO - actual date: 1484214349 01:45:49 INFO - starting webserver on 'localhost:41887' 01:45:49 INFO - SUITE-START | Running 2 tests 01:45:49 INFO - TEST-START | dromaeo_css 01:45:49 INFO - operating with platform_type : linux_ 01:45:49 INFO - Initialising browser for dromaeo_css test... 01:45:49 INFO - TEST-INFO | started process 13123 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNP_9l2/profile http://localhost:41887/getInfo.html) 01:45:53 INFO - PROCESS | 13123 | __metrics Screen width/height:1600/1200 01:45:53 INFO - PROCESS | 13123 | colorDepth:24 01:45:53 INFO - PROCESS | 13123 | Browser inner width/height: 1024/697 01:45:53 INFO - PROCESS | 13123 | __metrics 01:45:53 INFO - PROCESS | 13123 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:45:53 INFO - PROCESS | 13123 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:45:54 INFO - PROCESS | 13123 | console.error: PushService: 01:45:54 INFO - PROCESS | 13123 | stateChangeProcessEnqueue: Error transitioning state 01:45:54 INFO - PROCESS | 13123 | UnknownError 01:45:55 INFO - TEST-INFO | 13123: exit 0 01:45:55 INFO - Browser initialized. 01:45:55 INFO - Running cycle 1/1 for dromaeo_css test... 01:45:55 INFO - TEST-INFO | started process 13204 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNP_9l2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:46:07 INFO - PROCESS | 13204 | RSS: Main: 152580096 01:46:07 INFO - PROCESS | 13204 | 01:49:11 INFO - PROCESS | 13204 | Cycle 1(1): loaded http://localhost:41887/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41887/tests/dromaeo/cssquery-ext.html) 01:49:13 INFO - PROCESS | 13204 | RSS: Main: 288444416 01:49:13 INFO - PROCESS | 13204 | 01:50:56 INFO - PROCESS | 13204 | ************************* 01:50:56 INFO - PROCESS | 13204 | A coding exception was thrown and uncaught in a Task. 01:50:56 INFO - PROCESS | 13204 | 01:50:56 INFO - PROCESS | 13204 | Full message: ReferenceError: fetch is not defined 01:50:56 INFO - PROCESS | 13204 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 01:50:56 INFO - PROCESS | 13204 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 01:50:56 INFO - PROCESS | 13204 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 01:50:56 INFO - PROCESS | 13204 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 01:50:56 INFO - PROCESS | 13204 | TaskImpl@resource://gre/modules/Task.jsm:277:3 01:50:56 INFO - PROCESS | 13204 | asyncFunction@resource://gre/modules/Task.jsm:252:14 01:50:56 INFO - PROCESS | 13204 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 01:50:56 INFO - PROCESS | 13204 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 01:50:56 INFO - PROCESS | 13204 | TaskImpl@resource://gre/modules/Task.jsm:277:3 01:50:56 INFO - PROCESS | 13204 | asyncFunction@resource://gre/modules/Task.jsm:252:14 01:50:56 INFO - PROCESS | 13204 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 01:50:56 INFO - PROCESS | 13204 | 01:50:56 INFO - PROCESS | 13204 | ************************* 01:52:15 INFO - PROCESS | 13204 | Cycle 1(1): loaded http://localhost:41887/tests/dromaeo/cssquery-ext.html (next: http://localhost:41887/tests/dromaeo/cssquery-jquery.html) 01:52:16 INFO - PROCESS | 13204 | RSS: Main: 246472704 01:52:16 INFO - PROCESS | 13204 | 01:55:18 INFO - PROCESS | 13204 | Cycle 1(1): loaded http://localhost:41887/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41887/tests/dromaeo/cssquery-mootools.html) 01:55:19 INFO - PROCESS | 13204 | RSS: Main: 224038912 01:55:19 INFO - PROCESS | 13204 | 01:58:21 INFO - PROCESS | 13204 | Cycle 1(1): loaded http://localhost:41887/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41887/tests/dromaeo/cssquery-prototype.html) 01:58:22 INFO - PROCESS | 13204 | RSS: Main: 184627200 01:58:22 INFO - PROCESS | 13204 | 02:01:25 INFO - PROCESS | 13204 | Cycle 1(1): loaded http://localhost:41887/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41887/tests/dromaeo/cssquery-yui.html) 02:01:26 INFO - PROCESS | 13204 | RSS: Main: 185245696 02:01:26 INFO - PROCESS | 13204 | 02:04:29 INFO - PROCESS | 13204 | Cycle 1(1): loaded http://localhost:41887/tests/dromaeo/cssquery-yui.html (next: http://localhost:41887/tests/dromaeo/cssquery-dojo.html) 02:04:29 INFO - PROCESS | 13204 | RSS: Main: 277905408 02:04:29 INFO - PROCESS | 13204 | 02:04:29 INFO - PROCESS | 13204 | __start_tp_report 02:04:29 INFO - PROCESS | 13204 | _x_x_mozilla_page_load 02:04:29 INFO - PROCESS | 13204 | _x_x_mozilla_page_load_details 02:04:29 INFO - PROCESS | 13204 | |i|pagename|runs| 02:04:29 INFO - PROCESS | 13204 | |0;dojo.html;2581.819272650914;2608.0871694906796;2636.8681565921697;2639.0235612823258;2639.1554702495196;4660.7203567785955;4727.054589082189;4780.832670856521;4794.8801279967975;4832.323474713543;4783.665143439952;4794.880127996802;4823.107725070864;4872.853814385574;4913.115639184945;4397.714148580348;4424.712393694415;4460.308652158904;4505.07645932583;4519.16395466838;4518.661100417482;4524.592786649201;4527.52460991596;4528.682992190548;4534.410526631534;4378.474583050022;4461.665375096881;4473.4408198975125;4508.61676757476;4523.954760452402;4384.386185933972;4396.120775844844;4438.778061096965;4444.244478438641;4511.187986162489;4409;4410.316400957857;4416.757078360689;4422.889427764299;4456.197884380843;4792.161371759928;4812.807487700523;4816.20532612122;4817.181079216542;4818.325434439182;5056.342675452204;5092.210707340369;5115.462876397962;5132.5124113209185;5182.4299327073995;5148.61385396093;5148.948510514884;5169.353830771153;5182.352205974254;5189.169732842727;4810.230363141881;4824.95175048245;4825.348577942003;4832.758362081881;4870.366852309177;5111.539961403491;5148.9485105149215;5188.9740551297755;5232.607554433433;5270.358338598346;5053.67151135175;5065.062963351792;5065.594752419797;5076.035553244872;5115.104856650071;5030.496950305013;5062.949370506321;5138.023775482647;5148;5186.818461353834;5066.03745288394;5069.264956581275;5070.923936140961;5103.311053007871;5137.922931156036;5043.5965122790085;5070.898582028339;5076.543111120017;5080.7205603692155;5126.384833819965;4277.2942464493635;4297.54875738043;4298.892527686833;4303.1178608385835;4342.131573685276;3649.1424515238896;3664.5602527696847;3669.871554495633;3676.3750162472443;3690.1697118148204;4375.256206444912;4377.802998865059;4395.7142785718825;4416.646668266531;4429.512753597101;5026.949730502648;5064.063148317573;5074.543291103819;5084.822031228963;5125.718085505333;4311.116221174651;4345.087531618332;4368.453943257093;4372.23485889968;4413;4638.0491999140095;4644.442666879996;4647.883802904955;4693.601043911238;4699.342092107107;4881.194602890554;4882.6338024649;4896.632752543503;4910.21436570147;4938.209886418084;5082.745862706924;5152.072626927189;5177.689338639693;5230.5815534757885;5280.551153152025;4824.396950381202;4877.146499362669;4880.341153944172;4899.118158731462;4945.530174633404;5136.203888397305;5138.332016837787;5144;5151.356080489939;5199.220116982483;5048.444671086104;5206.479352064764;5210.036143313499;5214.191800270964;5218.921716174336;4475.5748203920575;4940.135476291563;4983.405310300669;5024.522670346311;5110.948890511196;5070.264811602223;5073.949260507347;5077.619178561548;5084.313617661568;5117.437081920912;4871.293662419001;4914.533119353656;4917.409910810726;4999.475055119306;5013;4995.375578052744;5009.849704508871;5046.1926091825135;5049.596032317332;5070.797168113234;4875.780589873535;4894.119058569491;4906.582940450102;4942.505749425172;4950.455449900436 02:04:29 INFO - PROCESS | 13204 | |1;ext.html;535.7401660194805;538.7925648625278;549.5493695169962;619.1517620859423;619.1826788638998;29522.261943451424;32529;40950;42082.57917420825;42287.57712422875;41541.7922910385;41800.58199418005;41899.581004189946;41951.58048419515;41995.37006944898;7633.923660763405;7812.179721129285;7815.687372505093;7818.843623127534;7824.139344672081;7559.962200188991;7731.265529774662;10120.443375614339;10391.064804167623;10406.63576774813;10331.690049298533;10365.429901355423;10377.066064054234;10378.429186394746;10382.532786024647;10266.384016959006;10328.431936243504;10343.431111288875;10354.896451035469;10355;10200.183985281234;10230.539625716861;10252.38485690861;10255.025772551595;10268.640597579124;38622.42066369006;38739.225215495535;38937;39077.60922390768;39141.21717565661;3785.1104990327253;3877.4377715231135;3894.55212650546;3900.356441187229;3913.6477717005323;29028.419431611248;29028.41943161146;29267.121986340444;30184.54723179154;30192.54711179334;3098.90703278902;3129.8435078246;3142.4343618148723;3187.3625274945102;3290;167925;167938;168737.99999999878;169125.15437422856;169579;55476.72261638666;55582;55779.16331255034;55832;55894.720526397105;57177;57373.71313143491;57397.426025740046;57427.71286143626;57540.71229643825;14913.254337283093;15525.378984840705;15532.145731984623;15547.84452155464;15552.611184720472;10288.845667314996;11794.646160615195;11872.465739041763;11883.524659013716;11908.940455297668;15029.248537573078;16736.41422550205;17130.48608541746;17353.82646173522;17896.373626922996;6793.762218322335;6842.965785171043;6877.979075275077;6904.378605925491;7112.295994528202;839.4585492357395;859.8563909999685;860.7460799064291;875.2166810704384;881.6635914825636;27570.133019915622;27858;28320.858395707888;28753.137405877857;28789.136325910255;938.9765255868522;990.9058639429243;1000.3947611694965;1005.2360206243308;1028.0747327405245;15264.771028434583;15288.464903728538;15293.694126117416;15318.770218446733;15660.373585056697;324615;325670;325938;326139;326995;51221;51262.231066534034;51357.48642513527;51377.229341559905;51426.228606570934;1277.4251586785983;1318.6835159561635;1328.5018118205674;1331.6204881608694;1335.8664133586758;26023.609645855708;26818;27013;27159.59260611132;27372.178834634993;44001.55998439975;44657.33014004728;44711.10577788491;44732.32901506415;44824.77587612041;270581;271229;271644;271706;272255;32703;33779.83110084434;36030;36592.63407365892;36852.447213292355;40631.39052914268;43240.78379608082;43480.13039739251;47683.76158119187;49384;35939.820300898326;36940.44589331216;37352.43971340378;37526.81236593799;38479;36579.26841463209;36651.633483664824;36879.26241475209;37015.444768329035;37287;35748.28503429865;36039;36725.44911826378;37013.074673133386;37019.8149009264;30477.695223048373;32564.674353256163;33319.66680333165;33377.49933750947;33522.32955340831;24477.143299984415;24763.50472990494;25075.623865641664;25100.62349064802;25317.113901013377 02:04:29 INFO - PROCESS | 13204 | |2;jquery.html;382.9597892221315;389.555906266856;391.57905251854265;396.89879080834385;424.535134028239;12956.416961236744;13675.78619024531;16712.58218544537;18120.18459169339;18153.27386904524;15188;18658.160382782775;18835.15241814118;18888.33890813822;19142.617147657038;5152.433232344449;5355.6786592804365;5362.034833729927;5363.892722145574;5373.328333958255;5009.624278179152;5247.081760691883;5263.105272103751;5271.42014378418;5272.762725677354;5234.6859188448625;5237.947620523784;5239.056969745444;5239.79040838366;5245.213218017289;4997.650164488469;5117.974410127944;5156.407013193493;5159.277701121827;5160.200168973777;4669.509701481364;4673.205555055649;4677.438707355139;4677.7661116944355;4679.906401871977;21926.232581859716;22415.887920560457;22538.43653908649;22552.323430297118;22559.210427634953;2291.5875142474347;2342.5783358995373;2377.655239990209;2385.558671645751;2417.697787776528;13709.520166794115;13812.723745525032;14077.507287244896;14130.434782608683;14489.130652160904;1722.888012279198;1758.8329108734777;1775.458485162025;1794.1657129434745;1795.3054250955968;58053.99999999958;71497.64251178764;75542.24457755407;75655.24344756537;76401.61799191024;10260.948695256477;10349.430781307101;10390;10659.626913058006;10801.729956751144;14815.481458148914;14827.03624264441;14833.332500037524;14848;14856;7292.598907060163;7410.5183163094225;7479.439042071866;7606.467547271748;7644.235576442311;6943.89584156238;7031.648417579203;7179.820504487429;7181.281871812881;7202.675879585431;6729.293424190488;6841.350071743176;6845.623490707959;6887.690053947585;6964.616946068015;1844.6587381334227;1917.3289348727833;1943.9416817495498;1948.5713143108494;1959.5003274164997;831.8669012957897;858.4505916213628;871.107115206918;876.1982785750967;880.0319648386724;16918.407855725236;17029.574260643334;17516.91241543784;17616.20727067285;18191.909040454713;840.2479780596332;840.5755093677653;856.178069053703;860.4493124400389;863.0937515608712;9426.811463770686;9591.90408095924;9830.4101753895;9838.60645574169;9931;476852;490446;496457;504400;504960;57206.7139664299;71464.64267678629;71544;72645.6367718158;73144;940.9294302927308;941.5245301122889;967.8935317115112;969.6024629901707;973.0609961387295;14952.700945981236;15000.924995374953;15567.221638918236;15730.370785168465;15762.763558546401;35499.29001420009;35758.8212058938;36514.8174259127;36682.266354672225;37159.628403715615;46553.30170047384;48730;49918.25122623091;50451.243231352295;52069.47930520646;7212;7812.296893279632;7924.167962363868;8134.389920756085;8201.917980820115;11732.589359372723;12174.086943479097;12182.878171218174;12336.321502317458;12445.751084978068;10075;10115.696529104138;10372.948135259276;10514.789704206027;10879;10332.276740628384;10500.894991050298;10696.41169735672;10739.194560408157;11054.889451105386;10492.370457772253;10811.56753729842;10917;10980.176486763365;11186.776264474502;7401.370883474965;7416.147143078615;7420.740274090381;7540.773776786705;7785.766427007199;10640;10656.413897235727;10700.839487407851;10829.350238985686;11100.944495277472 02:04:29 INFO - PROCESS | 13204 | |3;mootools.html;1354.5191457032754;1364.7884577890425;1368.2132773655148;1379.3585982518134;1383.5572616762627;6994.125734283215;7407.851842963138;7408.073990751156;7411.370033547141;7448.590327531983;6505.512086593512;6740.66296685165;7015.508914375996;7228.674709638066;7260.636968151598;2162.113533451285;2190.5728382965326;2196.7363916330064;2197.439652888519;2198;2190.047329411711;2222.5888210680996;2226.5101677630896;2227.4208705736464;2231.85492942959;1904.7333373327745;1960.9215631374727;2113.260358874397;2210.3368989303226;2211.701420308254;2176.1186719378675;2215.235743668432;2231.475603233239;2234.3520379090046;2239.261043855532;2146.1093646136833;2221.9666704999436;2244.147224054865;2251.3020963501367;2257.3792207143;7444.516106453118;7481.438892083062;7498.700051997914;7503.5497870127965;7508.249175082503;4550.522195169493;4676.438827340741;4676.971066365394;4679.719216847;4681.695689780154;2993.8832541869256;3033.0294305822144;3043.6043314369213;3052;3064.233941514621;1124.2074337591978;1140.8459857919158;1179.445660539545;1182.5920057580122;1194.0507296699145;9512.714618561455;9756.121949024551;9756.268279879037;9841.704748857474;9846.60613575456;4259.552746961586;4289.399484072233;4336.002719374562;4363.2364336241035;4431;8478.74563763088;8482.872756908651;8496.617652205665;8558.52928088961;8563.571821408905;4716.221823399101;4716.693414928019;4746.786394612251;4747.738874361943;4750.8337208197545;3450.275442157175;3721.9627803721614;4178.143480586473;4313.331433627793;4322.286822674287;3599.352116618981;3654.2691461707764;3659.524261845943;3714.814259287025;3749.4938183345444;1235.172434468908;1239.0583156800717;1249.1568191470722;1254.7678679444332;1263.848338199422;850.4132148817296;861.5175501719058;867.7657032601162;888.7689200807837;891.4651209274383;5107.6169287302855;5181.5854731621375;5183.429822719498;5208.427073021964;5315.787368505216;885.7209978856639;919.3794188922451;947.6067432015774;951.7335146159087;971.3443425687633;3434.21013166973;3527.488514165483;3564.7504674672523;3596.37063513884;3817.560980487224;8376;8647.827043459096;8702.173293537104;8710.085441028728;8737;8112.067112282163;8657.307415406753;8674.479531228146;8682.348823838238;8683.2185103341;6662.100616416818;6976.930230697628;6979.720811167598;6980.441564674814;6986.7205311787975;4981.551660350586;5075.08648443269;5175.508326708957;5306.2305965634;5317.973410132925;7712.151663317143;7882.330001949669;7920.405969552422;7994.360451163777;8017.759467215993;7920.722774702857;8139.674413023413;8236.958815205886;8239.794005149679;8270.958645206976;5638.069718496567;5718.714064296852;5790.739416726342;6141.232345956755;6274.058891166362;6877.759278425231;7110.964445177741;7124;7164.641767911688;7328.816779580553;6384.138141351044;6585.308542603149;6644.169478815148;6654.268030516542;6694.933050669431;6403.007533832263;6449.516286278454;6622.106015688013;6645.269020407654;6731.091302674272;5627.606067575231;5655.519280861173;5711.200971693903;5719.056355701263;5724.026915424472;4414.161309351213;4470.709403888737;4543.136804007228;4547.477040140427;4571.131485017836;4411.492678341903;4436.955630443655;4504.986378064909;4542.682012259243;4671.43942726875 02:04:29 INFO - PROCESS | 13204 | |4;prototype.html;351.1519679972866;363.30608537693;369.50301844019793;369.7300970291687;376.1874351400974;4685.85942421727;4730.692504987173;4851.660383773137;4897.853064408065;4905.730184839832;4641.187792136379;4737.857864264069;4757.738324392157;4768.73771942543;4806.639502037344;3906.179702262514;3913.9021524461973;3925.9803700981456;3926.3128952433353;3929.44987701722;3711.1464363196483;3853.3064048471265;3912.8630497932436;3926.666233370153;3933.527976642807;3796.3925771876507;3880.1269714314335;3889.4943657324648;3896.2012787378662;3906.941395879064;3868.941965870514;3881.204353107606;3881.8253178606888;3893.143508428141;3898.8830335089992;3494.685478306965;3498.4052711039185;3504.754667173299;3512.1570823002553;3518.2611651553207;4520.186366454037;4631.16639004979;4654.511276315972;4661.976690116561;4722.527747225285;4401.295792673157;4408.691391602589;4411.735295882225;4416;4444.955550444486;5046.84859454217;5052.242163675442;5054.646174767768;5055.974720126413;5067.290579318898;3689.4281386385155;3715.702743780491;3751.362268414376;3823.847046118152;3834.424836274581;5241.475852414766;5248.580113590941;5251.658642188284;5253.789848406059;5254.185601231815;3842.538895332522;3848.5381754189675;3850.4994350734223;3855.132595166065;3858.228354329089;3809.9809500952874;3914.706397020235;3917.3928041153667;3921.215756848642;3924.6271604197555;4307.698461107692;4377.5403582624;4379.956200437955;4389.100234451929;4428.82284708608;4997.350344455271;5001.824936127218;5041.722705251246;5065.949340506621;5067.315912351859;1270.339423499775;1314.1458052265912;1321.6431563477806;1344.764666183414;1357.470586471277;909.4305490010923;923.4828496042238;963.5258055175592;983.5770618633914;996.5266498413341;4290.592393722592;4299.828006879689;4300.505441874225;4302.9569704303185;4303.462067241595;4942;4986.401631804207;4997.7251251180805;5023;5041.949580504222;4224.366345048206;4474.284114541658;4475.462944446622;4480.924578101232;4487.259602165606;2642.322125450353;2674.879630416597;2685.852278124683;2686.3955609987597;2692.6768787745596;4773.212419950739;4773.427188737373;4774.785134668949;4793.161196790617;4817.590504807061;5063.620228482879;5250.606204534599;5271.156614941591;5290.947090529123;5327.254184414185;4877.6829506081995;4878.268259760993;4878.585320247747;4905.509449055137;4917.385326834145;4994.80020799164;5187.524358679619;5193.221016847503;5228.215767634885;5228.712420816892;5112.616553758408;5124.333836601218;5135.820246291362;5142.665726727751;5145.562627176732;4885.364902562644;4908.7300198488;4914.680545764514;4915.705057696549;4919.360483137312;3602.5496812898386;3700.296943580711;3702.90764224549;3704.3147017801793;3707.4994875692514;5102.387713474407;5129.897402052013;5167.61242906776;5174.172132458789;5174.586033117417;5020.397552293748;5031.1887720421355;5055.747212639427;5063.443021267732;5064.721440320818;4933.161362568444;5025.6482046256415;5044.2685810558;5052.216906379517;5081.441041485507;4794.161021821237;4819.927701084416;4909.288153217834;4975.925361119658;4981.42713587942;5065.417476990193;5095.515925987025;5097.796088156432;5099.69401835891;5102.387713474258;4970.9254361183885;4979.97910428354;4986.975065124651;4994.825181118644;5000.624953128603 02:04:29 INFO - PROCESS | 13204 | |5;yui.html;671.5131529641008;691.730225212167;727.5125665803911;730.2697302697303;751.0499218488612;13208.40562174702;14384.568462946103;14384.85615143851;14451.421943122275;14550.27248637568;13697;13846.930765346184;13857.23785191814;13862.930685346559;13865.445382184726;647.9060536222245;663.3532306001658;785.8899754034411;800.2397722163953;804.2399932064202;806.8587997100514;813.0487329824091;813.8535063688533;818.0796603820702;820.7578764264556;853.9914600854005;855.7860534866284;856.4047986649281;856.4133568505594;856.4518708026868;681.1043477826692;849.2441726863096;850.107387243395;850.2475309351238;850.3452341696859;511.7671459485925;605.6820169411094;616.6238594457377;619.0404872447688;624.6033768556999;13257.535986240531;13271.270080145589;13304.534341298007;13323.067385283033;13324.86675133246;12749.74500509994;12821.743565128645;12953.805692914613;13044.673883152996;13156.144850584682;11795.705107372385;11848.526058957632;11922.940385298018;12200.816987745191;12334.136610437274;4035.535913369971;4057.6550993165615;4069.491313585802;4219.51475580306;4242.681798865097;57269;57388;59202.70398647979;59572.70213648904;60401.395986040014;9911.355761875455;9928.702138935843;10027.247956403153;10085.29402941787;10176.796464070678;17683.823161768476;17747.378841740476;17793.911030444764;17805.287788488575;17907.73138402925;6585.73657053722;6638.137042184485;6902.413294869993;6915.273896240822;6949.861002779916;3464.9267207406683;3540.433530635086;3592.9640703593154;3596.9833669230024;3597.2985267872514;2761.406297646016;2811.2269125990106;2830.900918467885;2852.0303096947137;2853.885844566194;485.44901536755333;486.0904860904903;487.79268810755286;489.354052650505;496.990060198794;560;566.6854895532937;573.698808125729;592.6325678079618;609.6159419565645;8133.674653013932;8211.95894020526;8433.873491897626;8437;8496.745097646957;567.2059117235902;570.2729020498897;579.5450571301592;600.4835841176584;607.2136583124864;3799.1072098056934;3881.670058045098;3984.900377490586;4083.4895638045246;4162.729422587522;66616.33383666101;67118.32881671218;67490.66254668696;68040;69508.65245673739;57758;57962;58629.12056319159;59389.70305148447;59678.701606492556;43945.99999999936;44701;44832.10335793266;49393.76515587139;52665.47334526682;8540.203590301999;8665.610047547749;8847.115288471101;8866.955665221632;8995.775105622412;30270.243243919078;31386.843065784524;31974.482806891687;34277.80027699118;35215.11962200965;37797;40700.59299407087;40760.79619601883;41636.58363416327;45226.32160517529;9279.67521136757;9285.117913798178;9291.86062209081;9637.325387222827;9736.468518185182;11140.554377824796;11790.227127319176;11922;12088.939555302168;12283.57007504733;9425.245980321695;11003.064739497233;11353.829692554453;11936.462859171532;12956.35218239103;11216.831747523956;11632;11982.760344793229;12483.500659973499;12485.93757031209;10440.947795260976;10819.67540973772;11068.391238481961;11152.275102118661;11422.94288528552;9814.509274536387;10021.63409893713;10442.440971463906;10558.366498010144;10581.206409519471;9441.716748497556;9686;9696.70909872705;9701.175400091071;9714.174295184706 02:04:29 INFO - PROCESS | 13204 | __end_tp_report 02:04:29 INFO - PROCESS | 13204 | __start_cc_report 02:04:29 INFO - PROCESS | 13204 | _x_x_mozilla_cycle_collect,1330 02:04:29 INFO - PROCESS | 13204 | __end_cc_report 02:04:29 INFO - PROCESS | 13204 | __startTimestamp1484215469299__endTimestamp 02:04:29 INFO - PROCESS | 13204 | 02:04:29 INFO - PROCESS | 13204 | ------- Summary: start ------- 02:04:29 INFO - PROCESS | 13204 | Number of tests: 6 02:04:29 INFO - PROCESS | 13204 | 02:04:29 INFO - PROCESS | 13204 | [#0] dojo.html Cycles:165 Average:4747.62 Median:4894.12 stddev:513.21 (10.5%) stddev-sans-first:485.85 02:04:29 INFO - PROCESS | 13204 | Values: 2581.8 2608.1 2636.9 2639.0 2639.2 4660.7 4727.1 4780.8 4794.9 4832.3 4783.7 4794.9 4823.1 4872.9 4913.1 4397.7 4424.7 4460.3 4505.1 4519.2 4518.7 4524.6 4527.5 4528.7 4534.4 4378.5 4461.7 4473.4 4508.6 4524.0 4384.4 4396.1 4438.8 4444.2 4511.2 4409.0 4410.3 4416.8 4422.9 4456.2 4792.2 4812.8 4816.2 4817.2 4818.3 5056.3 5092.2 5115.5 5132.5 5182.4 5148.6 5148.9 5169.4 5182.4 5189.2 4810.2 4825.0 4825.3 4832.8 4870.4 5111.5 5148.9 5189.0 5232.6 5270.4 5053.7 5065.1 5065.6 5076.0 5115.1 5030.5 5062.9 5138.0 5148.0 5186.8 5066.0 5069.3 5070.9 5103.3 5137.9 5043.6 5070.9 5076.5 5080.7 5126.4 4277.3 4297.5 4298.9 4303.1 4342.1 3649.1 3664.6 3669.9 3676.4 3690.2 4375.3 4377.8 4395.7 4416.6 4429.5 5026.9 5064.1 5074.5 5084.8 5125.7 4311.1 4345.1 4368.5 4372.2 4413.0 4638.0 4644.4 4647.9 4693.6 4699.3 4881.2 4882.6 4896.6 4910.2 4938.2 5082.7 5152.1 5177.7 5230.6 5280.6 4824.4 4877.1 4880.3 4899.1 4945.5 5136.2 5138.3 5144.0 5151.4 5199.2 5048.4 5206.5 5210.0 5214.2 5218.9 4475.6 4940.1 4983.4 5024.5 5110.9 5070.3 5073.9 5077.6 5084.3 5117.4 4871.3 4914.5 4917.4 4999.5 5013.0 4995.4 5009.8 5046.2 5049.6 5070.8 4875.8 4894.1 4906.6 4942.5 4950.5 02:04:29 INFO - PROCESS | 13204 | 02:04:29 INFO - PROCESS | 13204 | [#1] ext.html Cycles:180 Average:43084.66 Median:18304.83 stddev:68930.37 (376.6%) stddev-sans-first:69049.71 02:04:29 INFO - PROCESS | 13204 | Values: 535.7 538.8 549.5 619.2 619.2 29522.3 32529.0 40950.0 42082.6 42287.6 41541.8 41800.6 41899.6 41951.6 41995.4 7633.9 7812.2 7815.7 7818.8 7824.1 7560.0 7731.3 10120.4 10391.1 10406.6 10331.7 10365.4 10377.1 10378.4 10382.5 10266.4 10328.4 10343.4 10354.9 10355.0 10200.2 10230.5 10252.4 10255.0 10268.6 38622.4 38739.2 38937.0 39077.6 39141.2 3785.1 3877.4 3894.6 3900.4 3913.6 29028.4 29028.4 29267.1 30184.5 30192.5 3098.9 3129.8 3142.4 3187.4 3290.0 167925.0 167938.0 168738.0 169125.2 169579.0 55476.7 55582.0 55779.2 55832.0 55894.7 57177.0 57373.7 57397.4 57427.7 57540.7 14913.3 15525.4 15532.1 15547.8 15552.6 10288.8 11794.6 11872.5 11883.5 11908.9 15029.2 16736.4 17130.5 17353.8 17896.4 6793.8 6843.0 6878.0 6904.4 7112.3 839.5 859.9 860.7 875.2 881.7 27570.1 27858.0 28320.9 28753.1 28789.1 939.0 990.9 1000.4 1005.2 1028.1 15264.8 15288.5 15293.7 15318.8 15660.4 324615.0 325670.0 325938.0 326139.0 326995.0 51221.0 51262.2 51357.5 51377.2 51426.2 1277.4 1318.7 1328.5 1331.6 1335.9 26023.6 26818.0 27013.0 27159.6 27372.2 44001.6 44657.3 44711.1 44732.3 44824.8 270581.0 271229.0 271644.0 271706.0 272255.0 32703.0 33779.8 36030.0 36592.6 36852.4 40631.4 43240.8 43480.1 47683.8 49384.0 35939.8 36940.4 37352.4 37526.8 38479.0 36579.3 36651.6 36879.3 37015.4 37287.0 35748.3 36039.0 36725.4 37013.1 37019.8 30477.7 32564.7 33319.7 33377.5 33522.3 24477.1 24763.5 25075.6 25100.6 25317.1 02:04:29 INFO - PROCESS | 13204 | 02:04:29 INFO - PROCESS | 13204 | [#2] jquery.html Cycles:180 Average:27387.37 Median:25611.41 stddev:80983.62 (316.2%) stddev-sans-first:81185.41 02:04:29 INFO - PROCESS | 13204 | Values: 383.0 389.6 391.6 396.9 424.5 12956.4 13675.8 16712.6 18120.2 18153.3 15188.0 18658.2 18835.2 18888.3 19142.6 5152.4 5355.7 5362.0 5363.9 5373.3 5009.6 5247.1 5263.1 5271.4 5272.8 5234.7 5237.9 5239.1 5239.8 5245.2 4997.7 5118.0 5156.4 5159.3 5160.2 4669.5 4673.2 4677.4 4677.8 4679.9 21926.2 22415.9 22538.4 22552.3 22559.2 2291.6 2342.6 2377.7 2385.6 2417.7 13709.5 13812.7 14077.5 14130.4 14489.1 1722.9 1758.8 1775.5 1794.2 1795.3 58054.0 71497.6 75542.2 75655.2 76401.6 10260.9 10349.4 10390.0 10659.6 10801.7 14815.5 14827.0 14833.3 14848.0 14856.0 7292.6 7410.5 7479.4 7606.5 7644.2 6943.9 7031.6 7179.8 7181.3 7202.7 6729.3 6841.4 6845.6 6887.7 6964.6 1844.7 1917.3 1943.9 1948.6 1959.5 831.9 858.5 871.1 876.2 880.0 16918.4 17029.6 17516.9 17616.2 18191.9 840.2 840.6 856.2 860.4 863.1 9426.8 9591.9 9830.4 9838.6 9931.0 476852.0 490446.0 496457.0 504400.0 504960.0 57206.7 71464.6 71544.0 72645.6 73144.0 940.9 941.5 967.9 969.6 973.1 14952.7 15000.9 15567.2 15730.4 15762.8 35499.3 35758.8 36514.8 36682.3 37159.6 46553.3 48730.0 49918.3 50451.2 52069.5 7212.0 7812.3 7924.2 8134.4 8201.9 11732.6 12174.1 12182.9 12336.3 12445.8 10075.0 10115.7 10372.9 10514.8 10879.0 10332.3 10500.9 10696.4 10739.2 11054.9 10492.4 10811.6 10917.0 10980.2 11186.8 7401.4 7416.1 7420.7 7540.8 7785.8 10640.0 10656.4 10700.8 10829.4 11100.9 02:04:29 INFO - PROCESS | 13204 | 02:04:29 INFO - PROCESS | 13204 | [#3] mootools.html Cycles:180 Average:4889.81 Median:5195.93 stddev:2557.36 (49.2%) stddev-sans-first:2550.73 02:04:29 INFO - PROCESS | 13204 | Values: 1354.5 1364.8 1368.2 1379.4 1383.6 6994.1 7407.9 7408.1 7411.4 7448.6 6505.5 6740.7 7015.5 7228.7 7260.6 2162.1 2190.6 2196.7 2197.4 2198.0 2190.0 2222.6 2226.5 2227.4 2231.9 1904.7 1960.9 2113.3 2210.3 2211.7 2176.1 2215.2 2231.5 2234.4 2239.3 2146.1 2222.0 2244.1 2251.3 2257.4 7444.5 7481.4 7498.7 7503.5 7508.2 4550.5 4676.4 4677.0 4679.7 4681.7 2993.9 3033.0 3043.6 3052.0 3064.2 1124.2 1140.8 1179.4 1182.6 1194.1 9512.7 9756.1 9756.3 9841.7 9846.6 4259.6 4289.4 4336.0 4363.2 4431.0 8478.7 8482.9 8496.6 8558.5 8563.6 4716.2 4716.7 4746.8 4747.7 4750.8 3450.3 3722.0 4178.1 4313.3 4322.3 3599.4 3654.3 3659.5 3714.8 3749.5 1235.2 1239.1 1249.2 1254.8 1263.8 850.4 861.5 867.8 888.8 891.5 5107.6 5181.6 5183.4 5208.4 5315.8 885.7 919.4 947.6 951.7 971.3 3434.2 3527.5 3564.8 3596.4 3817.6 8376.0 8647.8 8702.2 8710.1 8737.0 8112.1 8657.3 8674.5 8682.3 8683.2 6662.1 6976.9 6979.7 6980.4 6986.7 4981.6 5075.1 5175.5 5306.2 5318.0 7712.2 7882.3 7920.4 7994.4 8017.8 7920.7 8139.7 8237.0 8239.8 8271.0 5638.1 5718.7 5790.7 6141.2 6274.1 6877.8 7111.0 7124.0 7164.6 7328.8 6384.1 6585.3 6644.2 6654.3 6694.9 6403.0 6449.5 6622.1 6645.3 6731.1 5627.6 5655.5 5711.2 5719.1 5724.0 4414.2 4470.7 4543.1 4547.5 4571.1 4411.5 4437.0 4505.0 4542.7 4671.4 02:04:29 INFO - PROCESS | 13204 | 02:04:29 INFO - PROCESS | 13204 | [#4] prototype.html Cycles:180 Average:4220.73 Median:4770.98 stddev:1182.12 (24.8%) stddev-sans-first:1149.20 02:04:29 INFO - PROCESS | 13204 | Values: 351.2 363.3 369.5 369.7 376.2 4685.9 4730.7 4851.7 4897.9 4905.7 4641.2 4737.9 4757.7 4768.7 4806.6 3906.2 3913.9 3926.0 3926.3 3929.4 3711.1 3853.3 3912.9 3926.7 3933.5 3796.4 3880.1 3889.5 3896.2 3906.9 3868.9 3881.2 3881.8 3893.1 3898.9 3494.7 3498.4 3504.8 3512.2 3518.3 4520.2 4631.2 4654.5 4662.0 4722.5 4401.3 4408.7 4411.7 4416.0 4445.0 5046.8 5052.2 5054.6 5056.0 5067.3 3689.4 3715.7 3751.4 3823.8 3834.4 5241.5 5248.6 5251.7 5253.8 5254.2 3842.5 3848.5 3850.5 3855.1 3858.2 3810.0 3914.7 3917.4 3921.2 3924.6 4307.7 4377.5 4380.0 4389.1 4428.8 4997.4 5001.8 5041.7 5065.9 5067.3 1270.3 1314.1 1321.6 1344.8 1357.5 909.4 923.5 963.5 983.6 996.5 4290.6 4299.8 4300.5 4303.0 4303.5 4942.0 4986.4 4997.7 5023.0 5041.9 4224.4 4474.3 4475.5 4480.9 4487.3 2642.3 2674.9 2685.9 2686.4 2692.7 4773.2 4773.4 4774.8 4793.2 4817.6 5063.6 5250.6 5271.2 5290.9 5327.3 4877.7 4878.3 4878.6 4905.5 4917.4 4994.8 5187.5 5193.2 5228.2 5228.7 5112.6 5124.3 5135.8 5142.7 5145.6 4885.4 4908.7 4914.7 4915.7 4919.4 3602.5 3700.3 3702.9 3704.3 3707.5 5102.4 5129.9 5167.6 5174.2 5174.6 5020.4 5031.2 5055.7 5063.4 5064.7 4933.2 5025.6 5044.3 5052.2 5081.4 4794.2 4819.9 4909.3 4975.9 4981.4 5065.4 5095.5 5097.8 5099.7 5102.4 4970.9 4980.0 4987.0 4994.8 5000.6 02:04:29 INFO - PROCESS | 13204 | 02:04:29 INFO - PROCESS | 13204 | [#5] yui.html Cycles:180 Average:14454.48 Median:486.94 stddev:17801.84 (3655.8%) stddev-sans-first:17821.69 02:04:29 INFO - PROCESS | 13204 | Values: 671.5 691.7 727.5 730.3 751.0 13208.4 14384.6 14384.9 14451.4 14550.3 13697.0 13846.9 13857.2 13862.9 13865.4 647.9 663.4 785.9 800.2 804.2 806.9 813.0 813.9 818.1 820.8 854.0 855.8 856.4 856.4 856.5 681.1 849.2 850.1 850.2 850.3 511.8 605.7 616.6 619.0 624.6 13257.5 13271.3 13304.5 13323.1 13324.9 12749.7 12821.7 12953.8 13044.7 13156.1 11795.7 11848.5 11922.9 12200.8 12334.1 4035.5 4057.7 4069.5 4219.5 4242.7 57269.0 57388.0 59202.7 59572.7 60401.4 9911.4 9928.7 10027.2 10085.3 10176.8 17683.8 17747.4 17793.9 17805.3 17907.7 6585.7 6638.1 6902.4 6915.3 6949.9 3464.9 3540.4 3593.0 3597.0 3597.3 2761.4 2811.2 2830.9 2852.0 2853.9 485.4 486.1 487.8 489.4 497.0 560.0 566.7 573.7 592.6 609.6 8133.7 8212.0 8433.9 8437.0 8496.7 567.2 570.3 579.5 600.5 607.2 3799.1 3881.7 3984.9 4083.5 4162.7 66616.3 67118.3 67490.7 68040.0 69508.7 57758.0 57962.0 58629.1 59389.7 59678.7 43946.0 44701.0 44832.1 49393.8 52665.5 8540.2 8665.6 8847.1 8867.0 8995.8 30270.2 31386.8 31974.5 34277.8 35215.1 37797.0 40700.6 40760.8 41636.6 45226.3 9279.7 9285.1 9291.9 9637.3 9736.5 11140.6 11790.2 11922.0 12088.9 12283.6 9425.2 11003.1 11353.8 11936.5 12956.4 11216.8 11632.0 11982.8 12483.5 12485.9 10440.9 10819.7 11068.4 11152.3 11422.9 9814.5 10021.6 10442.4 10558.4 10581.2 9441.7 9686.0 9696.7 9701.2 9714.2 02:04:29 INFO - PROCESS | 13204 | -------- Summary: end -------- 02:04:29 INFO - PROCESS | 13204 | 02:04:30 INFO - TEST-INFO | 13204: exit 0 02:04:30 INFO - TEST-OK | dromaeo_css | took 1120710ms 02:04:30 INFO - TEST-START | kraken 02:04:30 INFO - operating with platform_type : linux_ 02:04:30 INFO - Initialising browser for kraken test... 02:04:30 INFO - TEST-INFO | started process 13504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp41WmjQ/profile http://localhost:41887/getInfo.html) 02:04:33 INFO - PROCESS | 13504 | __metrics Screen width/height:1600/1200 02:04:33 INFO - PROCESS | 13504 | colorDepth:24 02:04:33 INFO - PROCESS | 13504 | Browser inner width/height: 1024/697 02:04:33 INFO - PROCESS | 13504 | __metrics 02:04:34 INFO - PROCESS | 13504 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:04:34 INFO - PROCESS | 13504 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:04:35 INFO - TEST-INFO | 13504: exit 0 02:04:35 INFO - Browser initialized. 02:04:35 INFO - Running cycle 1/1 for kraken test... 02:04:35 INFO - TEST-INFO | started process 13587 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp41WmjQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:04:47 INFO - PROCESS | 13587 | RSS: Main: 151961600 02:04:47 INFO - PROCESS | 13587 | 02:04:50 INFO - PROCESS | 13587 | Cycle 1(1): loaded http://localhost:41887/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41887/tests/kraken/driver.html?testName=audio-beat-detection) 02:04:51 INFO - PROCESS | 13587 | RSS: Main: 206344192 02:04:51 INFO - PROCESS | 13587 | 02:04:54 INFO - PROCESS | 13587 | Cycle 1(1): loaded http://localhost:41887/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41887/tests/kraken/driver.html?testName=audio-dft) 02:04:54 INFO - PROCESS | 13587 | RSS: Main: 185430016 02:04:54 INFO - PROCESS | 13587 | 02:04:57 INFO - PROCESS | 13587 | Cycle 1(1): loaded http://localhost:41887/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41887/tests/kraken/driver.html?testName=audio-fft) 02:04:58 INFO - PROCESS | 13587 | RSS: Main: 268681216 02:04:58 INFO - PROCESS | 13587 | 02:05:00 INFO - PROCESS | 13587 | Cycle 1(1): loaded http://localhost:41887/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41887/tests/kraken/driver.html?testName=audio-oscillator) 02:05:01 INFO - PROCESS | 13587 | RSS: Main: 179298304 02:05:01 INFO - PROCESS | 13587 | 02:05:03 INFO - PROCESS | 13587 | Cycle 1(1): loaded http://localhost:41887/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41887/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:05:04 INFO - PROCESS | 13587 | RSS: Main: 182558720 02:05:04 INFO - PROCESS | 13587 | 02:05:07 INFO - PROCESS | 13587 | Cycle 1(1): loaded http://localhost:41887/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41887/tests/kraken/driver.html?testName=imaging-darkroom) 02:05:07 INFO - PROCESS | 13587 | RSS: Main: 221794304 02:05:07 INFO - PROCESS | 13587 | 02:05:11 INFO - PROCESS | 13587 | Cycle 1(1): loaded http://localhost:41887/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41887/tests/kraken/driver.html?testName=imaging-desaturate) 02:05:11 INFO - PROCESS | 13587 | RSS: Main: 216199168 02:05:11 INFO - PROCESS | 13587 | 02:05:14 INFO - PROCESS | 13587 | Cycle 1(1): loaded http://localhost:41887/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41887/tests/kraken/driver.html?testName=json-parse-financial) 02:05:15 INFO - PROCESS | 13587 | RSS: Main: 217964544 02:05:15 INFO - PROCESS | 13587 | 02:05:17 INFO - PROCESS | 13587 | Cycle 1(1): loaded http://localhost:41887/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41887/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:05:17 INFO - PROCESS | 13587 | RSS: Main: 181784576 02:05:17 INFO - PROCESS | 13587 | 02:05:19 INFO - PROCESS | 13587 | Cycle 1(1): loaded http://localhost:41887/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41887/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:05:20 INFO - PROCESS | 13587 | RSS: Main: 188477440 02:05:20 INFO - PROCESS | 13587 | 02:05:22 INFO - PROCESS | 13587 | Cycle 1(1): loaded http://localhost:41887/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41887/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:05:23 INFO - PROCESS | 13587 | RSS: Main: 196780032 02:05:23 INFO - PROCESS | 13587 | 02:05:25 INFO - PROCESS | 13587 | Cycle 1(1): loaded http://localhost:41887/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41887/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:05:26 INFO - PROCESS | 13587 | RSS: Main: 207360000 02:05:26 INFO - PROCESS | 13587 | 02:05:29 INFO - PROCESS | 13587 | Cycle 1(1): loaded http://localhost:41887/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41887/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:05:30 INFO - PROCESS | 13587 | RSS: Main: 203268096 02:05:30 INFO - PROCESS | 13587 | 02:05:31 INFO - PROCESS | 13587 | Cycle 1(1): loaded http://localhost:41887/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41887/tests/kraken/driver.html?testName=ai-astar) 02:05:32 INFO - PROCESS | 13587 | RSS: Main: 254304256 02:05:32 INFO - PROCESS | 13587 | 02:05:32 INFO - PROCESS | 13587 | __start_tp_report 02:05:32 INFO - PROCESS | 13587 | _x_x_mozilla_page_load 02:05:32 INFO - PROCESS | 13587 | _x_x_mozilla_page_load_details 02:05:32 INFO - PROCESS | 13587 | |i|pagename|runs| 02:05:32 INFO - PROCESS | 13587 | |0;ai-astar;105;115;115;115;116;112;114;114;116;114 02:05:32 INFO - PROCESS | 13587 | |1;audio-beat-detection;150;128;130;174;131;130;125;126;158;124 02:05:32 INFO - PROCESS | 13587 | |2;audio-dft;161;160;160;163;160;162;162;161;161;161 02:05:32 INFO - PROCESS | 13587 | |3;audio-fft;80;76;76;104;77;77;77;77;98;77 02:05:32 INFO - PROCESS | 13587 | |4;audio-oscillator;84;84;110;86;86;86;106;85;86;109 02:05:32 INFO - PROCESS | 13587 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 02:05:32 INFO - PROCESS | 13587 | |6;imaging-darkroom;149;149;150;149;148;149;149;149;149;149 02:05:32 INFO - PROCESS | 13587 | |7;imaging-desaturate;95;95;96;95;96;95;96;95;95;95 02:05:32 INFO - PROCESS | 13587 | |8;json-parse-financial;59;58;58;59;65;67;60;59;67;64 02:05:32 INFO - PROCESS | 13587 | |9;json-stringify-tinderbox;67;67;67;67;67;67;67;66;66;68 02:05:32 INFO - PROCESS | 13587 | |10;stanford-crypto-aes;86;85;85;85;86;85;85;88;85;91 02:05:32 INFO - PROCESS | 13587 | |11;stanford-crypto-ccm;135;142;141;132;135;137;137;131;187;130 02:05:32 INFO - PROCESS | 13587 | |12;stanford-crypto-pbkdf2;174;176;178;172;177;177;177;173;172;171 02:05:32 INFO - PROCESS | 13587 | |13;stanford-crypto-sha256-iterative;69;75;68;68;68;68;68;67;66;67 02:05:32 INFO - PROCESS | 13587 | __end_tp_report 02:05:32 INFO - PROCESS | 13587 | __start_cc_report 02:05:32 INFO - PROCESS | 13587 | _x_x_mozilla_cycle_collect,1803 02:05:32 INFO - PROCESS | 13587 | __end_cc_report 02:05:32 INFO - PROCESS | 13587 | __startTimestamp1484215532154__endTimestamp 02:05:32 INFO - PROCESS | 13587 | 02:05:32 INFO - PROCESS | 13587 | ------- Summary: start ------- 02:05:32 INFO - PROCESS | 13587 | Number of tests: 14 02:05:32 INFO - PROCESS | 13587 | 02:05:32 INFO - PROCESS | 13587 | [#0] ai-astar Cycles:10 Average:113.60 Median:115.00 stddev:3.24 (2.8%) stddev-sans-first:1.24 02:05:32 INFO - PROCESS | 13587 | Values: 105.0 115.0 115.0 115.0 116.0 112.0 114.0 114.0 116.0 114.0 02:05:32 INFO - PROCESS | 13587 | 02:05:32 INFO - PROCESS | 13587 | [#1] audio-beat-detection Cycles:10 Average:137.60 Median:130.50 stddev:17.08 (13.1%) stddev-sans-first:17.51 02:05:32 INFO - PROCESS | 13587 | Values: 150.0 128.0 130.0 174.0 131.0 130.0 125.0 126.0 158.0 124.0 02:05:32 INFO - PROCESS | 13587 | 02:05:32 INFO - PROCESS | 13587 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 02:05:32 INFO - PROCESS | 13587 | Values: 161.0 160.0 160.0 163.0 160.0 162.0 162.0 161.0 161.0 161.0 02:05:32 INFO - PROCESS | 13587 | 02:05:32 INFO - PROCESS | 13587 | [#3] audio-fft Cycles:10 Average:81.90 Median:77.00 stddev:10.22 (13.3%) stddev-sans-first:10.82 02:05:32 INFO - PROCESS | 13587 | Values: 80.0 76.0 76.0 104.0 77.0 77.0 77.0 77.0 98.0 77.0 02:05:32 INFO - PROCESS | 13587 | 02:05:32 INFO - PROCESS | 13587 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:85.50 stddev:11.20 (13.1%) stddev-sans-first:11.48 02:05:32 INFO - PROCESS | 13587 | Values: 84.0 84.0 110.0 86.0 86.0 86.0 106.0 85.0 86.0 109.0 02:05:32 INFO - PROCESS | 13587 | 02:05:32 INFO - PROCESS | 13587 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 02:05:32 INFO - PROCESS | 13587 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 02:05:32 INFO - PROCESS | 13587 | 02:05:32 INFO - PROCESS | 13587 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 02:05:32 INFO - PROCESS | 13587 | Values: 149.0 149.0 150.0 149.0 148.0 149.0 149.0 149.0 149.0 149.0 02:05:32 INFO - PROCESS | 13587 | 02:05:32 INFO - PROCESS | 13587 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 02:05:32 INFO - PROCESS | 13587 | Values: 95.0 95.0 96.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 02:05:32 INFO - PROCESS | 13587 | 02:05:32 INFO - PROCESS | 13587 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:62.00 stddev:3.72 (6.0%) stddev-sans-first:3.82 02:05:32 INFO - PROCESS | 13587 | Values: 59.0 58.0 58.0 59.0 65.0 67.0 60.0 59.0 67.0 64.0 02:05:32 INFO - PROCESS | 13587 | 02:05:32 INFO - PROCESS | 13587 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 02:05:32 INFO - PROCESS | 13587 | Values: 67.0 67.0 67.0 67.0 67.0 67.0 67.0 66.0 66.0 68.0 02:05:32 INFO - PROCESS | 13587 | 02:05:32 INFO - PROCESS | 13587 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:85.50 stddev:1.97 (2.3%) stddev-sans-first:2.09 02:05:32 INFO - PROCESS | 13587 | Values: 86.0 85.0 85.0 85.0 86.0 85.0 85.0 88.0 85.0 91.0 02:05:32 INFO - PROCESS | 13587 | 02:05:32 INFO - PROCESS | 13587 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:137.00 stddev:16.74 (12.2%) stddev-sans-first:17.63 02:05:32 INFO - PROCESS | 13587 | Values: 135.0 142.0 141.0 132.0 135.0 137.0 137.0 131.0 187.0 130.0 02:05:32 INFO - PROCESS | 13587 | 02:05:32 INFO - PROCESS | 13587 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.70 Median:176.50 stddev:2.58 (1.5%) stddev-sans-first:2.73 02:05:32 INFO - PROCESS | 13587 | Values: 174.0 176.0 178.0 172.0 177.0 177.0 177.0 173.0 172.0 171.0 02:05:32 INFO - PROCESS | 13587 | 02:05:32 INFO - PROCESS | 13587 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.00 stddev:2.46 (3.6%) stddev-sans-first:2.60 02:05:32 INFO - PROCESS | 13587 | Values: 69.0 75.0 68.0 68.0 68.0 68.0 68.0 67.0 66.0 67.0 02:05:32 INFO - PROCESS | 13587 | -------- Summary: end -------- 02:05:32 INFO - PROCESS | 13587 | 02:05:33 INFO - TEST-INFO | 13587: exit 0 02:05:33 INFO - TEST-OK | kraken | took 63117ms 02:05:33 INFO - SUITE-END | took 1183s 02:05:33 INFO - Completed test suite (00:19:44) 02:05:33 INFO - javascript benchmark 02:05:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2581.819272650914, 2608.0871694906796, 2636.8681565921697, 2639.0235612823258, 2639.1554702495196, 4660.7203567785955, 4727.054589082189, 4780.832670856521, 4794.8801279967975, 4832.323474713543, 4783.665143439952, 4794.880127996802, 4823.107725070864, 4872.853814385574, 4913.115639184945, 4397.714148580348, 4424.712393694415, 4460.308652158904, 4505.07645932583, 4519.16395466838, 4518.661100417482, 4524.592786649201, 4527.52460991596, 4528.682992190548, 4534.410526631534, 4378.474583050022, 4461.665375096881, 4473.4408198975125, 4508.61676757476, 4523.954760452402, 4384.386185933972, 4396.120775844844, 4438.778061096965, 4444.244478438641, 4511.187986162489, 4409.0, 4410.316400957857, 4416.757078360689, 4422.889427764299, 4456.197884380843, 4792.161371759928, 4812.807487700523, 4816.20532612122, 4817.181079216542, 4818.325434439182, 5056.342675452204, 5092.210707340369, 5115.462876397962, 5132.5124113209185, 5182.4299327073995, 5148.61385396093, 5148.948510514884, 5169.353830771153, 5182.352205974254, 5189.169732842727, 4810.230363141881, 4824.95175048245, 4825.348577942003, 4832.758362081881, 4870.366852309177, 5111.539961403491, 5148.9485105149215, 5188.9740551297755, 5232.607554433433, 5270.358338598346, 5053.67151135175, 5065.062963351792, 5065.594752419797, 5076.035553244872, 5115.104856650071, 5030.496950305013, 5062.949370506321, 5138.023775482647, 5148.0, 5186.818461353834, 5066.03745288394, 5069.264956581275, 5070.923936140961, 5103.311053007871, 5137.922931156036, 5043.5965122790085, 5070.898582028339, 5076.543111120017, 5080.7205603692155, 5126.384833819965, 4277.2942464493635, 4297.54875738043, 4298.892527686833, 4303.1178608385835, 4342.131573685276, 3649.1424515238896, 3664.5602527696847, 3669.871554495633, 3676.3750162472443, 3690.1697118148204, 4375.256206444912, 4377.802998865059, 4395.7142785718825, 4416.646668266531, 4429.512753597101, 5026.949730502648, 5064.063148317573, 5074.543291103819, 5084.822031228963, 5125.718085505333, 4311.116221174651, 4345.087531618332, 4368.453943257093, 4372.23485889968, 4413.0, 4638.0491999140095, 4644.442666879996, 4647.883802904955, 4693.601043911238, 4699.342092107107, 4881.194602890554, 4882.6338024649, 4896.632752543503, 4910.21436570147, 4938.209886418084, 5082.745862706924, 5152.072626927189, 5177.689338639693, 5230.5815534757885, 5280.551153152025, 4824.396950381202, 4877.146499362669, 4880.341153944172, 4899.118158731462, 4945.530174633404, 5136.203888397305, 5138.332016837787, 5144.0, 5151.356080489939, 5199.220116982483, 5048.444671086104, 5206.479352064764, 5210.036143313499, 5214.191800270964, 5218.921716174336, 4475.5748203920575, 4940.135476291563, 4983.405310300669, 5024.522670346311, 5110.948890511196, 5070.264811602223, 5073.949260507347, 5077.619178561548, 5084.313617661568, 5117.437081920912, 4871.293662419001, 4914.533119353656, 4917.409910810726, 4999.475055119306, 5013.0, 4995.375578052744, 5009.849704508871, 5046.1926091825135, 5049.596032317332, 5070.797168113234, 4875.780589873535, 4894.119058569491, 4906.582940450102, 4942.505749425172, 4950.455449900436], "value": 4713.373306684089, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.7401660194805, 538.7925648625278, 549.5493695169962, 619.1517620859423, 619.1826788638998, 29522.261943451424, 32529.0, 40950.0, 42082.57917420825, 42287.57712422875, 41541.7922910385, 41800.58199418005, 41899.581004189946, 41951.58048419515, 41995.37006944898, 7633.923660763405, 7812.179721129285, 7815.687372505093, 7818.843623127534, 7824.139344672081, 7559.962200188991, 7731.265529774662, 10120.443375614339, 10391.064804167623, 10406.63576774813, 10331.690049298533, 10365.429901355423, 10377.066064054234, 10378.429186394746, 10382.532786024647, 10266.384016959006, 10328.431936243504, 10343.431111288875, 10354.896451035469, 10355.0, 10200.183985281234, 10230.539625716861, 10252.38485690861, 10255.025772551595, 10268.640597579124, 38622.42066369006, 38739.225215495535, 38937.0, 39077.60922390768, 39141.21717565661, 3785.1104990327253, 3877.4377715231135, 3894.55212650546, 3900.356441187229, 3913.6477717005323, 29028.419431611248, 29028.41943161146, 29267.121986340444, 30184.54723179154, 30192.54711179334, 3098.90703278902, 3129.8435078246, 3142.4343618148723, 3187.3625274945102, 3290.0, 167925.0, 167938.0, 168737.99999999878, 169125.15437422856, 169579.0, 55476.72261638666, 55582.0, 55779.16331255034, 55832.0, 55894.720526397105, 57177.0, 57373.71313143491, 57397.426025740046, 57427.71286143626, 57540.71229643825, 14913.254337283093, 15525.378984840705, 15532.145731984623, 15547.84452155464, 15552.611184720472, 10288.845667314996, 11794.646160615195, 11872.465739041763, 11883.524659013716, 11908.940455297668, 15029.248537573078, 16736.41422550205, 17130.48608541746, 17353.82646173522, 17896.373626922996, 6793.762218322335, 6842.965785171043, 6877.979075275077, 6904.378605925491, 7112.295994528202, 839.4585492357395, 859.8563909999685, 860.7460799064291, 875.2166810704384, 881.6635914825636, 27570.133019915622, 27858.0, 28320.858395707888, 28753.137405877857, 28789.136325910255, 938.9765255868522, 990.9058639429243, 1000.3947611694965, 1005.2360206243308, 1028.0747327405245, 15264.771028434583, 15288.464903728538, 15293.694126117416, 15318.770218446733, 15660.373585056697, 324615.0, 325670.0, 325938.0, 326139.0, 326995.0, 51221.0, 51262.231066534034, 51357.48642513527, 51377.229341559905, 51426.228606570934, 1277.4251586785983, 1318.6835159561635, 1328.5018118205674, 1331.6204881608694, 1335.8664133586758, 26023.609645855708, 26818.0, 27013.0, 27159.59260611132, 27372.178834634993, 44001.55998439975, 44657.33014004728, 44711.10577788491, 44732.32901506415, 44824.77587612041, 270581.0, 271229.0, 271644.0, 271706.0, 272255.0, 32703.0, 33779.83110084434, 36030.0, 36592.63407365892, 36852.447213292355, 40631.39052914268, 43240.78379608082, 43480.13039739251, 47683.76158119187, 49384.0, 35939.820300898326, 36940.44589331216, 37352.43971340378, 37526.81236593799, 38479.0, 36579.26841463209, 36651.633483664824, 36879.26241475209, 37015.444768329035, 37287.0, 35748.28503429865, 36039.0, 36725.44911826378, 37013.074673133386, 37019.8149009264, 30477.695223048373, 32564.674353256163, 33319.66680333165, 33377.49933750947, 33522.32955340831, 24477.143299984415, 24763.50472990494, 25075.623865641664, 25100.62349064802, 25317.113901013377], "value": 18110.422622436643, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.9597892221315, 389.555906266856, 391.57905251854265, 396.89879080834385, 424.535134028239, 12956.416961236744, 13675.78619024531, 16712.58218544537, 18120.18459169339, 18153.27386904524, 15188.0, 18658.160382782775, 18835.15241814118, 18888.33890813822, 19142.617147657038, 5152.433232344449, 5355.6786592804365, 5362.034833729927, 5363.892722145574, 5373.328333958255, 5009.624278179152, 5247.081760691883, 5263.105272103751, 5271.42014378418, 5272.762725677354, 5234.6859188448625, 5237.947620523784, 5239.056969745444, 5239.79040838366, 5245.213218017289, 4997.650164488469, 5117.974410127944, 5156.407013193493, 5159.277701121827, 5160.200168973777, 4669.509701481364, 4673.205555055649, 4677.438707355139, 4677.7661116944355, 4679.906401871977, 21926.232581859716, 22415.887920560457, 22538.43653908649, 22552.323430297118, 22559.210427634953, 2291.5875142474347, 2342.5783358995373, 2377.655239990209, 2385.558671645751, 2417.697787776528, 13709.520166794115, 13812.723745525032, 14077.507287244896, 14130.434782608683, 14489.130652160904, 1722.888012279198, 1758.8329108734777, 1775.458485162025, 1794.1657129434745, 1795.3054250955968, 58053.99999999958, 71497.64251178764, 75542.24457755407, 75655.24344756537, 76401.61799191024, 10260.948695256477, 10349.430781307101, 10390.0, 10659.626913058006, 10801.729956751144, 14815.481458148914, 14827.03624264441, 14833.332500037524, 14848.0, 14856.0, 7292.598907060163, 7410.5183163094225, 7479.439042071866, 7606.467547271748, 7644.235576442311, 6943.89584156238, 7031.648417579203, 7179.820504487429, 7181.281871812881, 7202.675879585431, 6729.293424190488, 6841.350071743176, 6845.623490707959, 6887.690053947585, 6964.616946068015, 1844.6587381334227, 1917.3289348727833, 1943.9416817495498, 1948.5713143108494, 1959.5003274164997, 831.8669012957897, 858.4505916213628, 871.107115206918, 876.1982785750967, 880.0319648386724, 16918.407855725236, 17029.574260643334, 17516.91241543784, 17616.20727067285, 18191.909040454713, 840.2479780596332, 840.5755093677653, 856.178069053703, 860.4493124400389, 863.0937515608712, 9426.811463770686, 9591.90408095924, 9830.4101753895, 9838.60645574169, 9931.0, 476852.0, 490446.0, 496457.0, 504400.0, 504960.0, 57206.7139664299, 71464.64267678629, 71544.0, 72645.6367718158, 73144.0, 940.9294302927308, 941.5245301122889, 967.8935317115112, 969.6024629901707, 973.0609961387295, 14952.700945981236, 15000.924995374953, 15567.221638918236, 15730.370785168465, 15762.763558546401, 35499.29001420009, 35758.8212058938, 36514.8174259127, 36682.266354672225, 37159.628403715615, 46553.30170047384, 48730.0, 49918.25122623091, 50451.243231352295, 52069.47930520646, 7212.0, 7812.296893279632, 7924.167962363868, 8134.389920756085, 8201.917980820115, 11732.589359372723, 12174.086943479097, 12182.878171218174, 12336.321502317458, 12445.751084978068, 10075.0, 10115.696529104138, 10372.948135259276, 10514.789704206027, 10879.0, 10332.276740628384, 10500.894991050298, 10696.41169735672, 10739.194560408157, 11054.889451105386, 10492.370457772253, 10811.56753729842, 10917.0, 10980.176486763365, 11186.776264474502, 7401.370883474965, 7416.147143078615, 7420.740274090381, 7540.773776786705, 7785.766427007199, 10640.0, 10656.413897235727, 10700.839487407851, 10829.350238985686, 11100.944495277472], "value": 8599.132109425833, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1354.5191457032754, 1364.7884577890425, 1368.2132773655148, 1379.3585982518134, 1383.5572616762627, 6994.125734283215, 7407.851842963138, 7408.073990751156, 7411.370033547141, 7448.590327531983, 6505.512086593512, 6740.66296685165, 7015.508914375996, 7228.674709638066, 7260.636968151598, 2162.113533451285, 2190.5728382965326, 2196.7363916330064, 2197.439652888519, 2198.0, 2190.047329411711, 2222.5888210680996, 2226.5101677630896, 2227.4208705736464, 2231.85492942959, 1904.7333373327745, 1960.9215631374727, 2113.260358874397, 2210.3368989303226, 2211.701420308254, 2176.1186719378675, 2215.235743668432, 2231.475603233239, 2234.3520379090046, 2239.261043855532, 2146.1093646136833, 2221.9666704999436, 2244.147224054865, 2251.3020963501367, 2257.3792207143, 7444.516106453118, 7481.438892083062, 7498.700051997914, 7503.5497870127965, 7508.249175082503, 4550.522195169493, 4676.438827340741, 4676.971066365394, 4679.719216847, 4681.695689780154, 2993.8832541869256, 3033.0294305822144, 3043.6043314369213, 3052.0, 3064.233941514621, 1124.2074337591978, 1140.8459857919158, 1179.445660539545, 1182.5920057580122, 1194.0507296699145, 9512.714618561455, 9756.121949024551, 9756.268279879037, 9841.704748857474, 9846.60613575456, 4259.552746961586, 4289.399484072233, 4336.002719374562, 4363.2364336241035, 4431.0, 8478.74563763088, 8482.872756908651, 8496.617652205665, 8558.52928088961, 8563.571821408905, 4716.221823399101, 4716.693414928019, 4746.786394612251, 4747.738874361943, 4750.8337208197545, 3450.275442157175, 3721.9627803721614, 4178.143480586473, 4313.331433627793, 4322.286822674287, 3599.352116618981, 3654.2691461707764, 3659.524261845943, 3714.814259287025, 3749.4938183345444, 1235.172434468908, 1239.0583156800717, 1249.1568191470722, 1254.7678679444332, 1263.848338199422, 850.4132148817296, 861.5175501719058, 867.7657032601162, 888.7689200807837, 891.4651209274383, 5107.6169287302855, 5181.5854731621375, 5183.429822719498, 5208.427073021964, 5315.787368505216, 885.7209978856639, 919.3794188922451, 947.6067432015774, 951.7335146159087, 971.3443425687633, 3434.21013166973, 3527.488514165483, 3564.7504674672523, 3596.37063513884, 3817.560980487224, 8376.0, 8647.827043459096, 8702.173293537104, 8710.085441028728, 8737.0, 8112.067112282163, 8657.307415406753, 8674.479531228146, 8682.348823838238, 8683.2185103341, 6662.100616416818, 6976.930230697628, 6979.720811167598, 6980.441564674814, 6986.7205311787975, 4981.551660350586, 5075.08648443269, 5175.508326708957, 5306.2305965634, 5317.973410132925, 7712.151663317143, 7882.330001949669, 7920.405969552422, 7994.360451163777, 8017.759467215993, 7920.722774702857, 8139.674413023413, 8236.958815205886, 8239.794005149679, 8270.958645206976, 5638.069718496567, 5718.714064296852, 5790.739416726342, 6141.232345956755, 6274.058891166362, 6877.759278425231, 7110.964445177741, 7124.0, 7164.641767911688, 7328.816779580553, 6384.138141351044, 6585.308542603149, 6644.169478815148, 6654.268030516542, 6694.933050669431, 6403.007533832263, 6449.516286278454, 6622.106015688013, 6645.269020407654, 6731.091302674272, 5627.606067575231, 5655.519280861173, 5711.200971693903, 5719.056355701263, 5724.026915424472, 4414.161309351213, 4470.709403888737, 4543.136804007228, 4547.477040140427, 4571.131485017836, 4411.492678341903, 4436.955630443655, 4504.986378064909, 4542.682012259243, 4671.43942726875], "value": 4049.7492269175855, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.1519679972866, 363.30608537693, 369.50301844019793, 369.7300970291687, 376.1874351400974, 4685.85942421727, 4730.692504987173, 4851.660383773137, 4897.853064408065, 4905.730184839832, 4641.187792136379, 4737.857864264069, 4757.738324392157, 4768.73771942543, 4806.639502037344, 3906.179702262514, 3913.9021524461973, 3925.9803700981456, 3926.3128952433353, 3929.44987701722, 3711.1464363196483, 3853.3064048471265, 3912.8630497932436, 3926.666233370153, 3933.527976642807, 3796.3925771876507, 3880.1269714314335, 3889.4943657324648, 3896.2012787378662, 3906.941395879064, 3868.941965870514, 3881.204353107606, 3881.8253178606888, 3893.143508428141, 3898.8830335089992, 3494.685478306965, 3498.4052711039185, 3504.754667173299, 3512.1570823002553, 3518.2611651553207, 4520.186366454037, 4631.16639004979, 4654.511276315972, 4661.976690116561, 4722.527747225285, 4401.295792673157, 4408.691391602589, 4411.735295882225, 4416.0, 4444.955550444486, 5046.84859454217, 5052.242163675442, 5054.646174767768, 5055.974720126413, 5067.290579318898, 3689.4281386385155, 3715.702743780491, 3751.362268414376, 3823.847046118152, 3834.424836274581, 5241.475852414766, 5248.580113590941, 5251.658642188284, 5253.789848406059, 5254.185601231815, 3842.538895332522, 3848.5381754189675, 3850.4994350734223, 3855.132595166065, 3858.228354329089, 3809.9809500952874, 3914.706397020235, 3917.3928041153667, 3921.215756848642, 3924.6271604197555, 4307.698461107692, 4377.5403582624, 4379.956200437955, 4389.100234451929, 4428.82284708608, 4997.350344455271, 5001.824936127218, 5041.722705251246, 5065.949340506621, 5067.315912351859, 1270.339423499775, 1314.1458052265912, 1321.6431563477806, 1344.764666183414, 1357.470586471277, 909.4305490010923, 923.4828496042238, 963.5258055175592, 983.5770618633914, 996.5266498413341, 4290.592393722592, 4299.828006879689, 4300.505441874225, 4302.9569704303185, 4303.462067241595, 4942.0, 4986.401631804207, 4997.7251251180805, 5023.0, 5041.949580504222, 4224.366345048206, 4474.284114541658, 4475.462944446622, 4480.924578101232, 4487.259602165606, 2642.322125450353, 2674.879630416597, 2685.852278124683, 2686.3955609987597, 2692.6768787745596, 4773.212419950739, 4773.427188737373, 4774.785134668949, 4793.161196790617, 4817.590504807061, 5063.620228482879, 5250.606204534599, 5271.156614941591, 5290.947090529123, 5327.254184414185, 4877.6829506081995, 4878.268259760993, 4878.585320247747, 4905.509449055137, 4917.385326834145, 4994.80020799164, 5187.524358679619, 5193.221016847503, 5228.215767634885, 5228.712420816892, 5112.616553758408, 5124.333836601218, 5135.820246291362, 5142.665726727751, 5145.562627176732, 4885.364902562644, 4908.7300198488, 4914.680545764514, 4915.705057696549, 4919.360483137312, 3602.5496812898386, 3700.296943580711, 3702.90764224549, 3704.3147017801793, 3707.4994875692514, 5102.387713474407, 5129.897402052013, 5167.61242906776, 5174.172132458789, 5174.586033117417, 5020.397552293748, 5031.1887720421355, 5055.747212639427, 5063.443021267732, 5064.721440320818, 4933.161362568444, 5025.6482046256415, 5044.2685810558, 5052.216906379517, 5081.441041485507, 4794.161021821237, 4819.927701084416, 4909.288153217834, 4975.925361119658, 4981.42713587942, 5065.417476990193, 5095.515925987025, 5097.796088156432, 5099.69401835891, 5102.387713474258, 4970.9254361183885, 4979.97910428354, 4986.975065124651, 4994.825181118644, 5000.624953128603], "value": 3866.6756909691526, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.5131529641008, 691.730225212167, 727.5125665803911, 730.2697302697303, 751.0499218488612, 13208.40562174702, 14384.568462946103, 14384.85615143851, 14451.421943122275, 14550.27248637568, 13697.0, 13846.930765346184, 13857.23785191814, 13862.930685346559, 13865.445382184726, 647.9060536222245, 663.3532306001658, 785.8899754034411, 800.2397722163953, 804.2399932064202, 806.8587997100514, 813.0487329824091, 813.8535063688533, 818.0796603820702, 820.7578764264556, 853.9914600854005, 855.7860534866284, 856.4047986649281, 856.4133568505594, 856.4518708026868, 681.1043477826692, 849.2441726863096, 850.107387243395, 850.2475309351238, 850.3452341696859, 511.7671459485925, 605.6820169411094, 616.6238594457377, 619.0404872447688, 624.6033768556999, 13257.535986240531, 13271.270080145589, 13304.534341298007, 13323.067385283033, 13324.86675133246, 12749.74500509994, 12821.743565128645, 12953.805692914613, 13044.673883152996, 13156.144850584682, 11795.705107372385, 11848.526058957632, 11922.940385298018, 12200.816987745191, 12334.136610437274, 4035.535913369971, 4057.6550993165615, 4069.491313585802, 4219.51475580306, 4242.681798865097, 57269.0, 57388.0, 59202.70398647979, 59572.70213648904, 60401.395986040014, 9911.355761875455, 9928.702138935843, 10027.247956403153, 10085.29402941787, 10176.796464070678, 17683.823161768476, 17747.378841740476, 17793.911030444764, 17805.287788488575, 17907.73138402925, 6585.73657053722, 6638.137042184485, 6902.413294869993, 6915.273896240822, 6949.861002779916, 3464.9267207406683, 3540.433530635086, 3592.9640703593154, 3596.9833669230024, 3597.2985267872514, 2761.406297646016, 2811.2269125990106, 2830.900918467885, 2852.0303096947137, 2853.885844566194, 485.44901536755333, 486.0904860904903, 487.79268810755286, 489.354052650505, 496.990060198794, 560.0, 566.6854895532937, 573.698808125729, 592.6325678079618, 609.6159419565645, 8133.674653013932, 8211.95894020526, 8433.873491897626, 8437.0, 8496.745097646957, 567.2059117235902, 570.2729020498897, 579.5450571301592, 600.4835841176584, 607.2136583124864, 3799.1072098056934, 3881.670058045098, 3984.900377490586, 4083.4895638045246, 4162.729422587522, 66616.33383666101, 67118.32881671218, 67490.66254668696, 68040.0, 69508.65245673739, 57758.0, 57962.0, 58629.12056319159, 59389.70305148447, 59678.701606492556, 43945.99999999936, 44701.0, 44832.10335793266, 49393.76515587139, 52665.47334526682, 8540.203590301999, 8665.610047547749, 8847.115288471101, 8866.955665221632, 8995.775105622412, 30270.243243919078, 31386.843065784524, 31974.482806891687, 34277.80027699118, 35215.11962200965, 37797.0, 40700.59299407087, 40760.79619601883, 41636.58363416327, 45226.32160517529, 9279.67521136757, 9285.117913798178, 9291.86062209081, 9637.325387222827, 9736.468518185182, 11140.554377824796, 11790.227127319176, 11922.0, 12088.939555302168, 12283.57007504733, 9425.245980321695, 11003.064739497233, 11353.829692554453, 11936.462859171532, 12956.35218239103, 11216.831747523956, 11632.0, 11982.760344793229, 12483.500659973499, 12485.93757031209, 10440.947795260976, 10819.67540973772, 11068.391238481961, 11152.275102118661, 11422.94288528552, 9814.509274536387, 10021.63409893713, 10442.440971463906, 10558.366498010144, 10581.206409519471, 9441.716748497556, 9686.0, 9696.70909872705, 9701.175400091071, 9714.174295184706], "value": 6245.91434162376, "unit": "score"}], "name": "dromaeo_css", "value": 6446.956555696529, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 115.0, 115.0, 116.0, 112.0, 114.0, 114.0, 116.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 128.0, 130.0, 174.0, 131.0, 130.0, 125.0, 126.0, 158.0, 124.0], "value": 137.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 163.0, 160.0, 162.0, 162.0, 161.0, 161.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 76.0, 104.0, 77.0, 77.0, 77.0, 77.0, 98.0, 77.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 110.0, 86.0, 86.0, 86.0, 106.0, 85.0, 86.0, 109.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 150.0, 149.0, 148.0, 149.0, 149.0, 149.0, 149.0, 149.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 59.0, 65.0, 67.0, 60.0, 59.0, 67.0, 64.0], "value": 61.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0, 68.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 85.0, 86.0, 85.0, 85.0, 88.0, 85.0, 91.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 142.0, 141.0, 132.0, 135.0, 137.0, 137.0, 131.0, 187.0, 130.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 176.0, 178.0, 172.0, 177.0, 177.0, 177.0, 173.0, 172.0, 171.0], "value": 174.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 75.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0, 66.0, 67.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1546.1000000000001, "alertThreshold": 2.0}]} 02:05:33 INFO - Return code: 0 02:05:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:05:33 INFO - # TBPL SUCCESS # 02:05:33 INFO - Running post-action listener: _resource_record_post_action 02:05:33 INFO - [mozharness: 2017-01-12 10:05:33.952360Z] Finished run-tests step (success) 02:05:33 INFO - Running post-run listener: _resource_record_post_run 02:05:34 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 20480; Write bytes: 393711616; Read time: 48; Write time: 269152 02:05:34 INFO - TinderboxPrint: CPU usage
13.1% 02:05:34 INFO - TinderboxPrint: I/O read bytes / time
20,480 / 48 02:05:34 INFO - TinderboxPrint: I/O write bytes / time
393,711,616 / 269,152 02:05:34 INFO - TinderboxPrint: CPU idle
8,331.6 (86.9%) 02:05:34 INFO - TinderboxPrint: CPU user
1,210.0 (12.6%) 02:05:34 INFO - TinderboxPrint: Swap in / out
0 / 0 02:05:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110907392; Read time: 0; Write time: 86740 02:05:34 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 16384; Write bytes: 282185728; Read time: 36; Write time: 182388 02:05:34 INFO - Running post-run listener: _upload_blobber_files 02:05:34 INFO - Blob upload gear active. 02:05:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:05:34 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 02:05:34 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'] 02:05:34 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 02:05:35 INFO - (blobuploader) - INFO - Open directory for files ... 02:05:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:05:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:05:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:05:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:05:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:05:37 INFO - (blobuploader) - INFO - Done attempting. 02:05:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:05:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:05:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:05:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:05:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:05:39 INFO - (blobuploader) - INFO - Done attempting. 02:05:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:05:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:05:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:05:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:05:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:05:41 INFO - (blobuploader) - INFO - Done attempting. 02:05:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:05:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:05:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:05:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:05:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:05:52 INFO - (blobuploader) - INFO - Done attempting. 02:05:52 INFO - (blobuploader) - INFO - Iteration through files over. 02:05:52 INFO - Return code: 0 02:05:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:05:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:05:52 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4d3603a17ce9ec5d39c11cd7b4f6b9a0400b37e8e58c5e83a5ba67532596f5be2da0054627a6af9dc872afac1ee15c920b772753ce519368a83e80681d8ce32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5694f8c506e8df14491234648edb50c32177b42dac436219d6ba455899b8de6f7d596abe7e926b2a2a4b56c931b825b0654e6b13bda0454d7778c936c0168b27", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a96c2eac18c9336cdb05cb54a36b02dc7930aa22fb4aa59af568c1ec4525c770f639aabd964b8d7853cd31dec42373957c0c0b8295b86e6809456bfaea8a5c58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e346b6e63a63a33d561072697dfbbb83621cb78ae1a70f456ec600de18dd5f3aa5ac146a9122396fcd9aa6facb64da329031b1af354c8be506c845adcd16f4a"} 02:05:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:05:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:05:52 INFO - Contents: 02:05:52 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4d3603a17ce9ec5d39c11cd7b4f6b9a0400b37e8e58c5e83a5ba67532596f5be2da0054627a6af9dc872afac1ee15c920b772753ce519368a83e80681d8ce32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5694f8c506e8df14491234648edb50c32177b42dac436219d6ba455899b8de6f7d596abe7e926b2a2a4b56c931b825b0654e6b13bda0454d7778c936c0168b27", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a96c2eac18c9336cdb05cb54a36b02dc7930aa22fb4aa59af568c1ec4525c770f639aabd964b8d7853cd31dec42373957c0c0b8295b86e6809456bfaea8a5c58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e346b6e63a63a33d561072697dfbbb83621cb78ae1a70f456ec600de18dd5f3aa5ac146a9122396fcd9aa6facb64da329031b1af354c8be506c845adcd16f4a"} 02:05:52 INFO - Running post-run listener: copy_logs_to_upload_dir 02:05:52 INFO - Copying logs to upload dir... 02:05:52 INFO - mkdir: /builds/slave/test/build/upload/logs 02:05:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.303868 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-01-12 02:05:52.325542) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 02:05:52.328576) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745 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/a4d3603a17ce9ec5d39c11cd7b4f6b9a0400b37e8e58c5e83a5ba67532596f5be2da0054627a6af9dc872afac1ee15c920b772753ce519368a83e80681d8ce32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5694f8c506e8df14491234648edb50c32177b42dac436219d6ba455899b8de6f7d596abe7e926b2a2a4b56c931b825b0654e6b13bda0454d7778c936c0168b27", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a96c2eac18c9336cdb05cb54a36b02dc7930aa22fb4aa59af568c1ec4525c770f639aabd964b8d7853cd31dec42373957c0c0b8295b86e6809456bfaea8a5c58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e346b6e63a63a33d561072697dfbbb83621cb78ae1a70f456ec600de18dd5f3aa5ac146a9122396fcd9aa6facb64da329031b1af354c8be506c845adcd16f4a"} build_url:https://queue.taskcluster.net/v1/task/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/dYPnyWojQpW0oS1w5JiqRg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4d3603a17ce9ec5d39c11cd7b4f6b9a0400b37e8e58c5e83a5ba67532596f5be2da0054627a6af9dc872afac1ee15c920b772753ce519368a83e80681d8ce32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5694f8c506e8df14491234648edb50c32177b42dac436219d6ba455899b8de6f7d596abe7e926b2a2a4b56c931b825b0654e6b13bda0454d7778c936c0168b27", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a96c2eac18c9336cdb05cb54a36b02dc7930aa22fb4aa59af568c1ec4525c770f639aabd964b8d7853cd31dec42373957c0c0b8295b86e6809456bfaea8a5c58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e346b6e63a63a33d561072697dfbbb83621cb78ae1a70f456ec600de18dd5f3aa5ac146a9122396fcd9aa6facb64da329031b1af354c8be506c845adcd16f4a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 02:05:52.355115) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 02:05:52.355564) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1484212243.22365-542457745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 02:05:52.438058) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 02:05:52.438382) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 02:05:52.438691) ========= ========= Total master_lag: 0.16 =========