builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-046 starttime: 1489938145.95 results: success (0) revision: 928b6052cbcf3c1c29436313b61760dc35248d4a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-19 08:42:25.950064) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-19 08:42:25.950533) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-19 08:42:25.950804) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-19 08:42:25.965548) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 08:42:25.965865) ========= 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=652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-19 08:42:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.5M=0s 2017-03-19 08:42:26 (33.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119967 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 08:42:26.099466) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 08:42:26.099777) ========= 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=652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015350 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 08:42:26.150328) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-19 08:42:26.150661) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 928b6052cbcf3c1c29436313b61760dc35248d4a --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 928b6052cbcf3c1c29436313b61760dc35248d4a --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=652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-19 08:42:26,507 truncating revision to first 12 chars 2017-03-19 08:42:26,507 Setting DEBUG logging. 2017-03-19 08:42:26,507 attempt 1/10 2017-03-19 08:42:26,507 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/928b6052cbcf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-19 08:42:27,499 unpacking tar archive at: mozilla-central-928b6052cbcf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.261146 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-19 08:42:27.424992) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-19 08:42:27.425305) ========= script_repo_revision: 928b6052cbcf3c1c29436313b61760dc35248d4a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-19 08:42:27.425685) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-19 08:42:27.425946) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-19 08:42:27.435128) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-03-19 08:42:27.435526) ========= /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=652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:42:27 INFO - MultiFileLogger online at 20170319 08:42:27 in /builds/slave/test 08:42:27 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 08:42:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:42:27 INFO - {'append_to_log': False, 08:42:27 INFO - 'base_work_dir': '/builds/slave/test', 08:42:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:42:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:42:27 INFO - 'branch': 'Firefox-Non-PGO', 08:42:27 INFO - 'buildbot_json_path': 'buildprops.json', 08:42:27 INFO - 'config_files': ('talos/linux_config.py',), 08:42:27 INFO - 'default_actions': ('clobber', 08:42:27 INFO - 'read-buildbot-config', 08:42:27 INFO - 'download-and-extract', 08:42:27 INFO - 'populate-webroot', 08:42:27 INFO - 'create-virtualenv', 08:42:27 INFO - 'install', 08:42:27 INFO - 'run-tests'), 08:42:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:42:27 INFO - 'download_minidump_stackwalk': True, 08:42:27 INFO - 'download_symbols': 'ondemand', 08:42:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:42:27 INFO - 'tooltool.py': '/tools/tooltool.py', 08:42:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:42:27 INFO - '/tools/misc-python/virtualenv.py')}, 08:42:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:42:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:42:27 INFO - 'gecko_profile': False, 08:42:27 INFO - 'gecko_profile_interval': 0, 08:42:27 INFO - 'installer_path': 'installer.exe', 08:42:27 INFO - 'log_level': 'info', 08:42:27 INFO - 'log_name': 'talos', 08:42:27 INFO - 'log_to_console': True, 08:42:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:42:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:42:27 INFO - 'opt_config_files': (), 08:42:27 INFO - 'pip_index': False, 08:42:27 INFO - 'suite': 'dromaeojs-e10s', 08:42:27 INFO - 'system_bits': '32', 08:42:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:42:27 INFO - 'title': 'talos-linux64-ix-046', 08:42:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:42:27 INFO - 'use_talos_json': True, 08:42:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:42:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:42:27 INFO - 'work_dir': 'build'} 08:42:27 INFO - [mozharness: 2017-03-19 15:42:27.892977Z] Running clobber step. 08:42:27 INFO - Running pre-action listener: _resource_record_pre_action 08:42:27 INFO - Running main action method: clobber 08:42:27 INFO - rmtree: /builds/slave/test/build 08:42:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:42:29 INFO - Running post-action listener: _resource_record_post_action 08:42:29 INFO - [mozharness: 2017-03-19 15:42:29.344018Z] Finished clobber step (success) 08:42:29 INFO - [mozharness: 2017-03-19 15:42:29.344116Z] Running read-buildbot-config step. 08:42:29 INFO - Running pre-action listener: _resource_record_pre_action 08:42:29 INFO - Running main action method: read_buildbot_config 08:42:29 INFO - Using buildbot properties: 08:42:29 INFO - { 08:42:29 INFO - "project": "", 08:42:29 INFO - "product": "firefox", 08:42:29 INFO - "who": "ffxbld@noreply.mozilla.org", 08:42:29 INFO - "installer_path": "public/build/target.tar.bz2", 08:42:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:42:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:42:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:42:29 INFO - "stage_platform": "linux64", 08:42:29 INFO - "basedir": "/builds/slave/test", 08:42:29 INFO - "buildnumber": 473, 08:42:29 INFO - "platform": "ubuntu64_hw", 08:42:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:42:29 INFO - "slavebuilddir": "test", 08:42:29 INFO - "taskId": "BpGKTmpaToauFF5_vSjFNg", 08:42:29 INFO - "branch": "mozilla-central", 08:42:29 INFO - "script_repo_revision": "production", 08:42:29 INFO - "revision": "928b6052cbcf3c1c29436313b61760dc35248d4a", 08:42:29 INFO - "slavename": "talos-linux64-ix-046", 08:42:29 INFO - "repo_path": "mozilla-central" 08:42:29 INFO - } 08:42:29 INFO - Finding installer, test and symbols from parent task. 08:42:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BpGKTmpaToauFF5_vSjFNg'}, attempt #1 08:42:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BpGKTmpaToauFF5_vSjFNg'}, attempt #1 08:42:30 INFO - Task dependencies: THEgzUy0TPurbZDABYtWIw 08:42:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/THEgzUy0TPurbZDABYtWIw'}, attempt #1 08:42:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/target.tar.bz2 08:42:30 INFO - Set test_url: https://queue.taskcluster.net/v1/task/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/test_packages.json 08:42:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/target.crashreporter-symbols.zip 08:42:30 INFO - Running post-action listener: _resource_record_post_action 08:42:30 INFO - [mozharness: 2017-03-19 15:42:30.749355Z] Finished read-buildbot-config step (success) 08:42:30 INFO - [mozharness: 2017-03-19 15:42:30.749573Z] Running download-and-extract step. 08:42:30 INFO - Running pre-action listener: _resource_record_pre_action 08:42:30 INFO - Running main action method: download_and_extract 08:42:30 INFO - mkdir: /builds/slave/test/build/tests 08:42:30 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')]} 08:42:30 INFO - trying https://queue.taskcluster.net/v1/task/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/target.test_packages.json 08:42:30 INFO - Downloading https://queue.taskcluster.net/v1/task/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:42:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:42:31 INFO - Downloaded 986 bytes. 08:42:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:42:31 INFO - Using the following test package requirements: 08:42:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:42:31 INFO - u'common': [u'target.common.tests.zip'], 08:42:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:42:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:42:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:42:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:42:31 INFO - u'mozbase': [u'target.common.tests.zip'], 08:42:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:42:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:42:31 INFO - u'web-platform': [u'target.common.tests.zip', 08:42:31 INFO - u'target.web-platform.tests.zip'], 08:42:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:42:31 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:42:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/target.common.tests.zip 08:42:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:42:31 INFO - Fetch https://queue.taskcluster.net/v1/task/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/target.common.tests.zip into memory 08:42:33 INFO - Expected file size: 58186512 08:42:33 INFO - Obtained file size: 58186512 08:42:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:42:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/target.common.tests.zip 08:42:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:42:42 INFO - Fetch https://queue.taskcluster.net/v1/task/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/target.common.tests.zip into memory 08:42:44 INFO - Expected file size: 58186512 08:42:44 INFO - Obtained file size: 58186512 08:42:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/target.talos.tests.zip 08:42:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:42:54 INFO - Fetch https://queue.taskcluster.net/v1/task/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/target.talos.tests.zip into memory 08:42:56 INFO - Expected file size: 14404171 08:42:56 INFO - Obtained file size: 14404171 08:42:56 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')]} 08:42:56 INFO - trying https://queue.taskcluster.net/v1/task/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/target.tar.bz2 08:42:56 INFO - Downloading https://queue.taskcluster.net/v1/task/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:42:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:42:59 INFO - Downloaded 61845076 bytes. 08:42:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/target.tar.bz2 08:42:59 INFO - mkdir: /builds/slave/test/properties 08:42:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:42:59 INFO - Writing to file /builds/slave/test/properties/build_url 08:42:59 INFO - Contents: 08:42:59 INFO - build_url:https://queue.taskcluster.net/v1/task/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/target.tar.bz2 08:42:59 INFO - Running post-action listener: _resource_record_post_action 08:42:59 INFO - Running post-action listener: set_extra_try_arguments 08:42:59 INFO - [mozharness: 2017-03-19 15:42:59.811787Z] Finished download-and-extract step (success) 08:42:59 INFO - [mozharness: 2017-03-19 15:42:59.811884Z] Running populate-webroot step. 08:42:59 INFO - Running pre-action listener: _resource_record_pre_action 08:42:59 INFO - Running main action method: populate_webroot 08:42:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:42:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:42:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:42:59 INFO - '--tppagecycles', 08:42:59 INFO - '7'], 08:42:59 INFO - 'tests': ['tsvgm']}}, 08:42:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:42:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:42:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:42:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:42:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:42:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:42:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:42:59 INFO - 'talos_options': ['--disable-e10s'], 08:42:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:42:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:59 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:42:59 INFO - 'talos_options': ['--disable-e10s'], 08:42:59 INFO - 'tests': ['damp', 'tps']}, 08:42:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:42:59 INFO - 'tests': ['damp', 'tps']}, 08:42:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:42:59 INFO - 'tests': ['dromaeo_dom']}, 08:42:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:42:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:42:59 INFO - 'tests': ['basic_compositor_video']}, 08:42:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:42:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:42:59 INFO - 'tests': ['a11yr', 08:42:59 INFO - 'ts_paint', 08:42:59 INFO - 'tpaint', 08:42:59 INFO - 'sessionrestore', 08:42:59 INFO - 'sessionrestore_no_auto_restore', 08:42:59 INFO - 'tabpaint']}, 08:42:59 INFO - 'other-e10s': {'tests': ['a11yr', 08:42:59 INFO - 'ts_paint', 08:42:59 INFO - 'tpaint', 08:42:59 INFO - 'sessionrestore', 08:42:59 INFO - 'sessionrestore_no_auto_restore', 08:42:59 INFO - 'tabpaint']}, 08:42:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:42:59 INFO - 'ts_paint', 08:42:59 INFO - 'tpaint', 08:42:59 INFO - 'sessionrestore', 08:42:59 INFO - 'sessionrestore_no_auto_restore', 08:42:59 INFO - 'tabpaint']}, 08:42:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:42:59 INFO - 'ts_paint', 08:42:59 INFO - 'tpaint', 08:42:59 INFO - 'sessionrestore', 08:42:59 INFO - 'sessionrestore_no_auto_restore', 08:42:59 INFO - 'tabpaint']}, 08:42:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:42:59 INFO - 'tests': ['a11yr', 08:42:59 INFO - 'ts_paint', 08:42:59 INFO - 'tpaint', 08:42:59 INFO - 'sessionrestore', 08:42:59 INFO - 'sessionrestore_no_auto_restore', 08:42:59 INFO - 'tabpaint']}, 08:42:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:42:59 INFO - 'tests': ['a11yr', 08:42:59 INFO - 'ts_paint', 08:42:59 INFO - 'tpaint', 08:42:59 INFO - 'sessionrestore', 08:42:59 INFO - 'sessionrestore_no_auto_restore', 08:42:59 INFO - 'tabpaint']}, 08:42:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:42:59 INFO - 'tests': ['tsvgx', 08:42:59 INFO - 'tsvgr_opacity', 08:42:59 INFO - 'tart', 08:42:59 INFO - 'tscrollx', 08:42:59 INFO - 'cart', 08:42:59 INFO - 'tsvg_static']}, 08:42:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:42:59 INFO - 'tsvgr_opacity', 08:42:59 INFO - 'tart', 08:42:59 INFO - 'tscrollx', 08:42:59 INFO - 'cart', 08:42:59 INFO - 'tsvg_static']}, 08:42:59 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:42:59 INFO - 'talos_options': ['--disable-e10s'], 08:42:59 INFO - 'tests': ['tp5o']}, 08:42:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:42:59 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:42:59 INFO - 'talos_options': ['--disable-e10s', 08:42:59 INFO - '--xperf_path', 08:42:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:59 INFO - 'tests': ['tp5n']}, 08:42:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:42:59 INFO - 'talos_options': ['--xperf_path', 08:42:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:59 INFO - 'tests': ['tp5n']}}, 08:42:59 INFO - 'talos.zip': {'path': '', 08:42:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:42:59 INFO - Running post-action listener: _resource_record_post_action 08:42:59 INFO - [mozharness: 2017-03-19 15:42:59.825005Z] Finished populate-webroot step (success) 08:42:59 INFO - [mozharness: 2017-03-19 15:42:59.825104Z] Running create-virtualenv step. 08:42:59 INFO - Running pre-action listener: _resource_record_pre_action 08:42:59 INFO - Running main action method: create_virtualenv 08:42:59 INFO - Creating virtualenv /builds/slave/test/build/venv 08:42:59 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 08:42:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:42:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:42:59 INFO - Using real prefix '/usr' 08:42:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:43:00 INFO - Installing distribute.............................................................................................................................................................................................done. 08:43:02 INFO - Installing pip.................done. 08:43:02 INFO - Return code: 0 08:43:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:43:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:43:02 INFO - Reading from file tmpfile_stdout 08:43:02 INFO - Output received: 08:43:02 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) 08:43:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:02 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 0x13c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1662290>, '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 0x1662b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1663040>, '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': '652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051', '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 08:43:02 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 08:43:02 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 08:43:02 INFO - Using env: {'DISPLAY': ':0', 08:43:02 INFO - 'HOME': '/home/cltbld', 08:43:02 INFO - 'LANG': 'en_US.UTF-8', 08:43:02 INFO - 'LANGUAGE': 'en_US:en', 08:43:02 INFO - 'LOGNAME': 'cltbld', 08:43:02 INFO - 'MAIL': '/var/mail/cltbld', 08:43:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:02 INFO - 'MOZ_NO_REMOTE': '1', 08:43:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:02 INFO - 'NO_EM_RESTART': '1', 08:43:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:02 INFO - 'PWD': '/builds/slave/test', 08:43:02 INFO - 'SHELL': '/bin/bash', 08:43:02 INFO - 'SHLVL': '1', 08:43:02 INFO - 'TERM': 'linux', 08:43:02 INFO - 'TMOUT': '86400', 08:43:02 INFO - 'USER': 'cltbld', 08:43:02 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051', 08:43:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:02 INFO - '_': '/tools/buildbot/bin/python'} 08:43:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:02 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 08:43:02 INFO - Cleaning up... 08:43:02 INFO - Return code: 0 08:43:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:02 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 0x13c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1662290>, '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 0x1662b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1663040>, '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': '652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051', '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 08:43:02 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 08:43:02 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 08:43:02 INFO - Using env: {'DISPLAY': ':0', 08:43:02 INFO - 'HOME': '/home/cltbld', 08:43:02 INFO - 'LANG': 'en_US.UTF-8', 08:43:02 INFO - 'LANGUAGE': 'en_US:en', 08:43:02 INFO - 'LOGNAME': 'cltbld', 08:43:02 INFO - 'MAIL': '/var/mail/cltbld', 08:43:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:02 INFO - 'MOZ_NO_REMOTE': '1', 08:43:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:02 INFO - 'NO_EM_RESTART': '1', 08:43:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:02 INFO - 'PWD': '/builds/slave/test', 08:43:02 INFO - 'SHELL': '/bin/bash', 08:43:02 INFO - 'SHLVL': '1', 08:43:02 INFO - 'TERM': 'linux', 08:43:02 INFO - 'TMOUT': '86400', 08:43:02 INFO - 'USER': 'cltbld', 08:43:02 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051', 08:43:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:02 INFO - '_': '/tools/buildbot/bin/python'} 08:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:03 INFO - Downloading/unpacking psutil>=3.1.1 08:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:43:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:05 INFO - Installing collected packages: psutil 08:43:05 INFO - Running setup.py install for psutil 08:43:05 INFO - building 'psutil._psutil_linux' extension 08:43:05 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 08:43:05 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 08:43:05 INFO - building 'psutil._psutil_posix' extension 08:43:05 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 08:43:05 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 08:43:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:05 INFO - Successfully installed psutil 08:43:05 INFO - Cleaning up... 08:43:05 INFO - Return code: 0 08:43:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1662290>, '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 0x1662b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1663040>, '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': '652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051', '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 08:43:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:43:05 INFO - Using env: {'DISPLAY': ':0', 08:43:05 INFO - 'HOME': '/home/cltbld', 08:43:05 INFO - 'LANG': 'en_US.UTF-8', 08:43:05 INFO - 'LANGUAGE': 'en_US:en', 08:43:05 INFO - 'LOGNAME': 'cltbld', 08:43:05 INFO - 'MAIL': '/var/mail/cltbld', 08:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:05 INFO - 'MOZ_NO_REMOTE': '1', 08:43:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:05 INFO - 'NO_EM_RESTART': '1', 08:43:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:05 INFO - 'PWD': '/builds/slave/test', 08:43:05 INFO - 'SHELL': '/bin/bash', 08:43:05 INFO - 'SHLVL': '1', 08:43:05 INFO - 'TERM': 'linux', 08:43:05 INFO - 'TMOUT': '86400', 08:43:05 INFO - 'USER': 'cltbld', 08:43:05 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051', 08:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:05 INFO - '_': '/tools/buildbot/bin/python'} 08:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:43:05 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 08:43:05 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 08:43:05 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 08:43:05 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 08:43:05 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 08:43:05 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 08:43:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:43:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:43:08 INFO - Installing collected packages: mozsystemmonitor 08:43:08 INFO - Running setup.py install for mozsystemmonitor 08:43:08 INFO - Successfully installed mozsystemmonitor 08:43:08 INFO - Cleaning up... 08:43:08 INFO - Return code: 0 08:43:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:08 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 0x13c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1662290>, '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 0x1662b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1663040>, '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': '652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051', '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 08:43:08 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 08:43:08 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 08:43:08 INFO - Using env: {'DISPLAY': ':0', 08:43:08 INFO - 'HOME': '/home/cltbld', 08:43:08 INFO - 'LANG': 'en_US.UTF-8', 08:43:08 INFO - 'LANGUAGE': 'en_US:en', 08:43:08 INFO - 'LOGNAME': 'cltbld', 08:43:08 INFO - 'MAIL': '/var/mail/cltbld', 08:43:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:08 INFO - 'MOZ_NO_REMOTE': '1', 08:43:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:08 INFO - 'NO_EM_RESTART': '1', 08:43:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:08 INFO - 'PWD': '/builds/slave/test', 08:43:08 INFO - 'SHELL': '/bin/bash', 08:43:08 INFO - 'SHLVL': '1', 08:43:08 INFO - 'TERM': 'linux', 08:43:08 INFO - 'TMOUT': '86400', 08:43:08 INFO - 'USER': 'cltbld', 08:43:08 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051', 08:43:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:08 INFO - '_': '/tools/buildbot/bin/python'} 08:43:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:08 INFO - Downloading/unpacking jsonschema==2.5.1 08:43:08 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 08:43:08 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 08:43:08 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 08:43:08 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 08:43:08 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 08:43:08 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 08:43:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:43:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:43:10 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 08:43:10 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 08:43:10 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 08:43:10 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 08:43:10 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 08:43:10 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 08:43:10 INFO - Downloading functools32-3.2.3-2.tar.gz 08:43:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:43:10 INFO - warning: no files found matching '*.txt' 08:43:10 INFO - no previously-included directories found matching 'build' 08:43:10 INFO - no previously-included directories found matching 'dist' 08:43:10 INFO - no previously-included directories found matching '.git*' 08:43:10 INFO - Installing collected packages: jsonschema, functools32 08:43:10 INFO - Running setup.py install for functools32 08:43:10 INFO - warning: no files found matching '*.txt' 08:43:10 INFO - no previously-included directories found matching 'build' 08:43:10 INFO - no previously-included directories found matching 'dist' 08:43:10 INFO - no previously-included directories found matching '.git*' 08:43:10 INFO - Successfully installed jsonschema functools32 08:43:10 INFO - Cleaning up... 08:43:10 INFO - Return code: 0 08:43:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:43:10 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')]} 08:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:10 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')]} 08:43:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:10 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 0x13c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1662290>, '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 0x1662b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1663040>, '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': '652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051', '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 08:43:10 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 08:43:10 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 08:43:10 INFO - Using env: {'DISPLAY': ':0', 08:43:10 INFO - 'HOME': '/home/cltbld', 08:43:10 INFO - 'LANG': 'en_US.UTF-8', 08:43:10 INFO - 'LANGUAGE': 'en_US:en', 08:43:10 INFO - 'LOGNAME': 'cltbld', 08:43:10 INFO - 'MAIL': '/var/mail/cltbld', 08:43:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:10 INFO - 'MOZ_NO_REMOTE': '1', 08:43:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:10 INFO - 'NO_EM_RESTART': '1', 08:43:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:10 INFO - 'PWD': '/builds/slave/test', 08:43:10 INFO - 'SHELL': '/bin/bash', 08:43:10 INFO - 'SHLVL': '1', 08:43:10 INFO - 'TERM': 'linux', 08:43:10 INFO - 'TMOUT': '86400', 08:43:10 INFO - 'USER': 'cltbld', 08:43:10 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051', 08:43:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:10 INFO - '_': '/tools/buildbot/bin/python'} 08:43:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:43:11 INFO - Cleaning up... 08:43:11 INFO - Return code: 0 08:43:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:43: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')]} 08:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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')]} 08:43:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:11 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 0x13c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1662290>, '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 0x1662b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1663040>, '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': '652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051', '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 08:43:11 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 08:43:11 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 08:43:11 INFO - Using env: {'DISPLAY': ':0', 08:43:11 INFO - 'HOME': '/home/cltbld', 08:43:11 INFO - 'LANG': 'en_US.UTF-8', 08:43:11 INFO - 'LANGUAGE': 'en_US:en', 08:43:11 INFO - 'LOGNAME': 'cltbld', 08:43:11 INFO - 'MAIL': '/var/mail/cltbld', 08:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:11 INFO - 'MOZ_NO_REMOTE': '1', 08:43:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:11 INFO - 'NO_EM_RESTART': '1', 08:43:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:11 INFO - 'PWD': '/builds/slave/test', 08:43:11 INFO - 'SHELL': '/bin/bash', 08:43:11 INFO - 'SHLVL': '1', 08:43:11 INFO - 'TERM': 'linux', 08:43:11 INFO - 'TMOUT': '86400', 08:43:11 INFO - 'USER': 'cltbld', 08:43:11 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051', 08:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:11 INFO - '_': '/tools/buildbot/bin/python'} 08:43:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:11 INFO - Downloading/unpacking blobuploader==1.2.4 08:43:11 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 08:43:11 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 08:43:11 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 08:43:11 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 08:43:11 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 08:43:11 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 08:43:13 INFO - Downloading blobuploader-1.2.4.tar.gz 08:43:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:43:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:43:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:14 INFO - Downloading docopt-0.6.1.tar.gz 08:43:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:43:14 INFO - Installing collected packages: blobuploader, requests, docopt 08:43:14 INFO - Running setup.py install for blobuploader 08:43:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:43:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:43:14 INFO - Running setup.py install for requests 08:43:14 INFO - Running setup.py install for docopt 08:43:14 INFO - Successfully installed blobuploader requests docopt 08:43:14 INFO - Cleaning up... 08:43:14 INFO - Return code: 0 08:43:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:14 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')]} 08:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:14 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')]} 08:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:14 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 0x13c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1662290>, '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 0x1662b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1663040>, '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': '652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051', '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 08:43:14 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 08:43:14 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 08:43:14 INFO - Using env: {'DISPLAY': ':0', 08:43:14 INFO - 'HOME': '/home/cltbld', 08:43:14 INFO - 'LANG': 'en_US.UTF-8', 08:43:14 INFO - 'LANGUAGE': 'en_US:en', 08:43:14 INFO - 'LOGNAME': 'cltbld', 08:43:14 INFO - 'MAIL': '/var/mail/cltbld', 08:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:14 INFO - 'MOZ_NO_REMOTE': '1', 08:43:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:14 INFO - 'NO_EM_RESTART': '1', 08:43:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:14 INFO - 'PWD': '/builds/slave/test', 08:43:14 INFO - 'SHELL': '/bin/bash', 08:43:14 INFO - 'SHLVL': '1', 08:43:14 INFO - 'TERM': 'linux', 08:43:14 INFO - 'TMOUT': '86400', 08:43:14 INFO - 'USER': 'cltbld', 08:43:14 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051', 08:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:14 INFO - '_': '/tools/buildbot/bin/python'} 08:43:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:43:15 INFO - Running setup.py (path:/tmp/pip-PzEkhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:43:15 INFO - Running setup.py (path:/tmp/pip-HKEv0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:43:15 INFO - Running setup.py (path:/tmp/pip-0NavJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:43:15 INFO - Running setup.py (path:/tmp/pip-w2g2wA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:43:15 INFO - Running setup.py (path:/tmp/pip-V3UrwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:43:15 INFO - Running setup.py (path:/tmp/pip-rEvP9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:43:15 INFO - Running setup.py (path:/tmp/pip-N9HUCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:43:15 INFO - Running setup.py (path:/tmp/pip-QJdAI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:43:15 INFO - Running setup.py (path:/tmp/pip-H3u_Yx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:43:15 INFO - Running setup.py (path:/tmp/pip-9uInJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:43:15 INFO - Running setup.py (path:/tmp/pip-yJgWCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:43:15 INFO - Running setup.py (path:/tmp/pip-InrpgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:43:15 INFO - Running setup.py (path:/tmp/pip-4HAXUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:43:15 INFO - Running setup.py (path:/tmp/pip-wcizCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:16 INFO - Running setup.py (path:/tmp/pip-d4TDwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:43:16 INFO - Running setup.py (path:/tmp/pip-sqkKLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:43:16 INFO - Running setup.py (path:/tmp/pip-Tc6EKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:43:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:43:16 INFO - Running setup.py install for manifestparser 08:43:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:43:16 INFO - Running setup.py install for mozcrash 08:43:16 INFO - Running setup.py install for mozdebug 08:43:16 INFO - Running setup.py install for mozdevice 08:43:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:43:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:43:16 INFO - Running setup.py install for mozfile 08:43:16 INFO - Running setup.py install for mozhttpd 08:43:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:43:16 INFO - Running setup.py install for mozinfo 08:43:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:43:16 INFO - Running setup.py install for mozInstall 08:43:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:43:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:43:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:43:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:43:17 INFO - Running setup.py install for mozleak 08:43:17 INFO - Running setup.py install for mozlog 08:43:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:43:17 INFO - Running setup.py install for moznetwork 08:43:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:43:17 INFO - Running setup.py install for mozprocess 08:43:17 INFO - Running setup.py install for mozprofile 08:43:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:43:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:43:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:43:17 INFO - Running setup.py install for mozrunner 08:43:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:43:17 INFO - Running setup.py install for mozscreenshot 08:43:17 INFO - Running setup.py install for moztest 08:43:17 INFO - Running setup.py install for mozversion 08:43:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:43:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:43:18 INFO - Cleaning up... 08:43:18 INFO - Return code: 0 08:43:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:18 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 0x13c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1662290>, '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 0x1662b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1663040>, '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': '652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051', '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 08:43:18 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 08:43:18 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 08:43:18 INFO - Using env: {'DISPLAY': ':0', 08:43:18 INFO - 'HOME': '/home/cltbld', 08:43:18 INFO - 'LANG': 'en_US.UTF-8', 08:43:18 INFO - 'LANGUAGE': 'en_US:en', 08:43:18 INFO - 'LOGNAME': 'cltbld', 08:43:18 INFO - 'MAIL': '/var/mail/cltbld', 08:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:18 INFO - 'MOZ_NO_REMOTE': '1', 08:43:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:18 INFO - 'NO_EM_RESTART': '1', 08:43:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:18 INFO - 'PWD': '/builds/slave/test', 08:43:18 INFO - 'SHELL': '/bin/bash', 08:43:18 INFO - 'SHLVL': '1', 08:43:18 INFO - 'TERM': 'linux', 08:43:18 INFO - 'TMOUT': '86400', 08:43:18 INFO - 'USER': 'cltbld', 08:43:18 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051', 08:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:18 INFO - '_': '/tools/buildbot/bin/python'} 08:43:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:43:18 INFO - Running setup.py (path:/tmp/pip-bYfmUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:43:18 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)) 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:43:18 INFO - Running setup.py (path:/tmp/pip-hZ0XBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:43:18 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)) 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:43:18 INFO - Running setup.py (path:/tmp/pip-cEYu2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:43:18 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)) 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:43:18 INFO - Running setup.py (path:/tmp/pip-oGzhtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:43:18 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)) 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:43:18 INFO - Running setup.py (path:/tmp/pip-8O8N_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:43:18 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)) 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:43:18 INFO - Running setup.py (path:/tmp/pip-V77Xdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:43:18 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)) 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:43:18 INFO - Running setup.py (path:/tmp/pip-iRd8wR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:43:18 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)) 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:43:18 INFO - Running setup.py (path:/tmp/pip-g91QDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:43:18 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)) 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:43:18 INFO - Running setup.py (path:/tmp/pip-XIKZDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:43:18 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)) 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:43:18 INFO - Running setup.py (path:/tmp/pip-Vz_C0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:43:19 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)) 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:43:19 INFO - Running setup.py (path:/tmp/pip-6FeHa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:43:19 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)) 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:43:19 INFO - Running setup.py (path:/tmp/pip-wngJkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:43:19 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)) 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:43:19 INFO - Running setup.py (path:/tmp/pip-0vTMBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:43:19 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)) 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:43:19 INFO - Running setup.py (path:/tmp/pip-jb842l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:43:19 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)) 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:19 INFO - Running setup.py (path:/tmp/pip-iGxGQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:19 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)) 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:43:19 INFO - Running setup.py (path:/tmp/pip-hBpnBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:43:19 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)) 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:43:19 INFO - Running setup.py (path:/tmp/pip-6lp_UE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:43:19 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)) 08:43:19 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)) 08:43:19 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)) 08:43:19 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)) 08:43:19 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)) 08:43:19 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)) 08:43:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:43:19 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 08:43:19 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 08:43:19 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 08:43:19 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 08:43:19 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 08:43:19 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 08:43:21 INFO - Downloading blessings-1.6.tar.gz 08:43:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:43:21 INFO - Installing collected packages: blessings 08:43:21 INFO - Running setup.py install for blessings 08:43:21 INFO - Successfully installed blessings 08:43:21 INFO - Cleaning up... 08:43:21 INFO - Return code: 0 08:43:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:43:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:21 INFO - Reading from file tmpfile_stdout 08:43:21 INFO - Current package versions: 08:43:21 INFO - argparse == 1.2.1 08:43:21 INFO - blessings == 1.6 08:43:21 INFO - blobuploader == 1.2.4 08:43:21 INFO - docopt == 0.6.1 08:43:21 INFO - functools32 == 3.2.3-2 08:43:21 INFO - jsonschema == 2.5.1 08:43:21 INFO - manifestparser == 1.1 08:43:21 INFO - mozInstall == 1.12 08:43:21 INFO - mozcrash == 1.0 08:43:21 INFO - mozdebug == 0.1 08:43:21 INFO - mozdevice == 0.49 08:43:21 INFO - mozfile == 1.2 08:43:21 INFO - mozhttpd == 0.7 08:43:21 INFO - mozinfo == 0.9 08:43:21 INFO - mozleak == 0.1 08:43:21 INFO - mozlog == 3.4 08:43:21 INFO - moznetwork == 0.27 08:43:21 INFO - mozprocess == 0.25 08:43:21 INFO - mozprofile == 0.28 08:43:21 INFO - mozrunner == 6.13 08:43:21 INFO - mozscreenshot == 0.1 08:43:21 INFO - mozsystemmonitor == 0.3 08:43:21 INFO - moztest == 0.8 08:43:21 INFO - mozversion == 1.4 08:43:21 INFO - psutil == 3.1.1 08:43:21 INFO - requests == 1.2.3 08:43:21 INFO - wsgiref == 0.1.2 08:43:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:22 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 0x13c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1662290>, '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 0x1662b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1663040>, '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': '652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051', '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 08:43:22 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 08:43:22 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 08:43:22 INFO - Using env: {'DISPLAY': ':0', 08:43:22 INFO - 'HOME': '/home/cltbld', 08:43:22 INFO - 'LANG': 'en_US.UTF-8', 08:43:22 INFO - 'LANGUAGE': 'en_US:en', 08:43:22 INFO - 'LOGNAME': 'cltbld', 08:43:22 INFO - 'MAIL': '/var/mail/cltbld', 08:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:22 INFO - 'MOZ_NO_REMOTE': '1', 08:43:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:22 INFO - 'NO_EM_RESTART': '1', 08:43:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:22 INFO - 'PWD': '/builds/slave/test', 08:43:22 INFO - 'SHELL': '/bin/bash', 08:43:22 INFO - 'SHLVL': '1', 08:43:22 INFO - 'TERM': 'linux', 08:43:22 INFO - 'TMOUT': '86400', 08:43:22 INFO - 'USER': 'cltbld', 08:43:22 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051', 08:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:22 INFO - '_': '/tools/buildbot/bin/python'} 08:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:22 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)) 08:43:22 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)) 08:43:22 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)) 08:43:22 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)) 08:43:22 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)) 08:43:22 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)) 08:43:22 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)) 08:43:22 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)) 08:43:22 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)) 08:43:22 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)) 08:43:22 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)) 08:43:22 INFO - Cleaning up... 08:43:22 INFO - Return code: 0 08:43:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:22 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 0x13c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1662290>, '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 0x1662b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1663040>, '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': '652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051', '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 08:43:22 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 08:43:22 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 08:43:22 INFO - Using env: {'DISPLAY': ':0', 08:43:22 INFO - 'HOME': '/home/cltbld', 08:43:22 INFO - 'LANG': 'en_US.UTF-8', 08:43:22 INFO - 'LANGUAGE': 'en_US:en', 08:43:22 INFO - 'LOGNAME': 'cltbld', 08:43:22 INFO - 'MAIL': '/var/mail/cltbld', 08:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:22 INFO - 'MOZ_NO_REMOTE': '1', 08:43:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:22 INFO - 'NO_EM_RESTART': '1', 08:43:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:22 INFO - 'PWD': '/builds/slave/test', 08:43:22 INFO - 'SHELL': '/bin/bash', 08:43:22 INFO - 'SHLVL': '1', 08:43:22 INFO - 'TERM': 'linux', 08:43:22 INFO - 'TMOUT': '86400', 08:43:22 INFO - 'USER': 'cltbld', 08:43:22 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051', 08:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:22 INFO - '_': '/tools/buildbot/bin/python'} 08:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:43:22 INFO - Cleaning up... 08:43:22 INFO - Return code: 0 08:43:22 INFO - Running post-action listener: _resource_record_post_action 08:43:22 INFO - Running post-action listener: _start_resource_monitoring 08:43:22 INFO - Starting resource monitoring. 08:43:22 INFO - [mozharness: 2017-03-19 15:43:22.504240Z] Finished create-virtualenv step (success) 08:43:22 INFO - [mozharness: 2017-03-19 15:43:22.504759Z] Running install step. 08:43:22 INFO - Running pre-action listener: _resource_record_pre_action 08:43:22 INFO - Running main action method: install 08:43:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:22 INFO - Reading from file tmpfile_stdout 08:43:22 INFO - Detecting whether we're running mozinstall >=1.0... 08:43:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:43:22 INFO - Reading from file tmpfile_stdout 08:43:22 INFO - Output received: 08:43:22 INFO - Usage: mozinstall [options] installer 08:43:22 INFO - Options: 08:43:22 INFO - -h, --help show this help message and exit 08:43:22 INFO - -d DEST, --destination=DEST 08:43:22 INFO - Directory to install application into. [default: 08:43:22 INFO - "/builds/slave/test"] 08:43:22 INFO - --app=APP Application being installed. [default: firefox] 08:43:22 INFO - mkdir: /builds/slave/test/build/application 08:43:22 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'] 08:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:43:38 INFO - Reading from file tmpfile_stdout 08:43:38 INFO - Output received: 08:43:38 INFO - /builds/slave/test/build/application/firefox/firefox 08:43:38 INFO - Running post-action listener: _resource_record_post_action 08:43:38 INFO - [mozharness: 2017-03-19 15:43:38.242371Z] Finished install step (success) 08:43:38 INFO - [mozharness: 2017-03-19 15:43:38.242644Z] Running run-tests step. 08:43:38 INFO - Running pre-action listener: _resource_record_pre_action 08:43:38 INFO - Running main action method: run_tests 08:43:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:43:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:43:38 INFO - Python 2.7.3 08:43:38 INFO - Return code: 0 08:43:38 INFO - grabbing minidump binary from tooltool 08:43:38 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')]} 08:43:38 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 0x1662290>, '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 0x1662b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1663040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:43:38 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 08:43:38 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 08:43:38 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 08:43:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:43:38 INFO - Return code: 0 08:43:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:43:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:43:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:43:38 INFO - ENV: RUST_BACKTRACE is now 1 08:43:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:43:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:43:38 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/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 08:43:38 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/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 08:43:38 INFO - Using env: {'DISPLAY': ':0', 08:43:38 INFO - 'HOME': '/home/cltbld', 08:43:38 INFO - 'LANG': 'en_US.UTF-8', 08:43:38 INFO - 'LANGUAGE': 'en_US:en', 08:43:38 INFO - 'LOGNAME': 'cltbld', 08:43:38 INFO - 'MAIL': '/var/mail/cltbld', 08:43:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:43:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:43:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:38 INFO - 'MOZ_NO_REMOTE': '1', 08:43:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:43:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:38 INFO - 'NO_EM_RESTART': '1', 08:43:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:38 INFO - 'PWD': '/builds/slave/test', 08:43:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:43:38 INFO - 'RUST_BACKTRACE': '1', 08:43:38 INFO - 'SHELL': '/bin/bash', 08:43:38 INFO - 'SHLVL': '1', 08:43:38 INFO - 'TERM': 'linux', 08:43:38 INFO - 'TMOUT': '86400', 08:43:38 INFO - 'USER': 'cltbld', 08:43:38 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051', 08:43:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:38 INFO - '_': '/tools/buildbot/bin/python'} 08:43:38 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/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 08:43:38 INFO - mozversion application_buildid: 20170319151316 08:43:38 INFO - mozversion application_changeset: 928b6052cbcf3c1c29436313b61760dc35248d4a 08:43:38 INFO - mozversion application_display_name: Nightly 08:43:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:43:38 INFO - mozversion application_name: Firefox 08:43:38 INFO - mozversion application_remotingname: firefox 08:43:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:43:38 INFO - mozversion application_vendor: Mozilla 08:43:38 INFO - mozversion application_version: 55.0a1 08:43:38 INFO - mozversion platform_buildid: 20170319151316 08:43:38 INFO - mozversion platform_changeset: 928b6052cbcf3c1c29436313b61760dc35248d4a 08:43:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:43:38 INFO - mozversion platform_version: 55.0a1 08:43:38 INFO - using testdate: 1489938218 08:43:38 INFO - actual date: 1489938218 08:43:38 INFO - starting webserver on 'localhost:54998' 08:43:38 INFO - SUITE-START | Running 2 tests 08:43:38 INFO - TEST-START | dromaeo_css 08:43:38 INFO - operating with platform_type : linux_ 08:43:38 INFO - Initialising browser for dromaeo_css test... 08:43:38 INFO - TEST-INFO | started process 2554 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXgIWUp/profile http://localhost:54998/getInfo.html) 08:43:43 INFO - PID 2554 | __metrics Screen width/height:1600/1200 08:43:43 INFO - PID 2554 | colorDepth:24 08:43:43 INFO - PID 2554 | Browser inner width/height: 1024/697 08:43:43 INFO - PID 2554 | __metrics 08:43:44 ERROR - PID 2554 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 08:43:45 INFO - TEST-INFO | 2554: exit 0 08:43:45 INFO - Browser initialized. 08:43:45 INFO - Running cycle 1/1 for dromaeo_css test... 08:43:45 INFO - TEST-INFO | started process 2685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXgIWUp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:57 INFO - PID 2685 | RSS: Main: 155525120 08:43:57 INFO - PID 2685 | 08:47:01 INFO - PID 2685 | Cycle 1(1): loaded http://localhost:54998/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54998/tests/dromaeo/cssquery-ext.html) 08:47:03 INFO - PID 2685 | RSS: Main: 165076992 08:47:03 INFO - PID 2685 | 08:48:45 INFO - PID 2685 | ************************* 08:48:45 INFO - PID 2685 | A coding exception was thrown and uncaught in a Task. 08:48:45 INFO - PID 2685 | 08:48:45 ERROR - PID 2685 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:48:45 INFO - PID 2685 | Full stack: 08:48:45 INFO - PID 2685 | ************************* 08:50:06 INFO - PID 2685 | Cycle 1(1): loaded http://localhost:54998/tests/dromaeo/cssquery-ext.html (next: http://localhost:54998/tests/dromaeo/cssquery-jquery.html) 08:50:06 INFO - PID 2685 | RSS: Main: 161579008 08:50:06 INFO - PID 2685 | 08:53:08 INFO - PID 2685 | Cycle 1(1): loaded http://localhost:54998/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54998/tests/dromaeo/cssquery-mootools.html) 08:53:09 INFO - PID 2685 | RSS: Main: 169349120 08:53:09 INFO - PID 2685 | 08:56:11 INFO - PID 2685 | Cycle 1(1): loaded http://localhost:54998/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54998/tests/dromaeo/cssquery-prototype.html) 08:56:11 INFO - PID 2685 | RSS: Main: 161144832 08:56:11 INFO - PID 2685 | 08:59:14 INFO - PID 2685 | Cycle 1(1): loaded http://localhost:54998/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54998/tests/dromaeo/cssquery-yui.html) 08:59:15 INFO - PID 2685 | RSS: Main: 168984576 08:59:15 INFO - PID 2685 | 09:02:18 INFO - PID 2685 | Cycle 1(1): loaded http://localhost:54998/tests/dromaeo/cssquery-yui.html (next: http://localhost:54998/tests/dromaeo/cssquery-dojo.html) 09:02:18 INFO - PID 2685 | RSS: Main: 162082816 09:02:18 INFO - PID 2685 | 09:02:18 INFO - PID 2685 | __start_tp_report 09:02:18 INFO - PID 2685 | _x_x_mozilla_page_load 09:02:18 INFO - PID 2685 | _x_x_mozilla_page_load_details 09:02:18 INFO - PID 2685 | |i|pagename|runs| 09:02:18 INFO - PID 2685 | |0;dojo.html;2679;2706;2720.2791260316008;2740.575210842319;2757.393373457839;4989.077020751163;5088.10958082335;5088.516590923866;5122.692638441691;5168.896622067561;5051.964347308802;5097.59219262459;5108.64239503235;5150.098732721768;5175.120229560975;4610.861674149773;4660.4174478190225;4665.276882083265;4690.24956007039;4723.858284251478;4702.929456058162;4718.669693121483;4731.692439991407;4749.073930583538;4786.090642777878;4622.907541849144;4662.230731929228;4665.230237010889;4667.789949452283;4668.486466488684;4648.465426475965;4649.418822647169;4655.930161047587;4684.789184486706;4694.342792009122;4552.294394368878;4605.171069207541;4618.56123668251;4633.559811817872;4656.348111264426;4955.554000139969;4984.950150498485;5044.066847633199;5062.772175252086;5089.872753181163;5476.397596264408;5524.8342549723575;5533;5560.582956278296;5601.467860553241;5515.145152501369;5534.1975413565215;5565.721713914288;5569.832905012856;5583.5254003409755;5007;5060.671056381323;5062.139436295838;5178.948210517922;5180.585553155738;5418.729063546807;5523.475269849358;5538.335399751975;5543.473370029841;5543.77824887;5312.92030619541;5339.546138578186;5349.144136938071;5356.223347614652;5379.623426360117;5439.075357189287;5442.91835622466;5495.120780675073;5495.917561236584;5507.311586051744;5452.454754524516;5459.153831156177;5467.6416564206365;5471;5529.834104976777;5335.626506144533;5402.945970540323;5458.399576046631;5481.835544933659;5501;4662.207424737802;4668.836590719308;4673.626109911199;4699.825043739065;4708.929366059512;3994.2410941920944;4007.4189242559664;4013.0569316210667;4013.8595149170224;4057.0668746188544;4617.8383756568355;4628.467726211461;4757.881052973703;4760.928791021993;4794.2089555223;5557.638753481011;5559;5562.527185189223;5565.109582466866;5613.326400831845;4706.717596944194;4741.454732705714;4775;4784.4497882743235;4815.3258543803895;4824.228123500223;4862.3922009748785;4864.80540778372;4943.406791185081;4959.702417854868;5093.363329583802;5105.183170692671;5107.387113546398;5107.948920510896;5109.003744269831;5380;5447.591430642797;5449.3188351456065;5459.989901868167;5516.613837031369;5069.518395752398;5086.1353569893945;5095.33760611133;5122.871928201825;5139.640225184201;5254.5533629641905;5325.627206095536;5339.199120132012;5348.652337598043;5380.0046991306735;5364.14173732201;5424.728763561885;5431.5926305526455;5457.590680698884;5460.617756757148;5349.197620356822;5350.250964864844;5373.570114390761;5378.542823860016;5413.242146099628;5308.336457942757;5331.946680533145;5336.226247194058;5347.812826551052;5350.197470379474;5114.4629813869005;5256.6320357574605;5285.656432331886;5297.735113244399;5298.70857102863;5270.841874743764;5272.077386457431;5280;5283.735813209248;5313.707746073848;5140;5168.328117344721;5169.715665638426;5171.844844654666;5179.948200518097 09:02:18 INFO - PID 2685 | |1;ext.html;642.6593905230227;718.1238888555962;733.765195137556;861.3927181337154;861.4529773593766;32943.341133177324;33674.326513469714;33695;33747.83126084366;33808.661913380856;32217.838910805414;32668.509972350435;32669.67330326696;32683.509747353808;32725.509117363257;6323.778667746618;6486.870262594745;9037.457752534869;9227.446353218795;9239.445633262027;9208.401453905475;9248.260139188882;9253.907460925406;9337.299702522338;9363.578638961262;9395.107464790834;9564.426134431922;9593.616255349812;9595.520223988808;9624.989376115476;9486.241100711926;9505.809883802285;9529.618815247382;9542.379745316566;9571.952140239255;9068.365214434993;9193.264538836876;9206.815863682688;9231.261499080125;9231.584578693908;35188.64811351879;35408.82295588531;35457.82271088628;35525.64474355249;35595.64404355949;3248.391761831143;3327.218103745618;3337.3825842219267;3351.162209447638;3376.6623337666283;23753.643695344585;23919.760802391927;23934;24038.158664446837;24793.62809557858;3380.3431951488324;3431.8284085795613;3441.328940856534;3476.947845782315;3518.577770667511;143668;143767;143868;144713.27643361717;144794;38195.42706859399;38334.42498362527;38352.42471362932;38480.23039539193;38508.42237366442;39619.60380396159;39771;39937.60062399397;40025.399619005155;40118.39822402666;12608.747825043447;12787.168834025759;13156.736865262832;13339.666508337175;13391.933040334736;10560;10588.364698118137;10592.682219533426;10626.787464250827;10653.520591573399;13219.405126769318;13262.602121936357;13280.203187808762;13312;13386.531471398454;5380.78476860929;5522.420145884705;5524;5542.972285138549;5572.637778544382;798.9400794940402;827.0943317067802;830.5141492227115;837.4891316297054;864.4597126795753;21548.461288467915;22435.887820560794;22670.546589068457;22815;23056;853.38129855854;868.1318681318681;871.8517851965181;888.9511076890833;899.1997122560927;11631.197164439525;12123.575674851338;12161.635150945485;12179.330136842558;12252.081093917814;241233;241569;241743;241946;242170;41956.37065444021;42138.36792448116;42163.578364215966;42280.788596056824;42324;1205.833005571141;1220.3898050974512;1225.4179264849304;1239.5909349914507;1254.7239607286383;23927.282181533887;24983.87508062448;25717.871410642827;25739.613905791804;25781.226563203134;32736.83631581827;33339.33321333608;33358;33363.165920852174;33367.83316083404;224712;226001;226784;226934;228738;28818.711812881604;28955.27611809637;29170.854145729136;29330.266743331587;29337.559936601396;34802.651973479944;35474.290514190085;35516.82241588776;35554;35793.82103089468;29701.40597188001;30120.54819177758;30422;31036.68963310338;31466.21334466565;29838.254043648216;30005.399892001602;30257.394852103276;30611.846940766045;31263.218419539695;29902.551461727657;29932.102036938926;30016.099517014525;30027.69972300249;30487.237819054702;25365.239042828744;26604;27392.45215095647;27918.720812792424;28172.154835354973;21550.6767398486;21621.35135945924;21732.89133554322;21736.565268694852;21757.238496652542 09:02:18 INFO - PID 2685 | |2;jquery.html;396.34602905206424;408.0288912388513;411.8290909272652;418.322317845091;428.4494424664306;12342.81485777714;13773;17638.470845874628;18270.90864545677;18322.90838545807;13896.930515347409;14117.364718587662;17257.91371043146;18086.457406277834;19293.421197364103;5731.684757338345;5857.150713146591;5943.70281485924;5952.910706339387;5955.910661340062;5490.6431081979745;5799.536037117021;5807.854803629901;5817.912731309034;5825.912611310834;5641.68970706611;5790.594658373915;5791.507721843648;5826.446487583694;5847.122931560258;5765.308163020422;5854.414558544133;5855.941440585582;5862.38444963277;5883.882322353529;5697.145428185764;5709.200711900337;5710.486056254916;6558.901616475757;6832.59004459734;22862.513936594067;23024.65463018056;23047.078116875473;23261.418464538354;23414.180503682288;2321.1759825261956;2403.4111642647663;2421.1646981791255;2439.097533912464;2440.255722004788;13760.729479635847;14054.71890562183;14158;14276.643083922881;15334.386624535116;1952.726618273443;1973.6645368367558;1988.16497071229;1992.9103190356468;1999.7000449932482;83780;87329.56335218347;88516;94395.52802235945;95598;16713.91643041777;16866.156692165343;16973.483617824255;17177.914110429367;17289.56776080608;29024;29026.709732902822;29032;29071.709282907323;29144.708552914624;8605.139486051345;8936.731898043068;8939.821203575892;9202.263818894473;9324.25405967521;7285.271472852673;7289.161746399126;7314.817129571803;7455.925440745632;7480.625968701544;8832.955835220782;9344.813103737888;9387.90612093884;9425.9836852208;9536;3728.496652951871;3833.15670552478;3871.3031654302495;3906.5312162540677;3926.960730392717;822.4243029879109;849.9532525711145;863.3222920007764;864.3690106222493;876.4259410086404;18813.529661758566;19906;19989.600207995758;20059.147104734133;20233.392998210078;853.5177624642057;854.43607219235;856.280724191682;873.0745409865563;882.2677177942293;10465.42440165783;11106.111511079094;11154.553817847358;11191.160662950311;11251.606193783178;460320;465287;465998;471773;472055;76815;82051.17948820555;85836.57081714552;86242;86244.56877715571;1075.4891426572472;1085.1535802074395;1127.5940661361903;1127.8590176227972;1130.7512347283584;16365.836341636908;16574.751378729088;17035.744463832805;17040.57398565046;17241.91379043097;39614;39860;40001.79999099986;40220.79889600533;40225.39661905015;50940.74529627328;51441;51677.741611291705;53414.19878701745;53888.19167712566;10635.14918806509;10908.290961087503;10952.288101273392;10997.450127493754;11442.313461192354;12683.936580317039;12732.809007865075;12876.806847897102;12905.548305809252;12906.290154041242;11010.284331518425;11229.88770112321;11258.099352051653;11750.471228794553;11765.47055382527;10835.783284334111;11074.889251107386;11094.334339939629;11170.218084733991;11562.710932226762;11145.442727863412;11188.272762270426;11208.439578021229;11220.326780393203;11734.061275097802;9284.489353085644;10906.781864362827;10969.561217551209;11184.161187910777;11334.546618135182;9139.223166030963;9220.538973051454;9251.398659087137;9621.807563848544;9669.758256043655 09:02:18 INFO - PID 2685 | |3;mootools.html;1398.0423409964176;1400.97898531522;1402.9898473099365;1420.7087547052856;1489.3000289863764;8987.820243595124;9315.720528384143;9321.72034838955;9338.066193380659;9565.904340956587;9307.02276260993;9462.810743785138;9464.290178236643;9474.24206063515;9475.715728528137;1982.8116328948763;2010.8089731475486;2017.8486613504047;2018.1019446346381;2022.0193206294934;1987.4137129546746;2026.2502873936664;2035.9694604580943;2046.2633451957283;2058.50595856994;1975.733276007735;1994.8204661580455;2008.116428771336;2016.9899150504227;2019.4648418169197;1945.3191383015974;1948.162290215207;1955.2472298165237;1956.9315073972343;1976.683730603111;1928.855335849803;1935.8354539864129;1962.479942815155;2043.5708501214763;2049.7745248022707;9085.636574537011;9144.08559144087;9162.816743665157;9375.484348360837;9388.67139650109;4623.0984957933215;4789;4791.377120974251;4800.903981920342;4807.663463557517;2741.2872653110135;2744.6157537944705;2774.3618967637353;2816.901408450715;2844.5733140028956;998.8213907589042;1020.9438480883548;1036.4506811389974;1060.4697651174413;1072.7961687279392;13730.93134534331;13925.651858703613;14010.22943738094;14103.153810771386;14110.294485275695;3765.736398452082;3886.300465916162;3957.6240257175523;4016.7188296819527;4037.7981100944835;10331.225158113171;10343.482825858677;10386.480675966171;10392.37645741258;10423;4751.786169622375;4757.452892917289;4808.61531077513;4814.446338671028;4831.685940413862;4076;4228.556001619847;4308.849190278388;4309.245881970643;4394.8242070317465;3191.9361612767616;3230.3377807549396;3307.553480280131;3332.183615014337;3352.9664703352655;849.8470275350372;851.3529717414809;875.1379890807549;877.806882485852;885.7564169853213;791.2364568191723;794.0590400375573;802.1096582793095;809.9028116626042;810.8743144812563;5237.633365664443;5470.452954704498;5585.497305242548;5608.270924779753;5667.234923285386;861.9741407757778;878.6441491196076;888.4269646078243;889.4529864133511;899.9010108888017;3418.8290585470627;3438.896833095011;3443.1908501502126;3478.443449048191;3539.5134043701705;11697;12181.634550963485;12206.32865192423;12230.633081007583;12246.387680616112;11818.290902545874;11944.64166075019;12036.277823330629;12102.273863568214;12211.450484728208;8614.6984855531;8703.129687031245;8759.16787905148;8810.823783524294;8887.200151986352;5329.733513324396;5471.23402723627;5494.36814766307;5572.108462645957;5652.3217213934595;10554.630587929385;10579.10077643409;10591.841122383325;10703.571857125939;10710.410927399067;10470;10795.514201861091;10817.945910270399;10918.945405272923;10970.122390208924;7296.817579560554;7460.776176714708;7461.962690186514;7469.1037075551285;7502.062242219723;8869.157430044135;8870.290376769972;8897.154770297071;8911.598978045873;9002.549872506217;7870.331021863206;8049.678012879654;8080.353571714366;8144.959275203586;8192.426530142833;7484.812879678052;7572.621368931421;7594.772156835304;7749.7287594933905;7912.84174316522;7003.089598352181;7207.13514378278;7208.56748595086;7211.71153153868;7229.060222171084;4719.764011799465;4851.708897466164;4933.432655244693;4943.5797957174045;4980.377452818398;4884.462709101925;5007.1487847065355;5021.171506701354;5051.368578927634;5112.488751124858 09:02:18 INFO - PID 2685 | |4;prototype.html;346.25900572774253;366.4631315123345;370.42029224264036;374.8519334862731;382.7760759955426;5286.938094143287;5411.91882121768;5491.395946445893;5493.835184944448;5501.36734275558;5248.685078895269;5306.442823503535;5335.866603334918;5337.238711225296;5338.252644629755;4393.780310984446;4401.119776044788;4411.669124815636;4426.136903303857;4427.690061695683;4197.8530751423705;4349.760763158025;4399.890002749941;4410.889727756799;4416.712913660618;4383.539728328511;4386.495553011397;4391.956080439187;4396.758178300192;4400.44994375703;4386.517483076859;4387.670924680661;4391.165678521071;4391.3193455014525;4411.205982923073;3971.98014009931;4092.324766413568;4098.918021639581;4099.528554216274;4112.177564487115;5132.0249152661245;5132.461091585405;5164.612654050961;5172.793088276464;5174.844754657366;5138.922916156223;5154.9484505155215;5155;5156.149235376159;5164.845054648366;5515.503604675559;5582.5436807804435;5644.57665675076;5675.858103547403;5687.232223649796;4476.328550717386;4479;4498.8425405110665;4518.864434066983;4522.140793249305;5564.777408903639;5758.683272420015;5770.451807078321;5879.353780941343;5987.2815262168815;4637.559431853969;4642.187617166982;4654.906901861944;4670.462896766848;4672.205725026685;4721.102990431807;4737.739424331695;4746.43042834862;4756.524347565216;4766.380370551876;5028.547430731252;5106.923396149061;5112.258722485219;5124.615653825978;5124.666896651705;5609.80365687199;5626.015447296707;5627;5631.605787594911;5635.5773317001385;1644.9801123303628;1645.0047721128544;1656.9917150414171;1665.2256700634264;1667.8332166783225;1196.2284326609288;1245.2466257913832;1246.632243488155;1259.7102666386781;1265.7911444611536;4949.406071271398;4951.950480495221;4952.653314268039;4954.727489988013;4957.529034741694;5848.824535263949;5856.180134781134;5863.179154918314;5868.591538030927;5880.235569375954;4735.715857048588;4904.386951631046;4908.288298196813;4932.950670493321;4944.456109827916;3072.493038648598;3099.9225019374694;3104.9223769405944;3105.208171916192;3107.192130046204;5300.681959082391;5386.380566234855;5421.132618780976;5428.647137936022;5458.754356053987;5894.793682221101;5931.7923872665115;5942.316633587193;5951.4291425144565;5969.373215812364;5402.324709411324;5413.323334583177;5429.022775900376;5447.182922561568;5460.372057213472;5584.804531841366;5777.480026797609;5780.624259423124;5818;5831.533477321719;5433.646812957145;5729.799457019151;5733.856653583527;5742.989953516236;5761.395053519488;5213.985231371898;5281.181416880389;5396.001739678172;5431.4840090191365;5445.156000819879;4610.907781844411;4655.767211639472;4667.953320466752;4669.322948172564;4680.531946805292;5749.91375129365;5779.479846813807;5828.504577110823;5880.764769409176;5885.087811389241;5625.5218306442775;5630.634008789416;5630.887382252414;5648.293963254593;5661.122526008476;5633.464820842013;5646.9152962704775;5650.067738823048;5659.660420374791;5667.603267771216;5449.618526703092;5534.944650553443;5536.307961504812;5565.1930470082425;5580.888382232414;5658.321001479849;5663.830085097454;5673.489385955284;5681.829545113653;5687.459691329317;5364.409914909279;5511.728410481908;5515.586331025109;5528.80649177293;5538.338498450529 09:02:18 INFO - PID 2685 | |5;yui.html;647.4917190005847;651.443016221131;707.3068392974884;752.7741677496751;780.1691198873198;13252.337383130829;13342.599722008343;13726.2450565219;14444.5666630001;14572.34424450901;13159.736805263889;13613.455461781517;13799.31003449826;13822.792658110136;13826.377812998415;817.7138001699417;839;845.6744153500915;845.8392905347964;846.1496196322687;818.10008990111;848.775074605227;850.2560259772699;852.7058164933088;857.3012994409568;904.1049361132465;919.1911118215961;919.586186216202;919.7286800393866;920.8158368326361;901.589776651622;904.1094521895927;904.6336233825311;905.6558507767039;908.1917093786568;660.0462331930363;660.4848218389664;660.7522179182806;663.698017402081;663.9568428052161;12607;12854.742905141844;14975.251237438193;15022.924885375613;15042.699146017017;12492.75014499705;13875.791863122062;14137.505187318497;14179.305931872912;14216.14703117806;9885.802283954352;10286.356650069847;10504.474776261233;10676.733081672943;11179.441027948651;3261.9347613047607;3266.934661306784;3273.2798784267425;3288.2930170013324;3303.487959366302;65386;65879.3412065878;66604.3339566603;66688.66655666691;67120.6643966782;10354.948225258977;10367.896321036844;10376.221783366278;10472.424016679155;10606.787864242671;21648.89175554112;21661.67507487389;21704.89147554252;21752.45618859541;21759.67360489594;6555.311692272243;6714.697838597275;6850.794476165723;6917.412019978257;7001.879699248096;3587.892363229107;3630.618785027534;3666.5966743658178;3685.1155722626913;3717.553893532793;2834.6031555582235;2904.2448963269703;2906.4041871416307;2911.039357012181;2927.107232294128;444.5776512313315;453.9455265368177;461.967662263645;468.3256111199929;469.8003348576841;591.6391001489088;620.1442010026135;630.9369063093654;633.2622494793605;635.939585739354;8429.241368276884;8545.529995850287;8872.24585910192;8919.643214271486;8953.865692014626;611.5596770325359;621.6829416997364;633.7369991453587;638.3935261501592;640.5868215001298;4123.60825721556;4257.91484170321;4262.0660268447955;4272.636825869774;4349.934750978738;56238;56710.43289567134;64402.35597644057;65897.67051164714;66027.33972660212;42006.36990445146;45539.31691024637;45764;54659;56833.71583142058;44070.33894491585;45404.77297613491;45840.083198335844;46923.53076469192;47110.76444617755;8924.841859117189;9511.66709165176;9606.231501480004;9639.084286992724;9642.42145471274;31846.522302165024;32233.67766322307;32422.83788581042;33324;33423.83288083641;38062.429063564625;38328.23343533058;38567.614323856404;39273.410898837115;39589.40615890706;11112.277701949348;11227.438628068401;11404.144689148514;11427.714307142389;11451.198416110792;12832.165909215872;12848.421821018264;12922.935385323013;13002.674933126747;13751.931240344134;11661.24201926872;11794.52821887115;12379.93810030944;12414.62756117318;12965.870341296466;11662.475188616701;11924.940375298069;11958.162928594915;11999.940000299943;12358;11630.493059830498;12292.323922184365;12465.626031219077;12468.750624987631;12760.808587871375;10026.197904167504;10204.987309834256;10216.897831021595;10291.742706432398;10343.482825858828;8598.78503037429;8931.564245810108;9317.487538185194;9645.180159686504;9746.366486178376 09:02:18 INFO - PID 2685 | __end_tp_report 09:02:18 INFO - PID 2685 | __start_cc_report 09:02:18 INFO - PID 2685 | _x_x_mozilla_cycle_collect,382 09:02:18 INFO - PID 2685 | __end_cc_report 09:02:18 INFO - PID 2685 | __startTimestamp1489939338623__endTimestamp 09:02:18 INFO - PID 2685 | 09:02:18 INFO - PID 2685 | ------- Summary: start ------- 09:02:18 INFO - PID 2685 | Number of tests: 6 09:02:18 INFO - PID 2685 | 09:02:18 INFO - PID 2685 | [#0] dojo.html Cycles:165 Average:5036.47 Median:5150.10 stddev:549.31 (10.7%) stddev-sans-first:518.93 09:02:18 INFO - PID 2685 | Values: 2679.0 2706.0 2720.3 2740.6 2757.4 4989.1 5088.1 5088.5 5122.7 5168.9 5052.0 5097.6 5108.6 5150.1 5175.1 4610.9 4660.4 4665.3 4690.2 4723.9 4702.9 4718.7 4731.7 4749.1 4786.1 4622.9 4662.2 4665.2 4667.8 4668.5 4648.5 4649.4 4655.9 4684.8 4694.3 4552.3 4605.2 4618.6 4633.6 4656.3 4955.6 4985.0 5044.1 5062.8 5089.9 5476.4 5524.8 5533.0 5560.6 5601.5 5515.1 5534.2 5565.7 5569.8 5583.5 5007.0 5060.7 5062.1 5178.9 5180.6 5418.7 5523.5 5538.3 5543.5 5543.8 5312.9 5339.5 5349.1 5356.2 5379.6 5439.1 5442.9 5495.1 5495.9 5507.3 5452.5 5459.2 5467.6 5471.0 5529.8 5335.6 5402.9 5458.4 5481.8 5501.0 4662.2 4668.8 4673.6 4699.8 4708.9 3994.2 4007.4 4013.1 4013.9 4057.1 4617.8 4628.5 4757.9 4760.9 4794.2 5557.6 5559.0 5562.5 5565.1 5613.3 4706.7 4741.5 4775.0 4784.4 4815.3 4824.2 4862.4 4864.8 4943.4 4959.7 5093.4 5105.2 5107.4 5107.9 5109.0 5380.0 5447.6 5449.3 5460.0 5516.6 5069.5 5086.1 5095.3 5122.9 5139.6 5254.6 5325.6 5339.2 5348.7 5380.0 5364.1 5424.7 5431.6 5457.6 5460.6 5349.2 5350.3 5373.6 5378.5 5413.2 5308.3 5331.9 5336.2 5347.8 5350.2 5114.5 5256.6 5285.7 5297.7 5298.7 5270.8 5272.1 5280.0 5283.7 5313.7 5140.0 5168.3 5169.7 5171.8 5179.9 09:02:18 INFO - PID 2685 | 09:02:18 INFO - PID 2685 | [#1] ext.html Cycles:180 Average:34849.72 Median:32731.17 stddev:54190.11 (165.6%) stddev-sans-first:54281.26 09:02:18 INFO - PID 2685 | Values: 642.7 718.1 733.8 861.4 861.5 32943.3 33674.3 33695.0 33747.8 33808.7 32217.8 32668.5 32669.7 32683.5 32725.5 6323.8 6486.9 9037.5 9227.4 9239.4 9208.4 9248.3 9253.9 9337.3 9363.6 9395.1 9564.4 9593.6 9595.5 9625.0 9486.2 9505.8 9529.6 9542.4 9572.0 9068.4 9193.3 9206.8 9231.3 9231.6 35188.6 35408.8 35457.8 35525.6 35595.6 3248.4 3327.2 3337.4 3351.2 3376.7 23753.6 23919.8 23934.0 24038.2 24793.6 3380.3 3431.8 3441.3 3476.9 3518.6 143668.0 143767.0 143868.0 144713.3 144794.0 38195.4 38334.4 38352.4 38480.2 38508.4 39619.6 39771.0 39937.6 40025.4 40118.4 12608.7 12787.2 13156.7 13339.7 13391.9 10560.0 10588.4 10592.7 10626.8 10653.5 13219.4 13262.6 13280.2 13312.0 13386.5 5380.8 5522.4 5524.0 5543.0 5572.6 798.9 827.1 830.5 837.5 864.5 21548.5 22435.9 22670.5 22815.0 23056.0 853.4 868.1 871.9 889.0 899.2 11631.2 12123.6 12161.6 12179.3 12252.1 241233.0 241569.0 241743.0 241946.0 242170.0 41956.4 42138.4 42163.6 42280.8 42324.0 1205.8 1220.4 1225.4 1239.6 1254.7 23927.3 24983.9 25717.9 25739.6 25781.2 32736.8 33339.3 33358.0 33363.2 33367.8 224712.0 226001.0 226784.0 226934.0 228738.0 28818.7 28955.3 29170.9 29330.3 29337.6 34802.7 35474.3 35516.8 35554.0 35793.8 29701.4 30120.5 30422.0 31036.7 31466.2 29838.3 30005.4 30257.4 30611.8 31263.2 29902.6 29932.1 30016.1 30027.7 30487.2 25365.2 26604.0 27392.5 27918.7 28172.2 21550.7 21621.4 21732.9 21736.6 21757.2 09:02:18 INFO - PID 2685 | 09:02:18 INFO - PID 2685 | [#2] jquery.html Cycles:180 Average:28910.66 Median:3852.23 stddev:76956.99 (1997.7%) stddev-sans-first:77143.09 09:02:18 INFO - PID 2685 | Values: 396.3 408.0 411.8 418.3 428.4 12342.8 13773.0 17638.5 18270.9 18322.9 13896.9 14117.4 17257.9 18086.5 19293.4 5731.7 5857.2 5943.7 5952.9 5955.9 5490.6 5799.5 5807.9 5817.9 5825.9 5641.7 5790.6 5791.5 5826.4 5847.1 5765.3 5854.4 5855.9 5862.4 5883.9 5697.1 5709.2 5710.5 6558.9 6832.6 22862.5 23024.7 23047.1 23261.4 23414.2 2321.2 2403.4 2421.2 2439.1 2440.3 13760.7 14054.7 14158.0 14276.6 15334.4 1952.7 1973.7 1988.2 1992.9 1999.7 83780.0 87329.6 88516.0 94395.5 95598.0 16713.9 16866.2 16973.5 17177.9 17289.6 29024.0 29026.7 29032.0 29071.7 29144.7 8605.1 8936.7 8939.8 9202.3 9324.3 7285.3 7289.2 7314.8 7455.9 7480.6 8833.0 9344.8 9387.9 9426.0 9536.0 3728.5 3833.2 3871.3 3906.5 3927.0 822.4 850.0 863.3 864.4 876.4 18813.5 19906.0 19989.6 20059.1 20233.4 853.5 854.4 856.3 873.1 882.3 10465.4 11106.1 11154.6 11191.2 11251.6 460320.0 465287.0 465998.0 471773.0 472055.0 76815.0 82051.2 85836.6 86242.0 86244.6 1075.5 1085.2 1127.6 1127.9 1130.8 16365.8 16574.8 17035.7 17040.6 17241.9 39614.0 39860.0 40001.8 40220.8 40225.4 50940.7 51441.0 51677.7 53414.2 53888.2 10635.1 10908.3 10952.3 10997.5 11442.3 12683.9 12732.8 12876.8 12905.5 12906.3 11010.3 11229.9 11258.1 11750.5 11765.5 10835.8 11074.9 11094.3 11170.2 11562.7 11145.4 11188.3 11208.4 11220.3 11734.1 9284.5 10906.8 10969.6 11184.2 11334.5 9139.2 9220.5 9251.4 9621.8 9669.8 09:02:18 INFO - PID 2685 | 09:02:18 INFO - PID 2685 | [#3] mootools.html Cycles:180 Average:5808.01 Median:4735.78 stddev:3744.19 (79.1%) stddev-sans-first:3740.03 09:02:18 INFO - PID 2685 | Values: 1398.0 1401.0 1403.0 1420.7 1489.3 8987.8 9315.7 9321.7 9338.1 9565.9 9307.0 9462.8 9464.3 9474.2 9475.7 1982.8 2010.8 2017.8 2018.1 2022.0 1987.4 2026.3 2036.0 2046.3 2058.5 1975.7 1994.8 2008.1 2017.0 2019.5 1945.3 1948.2 1955.2 1956.9 1976.7 1928.9 1935.8 1962.5 2043.6 2049.8 9085.6 9144.1 9162.8 9375.5 9388.7 4623.1 4789.0 4791.4 4800.9 4807.7 2741.3 2744.6 2774.4 2816.9 2844.6 998.8 1020.9 1036.5 1060.5 1072.8 13730.9 13925.7 14010.2 14103.2 14110.3 3765.7 3886.3 3957.6 4016.7 4037.8 10331.2 10343.5 10386.5 10392.4 10423.0 4751.8 4757.5 4808.6 4814.4 4831.7 4076.0 4228.6 4308.8 4309.2 4394.8 3191.9 3230.3 3307.6 3332.2 3353.0 849.8 851.4 875.1 877.8 885.8 791.2 794.1 802.1 809.9 810.9 5237.6 5470.5 5585.5 5608.3 5667.2 862.0 878.6 888.4 889.5 899.9 3418.8 3438.9 3443.2 3478.4 3539.5 11697.0 12181.6 12206.3 12230.6 12246.4 11818.3 11944.6 12036.3 12102.3 12211.5 8614.7 8703.1 8759.2 8810.8 8887.2 5329.7 5471.2 5494.4 5572.1 5652.3 10554.6 10579.1 10591.8 10703.6 10710.4 10470.0 10795.5 10817.9 10918.9 10970.1 7296.8 7460.8 7462.0 7469.1 7502.1 8869.2 8870.3 8897.2 8911.6 9002.5 7870.3 8049.7 8080.4 8145.0 8192.4 7484.8 7572.6 7594.8 7749.7 7912.8 7003.1 7207.1 7208.6 7211.7 7229.1 4719.8 4851.7 4933.4 4943.6 4980.4 4884.5 5007.1 5021.2 5051.4 5112.5 09:02:18 INFO - PID 2685 | 09:02:18 INFO - PID 2685 | [#4] prototype.html Cycles:180 Average:4800.64 Median:5231.34 stddev:1287.43 (24.6%) stddev-sans-first:1246.87 09:02:18 INFO - PID 2685 | Values: 346.3 366.5 370.4 374.9 382.8 5286.9 5411.9 5491.4 5493.8 5501.4 5248.7 5306.4 5335.9 5337.2 5338.3 4393.8 4401.1 4411.7 4426.1 4427.7 4197.9 4349.8 4399.9 4410.9 4416.7 4383.5 4386.5 4392.0 4396.8 4400.4 4386.5 4387.7 4391.2 4391.3 4411.2 3972.0 4092.3 4098.9 4099.5 4112.2 5132.0 5132.5 5164.6 5172.8 5174.8 5138.9 5154.9 5155.0 5156.1 5164.8 5515.5 5582.5 5644.6 5675.9 5687.2 4476.3 4479.0 4498.8 4518.9 4522.1 5564.8 5758.7 5770.5 5879.4 5987.3 4637.6 4642.2 4654.9 4670.5 4672.2 4721.1 4737.7 4746.4 4756.5 4766.4 5028.5 5106.9 5112.3 5124.6 5124.7 5609.8 5626.0 5627.0 5631.6 5635.6 1645.0 1645.0 1657.0 1665.2 1667.8 1196.2 1245.2 1246.6 1259.7 1265.8 4949.4 4952.0 4952.7 4954.7 4957.5 5848.8 5856.2 5863.2 5868.6 5880.2 4735.7 4904.4 4908.3 4933.0 4944.5 3072.5 3099.9 3104.9 3105.2 3107.2 5300.7 5386.4 5421.1 5428.6 5458.8 5894.8 5931.8 5942.3 5951.4 5969.4 5402.3 5413.3 5429.0 5447.2 5460.4 5584.8 5777.5 5780.6 5818.0 5831.5 5433.6 5729.8 5733.9 5743.0 5761.4 5214.0 5281.2 5396.0 5431.5 5445.2 4610.9 4655.8 4668.0 4669.3 4680.5 5749.9 5779.5 5828.5 5880.8 5885.1 5625.5 5630.6 5630.9 5648.3 5661.1 5633.5 5646.9 5650.1 5659.7 5667.6 5449.6 5534.9 5536.3 5565.2 5580.9 5658.3 5663.8 5673.5 5681.8 5687.5 5364.4 5511.7 5515.6 5528.8 5538.3 09:02:18 INFO - PID 2685 | 09:02:18 INFO - PID 2685 | [#5] yui.html Cycles:180 Average:14404.85 Median:23132.14 stddev:17162.08 (74.2%) stddev-sans-first:17179.12 09:02:18 INFO - PID 2685 | Values: 647.5 651.4 707.3 752.8 780.2 13252.3 13342.6 13726.2 14444.6 14572.3 13159.7 13613.5 13799.3 13822.8 13826.4 817.7 839.0 845.7 845.8 846.1 818.1 848.8 850.3 852.7 857.3 904.1 919.2 919.6 919.7 920.8 901.6 904.1 904.6 905.7 908.2 660.0 660.5 660.8 663.7 664.0 12607.0 12854.7 14975.3 15022.9 15042.7 12492.8 13875.8 14137.5 14179.3 14216.1 9885.8 10286.4 10504.5 10676.7 11179.4 3261.9 3266.9 3273.3 3288.3 3303.5 65386.0 65879.3 66604.3 66688.7 67120.7 10354.9 10367.9 10376.2 10472.4 10606.8 21648.9 21661.7 21704.9 21752.5 21759.7 6555.3 6714.7 6850.8 6917.4 7001.9 3587.9 3630.6 3666.6 3685.1 3717.6 2834.6 2904.2 2906.4 2911.0 2927.1 444.6 453.9 462.0 468.3 469.8 591.6 620.1 630.9 633.3 635.9 8429.2 8545.5 8872.2 8919.6 8953.9 611.6 621.7 633.7 638.4 640.6 4123.6 4257.9 4262.1 4272.6 4349.9 56238.0 56710.4 64402.4 65897.7 66027.3 42006.4 45539.3 45764.0 54659.0 56833.7 44070.3 45404.8 45840.1 46923.5 47110.8 8924.8 9511.7 9606.2 9639.1 9642.4 31846.5 32233.7 32422.8 33324.0 33423.8 38062.4 38328.2 38567.6 39273.4 39589.4 11112.3 11227.4 11404.1 11427.7 11451.2 12832.2 12848.4 12922.9 13002.7 13751.9 11661.2 11794.5 12379.9 12414.6 12965.9 11662.5 11924.9 11958.2 11999.9 12358.0 11630.5 12292.3 12465.6 12468.8 12760.8 10026.2 10205.0 10216.9 10291.7 10343.5 8598.8 8931.6 9317.5 9645.2 9746.4 09:02:18 INFO - PID 2685 | -------- Summary: end -------- 09:02:18 INFO - PID 2685 | 09:02:19 INFO - TEST-INFO | 2685: exit 0 09:02:19 INFO - TEST-OK | dromaeo_css | took 1121008ms 09:02:19 INFO - TEST-START | kraken 09:02:19 INFO - operating with platform_type : linux_ 09:02:19 INFO - Initialising browser for kraken test... 09:02:19 INFO - TEST-INFO | started process 3171 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp32ANb0/profile http://localhost:54998/getInfo.html) 09:02:24 INFO - PID 3171 | __metrics Screen width/height:1600/1200 09:02:24 INFO - PID 3171 | colorDepth:24 09:02:24 INFO - PID 3171 | Browser inner width/height: 1024/697 09:02:24 INFO - PID 3171 | __metrics 09:02:24 ERROR - PID 3171 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 09:02:26 INFO - TEST-INFO | 3171: exit 0 09:02:26 INFO - Browser initialized. 09:02:26 INFO - Running cycle 1/1 for kraken test... 09:02:26 INFO - TEST-INFO | started process 3300 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp32ANb0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:38 INFO - PID 3300 | RSS: Main: 158375936 09:02:38 INFO - PID 3300 | 09:02:40 INFO - PID 3300 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54998/tests/kraken/driver.html?testName=audio-beat-detection) 09:02:41 INFO - PID 3300 | RSS: Main: 162459648 09:02:41 INFO - PID 3300 | 09:02:44 INFO - PID 3300 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54998/tests/kraken/driver.html?testName=audio-dft) 09:02:45 INFO - PID 3300 | RSS: Main: 162586624 09:02:45 INFO - PID 3300 | 09:02:48 INFO - PID 3300 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54998/tests/kraken/driver.html?testName=audio-fft) 09:02:48 INFO - PID 3300 | RSS: Main: 157229056 09:02:48 INFO - PID 3300 | 09:02:50 INFO - PID 3300 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54998/tests/kraken/driver.html?testName=audio-oscillator) 09:02:51 INFO - PID 3300 | RSS: Main: 158396416 09:02:51 INFO - PID 3300 | 09:02:53 INFO - PID 3300 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54998/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:02:54 INFO - PID 3300 | RSS: Main: 158453760 09:02:54 INFO - PID 3300 | 09:02:57 INFO - PID 3300 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54998/tests/kraken/driver.html?testName=imaging-darkroom) 09:02:58 INFO - PID 3300 | RSS: Main: 163770368 09:02:58 INFO - PID 3300 | 09:03:01 INFO - PID 3300 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54998/tests/kraken/driver.html?testName=imaging-desaturate) 09:03:02 INFO - PID 3300 | RSS: Main: 161771520 09:03:02 INFO - PID 3300 | 09:03:05 INFO - PID 3300 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54998/tests/kraken/driver.html?testName=json-parse-financial) 09:03:06 INFO - PID 3300 | RSS: Main: 162775040 09:03:06 INFO - PID 3300 | 09:03:07 INFO - PID 3300 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54998/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:03:08 INFO - PID 3300 | RSS: Main: 163000320 09:03:08 INFO - PID 3300 | 09:03:10 INFO - PID 3300 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54998/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:03:11 INFO - PID 3300 | RSS: Main: 163123200 09:03:11 INFO - PID 3300 | 09:03:13 INFO - PID 3300 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54998/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:03:13 INFO - PID 3300 | RSS: Main: 163368960 09:03:13 INFO - PID 3300 | 09:03:16 INFO - PID 3300 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54998/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:03:17 INFO - PID 3300 | RSS: Main: 163545088 09:03:17 INFO - PID 3300 | 09:03:20 INFO - PID 3300 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54998/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:03:21 INFO - PID 3300 | RSS: Main: 163287040 09:03:21 INFO - PID 3300 | 09:03:23 INFO - PID 3300 | Cycle 1(1): loaded http://localhost:54998/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54998/tests/kraken/driver.html?testName=ai-astar) 09:03:23 INFO - PID 3300 | RSS: Main: 165244928 09:03:23 INFO - PID 3300 | 09:03:23 INFO - PID 3300 | __start_tp_report 09:03:23 INFO - PID 3300 | _x_x_mozilla_page_load 09:03:23 INFO - PID 3300 | _x_x_mozilla_page_load_details 09:03:23 INFO - PID 3300 | |i|pagename|runs| 09:03:23 INFO - PID 3300 | |0;ai-astar;111;121;120;118;118;118;118;118;118;124 09:03:23 INFO - PID 3300 | |1;audio-beat-detection;148;126;124;169;125;127;129;128;150;133 09:03:23 INFO - PID 3300 | |2;audio-dft;165;164;164;168;169;167;163;165;164;165 09:03:23 INFO - PID 3300 | |3;audio-fft;76;76;76;110;78;86;79;78;97;75 09:03:23 INFO - PID 3300 | |4;audio-oscillator;84;85;104;85;85;85;108;87;85;115 09:03:23 INFO - PID 3300 | |5;imaging-gaussian-blur;115;114;114;113;114;119;114;114;114;115 09:03:23 INFO - PID 3300 | |6;imaging-darkroom;152;151;150;152;150;152;150;150;151;180 09:03:23 INFO - PID 3300 | |7;imaging-desaturate;95;95;95;94;95;95;94;95;95;95 09:03:23 INFO - PID 3300 | |8;json-parse-financial;70;68;69;70;71;70;70;69;69;69 09:03:23 INFO - PID 3300 | |9;json-stringify-tinderbox;57;57;70;57;56;59;56;57;57;57 09:03:23 INFO - PID 3300 | |10;stanford-crypto-aes;88;83;84;84;82;95;82;82;82;83 09:03:23 INFO - PID 3300 | |11;stanford-crypto-ccm;133;145;144;140;133;132;147;135;185;134 09:03:23 INFO - PID 3300 | |12;stanford-crypto-pbkdf2;185;198;197;196;201;194;188;194;194;196 09:03:23 INFO - PID 3300 | |13;stanford-crypto-sha256-iterative;72;71;72;73;72;73;74;80;72;72 09:03:23 INFO - PID 3300 | __end_tp_report 09:03:23 INFO - PID 3300 | __start_cc_report 09:03:23 INFO - PID 3300 | _x_x_mozilla_cycle_collect,900 09:03:23 INFO - PID 3300 | __end_cc_report 09:03:23 INFO - PID 3300 | __startTimestamp1489939403395__endTimestamp 09:03:23 INFO - PID 3300 | 09:03:23 INFO - PID 3300 | ------- Summary: start ------- 09:03:23 INFO - PID 3300 | Number of tests: 14 09:03:23 INFO - PID 3300 | 09:03:23 INFO - PID 3300 | [#0] ai-astar Cycles:10 Average:118.40 Median:118.00 stddev:3.27 (2.8%) stddev-sans-first:2.11 09:03:23 INFO - PID 3300 | Values: 111.0 121.0 120.0 118.0 118.0 118.0 118.0 118.0 118.0 124.0 09:03:23 INFO - PID 3300 | 09:03:23 INFO - PID 3300 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:131.00 stddev:14.90 (11.4%) stddev-sans-first:15.14 09:03:23 INFO - PID 3300 | Values: 148.0 126.0 124.0 169.0 125.0 127.0 129.0 128.0 150.0 133.0 09:03:23 INFO - PID 3300 | 09:03:23 INFO - PID 3300 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.00 stddev:1.96 (1.2%) stddev-sans-first:2.07 09:03:23 INFO - PID 3300 | Values: 165.0 164.0 164.0 168.0 169.0 167.0 163.0 165.0 164.0 165.0 09:03:23 INFO - PID 3300 | 09:03:23 INFO - PID 3300 | [#3] audio-fft Cycles:10 Average:83.10 Median:78.00 stddev:11.60 (14.9%) stddev-sans-first:12.02 09:03:23 INFO - PID 3300 | Values: 76.0 76.0 76.0 110.0 78.0 86.0 79.0 78.0 97.0 75.0 09:03:23 INFO - PID 3300 | 09:03:23 INFO - PID 3300 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:85.00 stddev:11.84 (13.9%) stddev-sans-first:12.17 09:03:23 INFO - PID 3300 | Values: 84.0 85.0 104.0 85.0 85.0 85.0 108.0 87.0 85.0 115.0 09:03:23 INFO - PID 3300 | 09:03:23 INFO - PID 3300 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.00 stddev:1.65 (1.4%) stddev-sans-first:1.74 09:03:23 INFO - PID 3300 | Values: 115.0 114.0 114.0 113.0 114.0 119.0 114.0 114.0 114.0 115.0 09:03:23 INFO - PID 3300 | 09:03:23 INFO - PID 3300 | [#6] imaging-darkroom Cycles:10 Average:153.80 Median:151.50 stddev:9.25 (6.1%) stddev-sans-first:9.79 09:03:23 INFO - PID 3300 | Values: 152.0 151.0 150.0 152.0 150.0 152.0 150.0 150.0 151.0 180.0 09:03:23 INFO - PID 3300 | 09:03:23 INFO - PID 3300 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:03:23 INFO - PID 3300 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 09:03:23 INFO - PID 3300 | 09:03:23 INFO - PID 3300 | [#8] json-parse-financial Cycles:10 Average:69.50 Median:70.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 09:03:23 INFO - PID 3300 | Values: 70.0 68.0 69.0 70.0 71.0 70.0 70.0 69.0 69.0 69.0 09:03:23 INFO - PID 3300 | 09:03:23 INFO - PID 3300 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:57.00 stddev:4.19 (7.4%) stddev-sans-first:4.42 09:03:23 INFO - PID 3300 | Values: 57.0 57.0 70.0 57.0 56.0 59.0 56.0 57.0 57.0 57.0 09:03:23 INFO - PID 3300 | 09:03:23 INFO - PID 3300 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:83.50 stddev:4.12 (4.9%) stddev-sans-first:4.17 09:03:23 INFO - PID 3300 | Values: 88.0 83.0 84.0 84.0 82.0 95.0 82.0 82.0 82.0 83.0 09:03:23 INFO - PID 3300 | 09:03:23 INFO - PID 3300 | [#11] stanford-crypto-ccm Cycles:10 Average:142.80 Median:142.00 stddev:15.85 (11.2%) stddev-sans-first:16.40 09:03:23 INFO - PID 3300 | Values: 133.0 145.0 144.0 140.0 133.0 132.0 147.0 135.0 185.0 134.0 09:03:23 INFO - PID 3300 | 09:03:23 INFO - PID 3300 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.30 Median:196.00 stddev:4.69 (2.4%) stddev-sans-first:3.57 09:03:23 INFO - PID 3300 | Values: 185.0 198.0 197.0 196.0 201.0 194.0 188.0 194.0 194.0 196.0 09:03:23 INFO - PID 3300 | 09:03:23 INFO - PID 3300 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:72.50 stddev:2.56 (3.5%) stddev-sans-first:2.68 09:03:23 INFO - PID 3300 | Values: 72.0 71.0 72.0 73.0 72.0 73.0 74.0 80.0 72.0 72.0 09:03:23 INFO - PID 3300 | -------- Summary: end -------- 09:03:23 INFO - PID 3300 | 09:03:24 INFO - TEST-INFO | 3300: exit 0 09:03:24 INFO - TEST-OK | kraken | took 65110ms 09:03:24 INFO - SUITE-END | took 1186s 09:03:25 INFO - Completed test suite (00:19:46) 09:03:25 INFO - javascript benchmark 09:03:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6762.01021026579, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2679.0, 2706.0, 2720.2791260316008, 2740.575210842319, 2757.393373457839, 4989.077020751163, 5088.10958082335, 5088.516590923866, 5122.692638441691, 5168.896622067561, 5051.964347308802, 5097.59219262459, 5108.64239503235, 5150.098732721768, 5175.120229560975, 4610.861674149773, 4660.4174478190225, 4665.276882083265, 4690.24956007039, 4723.858284251478, 4702.929456058162, 4718.669693121483, 4731.692439991407, 4749.073930583538, 4786.090642777878, 4622.907541849144, 4662.230731929228, 4665.230237010889, 4667.789949452283, 4668.486466488684, 4648.465426475965, 4649.418822647169, 4655.930161047587, 4684.789184486706, 4694.342792009122, 4552.294394368878, 4605.171069207541, 4618.56123668251, 4633.559811817872, 4656.348111264426, 4955.554000139969, 4984.950150498485, 5044.066847633199, 5062.772175252086, 5089.872753181163, 5476.397596264408, 5524.8342549723575, 5533.0, 5560.582956278296, 5601.467860553241, 5515.145152501369, 5534.1975413565215, 5565.721713914288, 5569.832905012856, 5583.5254003409755, 5007.0, 5060.671056381323, 5062.139436295838, 5178.948210517922, 5180.585553155738, 5418.729063546807, 5523.475269849358, 5538.335399751975, 5543.473370029841, 5543.77824887, 5312.92030619541, 5339.546138578186, 5349.144136938071, 5356.223347614652, 5379.623426360117, 5439.075357189287, 5442.91835622466, 5495.120780675073, 5495.917561236584, 5507.311586051744, 5452.454754524516, 5459.153831156177, 5467.6416564206365, 5471.0, 5529.834104976777, 5335.626506144533, 5402.945970540323, 5458.399576046631, 5481.835544933659, 5501.0, 4662.207424737802, 4668.836590719308, 4673.626109911199, 4699.825043739065, 4708.929366059512, 3994.2410941920944, 4007.4189242559664, 4013.0569316210667, 4013.8595149170224, 4057.0668746188544, 4617.8383756568355, 4628.467726211461, 4757.881052973703, 4760.928791021993, 4794.2089555223, 5557.638753481011, 5559.0, 5562.527185189223, 5565.109582466866, 5613.326400831845, 4706.717596944194, 4741.454732705714, 4775.0, 4784.4497882743235, 4815.3258543803895, 4824.228123500223, 4862.3922009748785, 4864.80540778372, 4943.406791185081, 4959.702417854868, 5093.363329583802, 5105.183170692671, 5107.387113546398, 5107.948920510896, 5109.003744269831, 5380.0, 5447.591430642797, 5449.3188351456065, 5459.989901868167, 5516.613837031369, 5069.518395752398, 5086.1353569893945, 5095.33760611133, 5122.871928201825, 5139.640225184201, 5254.5533629641905, 5325.627206095536, 5339.199120132012, 5348.652337598043, 5380.0046991306735, 5364.14173732201, 5424.728763561885, 5431.5926305526455, 5457.590680698884, 5460.617756757148, 5349.197620356822, 5350.250964864844, 5373.570114390761, 5378.542823860016, 5413.242146099628, 5308.336457942757, 5331.946680533145, 5336.226247194058, 5347.812826551052, 5350.197470379474, 5114.4629813869005, 5256.6320357574605, 5285.656432331886, 5297.735113244399, 5298.70857102863, 5270.841874743764, 5272.077386457431, 5280.0, 5283.735813209248, 5313.707746073848, 5140.0, 5168.328117344721, 5169.715665638426, 5171.844844654666, 5179.948200518097], "value": 4999.060478758356, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.6593905230227, 718.1238888555962, 733.765195137556, 861.3927181337154, 861.4529773593766, 32943.341133177324, 33674.326513469714, 33695.0, 33747.83126084366, 33808.661913380856, 32217.838910805414, 32668.509972350435, 32669.67330326696, 32683.509747353808, 32725.509117363257, 6323.778667746618, 6486.870262594745, 9037.457752534869, 9227.446353218795, 9239.445633262027, 9208.401453905475, 9248.260139188882, 9253.907460925406, 9337.299702522338, 9363.578638961262, 9395.107464790834, 9564.426134431922, 9593.616255349812, 9595.520223988808, 9624.989376115476, 9486.241100711926, 9505.809883802285, 9529.618815247382, 9542.379745316566, 9571.952140239255, 9068.365214434993, 9193.264538836876, 9206.815863682688, 9231.261499080125, 9231.584578693908, 35188.64811351879, 35408.82295588531, 35457.82271088628, 35525.64474355249, 35595.64404355949, 3248.391761831143, 3327.218103745618, 3337.3825842219267, 3351.162209447638, 3376.6623337666283, 23753.643695344585, 23919.760802391927, 23934.0, 24038.158664446837, 24793.62809557858, 3380.3431951488324, 3431.8284085795613, 3441.328940856534, 3476.947845782315, 3518.577770667511, 143668.0, 143767.0, 143868.0, 144713.27643361717, 144794.0, 38195.42706859399, 38334.42498362527, 38352.42471362932, 38480.23039539193, 38508.42237366442, 39619.60380396159, 39771.0, 39937.60062399397, 40025.399619005155, 40118.39822402666, 12608.747825043447, 12787.168834025759, 13156.736865262832, 13339.666508337175, 13391.933040334736, 10560.0, 10588.364698118137, 10592.682219533426, 10626.787464250827, 10653.520591573399, 13219.405126769318, 13262.602121936357, 13280.203187808762, 13312.0, 13386.531471398454, 5380.78476860929, 5522.420145884705, 5524.0, 5542.972285138549, 5572.637778544382, 798.9400794940402, 827.0943317067802, 830.5141492227115, 837.4891316297054, 864.4597126795753, 21548.461288467915, 22435.887820560794, 22670.546589068457, 22815.0, 23056.0, 853.38129855854, 868.1318681318681, 871.8517851965181, 888.9511076890833, 899.1997122560927, 11631.197164439525, 12123.575674851338, 12161.635150945485, 12179.330136842558, 12252.081093917814, 241233.0, 241569.0, 241743.0, 241946.0, 242170.0, 41956.37065444021, 42138.36792448116, 42163.578364215966, 42280.788596056824, 42324.0, 1205.833005571141, 1220.3898050974512, 1225.4179264849304, 1239.5909349914507, 1254.7239607286383, 23927.282181533887, 24983.87508062448, 25717.871410642827, 25739.613905791804, 25781.226563203134, 32736.83631581827, 33339.33321333608, 33358.0, 33363.165920852174, 33367.83316083404, 224712.0, 226001.0, 226784.0, 226934.0, 228738.0, 28818.711812881604, 28955.27611809637, 29170.854145729136, 29330.266743331587, 29337.559936601396, 34802.651973479944, 35474.290514190085, 35516.82241588776, 35554.0, 35793.82103089468, 29701.40597188001, 30120.54819177758, 30422.0, 31036.68963310338, 31466.21334466565, 29838.254043648216, 30005.399892001602, 30257.394852103276, 30611.846940766045, 31263.218419539695, 29902.551461727657, 29932.102036938926, 30016.099517014525, 30027.69972300249, 30487.237819054702, 25365.239042828744, 26604.0, 27392.45215095647, 27918.720812792424, 28172.154835354973, 21550.6767398486, 21621.35135945924, 21732.89133554322, 21736.565268694852, 21757.238496652542], "value": 15610.613417000264, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.34602905206424, 408.0288912388513, 411.8290909272652, 418.322317845091, 428.4494424664306, 12342.81485777714, 13773.0, 17638.470845874628, 18270.90864545677, 18322.90838545807, 13896.930515347409, 14117.364718587662, 17257.91371043146, 18086.457406277834, 19293.421197364103, 5731.684757338345, 5857.150713146591, 5943.70281485924, 5952.910706339387, 5955.910661340062, 5490.6431081979745, 5799.536037117021, 5807.854803629901, 5817.912731309034, 5825.912611310834, 5641.68970706611, 5790.594658373915, 5791.507721843648, 5826.446487583694, 5847.122931560258, 5765.308163020422, 5854.414558544133, 5855.941440585582, 5862.38444963277, 5883.882322353529, 5697.145428185764, 5709.200711900337, 5710.486056254916, 6558.901616475757, 6832.59004459734, 22862.513936594067, 23024.65463018056, 23047.078116875473, 23261.418464538354, 23414.180503682288, 2321.1759825261956, 2403.4111642647663, 2421.1646981791255, 2439.097533912464, 2440.255722004788, 13760.729479635847, 14054.71890562183, 14158.0, 14276.643083922881, 15334.386624535116, 1952.726618273443, 1973.6645368367558, 1988.16497071229, 1992.9103190356468, 1999.7000449932482, 83780.0, 87329.56335218347, 88516.0, 94395.52802235945, 95598.0, 16713.91643041777, 16866.156692165343, 16973.483617824255, 17177.914110429367, 17289.56776080608, 29024.0, 29026.709732902822, 29032.0, 29071.709282907323, 29144.708552914624, 8605.139486051345, 8936.731898043068, 8939.821203575892, 9202.263818894473, 9324.25405967521, 7285.271472852673, 7289.161746399126, 7314.817129571803, 7455.925440745632, 7480.625968701544, 8832.955835220782, 9344.813103737888, 9387.90612093884, 9425.9836852208, 9536.0, 3728.496652951871, 3833.15670552478, 3871.3031654302495, 3906.5312162540677, 3926.960730392717, 822.4243029879109, 849.9532525711145, 863.3222920007764, 864.3690106222493, 876.4259410086404, 18813.529661758566, 19906.0, 19989.600207995758, 20059.147104734133, 20233.392998210078, 853.5177624642057, 854.43607219235, 856.280724191682, 873.0745409865563, 882.2677177942293, 10465.42440165783, 11106.111511079094, 11154.553817847358, 11191.160662950311, 11251.606193783178, 460320.0, 465287.0, 465998.0, 471773.0, 472055.0, 76815.0, 82051.17948820555, 85836.57081714552, 86242.0, 86244.56877715571, 1075.4891426572472, 1085.1535802074395, 1127.5940661361903, 1127.8590176227972, 1130.7512347283584, 16365.836341636908, 16574.751378729088, 17035.744463832805, 17040.57398565046, 17241.91379043097, 39614.0, 39860.0, 40001.79999099986, 40220.79889600533, 40225.39661905015, 50940.74529627328, 51441.0, 51677.741611291705, 53414.19878701745, 53888.19167712566, 10635.14918806509, 10908.290961087503, 10952.288101273392, 10997.450127493754, 11442.313461192354, 12683.936580317039, 12732.809007865075, 12876.806847897102, 12905.548305809252, 12906.290154041242, 11010.284331518425, 11229.88770112321, 11258.099352051653, 11750.471228794553, 11765.47055382527, 10835.783284334111, 11074.889251107386, 11094.334339939629, 11170.218084733991, 11562.710932226762, 11145.442727863412, 11188.272762270426, 11208.439578021229, 11220.326780393203, 11734.061275097802, 9284.489353085644, 10906.781864362827, 10969.561217551209, 11184.161187910777, 11334.546618135182, 9139.223166030963, 9220.538973051454, 9251.398659087137, 9621.807563848544, 9669.758256043655], "value": 9877.55925160087, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1398.0423409964176, 1400.97898531522, 1402.9898473099365, 1420.7087547052856, 1489.3000289863764, 8987.820243595124, 9315.720528384143, 9321.72034838955, 9338.066193380659, 9565.904340956587, 9307.02276260993, 9462.810743785138, 9464.290178236643, 9474.24206063515, 9475.715728528137, 1982.8116328948763, 2010.8089731475486, 2017.8486613504047, 2018.1019446346381, 2022.0193206294934, 1987.4137129546746, 2026.2502873936664, 2035.9694604580943, 2046.2633451957283, 2058.50595856994, 1975.733276007735, 1994.8204661580455, 2008.116428771336, 2016.9899150504227, 2019.4648418169197, 1945.3191383015974, 1948.162290215207, 1955.2472298165237, 1956.9315073972343, 1976.683730603111, 1928.855335849803, 1935.8354539864129, 1962.479942815155, 2043.5708501214763, 2049.7745248022707, 9085.636574537011, 9144.08559144087, 9162.816743665157, 9375.484348360837, 9388.67139650109, 4623.0984957933215, 4789.0, 4791.377120974251, 4800.903981920342, 4807.663463557517, 2741.2872653110135, 2744.6157537944705, 2774.3618967637353, 2816.901408450715, 2844.5733140028956, 998.8213907589042, 1020.9438480883548, 1036.4506811389974, 1060.4697651174413, 1072.7961687279392, 13730.93134534331, 13925.651858703613, 14010.22943738094, 14103.153810771386, 14110.294485275695, 3765.736398452082, 3886.300465916162, 3957.6240257175523, 4016.7188296819527, 4037.7981100944835, 10331.225158113171, 10343.482825858677, 10386.480675966171, 10392.37645741258, 10423.0, 4751.786169622375, 4757.452892917289, 4808.61531077513, 4814.446338671028, 4831.685940413862, 4076.0, 4228.556001619847, 4308.849190278388, 4309.245881970643, 4394.8242070317465, 3191.9361612767616, 3230.3377807549396, 3307.553480280131, 3332.183615014337, 3352.9664703352655, 849.8470275350372, 851.3529717414809, 875.1379890807549, 877.806882485852, 885.7564169853213, 791.2364568191723, 794.0590400375573, 802.1096582793095, 809.9028116626042, 810.8743144812563, 5237.633365664443, 5470.452954704498, 5585.497305242548, 5608.270924779753, 5667.234923285386, 861.9741407757778, 878.6441491196076, 888.4269646078243, 889.4529864133511, 899.9010108888017, 3418.8290585470627, 3438.896833095011, 3443.1908501502126, 3478.443449048191, 3539.5134043701705, 11697.0, 12181.634550963485, 12206.32865192423, 12230.633081007583, 12246.387680616112, 11818.290902545874, 11944.64166075019, 12036.277823330629, 12102.273863568214, 12211.450484728208, 8614.6984855531, 8703.129687031245, 8759.16787905148, 8810.823783524294, 8887.200151986352, 5329.733513324396, 5471.23402723627, 5494.36814766307, 5572.108462645957, 5652.3217213934595, 10554.630587929385, 10579.10077643409, 10591.841122383325, 10703.571857125939, 10710.410927399067, 10470.0, 10795.514201861091, 10817.945910270399, 10918.945405272923, 10970.122390208924, 7296.817579560554, 7460.776176714708, 7461.962690186514, 7469.1037075551285, 7502.062242219723, 8869.157430044135, 8870.290376769972, 8897.154770297071, 8911.598978045873, 9002.549872506217, 7870.331021863206, 8049.678012879654, 8080.353571714366, 8144.959275203586, 8192.426530142833, 7484.812879678052, 7572.621368931421, 7594.772156835304, 7749.7287594933905, 7912.84174316522, 7003.089598352181, 7207.13514378278, 7208.56748595086, 7211.71153153868, 7229.060222171084, 4719.764011799465, 4851.708897466164, 4933.432655244693, 4943.5797957174045, 4980.377452818398, 4884.462709101925, 5007.1487847065355, 5021.171506701354, 5051.368578927634, 5112.488751124858], "value": 4387.4185314664755, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.25900572774253, 366.4631315123345, 370.42029224264036, 374.8519334862731, 382.7760759955426, 5286.938094143287, 5411.91882121768, 5491.395946445893, 5493.835184944448, 5501.36734275558, 5248.685078895269, 5306.442823503535, 5335.866603334918, 5337.238711225296, 5338.252644629755, 4393.780310984446, 4401.119776044788, 4411.669124815636, 4426.136903303857, 4427.690061695683, 4197.8530751423705, 4349.760763158025, 4399.890002749941, 4410.889727756799, 4416.712913660618, 4383.539728328511, 4386.495553011397, 4391.956080439187, 4396.758178300192, 4400.44994375703, 4386.517483076859, 4387.670924680661, 4391.165678521071, 4391.3193455014525, 4411.205982923073, 3971.98014009931, 4092.324766413568, 4098.918021639581, 4099.528554216274, 4112.177564487115, 5132.0249152661245, 5132.461091585405, 5164.612654050961, 5172.793088276464, 5174.844754657366, 5138.922916156223, 5154.9484505155215, 5155.0, 5156.149235376159, 5164.845054648366, 5515.503604675559, 5582.5436807804435, 5644.57665675076, 5675.858103547403, 5687.232223649796, 4476.328550717386, 4479.0, 4498.8425405110665, 4518.864434066983, 4522.140793249305, 5564.777408903639, 5758.683272420015, 5770.451807078321, 5879.353780941343, 5987.2815262168815, 4637.559431853969, 4642.187617166982, 4654.906901861944, 4670.462896766848, 4672.205725026685, 4721.102990431807, 4737.739424331695, 4746.43042834862, 4756.524347565216, 4766.380370551876, 5028.547430731252, 5106.923396149061, 5112.258722485219, 5124.615653825978, 5124.666896651705, 5609.80365687199, 5626.015447296707, 5627.0, 5631.605787594911, 5635.5773317001385, 1644.9801123303628, 1645.0047721128544, 1656.9917150414171, 1665.2256700634264, 1667.8332166783225, 1196.2284326609288, 1245.2466257913832, 1246.632243488155, 1259.7102666386781, 1265.7911444611536, 4949.406071271398, 4951.950480495221, 4952.653314268039, 4954.727489988013, 4957.529034741694, 5848.824535263949, 5856.180134781134, 5863.179154918314, 5868.591538030927, 5880.235569375954, 4735.715857048588, 4904.386951631046, 4908.288298196813, 4932.950670493321, 4944.456109827916, 3072.493038648598, 3099.9225019374694, 3104.9223769405944, 3105.208171916192, 3107.192130046204, 5300.681959082391, 5386.380566234855, 5421.132618780976, 5428.647137936022, 5458.754356053987, 5894.793682221101, 5931.7923872665115, 5942.316633587193, 5951.4291425144565, 5969.373215812364, 5402.324709411324, 5413.323334583177, 5429.022775900376, 5447.182922561568, 5460.372057213472, 5584.804531841366, 5777.480026797609, 5780.624259423124, 5818.0, 5831.533477321719, 5433.646812957145, 5729.799457019151, 5733.856653583527, 5742.989953516236, 5761.395053519488, 5213.985231371898, 5281.181416880389, 5396.001739678172, 5431.4840090191365, 5445.156000819879, 4610.907781844411, 4655.767211639472, 4667.953320466752, 4669.322948172564, 4680.531946805292, 5749.91375129365, 5779.479846813807, 5828.504577110823, 5880.764769409176, 5885.087811389241, 5625.5218306442775, 5630.634008789416, 5630.887382252414, 5648.293963254593, 5661.122526008476, 5633.464820842013, 5646.9152962704775, 5650.067738823048, 5659.660420374791, 5667.603267771216, 5449.618526703092, 5534.944650553443, 5536.307961504812, 5565.1930470082425, 5580.888382232414, 5658.321001479849, 5663.830085097454, 5673.489385955284, 5681.829545113653, 5687.459691329317, 5364.409914909279, 5511.728410481908, 5515.586331025109, 5528.80649177293, 5538.338498450529], "value": 4413.745135419829, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.4917190005847, 651.443016221131, 707.3068392974884, 752.7741677496751, 780.1691198873198, 13252.337383130829, 13342.599722008343, 13726.2450565219, 14444.5666630001, 14572.34424450901, 13159.736805263889, 13613.455461781517, 13799.31003449826, 13822.792658110136, 13826.377812998415, 817.7138001699417, 839.0, 845.6744153500915, 845.8392905347964, 846.1496196322687, 818.10008990111, 848.775074605227, 850.2560259772699, 852.7058164933088, 857.3012994409568, 904.1049361132465, 919.1911118215961, 919.586186216202, 919.7286800393866, 920.8158368326361, 901.589776651622, 904.1094521895927, 904.6336233825311, 905.6558507767039, 908.1917093786568, 660.0462331930363, 660.4848218389664, 660.7522179182806, 663.698017402081, 663.9568428052161, 12607.0, 12854.742905141844, 14975.251237438193, 15022.924885375613, 15042.699146017017, 12492.75014499705, 13875.791863122062, 14137.505187318497, 14179.305931872912, 14216.14703117806, 9885.802283954352, 10286.356650069847, 10504.474776261233, 10676.733081672943, 11179.441027948651, 3261.9347613047607, 3266.934661306784, 3273.2798784267425, 3288.2930170013324, 3303.487959366302, 65386.0, 65879.3412065878, 66604.3339566603, 66688.66655666691, 67120.6643966782, 10354.948225258977, 10367.896321036844, 10376.221783366278, 10472.424016679155, 10606.787864242671, 21648.89175554112, 21661.67507487389, 21704.89147554252, 21752.45618859541, 21759.67360489594, 6555.311692272243, 6714.697838597275, 6850.794476165723, 6917.412019978257, 7001.879699248096, 3587.892363229107, 3630.618785027534, 3666.5966743658178, 3685.1155722626913, 3717.553893532793, 2834.6031555582235, 2904.2448963269703, 2906.4041871416307, 2911.039357012181, 2927.107232294128, 444.5776512313315, 453.9455265368177, 461.967662263645, 468.3256111199929, 469.8003348576841, 591.6391001489088, 620.1442010026135, 630.9369063093654, 633.2622494793605, 635.939585739354, 8429.241368276884, 8545.529995850287, 8872.24585910192, 8919.643214271486, 8953.865692014626, 611.5596770325359, 621.6829416997364, 633.7369991453587, 638.3935261501592, 640.5868215001298, 4123.60825721556, 4257.91484170321, 4262.0660268447955, 4272.636825869774, 4349.934750978738, 56238.0, 56710.43289567134, 64402.35597644057, 65897.67051164714, 66027.33972660212, 42006.36990445146, 45539.31691024637, 45764.0, 54659.0, 56833.71583142058, 44070.33894491585, 45404.77297613491, 45840.083198335844, 46923.53076469192, 47110.76444617755, 8924.841859117189, 9511.66709165176, 9606.231501480004, 9639.084286992724, 9642.42145471274, 31846.522302165024, 32233.67766322307, 32422.83788581042, 33324.0, 33423.83288083641, 38062.429063564625, 38328.23343533058, 38567.614323856404, 39273.410898837115, 39589.40615890706, 11112.277701949348, 11227.438628068401, 11404.144689148514, 11427.714307142389, 11451.198416110792, 12832.165909215872, 12848.421821018264, 12922.935385323013, 13002.674933126747, 13751.931240344134, 11661.24201926872, 11794.52821887115, 12379.93810030944, 12414.62756117318, 12965.870341296466, 11662.475188616701, 11924.940375298069, 11958.162928594915, 11999.940000299943, 12358.0, 11630.493059830498, 12292.323922184365, 12465.626031219077, 12468.750624987631, 12760.808587871375, 10026.197904167504, 10204.987309834256, 10216.897831021595, 10291.742706432398, 10343.482825858828, 8598.78503037429, 8931.564245810108, 9317.487538185194, 9645.180159686504, 9746.366486178376], "value": 6403.864207415696, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1580.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 121.0, 120.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 124.0], "value": 118.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 126.0, 124.0, 169.0, 125.0, 127.0, 129.0, 128.0, 150.0, 133.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 164.0, 168.0, 169.0, 167.0, 163.0, 165.0, 164.0, 165.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 110.0, 78.0, 86.0, 79.0, 78.0, 97.0, 75.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 104.0, 85.0, 85.0, 85.0, 108.0, 87.0, 85.0, 115.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 113.0, 114.0, 119.0, 114.0, 114.0, 114.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 150.0, 152.0, 150.0, 152.0, 150.0, 150.0, 151.0, 180.0], "value": 153.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 70.0, 71.0, 70.0, 70.0, 69.0, 69.0, 69.0], "value": 69.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 70.0, 57.0, 56.0, 59.0, 56.0, 57.0, 57.0, 57.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 83.0, 84.0, 84.0, 82.0, 95.0, 82.0, 82.0, 82.0, 83.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 145.0, 144.0, 140.0, 133.0, 132.0, 147.0, 135.0, 185.0, 134.0], "value": 142.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 198.0, 197.0, 196.0, 201.0, 194.0, 188.0, 194.0, 194.0, 196.0], "value": 194.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 72.0, 73.0, 72.0, 73.0, 74.0, 80.0, 72.0, 72.0], "value": 73.1, "unit": "score"}]}]} 09:03:25 INFO - Return code: 0 09:03:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:03:25 ERROR - # TBPL SUCCESS # 09:03:25 INFO - Running post-action listener: _resource_record_post_action 09:03:25 INFO - [mozharness: 2017-03-19 16:03:25.196326Z] Finished run-tests step (success) 09:03:25 INFO - Running post-run listener: _resource_record_post_run 09:03:25 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 363991040; Read time: 20; Write time: 182644 09:03:25 INFO - TinderboxPrint: CPU usage
13.3% 09:03:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 09:03:25 INFO - TinderboxPrint: I/O write bytes / time
363,991,040 / 182,644 09:03:25 INFO - TinderboxPrint: CPU idle
8,312.7 (86.7%) 09:03:25 INFO - TinderboxPrint: CPU user
1,221.8 (12.7%) 09:03:25 INFO - TinderboxPrint: Swap in / out
0 / 0 09:03:25 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106004480; Read time: 0; Write time: 80276 09:03:25 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 257986560; Read time: 20; Write time: 102368 09:03:25 INFO - Running post-run listener: _upload_blobber_files 09:03:25 INFO - Blob upload gear active. 09:03:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:03:25 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:03:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:03:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:03:26 INFO - (blobuploader) - INFO - Open directory for files ... 09:03:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:03:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:03:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:27 INFO - (blobuploader) - INFO - Done attempting. 09:03:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:03:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:03:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:27 INFO - (blobuploader) - INFO - Done attempting. 09:03:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:03:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:03:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:29 INFO - (blobuploader) - INFO - Done attempting. 09:03:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:03:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:03:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:32 INFO - (blobuploader) - INFO - Done attempting. 09:03:32 INFO - (blobuploader) - INFO - Iteration through files over. 09:03:32 INFO - Return code: 0 09:03:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:03:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:03:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ec308ff2e0100a260c56996c3c2377a60b43957d349afb76f31b7c6d020eb5f2650619922521d50baa32f7881985e957695398734af692e6ef70d8077de006e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b28ec2c27fa6de5d80003b1febab9aebe49a4f6f25179ced7c7df547cda74381f29b56c8bf217b0d5ecd97ce1bf5aa6aa647542082b4c5f600986c0f79ac94c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff1e6631326cab86e4ec2b2e34415aaaa2cf6f23b846dca5e585d05e268c3190d294136dfaeb87a47680e02f217ad55e9b3d72b3d2cb9c6ac95bcbd738b3fcf8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ebf2b730f1a4f2ac2ed81285ea82a79370755c135235480d82b763920768ab3c01fa87345ac7882dd7f436b2f20be3fb8485200f34efa70a4d572ffe5cd7ea4c"} 09:03:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:03:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:03:32 INFO - Contents: 09:03:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ec308ff2e0100a260c56996c3c2377a60b43957d349afb76f31b7c6d020eb5f2650619922521d50baa32f7881985e957695398734af692e6ef70d8077de006e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b28ec2c27fa6de5d80003b1febab9aebe49a4f6f25179ced7c7df547cda74381f29b56c8bf217b0d5ecd97ce1bf5aa6aa647542082b4c5f600986c0f79ac94c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff1e6631326cab86e4ec2b2e34415aaaa2cf6f23b846dca5e585d05e268c3190d294136dfaeb87a47680e02f217ad55e9b3d72b3d2cb9c6ac95bcbd738b3fcf8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ebf2b730f1a4f2ac2ed81285ea82a79370755c135235480d82b763920768ab3c01fa87345ac7882dd7f436b2f20be3fb8485200f34efa70a4d572ffe5cd7ea4c"} 09:03:32 INFO - Running post-run listener: copy_logs_to_upload_dir 09:03:32 INFO - Copying logs to upload dir... 09:03:32 INFO - mkdir: /builds/slave/test/build/upload/logs 09:03:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.581120 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-03-19 09:03:32.036591) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-19 09:03:32.040897) ========= 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=652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051 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/7ec308ff2e0100a260c56996c3c2377a60b43957d349afb76f31b7c6d020eb5f2650619922521d50baa32f7881985e957695398734af692e6ef70d8077de006e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b28ec2c27fa6de5d80003b1febab9aebe49a4f6f25179ced7c7df547cda74381f29b56c8bf217b0d5ecd97ce1bf5aa6aa647542082b4c5f600986c0f79ac94c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff1e6631326cab86e4ec2b2e34415aaaa2cf6f23b846dca5e585d05e268c3190d294136dfaeb87a47680e02f217ad55e9b3d72b3d2cb9c6ac95bcbd738b3fcf8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ebf2b730f1a4f2ac2ed81285ea82a79370755c135235480d82b763920768ab3c01fa87345ac7882dd7f436b2f20be3fb8485200f34efa70a4d572ffe5cd7ea4c"} build_url:https://queue.taskcluster.net/v1/task/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011201 build_url: 'https://queue.taskcluster.net/v1/task/THEgzUy0TPurbZDABYtWIw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ec308ff2e0100a260c56996c3c2377a60b43957d349afb76f31b7c6d020eb5f2650619922521d50baa32f7881985e957695398734af692e6ef70d8077de006e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b28ec2c27fa6de5d80003b1febab9aebe49a4f6f25179ced7c7df547cda74381f29b56c8bf217b0d5ecd97ce1bf5aa6aa647542082b4c5f600986c0f79ac94c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff1e6631326cab86e4ec2b2e34415aaaa2cf6f23b846dca5e585d05e268c3190d294136dfaeb87a47680e02f217ad55e9b3d72b3d2cb9c6ac95bcbd738b3fcf8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ebf2b730f1a4f2ac2ed81285ea82a79370755c135235480d82b763920768ab3c01fa87345ac7882dd7f436b2f20be3fb8485200f34efa70a4d572ffe5cd7ea4c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-19 09:03:32.069024) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 09:03:32.069580) ========= 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=652eb03db935cfc1c15ebda0000001ad-1489933056.193377-1916928051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 09:03:32.154560) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-19 09:03:32.155108) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-19 09:03:32.155687) ========= ========= Total master_lag: 0.18 =========