builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-070 starttime: 1490733971.99 results: success (0) revision: e23cf1b38ad4b55416318d205864195d3666b4f3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-28 13:46:11.987397) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-28 13:46:11.987865) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-28 13:46:11.988171) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-28 13:46:12.003002) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 13:46:12.003317) ========= 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=2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-28 13:46:12-- 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% 31.9M=0s 2017-03-28 13:46:12 (31.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.096054 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 13:46:12.113661) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 13:46:12.114007) ========= 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=2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019631 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 13:46:12.164144) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-28 13:46:12.164484) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e23cf1b38ad4b55416318d205864195d3666b4f3 --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 e23cf1b38ad4b55416318d205864195d3666b4f3 --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=2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-28 13:46:12,426 truncating revision to first 12 chars 2017-03-28 13:46:12,426 Setting DEBUG logging. 2017-03-28 13:46:12,426 attempt 1/10 2017-03-28 13:46:12,426 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e23cf1b38ad4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-28 13:46:13,481 unpacking tar archive at: mozilla-central-e23cf1b38ad4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.452551 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-28 13:46:13.631733) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-28 13:46:13.632056) ========= script_repo_revision: e23cf1b38ad4b55416318d205864195d3666b4f3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-28 13:46:13.632470) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-28 13:46:13.632740) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-28 13:46:13.643960) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-28 13:46:13.644323) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:46:13 INFO - MultiFileLogger online at 20170328 13:46:13 in /builds/slave/test 13:46:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 13:46:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:46:14 INFO - {'append_to_log': False, 13:46:14 INFO - 'base_work_dir': '/builds/slave/test', 13:46:14 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 13:46:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:46:14 INFO - 'branch': 'Firefox-Non-PGO', 13:46:14 INFO - 'buildbot_json_path': 'buildprops.json', 13:46:14 INFO - 'config_files': ('talos/linux_config.py',), 13:46:14 INFO - 'default_actions': ('clobber', 13:46:14 INFO - 'read-buildbot-config', 13:46:14 INFO - 'download-and-extract', 13:46:14 INFO - 'populate-webroot', 13:46:14 INFO - 'create-virtualenv', 13:46:14 INFO - 'install', 13:46:14 INFO - 'run-tests'), 13:46:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:46:14 INFO - 'download_minidump_stackwalk': True, 13:46:14 INFO - 'download_symbols': 'ondemand', 13:46:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:46:14 INFO - 'tooltool.py': '/tools/tooltool.py', 13:46:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:46:14 INFO - '/tools/misc-python/virtualenv.py')}, 13:46:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:46:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:46:14 INFO - 'gecko_profile': False, 13:46:14 INFO - 'gecko_profile_interval': 0, 13:46:14 INFO - 'installer_path': 'installer.exe', 13:46:14 INFO - 'log_level': 'info', 13:46:14 INFO - 'log_name': 'talos', 13:46:14 INFO - 'log_to_console': True, 13:46:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:46:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:46:14 INFO - 'opt_config_files': (), 13:46:14 INFO - 'pip_index': False, 13:46:14 INFO - 'suite': 'dromaeojs-e10s', 13:46:14 INFO - 'system_bits': '32', 13:46:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:46:14 INFO - 'title': 'talos-linux64-ix-070', 13:46:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:46:14 INFO - 'use_talos_json': True, 13:46:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:46:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:46:14 INFO - 'work_dir': 'build'} 13:46:14 INFO - [mozharness: 2017-03-28 20:46:14.010117Z] Running clobber step. 13:46:14 INFO - Running pre-action listener: _resource_record_pre_action 13:46:14 INFO - Running main action method: clobber 13:46:14 INFO - rmtree: /builds/slave/test/build 13:46:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:46:15 INFO - Running post-action listener: _resource_record_post_action 13:46:15 INFO - [mozharness: 2017-03-28 20:46:15.469687Z] Finished clobber step (success) 13:46:15 INFO - [mozharness: 2017-03-28 20:46:15.469785Z] Running read-buildbot-config step. 13:46:15 INFO - Running pre-action listener: _resource_record_pre_action 13:46:15 INFO - Running main action method: read_buildbot_config 13:46:15 INFO - Using buildbot properties: 13:46:15 INFO - { 13:46:15 INFO - "project": "", 13:46:15 INFO - "product": "firefox", 13:46:15 INFO - "who": "kwierso@gmail.com", 13:46:15 INFO - "installer_path": "public/build/target.tar.bz2", 13:46:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 13:46:15 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 13:46:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 13:46:15 INFO - "stage_platform": "linux64", 13:46:15 INFO - "basedir": "/builds/slave/test", 13:46:15 INFO - "buildnumber": 776, 13:46:15 INFO - "platform": "ubuntu64_hw", 13:46:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:46:15 INFO - "slavebuilddir": "test", 13:46:15 INFO - "taskId": "LIQ5-G2ZQWWnjxs5VLdbPw", 13:46:15 INFO - "branch": "mozilla-central", 13:46:15 INFO - "script_repo_revision": "production", 13:46:15 INFO - "revision": "e23cf1b38ad4b55416318d205864195d3666b4f3", 13:46:15 INFO - "slavename": "talos-linux64-ix-070", 13:46:15 INFO - "repo_path": "mozilla-central" 13:46:15 INFO - } 13:46:15 INFO - Finding installer, test and symbols from parent task. 13:46:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LIQ5-G2ZQWWnjxs5VLdbPw'}, attempt #1 13:46:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LIQ5-G2ZQWWnjxs5VLdbPw'}, attempt #1 13:46:16 INFO - Task dependencies: LMedsouYShCY44rpV_xw1A 13:46:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A'}, attempt #1 13:46:16 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/target.tar.bz2 13:46:16 INFO - Set test_url: https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/test_packages.json 13:46:16 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/target.crashreporter-symbols.zip 13:46:16 INFO - Running post-action listener: _resource_record_post_action 13:46:16 INFO - [mozharness: 2017-03-28 20:46:16.845999Z] Finished read-buildbot-config step (success) 13:46:16 INFO - [mozharness: 2017-03-28 20:46:16.846217Z] Running download-and-extract step. 13:46:16 INFO - Running pre-action listener: _resource_record_pre_action 13:46:16 INFO - Running main action method: download_and_extract 13:46:16 INFO - mkdir: /builds/slave/test/build/tests 13:46:16 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')]} 13:46:16 INFO - trying https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/target.test_packages.json 13:46:16 INFO - Downloading https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:46:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:46:17 INFO - Downloaded 986 bytes. 13:46:17 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:46:17 INFO - Using the following test package requirements: 13:46:17 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:46:17 INFO - u'common': [u'target.common.tests.zip'], 13:46:17 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:46:17 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:46:17 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:46:17 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:46:17 INFO - u'mozbase': [u'target.common.tests.zip'], 13:46:17 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:46:17 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:46:17 INFO - u'web-platform': [u'target.common.tests.zip', 13:46:17 INFO - u'target.web-platform.tests.zip'], 13:46:17 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:46:17 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 13:46:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/target.common.tests.zip 13:46:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:46:17 INFO - Fetch https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/target.common.tests.zip into memory 13:46:18 INFO - Expected file size: 58221885 13:46:18 INFO - Obtained file size: 58221885 13:46:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 13:46:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/target.common.tests.zip 13:46:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:46:28 INFO - Fetch https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/target.common.tests.zip into memory 13:46:29 INFO - Expected file size: 58221885 13:46:29 INFO - Obtained file size: 58221885 13:46:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/target.talos.tests.zip 13:46:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:46:40 INFO - Fetch https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/target.talos.tests.zip into memory 13:46:41 INFO - Expected file size: 14404171 13:46:41 INFO - Obtained file size: 14404171 13:46:41 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')]} 13:46:41 INFO - trying https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/target.tar.bz2 13:46:41 INFO - Downloading https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:46:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:46:42 INFO - Downloaded 62651265 bytes. 13:46:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/target.tar.bz2 13:46:42 INFO - mkdir: /builds/slave/test/properties 13:46:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:46:42 INFO - Writing to file /builds/slave/test/properties/build_url 13:46:42 INFO - Contents: 13:46:42 INFO - build_url:https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/target.tar.bz2 13:46:42 INFO - Running post-action listener: _resource_record_post_action 13:46:42 INFO - Running post-action listener: set_extra_try_arguments 13:46:42 INFO - [mozharness: 2017-03-28 20:46:42.503096Z] Finished download-and-extract step (success) 13:46:42 INFO - [mozharness: 2017-03-28 20:46:42.503193Z] Running populate-webroot step. 13:46:42 INFO - Running pre-action listener: _resource_record_pre_action 13:46:42 INFO - Running main action method: populate_webroot 13:46:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:46:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:46:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:46:42 INFO - '--tppagecycles', 13:46:42 INFO - '7'], 13:46:42 INFO - 'tests': ['tsvgm']}}, 13:46:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:46:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:46:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:46:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:46:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:46:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:46:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:46:42 INFO - 'talos_options': ['--disable-e10s'], 13:46:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:46:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:46:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:46:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:46:42 INFO - 'talos_options': ['--disable-e10s'], 13:46:42 INFO - 'tests': ['damp', 'tps']}, 13:46:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:46:42 INFO - 'tests': ['damp', 'tps']}, 13:46:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:46:42 INFO - 'tests': ['dromaeo_dom']}, 13:46:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:46:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:46:42 INFO - 'tests': ['basic_compositor_video']}, 13:46:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:46:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:46:42 INFO - 'tests': ['a11yr', 13:46:42 INFO - 'ts_paint', 13:46:42 INFO - 'tpaint', 13:46:42 INFO - 'sessionrestore', 13:46:42 INFO - 'sessionrestore_no_auto_restore', 13:46:42 INFO - 'tabpaint']}, 13:46:42 INFO - 'other-e10s': {'tests': ['a11yr', 13:46:42 INFO - 'ts_paint', 13:46:42 INFO - 'tpaint', 13:46:42 INFO - 'sessionrestore', 13:46:42 INFO - 'sessionrestore_no_auto_restore', 13:46:42 INFO - 'tabpaint']}, 13:46:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:46:42 INFO - 'ts_paint', 13:46:42 INFO - 'tpaint', 13:46:42 INFO - 'sessionrestore', 13:46:42 INFO - 'sessionrestore_no_auto_restore', 13:46:42 INFO - 'tabpaint']}, 13:46:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:46:42 INFO - 'ts_paint', 13:46:42 INFO - 'tpaint', 13:46:42 INFO - 'sessionrestore', 13:46:42 INFO - 'sessionrestore_no_auto_restore', 13:46:42 INFO - 'tabpaint']}, 13:46:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:46:42 INFO - 'tests': ['a11yr', 13:46:42 INFO - 'ts_paint', 13:46:42 INFO - 'tpaint', 13:46:42 INFO - 'sessionrestore', 13:46:42 INFO - 'sessionrestore_no_auto_restore', 13:46:42 INFO - 'tabpaint']}, 13:46:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:46:42 INFO - 'tests': ['a11yr', 13:46:42 INFO - 'ts_paint', 13:46:42 INFO - 'tpaint', 13:46:42 INFO - 'sessionrestore', 13:46:42 INFO - 'sessionrestore_no_auto_restore', 13:46:42 INFO - 'tabpaint']}, 13:46:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:46:42 INFO - 'tests': ['tsvgx', 13:46:42 INFO - 'tsvgr_opacity', 13:46:42 INFO - 'tart', 13:46:42 INFO - 'tscrollx', 13:46:42 INFO - 'cart', 13:46:42 INFO - 'tsvg_static']}, 13:46:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:46:42 INFO - 'tsvgr_opacity', 13:46:42 INFO - 'tart', 13:46:42 INFO - 'tscrollx', 13:46:42 INFO - 'cart', 13:46:42 INFO - 'tsvg_static']}, 13:46:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:46:42 INFO - 'talos_options': ['--disable-e10s'], 13:46:42 INFO - 'tests': ['tp5o']}, 13:46:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:46:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:46:42 INFO - 'talos_options': ['--disable-e10s', 13:46:42 INFO - '--xperf_path', 13:46:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:46:42 INFO - 'tests': ['tp5n']}, 13:46:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:46:42 INFO - 'talos_options': ['--xperf_path', 13:46:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:46:42 INFO - 'tests': ['tp5n']}}, 13:46:42 INFO - 'talos.zip': {'path': '', 13:46:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:46:42 INFO - Running post-action listener: _resource_record_post_action 13:46:42 INFO - [mozharness: 2017-03-28 20:46:42.516558Z] Finished populate-webroot step (success) 13:46:42 INFO - [mozharness: 2017-03-28 20:46:42.516648Z] Running create-virtualenv step. 13:46:42 INFO - Running pre-action listener: _resource_record_pre_action 13:46:42 INFO - Running main action method: create_virtualenv 13:46:42 INFO - Creating virtualenv /builds/slave/test/build/venv 13:46:42 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 13:46:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:46:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:46:42 INFO - Using real prefix '/usr' 13:46:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:46:43 INFO - Installing distribute.............................................................................................................................................................................................done. 13:46:45 INFO - Installing pip.................done. 13:46:45 INFO - Return code: 0 13:46:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:46:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:46:45 INFO - Reading from file tmpfile_stdout 13:46:45 INFO - Output received: 13:46:45 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) 13:46:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2549b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2547290>, '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 0x2547b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548040>, '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': '2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816', '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 13:46:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:46:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:46:45 INFO - Using env: {'DISPLAY': ':0', 13:46:45 INFO - 'HOME': '/home/cltbld', 13:46:45 INFO - 'LANG': 'en_US.UTF-8', 13:46:45 INFO - 'LANGUAGE': 'en_US:en', 13:46:45 INFO - 'LOGNAME': 'cltbld', 13:46:45 INFO - 'MAIL': '/var/mail/cltbld', 13:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:45 INFO - 'MOZ_NO_REMOTE': '1', 13:46:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:45 INFO - 'NO_EM_RESTART': '1', 13:46:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:46:45 INFO - 'PWD': '/builds/slave/test', 13:46:45 INFO - 'SHELL': '/bin/bash', 13:46:45 INFO - 'SHLVL': '1', 13:46:45 INFO - 'TERM': 'linux', 13:46:45 INFO - 'TMOUT': '86400', 13:46:45 INFO - 'USER': 'cltbld', 13:46:45 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816', 13:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:45 INFO - '_': '/tools/buildbot/bin/python'} 13:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:45 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 13:46:45 INFO - Cleaning up... 13:46:45 INFO - Return code: 0 13:46:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2549b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2547290>, '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 0x2547b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548040>, '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': '2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816', '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 13:46:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:46:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:46:45 INFO - Using env: {'DISPLAY': ':0', 13:46:45 INFO - 'HOME': '/home/cltbld', 13:46:45 INFO - 'LANG': 'en_US.UTF-8', 13:46:45 INFO - 'LANGUAGE': 'en_US:en', 13:46:45 INFO - 'LOGNAME': 'cltbld', 13:46:45 INFO - 'MAIL': '/var/mail/cltbld', 13:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:45 INFO - 'MOZ_NO_REMOTE': '1', 13:46:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:45 INFO - 'NO_EM_RESTART': '1', 13:46:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:46:45 INFO - 'PWD': '/builds/slave/test', 13:46:45 INFO - 'SHELL': '/bin/bash', 13:46:45 INFO - 'SHLVL': '1', 13:46:45 INFO - 'TERM': 'linux', 13:46:45 INFO - 'TMOUT': '86400', 13:46:45 INFO - 'USER': 'cltbld', 13:46:45 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816', 13:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:45 INFO - '_': '/tools/buildbot/bin/python'} 13:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:45 INFO - Downloading/unpacking psutil>=3.1.1 13:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:46:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:46:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:46:47 INFO - Installing collected packages: psutil 13:46:47 INFO - Running setup.py install for psutil 13:46:47 INFO - building 'psutil._psutil_linux' extension 13:46:47 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 13:46:48 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 13:46:48 INFO - building 'psutil._psutil_posix' extension 13:46:48 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 13:46:48 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 13:46:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:46:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:46:48 INFO - Successfully installed psutil 13:46:48 INFO - Cleaning up... 13:46:48 INFO - Return code: 0 13:46:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2549b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2547290>, '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 0x2547b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548040>, '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': '2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816', '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 13:46:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:46:48 INFO - Using env: {'DISPLAY': ':0', 13:46:48 INFO - 'HOME': '/home/cltbld', 13:46:48 INFO - 'LANG': 'en_US.UTF-8', 13:46:48 INFO - 'LANGUAGE': 'en_US:en', 13:46:48 INFO - 'LOGNAME': 'cltbld', 13:46:48 INFO - 'MAIL': '/var/mail/cltbld', 13:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:48 INFO - 'MOZ_NO_REMOTE': '1', 13:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:48 INFO - 'NO_EM_RESTART': '1', 13:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:46:48 INFO - 'PWD': '/builds/slave/test', 13:46:48 INFO - 'SHELL': '/bin/bash', 13:46:48 INFO - 'SHLVL': '1', 13:46:48 INFO - 'TERM': 'linux', 13:46:48 INFO - 'TMOUT': '86400', 13:46:48 INFO - 'USER': 'cltbld', 13:46:48 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816', 13:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:48 INFO - '_': '/tools/buildbot/bin/python'} 13:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:46:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:46:50 INFO - Installing collected packages: mozsystemmonitor 13:46:50 INFO - Running setup.py install for mozsystemmonitor 13:46:50 INFO - Successfully installed mozsystemmonitor 13:46:50 INFO - Cleaning up... 13:46:50 INFO - Return code: 0 13:46:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:46:50 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')]} 13:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:50 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')]} 13:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:50 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 0x22ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2549b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2547290>, '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 0x2547b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548040>, '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': '2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816', '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 13:46:50 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 13:46:50 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 13:46:50 INFO - Using env: {'DISPLAY': ':0', 13:46:50 INFO - 'HOME': '/home/cltbld', 13:46:50 INFO - 'LANG': 'en_US.UTF-8', 13:46:50 INFO - 'LANGUAGE': 'en_US:en', 13:46:50 INFO - 'LOGNAME': 'cltbld', 13:46:50 INFO - 'MAIL': '/var/mail/cltbld', 13:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:50 INFO - 'MOZ_NO_REMOTE': '1', 13:46:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:50 INFO - 'NO_EM_RESTART': '1', 13:46:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:46:50 INFO - 'PWD': '/builds/slave/test', 13:46:50 INFO - 'SHELL': '/bin/bash', 13:46:50 INFO - 'SHLVL': '1', 13:46:50 INFO - 'TERM': 'linux', 13:46:50 INFO - 'TMOUT': '86400', 13:46:50 INFO - 'USER': 'cltbld', 13:46:50 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816', 13:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:50 INFO - '_': '/tools/buildbot/bin/python'} 13:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:51 INFO - Downloading/unpacking jsonschema==2.5.1 13:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:46:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:46:53 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 13:46:53 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 13:46:53 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 13:46:53 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 13:46:53 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 13:46:53 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 13:46:53 INFO - Downloading functools32-3.2.3-2.tar.gz 13:46:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:46:53 INFO - warning: no files found matching '*.txt' 13:46:53 INFO - no previously-included directories found matching 'build' 13:46:53 INFO - no previously-included directories found matching 'dist' 13:46:53 INFO - no previously-included directories found matching '.git*' 13:46:53 INFO - Installing collected packages: jsonschema, functools32 13:46:53 INFO - Running setup.py install for functools32 13:46:53 INFO - warning: no files found matching '*.txt' 13:46:53 INFO - no previously-included directories found matching 'build' 13:46:53 INFO - no previously-included directories found matching 'dist' 13:46:53 INFO - no previously-included directories found matching '.git*' 13:46:53 INFO - Successfully installed jsonschema functools32 13:46:53 INFO - Cleaning up... 13:46:53 INFO - Return code: 0 13:46:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:46:53 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')]} 13:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:53 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')]} 13:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:53 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 0x22ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2549b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2547290>, '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 0x2547b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548040>, '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': '2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816', '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 13:46:53 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 13:46:53 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 13:46:53 INFO - Using env: {'DISPLAY': ':0', 13:46:53 INFO - 'HOME': '/home/cltbld', 13:46:53 INFO - 'LANG': 'en_US.UTF-8', 13:46:53 INFO - 'LANGUAGE': 'en_US:en', 13:46:53 INFO - 'LOGNAME': 'cltbld', 13:46:53 INFO - 'MAIL': '/var/mail/cltbld', 13:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:53 INFO - 'MOZ_NO_REMOTE': '1', 13:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:53 INFO - 'NO_EM_RESTART': '1', 13:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:46:53 INFO - 'PWD': '/builds/slave/test', 13:46:53 INFO - 'SHELL': '/bin/bash', 13:46:53 INFO - 'SHLVL': '1', 13:46:53 INFO - 'TERM': 'linux', 13:46:53 INFO - 'TMOUT': '86400', 13:46:53 INFO - 'USER': 'cltbld', 13:46:53 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816', 13:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:53 INFO - '_': '/tools/buildbot/bin/python'} 13:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:46:53 INFO - Cleaning up... 13:46:53 INFO - Return code: 0 13:46:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:46:53 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')]} 13:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:53 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')]} 13:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:53 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 0x22ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2549b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2547290>, '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 0x2547b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548040>, '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': '2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816', '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 13:46:53 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 13:46:53 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 13:46:53 INFO - Using env: {'DISPLAY': ':0', 13:46:53 INFO - 'HOME': '/home/cltbld', 13:46:53 INFO - 'LANG': 'en_US.UTF-8', 13:46:53 INFO - 'LANGUAGE': 'en_US:en', 13:46:53 INFO - 'LOGNAME': 'cltbld', 13:46:53 INFO - 'MAIL': '/var/mail/cltbld', 13:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:53 INFO - 'MOZ_NO_REMOTE': '1', 13:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:53 INFO - 'NO_EM_RESTART': '1', 13:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:46:53 INFO - 'PWD': '/builds/slave/test', 13:46:53 INFO - 'SHELL': '/bin/bash', 13:46:53 INFO - 'SHLVL': '1', 13:46:53 INFO - 'TERM': 'linux', 13:46:53 INFO - 'TMOUT': '86400', 13:46:53 INFO - 'USER': 'cltbld', 13:46:53 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816', 13:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:53 INFO - '_': '/tools/buildbot/bin/python'} 13:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:54 INFO - Downloading/unpacking blobuploader==1.2.4 13:46:54 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 13:46:54 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 13:46:54 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 13:46:54 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 13:46:54 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 13:46:54 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 13:46:56 INFO - Downloading blobuploader-1.2.4.tar.gz 13:46:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:46:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:46:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:56 INFO - Downloading docopt-0.6.1.tar.gz 13:46:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:46:57 INFO - Installing collected packages: blobuploader, requests, docopt 13:46:57 INFO - Running setup.py install for blobuploader 13:46:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:46:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:46:57 INFO - Running setup.py install for requests 13:46:57 INFO - Running setup.py install for docopt 13:46:57 INFO - Successfully installed blobuploader requests docopt 13:46:57 INFO - Cleaning up... 13:46:57 INFO - Return code: 0 13:46:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:46: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')]} 13:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46: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')]} 13:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:57 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 0x22ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2549b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2547290>, '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 0x2547b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548040>, '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': '2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816', '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 13:46:57 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 13:46:57 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 13:46:57 INFO - Using env: {'DISPLAY': ':0', 13:46:57 INFO - 'HOME': '/home/cltbld', 13:46:57 INFO - 'LANG': 'en_US.UTF-8', 13:46:57 INFO - 'LANGUAGE': 'en_US:en', 13:46:57 INFO - 'LOGNAME': 'cltbld', 13:46:57 INFO - 'MAIL': '/var/mail/cltbld', 13:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:57 INFO - 'MOZ_NO_REMOTE': '1', 13:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:57 INFO - 'NO_EM_RESTART': '1', 13:46:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:46:57 INFO - 'PWD': '/builds/slave/test', 13:46:57 INFO - 'SHELL': '/bin/bash', 13:46:57 INFO - 'SHLVL': '1', 13:46:57 INFO - 'TERM': 'linux', 13:46:57 INFO - 'TMOUT': '86400', 13:46:57 INFO - 'USER': 'cltbld', 13:46:57 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816', 13:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:57 INFO - '_': '/tools/buildbot/bin/python'} 13:46:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:46:57 INFO - Running setup.py (path:/tmp/pip-0RVXNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:46:57 INFO - Running setup.py (path:/tmp/pip-Yzj5l1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:46:58 INFO - Running setup.py (path:/tmp/pip-Kz0Q4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:46:58 INFO - Running setup.py (path:/tmp/pip-zry_2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:46:58 INFO - Running setup.py (path:/tmp/pip-Aazi2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:46:58 INFO - Running setup.py (path:/tmp/pip-_sM0ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:46:58 INFO - Running setup.py (path:/tmp/pip-zXyUlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:46:58 INFO - Running setup.py (path:/tmp/pip-5Xn8we-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:46:58 INFO - Running setup.py (path:/tmp/pip-snwAX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:46:58 INFO - Running setup.py (path:/tmp/pip-PCynnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:46:58 INFO - Running setup.py (path:/tmp/pip-rXlK28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:46:58 INFO - Running setup.py (path:/tmp/pip-uyBXtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:46:58 INFO - Running setup.py (path:/tmp/pip-5nJNcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:46:58 INFO - Running setup.py (path:/tmp/pip-bIhi2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:46:58 INFO - Running setup.py (path:/tmp/pip-0auV_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:46:59 INFO - Running setup.py (path:/tmp/pip-433fp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:46:59 INFO - Running setup.py (path:/tmp/pip-I1GHFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:46:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:46:59 INFO - Running setup.py install for manifestparser 13:46:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:46:59 INFO - Running setup.py install for mozcrash 13:46:59 INFO - Running setup.py install for mozdebug 13:46:59 INFO - Running setup.py install for mozdevice 13:46:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:46:59 INFO - Running setup.py install for mozfile 13:46:59 INFO - Running setup.py install for mozhttpd 13:46:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:46:59 INFO - Running setup.py install for mozinfo 13:46:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:46:59 INFO - Running setup.py install for mozInstall 13:46:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:46:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:46:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:46:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:47:00 INFO - Running setup.py install for mozleak 13:47:00 INFO - Running setup.py install for mozlog 13:47:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:47:00 INFO - Running setup.py install for moznetwork 13:47:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:47:00 INFO - Running setup.py install for mozprocess 13:47:00 INFO - Running setup.py install for mozprofile 13:47:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:47:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:47:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:47:00 INFO - Running setup.py install for mozrunner 13:47:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:47:00 INFO - Running setup.py install for mozscreenshot 13:47:00 INFO - Running setup.py install for moztest 13:47:00 INFO - Running setup.py install for mozversion 13:47:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:47:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:47:00 INFO - Cleaning up... 13:47:01 INFO - Return code: 0 13:47:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:47:01 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')]} 13:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:01 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')]} 13:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:01 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 0x22ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2549b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2547290>, '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 0x2547b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548040>, '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': '2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816', '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 13:47:01 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 13:47:01 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 13:47:01 INFO - Using env: {'DISPLAY': ':0', 13:47:01 INFO - 'HOME': '/home/cltbld', 13:47:01 INFO - 'LANG': 'en_US.UTF-8', 13:47:01 INFO - 'LANGUAGE': 'en_US:en', 13:47:01 INFO - 'LOGNAME': 'cltbld', 13:47:01 INFO - 'MAIL': '/var/mail/cltbld', 13:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:01 INFO - 'MOZ_NO_REMOTE': '1', 13:47:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:01 INFO - 'NO_EM_RESTART': '1', 13:47:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:01 INFO - 'PWD': '/builds/slave/test', 13:47:01 INFO - 'SHELL': '/bin/bash', 13:47:01 INFO - 'SHLVL': '1', 13:47:01 INFO - 'TERM': 'linux', 13:47:01 INFO - 'TMOUT': '86400', 13:47:01 INFO - 'USER': 'cltbld', 13:47:01 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816', 13:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:01 INFO - '_': '/tools/buildbot/bin/python'} 13:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:47:01 INFO - Running setup.py (path:/tmp/pip-amxEpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:47:01 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)) 13:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:47:01 INFO - Running setup.py (path:/tmp/pip-q8lw89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:47:01 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)) 13:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:47:01 INFO - Running setup.py (path:/tmp/pip-8j3Nh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:47:01 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)) 13:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:47:01 INFO - Running setup.py (path:/tmp/pip-oCzU5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:47:01 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)) 13:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:47:01 INFO - Running setup.py (path:/tmp/pip-uXSgbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:47:01 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)) 13:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:47:01 INFO - Running setup.py (path:/tmp/pip-v9fU4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:47:01 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)) 13:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:47:01 INFO - Running setup.py (path:/tmp/pip-UevHcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:47:01 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)) 13:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:47:01 INFO - Running setup.py (path:/tmp/pip-GmI4CK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:47:01 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)) 13:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:47:01 INFO - Running setup.py (path:/tmp/pip-X2BeWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:47:01 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)) 13:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:47:01 INFO - Running setup.py (path:/tmp/pip-QIgrXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:47:01 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)) 13:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:47:01 INFO - Running setup.py (path:/tmp/pip-O2pB4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:47:02 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)) 13:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:47:02 INFO - Running setup.py (path:/tmp/pip-v0m4jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:47:02 INFO - Running setup.py (path:/tmp/pip-HtbsWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:47:02 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)) 13:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:47:02 INFO - Running setup.py (path:/tmp/pip-ccLb11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:47:02 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)) 13:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:47:02 INFO - Running setup.py (path:/tmp/pip-ndb1G0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:47:02 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)) 13:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:47:02 INFO - Running setup.py (path:/tmp/pip-XJWZyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:47:02 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)) 13:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:47:02 INFO - Running setup.py (path:/tmp/pip-7iKcex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:47:02 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)) 13:47:02 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)) 13:47:02 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)) 13:47:02 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)) 13:47:02 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)) 13:47:02 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)) 13:47:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:02 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 13:47:02 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 13:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:04 INFO - Downloading blessings-1.6.tar.gz 13:47:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:47:04 INFO - Installing collected packages: blessings 13:47:04 INFO - Running setup.py install for blessings 13:47:04 INFO - Successfully installed blessings 13:47:04 INFO - Cleaning up... 13:47:04 INFO - Return code: 0 13:47:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:47:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:47:04 INFO - Reading from file tmpfile_stdout 13:47:04 INFO - Current package versions: 13:47:04 INFO - argparse == 1.2.1 13:47:04 INFO - blessings == 1.6 13:47:04 INFO - blobuploader == 1.2.4 13:47:04 INFO - docopt == 0.6.1 13:47:04 INFO - functools32 == 3.2.3-2 13:47:04 INFO - jsonschema == 2.5.1 13:47:04 INFO - manifestparser == 1.1 13:47:04 INFO - mozInstall == 1.12 13:47:04 INFO - mozcrash == 1.0 13:47:04 INFO - mozdebug == 0.1 13:47:04 INFO - mozdevice == 0.49 13:47:04 INFO - mozfile == 1.2 13:47:04 INFO - mozhttpd == 0.7 13:47:04 INFO - mozinfo == 0.9 13:47:04 INFO - mozleak == 0.1 13:47:04 INFO - mozlog == 3.4 13:47:04 INFO - moznetwork == 0.27 13:47:04 INFO - mozprocess == 0.25 13:47:04 INFO - mozprofile == 0.28 13:47:04 INFO - mozrunner == 6.13 13:47:04 INFO - mozscreenshot == 0.1 13:47:04 INFO - mozsystemmonitor == 0.3 13:47:04 INFO - moztest == 0.8 13:47:04 INFO - mozversion == 1.4 13:47:04 INFO - psutil == 3.1.1 13:47:04 INFO - requests == 1.2.3 13:47:04 INFO - wsgiref == 0.1.2 13:47:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:47:04 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')]} 13:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:04 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')]} 13:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:04 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 0x22ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2549b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2547290>, '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 0x2547b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548040>, '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': '2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816', '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 13:47:04 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 13:47:04 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 13:47:04 INFO - Using env: {'DISPLAY': ':0', 13:47:04 INFO - 'HOME': '/home/cltbld', 13:47:04 INFO - 'LANG': 'en_US.UTF-8', 13:47:04 INFO - 'LANGUAGE': 'en_US:en', 13:47:04 INFO - 'LOGNAME': 'cltbld', 13:47:04 INFO - 'MAIL': '/var/mail/cltbld', 13:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:04 INFO - 'MOZ_NO_REMOTE': '1', 13:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:04 INFO - 'NO_EM_RESTART': '1', 13:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:04 INFO - 'PWD': '/builds/slave/test', 13:47:04 INFO - 'SHELL': '/bin/bash', 13:47:04 INFO - 'SHLVL': '1', 13:47:04 INFO - 'TERM': 'linux', 13:47:04 INFO - 'TMOUT': '86400', 13:47:04 INFO - 'USER': 'cltbld', 13:47:04 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816', 13:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:04 INFO - '_': '/tools/buildbot/bin/python'} 13:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:05 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)) 13:47:05 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)) 13:47:05 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)) 13:47:05 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)) 13:47:05 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)) 13:47:05 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)) 13:47:05 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)) 13:47:05 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)) 13:47:05 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)) 13:47:05 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)) 13:47:05 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)) 13:47:05 INFO - Cleaning up... 13:47:05 INFO - Return code: 0 13:47:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:47:05 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')]} 13:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:05 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')]} 13:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:05 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 0x22ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2549b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2547290>, '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 0x2547b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548040>, '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': '2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816', '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 13:47:05 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 13:47:05 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 13:47:05 INFO - Using env: {'DISPLAY': ':0', 13:47:05 INFO - 'HOME': '/home/cltbld', 13:47:05 INFO - 'LANG': 'en_US.UTF-8', 13:47:05 INFO - 'LANGUAGE': 'en_US:en', 13:47:05 INFO - 'LOGNAME': 'cltbld', 13:47:05 INFO - 'MAIL': '/var/mail/cltbld', 13:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:05 INFO - 'MOZ_NO_REMOTE': '1', 13:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:05 INFO - 'NO_EM_RESTART': '1', 13:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:05 INFO - 'PWD': '/builds/slave/test', 13:47:05 INFO - 'SHELL': '/bin/bash', 13:47:05 INFO - 'SHLVL': '1', 13:47:05 INFO - 'TERM': 'linux', 13:47:05 INFO - 'TMOUT': '86400', 13:47:05 INFO - 'USER': 'cltbld', 13:47:05 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816', 13:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:05 INFO - '_': '/tools/buildbot/bin/python'} 13:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:47:05 INFO - Cleaning up... 13:47:05 INFO - Return code: 0 13:47:05 INFO - Running post-action listener: _resource_record_post_action 13:47:05 INFO - Running post-action listener: _start_resource_monitoring 13:47:05 INFO - Starting resource monitoring. 13:47:05 INFO - [mozharness: 2017-03-28 20:47:05.435112Z] Finished create-virtualenv step (success) 13:47:05 INFO - [mozharness: 2017-03-28 20:47:05.435635Z] Running install step. 13:47:05 INFO - Running pre-action listener: _resource_record_pre_action 13:47:05 INFO - Running main action method: install 13:47:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:47:05 INFO - Reading from file tmpfile_stdout 13:47:05 INFO - Detecting whether we're running mozinstall >=1.0... 13:47:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:47:05 INFO - Reading from file tmpfile_stdout 13:47:05 INFO - Output received: 13:47:05 INFO - Usage: mozinstall [options] installer 13:47:05 INFO - Options: 13:47:05 INFO - -h, --help show this help message and exit 13:47:05 INFO - -d DEST, --destination=DEST 13:47:05 INFO - Directory to install application into. [default: 13:47:05 INFO - "/builds/slave/test"] 13:47:05 INFO - --app=APP Application being installed. [default: firefox] 13:47:05 INFO - mkdir: /builds/slave/test/build/application 13:47:05 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'] 13:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:47:21 INFO - Reading from file tmpfile_stdout 13:47:21 INFO - Output received: 13:47:21 INFO - /builds/slave/test/build/application/firefox/firefox 13:47:21 INFO - Running post-action listener: _resource_record_post_action 13:47:21 INFO - [mozharness: 2017-03-28 20:47:21.400504Z] Finished install step (success) 13:47:21 INFO - [mozharness: 2017-03-28 20:47:21.400780Z] Running run-tests step. 13:47:21 INFO - Running pre-action listener: _resource_record_pre_action 13:47:21 INFO - Running main action method: run_tests 13:47:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:47:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:47:21 INFO - Python 2.7.3 13:47:21 INFO - Return code: 0 13:47:21 INFO - grabbing minidump binary from tooltool 13:47: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')]} 13:47:21 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 0x2547290>, '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 0x2547b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:47:21 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 13:47:21 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 13:47:21 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 13:47:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:47:21 INFO - Return code: 0 13:47:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:47:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:47:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:47:21 INFO - ENV: RUST_BACKTRACE is now 1 13:47:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:47:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:47:21 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:47:21 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-070 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:47:21 INFO - Using env: {'DISPLAY': ':0', 13:47:21 INFO - 'HOME': '/home/cltbld', 13:47:21 INFO - 'LANG': 'en_US.UTF-8', 13:47:21 INFO - 'LANGUAGE': 'en_US:en', 13:47:21 INFO - 'LOGNAME': 'cltbld', 13:47:21 INFO - 'MAIL': '/var/mail/cltbld', 13:47:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:47:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:21 INFO - 'MOZ_NO_REMOTE': '1', 13:47:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:47:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:21 INFO - 'NO_EM_RESTART': '1', 13:47:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:21 INFO - 'PWD': '/builds/slave/test', 13:47:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:47:21 INFO - 'RUST_BACKTRACE': '1', 13:47:21 INFO - 'SHELL': '/bin/bash', 13:47:21 INFO - 'SHLVL': '1', 13:47:21 INFO - 'TERM': 'linux', 13:47:21 INFO - 'TMOUT': '86400', 13:47:21 INFO - 'USER': 'cltbld', 13:47:21 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816', 13:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:21 INFO - '_': '/tools/buildbot/bin/python'} 13:47:21 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:47:21 INFO - mozversion application_buildid: 20170328201607 13:47:21 INFO - mozversion application_changeset: e23cf1b38ad4b55416318d205864195d3666b4f3 13:47:21 INFO - mozversion application_display_name: Nightly 13:47:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:47:21 INFO - mozversion application_name: Firefox 13:47:21 INFO - mozversion application_remotingname: firefox 13:47:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:47:21 INFO - mozversion application_vendor: Mozilla 13:47:21 INFO - mozversion application_version: 55.0a1 13:47:21 INFO - mozversion platform_buildid: 20170328201607 13:47:21 INFO - mozversion platform_changeset: e23cf1b38ad4b55416318d205864195d3666b4f3 13:47:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:47:21 INFO - mozversion platform_version: 55.0a1 13:47:21 INFO - using testdate: 1490734041 13:47:21 INFO - actual date: 1490734041 13:47:21 INFO - starting webserver on 'localhost:34631' 13:47:21 INFO - SUITE-START | Running 2 tests 13:47:21 INFO - TEST-START | dromaeo_css 13:47:21 INFO - operating with platform_type : linux_ 13:47:21 INFO - Initialising browser for dromaeo_css test... 13:47:21 INFO - TEST-INFO | started process 28369 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpewsPZi/profile http://localhost:34631/getInfo.html) 13:47:25 INFO - PID 28369 | __metrics Screen width/height:1600/1200 13:47:25 INFO - PID 28369 | colorDepth:24 13:47:25 INFO - PID 28369 | Browser inner width/height: 1024/697 13:47:25 INFO - PID 28369 | __metrics 13:47:26 ERROR - PID 28369 | 1490734046760 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6376:36 < canClose@browser.js:5227:12 < forceQuit@jar:file:///tmp/tmpewsPZi/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpewsPZi/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpewsPZi/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpewsPZi/profile/extensions/talos-powers@TalosPowersService.js:55:9 13:47:26 ERROR - PID 28369 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 13:47:27 INFO - TEST-INFO | 28369: exit 0 13:47:27 INFO - Browser initialized. 13:47:27 INFO - Running cycle 1/1 for dromaeo_css test... 13:47:27 INFO - TEST-INFO | started process 28503 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpewsPZi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:47:39 INFO - PID 28503 | RSS: Main: 156336128 13:47:39 INFO - PID 28503 | 13:50:45 INFO - PID 28503 | Cycle 1(1): loaded http://localhost:34631/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34631/tests/dromaeo/cssquery-ext.html) 13:50:46 INFO - PID 28503 | RSS: Main: 165519360 13:50:46 INFO - PID 28503 | 13:52:28 INFO - PID 28503 | ************************* 13:52:28 INFO - PID 28503 | A coding exception was thrown and uncaught in a Task. 13:52:28 INFO - PID 28503 | 13:52:28 ERROR - PID 28503 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:52:28 INFO - PID 28503 | Full stack: 13:52:28 INFO - PID 28503 | ************************* 13:52:28 INFO - PID 28503 | ************************* 13:52:28 INFO - PID 28503 | A coding exception was thrown and uncaught in a Task. 13:52:28 INFO - PID 28503 | 13:52:28 ERROR - PID 28503 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:52:28 INFO - PID 28503 | Full stack: 13:52:28 INFO - PID 28503 | ************************* 13:52:28 INFO - PID 28503 | ************************* 13:52:28 INFO - PID 28503 | A coding exception was thrown and uncaught in a Task. 13:52:28 INFO - PID 28503 | 13:52:28 ERROR - PID 28503 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:52:28 INFO - PID 28503 | Full stack: 13:52:28 INFO - PID 28503 | ************************* 13:52:28 INFO - PID 28503 | ************************* 13:52:28 INFO - PID 28503 | A coding exception was thrown and uncaught in a Task. 13:52:28 INFO - PID 28503 | 13:52:28 ERROR - PID 28503 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:52:28 INFO - PID 28503 | Full stack: 13:52:28 INFO - PID 28503 | ************************* 13:53:49 INFO - PID 28503 | Cycle 1(1): loaded http://localhost:34631/tests/dromaeo/cssquery-ext.html (next: http://localhost:34631/tests/dromaeo/cssquery-jquery.html) 13:53:49 INFO - PID 28503 | RSS: Main: 161271808 13:53:49 INFO - PID 28503 | 13:56:51 INFO - PID 28503 | Cycle 1(1): loaded http://localhost:34631/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34631/tests/dromaeo/cssquery-mootools.html) 13:56:52 INFO - PID 28503 | RSS: Main: 169455616 13:56:52 INFO - PID 28503 | 13:59:54 INFO - PID 28503 | Cycle 1(1): loaded http://localhost:34631/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34631/tests/dromaeo/cssquery-prototype.html) 13:59:54 INFO - PID 28503 | RSS: Main: 162246656 13:59:54 INFO - PID 28503 | 14:02:57 INFO - PID 28503 | Cycle 1(1): loaded http://localhost:34631/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34631/tests/dromaeo/cssquery-yui.html) 14:02:58 INFO - PID 28503 | RSS: Main: 169762816 14:02:58 INFO - PID 28503 | 14:06:01 INFO - PID 28503 | Cycle 1(1): loaded http://localhost:34631/tests/dromaeo/cssquery-yui.html (next: http://localhost:34631/tests/dromaeo/cssquery-dojo.html) 14:06:01 INFO - PID 28503 | RSS: Main: 162668544 14:06:01 INFO - PID 28503 | 14:06:01 INFO - PID 28503 | __start_tp_report 14:06:01 INFO - PID 28503 | _x_x_mozilla_page_load 14:06:01 INFO - PID 28503 | _x_x_mozilla_page_load_details 14:06:01 INFO - PID 28503 | |i|pagename|runs| 14:06:01 INFO - PID 28503 | |0;dojo.html;2706.418120104178;2727.6454060972096;2743.8079334446584;2761.447710457909;2774.2786875412385;5052.84841454756;5213.452587478312;5227.163653815391;5271.762770675319;5301.7879284828605;5086.771095300711;5159.355080614923;5191.480851914806;5230.398504172022;5255.395629502608;4726.669133160672;4739.0758802033615;4776.8566942991765;4777.498362671921;4808.422989241296;4766.618670506368;4788.377510923592;4824.035192961422;4835.8549243522575;4870.391201099863;4762.618990480753;4764.690295130806;4771.904561908743;4778.187708089633;4812.542808433193;4725.598324142452;4736.9526304736855;4742.099001189763;4771.642126840501;4778.4982576829625;4630.791614377327;4691.62467002639;4714.882127946795;4724.480307166209;4759.833405830779;4916.58209052231;4977.477364876709;5122.180451127839;5149.974250128763;5218.321618189611;5580.553555715574;5589.245451863987;5599.936012157717;5626.690532020737;5658.688772117532;5637.041702910515;5651.9717401413145;5657.43425657431;5665.773369065232;5669.8582535436535;4993.6005119590345;5084.44071152173;5230.08473517133;5254.500822421864;5314.229436731653;5776.855578610484;5782.566307526952;5809.2738407699035;5843.415658434207;5855.912161317584;5291.206319052173;5356.357237131491;5480.890382192334;5523.6685798852195;5527.50252477279;5540.972295138579;5541.5289700375915;5613.887722245614;5620.606557541015;5640.8871822563315;5359.356877174764;5451.591130665216;5533.972330138324;5559.610827242135;5566.916496252559;5585.972070139624;5586.1062230043;5593.804216852391;5624.0439125348785;5635.633683810539;4638.95361046392;4651.418572678415;4656.348111264426;4662.137504561667;4700.670953033323;3874.651281384689;3914.4128380742545;3975.3639417693607;3997.620226078518;4018.3369743991916;4763.976180119146;4774.665773395829;4790.233562629963;4811.639127065414;4818.277258411266;5566.220729097849;5570.888582228414;5570.972145139248;5573.5819813514145;5576.7211639417865;4627.676062675648;4730.976345118322;4737.336772851803;4737.739424331626;4789.736564488987;4828.903421931542;4859.368282123372;4869.878253043702;4877.487863774323;4882.536159064884;5118.872028199325;5118.948810511996;5120.2319652051;5121.692698438105;5122.538971492583;5421.159720243211;5475.5072043516275;5476.67139971603;5491.395946445968;5495.422980587141;5154.226865970135;5161.561267292323;5163.922541161961;5174.379074511083;5191.143461328989;5459;5460.099083651312;5541.639793413416;5577.358603760619;5577.693226872561;5449.863753406196;5505.421930697219;5598.636088654224;5633.915491267716;5635.070213414904;5421.945780542302;5422.972885135549;5433.9456605435025;5434.510894019557;5437.912417516433;5274.97362513185;5328.520433161034;5339.786408543615;5413.160960051198;5429.565634749131;5379.1393377059485;5386.542143917811;5389.380221274603;5419.485148910847;5445.373782015119;5455.8363249102595;5472.562195024469;5503.036968530571;5518.117101263779;5554.389017208185;5164.715940623302;5238.083335416363;5340.706261155674;5343.492368225013;5355.732213389237 14:06:01 INFO - PID 28503 | |1;ext.html;671.1107782188601;726.5386479585463;737.0124033794714;1039.0544604409984;1044.9582016719332;31851.681483185163;32632.347353052926;32679.67320326796;32740.67259327406;32757.18107047322;33982.60173982607;34494;36850.8157459213;36899.26201475969;36994;7322.670479828421;7448.0317558717425;7479.663415146331;7656;7661.425393095512;7470.551766894004;7577.204393538682;7577.507462014979;7583.734569290076;7591.278828511283;7571.318581327707;7584.165741768401;7632.427567932427;7766.301032907038;7799;7707.537547747125;7729.111152217511;7729.922700773032;7743.457957942946;7766.689332426696;7382.963085184593;7474.7383841565825;7492.763693990485;7499.775006749752;7501.399888008947;34686.30627387438;34995;35034;35050.474242886376;35059;2597.5186991546993;2621.3315604520917;2622.0995624879088;2627.658404407434;2674.1977406777887;21839.890800545894;21873.343799686034;22241.332760017227;22291.77708222913;22884.31347059591;2718.4563087382603;2763.295359683268;2771.1825011621418;2772.36235665796;2785.6935737068907;109083;112071;121576.39211803884;123128.38435807763;123264;38357.232855342736;38479.61520384761;38592.42111368332;38636.90904727615;38689.22621547553;39974.80012599919;39993.60006399957;40003.39994900079;40013.79993100016;40041.79979100144;12185.268883866996;12325.630231093082;12334.568290109803;12344.938275308567;12346.629601111981;10147.847782283272;10149.086582207488;10152;10182.847257291147;10204.030617091365;13262.668433289246;13435.932820335836;13445.193288402726;13463.663408414868;13536.729265414833;5445.673259604437;5529.391766905637;5685.800996965087;5696.943030569724;5699.344575373885;866.2853146154448;867.5575456517096;884.8539990901429;892.5403417240127;913.72588223534;20262.696059558824;21184.04671789773;21276.78723212748;21356.679649805264;21469.355919322134;961.9134277915022;963.5375019990444;982.7051884434641;988.5946761827616;989.0208693393489;10923.945380273048;10956.945215273872;11181.776364472666;11228.270162439416;11228.775424491465;228649;230571;230912;231709;232954;41697.37453938193;42529.787351063045;42565.36151957723;42605.36091958623;42717.57282427198;1179.504608064615;1234.4074844074894;1243.9689007774698;1244.0918129765323;1253.035162924543;20112.59774804525;20114.89942550278;20148;20495.180192792122;20977.790222097585;30512.84743576268;34246.315073697886;34737.39469539845;35255.82372088123;35344.64655353517;201313;204985;251668;252105;252480;22071.448213794785;22707.545849083257;25906.870465647553;26322.446987579562;29748.55377169301;34605.30789384249;34617;34830.47754283738;34875.47686784751;34937.126571835906;26701.599476007486;26829.329266767705;27233.281010987914;27642.723572764015;28472.288192795346;28278.717212827607;28354.574681379385;28498.430031399672;28657.42685146327;29484.55773163447;31177.8441107793;31673.683263167994;31885.840570796998;31931.201719957186;31962.68037319597;27034.594481082408;27348.316292092855;27488.312792180357;27635.585466218425;28851.855740721163;20228.19087236553;22080.11679532865;22129.66805497951;22223.22218722337;22264.443388915406 14:06:01 INFO - PID 28503 | |2;jquery.html;406.69497876592555;421.2186394238689;429.7743684565602;436.1538615086732;441.2895238665748;16681.916590417048;17288.049157296344;17363.826361736377;17810.465686029438;18740.156692948814;18384;18610.34863779768;18702.625947481043;18840.623187536243;18886.150123244453;5754.16564598133;5767.740451679674;5840.06558950568;5856.590038697293;5869.9706501467435;5709.77160913563;5772.884542309152;5830.883382332351;5831.941680583203;5835.854103647422;5630.521405680522;5669.6314739542;5701.486866182043;5722.914156287638;5723.599348045638;5550.91673624896;5763.164341170528;5787.681677507735;5794.304683437993;5806.477417032487;5158;5190.636655434121;5206.609504287194;5245.318108645852;5250.789968401259;22476.550468990692;22613.660795088086;23061.7693823063;23136.305910822703;23365;1558.8597026267578;1590.4194968836407;1608.388812251337;1637.8116516600624;1656.7266401043814;13681.384337704827;14253.429862805475;14353.425862965469;14664.193469359181;14924.2537873107;1701.9829801701949;1716.1933891071176;1743.2765402358007;1745.4763570928671;1775.0326072290632;88958.8801399825;90080.54959725225;90977.54511227402;91601.62597561043;94302.05697943001;10969.725756856142;11091.500882460308;11211.38337391435;11248.887511124947;11339.376334301527;15443.768343474632;15458.845411545966;15483.5354939352;15492.767608485881;15521.301541430663;7128.714851405989;7338.853222935511;7514.736984205527;7559.508631938907;7618.885716714254;6521.413072823469;6574.5397822152945;6705.061291419205;6816.829579260459;6821.420179284717;7108.881605244216;7133.179684336368;7229.486357132242;7281.5631062136445;7355.3153099118435;2026.638965605083;2051.405092523152;2060.330392622404;2072.3782865140397;2095.245711543843;831.2477208126655;856.8928883889514;869.0527325215545;874.0734821089666;881.8131035033153;16529;16708.83291167073;17047.573810654583;17445.581792290624;17611.647767044586;862.6721845698594;887.8224355129;892.4422236102436;895.5611750242465;904.6426661468684;8825.161609647073;9015.63937442508;9428.717138485856;9449.90550094504;9504.857427138599;450900;455893;462515;472575.6371218122;473913;85427.57286213529;85466;86442.56778716066;87252.56373718091;88410.55794720985;1050.2963014780116;1071.678496451077;1075.774087441646;1080.7358583766995;1085.2457542008228;13960.2321872298;14304.499342522962;14394.20831854258;14689.265536722907;14982.325795339018;40542.59457405506;40580.59419405768;40964.79517602393;41267.38098928578;41377.0080121186;51261;51798.48201517937;52087.479125208265;54000.45999539954;54430.455695442535;5842.766289348378;7826.295633393022;7851.646675899712;7913;8075.273225409741;11330.830037549607;11963.700907477383;12050.819237711617;12113.636590902288;12534.561290354794;10318.48407579603;10523.368597884151;10875.564977401133;10910.509027093958;10979;10263.12763415118;10290.228232882713;10322.638707645196;10440.791184176425;10445.425501597181;10087.24345674092;10432.791344173225;10603.469826508797;10947.726306842393;10980.231383803377;7971.960140199262;7999.120096789232;8121.675132994614;8253.174682531699;8289.4197406181;10298.794024119326;10409.271351005356;10493.632722854663;10571.841422378824;10777.730556736144 14:06:01 INFO - PID 28503 | |3;mootools.html;1266.0884163402347;1331.8401791784975;1340.7318536292744;1342.2349260921276;1347.3061373392704;9164.450132992017;9499.335046546745;9522.76193095173;9790.06994335537;10024.147947424459;10058.547365368559;10249.590016399336;10254.128399086068;10255.33340332878;10271.948640256789;2289.954200915985;2307.5038866643667;2310.214527060799;2312.4103353644796;2321.883905804703;2188.1684959715367;2239.9216027439043;2316.9536609267802;2330.254318618043;2332.5101728637005;2227.676986836908;2231.542533780571;2250.8649481031107;2264.1056782570877;2323.012719594174;2105.4315334859657;2150.956980860382;2159.622066138435;2160.6758986152045;2162.9026693798737;1887.1790771014516;1949.0936714427717;2156.762756096828;2175.945601359979;2196.890155492235;9698.563564639608;9741.756456088584;9758.90241097587;9792.755181120458;10075.143612792921;5506.807261745819;5705.087186050212;5713.200151978726;5715.399883012307;5724.284464441945;3225.145336485833;3271.7382609391193;3331.083951913219;3342.5153352763955;3360.1263671445354;979.5396163803001;986.1371300112402;1022.9795404091951;1048.835792270579;1051;14643.487477938328;14656.926715366462;14723.337449814784;14738.336774845051;14758.778618320734;4761.2382018876815;4991.500849915052;5075.314832497639;5150.253213284052;5151.7166555839785;10945.671629851116;10978.341299521895;10983.176261780398;10989.175811814146;11003.064739497073;5647.237622920853;5660;5669.433056694297;5680.602357834994;5689.175069614966;5076.111680455905;5116.769745361393;5162.802293692346;5237.816676416307;5298.443663415363;3875.256134739322;3969.622885825842;3984.880453586397;4043.636072753466;4046.1503084352025;1162.3490845126755;1171.841801356823;1173.0849937049115;1173.7417768091007;1183.6981569699672;631.608402790273;656.5404217048085;656.9343065693392;665.4842497064717;670.5038271678923;5042.243663450438;5080.618953578496;5131.640785145004;5161.3032240647035;5291.788328466818;537.2022546518417;551.8179000929764;555.0868820789859;556.7661582135513;556.8635684257301;3530.435130379127;3681.5029970954115;3687.078230442389;3701.8889433317045;3797.886063418102;12650;13255;13358.198508089547;13394.531191408254;13395.330233488286;12585.181963172365;12796.976241900626;13047.478100875858;13103.2138071716;13212.141210821266;8994.505302208441;9033.554631259098;9065.954670226607;9075.954620226856;9145.0397708241;5651.802186923438;5736.856578585569;5801.506871915934;5846.912296315644;5897.112933778924;11273.323600583992;11354.091672666333;11441.370724610226;11571.421428928688;11665.941670291933;11568.710782230512;11662;11674.066074713832;11727.472263748323;11900.226485278428;7668.309852113337;7805.414593905366;7841.647125879235;7841.843163136591;7847.254510821463;9184.081591840762;9206.03336649669;9249.676261330822;9356.812863742824;9394.906050939677;7505.399568034435;7527;7561.6597253122645;7587.127480339832;7819.100803407453;7764.728234511765;7784.805379865548;7836.960815195887;7942.285194332538;7976.960115199387;6515.511336649675;6541.70562324687;6556.3443655634055;6595.274519802914;6633.1045308882685;5167.121589329748;5336.546393556591;5418.051840927901;5489.1217405214975;5683.715814209356;5330.786768529216;5369.946300537101;5465.1529013001455;5533.7786488540005;5646.774129034792 14:06:01 INFO - PID 28503 | |4;prototype.html;348.50512272572945;362.63555127097266;368.1422286073448;369.0514085627884;371.26489550689615;5353.491418315254;5497.752601132948;5534.75093620787;5542.722863856801;5552.916706249404;5305.522502974732;5361.0618141825125;5367.677939323634;5373.516383525482;5379.515843574078;4176.287722033967;4178.749275043499;4186.665066794664;4192.182524407742;4196.643285320752;3986.8604598839047;4161.479815023122;4179.516271723524;4184.937225941613;4187.560306167854;4137.565555616662;4147.647449966741;4154.563770804068;4160.771157586331;4162.229987452316;4125.690573207022;4126.587341265879;4130.524989626187;4134.669226461876;4154.750714957082;3624.3657359961903;3626.4016437287814;3635.1457407509215;3639.6542328478754;3654.543182102237;5240.082985477564;5270.5520030797425;5294.914542518774;5305.336832895888;5326.360836699582;4733.692309999839;4739.218029025206;4742.857714268543;4748.620110391161;4749.97875456775;5501.614886957915;5671.8582035449035;5684;5684.772609095672;5701.657900525982;3910.980445097785;3941.763494190358;3942.546607140187;3943.861964831217;3949.624785645359;5828.1549175369755;5932.881342373172;5993.490553302974;6005.849853753647;6021.217241758587;4013.2174226025645;4015.5181378234797;4027.3354896442347;4028.2144981728284;4037;4080.5103387593085;4086.182763447263;4086.9182616347507;4107.527634322091;4108.219438306712;4417.983863711364;4659.9767001165455;4732.266498692708;4751.952480475151;4753.952460475351;5700.4299570043495;5712.685802280915;5717.828465146053;5724.4561766632105;5742.799002034909;1398.930053497321;1406.69052808382;1409.8026276321323;1414.0101928649985;1418.8439271680106;882.4352414454754;940.9670661526951;945.6501094595044;956.818204541135;958.2525630008604;4980.252962055721;4995.875103122378;4998.925016124761;5001.349824522788;5013.674111182834;5905.704714764244;5920.615160014585;5931.703414829328;5937.406259374028;5943.435373639584;4868.537488938616;4957.157283261854;4979;4985.651004429727;4993.925091123636;3104.689531046877;3132;3139.3878193752457;3148.1185268124505;3148.874045038219;5487.75305111271;5507.889842203213;5514.365847927459;5538.584606154554;5542.224088627515;5862.736176872051;5939.346671866091;6035.39646035393;6035.849103772353;6049.243844519435;5467.781288748405;5480.753366098455;5503.449655034625;5506.752196151183;5514.696691681996;5658.85852853682;5918;5941.940580594139;5972.462478376967;5972.671503067373;5771.249737534094;5819.330776960704;5825.475707186373;5835.6790376528;5847.26909136358;5337.22610221508;5456.372517160577;5487.506124448819;5495.422980587141;5496.4503549646315;4015.156817068448;4036.253293140661;4047.777372244555;4051.5948405159247;4056.8782936511952;5632;5953.6725480097275;5957;5968.4926781224085;5974.641521508724;5642.492175704207;5661.943380566307;5675.91334239347;5708.600397972102;5718.456746609066;5725.828225153252;5740.368559458373;5744.138379243147;5763.106718458645;5781.739821707949;5577.105763141241;5589.133684278943;5642.520385767256;5653.625477299462;5674.148877668217;5778.306603207642;5779.971100144472;5784.132380142844;5789.102689083199;5800.361960184461;5533.833984980457;5624.74688639004;5626.212330273683;5637.49262566371;5651.095824668198 14:06:01 INFO - PID 28503 | |5;yui.html;695.2630211975303;710.5203987308568;711.8860982242842;727.5343779980816;731.9780406587803;12827.48690052398;13543.322833858318;13573.321333933312;13583.592492225225;13591.252481113535;13245.139065960706;13267.071305008629;13341.93329033356;13367.799483007762;13940.860591394083;836.0510820219049;841.7264389073575;842.1115722912325;842.204117109332;844.8437039147747;844.4384484317922;854.4915775113828;856.9914300857005;859.3297228162044;882.6116508736168;891.692366133686;916.8074704312103;916.9587368568397;917.0508523677995;917.8164367126568;900.6397441023578;916.2440986186423;918.4122161816442;918.5269586163131;919.3518569408584;676.35746041261;676.8781619308522;680.0309558878578;680.8468094678707;682.5392859819602;13516.391762370717;13546.254955977418;13604.047716659838;13753.518626848012;15027.699446011127;12938.913892578887;13397.397117129753;13554.590725334101;13594.044684821367;13644.386002629906;10131.645392411305;10411.687649370531;10495.160387169008;10586.247575630392;10609.257351985365;2645.7486538778785;2662.454196889633;2720.986395068032;2725.591161325817;2743.890244390222;58850.411495885346;59612.70193649048;61199;61380.4654883627;61408.999999999556;10372.170226381872;10436.791264174673;10493.370397776158;10588.576456941637;11022.614208502824;20209.059233449338;20334.694979575317;20477.692834607493;20481.692774608393;20529;6247.812565623039;6476.967615161894;6533.216014078246;6639.236487803868;6663.700133494004;3232.82219477931;3332.766706330582;3362.815045172539;3366.6969972702573;3398.7620866539105;3472.0625431133453;3533.9293214136087;3534.134137136418;3551.9112022199133;3553.1117220694828;613.8404014956144;626.4236902050034;634.1185751804994;641.2113100885937;644;527.8970600732897;551.8592758846469;560.9747561359749;571.3401021819722;575.7869588252373;8372.162783721578;8618.698345557876;8771.517566533774;8887.244584210286;8913.777155571162;529.3303970477349;539.1885212754779;544.8801263722054;546.3443867359185;549.3984087424265;3905.3946638271113;3923.6272554107313;4069.8372065117064;4117.547069822317;4155.459790227251;59673.40326596679;60835.08747368793;61060.38939610547;61387.38612613906;62270.688646556475;41078.58921410808;45190;53301;56294.71852640711;58053;48657.27014094791;48863;48934.51065489371;49334.753326233855;50789.74605126951;7967.442279040411;8086.676532938616;8111.9594402027615;8143.83712325762;8255.834883302181;25299.620505692797;25963.74036259613;26139.738602614492;26666.600000999613;26738.331541711614;30958.84520577383;31738.523922140725;31902.88339908092;32004.839975799972;32806.83596582002;9888.901110988798;9900.801983960424;10098.293119481566;10135.189184865341;10195.84706229422;10658.520366583678;10728.624498142528;10805.51375188134;11288.604898828502;11361.54553817871;10211.183105351703;10295.691129266133;10419.166466682798;10757.30077544957;10800.405977671304;9893.35693179941;10112.646057387956;10717.571297148026;10722.410267435054;10797.946010269898;10348.172146228435;10417;10440.073975381409;10656.62701805433;10955.726106847393;6912.417100397743;7055.647217638995;7260.927390726025;7286.6720997556295;7435;7944.6424910880305;8267.29727973129;8418.663253470038;8994.82010359776;9154 14:06:01 INFO - PID 28503 | __end_tp_report 14:06:01 INFO - PID 28503 | __start_cc_report 14:06:01 INFO - PID 28503 | _x_x_mozilla_cycle_collect,387 14:06:01 INFO - PID 28503 | __end_cc_report 14:06:01 INFO - PID 28503 | __startTimestamp1490735161587__endTimestamp 14:06:01 INFO - PID 28503 | 14:06:01 INFO - PID 28503 | ------- Summary: start ------- 14:06:01 INFO - PID 28503 | Number of tests: 6 14:06:01 INFO - PID 28503 | 14:06:01 INFO - PID 28503 | [#0] dojo.html Cycles:165 Average:5115.66 Median:5254.50 stddev:581.74 (11.1%) stddev-sans-first:551.97 14:06:01 INFO - PID 28503 | Values: 2706.4 2727.6 2743.8 2761.4 2774.3 5052.8 5213.5 5227.2 5271.8 5301.8 5086.8 5159.4 5191.5 5230.4 5255.4 4726.7 4739.1 4776.9 4777.5 4808.4 4766.6 4788.4 4824.0 4835.9 4870.4 4762.6 4764.7 4771.9 4778.2 4812.5 4725.6 4737.0 4742.1 4771.6 4778.5 4630.8 4691.6 4714.9 4724.5 4759.8 4916.6 4977.5 5122.2 5150.0 5218.3 5580.6 5589.2 5599.9 5626.7 5658.7 5637.0 5652.0 5657.4 5665.8 5669.9 4993.6 5084.4 5230.1 5254.5 5314.2 5776.9 5782.6 5809.3 5843.4 5855.9 5291.2 5356.4 5480.9 5523.7 5527.5 5541.0 5541.5 5613.9 5620.6 5640.9 5359.4 5451.6 5534.0 5559.6 5566.9 5586.0 5586.1 5593.8 5624.0 5635.6 4639.0 4651.4 4656.3 4662.1 4700.7 3874.7 3914.4 3975.4 3997.6 4018.3 4764.0 4774.7 4790.2 4811.6 4818.3 5566.2 5570.9 5571.0 5573.6 5576.7 4627.7 4731.0 4737.3 4737.7 4789.7 4828.9 4859.4 4869.9 4877.5 4882.5 5118.9 5118.9 5120.2 5121.7 5122.5 5421.2 5475.5 5476.7 5491.4 5495.4 5154.2 5161.6 5163.9 5174.4 5191.1 5459.0 5460.1 5541.6 5577.4 5577.7 5449.9 5505.4 5598.6 5633.9 5635.1 5421.9 5423.0 5433.9 5434.5 5437.9 5275.0 5328.5 5339.8 5413.2 5429.6 5379.1 5386.5 5389.4 5419.5 5445.4 5455.8 5472.6 5503.0 5518.1 5554.4 5164.7 5238.1 5340.7 5343.5 5355.7 14:06:01 INFO - PID 28503 | 14:06:01 INFO - PID 28503 | [#1] ext.html Cycles:180 Average:33349.29 Median:29616.56 stddev:52694.62 (177.9%) stddev-sans-first:52785.32 14:06:01 INFO - PID 28503 | Values: 671.1 726.5 737.0 1039.1 1045.0 31851.7 32632.3 32679.7 32740.7 32757.2 33982.6 34494.0 36850.8 36899.3 36994.0 7322.7 7448.0 7479.7 7656.0 7661.4 7470.6 7577.2 7577.5 7583.7 7591.3 7571.3 7584.2 7632.4 7766.3 7799.0 7707.5 7729.1 7729.9 7743.5 7766.7 7383.0 7474.7 7492.8 7499.8 7501.4 34686.3 34995.0 35034.0 35050.5 35059.0 2597.5 2621.3 2622.1 2627.7 2674.2 21839.9 21873.3 22241.3 22291.8 22884.3 2718.5 2763.3 2771.2 2772.4 2785.7 109083.0 112071.0 121576.4 123128.4 123264.0 38357.2 38479.6 38592.4 38636.9 38689.2 39974.8 39993.6 40003.4 40013.8 40041.8 12185.3 12325.6 12334.6 12344.9 12346.6 10147.8 10149.1 10152.0 10182.8 10204.0 13262.7 13435.9 13445.2 13463.7 13536.7 5445.7 5529.4 5685.8 5696.9 5699.3 866.3 867.6 884.9 892.5 913.7 20262.7 21184.0 21276.8 21356.7 21469.4 961.9 963.5 982.7 988.6 989.0 10923.9 10956.9 11181.8 11228.3 11228.8 228649.0 230571.0 230912.0 231709.0 232954.0 41697.4 42529.8 42565.4 42605.4 42717.6 1179.5 1234.4 1244.0 1244.1 1253.0 20112.6 20114.9 20148.0 20495.2 20977.8 30512.8 34246.3 34737.4 35255.8 35344.6 201313.0 204985.0 251668.0 252105.0 252480.0 22071.4 22707.5 25906.9 26322.4 29748.6 34605.3 34617.0 34830.5 34875.5 34937.1 26701.6 26829.3 27233.3 27642.7 28472.3 28278.7 28354.6 28498.4 28657.4 29484.6 31177.8 31673.7 31885.8 31931.2 31962.7 27034.6 27348.3 27488.3 27635.6 28851.9 20228.2 22080.1 22129.7 22223.2 22264.4 14:06:01 INFO - PID 28503 | 14:06:01 INFO - PID 28503 | [#2] jquery.html Cycles:180 Average:27880.05 Median:20899.11 stddev:76638.68 (366.7%) stddev-sans-first:76825.91 14:06:01 INFO - PID 28503 | Values: 406.7 421.2 429.8 436.2 441.3 16681.9 17288.0 17363.8 17810.5 18740.2 18384.0 18610.3 18702.6 18840.6 18886.2 5754.2 5767.7 5840.1 5856.6 5870.0 5709.8 5772.9 5830.9 5831.9 5835.9 5630.5 5669.6 5701.5 5722.9 5723.6 5550.9 5763.2 5787.7 5794.3 5806.5 5158.0 5190.6 5206.6 5245.3 5250.8 22476.6 22613.7 23061.8 23136.3 23365.0 1558.9 1590.4 1608.4 1637.8 1656.7 13681.4 14253.4 14353.4 14664.2 14924.3 1702.0 1716.2 1743.3 1745.5 1775.0 88958.9 90080.5 90977.5 91601.6 94302.1 10969.7 11091.5 11211.4 11248.9 11339.4 15443.8 15458.8 15483.5 15492.8 15521.3 7128.7 7338.9 7514.7 7559.5 7618.9 6521.4 6574.5 6705.1 6816.8 6821.4 7108.9 7133.2 7229.5 7281.6 7355.3 2026.6 2051.4 2060.3 2072.4 2095.2 831.2 856.9 869.1 874.1 881.8 16529.0 16708.8 17047.6 17445.6 17611.6 862.7 887.8 892.4 895.6 904.6 8825.2 9015.6 9428.7 9449.9 9504.9 450900.0 455893.0 462515.0 472575.6 473913.0 85427.6 85466.0 86442.6 87252.6 88410.6 1050.3 1071.7 1075.8 1080.7 1085.2 13960.2 14304.5 14394.2 14689.3 14982.3 40542.6 40580.6 40964.8 41267.4 41377.0 51261.0 51798.5 52087.5 54000.5 54430.5 5842.8 7826.3 7851.6 7913.0 8075.3 11330.8 11963.7 12050.8 12113.6 12534.6 10318.5 10523.4 10875.6 10910.5 10979.0 10263.1 10290.2 10322.6 10440.8 10445.4 10087.2 10432.8 10603.5 10947.7 10980.2 7972.0 7999.1 8121.7 8253.2 8289.4 10298.8 10409.3 10493.6 10571.8 10777.7 14:06:01 INFO - PID 28503 | 14:06:01 INFO - PID 28503 | [#3] mootools.html Cycles:180 Average:6192.84 Median:4876.37 stddev:3945.21 (80.9%) stddev-sans-first:3938.91 14:06:01 INFO - PID 28503 | Values: 1266.1 1331.8 1340.7 1342.2 1347.3 9164.5 9499.3 9522.8 9790.1 10024.1 10058.5 10249.6 10254.1 10255.3 10271.9 2290.0 2307.5 2310.2 2312.4 2321.9 2188.2 2239.9 2317.0 2330.3 2332.5 2227.7 2231.5 2250.9 2264.1 2323.0 2105.4 2151.0 2159.6 2160.7 2162.9 1887.2 1949.1 2156.8 2175.9 2196.9 9698.6 9741.8 9758.9 9792.8 10075.1 5506.8 5705.1 5713.2 5715.4 5724.3 3225.1 3271.7 3331.1 3342.5 3360.1 979.5 986.1 1023.0 1048.8 1051.0 14643.5 14656.9 14723.3 14738.3 14758.8 4761.2 4991.5 5075.3 5150.3 5151.7 10945.7 10978.3 10983.2 10989.2 11003.1 5647.2 5660.0 5669.4 5680.6 5689.2 5076.1 5116.8 5162.8 5237.8 5298.4 3875.3 3969.6 3984.9 4043.6 4046.2 1162.3 1171.8 1173.1 1173.7 1183.7 631.6 656.5 656.9 665.5 670.5 5042.2 5080.6 5131.6 5161.3 5291.8 537.2 551.8 555.1 556.8 556.9 3530.4 3681.5 3687.1 3701.9 3797.9 12650.0 13255.0 13358.2 13394.5 13395.3 12585.2 12797.0 13047.5 13103.2 13212.1 8994.5 9033.6 9066.0 9076.0 9145.0 5651.8 5736.9 5801.5 5846.9 5897.1 11273.3 11354.1 11441.4 11571.4 11665.9 11568.7 11662.0 11674.1 11727.5 11900.2 7668.3 7805.4 7841.6 7841.8 7847.3 9184.1 9206.0 9249.7 9356.8 9394.9 7505.4 7527.0 7561.7 7587.1 7819.1 7764.7 7784.8 7837.0 7942.3 7977.0 6515.5 6541.7 6556.3 6595.3 6633.1 5167.1 5336.5 5418.1 5489.1 5683.7 5330.8 5369.9 5465.2 5533.8 5646.8 14:06:01 INFO - PID 28503 | 14:06:01 INFO - PID 28503 | [#4] prototype.html Cycles:180 Average:4707.47 Median:5376.52 stddev:1394.99 (25.9%) stddev-sans-first:1359.99 14:06:01 INFO - PID 28503 | Values: 348.5 362.6 368.1 369.1 371.3 5353.5 5497.8 5534.8 5542.7 5552.9 5305.5 5361.1 5367.7 5373.5 5379.5 4176.3 4178.7 4186.7 4192.2 4196.6 3986.9 4161.5 4179.5 4184.9 4187.6 4137.6 4147.6 4154.6 4160.8 4162.2 4125.7 4126.6 4130.5 4134.7 4154.8 3624.4 3626.4 3635.1 3639.7 3654.5 5240.1 5270.6 5294.9 5305.3 5326.4 4733.7 4739.2 4742.9 4748.6 4750.0 5501.6 5671.9 5684.0 5684.8 5701.7 3911.0 3941.8 3942.5 3943.9 3949.6 5828.2 5932.9 5993.5 6005.8 6021.2 4013.2 4015.5 4027.3 4028.2 4037.0 4080.5 4086.2 4086.9 4107.5 4108.2 4418.0 4660.0 4732.3 4752.0 4754.0 5700.4 5712.7 5717.8 5724.5 5742.8 1398.9 1406.7 1409.8 1414.0 1418.8 882.4 941.0 945.7 956.8 958.3 4980.3 4995.9 4998.9 5001.3 5013.7 5905.7 5920.6 5931.7 5937.4 5943.4 4868.5 4957.2 4979.0 4985.7 4993.9 3104.7 3132.0 3139.4 3148.1 3148.9 5487.8 5507.9 5514.4 5538.6 5542.2 5862.7 5939.3 6035.4 6035.8 6049.2 5467.8 5480.8 5503.4 5506.8 5514.7 5658.9 5918.0 5941.9 5972.5 5972.7 5771.2 5819.3 5825.5 5835.7 5847.3 5337.2 5456.4 5487.5 5495.4 5496.5 4015.2 4036.3 4047.8 4051.6 4056.9 5632.0 5953.7 5957.0 5968.5 5974.6 5642.5 5661.9 5675.9 5708.6 5718.5 5725.8 5740.4 5744.1 5763.1 5781.7 5577.1 5589.1 5642.5 5653.6 5674.1 5778.3 5780.0 5784.1 5789.1 5800.4 5533.8 5624.7 5626.2 5637.5 5651.1 14:06:01 INFO - PID 28503 | 14:06:01 INFO - PID 28503 | [#5] yui.html Cycles:180 Average:13531.89 Median:48898.76 stddev:16576.96 (33.9%) stddev-sans-first:16595.44 14:06:01 INFO - PID 28503 | Values: 695.3 710.5 711.9 727.5 732.0 12827.5 13543.3 13573.3 13583.6 13591.3 13245.1 13267.1 13341.9 13367.8 13940.9 836.1 841.7 842.1 842.2 844.8 844.4 854.5 857.0 859.3 882.6 891.7 916.8 917.0 917.1 917.8 900.6 916.2 918.4 918.5 919.4 676.4 676.9 680.0 680.8 682.5 13516.4 13546.3 13604.0 13753.5 15027.7 12938.9 13397.4 13554.6 13594.0 13644.4 10131.6 10411.7 10495.2 10586.2 10609.3 2645.7 2662.5 2721.0 2725.6 2743.9 58850.4 59612.7 61199.0 61380.5 61409.0 10372.2 10436.8 10493.4 10588.6 11022.6 20209.1 20334.7 20477.7 20481.7 20529.0 6247.8 6477.0 6533.2 6639.2 6663.7 3232.8 3332.8 3362.8 3366.7 3398.8 3472.1 3533.9 3534.1 3551.9 3553.1 613.8 626.4 634.1 641.2 644.0 527.9 551.9 561.0 571.3 575.8 8372.2 8618.7 8771.5 8887.2 8913.8 529.3 539.2 544.9 546.3 549.4 3905.4 3923.6 4069.8 4117.5 4155.5 59673.4 60835.1 61060.4 61387.4 62270.7 41078.6 45190.0 53301.0 56294.7 58053.0 48657.3 48863.0 48934.5 49334.8 50789.7 7967.4 8086.7 8112.0 8143.8 8255.8 25299.6 25963.7 26139.7 26666.6 26738.3 30958.8 31738.5 31902.9 32004.8 32806.8 9888.9 9900.8 10098.3 10135.2 10195.8 10658.5 10728.6 10805.5 11288.6 11361.5 10211.2 10295.7 10419.2 10757.3 10800.4 9893.4 10112.6 10717.6 10722.4 10797.9 10348.2 10417.0 10440.1 10656.6 10955.7 6912.4 7055.6 7260.9 7286.7 7435.0 7944.6 8267.3 8418.7 8994.8 9154.0 14:06:01 INFO - PID 28503 | -------- Summary: end -------- 14:06:01 INFO - PID 28503 | 14:06:02 INFO - TEST-INFO | 28503: exit 0 14:06:02 INFO - TEST-OK | dromaeo_css | took 1120824ms 14:06:02 INFO - TEST-START | kraken 14:06:02 INFO - operating with platform_type : linux_ 14:06:02 INFO - Initialising browser for kraken test... 14:06:02 INFO - TEST-INFO | started process 28875 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1h8GWc/profile http://localhost:34631/getInfo.html) 14:06:06 INFO - PID 28875 | __metrics Screen width/height:1600/1200 14:06:06 INFO - PID 28875 | colorDepth:24 14:06:06 INFO - PID 28875 | Browser inner width/height: 1024/697 14:06:06 INFO - PID 28875 | __metrics 14:06:07 ERROR - PID 28875 | 1490735167514 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6376:36 < canClose@browser.js:5227:12 < forceQuit@jar:file:///tmp/tmp1h8GWc/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmp1h8GWc/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmp1h8GWc/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmp1h8GWc/profile/extensions/talos-powers@TalosPowersService.js:55:9 14:06:07 ERROR - PID 28875 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 14:06:08 INFO - TEST-INFO | 28875: exit 0 14:06:08 INFO - Browser initialized. 14:06:08 INFO - Running cycle 1/1 for kraken test... 14:06:08 INFO - TEST-INFO | started process 29007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1h8GWc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:06:20 INFO - PID 29007 | RSS: Main: 155713536 14:06:20 INFO - PID 29007 | 14:06:23 INFO - PID 29007 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34631/tests/kraken/driver.html?testName=audio-beat-detection) 14:06:24 INFO - PID 29007 | RSS: Main: 162852864 14:06:24 INFO - PID 29007 | 14:06:27 INFO - PID 29007 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34631/tests/kraken/driver.html?testName=audio-dft) 14:06:27 INFO - PID 29007 | RSS: Main: 161476608 14:06:27 INFO - PID 29007 | 14:06:30 INFO - PID 29007 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34631/tests/kraken/driver.html?testName=audio-fft) 14:06:31 INFO - PID 29007 | RSS: Main: 157585408 14:06:31 INFO - PID 29007 | 14:06:33 INFO - PID 29007 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34631/tests/kraken/driver.html?testName=audio-oscillator) 14:06:34 INFO - PID 29007 | RSS: Main: 158453760 14:06:34 INFO - PID 29007 | 14:06:36 INFO - PID 29007 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34631/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:06:36 INFO - PID 29007 | RSS: Main: 159088640 14:06:36 INFO - PID 29007 | 14:06:39 INFO - PID 29007 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34631/tests/kraken/driver.html?testName=imaging-darkroom) 14:06:40 INFO - PID 29007 | RSS: Main: 163966976 14:06:40 INFO - PID 29007 | 14:06:44 INFO - PID 29007 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34631/tests/kraken/driver.html?testName=imaging-desaturate) 14:06:44 INFO - PID 29007 | RSS: Main: 161968128 14:06:44 INFO - PID 29007 | 14:06:47 INFO - PID 29007 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34631/tests/kraken/driver.html?testName=json-parse-financial) 14:06:48 INFO - PID 29007 | RSS: Main: 163311616 14:06:48 INFO - PID 29007 | 14:06:50 INFO - PID 29007 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34631/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:06:50 INFO - PID 29007 | RSS: Main: 163172352 14:06:50 INFO - PID 29007 | 14:06:52 INFO - PID 29007 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34631/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:06:53 INFO - PID 29007 | RSS: Main: 163532800 14:06:53 INFO - PID 29007 | 14:06:55 INFO - PID 29007 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34631/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:06:56 INFO - PID 29007 | RSS: Main: 163979264 14:06:56 INFO - PID 29007 | 14:06:58 INFO - PID 29007 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34631/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:06:59 INFO - PID 29007 | RSS: Main: 164102144 14:06:59 INFO - PID 29007 | 14:07:02 INFO - PID 29007 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34631/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:07:03 INFO - PID 29007 | RSS: Main: 164179968 14:07:03 INFO - PID 29007 | 14:07:05 INFO - PID 29007 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34631/tests/kraken/driver.html?testName=ai-astar) 14:07:05 INFO - PID 29007 | RSS: Main: 165670912 14:07:05 INFO - PID 29007 | 14:07:05 INFO - PID 29007 | __start_tp_report 14:07:05 INFO - PID 29007 | _x_x_mozilla_page_load 14:07:05 INFO - PID 29007 | _x_x_mozilla_page_load_details 14:07:05 INFO - PID 29007 | |i|pagename|runs| 14:07:05 INFO - PID 29007 | |0;ai-astar;104;110;111;110;111;111;112;112;111;111 14:07:05 INFO - PID 29007 | |1;audio-beat-detection;154;125;124;167;125;126;127;126;154;124 14:07:05 INFO - PID 29007 | |2;audio-dft;166;167;169;168;170;174;167;167;167;167 14:07:05 INFO - PID 29007 | |3;audio-fft;75;79;78;109;77;77;75;76;100;76 14:07:05 INFO - PID 29007 | |4;audio-oscillator;84;84;106;85;85;84;100;86;86;105 14:07:05 INFO - PID 29007 | |5;imaging-gaussian-blur;115;118;114;114;115;115;115;114;114;114 14:07:05 INFO - PID 29007 | |6;imaging-darkroom;152;151;150;151;151;152;150;151;154;151 14:07:05 INFO - PID 29007 | |7;imaging-desaturate;97;94;95;95;95;95;95;95;95;96 14:07:05 INFO - PID 29007 | |8;json-parse-financial;80;70;71;71;71;74;71;71;72;73 14:07:05 INFO - PID 29007 | |9;json-stringify-tinderbox;55;56;55;56;55;56;57;56;55;57 14:07:05 INFO - PID 29007 | |10;stanford-crypto-aes;82;85;85;92;84;83;82;83;83;82 14:07:05 INFO - PID 29007 | |11;stanford-crypto-ccm;137;138;139;137;143;134;149;140;178;137 14:07:05 INFO - PID 29007 | |12;stanford-crypto-pbkdf2;191;197;200;202;198;189;196;201;195;194 14:07:05 INFO - PID 29007 | |13;stanford-crypto-sha256-iterative;74;76;75;70;73;70;71;74;72;70 14:07:05 INFO - PID 29007 | __end_tp_report 14:07:05 INFO - PID 29007 | __start_cc_report 14:07:05 INFO - PID 29007 | _x_x_mozilla_cycle_collect,857 14:07:05 INFO - PID 29007 | __end_cc_report 14:07:05 INFO - PID 29007 | __startTimestamp1490735225699__endTimestamp 14:07:05 INFO - PID 29007 | 14:07:05 INFO - PID 29007 | ------- Summary: start ------- 14:07:05 INFO - PID 29007 | Number of tests: 14 14:07:05 INFO - PID 29007 | 14:07:05 INFO - PID 29007 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.31 (2.1%) stddev-sans-first:0.71 14:07:05 INFO - PID 29007 | Values: 104.0 110.0 111.0 110.0 111.0 111.0 112.0 112.0 111.0 111.0 14:07:05 INFO - PID 29007 | 14:07:05 INFO - PID 29007 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:126.50 stddev:16.38 (12.9%) stddev-sans-first:15.89 14:07:05 INFO - PID 29007 | Values: 154.0 125.0 124.0 167.0 125.0 126.0 127.0 126.0 154.0 124.0 14:07:05 INFO - PID 29007 | 14:07:05 INFO - PID 29007 | [#2] audio-dft Cycles:10 Average:168.20 Median:167.50 stddev:2.35 (1.4%) stddev-sans-first:2.35 14:07:05 INFO - PID 29007 | Values: 166.0 167.0 169.0 168.0 170.0 174.0 167.0 167.0 167.0 167.0 14:07:05 INFO - PID 29007 | 14:07:05 INFO - PID 29007 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.50 stddev:12.01 (15.7%) stddev-sans-first:12.45 14:07:05 INFO - PID 29007 | Values: 75.0 79.0 78.0 109.0 77.0 77.0 75.0 76.0 100.0 76.0 14:07:05 INFO - PID 29007 | 14:07:05 INFO - PID 29007 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:84.50 stddev:9.24 (10.9%) stddev-sans-first:9.50 14:07:05 INFO - PID 29007 | Values: 84.0 84.0 106.0 85.0 85.0 84.0 100.0 86.0 86.0 105.0 14:07:05 INFO - PID 29007 | 14:07:05 INFO - PID 29007 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:115.00 stddev:1.23 (1.1%) stddev-sans-first:1.30 14:07:05 INFO - PID 29007 | Values: 115.0 118.0 114.0 114.0 115.0 115.0 115.0 114.0 114.0 114.0 14:07:05 INFO - PID 29007 | 14:07:05 INFO - PID 29007 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:151.00 stddev:1.16 (0.8%) stddev-sans-first:1.20 14:07:05 INFO - PID 29007 | Values: 152.0 151.0 150.0 151.0 151.0 152.0 150.0 151.0 154.0 151.0 14:07:05 INFO - PID 29007 | 14:07:05 INFO - PID 29007 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.50 14:07:05 INFO - PID 29007 | Values: 97.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 14:07:05 INFO - PID 29007 | 14:07:05 INFO - PID 29007 | [#8] json-parse-financial Cycles:10 Average:72.40 Median:71.50 stddev:2.91 (4.1%) stddev-sans-first:1.24 14:07:05 INFO - PID 29007 | Values: 80.0 70.0 71.0 71.0 71.0 74.0 71.0 71.0 72.0 73.0 14:07:05 INFO - PID 29007 | 14:07:05 INFO - PID 29007 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:56.00 stddev:0.79 (1.4%) stddev-sans-first:0.78 14:07:05 INFO - PID 29007 | Values: 55.0 56.0 55.0 56.0 55.0 56.0 57.0 56.0 55.0 57.0 14:07:05 INFO - PID 29007 | 14:07:05 INFO - PID 29007 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:83.50 stddev:3.00 (3.6%) stddev-sans-first:3.08 14:07:05 INFO - PID 29007 | Values: 82.0 85.0 85.0 92.0 84.0 83.0 82.0 83.0 83.0 82.0 14:07:05 INFO - PID 29007 | 14:07:05 INFO - PID 29007 | [#11] stanford-crypto-ccm Cycles:10 Average:143.20 Median:139.50 stddev:12.91 (9.3%) stddev-sans-first:13.49 14:07:05 INFO - PID 29007 | Values: 137.0 138.0 139.0 137.0 143.0 134.0 149.0 140.0 178.0 137.0 14:07:05 INFO - PID 29007 | 14:07:05 INFO - PID 29007 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.30 Median:197.50 stddev:4.22 (2.1%) stddev-sans-first:4.01 14:07:05 INFO - PID 29007 | Values: 191.0 197.0 200.0 202.0 198.0 189.0 196.0 201.0 195.0 194.0 14:07:05 INFO - PID 29007 | 14:07:05 INFO - PID 29007 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:73.50 stddev:2.22 (3.0%) stddev-sans-first:2.29 14:07:05 INFO - PID 29007 | Values: 74.0 76.0 75.0 70.0 73.0 70.0 71.0 74.0 72.0 70.0 14:07:05 INFO - PID 29007 | -------- Summary: end -------- 14:07:05 INFO - PID 29007 | 14:07:06 INFO - TEST-INFO | 29007: exit 0 14:07:06 INFO - TEST-OK | kraken | took 64451ms 14:07:06 INFO - SUITE-END | took 1185s 14:07:07 INFO - Completed test suite (00:19:45) 14:07:07 INFO - javascript benchmark 14:07:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6562.434540702404, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2706.418120104178, 2727.6454060972096, 2743.8079334446584, 2761.447710457909, 2774.2786875412385, 5052.84841454756, 5213.452587478312, 5227.163653815391, 5271.762770675319, 5301.7879284828605, 5086.771095300711, 5159.355080614923, 5191.480851914806, 5230.398504172022, 5255.395629502608, 4726.669133160672, 4739.0758802033615, 4776.8566942991765, 4777.498362671921, 4808.422989241296, 4766.618670506368, 4788.377510923592, 4824.035192961422, 4835.8549243522575, 4870.391201099863, 4762.618990480753, 4764.690295130806, 4771.904561908743, 4778.187708089633, 4812.542808433193, 4725.598324142452, 4736.9526304736855, 4742.099001189763, 4771.642126840501, 4778.4982576829625, 4630.791614377327, 4691.62467002639, 4714.882127946795, 4724.480307166209, 4759.833405830779, 4916.58209052231, 4977.477364876709, 5122.180451127839, 5149.974250128763, 5218.321618189611, 5580.553555715574, 5589.245451863987, 5599.936012157717, 5626.690532020737, 5658.688772117532, 5637.041702910515, 5651.9717401413145, 5657.43425657431, 5665.773369065232, 5669.8582535436535, 4993.6005119590345, 5084.44071152173, 5230.08473517133, 5254.500822421864, 5314.229436731653, 5776.855578610484, 5782.566307526952, 5809.2738407699035, 5843.415658434207, 5855.912161317584, 5291.206319052173, 5356.357237131491, 5480.890382192334, 5523.6685798852195, 5527.50252477279, 5540.972295138579, 5541.5289700375915, 5613.887722245614, 5620.606557541015, 5640.8871822563315, 5359.356877174764, 5451.591130665216, 5533.972330138324, 5559.610827242135, 5566.916496252559, 5585.972070139624, 5586.1062230043, 5593.804216852391, 5624.0439125348785, 5635.633683810539, 4638.95361046392, 4651.418572678415, 4656.348111264426, 4662.137504561667, 4700.670953033323, 3874.651281384689, 3914.4128380742545, 3975.3639417693607, 3997.620226078518, 4018.3369743991916, 4763.976180119146, 4774.665773395829, 4790.233562629963, 4811.639127065414, 4818.277258411266, 5566.220729097849, 5570.888582228414, 5570.972145139248, 5573.5819813514145, 5576.7211639417865, 4627.676062675648, 4730.976345118322, 4737.336772851803, 4737.739424331626, 4789.736564488987, 4828.903421931542, 4859.368282123372, 4869.878253043702, 4877.487863774323, 4882.536159064884, 5118.872028199325, 5118.948810511996, 5120.2319652051, 5121.692698438105, 5122.538971492583, 5421.159720243211, 5475.5072043516275, 5476.67139971603, 5491.395946445968, 5495.422980587141, 5154.226865970135, 5161.561267292323, 5163.922541161961, 5174.379074511083, 5191.143461328989, 5459.0, 5460.099083651312, 5541.639793413416, 5577.358603760619, 5577.693226872561, 5449.863753406196, 5505.421930697219, 5598.636088654224, 5633.915491267716, 5635.070213414904, 5421.945780542302, 5422.972885135549, 5433.9456605435025, 5434.510894019557, 5437.912417516433, 5274.97362513185, 5328.520433161034, 5339.786408543615, 5413.160960051198, 5429.565634749131, 5379.1393377059485, 5386.542143917811, 5389.380221274603, 5419.485148910847, 5445.373782015119, 5455.8363249102595, 5472.562195024469, 5503.036968530571, 5518.117101263779, 5554.389017208185, 5164.715940623302, 5238.083335416363, 5340.706261155674, 5343.492368225013, 5355.732213389237], "value": 5074.7646144021655, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.1107782188601, 726.5386479585463, 737.0124033794714, 1039.0544604409984, 1044.9582016719332, 31851.681483185163, 32632.347353052926, 32679.67320326796, 32740.67259327406, 32757.18107047322, 33982.60173982607, 34494.0, 36850.8157459213, 36899.26201475969, 36994.0, 7322.670479828421, 7448.0317558717425, 7479.663415146331, 7656.0, 7661.425393095512, 7470.551766894004, 7577.204393538682, 7577.507462014979, 7583.734569290076, 7591.278828511283, 7571.318581327707, 7584.165741768401, 7632.427567932427, 7766.301032907038, 7799.0, 7707.537547747125, 7729.111152217511, 7729.922700773032, 7743.457957942946, 7766.689332426696, 7382.963085184593, 7474.7383841565825, 7492.763693990485, 7499.775006749752, 7501.399888008947, 34686.30627387438, 34995.0, 35034.0, 35050.474242886376, 35059.0, 2597.5186991546993, 2621.3315604520917, 2622.0995624879088, 2627.658404407434, 2674.1977406777887, 21839.890800545894, 21873.343799686034, 22241.332760017227, 22291.77708222913, 22884.31347059591, 2718.4563087382603, 2763.295359683268, 2771.1825011621418, 2772.36235665796, 2785.6935737068907, 109083.0, 112071.0, 121576.39211803884, 123128.38435807763, 123264.0, 38357.232855342736, 38479.61520384761, 38592.42111368332, 38636.90904727615, 38689.22621547553, 39974.80012599919, 39993.60006399957, 40003.39994900079, 40013.79993100016, 40041.79979100144, 12185.268883866996, 12325.630231093082, 12334.568290109803, 12344.938275308567, 12346.629601111981, 10147.847782283272, 10149.086582207488, 10152.0, 10182.847257291147, 10204.030617091365, 13262.668433289246, 13435.932820335836, 13445.193288402726, 13463.663408414868, 13536.729265414833, 5445.673259604437, 5529.391766905637, 5685.800996965087, 5696.943030569724, 5699.344575373885, 866.2853146154448, 867.5575456517096, 884.8539990901429, 892.5403417240127, 913.72588223534, 20262.696059558824, 21184.04671789773, 21276.78723212748, 21356.679649805264, 21469.355919322134, 961.9134277915022, 963.5375019990444, 982.7051884434641, 988.5946761827616, 989.0208693393489, 10923.945380273048, 10956.945215273872, 11181.776364472666, 11228.270162439416, 11228.775424491465, 228649.0, 230571.0, 230912.0, 231709.0, 232954.0, 41697.37453938193, 42529.787351063045, 42565.36151957723, 42605.36091958623, 42717.57282427198, 1179.504608064615, 1234.4074844074894, 1243.9689007774698, 1244.0918129765323, 1253.035162924543, 20112.59774804525, 20114.89942550278, 20148.0, 20495.180192792122, 20977.790222097585, 30512.84743576268, 34246.315073697886, 34737.39469539845, 35255.82372088123, 35344.64655353517, 201313.0, 204985.0, 251668.0, 252105.0, 252480.0, 22071.448213794785, 22707.545849083257, 25906.870465647553, 26322.446987579562, 29748.55377169301, 34605.30789384249, 34617.0, 34830.47754283738, 34875.47686784751, 34937.126571835906, 26701.599476007486, 26829.329266767705, 27233.281010987914, 27642.723572764015, 28472.288192795346, 28278.717212827607, 28354.574681379385, 28498.430031399672, 28657.42685146327, 29484.55773163447, 31177.8441107793, 31673.683263167994, 31885.840570796998, 31931.201719957186, 31962.68037319597, 27034.594481082408, 27348.316292092855, 27488.312792180357, 27635.585466218425, 28851.855740721163, 20228.19087236553, 22080.11679532865, 22129.66805497951, 22223.22218722337, 22264.443388915406], "value": 14770.267041340452, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.69497876592555, 421.2186394238689, 429.7743684565602, 436.1538615086732, 441.2895238665748, 16681.916590417048, 17288.049157296344, 17363.826361736377, 17810.465686029438, 18740.156692948814, 18384.0, 18610.34863779768, 18702.625947481043, 18840.623187536243, 18886.150123244453, 5754.16564598133, 5767.740451679674, 5840.06558950568, 5856.590038697293, 5869.9706501467435, 5709.77160913563, 5772.884542309152, 5830.883382332351, 5831.941680583203, 5835.854103647422, 5630.521405680522, 5669.6314739542, 5701.486866182043, 5722.914156287638, 5723.599348045638, 5550.91673624896, 5763.164341170528, 5787.681677507735, 5794.304683437993, 5806.477417032487, 5158.0, 5190.636655434121, 5206.609504287194, 5245.318108645852, 5250.789968401259, 22476.550468990692, 22613.660795088086, 23061.7693823063, 23136.305910822703, 23365.0, 1558.8597026267578, 1590.4194968836407, 1608.388812251337, 1637.8116516600624, 1656.7266401043814, 13681.384337704827, 14253.429862805475, 14353.425862965469, 14664.193469359181, 14924.2537873107, 1701.9829801701949, 1716.1933891071176, 1743.2765402358007, 1745.4763570928671, 1775.0326072290632, 88958.8801399825, 90080.54959725225, 90977.54511227402, 91601.62597561043, 94302.05697943001, 10969.725756856142, 11091.500882460308, 11211.38337391435, 11248.887511124947, 11339.376334301527, 15443.768343474632, 15458.845411545966, 15483.5354939352, 15492.767608485881, 15521.301541430663, 7128.714851405989, 7338.853222935511, 7514.736984205527, 7559.508631938907, 7618.885716714254, 6521.413072823469, 6574.5397822152945, 6705.061291419205, 6816.829579260459, 6821.420179284717, 7108.881605244216, 7133.179684336368, 7229.486357132242, 7281.5631062136445, 7355.3153099118435, 2026.638965605083, 2051.405092523152, 2060.330392622404, 2072.3782865140397, 2095.245711543843, 831.2477208126655, 856.8928883889514, 869.0527325215545, 874.0734821089666, 881.8131035033153, 16529.0, 16708.83291167073, 17047.573810654583, 17445.581792290624, 17611.647767044586, 862.6721845698594, 887.8224355129, 892.4422236102436, 895.5611750242465, 904.6426661468684, 8825.161609647073, 9015.63937442508, 9428.717138485856, 9449.90550094504, 9504.857427138599, 450900.0, 455893.0, 462515.0, 472575.6371218122, 473913.0, 85427.57286213529, 85466.0, 86442.56778716066, 87252.56373718091, 88410.55794720985, 1050.2963014780116, 1071.678496451077, 1075.774087441646, 1080.7358583766995, 1085.2457542008228, 13960.2321872298, 14304.499342522962, 14394.20831854258, 14689.265536722907, 14982.325795339018, 40542.59457405506, 40580.59419405768, 40964.79517602393, 41267.38098928578, 41377.0080121186, 51261.0, 51798.48201517937, 52087.479125208265, 54000.45999539954, 54430.455695442535, 5842.766289348378, 7826.295633393022, 7851.646675899712, 7913.0, 8075.273225409741, 11330.830037549607, 11963.700907477383, 12050.819237711617, 12113.636590902288, 12534.561290354794, 10318.48407579603, 10523.368597884151, 10875.564977401133, 10910.509027093958, 10979.0, 10263.12763415118, 10290.228232882713, 10322.638707645196, 10440.791184176425, 10445.425501597181, 10087.24345674092, 10432.791344173225, 10603.469826508797, 10947.726306842393, 10980.231383803377, 7971.960140199262, 7999.120096789232, 8121.675132994614, 8253.174682531699, 8289.4197406181, 10298.794024119326, 10409.271351005356, 10493.632722854663, 10571.841422378824, 10777.730556736144], "value": 8859.993416088366, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1266.0884163402347, 1331.8401791784975, 1340.7318536292744, 1342.2349260921276, 1347.3061373392704, 9164.450132992017, 9499.335046546745, 9522.76193095173, 9790.06994335537, 10024.147947424459, 10058.547365368559, 10249.590016399336, 10254.128399086068, 10255.33340332878, 10271.948640256789, 2289.954200915985, 2307.5038866643667, 2310.214527060799, 2312.4103353644796, 2321.883905804703, 2188.1684959715367, 2239.9216027439043, 2316.9536609267802, 2330.254318618043, 2332.5101728637005, 2227.676986836908, 2231.542533780571, 2250.8649481031107, 2264.1056782570877, 2323.012719594174, 2105.4315334859657, 2150.956980860382, 2159.622066138435, 2160.6758986152045, 2162.9026693798737, 1887.1790771014516, 1949.0936714427717, 2156.762756096828, 2175.945601359979, 2196.890155492235, 9698.563564639608, 9741.756456088584, 9758.90241097587, 9792.755181120458, 10075.143612792921, 5506.807261745819, 5705.087186050212, 5713.200151978726, 5715.399883012307, 5724.284464441945, 3225.145336485833, 3271.7382609391193, 3331.083951913219, 3342.5153352763955, 3360.1263671445354, 979.5396163803001, 986.1371300112402, 1022.9795404091951, 1048.835792270579, 1051.0, 14643.487477938328, 14656.926715366462, 14723.337449814784, 14738.336774845051, 14758.778618320734, 4761.2382018876815, 4991.500849915052, 5075.314832497639, 5150.253213284052, 5151.7166555839785, 10945.671629851116, 10978.341299521895, 10983.176261780398, 10989.175811814146, 11003.064739497073, 5647.237622920853, 5660.0, 5669.433056694297, 5680.602357834994, 5689.175069614966, 5076.111680455905, 5116.769745361393, 5162.802293692346, 5237.816676416307, 5298.443663415363, 3875.256134739322, 3969.622885825842, 3984.880453586397, 4043.636072753466, 4046.1503084352025, 1162.3490845126755, 1171.841801356823, 1173.0849937049115, 1173.7417768091007, 1183.6981569699672, 631.608402790273, 656.5404217048085, 656.9343065693392, 665.4842497064717, 670.5038271678923, 5042.243663450438, 5080.618953578496, 5131.640785145004, 5161.3032240647035, 5291.788328466818, 537.2022546518417, 551.8179000929764, 555.0868820789859, 556.7661582135513, 556.8635684257301, 3530.435130379127, 3681.5029970954115, 3687.078230442389, 3701.8889433317045, 3797.886063418102, 12650.0, 13255.0, 13358.198508089547, 13394.531191408254, 13395.330233488286, 12585.181963172365, 12796.976241900626, 13047.478100875858, 13103.2138071716, 13212.141210821266, 8994.505302208441, 9033.554631259098, 9065.954670226607, 9075.954620226856, 9145.0397708241, 5651.802186923438, 5736.856578585569, 5801.506871915934, 5846.912296315644, 5897.112933778924, 11273.323600583992, 11354.091672666333, 11441.370724610226, 11571.421428928688, 11665.941670291933, 11568.710782230512, 11662.0, 11674.066074713832, 11727.472263748323, 11900.226485278428, 7668.309852113337, 7805.414593905366, 7841.647125879235, 7841.843163136591, 7847.254510821463, 9184.081591840762, 9206.03336649669, 9249.676261330822, 9356.812863742824, 9394.906050939677, 7505.399568034435, 7527.0, 7561.6597253122645, 7587.127480339832, 7819.100803407453, 7764.728234511765, 7784.805379865548, 7836.960815195887, 7942.285194332538, 7976.960115199387, 6515.511336649675, 6541.70562324687, 6556.3443655634055, 6595.274519802914, 6633.1045308882685, 5167.121589329748, 5336.546393556591, 5418.051840927901, 5489.1217405214975, 5683.715814209356, 5330.786768529216, 5369.946300537101, 5465.1529013001455, 5533.7786488540005, 5646.774129034792], "value": 4641.75123190424, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.50512272572945, 362.63555127097266, 368.1422286073448, 369.0514085627884, 371.26489550689615, 5353.491418315254, 5497.752601132948, 5534.75093620787, 5542.722863856801, 5552.916706249404, 5305.522502974732, 5361.0618141825125, 5367.677939323634, 5373.516383525482, 5379.515843574078, 4176.287722033967, 4178.749275043499, 4186.665066794664, 4192.182524407742, 4196.643285320752, 3986.8604598839047, 4161.479815023122, 4179.516271723524, 4184.937225941613, 4187.560306167854, 4137.565555616662, 4147.647449966741, 4154.563770804068, 4160.771157586331, 4162.229987452316, 4125.690573207022, 4126.587341265879, 4130.524989626187, 4134.669226461876, 4154.750714957082, 3624.3657359961903, 3626.4016437287814, 3635.1457407509215, 3639.6542328478754, 3654.543182102237, 5240.082985477564, 5270.5520030797425, 5294.914542518774, 5305.336832895888, 5326.360836699582, 4733.692309999839, 4739.218029025206, 4742.857714268543, 4748.620110391161, 4749.97875456775, 5501.614886957915, 5671.8582035449035, 5684.0, 5684.772609095672, 5701.657900525982, 3910.980445097785, 3941.763494190358, 3942.546607140187, 3943.861964831217, 3949.624785645359, 5828.1549175369755, 5932.881342373172, 5993.490553302974, 6005.849853753647, 6021.217241758587, 4013.2174226025645, 4015.5181378234797, 4027.3354896442347, 4028.2144981728284, 4037.0, 4080.5103387593085, 4086.182763447263, 4086.9182616347507, 4107.527634322091, 4108.219438306712, 4417.983863711364, 4659.9767001165455, 4732.266498692708, 4751.952480475151, 4753.952460475351, 5700.4299570043495, 5712.685802280915, 5717.828465146053, 5724.4561766632105, 5742.799002034909, 1398.930053497321, 1406.69052808382, 1409.8026276321323, 1414.0101928649985, 1418.8439271680106, 882.4352414454754, 940.9670661526951, 945.6501094595044, 956.818204541135, 958.2525630008604, 4980.252962055721, 4995.875103122378, 4998.925016124761, 5001.349824522788, 5013.674111182834, 5905.704714764244, 5920.615160014585, 5931.703414829328, 5937.406259374028, 5943.435373639584, 4868.537488938616, 4957.157283261854, 4979.0, 4985.651004429727, 4993.925091123636, 3104.689531046877, 3132.0, 3139.3878193752457, 3148.1185268124505, 3148.874045038219, 5487.75305111271, 5507.889842203213, 5514.365847927459, 5538.584606154554, 5542.224088627515, 5862.736176872051, 5939.346671866091, 6035.39646035393, 6035.849103772353, 6049.243844519435, 5467.781288748405, 5480.753366098455, 5503.449655034625, 5506.752196151183, 5514.696691681996, 5658.85852853682, 5918.0, 5941.940580594139, 5972.462478376967, 5972.671503067373, 5771.249737534094, 5819.330776960704, 5825.475707186373, 5835.6790376528, 5847.26909136358, 5337.22610221508, 5456.372517160577, 5487.506124448819, 5495.422980587141, 5496.4503549646315, 4015.156817068448, 4036.253293140661, 4047.777372244555, 4051.5948405159247, 4056.8782936511952, 5632.0, 5953.6725480097275, 5957.0, 5968.4926781224085, 5974.641521508724, 5642.492175704207, 5661.943380566307, 5675.91334239347, 5708.600397972102, 5718.456746609066, 5725.828225153252, 5740.368559458373, 5744.138379243147, 5763.106718458645, 5781.739821707949, 5577.105763141241, 5589.133684278943, 5642.520385767256, 5653.625477299462, 5674.148877668217, 5778.306603207642, 5779.971100144472, 5784.132380142844, 5789.102689083199, 5800.361960184461, 5533.833984980457, 5624.74688639004, 5626.212330273683, 5637.49262566371, 5651.095824668198], "value": 4270.6599449147525, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.2630211975303, 710.5203987308568, 711.8860982242842, 727.5343779980816, 731.9780406587803, 12827.48690052398, 13543.322833858318, 13573.321333933312, 13583.592492225225, 13591.252481113535, 13245.139065960706, 13267.071305008629, 13341.93329033356, 13367.799483007762, 13940.860591394083, 836.0510820219049, 841.7264389073575, 842.1115722912325, 842.204117109332, 844.8437039147747, 844.4384484317922, 854.4915775113828, 856.9914300857005, 859.3297228162044, 882.6116508736168, 891.692366133686, 916.8074704312103, 916.9587368568397, 917.0508523677995, 917.8164367126568, 900.6397441023578, 916.2440986186423, 918.4122161816442, 918.5269586163131, 919.3518569408584, 676.35746041261, 676.8781619308522, 680.0309558878578, 680.8468094678707, 682.5392859819602, 13516.391762370717, 13546.254955977418, 13604.047716659838, 13753.518626848012, 15027.699446011127, 12938.913892578887, 13397.397117129753, 13554.590725334101, 13594.044684821367, 13644.386002629906, 10131.645392411305, 10411.687649370531, 10495.160387169008, 10586.247575630392, 10609.257351985365, 2645.7486538778785, 2662.454196889633, 2720.986395068032, 2725.591161325817, 2743.890244390222, 58850.411495885346, 59612.70193649048, 61199.0, 61380.4654883627, 61408.999999999556, 10372.170226381872, 10436.791264174673, 10493.370397776158, 10588.576456941637, 11022.614208502824, 20209.059233449338, 20334.694979575317, 20477.692834607493, 20481.692774608393, 20529.0, 6247.812565623039, 6476.967615161894, 6533.216014078246, 6639.236487803868, 6663.700133494004, 3232.82219477931, 3332.766706330582, 3362.815045172539, 3366.6969972702573, 3398.7620866539105, 3472.0625431133453, 3533.9293214136087, 3534.134137136418, 3551.9112022199133, 3553.1117220694828, 613.8404014956144, 626.4236902050034, 634.1185751804994, 641.2113100885937, 644.0, 527.8970600732897, 551.8592758846469, 560.9747561359749, 571.3401021819722, 575.7869588252373, 8372.162783721578, 8618.698345557876, 8771.517566533774, 8887.244584210286, 8913.777155571162, 529.3303970477349, 539.1885212754779, 544.8801263722054, 546.3443867359185, 549.3984087424265, 3905.3946638271113, 3923.6272554107313, 4069.8372065117064, 4117.547069822317, 4155.459790227251, 59673.40326596679, 60835.08747368793, 61060.38939610547, 61387.38612613906, 62270.688646556475, 41078.58921410808, 45190.0, 53301.0, 56294.71852640711, 58053.0, 48657.27014094791, 48863.0, 48934.51065489371, 49334.753326233855, 50789.74605126951, 7967.442279040411, 8086.676532938616, 8111.9594402027615, 8143.83712325762, 8255.834883302181, 25299.620505692797, 25963.74036259613, 26139.738602614492, 26666.600000999613, 26738.331541711614, 30958.84520577383, 31738.523922140725, 31902.88339908092, 32004.839975799972, 32806.83596582002, 9888.901110988798, 9900.801983960424, 10098.293119481566, 10135.189184865341, 10195.84706229422, 10658.520366583678, 10728.624498142528, 10805.51375188134, 11288.604898828502, 11361.54553817871, 10211.183105351703, 10295.691129266133, 10419.166466682798, 10757.30077544957, 10800.405977671304, 9893.35693179941, 10112.646057387956, 10717.571297148026, 10722.410267435054, 10797.946010269898, 10348.172146228435, 10417.0, 10440.073975381409, 10656.62701805433, 10955.726106847393, 6912.417100397743, 7055.647217638995, 7260.927390726025, 7286.6720997556295, 7435.0, 7944.6424910880305, 8267.29727973129, 8418.663253470038, 8994.82010359776, 9154.0], "value": 6066.548073268743, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1572.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 110.0, 111.0, 110.0, 111.0, 111.0, 112.0, 112.0, 111.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 124.0, 167.0, 125.0, 126.0, 127.0, 126.0, 154.0, 124.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 169.0, 168.0, 170.0, 174.0, 167.0, 167.0, 167.0, 167.0], "value": 168.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 78.0, 109.0, 77.0, 77.0, 75.0, 76.0, 100.0, 76.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 106.0, 85.0, 85.0, 84.0, 100.0, 86.0, 86.0, 105.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 118.0, 114.0, 114.0, 115.0, 115.0, 115.0, 114.0, 114.0, 114.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 150.0, 151.0, 151.0, 152.0, 150.0, 151.0, 154.0, 151.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 70.0, 71.0, 71.0, 71.0, 74.0, 71.0, 71.0, 72.0, 73.0], "value": 72.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 56.0, 55.0, 56.0, 57.0, 56.0, 55.0, 57.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 85.0, 92.0, 84.0, 83.0, 82.0, 83.0, 83.0, 82.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 138.0, 139.0, 137.0, 143.0, 134.0, 149.0, 140.0, 178.0, 137.0], "value": 143.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 197.0, 200.0, 202.0, 198.0, 189.0, 196.0, 201.0, 195.0, 194.0], "value": 196.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 70.0, 73.0, 70.0, 71.0, 74.0, 72.0, 70.0], "value": 72.5, "unit": "score"}]}]} 14:07:07 INFO - Return code: 0 14:07:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:07:07 ERROR - # TBPL SUCCESS # 14:07:07 INFO - Running post-action listener: _resource_record_post_action 14:07:07 INFO - [mozharness: 2017-03-28 21:07:07.510358Z] Finished run-tests step (success) 14:07:07 INFO - Running post-run listener: _resource_record_post_run 14:07:07 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 366714880; Read time: 12; Write time: 185980 14:07:07 INFO - TinderboxPrint: CPU usage
13.3% 14:07:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:07:07 INFO - TinderboxPrint: I/O write bytes / time
366,714,880 / 185,980 14:07:07 INFO - TinderboxPrint: CPU idle
8,315.0 (86.7%) 14:07:07 INFO - TinderboxPrint: CPU user
1,219.8 (12.7%) 14:07:07 INFO - TinderboxPrint: Swap in / out
0 / 0 14:07:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106512384; Read time: 0; Write time: 85648 14:07:07 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 259809280; Read time: 12; Write time: 100308 14:07:08 INFO - Running post-run listener: _upload_blobber_files 14:07:08 INFO - Blob upload gear active. 14:07:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:07:08 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 14:07:08 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'] 14:07:08 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 14:07:08 INFO - (blobuploader) - INFO - Open directory for files ... 14:07:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:07:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:07:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:07:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:07:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:07:09 INFO - (blobuploader) - INFO - Done attempting. 14:07:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:07:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:07:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:07:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:07:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:07:10 INFO - (blobuploader) - INFO - Done attempting. 14:07:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:07:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:07:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:07:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:07:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:07:11 INFO - (blobuploader) - INFO - Done attempting. 14:07:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:07:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:07:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:07:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:07:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:07:14 INFO - (blobuploader) - INFO - Done attempting. 14:07:14 INFO - (blobuploader) - INFO - Iteration through files over. 14:07:14 INFO - Return code: 0 14:07:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:07:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:07:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/785ec119a5259e36fa36e8531fec7f301a1e57f67731a89d8f6aa3d41fb9f6ab7cedd87253cefd3fcff07c50d3e3cce4183f1e39e2a16ed93f729d40b0cc5170", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/295968989f9bfe1b0a7a6b5e7070c6eb66d576882ec8852848f792780be1babf0b7554c1e4b61f37d32ab3ff7a95cd689e554618e2b168661db1bb2a9f2f14e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/350e60728922619c2ff4410f81e19f44c41b141c0638ad7667dfc5b6986047f9749fbe2e58769bd2d653918a1b47e673fc57f8ab6988dfa5e8dc249a37bf9e63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7b202896fddaaf37b4b4c72561ca4d3457470d34f35c42282e81710dafbf55011664f2660ac961e9b90cc27657e141ac70d0f974a0756d257ad84a63a924e3e"} 14:07:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:07:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:07:14 INFO - Contents: 14:07:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/785ec119a5259e36fa36e8531fec7f301a1e57f67731a89d8f6aa3d41fb9f6ab7cedd87253cefd3fcff07c50d3e3cce4183f1e39e2a16ed93f729d40b0cc5170", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/295968989f9bfe1b0a7a6b5e7070c6eb66d576882ec8852848f792780be1babf0b7554c1e4b61f37d32ab3ff7a95cd689e554618e2b168661db1bb2a9f2f14e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/350e60728922619c2ff4410f81e19f44c41b141c0638ad7667dfc5b6986047f9749fbe2e58769bd2d653918a1b47e673fc57f8ab6988dfa5e8dc249a37bf9e63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7b202896fddaaf37b4b4c72561ca4d3457470d34f35c42282e81710dafbf55011664f2660ac961e9b90cc27657e141ac70d0f974a0756d257ad84a63a924e3e"} 14:07:14 INFO - Running post-run listener: copy_logs_to_upload_dir 14:07:14 INFO - Copying logs to upload dir... 14:07:14 INFO - mkdir: /builds/slave/test/build/upload/logs 14:07:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.372886 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-28 14:07:14.019903) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-28 14:07:14.025979) ========= 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=2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/785ec119a5259e36fa36e8531fec7f301a1e57f67731a89d8f6aa3d41fb9f6ab7cedd87253cefd3fcff07c50d3e3cce4183f1e39e2a16ed93f729d40b0cc5170", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/295968989f9bfe1b0a7a6b5e7070c6eb66d576882ec8852848f792780be1babf0b7554c1e4b61f37d32ab3ff7a95cd689e554618e2b168661db1bb2a9f2f14e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/350e60728922619c2ff4410f81e19f44c41b141c0638ad7667dfc5b6986047f9749fbe2e58769bd2d653918a1b47e673fc57f8ab6988dfa5e8dc249a37bf9e63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7b202896fddaaf37b4b4c72561ca4d3457470d34f35c42282e81710dafbf55011664f2660ac961e9b90cc27657e141ac70d0f974a0756d257ad84a63a924e3e"} build_url:https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011465 build_url: 'https://queue.taskcluster.net/v1/task/LMedsouYShCY44rpV_xw1A/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/785ec119a5259e36fa36e8531fec7f301a1e57f67731a89d8f6aa3d41fb9f6ab7cedd87253cefd3fcff07c50d3e3cce4183f1e39e2a16ed93f729d40b0cc5170", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/295968989f9bfe1b0a7a6b5e7070c6eb66d576882ec8852848f792780be1babf0b7554c1e4b61f37d32ab3ff7a95cd689e554618e2b168661db1bb2a9f2f14e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/350e60728922619c2ff4410f81e19f44c41b141c0638ad7667dfc5b6986047f9749fbe2e58769bd2d653918a1b47e673fc57f8ab6988dfa5e8dc249a37bf9e63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7b202896fddaaf37b4b4c72561ca4d3457470d34f35c42282e81710dafbf55011664f2660ac961e9b90cc27657e141ac70d0f974a0756d257ad84a63a924e3e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-28 14:07:14.052502) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 14:07:14.052919) ========= 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=2432103b8b3de4003b23cad4000001c2-1490733971.574187-1522645816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 14:07:14.138858) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-28 14:07:14.139457) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-28 14:07:14.140030) ========= ========= Total master_lag: 0.16 =========