builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-079 starttime: 1489775457.1 results: success (0) revision: 23a4b7430dd7e83a2809bf3dc41471f154301eda ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-17 11:30:57.095342) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-17 11:30:57.095755) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-17 11:30:57.096292) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-17 11:30:57.137234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 11:30:57.137577) ========= 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=1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-17 11:30:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2017-03-17 11:30:57 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.208795 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 11:30:57.382462) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 11:30:57.382865) ========= 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=1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.061129 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 11:30:57.456496) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-17 11:30:57.456874) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 23a4b7430dd7e83a2809bf3dc41471f154301eda --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 23a4b7430dd7e83a2809bf3dc41471f154301eda --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=1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-17 11:30:57,523 truncating revision to first 12 chars 2017-03-17 11:30:57,523 Setting DEBUG logging. 2017-03-17 11:30:57,524 attempt 1/10 2017-03-17 11:30:57,524 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/23a4b7430dd7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-17 11:30:58,766 unpacking tar archive at: mozilla-central-23a4b7430dd7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.543163 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-17 11:30:59.013425) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-17 11:30:59.013730) ========= script_repo_revision: 23a4b7430dd7e83a2809bf3dc41471f154301eda ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-17 11:30:59.014135) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-17 11:30:59.014472) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-17 11:30:59.023904) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-03-17 11:30:59.024357) ========= /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=1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:30:59 INFO - MultiFileLogger online at 20170317 11:30:59 in /builds/slave/test 11:30:59 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 11:30:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:30:59 INFO - {'append_to_log': False, 11:30:59 INFO - 'base_work_dir': '/builds/slave/test', 11:30:59 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:30:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:30:59 INFO - 'branch': 'Firefox-Non-PGO', 11:30:59 INFO - 'buildbot_json_path': 'buildprops.json', 11:30:59 INFO - 'config_files': ('talos/linux_config.py',), 11:30:59 INFO - 'default_actions': ('clobber', 11:30:59 INFO - 'read-buildbot-config', 11:30:59 INFO - 'download-and-extract', 11:30:59 INFO - 'populate-webroot', 11:30:59 INFO - 'create-virtualenv', 11:30:59 INFO - 'install', 11:30:59 INFO - 'run-tests'), 11:30:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:30:59 INFO - 'download_minidump_stackwalk': True, 11:30:59 INFO - 'download_symbols': 'ondemand', 11:30:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:30:59 INFO - 'tooltool.py': '/tools/tooltool.py', 11:30:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:30:59 INFO - '/tools/misc-python/virtualenv.py')}, 11:30:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:30:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:30:59 INFO - 'gecko_profile': False, 11:30:59 INFO - 'gecko_profile_interval': 0, 11:30:59 INFO - 'installer_path': 'installer.exe', 11:30:59 INFO - 'log_level': 'info', 11:30:59 INFO - 'log_name': 'talos', 11:30:59 INFO - 'log_to_console': True, 11:30:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:30:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:30:59 INFO - 'opt_config_files': (), 11:30:59 INFO - 'pip_index': False, 11:30:59 INFO - 'suite': 'dromaeojs-e10s', 11:30:59 INFO - 'system_bits': '32', 11:30:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:30:59 INFO - 'title': 'talos-linux64-ix-079', 11:30:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:30:59 INFO - 'use_talos_json': True, 11:30:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:30:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:30:59 INFO - 'work_dir': 'build'} 11:30:59 INFO - [mozharness: 2017-03-17 18:30:59.353395Z] Running clobber step. 11:30:59 INFO - Running pre-action listener: _resource_record_pre_action 11:30:59 INFO - Running main action method: clobber 11:30:59 INFO - rmtree: /builds/slave/test/build 11:30:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:31:01 INFO - Running post-action listener: _resource_record_post_action 11:31:01 INFO - [mozharness: 2017-03-17 18:31:01.299963Z] Finished clobber step (success) 11:31:01 INFO - [mozharness: 2017-03-17 18:31:01.300136Z] Running read-buildbot-config step. 11:31:01 INFO - Running pre-action listener: _resource_record_pre_action 11:31:01 INFO - Running main action method: read_buildbot_config 11:31:01 INFO - Using buildbot properties: 11:31:01 INFO - { 11:31:01 INFO - "project": "", 11:31:01 INFO - "product": "firefox", 11:31:01 INFO - "who": "kwierso@gmail.com", 11:31:01 INFO - "installer_path": "public/build/target.tar.bz2", 11:31:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:31:01 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 11:31:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 11:31:01 INFO - "stage_platform": "linux64", 11:31:01 INFO - "basedir": "/builds/slave/test", 11:31:01 INFO - "buildnumber": 471, 11:31:01 INFO - "platform": "ubuntu64_hw", 11:31:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:31:01 INFO - "slavebuilddir": "test", 11:31:01 INFO - "taskId": "QQxz3njwQKGPeLYgVgOwag", 11:31:01 INFO - "branch": "mozilla-central", 11:31:01 INFO - "script_repo_revision": "production", 11:31:01 INFO - "revision": "23a4b7430dd7e83a2809bf3dc41471f154301eda", 11:31:01 INFO - "slavename": "talos-linux64-ix-079", 11:31:01 INFO - "repo_path": "mozilla-central" 11:31:01 INFO - } 11:31:01 INFO - Finding installer, test and symbols from parent task. 11:31:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QQxz3njwQKGPeLYgVgOwag'}, attempt #1 11:31:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QQxz3njwQKGPeLYgVgOwag'}, attempt #1 11:31:02 INFO - Task dependencies: E85xswhnQnCXpgU03Rnugw 11:31:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E85xswhnQnCXpgU03Rnugw'}, attempt #1 11:31:06 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/target.tar.bz2 11:31:06 INFO - Set test_url: https://queue.taskcluster.net/v1/task/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/test_packages.json 11:31:06 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/target.crashreporter-symbols.zip 11:31:06 INFO - Running post-action listener: _resource_record_post_action 11:31:06 INFO - [mozharness: 2017-03-17 18:31:06.462505Z] Finished read-buildbot-config step (success) 11:31:06 INFO - [mozharness: 2017-03-17 18:31:06.462728Z] Running download-and-extract step. 11:31:06 INFO - Running pre-action listener: _resource_record_pre_action 11:31:06 INFO - Running main action method: download_and_extract 11:31:06 INFO - mkdir: /builds/slave/test/build/tests 11: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')]} 11:31:06 INFO - trying https://queue.taskcluster.net/v1/task/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/target.test_packages.json 11:31:06 INFO - Downloading https://queue.taskcluster.net/v1/task/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:31:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:31:07 INFO - Downloaded 986 bytes. 11:31:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:31:07 INFO - Using the following test package requirements: 11:31:07 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:31:07 INFO - u'common': [u'target.common.tests.zip'], 11:31:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:31:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:31:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:31:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:31:07 INFO - u'mozbase': [u'target.common.tests.zip'], 11:31:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:31:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:31:07 INFO - u'web-platform': [u'target.common.tests.zip', 11:31:07 INFO - u'target.web-platform.tests.zip'], 11:31:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:31:07 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:31:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/target.common.tests.zip 11:31:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:31:07 INFO - Fetch https://queue.taskcluster.net/v1/task/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/target.common.tests.zip into memory 11:31:08 INFO - Expected file size: 58186371 11:31:08 INFO - Obtained file size: 58186371 11:31:18 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:31:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/target.common.tests.zip 11:31:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:31:18 INFO - Fetch https://queue.taskcluster.net/v1/task/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/target.common.tests.zip into memory 11:31:19 INFO - Expected file size: 58186371 11:31:19 INFO - Obtained file size: 58186371 11:31:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/target.talos.tests.zip 11:31:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:31:30 INFO - Fetch https://queue.taskcluster.net/v1/task/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/target.talos.tests.zip into memory 11:31:30 INFO - Expected file size: 14404171 11:31:30 INFO - Obtained file size: 14404171 11:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:31 INFO - trying https://queue.taskcluster.net/v1/task/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/target.tar.bz2 11:31:31 INFO - Downloading https://queue.taskcluster.net/v1/task/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:31:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:31:32 INFO - Downloaded 61708320 bytes. 11:31:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/target.tar.bz2 11:31:32 INFO - mkdir: /builds/slave/test/properties 11:31:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:31:32 INFO - Writing to file /builds/slave/test/properties/build_url 11:31:32 INFO - Contents: 11:31:32 INFO - build_url:https://queue.taskcluster.net/v1/task/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/target.tar.bz2 11:31:32 INFO - Running post-action listener: _resource_record_post_action 11:31:32 INFO - Running post-action listener: set_extra_try_arguments 11:31:32 INFO - [mozharness: 2017-03-17 18:31:32.329471Z] Finished download-and-extract step (success) 11:31:32 INFO - [mozharness: 2017-03-17 18:31:32.329587Z] Running populate-webroot step. 11:31:32 INFO - Running pre-action listener: _resource_record_pre_action 11:31:32 INFO - Running main action method: populate_webroot 11:31:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:31:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:31:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:31:32 INFO - '--tppagecycles', 11:31:32 INFO - '7'], 11:31:32 INFO - 'tests': ['tsvgm']}}, 11:31:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:31:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:31:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:31:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:31:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:31:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:31:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:31:32 INFO - 'talos_options': ['--disable-e10s'], 11:31:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:31:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:31:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:31:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:31:32 INFO - 'talos_options': ['--disable-e10s'], 11:31:32 INFO - 'tests': ['damp', 'tps']}, 11:31:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:31:32 INFO - 'tests': ['damp', 'tps']}, 11:31:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:31:32 INFO - 'tests': ['dromaeo_dom']}, 11:31:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:31:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:31:32 INFO - 'tests': ['basic_compositor_video']}, 11:31:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:31:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:31:32 INFO - 'tests': ['a11yr', 11:31:32 INFO - 'ts_paint', 11:31:32 INFO - 'tpaint', 11:31:32 INFO - 'sessionrestore', 11:31:32 INFO - 'sessionrestore_no_auto_restore', 11:31:32 INFO - 'tabpaint']}, 11:31:32 INFO - 'other-e10s': {'tests': ['a11yr', 11:31:32 INFO - 'ts_paint', 11:31:32 INFO - 'tpaint', 11:31:32 INFO - 'sessionrestore', 11:31:32 INFO - 'sessionrestore_no_auto_restore', 11:31:32 INFO - 'tabpaint']}, 11:31:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:31:32 INFO - 'ts_paint', 11:31:32 INFO - 'tpaint', 11:31:32 INFO - 'sessionrestore', 11:31:32 INFO - 'sessionrestore_no_auto_restore', 11:31:32 INFO - 'tabpaint']}, 11:31:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:31:32 INFO - 'ts_paint', 11:31:32 INFO - 'tpaint', 11:31:32 INFO - 'sessionrestore', 11:31:32 INFO - 'sessionrestore_no_auto_restore', 11:31:32 INFO - 'tabpaint']}, 11:31:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:31:32 INFO - 'tests': ['a11yr', 11:31:32 INFO - 'ts_paint', 11:31:32 INFO - 'tpaint', 11:31:32 INFO - 'sessionrestore', 11:31:32 INFO - 'sessionrestore_no_auto_restore', 11:31:32 INFO - 'tabpaint']}, 11:31:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:31:32 INFO - 'tests': ['a11yr', 11:31:32 INFO - 'ts_paint', 11:31:32 INFO - 'tpaint', 11:31:32 INFO - 'sessionrestore', 11:31:32 INFO - 'sessionrestore_no_auto_restore', 11:31:32 INFO - 'tabpaint']}, 11:31:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:31:32 INFO - 'tests': ['tsvgx', 11:31:32 INFO - 'tsvgr_opacity', 11:31:32 INFO - 'tart', 11:31:32 INFO - 'tscrollx', 11:31:32 INFO - 'cart', 11:31:32 INFO - 'tsvg_static']}, 11:31:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:31:32 INFO - 'tsvgr_opacity', 11:31:32 INFO - 'tart', 11:31:32 INFO - 'tscrollx', 11:31:32 INFO - 'cart', 11:31:32 INFO - 'tsvg_static']}, 11:31:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:31:32 INFO - 'talos_options': ['--disable-e10s'], 11:31:32 INFO - 'tests': ['tp5o']}, 11:31:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:31:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:31:32 INFO - 'talos_options': ['--disable-e10s', 11:31:32 INFO - '--xperf_path', 11:31:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:31:32 INFO - 'tests': ['tp5n']}, 11:31:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:31:32 INFO - 'talos_options': ['--xperf_path', 11:31:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:31:32 INFO - 'tests': ['tp5n']}}, 11:31:32 INFO - 'talos.zip': {'path': '', 11:31:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:31:32 INFO - Running post-action listener: _resource_record_post_action 11:31:32 INFO - [mozharness: 2017-03-17 18:31:32.346234Z] Finished populate-webroot step (success) 11:31:32 INFO - [mozharness: 2017-03-17 18:31:32.346342Z] Running create-virtualenv step. 11:31:32 INFO - Running pre-action listener: _resource_record_pre_action 11:31:32 INFO - Running main action method: create_virtualenv 11:31:32 INFO - Creating virtualenv /builds/slave/test/build/venv 11:31:32 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 11:31:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:31:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:31:32 INFO - Using real prefix '/usr' 11:31:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:31:33 INFO - Installing distribute.............................................................................................................................................................................................done. 11:31:35 INFO - Installing pip.................done. 11:31:35 INFO - Return code: 0 11:31:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:31:35 INFO - Reading from file tmpfile_stdout 11:31:35 INFO - Output received: 11:31:35 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) 11:31:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:35 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 0x23c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d290>, '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 0x265db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265e040>, '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': '1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094', '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 11:31:35 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 11:31:35 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 11:31:35 INFO - Using env: {'DISPLAY': ':0', 11:31:35 INFO - 'HOME': '/home/cltbld', 11:31:35 INFO - 'LANG': 'en_US.UTF-8', 11:31:35 INFO - 'LANGUAGE': 'en_US:en', 11:31:35 INFO - 'LOGNAME': 'cltbld', 11:31:35 INFO - 'MAIL': '/var/mail/cltbld', 11:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:35 INFO - 'MOZ_NO_REMOTE': '1', 11:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:35 INFO - 'NO_EM_RESTART': '1', 11:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:35 INFO - 'PWD': '/builds/slave/test', 11:31:35 INFO - 'SHELL': '/bin/bash', 11:31:35 INFO - 'SHLVL': '1', 11:31:35 INFO - 'TERM': 'linux', 11:31:35 INFO - 'TMOUT': '86400', 11:31:35 INFO - 'USER': 'cltbld', 11:31:35 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094', 11:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:35 INFO - '_': '/tools/buildbot/bin/python'} 11:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:35 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 11:31:35 INFO - Cleaning up... 11:31:35 INFO - Return code: 0 11:31:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:35 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 0x23c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d290>, '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 0x265db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265e040>, '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': '1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094', '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 11:31:35 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 11:31:35 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 11:31:35 INFO - Using env: {'DISPLAY': ':0', 11:31:35 INFO - 'HOME': '/home/cltbld', 11:31:35 INFO - 'LANG': 'en_US.UTF-8', 11:31:35 INFO - 'LANGUAGE': 'en_US:en', 11:31:35 INFO - 'LOGNAME': 'cltbld', 11:31:35 INFO - 'MAIL': '/var/mail/cltbld', 11:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:35 INFO - 'MOZ_NO_REMOTE': '1', 11:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:35 INFO - 'NO_EM_RESTART': '1', 11:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:35 INFO - 'PWD': '/builds/slave/test', 11:31:35 INFO - 'SHELL': '/bin/bash', 11:31:35 INFO - 'SHLVL': '1', 11:31:35 INFO - 'TERM': 'linux', 11:31:35 INFO - 'TMOUT': '86400', 11:31:35 INFO - 'USER': 'cltbld', 11:31:35 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094', 11:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:35 INFO - '_': '/tools/buildbot/bin/python'} 11:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:35 INFO - Downloading/unpacking psutil>=3.1.1 11:31:35 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 11:31:35 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 11:31:35 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 11:31:35 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 11:31:35 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 11:31:35 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 11:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:31:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:31:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:31:37 INFO - Installing collected packages: psutil 11:31:37 INFO - Running setup.py install for psutil 11:31:37 INFO - building 'psutil._psutil_linux' extension 11:31:37 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 11:31:38 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 11:31:38 INFO - building 'psutil._psutil_posix' extension 11:31:38 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 11:31:39 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 11:31:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:31:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:31:39 INFO - Successfully installed psutil 11:31:39 INFO - Cleaning up... 11:31:39 INFO - Return code: 0 11:31:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d290>, '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 0x265db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265e040>, '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': '1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094', '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 11:31:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:31:39 INFO - Using env: {'DISPLAY': ':0', 11:31:39 INFO - 'HOME': '/home/cltbld', 11:31:39 INFO - 'LANG': 'en_US.UTF-8', 11:31:39 INFO - 'LANGUAGE': 'en_US:en', 11:31:39 INFO - 'LOGNAME': 'cltbld', 11:31:39 INFO - 'MAIL': '/var/mail/cltbld', 11:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:39 INFO - 'MOZ_NO_REMOTE': '1', 11:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:39 INFO - 'NO_EM_RESTART': '1', 11:31:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:39 INFO - 'PWD': '/builds/slave/test', 11:31:39 INFO - 'SHELL': '/bin/bash', 11:31:39 INFO - 'SHLVL': '1', 11:31:39 INFO - 'TERM': 'linux', 11:31:39 INFO - 'TMOUT': '86400', 11:31:39 INFO - 'USER': 'cltbld', 11:31:39 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094', 11:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:39 INFO - '_': '/tools/buildbot/bin/python'} 11:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:31:39 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 11:31:39 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 11:31:39 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 11:31:39 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 11:31:39 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 11:31:39 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 11:31:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:31:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:31:41 INFO - Installing collected packages: mozsystemmonitor 11:31:41 INFO - Running setup.py install for mozsystemmonitor 11:31:41 INFO - Successfully installed mozsystemmonitor 11:31:41 INFO - Cleaning up... 11:31:41 INFO - Return code: 0 11:31:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:41 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 0x23c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d290>, '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 0x265db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265e040>, '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': '1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094', '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 11:31:41 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 11:31:41 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 11:31:41 INFO - Using env: {'DISPLAY': ':0', 11:31:41 INFO - 'HOME': '/home/cltbld', 11:31:41 INFO - 'LANG': 'en_US.UTF-8', 11:31:41 INFO - 'LANGUAGE': 'en_US:en', 11:31:41 INFO - 'LOGNAME': 'cltbld', 11:31:41 INFO - 'MAIL': '/var/mail/cltbld', 11:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:41 INFO - 'MOZ_NO_REMOTE': '1', 11:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:41 INFO - 'NO_EM_RESTART': '1', 11:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:41 INFO - 'PWD': '/builds/slave/test', 11:31:41 INFO - 'SHELL': '/bin/bash', 11:31:41 INFO - 'SHLVL': '1', 11:31:41 INFO - 'TERM': 'linux', 11:31:41 INFO - 'TMOUT': '86400', 11:31:41 INFO - 'USER': 'cltbld', 11:31:41 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094', 11:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:41 INFO - '_': '/tools/buildbot/bin/python'} 11:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:41 INFO - Downloading/unpacking jsonschema==2.5.1 11:31:41 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 11:31:41 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 11:31:41 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 11:31:41 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 11:31:41 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 11:31:41 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 11:31:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:31:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:44 INFO - Downloading functools32-3.2.3-2.tar.gz 11:31:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:31:44 INFO - warning: no files found matching '*.txt' 11:31:44 INFO - no previously-included directories found matching 'build' 11:31:44 INFO - no previously-included directories found matching 'dist' 11:31:44 INFO - no previously-included directories found matching '.git*' 11:31:44 INFO - Installing collected packages: jsonschema, functools32 11:31:44 INFO - Running setup.py install for functools32 11:31:44 INFO - warning: no files found matching '*.txt' 11:31:44 INFO - no previously-included directories found matching 'build' 11:31:44 INFO - no previously-included directories found matching 'dist' 11:31:44 INFO - no previously-included directories found matching '.git*' 11:31:44 INFO - Successfully installed jsonschema functools32 11:31:44 INFO - Cleaning up... 11:31:44 INFO - Return code: 0 11:31:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:31:44 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')]} 11:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:44 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')]} 11:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:44 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 0x23c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d290>, '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 0x265db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265e040>, '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': '1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094', '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 11:31:44 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 11:31:44 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 11:31:44 INFO - Using env: {'DISPLAY': ':0', 11:31:44 INFO - 'HOME': '/home/cltbld', 11:31:44 INFO - 'LANG': 'en_US.UTF-8', 11:31:44 INFO - 'LANGUAGE': 'en_US:en', 11:31:44 INFO - 'LOGNAME': 'cltbld', 11:31:44 INFO - 'MAIL': '/var/mail/cltbld', 11:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:44 INFO - 'MOZ_NO_REMOTE': '1', 11:31:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:44 INFO - 'NO_EM_RESTART': '1', 11:31:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:44 INFO - 'PWD': '/builds/slave/test', 11:31:44 INFO - 'SHELL': '/bin/bash', 11:31:44 INFO - 'SHLVL': '1', 11:31:44 INFO - 'TERM': 'linux', 11:31:44 INFO - 'TMOUT': '86400', 11:31:44 INFO - 'USER': 'cltbld', 11:31:44 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094', 11:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:44 INFO - '_': '/tools/buildbot/bin/python'} 11:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:31:44 INFO - Cleaning up... 11:31:44 INFO - Return code: 0 11:31:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:31:44 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')]} 11:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:44 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')]} 11:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:44 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 0x23c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d290>, '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 0x265db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265e040>, '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': '1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094', '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 11:31:44 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 11:31:44 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 11:31:44 INFO - Using env: {'DISPLAY': ':0', 11:31:44 INFO - 'HOME': '/home/cltbld', 11:31:44 INFO - 'LANG': 'en_US.UTF-8', 11:31:44 INFO - 'LANGUAGE': 'en_US:en', 11:31:44 INFO - 'LOGNAME': 'cltbld', 11:31:44 INFO - 'MAIL': '/var/mail/cltbld', 11:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:44 INFO - 'MOZ_NO_REMOTE': '1', 11:31:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:44 INFO - 'NO_EM_RESTART': '1', 11:31:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:44 INFO - 'PWD': '/builds/slave/test', 11:31:44 INFO - 'SHELL': '/bin/bash', 11:31:44 INFO - 'SHLVL': '1', 11:31:44 INFO - 'TERM': 'linux', 11:31:44 INFO - 'TMOUT': '86400', 11:31:44 INFO - 'USER': 'cltbld', 11:31:44 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094', 11:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:44 INFO - '_': '/tools/buildbot/bin/python'} 11:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:44 INFO - Downloading/unpacking blobuploader==1.2.4 11:31:44 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 11:31:44 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 11:31:44 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 11:31:44 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 11:31:44 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 11:31:44 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 11:31:46 INFO - Downloading blobuploader-1.2.4.tar.gz 11:31:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:31:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:31:46 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 11:31:46 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 11:31:46 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 11:31:46 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 11:31:46 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 11:31:46 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 11:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:31:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:31: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 11:31: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 11:31: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 11:31: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 11:31: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 11:31: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 11:31:47 INFO - Downloading docopt-0.6.1.tar.gz 11:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:31:47 INFO - Installing collected packages: blobuploader, requests, docopt 11:31:47 INFO - Running setup.py install for blobuploader 11:31:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:31:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:31:47 INFO - Running setup.py install for requests 11:31:48 INFO - Running setup.py install for docopt 11:31:48 INFO - Successfully installed blobuploader requests docopt 11:31:48 INFO - Cleaning up... 11:31:48 INFO - Return code: 0 11:31:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:48 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 0x23c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d290>, '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 0x265db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265e040>, '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': '1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094', '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 11:31:48 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 11:31:48 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 11:31:48 INFO - Using env: {'DISPLAY': ':0', 11:31:48 INFO - 'HOME': '/home/cltbld', 11:31:48 INFO - 'LANG': 'en_US.UTF-8', 11:31:48 INFO - 'LANGUAGE': 'en_US:en', 11:31:48 INFO - 'LOGNAME': 'cltbld', 11:31:48 INFO - 'MAIL': '/var/mail/cltbld', 11:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:48 INFO - 'MOZ_NO_REMOTE': '1', 11:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:48 INFO - 'NO_EM_RESTART': '1', 11:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:48 INFO - 'PWD': '/builds/slave/test', 11:31:48 INFO - 'SHELL': '/bin/bash', 11:31:48 INFO - 'SHLVL': '1', 11:31:48 INFO - 'TERM': 'linux', 11:31:48 INFO - 'TMOUT': '86400', 11:31:48 INFO - 'USER': 'cltbld', 11:31:48 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094', 11:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:48 INFO - '_': '/tools/buildbot/bin/python'} 11:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:31:48 INFO - Running setup.py (path:/tmp/pip-bntILi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:31:48 INFO - Running setup.py (path:/tmp/pip-RRx_4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:31:48 INFO - Running setup.py (path:/tmp/pip-HzFwy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:31:48 INFO - Running setup.py (path:/tmp/pip-gEw01d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:31:48 INFO - Running setup.py (path:/tmp/pip-HZuufV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:31:48 INFO - Running setup.py (path:/tmp/pip-KRrdr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:31:48 INFO - Running setup.py (path:/tmp/pip-0OCzYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:31:49 INFO - Running setup.py (path:/tmp/pip-DVOGzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:31:49 INFO - Running setup.py (path:/tmp/pip-IQWywX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:31:49 INFO - Running setup.py (path:/tmp/pip-v_1WVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:31:49 INFO - Running setup.py (path:/tmp/pip-v5YzkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:31:49 INFO - Running setup.py (path:/tmp/pip-WPafdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:31:49 INFO - Running setup.py (path:/tmp/pip-HrY3Ob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:31:49 INFO - Running setup.py (path:/tmp/pip-PB7Iba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:49 INFO - Running setup.py (path:/tmp/pip-1VQUFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:31:49 INFO - Running setup.py (path:/tmp/pip-Lx9BoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:31:49 INFO - Running setup.py (path:/tmp/pip-CRBHkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:31:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:31:49 INFO - Running setup.py install for manifestparser 11:31:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:31:49 INFO - Running setup.py install for mozcrash 11:31:49 INFO - Running setup.py install for mozdebug 11:31:50 INFO - Running setup.py install for mozdevice 11:31:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:31:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:31:50 INFO - Running setup.py install for mozfile 11:31:50 INFO - Running setup.py install for mozhttpd 11:31:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:31:50 INFO - Running setup.py install for mozinfo 11:31:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:31:50 INFO - Running setup.py install for mozInstall 11:31:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:31:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:31:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:31:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:31:50 INFO - Running setup.py install for mozleak 11:31:50 INFO - Running setup.py install for mozlog 11:31:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:31:50 INFO - Running setup.py install for moznetwork 11:31:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:31:50 INFO - Running setup.py install for mozprocess 11:31:50 INFO - Running setup.py install for mozprofile 11:31:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:31:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:31:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:31:51 INFO - Running setup.py install for mozrunner 11:31:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:31:51 INFO - Running setup.py install for mozscreenshot 11:31:51 INFO - Running setup.py install for moztest 11:31:51 INFO - Running setup.py install for mozversion 11:31:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:31:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:31:51 INFO - Cleaning up... 11:31:51 INFO - Return code: 0 11:31:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:31:51 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')]} 11:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:51 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')]} 11:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:51 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 0x23c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d290>, '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 0x265db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265e040>, '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': '1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094', '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 11:31:51 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 11:31:51 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 11:31:51 INFO - Using env: {'DISPLAY': ':0', 11:31:51 INFO - 'HOME': '/home/cltbld', 11:31:51 INFO - 'LANG': 'en_US.UTF-8', 11:31:51 INFO - 'LANGUAGE': 'en_US:en', 11:31:51 INFO - 'LOGNAME': 'cltbld', 11:31:51 INFO - 'MAIL': '/var/mail/cltbld', 11:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:51 INFO - 'MOZ_NO_REMOTE': '1', 11:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:51 INFO - 'NO_EM_RESTART': '1', 11:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:51 INFO - 'PWD': '/builds/slave/test', 11:31:51 INFO - 'SHELL': '/bin/bash', 11:31:51 INFO - 'SHLVL': '1', 11:31:51 INFO - 'TERM': 'linux', 11:31:51 INFO - 'TMOUT': '86400', 11:31:51 INFO - 'USER': 'cltbld', 11:31:51 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094', 11:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:51 INFO - '_': '/tools/buildbot/bin/python'} 11:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:31:51 INFO - Running setup.py (path:/tmp/pip-QGjy_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:31:51 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)) 11:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:31:51 INFO - Running setup.py (path:/tmp/pip-dEvF9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:31:51 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)) 11:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:31:51 INFO - Running setup.py (path:/tmp/pip-nyX_ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:31:51 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)) 11:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:31:51 INFO - Running setup.py (path:/tmp/pip-63M4zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:31:52 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)) 11:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:31:52 INFO - Running setup.py (path:/tmp/pip-xVmi67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:31:52 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)) 11:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:31:52 INFO - Running setup.py (path:/tmp/pip-Wckj8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:31:52 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)) 11:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:31:52 INFO - Running setup.py (path:/tmp/pip-tA57qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:31:52 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)) 11:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:31:52 INFO - Running setup.py (path:/tmp/pip-QvF5QS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:31:52 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)) 11:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:31:52 INFO - Running setup.py (path:/tmp/pip-5_90Se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:31:52 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)) 11:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:31:52 INFO - Running setup.py (path:/tmp/pip-DSLijD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:31:52 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)) 11:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:31:52 INFO - Running setup.py (path:/tmp/pip-QKcuOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:31:52 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)) 11:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:31:52 INFO - Running setup.py (path:/tmp/pip-mWRZua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:31:52 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)) 11:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:31:52 INFO - Running setup.py (path:/tmp/pip-NHfalC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:31:52 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)) 11:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:31:52 INFO - Running setup.py (path:/tmp/pip-pFIZZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:31:52 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)) 11:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:52 INFO - Running setup.py (path:/tmp/pip-onoZPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:52 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)) 11:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:31:52 INFO - Running setup.py (path:/tmp/pip-xK7xcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:31:52 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)) 11:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:31:52 INFO - Running setup.py (path:/tmp/pip-h2QcHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:31:52 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)) 11:31:52 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)) 11:31:52 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)) 11:31:52 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)) 11:31:52 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)) 11:31:52 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)) 11:31:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:31: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 11:31: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 11:31: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 11:31: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 11:31: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 11:31: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 11:31:54 INFO - Downloading blessings-1.6.tar.gz 11:31:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:31:55 INFO - Installing collected packages: blessings 11:31:55 INFO - Running setup.py install for blessings 11:31:55 INFO - Successfully installed blessings 11:31:55 INFO - Cleaning up... 11:31:55 INFO - Return code: 0 11:31:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:31:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:31:55 INFO - Reading from file tmpfile_stdout 11:31:55 INFO - Current package versions: 11:31:55 INFO - argparse == 1.2.1 11:31:55 INFO - blessings == 1.6 11:31:55 INFO - blobuploader == 1.2.4 11:31:55 INFO - docopt == 0.6.1 11:31:55 INFO - functools32 == 3.2.3-2 11:31:55 INFO - jsonschema == 2.5.1 11:31:55 INFO - manifestparser == 1.1 11:31:55 INFO - mozInstall == 1.12 11:31:55 INFO - mozcrash == 1.0 11:31:55 INFO - mozdebug == 0.1 11:31:55 INFO - mozdevice == 0.49 11:31:55 INFO - mozfile == 1.2 11:31:55 INFO - mozhttpd == 0.7 11:31:55 INFO - mozinfo == 0.9 11:31:55 INFO - mozleak == 0.1 11:31:55 INFO - mozlog == 3.4 11:31:55 INFO - moznetwork == 0.27 11:31:55 INFO - mozprocess == 0.25 11:31:55 INFO - mozprofile == 0.28 11:31:55 INFO - mozrunner == 6.13 11:31:55 INFO - mozscreenshot == 0.1 11:31:55 INFO - mozsystemmonitor == 0.3 11:31:55 INFO - moztest == 0.8 11:31:55 INFO - mozversion == 1.4 11:31:55 INFO - psutil == 3.1.1 11:31:55 INFO - requests == 1.2.3 11:31:55 INFO - wsgiref == 0.1.2 11:31:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:31: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')]} 11:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31: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')]} 11:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:55 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 0x23c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d290>, '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 0x265db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265e040>, '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': '1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094', '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 11:31:55 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 11:31:55 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 11:31:55 INFO - Using env: {'DISPLAY': ':0', 11:31:55 INFO - 'HOME': '/home/cltbld', 11:31:55 INFO - 'LANG': 'en_US.UTF-8', 11:31:55 INFO - 'LANGUAGE': 'en_US:en', 11:31:55 INFO - 'LOGNAME': 'cltbld', 11:31:55 INFO - 'MAIL': '/var/mail/cltbld', 11:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:55 INFO - 'MOZ_NO_REMOTE': '1', 11:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:55 INFO - 'NO_EM_RESTART': '1', 11:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:55 INFO - 'PWD': '/builds/slave/test', 11:31:55 INFO - 'SHELL': '/bin/bash', 11:31:55 INFO - 'SHLVL': '1', 11:31:55 INFO - 'TERM': 'linux', 11:31:55 INFO - 'TMOUT': '86400', 11:31:55 INFO - 'USER': 'cltbld', 11:31:55 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094', 11:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:55 INFO - '_': '/tools/buildbot/bin/python'} 11:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:55 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)) 11:31:55 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)) 11:31:55 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)) 11:31:55 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)) 11:31:55 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)) 11:31:55 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)) 11:31:55 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)) 11:31:55 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)) 11:31:55 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)) 11:31:55 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)) 11:31:55 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)) 11:31:55 INFO - Cleaning up... 11:31:55 INFO - Return code: 0 11:31:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:31: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')]} 11:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31: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')]} 11:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d290>, '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 0x265db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265e040>, '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': '1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094', '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 11:31: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', 'jsonschema'] in /builds/slave/test/build 11:31: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 jsonschema 11:31:55 INFO - Using env: {'DISPLAY': ':0', 11:31:55 INFO - 'HOME': '/home/cltbld', 11:31:55 INFO - 'LANG': 'en_US.UTF-8', 11:31:55 INFO - 'LANGUAGE': 'en_US:en', 11:31:55 INFO - 'LOGNAME': 'cltbld', 11:31:55 INFO - 'MAIL': '/var/mail/cltbld', 11:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:55 INFO - 'MOZ_NO_REMOTE': '1', 11:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:55 INFO - 'NO_EM_RESTART': '1', 11:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:55 INFO - 'PWD': '/builds/slave/test', 11:31:55 INFO - 'SHELL': '/bin/bash', 11:31:55 INFO - 'SHLVL': '1', 11:31:55 INFO - 'TERM': 'linux', 11:31:55 INFO - 'TMOUT': '86400', 11:31:55 INFO - 'USER': 'cltbld', 11:31:55 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094', 11:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:55 INFO - '_': '/tools/buildbot/bin/python'} 11:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:31:55 INFO - Cleaning up... 11:31:55 INFO - Return code: 0 11:31:55 INFO - Running post-action listener: _resource_record_post_action 11:31:55 INFO - Running post-action listener: _start_resource_monitoring 11:31:56 INFO - Starting resource monitoring. 11:31:56 INFO - [mozharness: 2017-03-17 18:31:56.018063Z] Finished create-virtualenv step (success) 11:31:56 INFO - [mozharness: 2017-03-17 18:31:56.018524Z] Running install step. 11:31:56 INFO - Running pre-action listener: _resource_record_pre_action 11:31:56 INFO - Running main action method: install 11:31:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:31:56 INFO - Reading from file tmpfile_stdout 11:31:56 INFO - Detecting whether we're running mozinstall >=1.0... 11:31:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:31:56 INFO - Reading from file tmpfile_stdout 11:31:56 INFO - Output received: 11:31:56 INFO - Usage: mozinstall [options] installer 11:31:56 INFO - Options: 11:31:56 INFO - -h, --help show this help message and exit 11:31:56 INFO - -d DEST, --destination=DEST 11:31:56 INFO - Directory to install application into. [default: 11:31:56 INFO - "/builds/slave/test"] 11:31:56 INFO - --app=APP Application being installed. [default: firefox] 11:31:56 INFO - mkdir: /builds/slave/test/build/application 11:31:56 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'] 11:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:32:11 INFO - Reading from file tmpfile_stdout 11:32:11 INFO - Output received: 11:32:11 INFO - /builds/slave/test/build/application/firefox/firefox 11:32:11 INFO - Running post-action listener: _resource_record_post_action 11:32:11 INFO - [mozharness: 2017-03-17 18:32:11.750626Z] Finished install step (success) 11:32:11 INFO - [mozharness: 2017-03-17 18:32:11.750900Z] Running run-tests step. 11:32:11 INFO - Running pre-action listener: _resource_record_pre_action 11:32:11 INFO - Running main action method: run_tests 11:32:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:32:11 INFO - Python 2.7.3 11:32:11 INFO - Return code: 0 11:32:11 INFO - grabbing minidump binary from tooltool 11:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:11 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 0x265d290>, '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 0x265db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265e040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:32:11 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 11:32:11 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 11:32:11 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 11:32:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:32:11 INFO - Return code: 0 11:32:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:32:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:32:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:32:11 INFO - ENV: RUST_BACKTRACE is now 1 11:32:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:32:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:32:11 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/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 11:32:11 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/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-079 --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 11:32:11 INFO - Using env: {'DISPLAY': ':0', 11:32:11 INFO - 'HOME': '/home/cltbld', 11:32:11 INFO - 'LANG': 'en_US.UTF-8', 11:32:11 INFO - 'LANGUAGE': 'en_US:en', 11:32:11 INFO - 'LOGNAME': 'cltbld', 11:32:11 INFO - 'MAIL': '/var/mail/cltbld', 11:32:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:32:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:11 INFO - 'MOZ_NO_REMOTE': '1', 11:32:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:11 INFO - 'NO_EM_RESTART': '1', 11:32:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:11 INFO - 'PWD': '/builds/slave/test', 11:32:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:32:11 INFO - 'RUST_BACKTRACE': '1', 11:32:11 INFO - 'SHELL': '/bin/bash', 11:32:11 INFO - 'SHLVL': '1', 11:32:11 INFO - 'TERM': 'linux', 11:32:11 INFO - 'TMOUT': '86400', 11:32:11 INFO - 'USER': 'cltbld', 11:32:11 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094', 11:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:11 INFO - '_': '/tools/buildbot/bin/python'} 11:32:11 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/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 11:32:12 INFO - mozversion application_buildid: 20170317180410 11:32:12 INFO - mozversion application_changeset: 23a4b7430dd7e83a2809bf3dc41471f154301eda 11:32:12 INFO - mozversion application_display_name: Nightly 11:32:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:32:12 INFO - mozversion application_name: Firefox 11:32:12 INFO - mozversion application_remotingname: firefox 11:32:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:32:12 INFO - mozversion application_vendor: Mozilla 11:32:12 INFO - mozversion application_version: 55.0a1 11:32:12 INFO - mozversion platform_buildid: 20170317180410 11:32:12 INFO - mozversion platform_changeset: 23a4b7430dd7e83a2809bf3dc41471f154301eda 11:32:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:32:12 INFO - mozversion platform_version: 55.0a1 11:32:12 INFO - using testdate: 1489775532 11:32:12 INFO - actual date: 1489775532 11:32:12 INFO - starting webserver on 'localhost:34809' 11:32:12 INFO - SUITE-START | Running 2 tests 11:32:12 INFO - TEST-START | dromaeo_css 11:32:12 INFO - operating with platform_type : linux_ 11:32:12 INFO - Initialising browser for dromaeo_css test... 11:32:12 INFO - TEST-INFO | started process 3310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJNPYqb/profile http://localhost:34809/getInfo.html) 11:32:17 INFO - PID 3310 | __metrics Screen width/height:1600/1200 11:32:17 INFO - PID 3310 | colorDepth:24 11:32:17 INFO - PID 3310 | Browser inner width/height: 1024/697 11:32:17 INFO - PID 3310 | __metrics 11:32:18 ERROR - PID 3310 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 11:32:19 INFO - TEST-INFO | 3310: exit 0 11:32:19 INFO - Browser initialized. 11:32:19 INFO - Running cycle 1/1 for dromaeo_css test... 11:32:19 INFO - TEST-INFO | started process 3445 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJNPYqb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:32:31 INFO - PID 3445 | RSS: Main: 155336704 11:32:31 INFO - PID 3445 | 11:35:35 INFO - PID 3445 | Cycle 1(1): loaded http://localhost:34809/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34809/tests/dromaeo/cssquery-ext.html) 11:35:37 INFO - PID 3445 | RSS: Main: 165113856 11:35:37 INFO - PID 3445 | 11:37:19 INFO - PID 3445 | ************************* 11:37:19 INFO - PID 3445 | A coding exception was thrown and uncaught in a Task. 11:37:19 INFO - PID 3445 | 11:37:19 ERROR - PID 3445 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:37:19 INFO - PID 3445 | Full stack: 11:37:19 INFO - PID 3445 | ************************* 11:38:40 INFO - PID 3445 | Cycle 1(1): loaded http://localhost:34809/tests/dromaeo/cssquery-ext.html (next: http://localhost:34809/tests/dromaeo/cssquery-jquery.html) 11:38:40 INFO - PID 3445 | RSS: Main: 160788480 11:38:40 INFO - PID 3445 | 11:41:42 INFO - PID 3445 | Cycle 1(1): loaded http://localhost:34809/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34809/tests/dromaeo/cssquery-mootools.html) 11:41:43 INFO - PID 3445 | RSS: Main: 168763392 11:41:43 INFO - PID 3445 | 11:44:45 INFO - PID 3445 | Cycle 1(1): loaded http://localhost:34809/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34809/tests/dromaeo/cssquery-prototype.html) 11:44:45 INFO - PID 3445 | RSS: Main: 160362496 11:44:45 INFO - PID 3445 | 11:47:48 INFO - PID 3445 | Cycle 1(1): loaded http://localhost:34809/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34809/tests/dromaeo/cssquery-yui.html) 11:47:49 INFO - PID 3445 | RSS: Main: 167985152 11:47:49 INFO - PID 3445 | 11:50:52 INFO - PID 3445 | Cycle 1(1): loaded http://localhost:34809/tests/dromaeo/cssquery-yui.html (next: http://localhost:34809/tests/dromaeo/cssquery-dojo.html) 11:50:52 INFO - PID 3445 | RSS: Main: 161497088 11:50:52 INFO - PID 3445 | 11:50:52 INFO - PID 3445 | __start_tp_report 11:50:52 INFO - PID 3445 | _x_x_mozilla_page_load 11:50:52 INFO - PID 3445 | _x_x_mozilla_page_load_details 11:50:52 INFO - PID 3445 | |i|pagename|runs| 11:50:52 INFO - PID 3445 | |0;dojo.html;2683.9731602683974;2704.013035242137;2713.8778754956024;2740.6574178227715;2748.1480740970287;4917.4099108107075;5107.514786095319;5143.305653736745;5170.405403378612;5191.662541934772;4954.777035033423;5084.805070808357;5116.155834287348;5184.922226166611;5189.6107791915565;4646.163690535702;4657.441107067149;4709.670323077386;4711.811527538895;4747.240441529356;4744.217204161327;4762.97618511907;4769.332293478916;4777.784999675023;4826.61387089032;4659.464161621389;4701.7414042227665;4705.811767529295;4710.8351207707565;4723.952760472385;4627.23650597651;4630.21286381316;4630.560096790799;4675.579197872174;4677.573340131258;4544.113897789933;4577.748223847687;4596.839110631112;4613.653975951784;4633.675642705012;4891.804327826882;4976.2038073908;5036.043151801183;5089.160288552384;5103.923441148386;5532.917006244909;5536.833894983157;5547.084731019418;5589.972050139764;5616.98894199044;5570.248016517799;5576.693281869496;5576.888462230773;5580.944190558083;5594;4947.604191664658;4994.600431965434;4998.975210081997;5163.181668611111;5230.686158830406;5455.890882182334;5456.154296084113;5457.792902381624;5480.150576660624;5483.698396588226;5266.078436273637;5401.108817045144;5436.565074794007;5440.374356949002;5443.101888188484;5487.533559647395;5501.972490137524;5529.778808847682;5533.170024496358;5545.61180717354;5488.368837583729;5490.752916118784;5509.118541033416;5517.613767036269;5567.025770490148;5203.895922081537;5273.235380869829;5402.189671549299;5438.048341540294;5466.617336786467;4606.286025666027;4621.23749581322;4625.676202665848;4648.465426475998;4661.463931647836;3949.8025098744947;3968.2460332537303;3978.8607398740905;3978.980105099514;4016.8995775105273;4616.722996620214;4677.95322046782;4788.736619485892;4811.975940120277;4831.830885918976;5556.305461817273;5582.162675598612;5584.888302233932;5598.216249725042;5613.7193140342815;4776.379070720854;4817.421909370898;4818.927716084261;4824.035192961422;4871.269309603517;4766.547178018082;4819.518048195152;4827.662063655581;4942.950570494321;4953.628477864175;5008.499150084962;5009.423916249532;5018.422881368543;5021;5023.598112151092;5299.788008479618;5357.758900849549;5364.38309594386;5371.328583927009;5376.301080859464;5124.1032819257225;5136.717480538607;5177.378714554277;5183.688978661293;5193.143131383279;5386.246652263655;5391.598184471987;5417.106177480671;5431.185322201702;5438.075527160471;5165.251038599307;5514.393416724077;5516.917246241229;5537.972310138584;5575.4424557543925;5159.380874295109;5377.542908852635;5428.56571474289;5440.755166017618;5458.9454105458435;5341.172118321511;5341.679499230058;5376.247325374529;5381.246625472359;5388.030154572215;5233.947660523346;5251.317328747238;5298.788048478018;5311.150215965427;5320.494553017457;5163.896722065462;5230.032443997872;5417.295751552273;5461.1808228766;5462.754176062007;5222.216667499905;5222.817201398085;5228.215767634885;5228.477152284741;5262.789488420573 11:50:52 INFO - PID 3445 | |1;ext.html;633.5153607490271;708.9645517724114;723.7901008707476;785.0461689047805;790.9129995700475;30360.089197324087;31809.840950795242;31841.84079079607;31848.203794905137;31941.041768746916;36981.81509092451;37356.43965340522;37435.438468422995;37591.812040939825;37601.24797504048;7458.7016519339295;7652.1582625911105;7654.732084377048;8980.730578082668;9201.263898888074;9221.492817895047;9332.906670933271;9366.953165234198;9368.063193680646;9370.484623345714;9496.66761663342;9569.473678947656;9583.185429238489;9602.08780165883;9612.519374031306;9477.336586438883;9501.71494855152;9554.808903821955;9567.425954442755;9581.329306948552;9154.954225228832;9257.861132083024;9278.860817087749;9286.907130928672;9303.395279306824;34125.31749365023;34211.486827697605;34298.31403371919;34322.31355372879;34409.483857742154;3363.512290717832;3429.879954201616;3458.8962331130106;3473.70473509752;3488.7034602058857;24769;24831.50336993268;24874.751252487604;24995.250142495755;25654.230373088838;3219.742420606346;3309.4539400998806;3403.710684591813;3417.6411476795074;3423.4864770284407;153935;154970;155034;155564;156012.99999999886;43269.35095973563;43570.346444803356;43634.56365436369;43704.56295437068;43822;45116.548834511894;45370;45501.72491375418;45502.77248613736;45716.77141614271;12950.352482376033;12974.675633109058;13071.411786469442;13092.410841512155;13126.212427254395;10330.896691033144;10383.9480802597;10386.636467723594;10410.219233557362;10471.371717696962;12020.699482512833;13382.93308533451;13384.9214680624;13434.529791457448;13570.59288221355;5462.262594549685;5510.834674959758;5536.833894983157;5579.6652200868075;5586.106223004381;1008.5511947183433;1011.6560369474414;1034.5189486888632;1042.3641578637025;1044.5404022230193;22128.778712212992;22144.778552214593;22203.66694499584;22264.666030009565;22696;1113.560143743217;1114.2979922648678;1125.6027348862226;1133.7222380516826;1140.6521011091531;11210.55157793679;11926.284422934477;11969.401529923469;11972.461239244254;12065.819012714815;224372;224861;225832;226053;226369;30592.23519411988;42421.78789106035;43014.13971720548;43081;43122;1211.3398197982121;1226.7301193737364;1230.44014973187;1235.4872727817856;1264.607971528829;21912.89043554772;22090.33728988133;22991.65512517347;23132.421689457897;23265.418364541023;27061.729382705922;35418.468722969694;36100.27799444049;36177.819110904275;36260.81869590635;165818;166079.16960415122;166370;166378;166953;26175.34561635898;26238;26534.336641584116;26627.866860665574;27993.580096298163;33677.831610841786;33907.66092339045;33951;34617.134571635914;34709.826450867586;28150.155495335173;28353.858230708713;28758.85620571884;29360.41279174447;29385.706142938296;28540.42919141564;28911.42177156403;28950;29800.403991920473;30132.84933575318;28354.2911427216;28795.28011799722;28978.56532151977;29083;29173;25460.745392545836;25940.481190376464;26064.478710425305;27121.593176102768;27144.864275678494;21584.460388490414;21813.890930545247;22721.772782271964;23071.19250826213;23109.19117830868 11:50:52 INFO - PID 3445 | |2;jquery.html;364.19512876542836;393.9409088636704;426.075416346528;434.25741981212127;443.11156131955426;17548.122593870303;18240;19124.713129303072;19297.0351482426;20056.59886802263;18904.258882462036;18950.768200066985;18963.146658400372;19007.61984760304;19011.239550417966;5597.384287728347;5640.520555752766;5763.942360576403;5845.152452894327;5850.707464626773;5719.513841323493;5808.912866306988;5825.970870145643;5831.154482600021;5840.06558950568;5626.690532020737;5810.506106980912;5817.476427121558;5854.76580936762;5872.031114866042;5690.089585666315;5709.514691251248;5717.1995920570735;5734.254546908896;5798.043322851724;5607.2897766181295;5674.886502269973;5677.091665333568;5685.715714214272;5687.459691329317;21845.126194952183;21944.89027554852;22047.448813779625;22167.334979950465;22203.111875525123;2354.7880690737916;2392.736798952114;2401.1115887121878;2403;2407.590709579376;12671.809922851164;13915.512957046556;14003.789943150861;14124.717505649829;14752.778708319383;1924.7497825282624;1944.9513762155918;1956.7358406615067;1961.6763234066361;1972.6942323939813;83998;85438;86766.56616716876;86848.56575717081;87845;16089;16728.414505492492;16832.57918552046;16846.15769211559;17103.48689539316;29199;29328.26679332991;29366.706332936395;29441.263968400963;29493.410131797245;8623.137686231452;8697.826043479221;8758.605862736065;9055.366124371363;9153.313501487415;7151.249118842551;7170.4622153338705;7226.927730722626;7431.479796414199;7442.739504117439;8802.735917922473;8927.464352138762;8968.847476605699;9010.504422256708;9384.624615015324;3429.4684323929832;3439.105832483572;3556;3560.875294493467;4036.6770658347264;787.1105650614883;811.5090370325986;817.1542453560536;824.2128767027474;843.7637461510664;18187.181576829076;19220.231190752493;19292.710609340873;19370.5157371064;19379.90310048469;806.1092492795377;810.5744484145753;819.9549024803574;821.757581513455;826.2646244842095;9937.950310248547;10781.083607893417;10866;10879.673609791718;10902;441006;441770;446304;447558;448468;84167;84739;90069.54965225262;90209;90356.54821725849;1096.9670909872557;1110.8000559899297;1168.3574034281282;1178.793711100554;1179.4869231884159;16728.832711673214;16769.748453772958;18498.982555959552;18584.2566297352;18734.344297949505;40209.39685904772;40612.79693601513;41464.58535414728;42224.36663449989;42719.3592096125;50758.49241507538;52456.21315680344;52868.471315286355;52889.47110528845;52932;10021.549030293509;11192.720181995515;11195.552177913118;11216.439178041228;11312.095032397554;12937.741245175232;13288.604696506727;13425.597232083053;13467.730645386842;13530.93234533821;10811.675649730521;10848.45757712127;11002.834957475485;11232.494537745984;11300.660980170607;10765.30025548337;10956.233063685466;11038.779224415306;11062.446877655924;11297.096232301561;11024.834627480755;11048.889511105108;11055.336679799238;11159.87962287163;11267.661970140909;11111.444427778417;11302.378369189444;11527.76944461123;11567.710807229887;11582.6525204244;10315.226358023328;10437.895621043692;10451.32066415711;10742.355458672504;10800.945995269973 11:50:52 INFO - PID 3445 | |3;mootools.html;1448.898577099602;1448.9275536223192;1473.344361759017;1488.5906375746667;1547.0949494545691;8310.12743661916;8534.146585341463;8998.68504602339;9405.717828465149;9422.90577094228;9190.816183676323;9475.052494750522;9481.47851868147;9499.145076943074;9509.191718703918;2008.4376374615094;2041.591681663666;2043.1725151313742;2043.7649670287958;2048.4673984763995;2000.8499362547793;2038.3069756282862;2042.0912693851242;2042.693595960603;2047.9692804607944;2048.514826750609;2058.032724619434;2070.9378718638463;2079.511314841011;2082.4169232614818;2009.859309848311;2011.2055737983414;2019.2024150460486;2023.5042414608442;2027.523531969986;1900.5058684741928;1923.5287354598074;1985.3944546913185;2033.4916270932267;2033.6136134134467;9352.812943741086;9501.144896959238;9511.57197926095;9516.762080947963;9571.18644915183;4643.8142474300985;4776.47458779534;4794.304825800239;4813.614910807127;4818.879528011793;2577.574700174469;2669.7997650176317;2697.042549894779;2724.0601992312622;2782.040196132331;971.6259240192506;1013.1843865688118;1014.8071866345371;1060.1148041385452;1062.5218651606808;13773.862261377359;13856;13889.236092014935;13925.721485570231;13960.650983725489;3871.245107204068;4124.8556300529335;4187.685923555746;4251.511076226212;4251.766152861561;11543.942280288713;11562.30626162433;11580.420978951019;11581.768364632828;11616.94191529054;4913.091078150554;4937.7777999990085;4942.752862356868;4961.826336078292;4964.429090654548;3810.7141964352786;4013.418054382098;4279.636230920344;4363.149185908717;4371.584699453547;3464.497647841049;3481.3037392521596;3609.5668519777796;3614.1687411894886;3620.8551657933913;1020.3163880200284;1023.6775415744016;1024.0936770957608;1038.85456036155;1039.1219419590434;762.7482930632877;765.6439755513602;775.899133112703;778.4473024152802;788.5465857132057;5300.31095957523;5340.118880384693;5387;5492.5331346835965;5494.395616482184;823.9629216685264;837.7361131243639;841.4572600672532;860.6815478273079;873.2271939333735;3359.4624860022277;3466.4626982817704;3478.1826270826336;3502.8073455959657;3550.3076900004767;11863.88136118645;12187.45156467961;12335.629931102081;12353.567625133257;12355.505779768888;12076.033917286595;12151.75696486083;12157.574484892986;12218.572349967886;12230.938845305895;8805.42764720291;8873.112688731204;8947.686830960885;8992.640294388151;9002.369834111549;5241.554467870121;5289.68261904287;5290.365156181283;5479.643823151482;5527.281453411031;10490.370577765358;10837.783244335227;10889.237753357505;10911.127109831354;10969.616063437741;11030.779384412428;11122.721931951766;11139.554417823521;11155.888441115485;11200.271982321123;6846;7028.4728645352825;7716.961415193113;8004.879926800986;8140.59297035134;8753.080926502626;8965.686200983195;8973.416727912665;8978.640854365753;8987.685431009882;7616.543007419573;7774.222577742406;7783.182765809508;7839.608019599112;7986.600669966362;7813.726519571787;7894.289513943772;7946.483478573874;7973.880391794244;8046.758597242092;6624.90062649051;6656.434203092791;6667.799966001027;6697.129373181455;6724.159480064992;4625.722456652612;4642.489326174051;4660.300954856799;4845.612351011981;4960.057589058068;4677.649176311722;4800.591949684316;4814.662973591955;4860.3681521401995;4989.875253118701 11:50:52 INFO - PID 3445 | |4;prototype.html;380.25280324163015;381.4316668164434;388.80365415465184;390.43582023975347;392.0277711276037;5341.786328546858;5388.084025715628;5398.190271459283;5408.729563521828;5427.213054107157;5038.622103342254;5290.603204759649;5294.735263236832;5297.947020529794;5312.150055991042;4463.085067561142;4468.419105516295;4472.44094488189;4476.12715520472;4484.282514797633;4487.977560112195;4488.932666010012;4489.708168969007;4490.9550904491025;4492.842750503733;4344.674149438789;4416.911661766762;4456.420665313504;4461.196984542781;4464.3080322549895;4384.101259241847;4389;4390.736555806662;4408.228560002003;4420.778961051935;4054.432379466877;4058.7361821481804;4062.3500239961463;4080.5307389650275;4101.200265948141;5091.719955402451;5221.582273418117;5249.580033597341;5260.894782104375;5261.105612045962;5166.943949000017;5168.095583272912;5184.844454666366;5210.114280572312;5214.217867319894;5654.6324488908085;5663.2637757091725;5663.546916246691;5664.2636457260705;5699.601027928046;4467.285234362486;4541.45502539694;4550.249208880531;4558.2251017327135;4559.430071241095;5644.463775941279;5917.970410147965;5944.791932282393;6023.247094113236;6027;4567.931481027787;4705.576498115186;4724.763761811896;4730.894751835469;4734.384530011145;4786.593139583105;4797.18447863864;4807.879803004953;4809.917768502059;4823.43238447499;5064.544191022752;5127.589792816566;5156.355455568054;5177.58579313654;5200.049981257029;5690.715464226855;5708.286464191976;5711.685857277889;5712.685802280831;5714.342850572238;1654.081984498615;1683.9158042097847;1684.9578760531085;1687.5865412973899;1691.3234706117405;1238.0467040378858;1252.9122961392798;1253.6991122130623;1257.9622611321674;1263.595649392204;4986.90026199474;5039.77321020555;5040.067587496325;5047.41954675217;5054.7472626368535;5879.706014699248;5883.764649413975;5901.409859014064;5905.350411454822;5911.9113213301835;4788.784504697297;5004.149294619923;5030.622703297267;5042.949570504321;5048.7728052237;3102.565640810288;3140.528920661919;3144.8427578620976;3149.480335744622;3153.5900332957026;5252.369715634149;5474.151506516497;5504.036793561111;5526.557875369961;5529.557635389159;6009;6036.426539478743;6044.637321760709;6045.123457098696;6054.364291749391;5528.143137813645;5532.806351777668;5536.446355364431;5541.639793413416;5545.916811247835;5801.245838041196;5845.795397161079;5912.674802885883;5931.495822855106;5939.67331796738;5816.214811000461;5837.357890631942;5843.2403787507355;5844.240248767633;5863.885861686266;5262.368515777978;5374.247605335335;5388.622796404214;5488.9725551371985;5531.280933478622;4669.906601868011;4729.196036673842;4729.69256998294;4731.391326948854;4749;5759.94240057594;5857.4435428634215;5921.911171332347;5949.702514874326;5967.46292833647;5698.800541981011;5700.572457065819;5717.285339332583;5727.484526392478;5739;5674.716264186856;5717.656940583578;5726.198332233407;5726.370099289158;5732.426757324234;5456.399796022513;5594.98539070509;5627;5636.182753500638;5658.830235092953;5742.971285143548;5764.7405866736935;5777.740001700017;5791.565632577489;5798.217240672624;5278.706716854395;5589.608727389043;5605.103183490622;5614.54021954303;5620.85947851307 11:50:52 INFO - PID 3445 | |5;yui.html;615.8645098078421;651.7197605029842;679.1714108787279;688.9242183359829;696.4950410952059;12797.23216607003;13033.34833258338;13394.464221431132;13417.664558386045;13492.392842322106;13696.794548081787;13755.312234388266;13831.585052448418;13923.58229253124;13961.232132232723;822.2805045585098;838.6645341863273;847.7075408983891;851.8551846186132;866.2117473099481;879.0725784297564;879.5646155153208;879.9428037177563;880.1330689271094;881.5944665453899;904.1275169461468;907.0158877617793;907.6051917415912;907.859281811317;908.3550679017873;893.1068931068932;894.7047474333455;899.2715900120922;899.9550022498914;901.6708901251062;664.0371461381017;665.6838001949084;665.7037618259876;666.1539844397588;667.0661074495696;13131.409086591126;13674.453021879113;14513.129212247193;14701.338439770236;14769.040012399268;12521.93739031299;13196.274204918725;13304.06871518994;13356.265405402699;13502;9658.855117173249;9732.41605503665;9757.26820488459;9902.554385052617;10462;3234.1429521176906;3265.510173473998;3380.8478618462227;3389.2374215801246;3395.9660403395897;66348;67655.66172169156;68547.31452685459;70076.64961675159;70330.29669703289;10682.51928663212;10782;10803.243772935975;10919.508622111865;11364.431778411046;18152.364667236583;18881.055947202585;22092.55814883693;22160;22515.54968900613;6704.798856034229;6911.5853048817235;6948.131483564554;7021.368076873106;7151.713931442788;3446.551948246712;3581.3016461789703;3623.3115708015393;3625.2930678517964;3652.7443078984747;2815.9296017599313;2853.9143825685264;2864.7135286471184;2874.2814296425895;2880.7551358134792;484.60020483101584;486.54264990908433;488.5944665927272;495.07421122501154;497.30625777040825;579.8405438504445;602.7257597792993;619.495111484148;619.8729260501586;624.7594676049663;8390.664373425117;8621.78445538854;8674.479531228146;9127.402704526681;9257.213136883305;624.6533174088424;635.8346829824186;636.3032479435011;640.1581919775573;641.6150309814075;4170.311898536707;4179.384363716188;4365.105153443536;4435.090806384684;4469.575390337913;58565.41434585685;59028;60255;60956.695216524524;61719.07421388683;44476.77761611236;46676.5332346679;49457.752711236215;52182.739086304326;52207.477925220264;45765.31352029722;46507.06985860264;46919.530804691516;46936.29595556138;47117.293240601415;9191.77020574491;9604.727381070668;9737.367071140354;9771.120599145826;9848.803023939337;31630.36739265248;31773.841130794197;32110.51834222442;32847.507287391185;32875.17812054718;38184.618153818104;38717.806410967765;39170.80414597909;39465.802670986464;40046.1990760189;11306.208565400342;11727.47226374798;11731.706707332043;11821.290722556674;11874.346910919638;12609.684757881127;12609.87390126087;12678.619641410773;13005.609831704685;13240.735185296433;11015.173861960546;11412.258203216765;11537.250078744855;11558.884411155781;11741.354225517336;11149.777004459704;11163.553457861595;11551.42242887869;11666.824997624874;11828.645140645795;11669.35818529989;11739.823902641296;11787.646370608896;11922.463489142836;11972.820407694066;9643.517824108627;9953.900460995297;10357.611532186012;10416;10585.470726463493;8635.611397487002;9186.678466253648;9189.724308270763;9838.212942964688;9900.50497475109 11:50:52 INFO - PID 3445 | __end_tp_report 11:50:52 INFO - PID 3445 | __start_cc_report 11:50:52 INFO - PID 3445 | _x_x_mozilla_cycle_collect,400 11:50:52 INFO - PID 3445 | __end_cc_report 11:50:52 INFO - PID 3445 | __startTimestamp1489776652632__endTimestamp 11:50:52 INFO - PID 3445 | 11:50:52 INFO - PID 3445 | ------- Summary: start ------- 11:50:52 INFO - PID 3445 | Number of tests: 6 11:50:52 INFO - PID 3445 | 11:50:52 INFO - PID 3445 | [#0] dojo.html Cycles:165 Average:5044.42 Median:5183.69 stddev:558.00 (10.8%) stddev-sans-first:528.09 11:50:52 INFO - PID 3445 | Values: 2684.0 2704.0 2713.9 2740.7 2748.1 4917.4 5107.5 5143.3 5170.4 5191.7 4954.8 5084.8 5116.2 5184.9 5189.6 4646.2 4657.4 4709.7 4711.8 4747.2 4744.2 4763.0 4769.3 4777.8 4826.6 4659.5 4701.7 4705.8 4710.8 4724.0 4627.2 4630.2 4630.6 4675.6 4677.6 4544.1 4577.7 4596.8 4613.7 4633.7 4891.8 4976.2 5036.0 5089.2 5103.9 5532.9 5536.8 5547.1 5590.0 5617.0 5570.2 5576.7 5576.9 5580.9 5594.0 4947.6 4994.6 4999.0 5163.2 5230.7 5455.9 5456.2 5457.8 5480.2 5483.7 5266.1 5401.1 5436.6 5440.4 5443.1 5487.5 5502.0 5529.8 5533.2 5545.6 5488.4 5490.8 5509.1 5517.6 5567.0 5203.9 5273.2 5402.2 5438.0 5466.6 4606.3 4621.2 4625.7 4648.5 4661.5 3949.8 3968.2 3978.9 3979.0 4016.9 4616.7 4678.0 4788.7 4812.0 4831.8 5556.3 5582.2 5584.9 5598.2 5613.7 4776.4 4817.4 4818.9 4824.0 4871.3 4766.5 4819.5 4827.7 4943.0 4953.6 5008.5 5009.4 5018.4 5021.0 5023.6 5299.8 5357.8 5364.4 5371.3 5376.3 5124.1 5136.7 5177.4 5183.7 5193.1 5386.2 5391.6 5417.1 5431.2 5438.1 5165.3 5514.4 5516.9 5538.0 5575.4 5159.4 5377.5 5428.6 5440.8 5458.9 5341.2 5341.7 5376.2 5381.2 5388.0 5233.9 5251.3 5298.8 5311.2 5320.5 5163.9 5230.0 5417.3 5461.2 5462.8 5222.2 5222.8 5228.2 5228.5 5262.8 11:50:52 INFO - PID 3445 | 11:50:52 INFO - PID 3445 | [#1] ext.html Cycles:180 Average:33089.78 Median:29128.00 stddev:47813.35 (164.1%) stddev-sans-first:47885.37 11:50:52 INFO - PID 3445 | Values: 633.5 709.0 723.8 785.0 790.9 30360.1 31809.8 31841.8 31848.2 31941.0 36981.8 37356.4 37435.4 37591.8 37601.2 7458.7 7652.2 7654.7 8980.7 9201.3 9221.5 9332.9 9367.0 9368.1 9370.5 9496.7 9569.5 9583.2 9602.1 9612.5 9477.3 9501.7 9554.8 9567.4 9581.3 9155.0 9257.9 9278.9 9286.9 9303.4 34125.3 34211.5 34298.3 34322.3 34409.5 3363.5 3429.9 3458.9 3473.7 3488.7 24769.0 24831.5 24874.8 24995.3 25654.2 3219.7 3309.5 3403.7 3417.6 3423.5 153935.0 154970.0 155034.0 155564.0 156013.0 43269.4 43570.3 43634.6 43704.6 43822.0 45116.5 45370.0 45501.7 45502.8 45716.8 12950.4 12974.7 13071.4 13092.4 13126.2 10330.9 10383.9 10386.6 10410.2 10471.4 12020.7 13382.9 13384.9 13434.5 13570.6 5462.3 5510.8 5536.8 5579.7 5586.1 1008.6 1011.7 1034.5 1042.4 1044.5 22128.8 22144.8 22203.7 22264.7 22696.0 1113.6 1114.3 1125.6 1133.7 1140.7 11210.6 11926.3 11969.4 11972.5 12065.8 224372.0 224861.0 225832.0 226053.0 226369.0 30592.2 42421.8 43014.1 43081.0 43122.0 1211.3 1226.7 1230.4 1235.5 1264.6 21912.9 22090.3 22991.7 23132.4 23265.4 27061.7 35418.5 36100.3 36177.8 36260.8 165818.0 166079.2 166370.0 166378.0 166953.0 26175.3 26238.0 26534.3 26627.9 27993.6 33677.8 33907.7 33951.0 34617.1 34709.8 28150.2 28353.9 28758.9 29360.4 29385.7 28540.4 28911.4 28950.0 29800.4 30132.8 28354.3 28795.3 28978.6 29083.0 29173.0 25460.7 25940.5 26064.5 27121.6 27144.9 21584.5 21813.9 22721.8 23071.2 23109.2 11:50:52 INFO - PID 3445 | 11:50:52 INFO - PID 3445 | [#2] jquery.html Cycles:180 Average:28469.55 Median:29347.49 stddev:73452.21 (250.3%) stddev-sans-first:73627.95 11:50:52 INFO - PID 3445 | Values: 364.2 393.9 426.1 434.3 443.1 17548.1 18240.0 19124.7 19297.0 20056.6 18904.3 18950.8 18963.1 19007.6 19011.2 5597.4 5640.5 5763.9 5845.2 5850.7 5719.5 5808.9 5826.0 5831.2 5840.1 5626.7 5810.5 5817.5 5854.8 5872.0 5690.1 5709.5 5717.2 5734.3 5798.0 5607.3 5674.9 5677.1 5685.7 5687.5 21845.1 21944.9 22047.4 22167.3 22203.1 2354.8 2392.7 2401.1 2403.0 2407.6 12671.8 13915.5 14003.8 14124.7 14752.8 1924.7 1945.0 1956.7 1961.7 1972.7 83998.0 85438.0 86766.6 86848.6 87845.0 16089.0 16728.4 16832.6 16846.2 17103.5 29199.0 29328.3 29366.7 29441.3 29493.4 8623.1 8697.8 8758.6 9055.4 9153.3 7151.2 7170.5 7226.9 7431.5 7442.7 8802.7 8927.5 8968.8 9010.5 9384.6 3429.5 3439.1 3556.0 3560.9 4036.7 787.1 811.5 817.2 824.2 843.8 18187.2 19220.2 19292.7 19370.5 19379.9 806.1 810.6 820.0 821.8 826.3 9938.0 10781.1 10866.0 10879.7 10902.0 441006.0 441770.0 446304.0 447558.0 448468.0 84167.0 84739.0 90069.5 90209.0 90356.5 1097.0 1110.8 1168.4 1178.8 1179.5 16728.8 16769.7 18499.0 18584.3 18734.3 40209.4 40612.8 41464.6 42224.4 42719.4 50758.5 52456.2 52868.5 52889.5 52932.0 10021.5 11192.7 11195.6 11216.4 11312.1 12937.7 13288.6 13425.6 13467.7 13530.9 10811.7 10848.5 11002.8 11232.5 11300.7 10765.3 10956.2 11038.8 11062.4 11297.1 11024.8 11048.9 11055.3 11159.9 11267.7 11111.4 11302.4 11527.8 11567.7 11582.7 10315.2 10437.9 10451.3 10742.4 10800.9 11:50:52 INFO - PID 3445 | 11:50:52 INFO - PID 3445 | [#3] mootools.html Cycles:180 Average:5856.51 Median:4265.70 stddev:3804.49 (89.2%) stddev-sans-first:3800.75 11:50:52 INFO - PID 3445 | Values: 1448.9 1448.9 1473.3 1488.6 1547.1 8310.1 8534.1 8998.7 9405.7 9422.9 9190.8 9475.1 9481.5 9499.1 9509.2 2008.4 2041.6 2043.2 2043.8 2048.5 2000.8 2038.3 2042.1 2042.7 2048.0 2048.5 2058.0 2070.9 2079.5 2082.4 2009.9 2011.2 2019.2 2023.5 2027.5 1900.5 1923.5 1985.4 2033.5 2033.6 9352.8 9501.1 9511.6 9516.8 9571.2 4643.8 4776.5 4794.3 4813.6 4818.9 2577.6 2669.8 2697.0 2724.1 2782.0 971.6 1013.2 1014.8 1060.1 1062.5 13773.9 13856.0 13889.2 13925.7 13960.7 3871.2 4124.9 4187.7 4251.5 4251.8 11543.9 11562.3 11580.4 11581.8 11616.9 4913.1 4937.8 4942.8 4961.8 4964.4 3810.7 4013.4 4279.6 4363.1 4371.6 3464.5 3481.3 3609.6 3614.2 3620.9 1020.3 1023.7 1024.1 1038.9 1039.1 762.7 765.6 775.9 778.4 788.5 5300.3 5340.1 5387.0 5492.5 5494.4 824.0 837.7 841.5 860.7 873.2 3359.5 3466.5 3478.2 3502.8 3550.3 11863.9 12187.5 12335.6 12353.6 12355.5 12076.0 12151.8 12157.6 12218.6 12230.9 8805.4 8873.1 8947.7 8992.6 9002.4 5241.6 5289.7 5290.4 5479.6 5527.3 10490.4 10837.8 10889.2 10911.1 10969.6 11030.8 11122.7 11139.6 11155.9 11200.3 6846.0 7028.5 7717.0 8004.9 8140.6 8753.1 8965.7 8973.4 8978.6 8987.7 7616.5 7774.2 7783.2 7839.6 7986.6 7813.7 7894.3 7946.5 7973.9 8046.8 6624.9 6656.4 6667.8 6697.1 6724.2 4625.7 4642.5 4660.3 4845.6 4960.1 4677.6 4800.6 4814.7 4860.4 4989.9 11:50:52 INFO - PID 3445 | 11:50:52 INFO - PID 3445 | [#4] prototype.html Cycles:180 Average:4857.51 Median:5261.00 stddev:1304.35 (24.8%) stddev-sans-first:1263.97 11:50:52 INFO - PID 3445 | Values: 380.3 381.4 388.8 390.4 392.0 5341.8 5388.1 5398.2 5408.7 5427.2 5038.6 5290.6 5294.7 5297.9 5312.2 4463.1 4468.4 4472.4 4476.1 4484.3 4488.0 4488.9 4489.7 4491.0 4492.8 4344.7 4416.9 4456.4 4461.2 4464.3 4384.1 4389.0 4390.7 4408.2 4420.8 4054.4 4058.7 4062.4 4080.5 4101.2 5091.7 5221.6 5249.6 5260.9 5261.1 5166.9 5168.1 5184.8 5210.1 5214.2 5654.6 5663.3 5663.5 5664.3 5699.6 4467.3 4541.5 4550.2 4558.2 4559.4 5644.5 5918.0 5944.8 6023.2 6027.0 4567.9 4705.6 4724.8 4730.9 4734.4 4786.6 4797.2 4807.9 4809.9 4823.4 5064.5 5127.6 5156.4 5177.6 5200.0 5690.7 5708.3 5711.7 5712.7 5714.3 1654.1 1683.9 1685.0 1687.6 1691.3 1238.0 1252.9 1253.7 1258.0 1263.6 4986.9 5039.8 5040.1 5047.4 5054.7 5879.7 5883.8 5901.4 5905.4 5911.9 4788.8 5004.1 5030.6 5042.9 5048.8 3102.6 3140.5 3144.8 3149.5 3153.6 5252.4 5474.2 5504.0 5526.6 5529.6 6009.0 6036.4 6044.6 6045.1 6054.4 5528.1 5532.8 5536.4 5541.6 5545.9 5801.2 5845.8 5912.7 5931.5 5939.7 5816.2 5837.4 5843.2 5844.2 5863.9 5262.4 5374.2 5388.6 5489.0 5531.3 4669.9 4729.2 4729.7 4731.4 4749.0 5759.9 5857.4 5921.9 5949.7 5967.5 5698.8 5700.6 5717.3 5727.5 5739.0 5674.7 5717.7 5726.2 5726.4 5732.4 5456.4 5595.0 5627.0 5636.2 5658.8 5743.0 5764.7 5777.7 5791.6 5798.2 5278.7 5589.6 5605.1 5614.5 5620.9 11:50:52 INFO - PID 3445 | 11:50:52 INFO - PID 3445 | [#5] yui.html Cycles:180 Average:14349.32 Median:46136.19 stddev:17230.74 (37.3%) stddev-sans-first:17248.21 11:50:52 INFO - PID 3445 | Values: 615.9 651.7 679.2 688.9 696.5 12797.2 13033.3 13394.5 13417.7 13492.4 13696.8 13755.3 13831.6 13923.6 13961.2 822.3 838.7 847.7 851.9 866.2 879.1 879.6 879.9 880.1 881.6 904.1 907.0 907.6 907.9 908.4 893.1 894.7 899.3 900.0 901.7 664.0 665.7 665.7 666.2 667.1 13131.4 13674.5 14513.1 14701.3 14769.0 12521.9 13196.3 13304.1 13356.3 13502.0 9658.9 9732.4 9757.3 9902.6 10462.0 3234.1 3265.5 3380.8 3389.2 3396.0 66348.0 67655.7 68547.3 70076.6 70330.3 10682.5 10782.0 10803.2 10919.5 11364.4 18152.4 18881.1 22092.6 22160.0 22515.5 6704.8 6911.6 6948.1 7021.4 7151.7 3446.6 3581.3 3623.3 3625.3 3652.7 2815.9 2853.9 2864.7 2874.3 2880.8 484.6 486.5 488.6 495.1 497.3 579.8 602.7 619.5 619.9 624.8 8390.7 8621.8 8674.5 9127.4 9257.2 624.7 635.8 636.3 640.2 641.6 4170.3 4179.4 4365.1 4435.1 4469.6 58565.4 59028.0 60255.0 60956.7 61719.1 44476.8 46676.5 49457.8 52182.7 52207.5 45765.3 46507.1 46919.5 46936.3 47117.3 9191.8 9604.7 9737.4 9771.1 9848.8 31630.4 31773.8 32110.5 32847.5 32875.2 38184.6 38717.8 39170.8 39465.8 40046.2 11306.2 11727.5 11731.7 11821.3 11874.3 12609.7 12609.9 12678.6 13005.6 13240.7 11015.2 11412.3 11537.3 11558.9 11741.4 11149.8 11163.6 11551.4 11666.8 11828.6 11669.4 11739.8 11787.6 11922.5 11972.8 9643.5 9953.9 10357.6 10416.0 10585.5 8635.6 9186.7 9189.7 9838.2 9900.5 11:50:52 INFO - PID 3445 | -------- Summary: end -------- 11:50:52 INFO - PID 3445 | 11:50:53 INFO - TEST-INFO | 3445: exit 0 11:50:53 INFO - TEST-OK | dromaeo_css | took 1121354ms 11:50:53 INFO - TEST-START | kraken 11:50:53 INFO - operating with platform_type : linux_ 11:50:53 INFO - Initialising browser for kraken test... 11:50:53 INFO - TEST-INFO | started process 3822 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjodQhP/profile http://localhost:34809/getInfo.html) 11:50:58 INFO - PID 3822 | __metrics Screen width/height:1600/1200 11:50:58 INFO - PID 3822 | colorDepth:24 11:50:58 INFO - PID 3822 | Browser inner width/height: 1024/697 11:50:58 INFO - PID 3822 | __metrics 11:50:58 ERROR - PID 3822 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 11:50:59 INFO - TEST-INFO | 3822: exit 0 11:50:59 INFO - Browser initialized. 11:50:59 INFO - Running cycle 1/1 for kraken test... 11:50:59 INFO - TEST-INFO | started process 3954 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjodQhP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:51:12 INFO - PID 3954 | RSS: Main: 154935296 11:51:12 INFO - PID 3954 | 11:51:14 INFO - PID 3954 | Cycle 1(1): loaded http://localhost:34809/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34809/tests/kraken/driver.html?testName=audio-beat-detection) 11:51:15 INFO - PID 3954 | RSS: Main: 160944128 11:51:15 INFO - PID 3954 | 11:51:18 INFO - PID 3954 | Cycle 1(1): loaded http://localhost:34809/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34809/tests/kraken/driver.html?testName=audio-dft) 11:51:19 INFO - PID 3954 | RSS: Main: 160604160 11:51:19 INFO - PID 3954 | 11:51:22 INFO - PID 3954 | Cycle 1(1): loaded http://localhost:34809/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34809/tests/kraken/driver.html?testName=audio-fft) 11:51:22 INFO - PID 3954 | RSS: Main: 157208576 11:51:22 INFO - PID 3954 | 11:51:24 INFO - PID 3954 | Cycle 1(1): loaded http://localhost:34809/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34809/tests/kraken/driver.html?testName=audio-oscillator) 11:51:25 INFO - PID 3954 | RSS: Main: 157900800 11:51:25 INFO - PID 3954 | 11:51:27 INFO - PID 3954 | Cycle 1(1): loaded http://localhost:34809/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34809/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:51:28 INFO - PID 3954 | RSS: Main: 158642176 11:51:28 INFO - PID 3954 | 11:51:31 INFO - PID 3954 | Cycle 1(1): loaded http://localhost:34809/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34809/tests/kraken/driver.html?testName=imaging-darkroom) 11:51:32 INFO - PID 3954 | RSS: Main: 164130816 11:51:32 INFO - PID 3954 | 11:51:35 INFO - PID 3954 | Cycle 1(1): loaded http://localhost:34809/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34809/tests/kraken/driver.html?testName=imaging-desaturate) 11:51:36 INFO - PID 3954 | RSS: Main: 161185792 11:51:36 INFO - PID 3954 | 11:51:39 INFO - PID 3954 | Cycle 1(1): loaded http://localhost:34809/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34809/tests/kraken/driver.html?testName=json-parse-financial) 11:51:39 INFO - PID 3954 | RSS: Main: 161869824 11:51:39 INFO - PID 3954 | 11:51:41 INFO - PID 3954 | Cycle 1(1): loaded http://localhost:34809/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34809/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:51:42 INFO - PID 3954 | RSS: Main: 162627584 11:51:42 INFO - PID 3954 | 11:51:44 INFO - PID 3954 | Cycle 1(1): loaded http://localhost:34809/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34809/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:51:44 INFO - PID 3954 | RSS: Main: 162381824 11:51:44 INFO - PID 3954 | 11:51:46 INFO - PID 3954 | Cycle 1(1): loaded http://localhost:34809/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34809/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:51:47 INFO - PID 3954 | RSS: Main: 163237888 11:51:47 INFO - PID 3954 | 11:51:50 INFO - PID 3954 | Cycle 1(1): loaded http://localhost:34809/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34809/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:51:51 INFO - PID 3954 | RSS: Main: 163676160 11:51:51 INFO - PID 3954 | 11:51:54 INFO - PID 3954 | Cycle 1(1): loaded http://localhost:34809/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34809/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:51:55 INFO - PID 3954 | RSS: Main: 163020800 11:51:55 INFO - PID 3954 | 11:51:56 INFO - PID 3954 | Cycle 1(1): loaded http://localhost:34809/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34809/tests/kraken/driver.html?testName=ai-astar) 11:51:57 INFO - PID 3954 | RSS: Main: 164773888 11:51:57 INFO - PID 3954 | 11:51:57 INFO - PID 3954 | __start_tp_report 11:51:57 INFO - PID 3954 | _x_x_mozilla_page_load 11:51:57 INFO - PID 3954 | _x_x_mozilla_page_load_details 11:51:57 INFO - PID 3954 | |i|pagename|runs| 11:51:57 INFO - PID 3954 | |0;ai-astar;111;119;120;118;123;118;117;118;118;117 11:51:57 INFO - PID 3954 | |1;audio-beat-detection;159;134;126;168;127;127;126;127;156;128 11:51:57 INFO - PID 3954 | |2;audio-dft;163;164;164;171;167;169;165;163;162;164 11:51:57 INFO - PID 3954 | |3;audio-fft;75;75;75;125;77;75;75;75;92;76 11:51:57 INFO - PID 3954 | |4;audio-oscillator;85;83;111;85;85;84;99;84;86;110 11:51:57 INFO - PID 3954 | |5;imaging-gaussian-blur;114;115;115;114;114;119;114;114;114;115 11:51:57 INFO - PID 3954 | |6;imaging-darkroom;150;149;150;150;149;151;151;151;151;150 11:51:57 INFO - PID 3954 | |7;imaging-desaturate;96;94;95;94;95;95;94;95;94;94 11:51:57 INFO - PID 3954 | |8;json-parse-financial;69;67;68;69;71;69;69;71;68;68 11:51:57 INFO - PID 3954 | |9;json-stringify-tinderbox;56;55;56;56;57;56;56;55;55;56 11:51:57 INFO - PID 3954 | |10;stanford-crypto-aes;83;84;83;84;91;82;83;82;81;80 11:51:57 INFO - PID 3954 | |11;stanford-crypto-ccm;136;138;135;136;132;136;133;136;238;139 11:51:57 INFO - PID 3954 | |12;stanford-crypto-pbkdf2;189;197;195;198;194;193;195;196;193;191 11:51:57 INFO - PID 3954 | |13;stanford-crypto-sha256-iterative;74;73;73;70;70;71;73;70;69;72 11:51:57 INFO - PID 3954 | __end_tp_report 11:51:57 INFO - PID 3954 | __start_cc_report 11:51:57 INFO - PID 3954 | _x_x_mozilla_cycle_collect,882 11:51:57 INFO - PID 3954 | __end_cc_report 11:51:57 INFO - PID 3954 | __startTimestamp1489776717077__endTimestamp 11:51:57 INFO - PID 3954 | 11:51:57 INFO - PID 3954 | ------- Summary: start ------- 11:51:57 INFO - PID 3954 | Number of tests: 14 11:51:57 INFO - PID 3954 | 11:51:57 INFO - PID 3954 | [#0] ai-astar Cycles:10 Average:117.90 Median:118.00 stddev:3.00 (2.5%) stddev-sans-first:1.87 11:51:57 INFO - PID 3954 | Values: 111.0 119.0 120.0 118.0 123.0 118.0 117.0 118.0 118.0 117.0 11:51:57 INFO - PID 3954 | 11:51:57 INFO - PID 3954 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:131.00 stddev:16.44 (12.5%) stddev-sans-first:15.54 11:51:57 INFO - PID 3954 | Values: 159.0 134.0 126.0 168.0 127.0 127.0 126.0 127.0 156.0 128.0 11:51:57 INFO - PID 3954 | 11:51:57 INFO - PID 3954 | [#2] audio-dft Cycles:10 Average:165.20 Median:164.50 stddev:2.90 (1.8%) stddev-sans-first:2.96 11:51:57 INFO - PID 3954 | Values: 163.0 164.0 164.0 171.0 167.0 169.0 165.0 163.0 162.0 164.0 11:51:57 INFO - PID 3954 | 11:51:57 INFO - PID 3954 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.00 stddev:16.00 (21.3%) stddev-sans-first:16.77 11:51:57 INFO - PID 3954 | Values: 75.0 75.0 75.0 125.0 77.0 75.0 75.0 75.0 92.0 76.0 11:51:57 INFO - PID 3954 | 11:51:57 INFO - PID 3954 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:85.00 stddev:11.15 (13.1%) stddev-sans-first:11.60 11:51:57 INFO - PID 3954 | Values: 85.0 83.0 111.0 85.0 85.0 84.0 99.0 84.0 86.0 110.0 11:51:57 INFO - PID 3954 | 11:51:57 INFO - PID 3954 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:114.50 stddev:1.55 (1.4%) stddev-sans-first:1.62 11:51:57 INFO - PID 3954 | Values: 114.0 115.0 115.0 114.0 114.0 119.0 114.0 114.0 114.0 115.0 11:51:57 INFO - PID 3954 | 11:51:57 INFO - PID 3954 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:150.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 11:51:57 INFO - PID 3954 | Values: 150.0 149.0 150.0 150.0 149.0 151.0 151.0 151.0 151.0 150.0 11:51:57 INFO - PID 3954 | 11:51:57 INFO - PID 3954 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.53 11:51:57 INFO - PID 3954 | Values: 96.0 94.0 95.0 94.0 95.0 95.0 94.0 95.0 94.0 94.0 11:51:57 INFO - PID 3954 | 11:51:57 INFO - PID 3954 | [#8] json-parse-financial Cycles:10 Average:68.90 Median:69.00 stddev:1.29 (1.9%) stddev-sans-first:1.36 11:51:57 INFO - PID 3954 | Values: 69.0 67.0 68.0 69.0 71.0 69.0 69.0 71.0 68.0 68.0 11:51:57 INFO - PID 3954 | 11:51:57 INFO - PID 3954 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:56.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 11:51:57 INFO - PID 3954 | Values: 56.0 55.0 56.0 56.0 57.0 56.0 56.0 55.0 55.0 56.0 11:51:57 INFO - PID 3954 | 11:51:57 INFO - PID 3954 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.00 stddev:2.98 (3.6%) stddev-sans-first:3.16 11:51:57 INFO - PID 3954 | Values: 83.0 84.0 83.0 84.0 91.0 82.0 83.0 82.0 81.0 80.0 11:51:57 INFO - PID 3954 | 11:51:57 INFO - PID 3954 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:136.00 stddev:32.43 (23.8%) stddev-sans-first:34.19 11:51:57 INFO - PID 3954 | Values: 136.0 138.0 135.0 136.0 132.0 136.0 133.0 136.0 238.0 139.0 11:51:57 INFO - PID 3954 | 11:51:57 INFO - PID 3954 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.10 Median:195.00 stddev:2.73 (1.4%) stddev-sans-first:2.18 11:51:57 INFO - PID 3954 | Values: 189.0 197.0 195.0 198.0 194.0 193.0 195.0 196.0 193.0 191.0 11:51:57 INFO - PID 3954 | 11:51:57 INFO - PID 3954 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:72.50 stddev:1.72 (2.4%) stddev-sans-first:1.56 11:51:57 INFO - PID 3954 | Values: 74.0 73.0 73.0 70.0 70.0 71.0 73.0 70.0 69.0 72.0 11:51:57 INFO - PID 3954 | -------- Summary: end -------- 11:51:57 INFO - PID 3954 | 11:51:58 INFO - TEST-INFO | 3954: exit 0 11:51:58 INFO - TEST-OK | kraken | took 65037ms 11:51:58 INFO - SUITE-END | took 1186s 11:51:58 INFO - Completed test suite (00:19:46) 11:51:58 INFO - javascript benchmark 11:51:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6785.38960198931, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2683.9731602683974, 2704.013035242137, 2713.8778754956024, 2740.6574178227715, 2748.1480740970287, 4917.4099108107075, 5107.514786095319, 5143.305653736745, 5170.405403378612, 5191.662541934772, 4954.777035033423, 5084.805070808357, 5116.155834287348, 5184.922226166611, 5189.6107791915565, 4646.163690535702, 4657.441107067149, 4709.670323077386, 4711.811527538895, 4747.240441529356, 4744.217204161327, 4762.97618511907, 4769.332293478916, 4777.784999675023, 4826.61387089032, 4659.464161621389, 4701.7414042227665, 4705.811767529295, 4710.8351207707565, 4723.952760472385, 4627.23650597651, 4630.21286381316, 4630.560096790799, 4675.579197872174, 4677.573340131258, 4544.113897789933, 4577.748223847687, 4596.839110631112, 4613.653975951784, 4633.675642705012, 4891.804327826882, 4976.2038073908, 5036.043151801183, 5089.160288552384, 5103.923441148386, 5532.917006244909, 5536.833894983157, 5547.084731019418, 5589.972050139764, 5616.98894199044, 5570.248016517799, 5576.693281869496, 5576.888462230773, 5580.944190558083, 5594.0, 4947.604191664658, 4994.600431965434, 4998.975210081997, 5163.181668611111, 5230.686158830406, 5455.890882182334, 5456.154296084113, 5457.792902381624, 5480.150576660624, 5483.698396588226, 5266.078436273637, 5401.108817045144, 5436.565074794007, 5440.374356949002, 5443.101888188484, 5487.533559647395, 5501.972490137524, 5529.778808847682, 5533.170024496358, 5545.61180717354, 5488.368837583729, 5490.752916118784, 5509.118541033416, 5517.613767036269, 5567.025770490148, 5203.895922081537, 5273.235380869829, 5402.189671549299, 5438.048341540294, 5466.617336786467, 4606.286025666027, 4621.23749581322, 4625.676202665848, 4648.465426475998, 4661.463931647836, 3949.8025098744947, 3968.2460332537303, 3978.8607398740905, 3978.980105099514, 4016.8995775105273, 4616.722996620214, 4677.95322046782, 4788.736619485892, 4811.975940120277, 4831.830885918976, 5556.305461817273, 5582.162675598612, 5584.888302233932, 5598.216249725042, 5613.7193140342815, 4776.379070720854, 4817.421909370898, 4818.927716084261, 4824.035192961422, 4871.269309603517, 4766.547178018082, 4819.518048195152, 4827.662063655581, 4942.950570494321, 4953.628477864175, 5008.499150084962, 5009.423916249532, 5018.422881368543, 5021.0, 5023.598112151092, 5299.788008479618, 5357.758900849549, 5364.38309594386, 5371.328583927009, 5376.301080859464, 5124.1032819257225, 5136.717480538607, 5177.378714554277, 5183.688978661293, 5193.143131383279, 5386.246652263655, 5391.598184471987, 5417.106177480671, 5431.185322201702, 5438.075527160471, 5165.251038599307, 5514.393416724077, 5516.917246241229, 5537.972310138584, 5575.4424557543925, 5159.380874295109, 5377.542908852635, 5428.56571474289, 5440.755166017618, 5458.9454105458435, 5341.172118321511, 5341.679499230058, 5376.247325374529, 5381.246625472359, 5388.030154572215, 5233.947660523346, 5251.317328747238, 5298.788048478018, 5311.150215965427, 5320.494553017457, 5163.896722065462, 5230.032443997872, 5417.295751552273, 5461.1808228766, 5462.754176062007, 5222.216667499905, 5222.817201398085, 5228.215767634885, 5228.477152284741, 5262.789488420573], "value": 5006.183930745261, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.5153607490271, 708.9645517724114, 723.7901008707476, 785.0461689047805, 790.9129995700475, 30360.089197324087, 31809.840950795242, 31841.84079079607, 31848.203794905137, 31941.041768746916, 36981.81509092451, 37356.43965340522, 37435.438468422995, 37591.812040939825, 37601.24797504048, 7458.7016519339295, 7652.1582625911105, 7654.732084377048, 8980.730578082668, 9201.263898888074, 9221.492817895047, 9332.906670933271, 9366.953165234198, 9368.063193680646, 9370.484623345714, 9496.66761663342, 9569.473678947656, 9583.185429238489, 9602.08780165883, 9612.519374031306, 9477.336586438883, 9501.71494855152, 9554.808903821955, 9567.425954442755, 9581.329306948552, 9154.954225228832, 9257.861132083024, 9278.860817087749, 9286.907130928672, 9303.395279306824, 34125.31749365023, 34211.486827697605, 34298.31403371919, 34322.31355372879, 34409.483857742154, 3363.512290717832, 3429.879954201616, 3458.8962331130106, 3473.70473509752, 3488.7034602058857, 24769.0, 24831.50336993268, 24874.751252487604, 24995.250142495755, 25654.230373088838, 3219.742420606346, 3309.4539400998806, 3403.710684591813, 3417.6411476795074, 3423.4864770284407, 153935.0, 154970.0, 155034.0, 155564.0, 156012.99999999886, 43269.35095973563, 43570.346444803356, 43634.56365436369, 43704.56295437068, 43822.0, 45116.548834511894, 45370.0, 45501.72491375418, 45502.77248613736, 45716.77141614271, 12950.352482376033, 12974.675633109058, 13071.411786469442, 13092.410841512155, 13126.212427254395, 10330.896691033144, 10383.9480802597, 10386.636467723594, 10410.219233557362, 10471.371717696962, 12020.699482512833, 13382.93308533451, 13384.9214680624, 13434.529791457448, 13570.59288221355, 5462.262594549685, 5510.834674959758, 5536.833894983157, 5579.6652200868075, 5586.106223004381, 1008.5511947183433, 1011.6560369474414, 1034.5189486888632, 1042.3641578637025, 1044.5404022230193, 22128.778712212992, 22144.778552214593, 22203.66694499584, 22264.666030009565, 22696.0, 1113.560143743217, 1114.2979922648678, 1125.6027348862226, 1133.7222380516826, 1140.6521011091531, 11210.55157793679, 11926.284422934477, 11969.401529923469, 11972.461239244254, 12065.819012714815, 224372.0, 224861.0, 225832.0, 226053.0, 226369.0, 30592.23519411988, 42421.78789106035, 43014.13971720548, 43081.0, 43122.0, 1211.3398197982121, 1226.7301193737364, 1230.44014973187, 1235.4872727817856, 1264.607971528829, 21912.89043554772, 22090.33728988133, 22991.65512517347, 23132.421689457897, 23265.418364541023, 27061.729382705922, 35418.468722969694, 36100.27799444049, 36177.819110904275, 36260.81869590635, 165818.0, 166079.16960415122, 166370.0, 166378.0, 166953.0, 26175.34561635898, 26238.0, 26534.336641584116, 26627.866860665574, 27993.580096298163, 33677.831610841786, 33907.66092339045, 33951.0, 34617.134571635914, 34709.826450867586, 28150.155495335173, 28353.858230708713, 28758.85620571884, 29360.41279174447, 29385.706142938296, 28540.42919141564, 28911.42177156403, 28950.0, 29800.403991920473, 30132.84933575318, 28354.2911427216, 28795.28011799722, 28978.56532151977, 29083.0, 29173.0, 25460.745392545836, 25940.481190376464, 26064.478710425305, 27121.593176102768, 27144.864275678494, 21584.460388490414, 21813.890930545247, 22721.772782271964, 23071.19250826213, 23109.19117830868], "value": 15637.013906335807, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.19512876542836, 393.9409088636704, 426.075416346528, 434.25741981212127, 443.11156131955426, 17548.122593870303, 18240.0, 19124.713129303072, 19297.0351482426, 20056.59886802263, 18904.258882462036, 18950.768200066985, 18963.146658400372, 19007.61984760304, 19011.239550417966, 5597.384287728347, 5640.520555752766, 5763.942360576403, 5845.152452894327, 5850.707464626773, 5719.513841323493, 5808.912866306988, 5825.970870145643, 5831.154482600021, 5840.06558950568, 5626.690532020737, 5810.506106980912, 5817.476427121558, 5854.76580936762, 5872.031114866042, 5690.089585666315, 5709.514691251248, 5717.1995920570735, 5734.254546908896, 5798.043322851724, 5607.2897766181295, 5674.886502269973, 5677.091665333568, 5685.715714214272, 5687.459691329317, 21845.126194952183, 21944.89027554852, 22047.448813779625, 22167.334979950465, 22203.111875525123, 2354.7880690737916, 2392.736798952114, 2401.1115887121878, 2403.0, 2407.590709579376, 12671.809922851164, 13915.512957046556, 14003.789943150861, 14124.717505649829, 14752.778708319383, 1924.7497825282624, 1944.9513762155918, 1956.7358406615067, 1961.6763234066361, 1972.6942323939813, 83998.0, 85438.0, 86766.56616716876, 86848.56575717081, 87845.0, 16089.0, 16728.414505492492, 16832.57918552046, 16846.15769211559, 17103.48689539316, 29199.0, 29328.26679332991, 29366.706332936395, 29441.263968400963, 29493.410131797245, 8623.137686231452, 8697.826043479221, 8758.605862736065, 9055.366124371363, 9153.313501487415, 7151.249118842551, 7170.4622153338705, 7226.927730722626, 7431.479796414199, 7442.739504117439, 8802.735917922473, 8927.464352138762, 8968.847476605699, 9010.504422256708, 9384.624615015324, 3429.4684323929832, 3439.105832483572, 3556.0, 3560.875294493467, 4036.6770658347264, 787.1105650614883, 811.5090370325986, 817.1542453560536, 824.2128767027474, 843.7637461510664, 18187.181576829076, 19220.231190752493, 19292.710609340873, 19370.5157371064, 19379.90310048469, 806.1092492795377, 810.5744484145753, 819.9549024803574, 821.757581513455, 826.2646244842095, 9937.950310248547, 10781.083607893417, 10866.0, 10879.673609791718, 10902.0, 441006.0, 441770.0, 446304.0, 447558.0, 448468.0, 84167.0, 84739.0, 90069.54965225262, 90209.0, 90356.54821725849, 1096.9670909872557, 1110.8000559899297, 1168.3574034281282, 1178.793711100554, 1179.4869231884159, 16728.832711673214, 16769.748453772958, 18498.982555959552, 18584.2566297352, 18734.344297949505, 40209.39685904772, 40612.79693601513, 41464.58535414728, 42224.36663449989, 42719.3592096125, 50758.49241507538, 52456.21315680344, 52868.471315286355, 52889.47110528845, 52932.0, 10021.549030293509, 11192.720181995515, 11195.552177913118, 11216.439178041228, 11312.095032397554, 12937.741245175232, 13288.604696506727, 13425.597232083053, 13467.730645386842, 13530.93234533821, 10811.675649730521, 10848.45757712127, 11002.834957475485, 11232.494537745984, 11300.660980170607, 10765.30025548337, 10956.233063685466, 11038.779224415306, 11062.446877655924, 11297.096232301561, 11024.834627480755, 11048.889511105108, 11055.336679799238, 11159.87962287163, 11267.661970140909, 11111.444427778417, 11302.378369189444, 11527.76944461123, 11567.710807229887, 11582.6525204244, 10315.226358023328, 10437.895621043692, 10451.32066415711, 10742.355458672504, 10800.945995269973], "value": 9887.72036652288, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.898577099602, 1448.9275536223192, 1473.344361759017, 1488.5906375746667, 1547.0949494545691, 8310.12743661916, 8534.146585341463, 8998.68504602339, 9405.717828465149, 9422.90577094228, 9190.816183676323, 9475.052494750522, 9481.47851868147, 9499.145076943074, 9509.191718703918, 2008.4376374615094, 2041.591681663666, 2043.1725151313742, 2043.7649670287958, 2048.4673984763995, 2000.8499362547793, 2038.3069756282862, 2042.0912693851242, 2042.693595960603, 2047.9692804607944, 2048.514826750609, 2058.032724619434, 2070.9378718638463, 2079.511314841011, 2082.4169232614818, 2009.859309848311, 2011.2055737983414, 2019.2024150460486, 2023.5042414608442, 2027.523531969986, 1900.5058684741928, 1923.5287354598074, 1985.3944546913185, 2033.4916270932267, 2033.6136134134467, 9352.812943741086, 9501.144896959238, 9511.57197926095, 9516.762080947963, 9571.18644915183, 4643.8142474300985, 4776.47458779534, 4794.304825800239, 4813.614910807127, 4818.879528011793, 2577.574700174469, 2669.7997650176317, 2697.042549894779, 2724.0601992312622, 2782.040196132331, 971.6259240192506, 1013.1843865688118, 1014.8071866345371, 1060.1148041385452, 1062.5218651606808, 13773.862261377359, 13856.0, 13889.236092014935, 13925.721485570231, 13960.650983725489, 3871.245107204068, 4124.8556300529335, 4187.685923555746, 4251.511076226212, 4251.766152861561, 11543.942280288713, 11562.30626162433, 11580.420978951019, 11581.768364632828, 11616.94191529054, 4913.091078150554, 4937.7777999990085, 4942.752862356868, 4961.826336078292, 4964.429090654548, 3810.7141964352786, 4013.418054382098, 4279.636230920344, 4363.149185908717, 4371.584699453547, 3464.497647841049, 3481.3037392521596, 3609.5668519777796, 3614.1687411894886, 3620.8551657933913, 1020.3163880200284, 1023.6775415744016, 1024.0936770957608, 1038.85456036155, 1039.1219419590434, 762.7482930632877, 765.6439755513602, 775.899133112703, 778.4473024152802, 788.5465857132057, 5300.31095957523, 5340.118880384693, 5387.0, 5492.5331346835965, 5494.395616482184, 823.9629216685264, 837.7361131243639, 841.4572600672532, 860.6815478273079, 873.2271939333735, 3359.4624860022277, 3466.4626982817704, 3478.1826270826336, 3502.8073455959657, 3550.3076900004767, 11863.88136118645, 12187.45156467961, 12335.629931102081, 12353.567625133257, 12355.505779768888, 12076.033917286595, 12151.75696486083, 12157.574484892986, 12218.572349967886, 12230.938845305895, 8805.42764720291, 8873.112688731204, 8947.686830960885, 8992.640294388151, 9002.369834111549, 5241.554467870121, 5289.68261904287, 5290.365156181283, 5479.643823151482, 5527.281453411031, 10490.370577765358, 10837.783244335227, 10889.237753357505, 10911.127109831354, 10969.616063437741, 11030.779384412428, 11122.721931951766, 11139.554417823521, 11155.888441115485, 11200.271982321123, 6846.0, 7028.4728645352825, 7716.961415193113, 8004.879926800986, 8140.59297035134, 8753.080926502626, 8965.686200983195, 8973.416727912665, 8978.640854365753, 8987.685431009882, 7616.543007419573, 7774.222577742406, 7783.182765809508, 7839.608019599112, 7986.600669966362, 7813.726519571787, 7894.289513943772, 7946.483478573874, 7973.880391794244, 8046.758597242092, 6624.90062649051, 6656.434203092791, 6667.799966001027, 6697.129373181455, 6724.159480064992, 4625.722456652612, 4642.489326174051, 4660.300954856799, 4845.612351011981, 4960.057589058068, 4677.649176311722, 4800.591949684316, 4814.662973591955, 4860.3681521401995, 4989.875253118701], "value": 4425.926999226978, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.25280324163015, 381.4316668164434, 388.80365415465184, 390.43582023975347, 392.0277711276037, 5341.786328546858, 5388.084025715628, 5398.190271459283, 5408.729563521828, 5427.213054107157, 5038.622103342254, 5290.603204759649, 5294.735263236832, 5297.947020529794, 5312.150055991042, 4463.085067561142, 4468.419105516295, 4472.44094488189, 4476.12715520472, 4484.282514797633, 4487.977560112195, 4488.932666010012, 4489.708168969007, 4490.9550904491025, 4492.842750503733, 4344.674149438789, 4416.911661766762, 4456.420665313504, 4461.196984542781, 4464.3080322549895, 4384.101259241847, 4389.0, 4390.736555806662, 4408.228560002003, 4420.778961051935, 4054.432379466877, 4058.7361821481804, 4062.3500239961463, 4080.5307389650275, 4101.200265948141, 5091.719955402451, 5221.582273418117, 5249.580033597341, 5260.894782104375, 5261.105612045962, 5166.943949000017, 5168.095583272912, 5184.844454666366, 5210.114280572312, 5214.217867319894, 5654.6324488908085, 5663.2637757091725, 5663.546916246691, 5664.2636457260705, 5699.601027928046, 4467.285234362486, 4541.45502539694, 4550.249208880531, 4558.2251017327135, 4559.430071241095, 5644.463775941279, 5917.970410147965, 5944.791932282393, 6023.247094113236, 6027.0, 4567.931481027787, 4705.576498115186, 4724.763761811896, 4730.894751835469, 4734.384530011145, 4786.593139583105, 4797.18447863864, 4807.879803004953, 4809.917768502059, 4823.43238447499, 5064.544191022752, 5127.589792816566, 5156.355455568054, 5177.58579313654, 5200.049981257029, 5690.715464226855, 5708.286464191976, 5711.685857277889, 5712.685802280831, 5714.342850572238, 1654.081984498615, 1683.9158042097847, 1684.9578760531085, 1687.5865412973899, 1691.3234706117405, 1238.0467040378858, 1252.9122961392798, 1253.6991122130623, 1257.9622611321674, 1263.595649392204, 4986.90026199474, 5039.77321020555, 5040.067587496325, 5047.41954675217, 5054.7472626368535, 5879.706014699248, 5883.764649413975, 5901.409859014064, 5905.350411454822, 5911.9113213301835, 4788.784504697297, 5004.149294619923, 5030.622703297267, 5042.949570504321, 5048.7728052237, 3102.565640810288, 3140.528920661919, 3144.8427578620976, 3149.480335744622, 3153.5900332957026, 5252.369715634149, 5474.151506516497, 5504.036793561111, 5526.557875369961, 5529.557635389159, 6009.0, 6036.426539478743, 6044.637321760709, 6045.123457098696, 6054.364291749391, 5528.143137813645, 5532.806351777668, 5536.446355364431, 5541.639793413416, 5545.916811247835, 5801.245838041196, 5845.795397161079, 5912.674802885883, 5931.495822855106, 5939.67331796738, 5816.214811000461, 5837.357890631942, 5843.2403787507355, 5844.240248767633, 5863.885861686266, 5262.368515777978, 5374.247605335335, 5388.622796404214, 5488.9725551371985, 5531.280933478622, 4669.906601868011, 4729.196036673842, 4729.69256998294, 4731.391326948854, 4749.0, 5759.94240057594, 5857.4435428634215, 5921.911171332347, 5949.702514874326, 5967.46292833647, 5698.800541981011, 5700.572457065819, 5717.285339332583, 5727.484526392478, 5739.0, 5674.716264186856, 5717.656940583578, 5726.198332233407, 5726.370099289158, 5732.426757324234, 5456.399796022513, 5594.98539070509, 5627.0, 5636.182753500638, 5658.830235092953, 5742.971285143548, 5764.7405866736935, 5777.740001700017, 5791.565632577489, 5798.217240672624, 5278.706716854395, 5589.608727389043, 5605.103183490622, 5614.54021954303, 5620.85947851307], "value": 4469.589112823673, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.8645098078421, 651.7197605029842, 679.1714108787279, 688.9242183359829, 696.4950410952059, 12797.23216607003, 13033.34833258338, 13394.464221431132, 13417.664558386045, 13492.392842322106, 13696.794548081787, 13755.312234388266, 13831.585052448418, 13923.58229253124, 13961.232132232723, 822.2805045585098, 838.6645341863273, 847.7075408983891, 851.8551846186132, 866.2117473099481, 879.0725784297564, 879.5646155153208, 879.9428037177563, 880.1330689271094, 881.5944665453899, 904.1275169461468, 907.0158877617793, 907.6051917415912, 907.859281811317, 908.3550679017873, 893.1068931068932, 894.7047474333455, 899.2715900120922, 899.9550022498914, 901.6708901251062, 664.0371461381017, 665.6838001949084, 665.7037618259876, 666.1539844397588, 667.0661074495696, 13131.409086591126, 13674.453021879113, 14513.129212247193, 14701.338439770236, 14769.040012399268, 12521.93739031299, 13196.274204918725, 13304.06871518994, 13356.265405402699, 13502.0, 9658.855117173249, 9732.41605503665, 9757.26820488459, 9902.554385052617, 10462.0, 3234.1429521176906, 3265.510173473998, 3380.8478618462227, 3389.2374215801246, 3395.9660403395897, 66348.0, 67655.66172169156, 68547.31452685459, 70076.64961675159, 70330.29669703289, 10682.51928663212, 10782.0, 10803.243772935975, 10919.508622111865, 11364.431778411046, 18152.364667236583, 18881.055947202585, 22092.55814883693, 22160.0, 22515.54968900613, 6704.798856034229, 6911.5853048817235, 6948.131483564554, 7021.368076873106, 7151.713931442788, 3446.551948246712, 3581.3016461789703, 3623.3115708015393, 3625.2930678517964, 3652.7443078984747, 2815.9296017599313, 2853.9143825685264, 2864.7135286471184, 2874.2814296425895, 2880.7551358134792, 484.60020483101584, 486.54264990908433, 488.5944665927272, 495.07421122501154, 497.30625777040825, 579.8405438504445, 602.7257597792993, 619.495111484148, 619.8729260501586, 624.7594676049663, 8390.664373425117, 8621.78445538854, 8674.479531228146, 9127.402704526681, 9257.213136883305, 624.6533174088424, 635.8346829824186, 636.3032479435011, 640.1581919775573, 641.6150309814075, 4170.311898536707, 4179.384363716188, 4365.105153443536, 4435.090806384684, 4469.575390337913, 58565.41434585685, 59028.0, 60255.0, 60956.695216524524, 61719.07421388683, 44476.77761611236, 46676.5332346679, 49457.752711236215, 52182.739086304326, 52207.477925220264, 45765.31352029722, 46507.06985860264, 46919.530804691516, 46936.29595556138, 47117.293240601415, 9191.77020574491, 9604.727381070668, 9737.367071140354, 9771.120599145826, 9848.803023939337, 31630.36739265248, 31773.841130794197, 32110.51834222442, 32847.507287391185, 32875.17812054718, 38184.618153818104, 38717.806410967765, 39170.80414597909, 39465.802670986464, 40046.1990760189, 11306.208565400342, 11727.47226374798, 11731.706707332043, 11821.290722556674, 11874.346910919638, 12609.684757881127, 12609.87390126087, 12678.619641410773, 13005.609831704685, 13240.735185296433, 11015.173861960546, 11412.258203216765, 11537.250078744855, 11558.884411155781, 11741.354225517336, 11149.777004459704, 11163.553457861595, 11551.42242887869, 11666.824997624874, 11828.645140645795, 11669.35818529989, 11739.823902641296, 11787.646370608896, 11922.463489142836, 11972.820407694066, 9643.517824108627, 9953.900460995297, 10357.611532186012, 10416.0, 10585.470726463493, 8635.611397487002, 9186.678466253648, 9189.724308270763, 9838.212942964688, 9900.50497475109], "value": 6373.562432812896, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1573.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 119.0, 120.0, 118.0, 123.0, 118.0, 117.0, 118.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 134.0, 126.0, 168.0, 127.0, 127.0, 126.0, 127.0, 156.0, 128.0], "value": 137.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 171.0, 167.0, 169.0, 165.0, 163.0, 162.0, 164.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 125.0, 77.0, 75.0, 75.0, 75.0, 92.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 111.0, 85.0, 85.0, 84.0, 99.0, 84.0, 86.0, 110.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 114.0, 119.0, 114.0, 114.0, 114.0, 115.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 150.0, 150.0, 149.0, 151.0, 151.0, 151.0, 151.0, 150.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 68.0, 69.0, 71.0, 69.0, 69.0, 71.0, 68.0, 68.0], "value": 68.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 56.0, 57.0, 56.0, 56.0, 55.0, 55.0, 56.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 83.0, 84.0, 91.0, 82.0, 83.0, 82.0, 81.0, 80.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 138.0, 135.0, 136.0, 132.0, 136.0, 133.0, 136.0, 238.0, 139.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 197.0, 195.0, 198.0, 194.0, 193.0, 195.0, 196.0, 193.0, 191.0], "value": 194.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 70.0, 70.0, 71.0, 73.0, 70.0, 69.0, 72.0], "value": 71.5, "unit": "score"}]}]} 11:51:58 INFO - Return code: 0 11:51:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:51:58 ERROR - # TBPL SUCCESS # 11:51:58 INFO - Running post-action listener: _resource_record_post_action 11:51:58 INFO - [mozharness: 2017-03-17 18:51:58.890569Z] Finished run-tests step (success) 11:51:58 INFO - Running post-run listener: _resource_record_post_run 11:51:58 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 7311360; Write bytes: 282963968; Read time: 1212; Write time: 157952 11:51:58 INFO - TinderboxPrint: CPU usage
13.3% 11:51:58 INFO - TinderboxPrint: I/O read bytes / time
7,311,360 / 1,212 11:51:58 INFO - TinderboxPrint: I/O write bytes / time
282,963,968 / 157,952 11:51:58 INFO - TinderboxPrint: CPU idle
8,315.2 (86.7%) 11:51:58 INFO - TinderboxPrint: CPU user
1,217.8 (12.7%) 11:51:58 INFO - TinderboxPrint: Swap in / out
0 / 0 11:51:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 31633408; Read time: 0; Write time: 15580 11:51:58 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 5279744; Write bytes: 251330560; Read time: 1144; Write time: 142372 11:51:59 INFO - Running post-run listener: _upload_blobber_files 11:51:59 INFO - Blob upload gear active. 11:51:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:51:59 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 11:51:59 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'] 11:51:59 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 11:51:59 INFO - (blobuploader) - INFO - Open directory for files ... 11:51:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:51:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:51:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:52:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:00 INFO - (blobuploader) - INFO - Done attempting. 11:52:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:52:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:52:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:02 INFO - (blobuploader) - INFO - Done attempting. 11:52:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:52:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:52:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:03 INFO - (blobuploader) - INFO - Done attempting. 11:52:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:52:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:52:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:08 INFO - (blobuploader) - INFO - Done attempting. 11:52:08 INFO - (blobuploader) - INFO - Iteration through files over. 11:52:08 INFO - Return code: 0 11:52:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:52:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:52:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94d4da0ac828d01a1031950f9be1f57197dfb0080cbb1d926561b193aa0f6bb4a1c1107b9401ddfd3d6bea5371dfb63c0810c4c78bba2832ca4e7aacf249ccf8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df02a2873d90fe464caa96f5f77b0c1048eb9b8195b6ca4a0892d99872e0b9965821fde7bda46540bbda8b166410cf35784dfb9126af25c85a1064f446f2d335", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d71775cebb354761112b2733ed3f94ab63b971c4a8e5ce08b6e45a1879af71b48323005b2de01c5242d5b58182f3818051d273b862158efb6e9ce8d535c86c56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/10b83d8b3ef6f58c6a16c29cc4873a9746afcd746aa47245596d1efbe6d01b0c0aee9f8ec23f4a4e8f6a129ab3fc27ba33eb494df9c86e9504735b088d64dc21"} 11:52:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:52:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:52:08 INFO - Contents: 11:52:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94d4da0ac828d01a1031950f9be1f57197dfb0080cbb1d926561b193aa0f6bb4a1c1107b9401ddfd3d6bea5371dfb63c0810c4c78bba2832ca4e7aacf249ccf8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df02a2873d90fe464caa96f5f77b0c1048eb9b8195b6ca4a0892d99872e0b9965821fde7bda46540bbda8b166410cf35784dfb9126af25c85a1064f446f2d335", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d71775cebb354761112b2733ed3f94ab63b971c4a8e5ce08b6e45a1879af71b48323005b2de01c5242d5b58182f3818051d273b862158efb6e9ce8d535c86c56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/10b83d8b3ef6f58c6a16c29cc4873a9746afcd746aa47245596d1efbe6d01b0c0aee9f8ec23f4a4e8f6a129ab3fc27ba33eb494df9c86e9504735b088d64dc21"} 11:52:08 INFO - Running post-run listener: copy_logs_to_upload_dir 11:52:08 INFO - Copying logs to upload dir... 11:52:08 INFO - mkdir: /builds/slave/test/build/upload/logs 11:52:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.233653 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-03-17 11:52:08.270525) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-17 11:52:08.273684) ========= 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=1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94d4da0ac828d01a1031950f9be1f57197dfb0080cbb1d926561b193aa0f6bb4a1c1107b9401ddfd3d6bea5371dfb63c0810c4c78bba2832ca4e7aacf249ccf8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df02a2873d90fe464caa96f5f77b0c1048eb9b8195b6ca4a0892d99872e0b9965821fde7bda46540bbda8b166410cf35784dfb9126af25c85a1064f446f2d335", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d71775cebb354761112b2733ed3f94ab63b971c4a8e5ce08b6e45a1879af71b48323005b2de01c5242d5b58182f3818051d273b862158efb6e9ce8d535c86c56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/10b83d8b3ef6f58c6a16c29cc4873a9746afcd746aa47245596d1efbe6d01b0c0aee9f8ec23f4a4e8f6a129ab3fc27ba33eb494df9c86e9504735b088d64dc21"} build_url:https://queue.taskcluster.net/v1/task/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011257 build_url: 'https://queue.taskcluster.net/v1/task/E85xswhnQnCXpgU03Rnugw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94d4da0ac828d01a1031950f9be1f57197dfb0080cbb1d926561b193aa0f6bb4a1c1107b9401ddfd3d6bea5371dfb63c0810c4c78bba2832ca4e7aacf249ccf8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df02a2873d90fe464caa96f5f77b0c1048eb9b8195b6ca4a0892d99872e0b9965821fde7bda46540bbda8b166410cf35784dfb9126af25c85a1064f446f2d335", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d71775cebb354761112b2733ed3f94ab63b971c4a8e5ce08b6e45a1879af71b48323005b2de01c5242d5b58182f3818051d273b862158efb6e9ce8d535c86c56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/10b83d8b3ef6f58c6a16c29cc4873a9746afcd746aa47245596d1efbe6d01b0c0aee9f8ec23f4a4e8f6a129ab3fc27ba33eb494df9c86e9504735b088d64dc21"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-17 11:52:08.298920) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 11:52:08.299379) ========= 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=1258088b6da462a47ba2cd90000001a2-1489774797.8267-1903576094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 11:52:08.386339) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-17 11:52:08.387029) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-17 11:52:08.387587) ========= ========= Total master_lag: 0.17 =========