builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-027 starttime: 1490959813.73 results: success (0) revision: 03d602fd723ad6ff4588c04855884ffa1dee9410 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 04:30:13.730219) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 04:30:13.730643) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 04:30:13.730924) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 04:30:13.747007) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:30:13.747373) ========= 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=1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-31 04:30:13-- 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% 50.7M=0s 2017-03-31 04:30:14 (50.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087864 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:30:13.849218) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:30:13.849535) ========= 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=1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021757 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:30:13.898948) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-31 04:30:13.899286) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 03d602fd723ad6ff4588c04855884ffa1dee9410 --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 03d602fd723ad6ff4588c04855884ffa1dee9410 --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=1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-31 04:30:14,189 truncating revision to first 12 chars 2017-03-31 04:30:14,189 Setting DEBUG logging. 2017-03-31 04:30:14,189 attempt 1/10 2017-03-31 04:30:14,189 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/03d602fd723a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-31 04:30:15,328 unpacking tar archive at: mozilla-central-03d602fd723a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.479396 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-31 04:30:15.394970) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 04:30:15.395328) ========= script_repo_revision: 03d602fd723ad6ff4588c04855884ffa1dee9410 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 04:30:15.395721) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 04:30:15.396031) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 04:30:15.407205) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-03-31 04:30:15.407533) ========= /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=1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:30:15 INFO - MultiFileLogger online at 20170331 04:30:15 in /builds/slave/test 04:30:15 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 04:30:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:30:15 INFO - {'append_to_log': False, 04:30:15 INFO - 'base_work_dir': '/builds/slave/test', 04:30:15 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:30:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:30:15 INFO - 'branch': 'Firefox-Non-PGO', 04:30:15 INFO - 'buildbot_json_path': 'buildprops.json', 04:30:15 INFO - 'config_files': ('talos/linux_config.py',), 04:30:15 INFO - 'default_actions': ('clobber', 04:30:15 INFO - 'read-buildbot-config', 04:30:15 INFO - 'download-and-extract', 04:30:15 INFO - 'populate-webroot', 04:30:15 INFO - 'create-virtualenv', 04:30:15 INFO - 'install', 04:30:15 INFO - 'run-tests'), 04:30:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:30:15 INFO - 'download_minidump_stackwalk': True, 04:30:15 INFO - 'download_symbols': 'ondemand', 04:30:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:30:15 INFO - 'tooltool.py': '/tools/tooltool.py', 04:30:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:30:15 INFO - '/tools/misc-python/virtualenv.py')}, 04:30:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:30:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:30:15 INFO - 'gecko_profile': False, 04:30:15 INFO - 'gecko_profile_interval': 0, 04:30:15 INFO - 'installer_path': 'installer.exe', 04:30:15 INFO - 'log_level': 'info', 04:30:15 INFO - 'log_name': 'talos', 04:30:15 INFO - 'log_to_console': True, 04:30:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:30:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:30:15 INFO - 'opt_config_files': (), 04:30:15 INFO - 'pip_index': False, 04:30:15 INFO - 'suite': 'dromaeojs-e10s', 04:30:15 INFO - 'system_bits': '32', 04:30:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:30:15 INFO - 'title': 'talos-linux64-ix-027', 04:30:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:30:15 INFO - 'use_talos_json': True, 04:30:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:30:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:30:15 INFO - 'work_dir': 'build'} 04:30:15 INFO - [mozharness: 2017-03-31 11:30:15.791251Z] Running clobber step. 04:30:15 INFO - Running pre-action listener: _resource_record_pre_action 04:30:15 INFO - Running main action method: clobber 04:30:15 INFO - rmtree: /builds/slave/test/build 04:30:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:30:16 INFO - Running post-action listener: _resource_record_post_action 04:30:16 INFO - [mozharness: 2017-03-31 11:30:16.797979Z] Finished clobber step (success) 04:30:16 INFO - [mozharness: 2017-03-31 11:30:16.798079Z] Running read-buildbot-config step. 04:30:16 INFO - Running pre-action listener: _resource_record_pre_action 04:30:16 INFO - Running main action method: read_buildbot_config 04:30:16 INFO - Using buildbot properties: 04:30:16 INFO - { 04:30:16 INFO - "project": "", 04:30:16 INFO - "product": "firefox", 04:30:16 INFO - "who": "cbook@mozilla.com", 04:30:16 INFO - "installer_path": "public/build/target.tar.bz2", 04:30:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:30:16 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:30:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:30:16 INFO - "stage_platform": "linux64", 04:30:16 INFO - "basedir": "/builds/slave/test", 04:30:16 INFO - "buildnumber": 500, 04:30:16 INFO - "platform": "ubuntu64_hw", 04:30:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:30:16 INFO - "slavebuilddir": "test", 04:30:16 INFO - "taskId": "UFxz5J0yRrKlEYJovTfBOQ", 04:30:16 INFO - "branch": "mozilla-central", 04:30:16 INFO - "script_repo_revision": "production", 04:30:16 INFO - "revision": "03d602fd723ad6ff4588c04855884ffa1dee9410", 04:30:16 INFO - "slavename": "talos-linux64-ix-027", 04:30:16 INFO - "repo_path": "mozilla-central" 04:30:16 INFO - } 04:30:16 INFO - Finding installer, test and symbols from parent task. 04:30:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UFxz5J0yRrKlEYJovTfBOQ'}, attempt #1 04:30:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UFxz5J0yRrKlEYJovTfBOQ'}, attempt #1 04:30:17 INFO - Task dependencies: FziPe46tTL-TfFHS0Z7sXw 04:30:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw'}, attempt #1 04:30:18 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 04:30:18 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/test_packages.json 04:30:18 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.crashreporter-symbols.zip 04:30:18 INFO - Running post-action listener: _resource_record_post_action 04:30:18 INFO - [mozharness: 2017-03-31 11:30:18.184166Z] Finished read-buildbot-config step (success) 04:30:18 INFO - [mozharness: 2017-03-31 11:30:18.184382Z] Running download-and-extract step. 04:30:18 INFO - Running pre-action listener: _resource_record_pre_action 04:30:18 INFO - Running main action method: download_and_extract 04:30:18 INFO - mkdir: /builds/slave/test/build/tests 04:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:18 INFO - trying https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.test_packages.json 04:30:18 INFO - Downloading https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:30:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:30:18 INFO - Downloaded 986 bytes. 04:30:18 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:30:18 INFO - Using the following test package requirements: 04:30:18 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:30:18 INFO - u'common': [u'target.common.tests.zip'], 04:30:18 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:30:18 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:30:18 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:30:18 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:30:18 INFO - u'mozbase': [u'target.common.tests.zip'], 04:30:18 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:30:18 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:30:18 INFO - u'web-platform': [u'target.common.tests.zip', 04:30:18 INFO - u'target.web-platform.tests.zip'], 04:30:18 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:30:18 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:30:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip 04:30:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:30:18 INFO - Fetch https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip into memory 04:30:19 INFO - Expected file size: 58227794 04:30:19 INFO - Obtained file size: 58227794 04:30:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:30:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip 04:30:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:30:29 INFO - Fetch https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip into memory 04:30:30 INFO - Expected file size: 58227794 04:30:30 INFO - Obtained file size: 58227794 04:30:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.talos.tests.zip 04:30:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:30:41 INFO - Fetch https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.talos.tests.zip into memory 04:30:42 INFO - Expected file size: 14404152 04:30:42 INFO - Obtained file size: 14404152 04:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:42 INFO - trying https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 04:30:42 INFO - Downloading https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:30:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:30:43 INFO - Downloaded 62478421 bytes. 04:30:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 04:30:43 INFO - mkdir: /builds/slave/test/properties 04:30:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:30:43 INFO - Writing to file /builds/slave/test/properties/build_url 04:30:43 INFO - Contents: 04:30:43 INFO - build_url:https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 04:30:43 INFO - Running post-action listener: _resource_record_post_action 04:30:43 INFO - Running post-action listener: set_extra_try_arguments 04:30:43 INFO - [mozharness: 2017-03-31 11:30:43.955302Z] Finished download-and-extract step (success) 04:30:43 INFO - [mozharness: 2017-03-31 11:30:43.955399Z] Running populate-webroot step. 04:30:43 INFO - Running pre-action listener: _resource_record_pre_action 04:30:43 INFO - Running main action method: populate_webroot 04:30:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:30:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:30:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:30:43 INFO - '--tppagecycles', 04:30:43 INFO - '7'], 04:30:43 INFO - 'tests': ['tsvgm']}}, 04:30:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:30:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:30:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:30:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:30:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:30:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:30:43 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:30:43 INFO - 'talos_options': ['--disable-e10s'], 04:30:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:30:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:43 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:30:43 INFO - 'talos_options': ['--disable-e10s'], 04:30:43 INFO - 'tests': ['damp', 'tps']}, 04:30:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:30:43 INFO - 'tests': ['damp', 'tps']}, 04:30:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:30:43 INFO - 'tests': ['dromaeo_dom']}, 04:30:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:30:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:30:43 INFO - 'tests': ['basic_compositor_video']}, 04:30:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:30:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:30:43 INFO - 'tests': ['a11yr', 04:30:43 INFO - 'ts_paint', 04:30:43 INFO - 'tpaint', 04:30:43 INFO - 'sessionrestore', 04:30:43 INFO - 'sessionrestore_no_auto_restore', 04:30:43 INFO - 'tabpaint']}, 04:30:43 INFO - 'other-e10s': {'tests': ['a11yr', 04:30:43 INFO - 'ts_paint', 04:30:43 INFO - 'tpaint', 04:30:43 INFO - 'sessionrestore', 04:30:43 INFO - 'sessionrestore_no_auto_restore', 04:30:43 INFO - 'tabpaint']}, 04:30:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:30:43 INFO - 'ts_paint', 04:30:43 INFO - 'tpaint', 04:30:43 INFO - 'sessionrestore', 04:30:43 INFO - 'sessionrestore_no_auto_restore', 04:30:43 INFO - 'tabpaint']}, 04:30:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:30:43 INFO - 'ts_paint', 04:30:43 INFO - 'tpaint', 04:30:43 INFO - 'sessionrestore', 04:30:43 INFO - 'sessionrestore_no_auto_restore', 04:30:43 INFO - 'tabpaint']}, 04:30:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:30:43 INFO - 'tests': ['a11yr', 04:30:43 INFO - 'ts_paint', 04:30:43 INFO - 'tpaint', 04:30:43 INFO - 'sessionrestore', 04:30:43 INFO - 'sessionrestore_no_auto_restore', 04:30:43 INFO - 'tabpaint']}, 04:30:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:30:43 INFO - 'tests': ['a11yr', 04:30:43 INFO - 'ts_paint', 04:30:43 INFO - 'tpaint', 04:30:43 INFO - 'sessionrestore', 04:30:43 INFO - 'sessionrestore_no_auto_restore', 04:30:43 INFO - 'tabpaint']}, 04:30:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:30:43 INFO - 'tests': ['tsvgx', 04:30:43 INFO - 'tsvgr_opacity', 04:30:43 INFO - 'tart', 04:30:43 INFO - 'tscrollx', 04:30:43 INFO - 'cart', 04:30:43 INFO - 'tsvg_static']}, 04:30:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:30:43 INFO - 'tsvgr_opacity', 04:30:43 INFO - 'tart', 04:30:43 INFO - 'tscrollx', 04:30:43 INFO - 'cart', 04:30:43 INFO - 'tsvg_static']}, 04:30:43 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:30:43 INFO - 'talos_options': ['--disable-e10s'], 04:30:43 INFO - 'tests': ['tp5o']}, 04:30:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:30:43 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:30:43 INFO - 'talos_options': ['--disable-e10s', 04:30:43 INFO - '--xperf_path', 04:30:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:43 INFO - 'tests': ['tp5n']}, 04:30:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:30:43 INFO - 'talos_options': ['--xperf_path', 04:30:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:43 INFO - 'tests': ['tp5n']}}, 04:30:43 INFO - 'talos.zip': {'path': '', 04:30:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:30:43 INFO - Running post-action listener: _resource_record_post_action 04:30:43 INFO - [mozharness: 2017-03-31 11:30:43.968582Z] Finished populate-webroot step (success) 04:30:43 INFO - [mozharness: 2017-03-31 11:30:43.968671Z] Running create-virtualenv step. 04:30:43 INFO - Running pre-action listener: _resource_record_pre_action 04:30:43 INFO - Running main action method: create_virtualenv 04:30:43 INFO - Creating virtualenv /builds/slave/test/build/venv 04:30:43 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 04:30:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:30:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:30:44 INFO - Using real prefix '/usr' 04:30:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:30:44 INFO - Installing distribute.............................................................................................................................................................................................done. 04:30:46 INFO - Installing pip.................done. 04:30:46 INFO - Return code: 0 04:30:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:30:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:30:46 INFO - Reading from file tmpfile_stdout 04:30:46 INFO - Output received: 04:30:46 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) 04:30:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:30:46 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')]} 04:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:46 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')]} 04:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:46 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 0x1e251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c0290>, '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 0x20c0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c1040>, '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': '1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306', '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 04:30:46 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 04:30:46 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 04:30:46 INFO - Using env: {'DISPLAY': ':0', 04:30:46 INFO - 'HOME': '/home/cltbld', 04:30:46 INFO - 'LANG': 'en_US.UTF-8', 04:30:46 INFO - 'LANGUAGE': 'en_US:en', 04:30:46 INFO - 'LOGNAME': 'cltbld', 04:30:46 INFO - 'MAIL': '/var/mail/cltbld', 04:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:46 INFO - 'MOZ_NO_REMOTE': '1', 04:30:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:46 INFO - 'NO_EM_RESTART': '1', 04:30:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:46 INFO - 'PWD': '/builds/slave/test', 04:30:46 INFO - 'SHELL': '/bin/bash', 04:30:46 INFO - 'SHLVL': '1', 04:30:46 INFO - 'TERM': 'linux', 04:30:46 INFO - 'TMOUT': '86400', 04:30:46 INFO - 'USER': 'cltbld', 04:30:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306', 04:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:46 INFO - '_': '/tools/buildbot/bin/python'} 04:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:46 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 04:30:46 INFO - Cleaning up... 04:30:46 INFO - Return code: 0 04:30:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:30:46 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')]} 04:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:46 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')]} 04:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:46 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 0x1e251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c0290>, '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 0x20c0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c1040>, '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': '1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306', '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 04:30:46 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 04:30:46 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 04:30:46 INFO - Using env: {'DISPLAY': ':0', 04:30:46 INFO - 'HOME': '/home/cltbld', 04:30:46 INFO - 'LANG': 'en_US.UTF-8', 04:30:46 INFO - 'LANGUAGE': 'en_US:en', 04:30:46 INFO - 'LOGNAME': 'cltbld', 04:30:46 INFO - 'MAIL': '/var/mail/cltbld', 04:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:46 INFO - 'MOZ_NO_REMOTE': '1', 04:30:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:46 INFO - 'NO_EM_RESTART': '1', 04:30:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:46 INFO - 'PWD': '/builds/slave/test', 04:30:46 INFO - 'SHELL': '/bin/bash', 04:30:46 INFO - 'SHLVL': '1', 04:30:46 INFO - 'TERM': 'linux', 04:30:46 INFO - 'TMOUT': '86400', 04:30:46 INFO - 'USER': 'cltbld', 04:30:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306', 04:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:46 INFO - '_': '/tools/buildbot/bin/python'} 04:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:47 INFO - Downloading/unpacking psutil>=3.1.1 04:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:30:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:49 INFO - Installing collected packages: psutil 04:30:49 INFO - Running setup.py install for psutil 04:30:49 INFO - building 'psutil._psutil_linux' extension 04:30:49 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 04:30:49 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 04:30:49 INFO - building 'psutil._psutil_posix' extension 04:30:49 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 04:30:49 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 04:30:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:49 INFO - Successfully installed psutil 04:30:49 INFO - Cleaning up... 04:30:49 INFO - Return code: 0 04:30:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:49 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 0x1e251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c0290>, '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 0x20c0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c1040>, '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': '1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306', '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 04:30:49 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 04:30:49 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 04:30:49 INFO - Using env: {'DISPLAY': ':0', 04:30:49 INFO - 'HOME': '/home/cltbld', 04:30:49 INFO - 'LANG': 'en_US.UTF-8', 04:30:49 INFO - 'LANGUAGE': 'en_US:en', 04:30:49 INFO - 'LOGNAME': 'cltbld', 04:30:49 INFO - 'MAIL': '/var/mail/cltbld', 04:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:49 INFO - 'MOZ_NO_REMOTE': '1', 04:30:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:49 INFO - 'NO_EM_RESTART': '1', 04:30:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:49 INFO - 'PWD': '/builds/slave/test', 04:30:49 INFO - 'SHELL': '/bin/bash', 04:30:49 INFO - 'SHLVL': '1', 04:30:49 INFO - 'TERM': 'linux', 04:30:49 INFO - 'TMOUT': '86400', 04:30:49 INFO - 'USER': 'cltbld', 04:30:49 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306', 04:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:49 INFO - '_': '/tools/buildbot/bin/python'} 04:30:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:30:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:30:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:30:52 INFO - Installing collected packages: mozsystemmonitor 04:30:52 INFO - Running setup.py install for mozsystemmonitor 04:30:52 INFO - Successfully installed mozsystemmonitor 04:30:52 INFO - Cleaning up... 04:30:52 INFO - Return code: 0 04:30:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:52 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 0x1e251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c0290>, '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 0x20c0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c1040>, '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': '1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306', '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 04:30:52 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 04:30:52 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 04:30:52 INFO - Using env: {'DISPLAY': ':0', 04:30:52 INFO - 'HOME': '/home/cltbld', 04:30:52 INFO - 'LANG': 'en_US.UTF-8', 04:30:52 INFO - 'LANGUAGE': 'en_US:en', 04:30:52 INFO - 'LOGNAME': 'cltbld', 04:30:52 INFO - 'MAIL': '/var/mail/cltbld', 04:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:52 INFO - 'MOZ_NO_REMOTE': '1', 04:30:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:52 INFO - 'NO_EM_RESTART': '1', 04:30:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:52 INFO - 'PWD': '/builds/slave/test', 04:30:52 INFO - 'SHELL': '/bin/bash', 04:30:52 INFO - 'SHLVL': '1', 04:30:52 INFO - 'TERM': 'linux', 04:30:52 INFO - 'TMOUT': '86400', 04:30:52 INFO - 'USER': 'cltbld', 04:30:52 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306', 04:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:52 INFO - '_': '/tools/buildbot/bin/python'} 04:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:52 INFO - Downloading/unpacking jsonschema==2.5.1 04:30:52 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 04:30:52 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 04:30:52 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 04:30:52 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 04:30:52 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 04:30:52 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 04:30:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:30:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30:54 INFO - Downloading functools32-3.2.3-2.tar.gz 04:30:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:30:54 INFO - warning: no files found matching '*.txt' 04:30:54 INFO - no previously-included directories found matching 'build' 04:30:54 INFO - no previously-included directories found matching 'dist' 04:30:54 INFO - no previously-included directories found matching '.git*' 04:30:54 INFO - Installing collected packages: jsonschema, functools32 04:30:54 INFO - Running setup.py install for functools32 04:30:55 INFO - warning: no files found matching '*.txt' 04:30:55 INFO - no previously-included directories found matching 'build' 04:30:55 INFO - no previously-included directories found matching 'dist' 04:30:55 INFO - no previously-included directories found matching '.git*' 04:30:55 INFO - Successfully installed jsonschema functools32 04:30:55 INFO - Cleaning up... 04:30:55 INFO - Return code: 0 04:30:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:55 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 0x1e251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c0290>, '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 0x20c0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c1040>, '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': '1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306', '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 04:30:55 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 04:30:55 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 04:30:55 INFO - Using env: {'DISPLAY': ':0', 04:30:55 INFO - 'HOME': '/home/cltbld', 04:30:55 INFO - 'LANG': 'en_US.UTF-8', 04:30:55 INFO - 'LANGUAGE': 'en_US:en', 04:30:55 INFO - 'LOGNAME': 'cltbld', 04:30:55 INFO - 'MAIL': '/var/mail/cltbld', 04:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:55 INFO - 'MOZ_NO_REMOTE': '1', 04:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:55 INFO - 'NO_EM_RESTART': '1', 04:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:55 INFO - 'PWD': '/builds/slave/test', 04:30:55 INFO - 'SHELL': '/bin/bash', 04:30:55 INFO - 'SHLVL': '1', 04:30:55 INFO - 'TERM': 'linux', 04:30:55 INFO - 'TMOUT': '86400', 04:30:55 INFO - 'USER': 'cltbld', 04:30:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306', 04:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:55 INFO - '_': '/tools/buildbot/bin/python'} 04:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:30:55 INFO - Cleaning up... 04:30:55 INFO - Return code: 0 04:30:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:55 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 0x1e251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c0290>, '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 0x20c0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c1040>, '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': '1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306', '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 04:30:55 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 04:30:55 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 04:30:55 INFO - Using env: {'DISPLAY': ':0', 04:30:55 INFO - 'HOME': '/home/cltbld', 04:30:55 INFO - 'LANG': 'en_US.UTF-8', 04:30:55 INFO - 'LANGUAGE': 'en_US:en', 04:30:55 INFO - 'LOGNAME': 'cltbld', 04:30:55 INFO - 'MAIL': '/var/mail/cltbld', 04:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:55 INFO - 'MOZ_NO_REMOTE': '1', 04:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:55 INFO - 'NO_EM_RESTART': '1', 04:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:55 INFO - 'PWD': '/builds/slave/test', 04:30:55 INFO - 'SHELL': '/bin/bash', 04:30:55 INFO - 'SHLVL': '1', 04:30:55 INFO - 'TERM': 'linux', 04:30:55 INFO - 'TMOUT': '86400', 04:30:55 INFO - 'USER': 'cltbld', 04:30:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306', 04:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:55 INFO - '_': '/tools/buildbot/bin/python'} 04:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:55 INFO - Downloading/unpacking blobuploader==1.2.4 04:30:55 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 04:30:55 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 04:30:55 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 04:30:55 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 04:30:55 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 04:30:55 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 04:30:57 INFO - Downloading blobuploader-1.2.4.tar.gz 04:30:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:30:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:57 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 04:30:57 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 04:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:30:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:30:58 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 04:30:58 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 04:30:58 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 04:30:58 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 04:30:58 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 04:30:58 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 04:30:58 INFO - Downloading docopt-0.6.1.tar.gz 04:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:30:58 INFO - Installing collected packages: blobuploader, requests, docopt 04:30:58 INFO - Running setup.py install for blobuploader 04:30:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:30:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:30:58 INFO - Running setup.py install for requests 04:30:58 INFO - Running setup.py install for docopt 04:30:58 INFO - Successfully installed blobuploader requests docopt 04:30:58 INFO - Cleaning up... 04:30:58 INFO - Return code: 0 04:30:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30:58 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')]} 04:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:58 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')]} 04:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:58 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 0x1e251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c0290>, '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 0x20c0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c1040>, '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': '1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306', '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 04:30:58 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 04:30:58 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 04:30:58 INFO - Using env: {'DISPLAY': ':0', 04:30:58 INFO - 'HOME': '/home/cltbld', 04:30:58 INFO - 'LANG': 'en_US.UTF-8', 04:30:58 INFO - 'LANGUAGE': 'en_US:en', 04:30:58 INFO - 'LOGNAME': 'cltbld', 04:30:58 INFO - 'MAIL': '/var/mail/cltbld', 04:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:58 INFO - 'MOZ_NO_REMOTE': '1', 04:30:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:58 INFO - 'NO_EM_RESTART': '1', 04:30:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:58 INFO - 'PWD': '/builds/slave/test', 04:30:58 INFO - 'SHELL': '/bin/bash', 04:30:58 INFO - 'SHLVL': '1', 04:30:58 INFO - 'TERM': 'linux', 04:30:58 INFO - 'TMOUT': '86400', 04:30:58 INFO - 'USER': 'cltbld', 04:30:58 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306', 04:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:58 INFO - '_': '/tools/buildbot/bin/python'} 04:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:30:59 INFO - Running setup.py (path:/tmp/pip-bQxnuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:30:59 INFO - Running setup.py (path:/tmp/pip-pDcvyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:30:59 INFO - Running setup.py (path:/tmp/pip-VV8kzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:30:59 INFO - Running setup.py (path:/tmp/pip-ihb2XC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:30:59 INFO - Running setup.py (path:/tmp/pip-gMXlFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:30:59 INFO - Running setup.py (path:/tmp/pip-S8pvmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:30:59 INFO - Running setup.py (path:/tmp/pip-zn2cEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:30:59 INFO - Running setup.py (path:/tmp/pip-n9Wb2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:30:59 INFO - Running setup.py (path:/tmp/pip-G4Gbt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:30:59 INFO - Running setup.py (path:/tmp/pip-STxIno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:30:59 INFO - Running setup.py (path:/tmp/pip-xBbbT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:30:59 INFO - Running setup.py (path:/tmp/pip-HMA4KK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:00 INFO - Running setup.py (path:/tmp/pip-HTD5hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:00 INFO - Running setup.py (path:/tmp/pip-MqAGpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:00 INFO - Running setup.py (path:/tmp/pip-YcoNQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:00 INFO - Running setup.py (path:/tmp/pip-zMt7p5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:00 INFO - Running setup.py (path:/tmp/pip-RI5rt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:31:00 INFO - Running setup.py install for manifestparser 04:31:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:31:00 INFO - Running setup.py install for mozcrash 04:31:00 INFO - Running setup.py install for mozdebug 04:31:00 INFO - Running setup.py install for mozdevice 04:31:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:31:00 INFO - Running setup.py install for mozfile 04:31:00 INFO - Running setup.py install for mozhttpd 04:31:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:31:01 INFO - Running setup.py install for mozinfo 04:31:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:31:01 INFO - Running setup.py install for mozInstall 04:31:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:31:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:31:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:31:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:31:01 INFO - Running setup.py install for mozleak 04:31:01 INFO - Running setup.py install for mozlog 04:31:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:31:01 INFO - Running setup.py install for moznetwork 04:31:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:31:01 INFO - Running setup.py install for mozprocess 04:31:01 INFO - Running setup.py install for mozprofile 04:31:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:31:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:31:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:31:01 INFO - Running setup.py install for mozrunner 04:31:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:31:01 INFO - Running setup.py install for mozscreenshot 04:31:01 INFO - Running setup.py install for moztest 04:31:02 INFO - Running setup.py install for mozversion 04:31:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:31:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:31:02 INFO - Cleaning up... 04:31:02 INFO - Return code: 0 04:31:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:02 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')]} 04:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:02 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')]} 04:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:02 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 0x1e251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c0290>, '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 0x20c0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c1040>, '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': '1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306', '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 04:31:02 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 04:31:02 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 04:31:02 INFO - Using env: {'DISPLAY': ':0', 04:31:02 INFO - 'HOME': '/home/cltbld', 04:31:02 INFO - 'LANG': 'en_US.UTF-8', 04:31:02 INFO - 'LANGUAGE': 'en_US:en', 04:31:02 INFO - 'LOGNAME': 'cltbld', 04:31:02 INFO - 'MAIL': '/var/mail/cltbld', 04:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:02 INFO - 'MOZ_NO_REMOTE': '1', 04:31:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:02 INFO - 'NO_EM_RESTART': '1', 04:31:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:02 INFO - 'PWD': '/builds/slave/test', 04:31:02 INFO - 'SHELL': '/bin/bash', 04:31:02 INFO - 'SHLVL': '1', 04:31:02 INFO - 'TERM': 'linux', 04:31:02 INFO - 'TMOUT': '86400', 04:31:02 INFO - 'USER': 'cltbld', 04:31:02 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306', 04:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:02 INFO - '_': '/tools/buildbot/bin/python'} 04:31:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:02 INFO - Running setup.py (path:/tmp/pip-nM6pcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:02 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)) 04:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:02 INFO - Running setup.py (path:/tmp/pip-SSHd4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:02 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)) 04:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:02 INFO - Running setup.py (path:/tmp/pip-kPx7IG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:02 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)) 04:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:02 INFO - Running setup.py (path:/tmp/pip-H72Tlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:02 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)) 04:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:02 INFO - Running setup.py (path:/tmp/pip-p8mnPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:02 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)) 04:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:02 INFO - Running setup.py (path:/tmp/pip-MJf3FG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:02 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)) 04:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:02 INFO - Running setup.py (path:/tmp/pip-HfCpRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:02 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)) 04:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:02 INFO - Running setup.py (path:/tmp/pip-ZXSZXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:02 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)) 04:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:02 INFO - Running setup.py (path:/tmp/pip-Tx7GLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:03 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)) 04:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:03 INFO - Running setup.py (path:/tmp/pip-Lp1zVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:03 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)) 04:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:03 INFO - Running setup.py (path:/tmp/pip-KBVzMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:03 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)) 04:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:03 INFO - Running setup.py (path:/tmp/pip-N_EauT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:03 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)) 04:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:03 INFO - Running setup.py (path:/tmp/pip-7yhcUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:03 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)) 04:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:03 INFO - Running setup.py (path:/tmp/pip-SCMEgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:03 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)) 04:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:03 INFO - Running setup.py (path:/tmp/pip-pujr_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:03 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)) 04:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:03 INFO - Running setup.py (path:/tmp/pip-wYSaV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:03 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)) 04:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:03 INFO - Running setup.py (path:/tmp/pip-BGcKAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:03 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)) 04:31:03 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)) 04:31:03 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)) 04:31:03 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)) 04:31:03 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)) 04:31:03 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)) 04:31:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:03 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 04:31:03 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 04:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:05 INFO - Downloading blessings-1.6.tar.gz 04:31:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:31:05 INFO - Installing collected packages: blessings 04:31:05 INFO - Running setup.py install for blessings 04:31:05 INFO - Successfully installed blessings 04:31:05 INFO - Cleaning up... 04:31:05 INFO - Return code: 0 04:31:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:31:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:06 INFO - Reading from file tmpfile_stdout 04:31:06 INFO - Current package versions: 04:31:06 INFO - argparse == 1.2.1 04:31:06 INFO - blessings == 1.6 04:31:06 INFO - blobuploader == 1.2.4 04:31:06 INFO - docopt == 0.6.1 04:31:06 INFO - functools32 == 3.2.3-2 04:31:06 INFO - jsonschema == 2.5.1 04:31:06 INFO - manifestparser == 1.1 04:31:06 INFO - mozInstall == 1.12 04:31:06 INFO - mozcrash == 1.0 04:31:06 INFO - mozdebug == 0.1 04:31:06 INFO - mozdevice == 0.49 04:31:06 INFO - mozfile == 1.2 04:31:06 INFO - mozhttpd == 0.7 04:31:06 INFO - mozinfo == 0.9 04:31:06 INFO - mozleak == 0.1 04:31:06 INFO - mozlog == 3.4 04:31:06 INFO - moznetwork == 0.27 04:31:06 INFO - mozprocess == 0.25 04:31:06 INFO - mozprofile == 0.28 04:31:06 INFO - mozrunner == 6.13 04:31:06 INFO - mozscreenshot == 0.1 04:31:06 INFO - mozsystemmonitor == 0.3 04:31:06 INFO - moztest == 0.8 04:31:06 INFO - mozversion == 1.4 04:31:06 INFO - psutil == 3.1.1 04:31:06 INFO - requests == 1.2.3 04:31:06 INFO - wsgiref == 0.1.2 04:31:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:06 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')]} 04:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:06 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')]} 04:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:06 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 0x1e251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c0290>, '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 0x20c0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c1040>, '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': '1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306', '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 04:31:06 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 04:31:06 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 04:31:06 INFO - Using env: {'DISPLAY': ':0', 04:31:06 INFO - 'HOME': '/home/cltbld', 04:31:06 INFO - 'LANG': 'en_US.UTF-8', 04:31:06 INFO - 'LANGUAGE': 'en_US:en', 04:31:06 INFO - 'LOGNAME': 'cltbld', 04:31:06 INFO - 'MAIL': '/var/mail/cltbld', 04:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:06 INFO - 'MOZ_NO_REMOTE': '1', 04:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:06 INFO - 'NO_EM_RESTART': '1', 04:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:06 INFO - 'PWD': '/builds/slave/test', 04:31:06 INFO - 'SHELL': '/bin/bash', 04:31:06 INFO - 'SHLVL': '1', 04:31:06 INFO - 'TERM': 'linux', 04:31:06 INFO - 'TMOUT': '86400', 04:31:06 INFO - 'USER': 'cltbld', 04:31:06 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306', 04:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:06 INFO - '_': '/tools/buildbot/bin/python'} 04:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:06 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)) 04:31:06 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)) 04:31:06 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)) 04:31:06 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)) 04:31:06 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)) 04:31:06 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)) 04:31:06 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)) 04:31:06 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)) 04:31:06 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)) 04:31:06 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)) 04:31:06 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)) 04:31:06 INFO - Cleaning up... 04:31:06 INFO - Return code: 0 04:31:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:31:06 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')]} 04:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:06 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')]} 04:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:06 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 0x1e251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c0290>, '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 0x20c0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c1040>, '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': '1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306', '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 04:31:06 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 04:31:06 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 04:31:06 INFO - Using env: {'DISPLAY': ':0', 04:31:06 INFO - 'HOME': '/home/cltbld', 04:31:06 INFO - 'LANG': 'en_US.UTF-8', 04:31:06 INFO - 'LANGUAGE': 'en_US:en', 04:31:06 INFO - 'LOGNAME': 'cltbld', 04:31:06 INFO - 'MAIL': '/var/mail/cltbld', 04:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:06 INFO - 'MOZ_NO_REMOTE': '1', 04:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:06 INFO - 'NO_EM_RESTART': '1', 04:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:06 INFO - 'PWD': '/builds/slave/test', 04:31:06 INFO - 'SHELL': '/bin/bash', 04:31:06 INFO - 'SHLVL': '1', 04:31:06 INFO - 'TERM': 'linux', 04:31:06 INFO - 'TMOUT': '86400', 04:31:06 INFO - 'USER': 'cltbld', 04:31:06 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306', 04:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:06 INFO - '_': '/tools/buildbot/bin/python'} 04:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:31:06 INFO - Cleaning up... 04:31:06 INFO - Return code: 0 04:31:06 INFO - Running post-action listener: _resource_record_post_action 04:31:06 INFO - Running post-action listener: _start_resource_monitoring 04:31:06 INFO - Starting resource monitoring. 04:31:06 INFO - [mozharness: 2017-03-31 11:31:06.662949Z] Finished create-virtualenv step (success) 04:31:06 INFO - [mozharness: 2017-03-31 11:31:06.663468Z] Running install step. 04:31:06 INFO - Running pre-action listener: _resource_record_pre_action 04:31:06 INFO - Running main action method: install 04:31:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:06 INFO - Reading from file tmpfile_stdout 04:31:06 INFO - Detecting whether we're running mozinstall >=1.0... 04:31:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:31:06 INFO - Reading from file tmpfile_stdout 04:31:06 INFO - Output received: 04:31:06 INFO - Usage: mozinstall [options] installer 04:31:06 INFO - Options: 04:31:06 INFO - -h, --help show this help message and exit 04:31:06 INFO - -d DEST, --destination=DEST 04:31:06 INFO - Directory to install application into. [default: 04:31:06 INFO - "/builds/slave/test"] 04:31:06 INFO - --app=APP Application being installed. [default: firefox] 04:31:06 INFO - mkdir: /builds/slave/test/build/application 04:31:06 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'] 04:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:31:22 INFO - Reading from file tmpfile_stdout 04:31:22 INFO - Output received: 04:31:22 INFO - /builds/slave/test/build/application/firefox/firefox 04:31:22 INFO - Running post-action listener: _resource_record_post_action 04:31:22 INFO - [mozharness: 2017-03-31 11:31:22.610870Z] Finished install step (success) 04:31:22 INFO - [mozharness: 2017-03-31 11:31:22.611139Z] Running run-tests step. 04:31:22 INFO - Running pre-action listener: _resource_record_pre_action 04:31:22 INFO - Running main action method: run_tests 04:31:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:31:22 INFO - Python 2.7.3 04:31:22 INFO - Return code: 0 04:31:22 INFO - grabbing minidump binary from tooltool 04:31:22 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')]} 04:31:22 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 0x20c0290>, '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 0x20c0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c1040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:31:22 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 04:31:22 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 04:31:22 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 04:31:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:31:22 INFO - Return code: 0 04:31:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:31:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:31:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:31:22 INFO - ENV: RUST_BACKTRACE is now 1 04:31:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:31:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:31:22 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/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 04:31:22 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/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 04:31:22 INFO - Using env: {'DISPLAY': ':0', 04:31:22 INFO - 'HOME': '/home/cltbld', 04:31:22 INFO - 'LANG': 'en_US.UTF-8', 04:31:22 INFO - 'LANGUAGE': 'en_US:en', 04:31:22 INFO - 'LOGNAME': 'cltbld', 04:31:22 INFO - 'MAIL': '/var/mail/cltbld', 04:31:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:31:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:22 INFO - 'MOZ_NO_REMOTE': '1', 04:31:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:31:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:22 INFO - 'NO_EM_RESTART': '1', 04:31:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:22 INFO - 'PWD': '/builds/slave/test', 04:31:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:31:22 INFO - 'RUST_BACKTRACE': '1', 04:31:22 INFO - 'SHELL': '/bin/bash', 04:31:22 INFO - 'SHLVL': '1', 04:31:22 INFO - 'TERM': 'linux', 04:31:22 INFO - 'TMOUT': '86400', 04:31:22 INFO - 'USER': 'cltbld', 04:31:22 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306', 04:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:22 INFO - '_': '/tools/buildbot/bin/python'} 04:31:22 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/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 04:31:22 INFO - mozversion application_buildid: 20170330114804 04:31:22 INFO - mozversion application_changeset: 03d602fd723ad6ff4588c04855884ffa1dee9410 04:31:22 INFO - mozversion application_display_name: Nightly 04:31:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:31:22 INFO - mozversion application_name: Firefox 04:31:22 INFO - mozversion application_remotingname: firefox 04:31:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:31:22 INFO - mozversion application_vendor: Mozilla 04:31:22 INFO - mozversion application_version: 55.0a1 04:31:22 INFO - mozversion platform_buildid: 20170330114804 04:31:22 INFO - mozversion platform_changeset: 03d602fd723ad6ff4588c04855884ffa1dee9410 04:31:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:31:22 INFO - mozversion platform_version: 55.0a1 04:31:22 INFO - using testdate: 1490959882 04:31:22 INFO - actual date: 1490959882 04:31:22 INFO - starting webserver on 'localhost:36735' 04:31:22 INFO - SUITE-START | Running 2 tests 04:31:22 INFO - TEST-START | dromaeo_css 04:31:22 INFO - operating with platform_type : linux_ 04:31:22 INFO - Initialising browser for dromaeo_css test... 04:31:22 INFO - TEST-INFO | started process 24645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7nfs9Q/profile http://localhost:36735/getInfo.html) 04:31:27 INFO - PID 24645 | __metrics Screen width/height:1600/1200 04:31:27 INFO - PID 24645 | colorDepth:24 04:31:27 INFO - PID 24645 | Browser inner width/height: 1024/697 04:31:27 INFO - PID 24645 | __metrics 04:31:28 ERROR - PID 24645 | 1490959888464 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:6382:36 < canClose@browser.js:5233:12 < forceQuit@jar:file:///tmp/tmp7nfs9Q/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmp7nfs9Q/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmp7nfs9Q/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmp7nfs9Q/profile/extensions/talos-powers@TalosPowersService.js:55:9 04:31:28 ERROR - PID 24645 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 04:31:29 INFO - TEST-INFO | 24645: exit 0 04:31:29 INFO - Browser initialized. 04:31:29 INFO - Running cycle 1/1 for dromaeo_css test... 04:31:29 INFO - TEST-INFO | started process 24780 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7nfs9Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:31:41 INFO - PID 24780 | RSS: Main: 155918336 04:31:41 INFO - PID 24780 | 04:34:46 INFO - PID 24780 | Cycle 1(1): loaded http://localhost:36735/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36735/tests/dromaeo/cssquery-ext.html) 04:34:48 INFO - PID 24780 | RSS: Main: 166653952 04:34:48 INFO - PID 24780 | 04:36:30 INFO - PID 24780 | ************************* 04:36:30 INFO - PID 24780 | A coding exception was thrown and uncaught in a Task. 04:36:30 INFO - PID 24780 | 04:36:30 ERROR - PID 24780 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:36:30 INFO - PID 24780 | Full stack: 04:36:30 INFO - PID 24780 | ************************* 04:36:30 INFO - PID 24780 | ************************* 04:36:30 INFO - PID 24780 | A coding exception was thrown and uncaught in a Task. 04:36:30 INFO - PID 24780 | 04:36:30 ERROR - PID 24780 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:36:30 INFO - PID 24780 | Full stack: 04:36:30 INFO - PID 24780 | ************************* 04:36:30 INFO - PID 24780 | ************************* 04:36:30 INFO - PID 24780 | A coding exception was thrown and uncaught in a Task. 04:36:30 INFO - PID 24780 | 04:36:30 ERROR - PID 24780 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:36:30 INFO - PID 24780 | Full stack: 04:36:30 INFO - PID 24780 | ************************* 04:36:30 INFO - PID 24780 | ************************* 04:36:30 INFO - PID 24780 | A coding exception was thrown and uncaught in a Task. 04:36:30 INFO - PID 24780 | 04:36:30 ERROR - PID 24780 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:36:30 INFO - PID 24780 | Full stack: 04:36:30 INFO - PID 24780 | ************************* 04:37:51 INFO - PID 24780 | Cycle 1(1): loaded http://localhost:36735/tests/dromaeo/cssquery-ext.html (next: http://localhost:36735/tests/dromaeo/cssquery-jquery.html) 04:37:51 INFO - PID 24780 | RSS: Main: 160980992 04:37:51 INFO - PID 24780 | 04:40:53 INFO - PID 24780 | Cycle 1(1): loaded http://localhost:36735/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36735/tests/dromaeo/cssquery-mootools.html) 04:40:54 INFO - PID 24780 | RSS: Main: 169324544 04:40:54 INFO - PID 24780 | 04:43:56 INFO - PID 24780 | Cycle 1(1): loaded http://localhost:36735/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36735/tests/dromaeo/cssquery-prototype.html) 04:43:56 INFO - PID 24780 | RSS: Main: 162009088 04:43:56 INFO - PID 24780 | 04:46:59 INFO - PID 24780 | Cycle 1(1): loaded http://localhost:36735/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36735/tests/dromaeo/cssquery-yui.html) 04:47:00 INFO - PID 24780 | RSS: Main: 168886272 04:47:00 INFO - PID 24780 | 04:50:03 INFO - PID 24780 | Cycle 1(1): loaded http://localhost:36735/tests/dromaeo/cssquery-yui.html (next: http://localhost:36735/tests/dromaeo/cssquery-dojo.html) 04:50:03 INFO - PID 24780 | RSS: Main: 163876864 04:50:03 INFO - PID 24780 | 04:50:03 INFO - PID 24780 | __start_tp_report 04:50:03 INFO - PID 24780 | _x_x_mozilla_page_load 04:50:03 INFO - PID 24780 | _x_x_mozilla_page_load_details 04:50:03 INFO - PID 24780 | |i|pagename|runs| 04:50:03 INFO - PID 24780 | |0;dojo.html;2674.613633640829;2707.756301932826;2729.56326987682;2755.683096443907;2757.2831063923372;5142.588592912567;5257.106291930376;5282.260483532304;5283.181106928428;5315.574754019679;5214.035403450355;5236.659617124884;5255.421903590602;5345.1447768357075;5360.088784906566;4797.712137271767;4799.952000479985;4831.975840120795;4838.467768545474;4853.757312134397;4834.468208497063;4857.684250523723;4936.456989731127;4939.43196532398;4963.602911767068;4724.244120940633;4735.431748190239;4769.093872164278;4835.178019736618;4866.4403593586485;4793.54461326177;4833.226683730586;4833.347498087748;4850;4884.242942343943;4700.882477938045;4762.404699412574;4767.475577686451;4801.639877009238;4807.18277892759;5062.544371006627;5125.154349532323;5216;5260.473952604747;5299.33758280215;5512.889742205173;5557.555395568385;5578.721063946787;5581.330240371181;5611.607187496877;5667.6316039457715;5673.319201695782;5686.5735069869515;5730.19777231188;5763.193152958589;5270.8155214567305;5294.12646913255;5303.36359636846;5310.070737620901;5349.5720342372515;5634.154876768435;5643.943560564424;5727.742251598688;5741.88516229673;5849.6782676952325;5395.541378982752;5450.754716037788;5471.835844924659;5529.198266251371;5538.086215774432;5570.832875013756;5639.43605639441;5641.407652196543;5656.490915817596;5669.914951275734;5391;5527.723613819293;5597.132444471114;5598.4961353477565;5627.861412663244;5553.916691249635;5559.388467268597;5559.916601250984;5582.413846546136;5588.329400471969;4734.289856521549;4738.668293219511;4751.83368582098;4754.144254034238;4754.904901902012;4110.301248787713;4125.071858831739;4129.710920235615;4132.690048246393;4137.379393091061;4783.378160839138;4821.614270858323;4826.962203126344;4829.73436460991;4834.371531700926;5652.349979752299;5657.57568182388;5658.74535645897;5673.205751194836;5674.319081710139;4810.5670489656095;4810.95189048105;4815.4590531030435;4815.783289751969;4831.0820944021225;5073.797048118034;5079.238114282887;5080.085584594734;5087.491250874957;5126.179811230185;5291.947080529222;5305.787768489217;5310.336207974004;5312.893742125136;5313.388960269618;5545.112781954868;5609.186667933045;5620.185073164286;5620.915686264628;5701.743421545957;5290.894182116259;5309.442508536703;5310.309659744208;5310.362756469249;5368.973155134199;5592.245046918614;5595.664260144405;5599.916001260066;5600.299962504687;5602.971985140048;5536.695481748542;5594.0769772987005;5674.404187560412;5682.460166284196;5730.140478928194;5345.1982202669915;5452.0731475648445;5452.454754524516;5453.918191227214;5460;5464.562834973113;5500.972495137658;5544.251526043932;5545.667259964253;5553.222548843084;5387.272718182995;5426.728663566885;5468.043092458884;5473.534749546333;5483.561315094863;5571.637843540157;5575.832725018256;5611.74747136388;5619.353774316006;5655.2648155741135;5239.554637855673;5319.4414586467865;5382.219578161223;5421.756020978986;5453.890922181455 04:50:03 INFO - PID 24780 | |1;ext.html;584.8830233953211;647.3526473526473;661.9238787539433;1195.2828303018184;1205.7166565857017;35640.46539301909;36357.27285454289;36359.27281454369;36378.818105909464;36409.45385819208;33807.66192338076;34109.82945085271;34125.14687132823;34134.14664633385;34291.31417371651;7021.684024218923;7358.5584864908005;7572.053493313336;7588.810279743023;7606.04924384452;7522.360599349035;7601.163871974079;7606.201348858373;7620.161782203953;7628.237176282383;7551.697932082738;7628.961855190716;7630.50401723889;7660.1573826879;7679.6160191990175;7587.620618969057;7620.733274335372;7621.6570254338685;7622.961885190594;7627.7330293439745;7452.06849143857;7555.924440755632;7588;7590.406014736912;7599.772006839748;33981.83009084963;34066;34074.65925340739;34218.14454638629;34348.82825585881;2420.185119790712;2448.424620214248;2465.1125594785863;2514.924552263435;2520.092766604021;24334.269971900696;24515.877420612782;24723.62914556283;24871.378215544577;24924.37689057788;2583.1604728463135;2591.7667409933006;2592.1705054382605;2593.9870300648377;2613.516499447608;159643;161998;162042;162901;163845;40231;40323.71745205013;40411.59588404137;40576.391354129715;40584.39123413151;41696.583034169875;41845.37231941523;41892.79053604773;41897.581024189974;41989.950251243965;12897.871021289855;13120.540781072617;13146.4084116215;13263.469461221443;13270.402831872589;10452.425116618508;10552.366857988545;10564.366138031743;10577.682669519927;10589.894101058891;13171.802422963663;13221.735565288833;13251.403686834115;13259.138156019828;13433;5477.3427188737605;5480.945190548123;5500.312460942382;5570.916436253459;5642.774289028475;840.3613253927059;851.0850835352021;874.5933141089424;879.6923567386672;885.6767279942775;21580;22149.446263843533;22520.324390268317;22563.548729025326;22628;961.3318743473219;962.7593101724569;964.8263312603658;986.8125056239435;993.6273897288517;11295.830562541569;11300.321980681185;11400.201985861077;11464.59873904426;11523.76952460946;238050;241667;241975;243092;243769;43500.78249608795;43650.7817460917;43704.56295437005;43733.34399984003;43770.34344484835;1199.5654179875391;1225.914186006971;1231.1874163052341;1231.6366671831652;1241.5158088345552;23917.16289929844;25156;25357.74642253554;25601.359966001;25734.742652573233;30383.39233215279;30665.846670766503;30710.232244194074;30770.230744231572;30821;218924;219870;220295;220854;220926;29861.55207671843;30243.395132096794;30260.54609180908;30644.08067757971;31202.375952481278;39693.60306396899;39860;40602.187956240115;40612;40662.39006414965;29576.852115740145;30053.849730751208;30386;30500.389992199587;31601.841990790817;30252.24369390783;30402.54396184103;30603.846980765844;31298.843505783236;31698.841505792323;33358.66641333556;33809;33849.49225761665;34098.31803363968;34129.829350853084;29777.2999233436;29788.55317170201;30161;30203.244918876324;30267.69732302649;22539.88730056339;24139.275821725376;24145.879270603535;24341.634875477237;24570 04:50:03 INFO - PID 24780 | |2;jquery.html;409.3736583027968;416.40869964650193;416.76452804165655;431.73232595790614;434.29860774848623;17281.481555553353;18162;18873.528161795963;18889.338873139444;18922.52693682657;16421.589460263498;16809.83190168098;16887;17015.91492042541;17110.230039648213;5750.3962083981205;5766.538676905838;5840.153177789218;5888.793892213774;5915.231019967419;5692.288463942007;5781.046127388976;5789.015867302548;5789.710514474259;5793.971030144864;5620.91568626471;5755.971220143914;5814.912776308359;5817.447342502455;5845.532357411418;5697.829065128053;5705.5435565154685;5737.053386191274;5755.4244575542525;5756.856078598048;4934.555889969884;5100.285959965608;5127.256547800548;5144;5148.485151484859;22723.204687835845;22866.428339291484;23103.53792924149;23245.30264092063;23362.299131026095;1545.1115608525142;1563.3590228006462;1568.2315665324022;1587.1350114187796;1594.1789978161257;13455.330441843416;14431.49489767853;14513.782293265609;14593.562193134223;14693.412263509446;1709.6666150100734;1710.9392176850308;1711.4951089428648;1736.2360561352964;1772.5834428909195;85729;87333.56333218356;87822;88721;92942.07057929401;10974.506147223234;11093.611723589636;11260.662180134608;11438.771224575461;11523.078153747847;15650.765238521431;15659.530214093595;15661.295241713922;15698.76451853223;15716.21418929049;7373.262673732691;7550.6602202901;7588.734394296283;7764.340031097307;7791.805204869924;6929.41100006495;7000.964995174992;7177.354038136593;7178.712851485987;7200;6974.895376569356;7018.964905175441;7129.857402851914;7138.464615153885;7161.57030578167;1950.8927009014355;1953.8339241164376;1980.5741765520481;1999.2802591067205;2045.509077821312;816.7141500474786;840.9369297302727;845.556083056388;865.6580650642961;865.9565223905179;15810.841891580936;16439.178041098137;16700.164991750364;16837.242324095445;16987;852.3436953545859;857.4255248983196;874.8906386701663;877.0659247900965;879.5338470610586;8988.191062804379;9025.104728007062;9277.814443711088;9366.203872670763;9503.762405939908;434972;436821.6860482508;441102;451442;453445;86201;87368.5631571838;90165.9425325862;90597.54701226452;93410.53294733482;1022.9130523905402;1024.8565200871883;1047.1518070363031;1051.6056478820442;1059.0944742245424;13959.651008724457;13968.720625587635;14031.087979281314;14181.432742690176;14843.183624900303;42460.36309455299;43530.56469435265;43639.345409819514;44055.559444405146;44942.325865111394;54037;54782.45217547774;55247.44752552584;55590.44409555852;56082.439175607724;8265.504069755834;8269.669213231404;8345.29065029455;8467;8728.869066964127;13158;13573.1856088635;13647.86352136466;13759;13765.38055787512;10755.623553175601;10823.350598964087;10827.458627068772;11074.343041102109;11262.324260544066;11253.15601329887;11340.489677964346;11448.198626096426;11454.94272528632;11599.188056835941;11743.823842642538;11802.645920622395;12016.879831201577;12220.816687749868;12359.876401235873;8007.91992080095;8029.437939344423;8054.436189466681;8191.83616327682;8596.226339629464;11484.770304594029;11540.307581545134;11570.19008669385;11678.474468648761;11989.940050300042 04:50:03 INFO - PID 24780 | |3;mootools.html;1253.9811902821457;1317.150437967511;1326.5556038727032;1332.533613235367;1339.6115126613279;9290.67482638107;9674.467904265262;9776.560054797543;9803.460809655466;9935.403875767459;9773.364731292479;9893.40639561625;9905.851412228805;9945.15466185375;9957.601695932171;2202.559488102378;2215.235743668432;2238.149503188794;2238.854474459155;2239.540894116702;2097.800708932649;2115.682647602864;2128.8084072433476;2135.5835612055657;2145.0025738031813;2130.371540395587;2149.7420309562876;2188.223180770827;2203.8787866667326;2207.150247154849;2109.546447513784;2120.0883620043373;2121.893905304736;2124.437024188599;2124.8300135989084;2073.1085633177727;2094.863833850795;2125.033109934976;2130.3076500137518;2183.3340831046526;9814.705558833246;9904.653337133166;9918.057784510533;9948.651797187063;9953.25350598708;5360.65155764874;5536.833894983117;5560.110382338847;5576.86057848553;5591.944080559183;3292.7859689120132;3347.196672798535;3354.04409743222;3473.635268296843;3537.080359106625;1029.526417847791;1043.2332235806675;1083.9458027098692;1085.9945700271448;1107.6953837694618;13719.039667223298;13720.176789392668;13784.241866697228;13805.17168969865;13809.861901380958;4451.821927122944;4672.74299913508;4776.9761151194025;4797.544233297831;4827.565519103227;10800.94599527013;10838.620648277272;10856.728581785519;10877.67366978992;10891.782164356668;5384.246205531151;5415.025295446779;5423.810166644149;5425.240466334637;5438.945610543923;4750.239961606127;4987.725675087832;4995.100881841231;5012.724300163526;5029.572486338702;3741.5136032315627;3817.1983883384246;3875.992242017096;3929.4695216145456;3945.861894833667;1154.3535620052796;1163.2206421697483;1166.1720178673067;1176.082655528689;1190.9821352679717;659.7921654678761;693.8230751158422;695.5478938689791;698.3749544157951;707.1090426063197;5615.747291371817;5626.97186514073;5760.855978600484;5852.268466441695;6075.817725468243;792.4809249941297;805.2229598437419;811.5414790643267;842.3471809347805;849.2229609906866;3453.723702103826;3690.8892733218045;3734.8319325630414;3832.0994566276904;3856.9614303857165;11566.768664626828;12100.757984840255;12299.200551964093;12481.625551233477;12591.811122833165;12194.81707774384;12303.384830758427;12451.501939922302;12457.626271211879;12466.065045121652;8937.955310223537;9086.45481271126;9094.86357704635;9101.226395756303;9179.082091790768;5770.769169233184;5963.314218864886;5986.9401305986385;6020.668863212565;6125.84685382869;11032.889671103507;11288.49201785938;11317.71705707364;11511.884881151416;11523.250988685708;11453.942730286295;11619.0704743622;11724.941375293069;11821.881781182423;11837.82243266369;7952.522848629101;7962.840743184988;8058.476199047043;8063.637136328996;8071.556064416279;8800.119988001148;8901.821963560822;8942.195202431813;8992.685256016008;9242.399244049384;7377.299156580117;7412.444066694911;7515.398768098648;7550.697972081055;7621.047369078865;7274.345308922222;7307.525010874276;7363.116426028697;7475.925240747523;7582.279683430065;6719.832004199739;6752.763653272112;6782.152230971129;6804.55770374924;6849.931500684929;5036.6726162799305;5046.268291097844;5076.441591424867;5262.079136151082;5279.076161671615;5049.166887463527;5113.8721531962;5159.742012899415;5181;5221 04:50:03 INFO - PID 24780 | |4;prototype.html;386.3374313053115;389.53061560819214;393.27048325356463;394.9269385163744;397.0668928019155;5468.589855760814;5496.203050557667;5519.571388589023;5545.3345598528185;5624.240727501786;5348.652337598053;5388;5436.21174929635;5465.945340546593;5484.670919744818;4069.2065047315787;4210.789460526977;4224.598663126998;4246.108317253365;4265.424167737362;4234.576542345756;4239;4242.6605871530355;4245.766482843443;4254.31930891056;4169.937450938239;4206.600372964579;4219.578042195772;4223.1975924574235;4230.51349094855;4115.753054816721;4215.894602634943;4217.36739489076;4222.366645003243;4228.76741779202;3624.655657712513;3627.292677927805;3634.345817752803;3649.981750091259;3671.889843304705;5315.920261196085;5322.893542129135;5324.627276090675;5326.840194794162;5336.91994620081;4701.717896926195;4778.450478195017;4793.233082706785;4819.397575303087;4830.782614782308;5725.198472213893;5769.682667453289;5773.960687076325;5794.246747922785;5796.333421656522;4003.959960400417;4011.3180759270704;4014.2573623879675;4015.4980627421573;4027.0939038716347;5553.805616803393;5960.552958528085;6127;6188.412100850412;6196.2874269459135;4122.91754164915;4125.824140120051;4130.690198235145;4145.91708165841;4159.313713237342;4219.409282700424;4219.746815191098;4231.534531201565;4234.894127646833;4236.9364459533135;4844.442889067732;4847.200211965057;4864.173090574611;4868.537488938545;4875.68308059975;5558.944410555923;5755.1367294906095;5774.769009239583;5793.478586927196;5817.534597232211;1446.7034257977089;1469.9632509187143;1471.3820195517908;1471.852814718541;1472.9852701473062;909.6043221198668;953.9173038601238;969.1084202533686;973.3089506450358;976.8876579193342;5036.521530454675;5042.193249080203;5052.797888084436;5071.644984851099;5074.416442109205;6014.458698717136;6020.729067191987;6021.608595441282;6024.819255422344;6044.7582096716515;4893.510648935078;4995.650304478724;5028.823991160292;5049.394072711299;5062.240663900371;3136.40408322418;3159.794613350125;3170.556122142902;3189.6012998375204;3191.5531825544444;5549.139883318092;5552.7778888844805;5564.721763911788;5568.6101972862325;5573.359063707644;5920.496757775637;5999.790007349722;6018.21763170785;6102.908456373158;6203.534734894811;5609.326880774252;5618.775248989995;5619.185218143346;5631.155326701028;5637.746301416446;6008.849778755566;6013.331867560872;6045.425684559959;6058.969705151446;6059.969700151471;5767.279090113736;5871;5968.253968253968;5973.970130149321;5991.310999234969;5633.746481408264;5641.915371269352;5642.633228840113;5646.096624540054;5653.971730141323;3954.466147070224;4147.440095587178;4180.348762238959;4191.916161676811;4192.161567686414;5985.760569577168;6007.189029481139;6019.699015049143;6043;6050.818475445743;5814.73833677494;5827.94172058274;5830.280067380218;5841.532677385884;5856.853578660568;5668.858278543069;5792.478676919098;5812.680302583399;5816.621919575214;5829.271341082364;5731.5128214100605;5735.8852822944145;5736.942630573641;5748.166515855261;5758.0499217630295;5721.57088218377;5880.882382352414;5890.674598215367;5894.793682221101;5924.407559244041;5694.861027794374;5731.828045158652;5735.684537350486;5744.626599271034;5747.798827041033 04:50:03 INFO - PID 24780 | |5;yui.html;588.7438964050635;590.7371219807185;602.9849253768655;606.369375849117;621.6177051113565;12201.450934707947;12486.937565312172;12672.303023333712;14993.85006149938;15901.443449479271;14371.496997605085;14371.856281437182;14679.19264440458;14765.261736913166;15829.525114246591;828.7845160258316;837.3301358912876;837.4598384042289;838.1116017021945;838.9848283576879;893.1515060692336;924.5469719837298;925.2135684668045;931.4039015030386;933.593886659302;970.5875003123645;975.5317447625109;975.7219192530131;976.0288512929645;977.296346630425;950.0879156010169;953.046953046953;955.8375076237022;955.8422860228054;956.2159029595734;709.0604948443333;709.3970125393425;711.1111111111111;712.3446429285018;714.2036629158503;13361.13152645075;13427.932860335733;13429.798553021712;13581.932090339584;14529.927350363181;13207.471701131943;13399.665008374772;13491.580846800327;13519.256440895746;13607.795883061763;8608.354373421957;8874.201321881063;8905.154010369004;9011.594478248495;9102.499362535058;2382.5354055959097;2410.927672169838;2416.5770990076667;2422.63660450932;2427.5023620157826;61905.38094619086;63340;63548.364516354704;63685.999999999534;63986.36013639851;9103.590338434786;9490.810183796424;9503;9549.09283618055;9661.855072173923;20596.27913023037;21058.368248952556;21629.891850540647;21830.563388732135;21863.453413664785;5659;5905.852353691193;6420.422162005442;6496.577722448026;6524.739010439529;2995.1613548206537;3041.285297954979;3096.845157742149;3109.6423911250495;3129.8748050078198;3557.804400129019;3628.1111127773866;3680.300742858848;3682.1715114099115;3690.723195760275;638.1162090504685;673.245964519741;692.4706220826695;692.757534862804;706.5766361976217;458.6858002268457;472.6667699272005;484.1189035954529;488.1579275749304;492.21000294526766;6988.580685158907;7238.855222895512;7509.699612015458;7601.695932162762;8032.839343213103;439.9978000109979;456.98629041128817;466.6756604160076;496.41918954822944;512.6616433154101;3264.3308121834966;3428.8457019434186;3462.532558104674;3492.0746002309406;3542.167590616203;61823.76352472926;62827;63883;64295;65573;54384;54656;54838.72580637151;56390.71804640951;57194;48027.519724803;48403;48667.75666121717;49538.75230623824;50521.242181367306;6799.558028728117;6981.616011119234;7034.683439245348;7072.115985501812;7085.858282834418;23941.52116957616;24192.758072419052;24715.87642061778;25510;26115.216543503724;42670.78664606657;42711.57288427076;43384.783076084415;43825.34261986137;44814.77592612016;11085.667429977113;11155.10759139283;11384.37385943781;11388.94305528467;11741.471633776671;11772.941135294268;11786.941065294619;11856.170068095496;11980.76038479243;12176.817347739614;10211.642592509226;10287.485625718833;10415.895841041493;10491.737706557093;10500.47497625131;10666.306690065121;10726.141908647445;10794.244402891722;10815.242932994615;11164.274322169033;10036.146927510952;10056.245781566266;10354.5340459678;10397.428141452292;10409.42748148859;7904.359636423227;7984.800379990546;8016.8797468036855;8178.764713503899;8286.668533258602;8997.910020899708;9054.54727263621;9116.772080698036;9160.58777355034;9183.448993060438 04:50:03 INFO - PID 24780 | __end_tp_report 04:50:03 INFO - PID 24780 | __start_cc_report 04:50:03 INFO - PID 24780 | _x_x_mozilla_cycle_collect,380 04:50:03 INFO - PID 24780 | __end_cc_report 04:50:03 INFO - PID 24780 | __startTimestamp1490961003606__endTimestamp 04:50:03 INFO - PID 24780 | 04:50:03 INFO - PID 24780 | ------- Summary: start ------- 04:50:03 INFO - PID 24780 | Number of tests: 6 04:50:03 INFO - PID 24780 | 04:50:03 INFO - PID 24780 | [#0] dojo.html Cycles:165 Average:5188.73 Median:5319.44 stddev:577.80 (10.9%) stddev-sans-first:544.87 04:50:03 INFO - PID 24780 | Values: 2674.6 2707.8 2729.6 2755.7 2757.3 5142.6 5257.1 5282.3 5283.2 5315.6 5214.0 5236.7 5255.4 5345.1 5360.1 4797.7 4800.0 4832.0 4838.5 4853.8 4834.5 4857.7 4936.5 4939.4 4963.6 4724.2 4735.4 4769.1 4835.2 4866.4 4793.5 4833.2 4833.3 4850.0 4884.2 4700.9 4762.4 4767.5 4801.6 4807.2 5062.5 5125.2 5216.0 5260.5 5299.3 5512.9 5557.6 5578.7 5581.3 5611.6 5667.6 5673.3 5686.6 5730.2 5763.2 5270.8 5294.1 5303.4 5310.1 5349.6 5634.2 5643.9 5727.7 5741.9 5849.7 5395.5 5450.8 5471.8 5529.2 5538.1 5570.8 5639.4 5641.4 5656.5 5669.9 5391.0 5527.7 5597.1 5598.5 5627.9 5553.9 5559.4 5559.9 5582.4 5588.3 4734.3 4738.7 4751.8 4754.1 4754.9 4110.3 4125.1 4129.7 4132.7 4137.4 4783.4 4821.6 4827.0 4829.7 4834.4 5652.3 5657.6 5658.7 5673.2 5674.3 4810.6 4811.0 4815.5 4815.8 4831.1 5073.8 5079.2 5080.1 5087.5 5126.2 5291.9 5305.8 5310.3 5312.9 5313.4 5545.1 5609.2 5620.2 5620.9 5701.7 5290.9 5309.4 5310.3 5310.4 5369.0 5592.2 5595.7 5599.9 5600.3 5603.0 5536.7 5594.1 5674.4 5682.5 5730.1 5345.2 5452.1 5452.5 5453.9 5460.0 5464.6 5501.0 5544.3 5545.7 5553.2 5387.3 5426.7 5468.0 5473.5 5483.6 5571.6 5575.8 5611.7 5619.4 5655.3 5239.6 5319.4 5382.2 5421.8 5453.9 04:50:03 INFO - PID 24780 | 04:50:03 INFO - PID 24780 | [#1] ext.html Cycles:180 Average:35492.39 Median:30740.23 stddev:54776.71 (178.2%) stddev-sans-first:54867.66 04:50:03 INFO - PID 24780 | Values: 584.9 647.4 661.9 1195.3 1205.7 35640.5 36357.3 36359.3 36378.8 36409.5 33807.7 34109.8 34125.1 34134.1 34291.3 7021.7 7358.6 7572.1 7588.8 7606.0 7522.4 7601.2 7606.2 7620.2 7628.2 7551.7 7629.0 7630.5 7660.2 7679.6 7587.6 7620.7 7621.7 7623.0 7627.7 7452.1 7555.9 7588.0 7590.4 7599.8 33981.8 34066.0 34074.7 34218.1 34348.8 2420.2 2448.4 2465.1 2514.9 2520.1 24334.3 24515.9 24723.6 24871.4 24924.4 2583.2 2591.8 2592.2 2594.0 2613.5 159643.0 161998.0 162042.0 162901.0 163845.0 40231.0 40323.7 40411.6 40576.4 40584.4 41696.6 41845.4 41892.8 41897.6 41990.0 12897.9 13120.5 13146.4 13263.5 13270.4 10452.4 10552.4 10564.4 10577.7 10589.9 13171.8 13221.7 13251.4 13259.1 13433.0 5477.3 5480.9 5500.3 5570.9 5642.8 840.4 851.1 874.6 879.7 885.7 21580.0 22149.4 22520.3 22563.5 22628.0 961.3 962.8 964.8 986.8 993.6 11295.8 11300.3 11400.2 11464.6 11523.8 238050.0 241667.0 241975.0 243092.0 243769.0 43500.8 43650.8 43704.6 43733.3 43770.3 1199.6 1225.9 1231.2 1231.6 1241.5 23917.2 25156.0 25357.7 25601.4 25734.7 30383.4 30665.8 30710.2 30770.2 30821.0 218924.0 219870.0 220295.0 220854.0 220926.0 29861.6 30243.4 30260.5 30644.1 31202.4 39693.6 39860.0 40602.2 40612.0 40662.4 29576.9 30053.8 30386.0 30500.4 31601.8 30252.2 30402.5 30603.8 31298.8 31698.8 33358.7 33809.0 33849.5 34098.3 34129.8 29777.3 29788.6 30161.0 30203.2 30267.7 22539.9 24139.3 24145.9 24341.6 24570.0 04:50:03 INFO - PID 24780 | 04:50:03 INFO - PID 24780 | [#2] jquery.html Cycles:180 Average:27632.08 Median:217703.15 stddev:73539.84 (33.8%) stddev-sans-first:73717.73 04:50:03 INFO - PID 24780 | Values: 409.4 416.4 416.8 431.7 434.3 17281.5 18162.0 18873.5 18889.3 18922.5 16421.6 16809.8 16887.0 17015.9 17110.2 5750.4 5766.5 5840.2 5888.8 5915.2 5692.3 5781.0 5789.0 5789.7 5794.0 5620.9 5756.0 5814.9 5817.4 5845.5 5697.8 5705.5 5737.1 5755.4 5756.9 4934.6 5100.3 5127.3 5144.0 5148.5 22723.2 22866.4 23103.5 23245.3 23362.3 1545.1 1563.4 1568.2 1587.1 1594.2 13455.3 14431.5 14513.8 14593.6 14693.4 1709.7 1710.9 1711.5 1736.2 1772.6 85729.0 87333.6 87822.0 88721.0 92942.1 10974.5 11093.6 11260.7 11438.8 11523.1 15650.8 15659.5 15661.3 15698.8 15716.2 7373.3 7550.7 7588.7 7764.3 7791.8 6929.4 7001.0 7177.4 7178.7 7200.0 6974.9 7019.0 7129.9 7138.5 7161.6 1950.9 1953.8 1980.6 1999.3 2045.5 816.7 840.9 845.6 865.7 866.0 15810.8 16439.2 16700.2 16837.2 16987.0 852.3 857.4 874.9 877.1 879.5 8988.2 9025.1 9277.8 9366.2 9503.8 434972.0 436821.7 441102.0 451442.0 453445.0 86201.0 87368.6 90165.9 90597.5 93410.5 1022.9 1024.9 1047.2 1051.6 1059.1 13959.7 13968.7 14031.1 14181.4 14843.2 42460.4 43530.6 43639.3 44055.6 44942.3 54037.0 54782.5 55247.4 55590.4 56082.4 8265.5 8269.7 8345.3 8467.0 8728.9 13158.0 13573.2 13647.9 13759.0 13765.4 10755.6 10823.4 10827.5 11074.3 11262.3 11253.2 11340.5 11448.2 11454.9 11599.2 11743.8 11802.6 12016.9 12220.8 12359.9 8007.9 8029.4 8054.4 8191.8 8596.2 11484.8 11540.3 11570.2 11678.5 11989.9 04:50:03 INFO - PID 24780 | 04:50:03 INFO - PID 24780 | [#3] mootools.html Cycles:180 Average:6081.76 Median:4907.65 stddev:3794.47 (77.3%) stddev-sans-first:3787.77 04:50:03 INFO - PID 24780 | Values: 1254.0 1317.2 1326.6 1332.5 1339.6 9290.7 9674.5 9776.6 9803.5 9935.4 9773.4 9893.4 9905.9 9945.2 9957.6 2202.6 2215.2 2238.1 2238.9 2239.5 2097.8 2115.7 2128.8 2135.6 2145.0 2130.4 2149.7 2188.2 2203.9 2207.2 2109.5 2120.1 2121.9 2124.4 2124.8 2073.1 2094.9 2125.0 2130.3 2183.3 9814.7 9904.7 9918.1 9948.7 9953.3 5360.7 5536.8 5560.1 5576.9 5591.9 3292.8 3347.2 3354.0 3473.6 3537.1 1029.5 1043.2 1083.9 1086.0 1107.7 13719.0 13720.2 13784.2 13805.2 13809.9 4451.8 4672.7 4777.0 4797.5 4827.6 10800.9 10838.6 10856.7 10877.7 10891.8 5384.2 5415.0 5423.8 5425.2 5438.9 4750.2 4987.7 4995.1 5012.7 5029.6 3741.5 3817.2 3876.0 3929.5 3945.9 1154.4 1163.2 1166.2 1176.1 1191.0 659.8 693.8 695.5 698.4 707.1 5615.7 5627.0 5760.9 5852.3 6075.8 792.5 805.2 811.5 842.3 849.2 3453.7 3690.9 3734.8 3832.1 3857.0 11566.8 12100.8 12299.2 12481.6 12591.8 12194.8 12303.4 12451.5 12457.6 12466.1 8938.0 9086.5 9094.9 9101.2 9179.1 5770.8 5963.3 5986.9 6020.7 6125.8 11032.9 11288.5 11317.7 11511.9 11523.3 11453.9 11619.1 11724.9 11821.9 11837.8 7952.5 7962.8 8058.5 8063.6 8071.6 8800.1 8901.8 8942.2 8992.7 9242.4 7377.3 7412.4 7515.4 7550.7 7621.0 7274.3 7307.5 7363.1 7475.9 7582.3 6719.8 6752.8 6782.2 6804.6 6849.9 5036.7 5046.3 5076.4 5262.1 5279.1 5049.2 5113.9 5159.7 5181.0 5221.0 04:50:03 INFO - PID 24780 | 04:50:03 INFO - PID 24780 | [#4] prototype.html Cycles:180 Average:4786.94 Median:5490.44 stddev:1412.64 (25.7%) stddev-sans-first:1377.44 04:50:03 INFO - PID 24780 | Values: 386.3 389.5 393.3 394.9 397.1 5468.6 5496.2 5519.6 5545.3 5624.2 5348.7 5388.0 5436.2 5465.9 5484.7 4069.2 4210.8 4224.6 4246.1 4265.4 4234.6 4239.0 4242.7 4245.8 4254.3 4169.9 4206.6 4219.6 4223.2 4230.5 4115.8 4215.9 4217.4 4222.4 4228.8 3624.7 3627.3 3634.3 3650.0 3671.9 5315.9 5322.9 5324.6 5326.8 5336.9 4701.7 4778.5 4793.2 4819.4 4830.8 5725.2 5769.7 5774.0 5794.2 5796.3 4004.0 4011.3 4014.3 4015.5 4027.1 5553.8 5960.6 6127.0 6188.4 6196.3 4122.9 4125.8 4130.7 4145.9 4159.3 4219.4 4219.7 4231.5 4234.9 4236.9 4844.4 4847.2 4864.2 4868.5 4875.7 5558.9 5755.1 5774.8 5793.5 5817.5 1446.7 1470.0 1471.4 1471.9 1473.0 909.6 953.9 969.1 973.3 976.9 5036.5 5042.2 5052.8 5071.6 5074.4 6014.5 6020.7 6021.6 6024.8 6044.8 4893.5 4995.7 5028.8 5049.4 5062.2 3136.4 3159.8 3170.6 3189.6 3191.6 5549.1 5552.8 5564.7 5568.6 5573.4 5920.5 5999.8 6018.2 6102.9 6203.5 5609.3 5618.8 5619.2 5631.2 5637.7 6008.8 6013.3 6045.4 6059.0 6060.0 5767.3 5871.0 5968.3 5974.0 5991.3 5633.7 5641.9 5642.6 5646.1 5654.0 3954.5 4147.4 4180.3 4191.9 4192.2 5985.8 6007.2 6019.7 6043.0 6050.8 5814.7 5827.9 5830.3 5841.5 5856.9 5668.9 5792.5 5812.7 5816.6 5829.3 5731.5 5735.9 5736.9 5748.2 5758.0 5721.6 5880.9 5890.7 5894.8 5924.4 5694.9 5731.8 5735.7 5744.6 5747.8 04:50:03 INFO - PID 24780 | 04:50:03 INFO - PID 24780 | [#5] yui.html Cycles:180 Average:14082.88 Median:25015.48 stddev:17736.28 (70.9%) stddev-sans-first:17757.09 04:50:03 INFO - PID 24780 | Values: 588.7 590.7 603.0 606.4 621.6 12201.5 12486.9 12672.3 14993.9 15901.4 14371.5 14371.9 14679.2 14765.3 15829.5 828.8 837.3 837.5 838.1 839.0 893.2 924.5 925.2 931.4 933.6 970.6 975.5 975.7 976.0 977.3 950.1 953.0 955.8 955.8 956.2 709.1 709.4 711.1 712.3 714.2 13361.1 13427.9 13429.8 13581.9 14529.9 13207.5 13399.7 13491.6 13519.3 13607.8 8608.4 8874.2 8905.2 9011.6 9102.5 2382.5 2410.9 2416.6 2422.6 2427.5 61905.4 63340.0 63548.4 63686.0 63986.4 9103.6 9490.8 9503.0 9549.1 9661.9 20596.3 21058.4 21629.9 21830.6 21863.5 5659.0 5905.9 6420.4 6496.6 6524.7 2995.2 3041.3 3096.8 3109.6 3129.9 3557.8 3628.1 3680.3 3682.2 3690.7 638.1 673.2 692.5 692.8 706.6 458.7 472.7 484.1 488.2 492.2 6988.6 7238.9 7509.7 7601.7 8032.8 440.0 457.0 466.7 496.4 512.7 3264.3 3428.8 3462.5 3492.1 3542.2 61823.8 62827.0 63883.0 64295.0 65573.0 54384.0 54656.0 54838.7 56390.7 57194.0 48027.5 48403.0 48667.8 49538.8 50521.2 6799.6 6981.6 7034.7 7072.1 7085.9 23941.5 24192.8 24715.9 25510.0 26115.2 42670.8 42711.6 43384.8 43825.3 44814.8 11085.7 11155.1 11384.4 11388.9 11741.5 11772.9 11786.9 11856.2 11980.8 12176.8 10211.6 10287.5 10415.9 10491.7 10500.5 10666.3 10726.1 10794.2 10815.2 11164.3 10036.1 10056.2 10354.5 10397.4 10409.4 7904.4 7984.8 8016.9 8178.8 8286.7 8997.9 9054.5 9116.8 9160.6 9183.4 04:50:03 INFO - PID 24780 | -------- Summary: end -------- 04:50:03 INFO - PID 24780 | 04:50:04 INFO - TEST-INFO | 24780: exit 0 04:50:04 INFO - TEST-OK | dromaeo_css | took 1121621ms 04:50:04 INFO - TEST-START | kraken 04:50:04 INFO - operating with platform_type : linux_ 04:50:04 INFO - Initialising browser for kraken test... 04:50:04 INFO - TEST-INFO | started process 25155 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4hMsg3/profile http://localhost:36735/getInfo.html) 04:50:08 INFO - PID 25155 | __metrics Screen width/height:1600/1200 04:50:08 INFO - PID 25155 | colorDepth:24 04:50:08 INFO - PID 25155 | Browser inner width/height: 1024/697 04:50:08 INFO - PID 25155 | __metrics 04:50:09 ERROR - PID 25155 | 1490961009653 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:6382:36 < canClose@browser.js:5233:12 < forceQuit@jar:file:///tmp/tmp4hMsg3/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmp4hMsg3/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmp4hMsg3/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmp4hMsg3/profile/extensions/talos-powers@TalosPowersService.js:55:9 04:50:09 ERROR - PID 25155 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 04:50:10 INFO - TEST-INFO | 25155: exit 0 04:50:10 INFO - Browser initialized. 04:50:10 INFO - Running cycle 1/1 for kraken test... 04:50:10 INFO - TEST-INFO | started process 25291 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4hMsg3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:22 INFO - PID 25291 | RSS: Main: 155803648 04:50:22 INFO - PID 25291 | 04:50:25 INFO - PID 25291 | Cycle 1(1): loaded http://localhost:36735/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36735/tests/kraken/driver.html?testName=audio-beat-detection) 04:50:26 INFO - PID 25291 | RSS: Main: 162185216 04:50:26 INFO - PID 25291 | 04:50:29 INFO - PID 25291 | Cycle 1(1): loaded http://localhost:36735/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36735/tests/kraken/driver.html?testName=audio-dft) 04:50:29 INFO - PID 25291 | RSS: Main: 161042432 04:50:29 INFO - PID 25291 | 04:50:32 INFO - PID 25291 | Cycle 1(1): loaded http://localhost:36735/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36735/tests/kraken/driver.html?testName=audio-fft) 04:50:33 INFO - PID 25291 | RSS: Main: 157765632 04:50:33 INFO - PID 25291 | 04:50:35 INFO - PID 25291 | Cycle 1(1): loaded http://localhost:36735/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36735/tests/kraken/driver.html?testName=audio-oscillator) 04:50:36 INFO - PID 25291 | RSS: Main: 158674944 04:50:36 INFO - PID 25291 | 04:50:38 INFO - PID 25291 | Cycle 1(1): loaded http://localhost:36735/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36735/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:50:39 INFO - PID 25291 | RSS: Main: 159080448 04:50:39 INFO - PID 25291 | 04:50:42 INFO - PID 25291 | Cycle 1(1): loaded http://localhost:36735/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36735/tests/kraken/driver.html?testName=imaging-darkroom) 04:50:42 INFO - PID 25291 | RSS: Main: 163819520 04:50:42 INFO - PID 25291 | 04:50:46 INFO - PID 25291 | Cycle 1(1): loaded http://localhost:36735/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36735/tests/kraken/driver.html?testName=imaging-desaturate) 04:50:47 INFO - PID 25291 | RSS: Main: 161853440 04:50:47 INFO - PID 25291 | 04:50:50 INFO - PID 25291 | Cycle 1(1): loaded http://localhost:36735/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36735/tests/kraken/driver.html?testName=json-parse-financial) 04:50:50 INFO - PID 25291 | RSS: Main: 162775040 04:50:50 INFO - PID 25291 | 04:50:52 INFO - PID 25291 | Cycle 1(1): loaded http://localhost:36735/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36735/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:50:53 INFO - PID 25291 | RSS: Main: 163516416 04:50:53 INFO - PID 25291 | 04:50:55 INFO - PID 25291 | Cycle 1(1): loaded http://localhost:36735/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36735/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:50:55 INFO - PID 25291 | RSS: Main: 163315712 04:50:55 INFO - PID 25291 | 04:50:57 INFO - PID 25291 | Cycle 1(1): loaded http://localhost:36735/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36735/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:50:58 INFO - PID 25291 | RSS: Main: 164278272 04:50:58 INFO - PID 25291 | 04:51:01 INFO - PID 25291 | Cycle 1(1): loaded http://localhost:36735/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36735/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:51:02 INFO - PID 25291 | RSS: Main: 164179968 04:51:02 INFO - PID 25291 | 04:51:05 INFO - PID 25291 | Cycle 1(1): loaded http://localhost:36735/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36735/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:51:06 INFO - PID 25291 | RSS: Main: 163856384 04:51:06 INFO - PID 25291 | 04:51:07 INFO - PID 25291 | Cycle 1(1): loaded http://localhost:36735/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36735/tests/kraken/driver.html?testName=ai-astar) 04:51:08 INFO - PID 25291 | RSS: Main: 165306368 04:51:08 INFO - PID 25291 | 04:51:08 INFO - PID 25291 | __start_tp_report 04:51:08 INFO - PID 25291 | _x_x_mozilla_page_load 04:51:08 INFO - PID 25291 | _x_x_mozilla_page_load_details 04:51:08 INFO - PID 25291 | |i|pagename|runs| 04:51:08 INFO - PID 25291 | |0;ai-astar;105;114;113;113;114;113;113;114;112;112 04:51:08 INFO - PID 25291 | |1;audio-beat-detection;152;127;125;182;127;127;130;124;146;134 04:51:08 INFO - PID 25291 | |2;audio-dft;167;166;167;172;166;178;166;166;180;166 04:51:08 INFO - PID 25291 | |3;audio-fft;78;75;84;122;75;79;76;75;93;75 04:51:08 INFO - PID 25291 | |4;audio-oscillator;85;85;116;84;84;84;100;86;86;110 04:51:08 INFO - PID 25291 | |5;imaging-gaussian-blur;115;115;114;115;116;119;115;115;116;115 04:51:08 INFO - PID 25291 | |6;imaging-darkroom;151;151;152;153;150;152;152;151;153;151 04:51:08 INFO - PID 25291 | |7;imaging-desaturate;95;95;95;95;96;96;96;95;95;96 04:51:08 INFO - PID 25291 | |8;json-parse-financial;68;68;67;69;68;69;68;69;69;69 04:51:08 INFO - PID 25291 | |9;json-stringify-tinderbox;55;56;56;56;56;56;59;56;56;56 04:51:08 INFO - PID 25291 | |10;stanford-crypto-aes;94;85;84;83;86;83;87;85;85;84 04:51:08 INFO - PID 25291 | |11;stanford-crypto-ccm;139;134;136;156;137;144;148;145;185;137 04:51:08 INFO - PID 25291 | |12;stanford-crypto-pbkdf2;188;199;191;195;198;199;186;196;210;197 04:51:08 INFO - PID 25291 | |13;stanford-crypto-sha256-iterative;74;72;74;72;74;71;72;72;71;77 04:51:08 INFO - PID 25291 | __end_tp_report 04:51:08 INFO - PID 25291 | __start_cc_report 04:51:08 INFO - PID 25291 | _x_x_mozilla_cycle_collect,897 04:51:08 INFO - PID 25291 | __end_cc_report 04:51:08 INFO - PID 25291 | __startTimestamp1490961068195__endTimestamp 04:51:08 INFO - PID 25291 | 04:51:08 INFO - PID 25291 | ------- Summary: start ------- 04:51:08 INFO - PID 25291 | Number of tests: 14 04:51:08 INFO - PID 25291 | 04:51:08 INFO - PID 25291 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:2.67 (2.4%) stddev-sans-first:0.78 04:51:08 INFO - PID 25291 | Values: 105.0 114.0 113.0 113.0 114.0 113.0 113.0 114.0 112.0 112.0 04:51:08 INFO - PID 25291 | 04:51:08 INFO - PID 25291 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:132.00 stddev:18.26 (13.8%) stddev-sans-first:18.59 04:51:08 INFO - PID 25291 | Values: 152.0 127.0 125.0 182.0 127.0 127.0 130.0 124.0 146.0 134.0 04:51:08 INFO - PID 25291 | 04:51:08 INFO - PID 25291 | [#2] audio-dft Cycles:10 Average:169.40 Median:167.00 stddev:5.40 (3.2%) stddev-sans-first:5.66 04:51:08 INFO - PID 25291 | Values: 167.0 166.0 167.0 172.0 166.0 178.0 166.0 166.0 180.0 166.0 04:51:08 INFO - PID 25291 | 04:51:08 INFO - PID 25291 | [#3] audio-fft Cycles:10 Average:83.20 Median:77.00 stddev:14.79 (19.2%) stddev-sans-first:15.56 04:51:08 INFO - PID 25291 | Values: 78.0 75.0 84.0 122.0 75.0 79.0 76.0 75.0 93.0 75.0 04:51:08 INFO - PID 25291 | 04:51:08 INFO - PID 25291 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:84.50 stddev:12.14 (14.4%) stddev-sans-first:12.61 04:51:08 INFO - PID 25291 | Values: 85.0 85.0 116.0 84.0 84.0 84.0 100.0 86.0 86.0 110.0 04:51:08 INFO - PID 25291 | 04:51:08 INFO - PID 25291 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:115.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 04:51:08 INFO - PID 25291 | Values: 115.0 115.0 114.0 115.0 116.0 119.0 115.0 115.0 116.0 115.0 04:51:08 INFO - PID 25291 | 04:51:08 INFO - PID 25291 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:152.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 04:51:08 INFO - PID 25291 | Values: 151.0 151.0 152.0 153.0 150.0 152.0 152.0 151.0 153.0 151.0 04:51:08 INFO - PID 25291 | 04:51:08 INFO - PID 25291 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:51:08 INFO - PID 25291 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 96.0 04:51:08 INFO - PID 25291 | 04:51:08 INFO - PID 25291 | [#8] json-parse-financial Cycles:10 Average:68.40 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 04:51:08 INFO - PID 25291 | Values: 68.0 68.0 67.0 69.0 68.0 69.0 68.0 69.0 69.0 69.0 04:51:08 INFO - PID 25291 | 04:51:08 INFO - PID 25291 | [#9] json-stringify-tinderbox Cycles:10 Average:56.20 Median:56.00 stddev:1.03 (1.8%) stddev-sans-first:1.00 04:51:08 INFO - PID 25291 | Values: 55.0 56.0 56.0 56.0 56.0 56.0 59.0 56.0 56.0 56.0 04:51:08 INFO - PID 25291 | 04:51:08 INFO - PID 25291 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.00 stddev:3.20 (3.8%) stddev-sans-first:1.32 04:51:08 INFO - PID 25291 | Values: 94.0 85.0 84.0 83.0 86.0 83.0 87.0 85.0 85.0 84.0 04:51:08 INFO - PID 25291 | 04:51:08 INFO - PID 25291 | [#11] stanford-crypto-ccm Cycles:10 Average:146.10 Median:144.50 stddev:15.22 (10.5%) stddev-sans-first:15.93 04:51:08 INFO - PID 25291 | Values: 139.0 134.0 136.0 156.0 137.0 144.0 148.0 145.0 185.0 137.0 04:51:08 INFO - PID 25291 | 04:51:08 INFO - PID 25291 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.90 Median:197.50 stddev:6.74 (3.4%) stddev-sans-first:6.51 04:51:08 INFO - PID 25291 | Values: 188.0 199.0 191.0 195.0 198.0 199.0 186.0 196.0 210.0 197.0 04:51:08 INFO - PID 25291 | 04:51:08 INFO - PID 25291 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:73.00 stddev:1.85 (2.5%) stddev-sans-first:1.92 04:51:08 INFO - PID 25291 | Values: 74.0 72.0 74.0 72.0 74.0 71.0 72.0 72.0 71.0 77.0 04:51:08 INFO - PID 25291 | -------- Summary: end -------- 04:51:08 INFO - PID 25291 | 04:51:09 INFO - TEST-INFO | 25291: exit 0 04:51:09 INFO - TEST-OK | kraken | took 64895ms 04:51:09 INFO - SUITE-END | took 1186s 04:51:09 INFO - Completed test suite (00:19:46) 04:51:09 INFO - javascript benchmark 04:51:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6651.0396805065175, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2674.613633640829, 2707.756301932826, 2729.56326987682, 2755.683096443907, 2757.2831063923372, 5142.588592912567, 5257.106291930376, 5282.260483532304, 5283.181106928428, 5315.574754019679, 5214.035403450355, 5236.659617124884, 5255.421903590602, 5345.1447768357075, 5360.088784906566, 4797.712137271767, 4799.952000479985, 4831.975840120795, 4838.467768545474, 4853.757312134397, 4834.468208497063, 4857.684250523723, 4936.456989731127, 4939.43196532398, 4963.602911767068, 4724.244120940633, 4735.431748190239, 4769.093872164278, 4835.178019736618, 4866.4403593586485, 4793.54461326177, 4833.226683730586, 4833.347498087748, 4850.0, 4884.242942343943, 4700.882477938045, 4762.404699412574, 4767.475577686451, 4801.639877009238, 4807.18277892759, 5062.544371006627, 5125.154349532323, 5216.0, 5260.473952604747, 5299.33758280215, 5512.889742205173, 5557.555395568385, 5578.721063946787, 5581.330240371181, 5611.607187496877, 5667.6316039457715, 5673.319201695782, 5686.5735069869515, 5730.19777231188, 5763.193152958589, 5270.8155214567305, 5294.12646913255, 5303.36359636846, 5310.070737620901, 5349.5720342372515, 5634.154876768435, 5643.943560564424, 5727.742251598688, 5741.88516229673, 5849.6782676952325, 5395.541378982752, 5450.754716037788, 5471.835844924659, 5529.198266251371, 5538.086215774432, 5570.832875013756, 5639.43605639441, 5641.407652196543, 5656.490915817596, 5669.914951275734, 5391.0, 5527.723613819293, 5597.132444471114, 5598.4961353477565, 5627.861412663244, 5553.916691249635, 5559.388467268597, 5559.916601250984, 5582.413846546136, 5588.329400471969, 4734.289856521549, 4738.668293219511, 4751.83368582098, 4754.144254034238, 4754.904901902012, 4110.301248787713, 4125.071858831739, 4129.710920235615, 4132.690048246393, 4137.379393091061, 4783.378160839138, 4821.614270858323, 4826.962203126344, 4829.73436460991, 4834.371531700926, 5652.349979752299, 5657.57568182388, 5658.74535645897, 5673.205751194836, 5674.319081710139, 4810.5670489656095, 4810.95189048105, 4815.4590531030435, 4815.783289751969, 4831.0820944021225, 5073.797048118034, 5079.238114282887, 5080.085584594734, 5087.491250874957, 5126.179811230185, 5291.947080529222, 5305.787768489217, 5310.336207974004, 5312.893742125136, 5313.388960269618, 5545.112781954868, 5609.186667933045, 5620.185073164286, 5620.915686264628, 5701.743421545957, 5290.894182116259, 5309.442508536703, 5310.309659744208, 5310.362756469249, 5368.973155134199, 5592.245046918614, 5595.664260144405, 5599.916001260066, 5600.299962504687, 5602.971985140048, 5536.695481748542, 5594.0769772987005, 5674.404187560412, 5682.460166284196, 5730.140478928194, 5345.1982202669915, 5452.0731475648445, 5452.454754524516, 5453.918191227214, 5460.0, 5464.562834973113, 5500.972495137658, 5544.251526043932, 5545.667259964253, 5553.222548843084, 5387.272718182995, 5426.728663566885, 5468.043092458884, 5473.534749546333, 5483.561315094863, 5571.637843540157, 5575.832725018256, 5611.74747136388, 5619.353774316006, 5655.2648155741135, 5239.554637855673, 5319.4414586467865, 5382.219578161223, 5421.756020978986, 5453.890922181455], "value": 5147.905003065222, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.8830233953211, 647.3526473526473, 661.9238787539433, 1195.2828303018184, 1205.7166565857017, 35640.46539301909, 36357.27285454289, 36359.27281454369, 36378.818105909464, 36409.45385819208, 33807.66192338076, 34109.82945085271, 34125.14687132823, 34134.14664633385, 34291.31417371651, 7021.684024218923, 7358.5584864908005, 7572.053493313336, 7588.810279743023, 7606.04924384452, 7522.360599349035, 7601.163871974079, 7606.201348858373, 7620.161782203953, 7628.237176282383, 7551.697932082738, 7628.961855190716, 7630.50401723889, 7660.1573826879, 7679.6160191990175, 7587.620618969057, 7620.733274335372, 7621.6570254338685, 7622.961885190594, 7627.7330293439745, 7452.06849143857, 7555.924440755632, 7588.0, 7590.406014736912, 7599.772006839748, 33981.83009084963, 34066.0, 34074.65925340739, 34218.14454638629, 34348.82825585881, 2420.185119790712, 2448.424620214248, 2465.1125594785863, 2514.924552263435, 2520.092766604021, 24334.269971900696, 24515.877420612782, 24723.62914556283, 24871.378215544577, 24924.37689057788, 2583.1604728463135, 2591.7667409933006, 2592.1705054382605, 2593.9870300648377, 2613.516499447608, 159643.0, 161998.0, 162042.0, 162901.0, 163845.0, 40231.0, 40323.71745205013, 40411.59588404137, 40576.391354129715, 40584.39123413151, 41696.583034169875, 41845.37231941523, 41892.79053604773, 41897.581024189974, 41989.950251243965, 12897.871021289855, 13120.540781072617, 13146.4084116215, 13263.469461221443, 13270.402831872589, 10452.425116618508, 10552.366857988545, 10564.366138031743, 10577.682669519927, 10589.894101058891, 13171.802422963663, 13221.735565288833, 13251.403686834115, 13259.138156019828, 13433.0, 5477.3427188737605, 5480.945190548123, 5500.312460942382, 5570.916436253459, 5642.774289028475, 840.3613253927059, 851.0850835352021, 874.5933141089424, 879.6923567386672, 885.6767279942775, 21580.0, 22149.446263843533, 22520.324390268317, 22563.548729025326, 22628.0, 961.3318743473219, 962.7593101724569, 964.8263312603658, 986.8125056239435, 993.6273897288517, 11295.830562541569, 11300.321980681185, 11400.201985861077, 11464.59873904426, 11523.76952460946, 238050.0, 241667.0, 241975.0, 243092.0, 243769.0, 43500.78249608795, 43650.7817460917, 43704.56295437005, 43733.34399984003, 43770.34344484835, 1199.5654179875391, 1225.914186006971, 1231.1874163052341, 1231.6366671831652, 1241.5158088345552, 23917.16289929844, 25156.0, 25357.74642253554, 25601.359966001, 25734.742652573233, 30383.39233215279, 30665.846670766503, 30710.232244194074, 30770.230744231572, 30821.0, 218924.0, 219870.0, 220295.0, 220854.0, 220926.0, 29861.55207671843, 30243.395132096794, 30260.54609180908, 30644.08067757971, 31202.375952481278, 39693.60306396899, 39860.0, 40602.187956240115, 40612.0, 40662.39006414965, 29576.852115740145, 30053.849730751208, 30386.0, 30500.389992199587, 31601.841990790817, 30252.24369390783, 30402.54396184103, 30603.846980765844, 31298.843505783236, 31698.841505792323, 33358.66641333556, 33809.0, 33849.49225761665, 34098.31803363968, 34129.829350853084, 29777.2999233436, 29788.55317170201, 30161.0, 30203.244918876324, 30267.69732302649, 22539.88730056339, 24139.275821725376, 24145.879270603535, 24341.634875477237, 24570.0], "value": 15370.987102562829, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.3736583027968, 416.40869964650193, 416.76452804165655, 431.73232595790614, 434.29860774848623, 17281.481555553353, 18162.0, 18873.528161795963, 18889.338873139444, 18922.52693682657, 16421.589460263498, 16809.83190168098, 16887.0, 17015.91492042541, 17110.230039648213, 5750.3962083981205, 5766.538676905838, 5840.153177789218, 5888.793892213774, 5915.231019967419, 5692.288463942007, 5781.046127388976, 5789.015867302548, 5789.710514474259, 5793.971030144864, 5620.91568626471, 5755.971220143914, 5814.912776308359, 5817.447342502455, 5845.532357411418, 5697.829065128053, 5705.5435565154685, 5737.053386191274, 5755.4244575542525, 5756.856078598048, 4934.555889969884, 5100.285959965608, 5127.256547800548, 5144.0, 5148.485151484859, 22723.204687835845, 22866.428339291484, 23103.53792924149, 23245.30264092063, 23362.299131026095, 1545.1115608525142, 1563.3590228006462, 1568.2315665324022, 1587.1350114187796, 1594.1789978161257, 13455.330441843416, 14431.49489767853, 14513.782293265609, 14593.562193134223, 14693.412263509446, 1709.6666150100734, 1710.9392176850308, 1711.4951089428648, 1736.2360561352964, 1772.5834428909195, 85729.0, 87333.56333218356, 87822.0, 88721.0, 92942.07057929401, 10974.506147223234, 11093.611723589636, 11260.662180134608, 11438.771224575461, 11523.078153747847, 15650.765238521431, 15659.530214093595, 15661.295241713922, 15698.76451853223, 15716.21418929049, 7373.262673732691, 7550.6602202901, 7588.734394296283, 7764.340031097307, 7791.805204869924, 6929.41100006495, 7000.964995174992, 7177.354038136593, 7178.712851485987, 7200.0, 6974.895376569356, 7018.964905175441, 7129.857402851914, 7138.464615153885, 7161.57030578167, 1950.8927009014355, 1953.8339241164376, 1980.5741765520481, 1999.2802591067205, 2045.509077821312, 816.7141500474786, 840.9369297302727, 845.556083056388, 865.6580650642961, 865.9565223905179, 15810.841891580936, 16439.178041098137, 16700.164991750364, 16837.242324095445, 16987.0, 852.3436953545859, 857.4255248983196, 874.8906386701663, 877.0659247900965, 879.5338470610586, 8988.191062804379, 9025.104728007062, 9277.814443711088, 9366.203872670763, 9503.762405939908, 434972.0, 436821.6860482508, 441102.0, 451442.0, 453445.0, 86201.0, 87368.5631571838, 90165.9425325862, 90597.54701226452, 93410.53294733482, 1022.9130523905402, 1024.8565200871883, 1047.1518070363031, 1051.6056478820442, 1059.0944742245424, 13959.651008724457, 13968.720625587635, 14031.087979281314, 14181.432742690176, 14843.183624900303, 42460.36309455299, 43530.56469435265, 43639.345409819514, 44055.559444405146, 44942.325865111394, 54037.0, 54782.45217547774, 55247.44752552584, 55590.44409555852, 56082.439175607724, 8265.504069755834, 8269.669213231404, 8345.29065029455, 8467.0, 8728.869066964127, 13158.0, 13573.1856088635, 13647.86352136466, 13759.0, 13765.38055787512, 10755.623553175601, 10823.350598964087, 10827.458627068772, 11074.343041102109, 11262.324260544066, 11253.15601329887, 11340.489677964346, 11448.198626096426, 11454.94272528632, 11599.188056835941, 11743.823842642538, 11802.645920622395, 12016.879831201577, 12220.816687749868, 12359.876401235873, 8007.91992080095, 8029.437939344423, 8054.436189466681, 8191.83616327682, 8596.226339629464, 11484.770304594029, 11540.307581545134, 11570.19008669385, 11678.474468648761, 11989.940050300042], "value": 8979.283867755861, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1253.9811902821457, 1317.150437967511, 1326.5556038727032, 1332.533613235367, 1339.6115126613279, 9290.67482638107, 9674.467904265262, 9776.560054797543, 9803.460809655466, 9935.403875767459, 9773.364731292479, 9893.40639561625, 9905.851412228805, 9945.15466185375, 9957.601695932171, 2202.559488102378, 2215.235743668432, 2238.149503188794, 2238.854474459155, 2239.540894116702, 2097.800708932649, 2115.682647602864, 2128.8084072433476, 2135.5835612055657, 2145.0025738031813, 2130.371540395587, 2149.7420309562876, 2188.223180770827, 2203.8787866667326, 2207.150247154849, 2109.546447513784, 2120.0883620043373, 2121.893905304736, 2124.437024188599, 2124.8300135989084, 2073.1085633177727, 2094.863833850795, 2125.033109934976, 2130.3076500137518, 2183.3340831046526, 9814.705558833246, 9904.653337133166, 9918.057784510533, 9948.651797187063, 9953.25350598708, 5360.65155764874, 5536.833894983117, 5560.110382338847, 5576.86057848553, 5591.944080559183, 3292.7859689120132, 3347.196672798535, 3354.04409743222, 3473.635268296843, 3537.080359106625, 1029.526417847791, 1043.2332235806675, 1083.9458027098692, 1085.9945700271448, 1107.6953837694618, 13719.039667223298, 13720.176789392668, 13784.241866697228, 13805.17168969865, 13809.861901380958, 4451.821927122944, 4672.74299913508, 4776.9761151194025, 4797.544233297831, 4827.565519103227, 10800.94599527013, 10838.620648277272, 10856.728581785519, 10877.67366978992, 10891.782164356668, 5384.246205531151, 5415.025295446779, 5423.810166644149, 5425.240466334637, 5438.945610543923, 4750.239961606127, 4987.725675087832, 4995.100881841231, 5012.724300163526, 5029.572486338702, 3741.5136032315627, 3817.1983883384246, 3875.992242017096, 3929.4695216145456, 3945.861894833667, 1154.3535620052796, 1163.2206421697483, 1166.1720178673067, 1176.082655528689, 1190.9821352679717, 659.7921654678761, 693.8230751158422, 695.5478938689791, 698.3749544157951, 707.1090426063197, 5615.747291371817, 5626.97186514073, 5760.855978600484, 5852.268466441695, 6075.817725468243, 792.4809249941297, 805.2229598437419, 811.5414790643267, 842.3471809347805, 849.2229609906866, 3453.723702103826, 3690.8892733218045, 3734.8319325630414, 3832.0994566276904, 3856.9614303857165, 11566.768664626828, 12100.757984840255, 12299.200551964093, 12481.625551233477, 12591.811122833165, 12194.81707774384, 12303.384830758427, 12451.501939922302, 12457.626271211879, 12466.065045121652, 8937.955310223537, 9086.45481271126, 9094.86357704635, 9101.226395756303, 9179.082091790768, 5770.769169233184, 5963.314218864886, 5986.9401305986385, 6020.668863212565, 6125.84685382869, 11032.889671103507, 11288.49201785938, 11317.71705707364, 11511.884881151416, 11523.250988685708, 11453.942730286295, 11619.0704743622, 11724.941375293069, 11821.881781182423, 11837.82243266369, 7952.522848629101, 7962.840743184988, 8058.476199047043, 8063.637136328996, 8071.556064416279, 8800.119988001148, 8901.821963560822, 8942.195202431813, 8992.685256016008, 9242.399244049384, 7377.299156580117, 7412.444066694911, 7515.398768098648, 7550.697972081055, 7621.047369078865, 7274.345308922222, 7307.525010874276, 7363.116426028697, 7475.925240747523, 7582.279683430065, 6719.832004199739, 6752.763653272112, 6782.152230971129, 6804.55770374924, 6849.931500684929, 5036.6726162799305, 5046.268291097844, 5076.441591424867, 5262.079136151082, 5279.076161671615, 5049.166887463527, 5113.8721531962, 5159.742012899415, 5181.0, 5221.0], "value": 4634.014769468984, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.3374313053115, 389.53061560819214, 393.27048325356463, 394.9269385163744, 397.0668928019155, 5468.589855760814, 5496.203050557667, 5519.571388589023, 5545.3345598528185, 5624.240727501786, 5348.652337598053, 5388.0, 5436.21174929635, 5465.945340546593, 5484.670919744818, 4069.2065047315787, 4210.789460526977, 4224.598663126998, 4246.108317253365, 4265.424167737362, 4234.576542345756, 4239.0, 4242.6605871530355, 4245.766482843443, 4254.31930891056, 4169.937450938239, 4206.600372964579, 4219.578042195772, 4223.1975924574235, 4230.51349094855, 4115.753054816721, 4215.894602634943, 4217.36739489076, 4222.366645003243, 4228.76741779202, 3624.655657712513, 3627.292677927805, 3634.345817752803, 3649.981750091259, 3671.889843304705, 5315.920261196085, 5322.893542129135, 5324.627276090675, 5326.840194794162, 5336.91994620081, 4701.717896926195, 4778.450478195017, 4793.233082706785, 4819.397575303087, 4830.782614782308, 5725.198472213893, 5769.682667453289, 5773.960687076325, 5794.246747922785, 5796.333421656522, 4003.959960400417, 4011.3180759270704, 4014.2573623879675, 4015.4980627421573, 4027.0939038716347, 5553.805616803393, 5960.552958528085, 6127.0, 6188.412100850412, 6196.2874269459135, 4122.91754164915, 4125.824140120051, 4130.690198235145, 4145.91708165841, 4159.313713237342, 4219.409282700424, 4219.746815191098, 4231.534531201565, 4234.894127646833, 4236.9364459533135, 4844.442889067732, 4847.200211965057, 4864.173090574611, 4868.537488938545, 4875.68308059975, 5558.944410555923, 5755.1367294906095, 5774.769009239583, 5793.478586927196, 5817.534597232211, 1446.7034257977089, 1469.9632509187143, 1471.3820195517908, 1471.852814718541, 1472.9852701473062, 909.6043221198668, 953.9173038601238, 969.1084202533686, 973.3089506450358, 976.8876579193342, 5036.521530454675, 5042.193249080203, 5052.797888084436, 5071.644984851099, 5074.416442109205, 6014.458698717136, 6020.729067191987, 6021.608595441282, 6024.819255422344, 6044.7582096716515, 4893.510648935078, 4995.650304478724, 5028.823991160292, 5049.394072711299, 5062.240663900371, 3136.40408322418, 3159.794613350125, 3170.556122142902, 3189.6012998375204, 3191.5531825544444, 5549.139883318092, 5552.7778888844805, 5564.721763911788, 5568.6101972862325, 5573.359063707644, 5920.496757775637, 5999.790007349722, 6018.21763170785, 6102.908456373158, 6203.534734894811, 5609.326880774252, 5618.775248989995, 5619.185218143346, 5631.155326701028, 5637.746301416446, 6008.849778755566, 6013.331867560872, 6045.425684559959, 6058.969705151446, 6059.969700151471, 5767.279090113736, 5871.0, 5968.253968253968, 5973.970130149321, 5991.310999234969, 5633.746481408264, 5641.915371269352, 5642.633228840113, 5646.096624540054, 5653.971730141323, 3954.466147070224, 4147.440095587178, 4180.348762238959, 4191.916161676811, 4192.161567686414, 5985.760569577168, 6007.189029481139, 6019.699015049143, 6043.0, 6050.818475445743, 5814.73833677494, 5827.94172058274, 5830.280067380218, 5841.532677385884, 5856.853578660568, 5668.858278543069, 5792.478676919098, 5812.680302583399, 5816.621919575214, 5829.271341082364, 5731.5128214100605, 5735.8852822944145, 5736.942630573641, 5748.166515855261, 5758.0499217630295, 5721.57088218377, 5880.882382352414, 5890.674598215367, 5894.793682221101, 5924.407559244041, 5694.861027794374, 5731.828045158652, 5735.684537350486, 5744.626599271034, 5747.798827041033], "value": 4351.792734976716, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.7438964050635, 590.7371219807185, 602.9849253768655, 606.369375849117, 621.6177051113565, 12201.450934707947, 12486.937565312172, 12672.303023333712, 14993.85006149938, 15901.443449479271, 14371.496997605085, 14371.856281437182, 14679.19264440458, 14765.261736913166, 15829.525114246591, 828.7845160258316, 837.3301358912876, 837.4598384042289, 838.1116017021945, 838.9848283576879, 893.1515060692336, 924.5469719837298, 925.2135684668045, 931.4039015030386, 933.593886659302, 970.5875003123645, 975.5317447625109, 975.7219192530131, 976.0288512929645, 977.296346630425, 950.0879156010169, 953.046953046953, 955.8375076237022, 955.8422860228054, 956.2159029595734, 709.0604948443333, 709.3970125393425, 711.1111111111111, 712.3446429285018, 714.2036629158503, 13361.13152645075, 13427.932860335733, 13429.798553021712, 13581.932090339584, 14529.927350363181, 13207.471701131943, 13399.665008374772, 13491.580846800327, 13519.256440895746, 13607.795883061763, 8608.354373421957, 8874.201321881063, 8905.154010369004, 9011.594478248495, 9102.499362535058, 2382.5354055959097, 2410.927672169838, 2416.5770990076667, 2422.63660450932, 2427.5023620157826, 61905.38094619086, 63340.0, 63548.364516354704, 63685.999999999534, 63986.36013639851, 9103.590338434786, 9490.810183796424, 9503.0, 9549.09283618055, 9661.855072173923, 20596.27913023037, 21058.368248952556, 21629.891850540647, 21830.563388732135, 21863.453413664785, 5659.0, 5905.852353691193, 6420.422162005442, 6496.577722448026, 6524.739010439529, 2995.1613548206537, 3041.285297954979, 3096.845157742149, 3109.6423911250495, 3129.8748050078198, 3557.804400129019, 3628.1111127773866, 3680.300742858848, 3682.1715114099115, 3690.723195760275, 638.1162090504685, 673.245964519741, 692.4706220826695, 692.757534862804, 706.5766361976217, 458.6858002268457, 472.6667699272005, 484.1189035954529, 488.1579275749304, 492.21000294526766, 6988.580685158907, 7238.855222895512, 7509.699612015458, 7601.695932162762, 8032.839343213103, 439.9978000109979, 456.98629041128817, 466.6756604160076, 496.41918954822944, 512.6616433154101, 3264.3308121834966, 3428.8457019434186, 3462.532558104674, 3492.0746002309406, 3542.167590616203, 61823.76352472926, 62827.0, 63883.0, 64295.0, 65573.0, 54384.0, 54656.0, 54838.72580637151, 56390.71804640951, 57194.0, 48027.519724803, 48403.0, 48667.75666121717, 49538.75230623824, 50521.242181367306, 6799.558028728117, 6981.616011119234, 7034.683439245348, 7072.115985501812, 7085.858282834418, 23941.52116957616, 24192.758072419052, 24715.87642061778, 25510.0, 26115.216543503724, 42670.78664606657, 42711.57288427076, 43384.783076084415, 43825.34261986137, 44814.77592612016, 11085.667429977113, 11155.10759139283, 11384.37385943781, 11388.94305528467, 11741.471633776671, 11772.941135294268, 11786.941065294619, 11856.170068095496, 11980.76038479243, 12176.817347739614, 10211.642592509226, 10287.485625718833, 10415.895841041493, 10491.737706557093, 10500.47497625131, 10666.306690065121, 10726.141908647445, 10794.244402891722, 10815.242932994615, 11164.274322169033, 10036.146927510952, 10056.245781566266, 10354.5340459678, 10397.428141452292, 10409.42748148859, 7904.359636423227, 7984.800379990546, 8016.8797468036855, 8178.764713503899, 8286.668533258602, 8997.910020899708, 9054.54727263621, 9116.772080698036, 9160.58777355034, 9183.448993060438], "value": 6040.919312872417, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1581.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 113.0, 113.0, 114.0, 113.0, 113.0, 114.0, 112.0, 112.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 127.0, 125.0, 182.0, 127.0, 127.0, 130.0, 124.0, 146.0, 134.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 167.0, 172.0, 166.0, 178.0, 166.0, 166.0, 180.0, 166.0], "value": 169.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 84.0, 122.0, 75.0, 79.0, 76.0, 75.0, 93.0, 75.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 116.0, 84.0, 84.0, 84.0, 100.0, 86.0, 86.0, 110.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 115.0, 116.0, 119.0, 115.0, 115.0, 116.0, 115.0], "value": 115.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 152.0, 153.0, 150.0, 152.0, 152.0, 151.0, 153.0, 151.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 69.0, 68.0, 69.0, 68.0, 69.0, 69.0, 69.0], "value": 68.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 56.0, 56.0, 56.0, 59.0, 56.0, 56.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 85.0, 84.0, 83.0, 86.0, 83.0, 87.0, 85.0, 85.0, 84.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 134.0, 136.0, 156.0, 137.0, 144.0, 148.0, 145.0, 185.0, 137.0], "value": 146.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 199.0, 191.0, 195.0, 198.0, 199.0, 186.0, 196.0, 210.0, 197.0], "value": 195.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 74.0, 72.0, 74.0, 71.0, 72.0, 72.0, 71.0, 77.0], "value": 72.9, "unit": "score"}]}]} 04:51:09 INFO - Return code: 0 04:51:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:51:09 ERROR - # TBPL SUCCESS # 04:51:09 INFO - Running post-action listener: _resource_record_post_action 04:51:09 INFO - [mozharness: 2017-03-31 11:51:09.982273Z] Finished run-tests step (success) 04:51:09 INFO - Running post-run listener: _resource_record_post_run 04:51:10 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 367075328; Read time: 16; Write time: 213072 04:51:10 INFO - TinderboxPrint: CPU usage
13.3% 04:51:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:51:10 INFO - TinderboxPrint: I/O write bytes / time
367,075,328 / 213,072 04:51:10 INFO - TinderboxPrint: CPU idle
8,320.1 (86.7%) 04:51:10 INFO - TinderboxPrint: CPU user
1,222.4 (12.7%) 04:51:10 INFO - TinderboxPrint: Swap in / out
0 / 0 04:51:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105889792; Read time: 0; Write time: 57632 04:51:10 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 261185536; Read time: 16; Write time: 155440 04:51:10 INFO - Running post-run listener: _upload_blobber_files 04:51:10 INFO - Blob upload gear active. 04:51:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:51:10 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 04:51:10 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'] 04:51:10 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 04:51:11 INFO - (blobuploader) - INFO - Open directory for files ... 04:51:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:51:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:51:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:11 INFO - (blobuploader) - INFO - Done attempting. 04:51:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:51:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:51:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:15 INFO - (blobuploader) - INFO - Done attempting. 04:51:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:51:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:51:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:15 INFO - (blobuploader) - INFO - Done attempting. 04:51:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:51:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:51:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:17 INFO - (blobuploader) - INFO - Done attempting. 04:51:17 INFO - (blobuploader) - INFO - Iteration through files over. 04:51:17 INFO - Return code: 0 04:51:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:51:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:51:17 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0fd8dc21e6f8f7cbe9d741fca462ac44f731593c9fb318b3903e057d3d4af623e562434632e1fce63c591112a72279e151f10c9114293868e088c600f711aa09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c69affe2be79d2f0394ea6d72a2e1c759e17ff96b3f2d49e7838f6f4d44dd8d1520ef3b82cbd7f8d7742ae56996ec879b9665886dce8a4834853e757f095843", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3bc825270ffea5face01dd88ebad712d264728f6d46a5348fa2d3800f37ba813422c64d2338e9c6d7fcd080c1a2297c3939788cc47d7ba2456daf55b6acca59b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ce05a795e4bb93ac7bd41e1e524ea4484512c5b7773b877ad627e3a44345c675486af36c758cfb34036a99c9eaf97c6e56b106dac8629f76c13c9201942828c2"} 04:51:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:51:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:51:17 INFO - Contents: 04:51:17 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0fd8dc21e6f8f7cbe9d741fca462ac44f731593c9fb318b3903e057d3d4af623e562434632e1fce63c591112a72279e151f10c9114293868e088c600f711aa09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c69affe2be79d2f0394ea6d72a2e1c759e17ff96b3f2d49e7838f6f4d44dd8d1520ef3b82cbd7f8d7742ae56996ec879b9665886dce8a4834853e757f095843", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3bc825270ffea5face01dd88ebad712d264728f6d46a5348fa2d3800f37ba813422c64d2338e9c6d7fcd080c1a2297c3939788cc47d7ba2456daf55b6acca59b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ce05a795e4bb93ac7bd41e1e524ea4484512c5b7773b877ad627e3a44345c675486af36c758cfb34036a99c9eaf97c6e56b106dac8629f76c13c9201942828c2"} 04:51:17 INFO - Running post-run listener: copy_logs_to_upload_dir 04:51:17 INFO - Copying logs to upload dir... 04:51:17 INFO - mkdir: /builds/slave/test/build/upload/logs 04:51:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.488289 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-03-31 04:51:16.924222) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 04:51:16.927679) ========= 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=1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0fd8dc21e6f8f7cbe9d741fca462ac44f731593c9fb318b3903e057d3d4af623e562434632e1fce63c591112a72279e151f10c9114293868e088c600f711aa09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c69affe2be79d2f0394ea6d72a2e1c759e17ff96b3f2d49e7838f6f4d44dd8d1520ef3b82cbd7f8d7742ae56996ec879b9665886dce8a4834853e757f095843", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3bc825270ffea5face01dd88ebad712d264728f6d46a5348fa2d3800f37ba813422c64d2338e9c6d7fcd080c1a2297c3939788cc47d7ba2456daf55b6acca59b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ce05a795e4bb93ac7bd41e1e524ea4484512c5b7773b877ad627e3a44345c675486af36c758cfb34036a99c9eaf97c6e56b106dac8629f76c13c9201942828c2"} build_url:https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011238 build_url: 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0fd8dc21e6f8f7cbe9d741fca462ac44f731593c9fb318b3903e057d3d4af623e562434632e1fce63c591112a72279e151f10c9114293868e088c600f711aa09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c69affe2be79d2f0394ea6d72a2e1c759e17ff96b3f2d49e7838f6f4d44dd8d1520ef3b82cbd7f8d7742ae56996ec879b9665886dce8a4834853e757f095843", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3bc825270ffea5face01dd88ebad712d264728f6d46a5348fa2d3800f37ba813422c64d2338e9c6d7fcd080c1a2297c3939788cc47d7ba2456daf55b6acca59b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ce05a795e4bb93ac7bd41e1e524ea4484512c5b7773b877ad627e3a44345c675486af36c758cfb34036a99c9eaf97c6e56b106dac8629f76c13c9201942828c2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 04:51:16.956109) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:51:16.956676) ========= 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=1f5564757af27664ca02d71f000001b0-1490959813.206018-1609831306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004638 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:51:17.041873) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 04:51:17.042380) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 04:51:17.042903) ========= ========= Total master_lag: 0.18 =========