builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1490156712.19 results: success (0) revision: 201231223cd4354a450c3e5d80959f35b8e4cf0c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 21:25:12.185894) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 21:25:12.186523) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 21:25:12.186804) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 21:25:12.206493) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 21:25:12.206753) ========= 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=0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-21 21:25:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.1M=0s 2017-03-21 21:25:12 (37.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131411 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 21:25:12.352986) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 21:25:12.353310) ========= 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=0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022717 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 21:25:12.414330) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 21:25:12.414787) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 201231223cd4354a450c3e5d80959f35b8e4cf0c --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 201231223cd4354a450c3e5d80959f35b8e4cf0c --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=0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-21 21:25:12,595 truncating revision to first 12 chars 2017-03-21 21:25:12,595 Setting DEBUG logging. 2017-03-21 21:25:12,595 attempt 1/10 2017-03-21 21:25:12,595 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/201231223cd4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-21 21:25:13,052 unpacking tar archive at: mozilla-central-201231223cd4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.850182 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 21:25:13.282810) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 21:25:13.283147) ========= script_repo_revision: 201231223cd4354a450c3e5d80959f35b8e4cf0c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 21:25:13.283545) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 21:25:13.283870) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 21:25:13.295382) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-21 21:25:13.295791) ========= /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=0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:25:13 INFO - MultiFileLogger online at 20170321 21:25:13 in /builds/slave/test 21:25:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 21:25:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:25:13 INFO - {'append_to_log': False, 21:25:13 INFO - 'base_work_dir': '/builds/slave/test', 21:25:13 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 21:25:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:25:13 INFO - 'branch': 'Firefox-Non-PGO', 21:25:13 INFO - 'buildbot_json_path': 'buildprops.json', 21:25:13 INFO - 'config_files': ('talos/linux_config.py',), 21:25:13 INFO - 'default_actions': ('clobber', 21:25:13 INFO - 'read-buildbot-config', 21:25:13 INFO - 'download-and-extract', 21:25:13 INFO - 'populate-webroot', 21:25:13 INFO - 'create-virtualenv', 21:25:13 INFO - 'install', 21:25:13 INFO - 'run-tests'), 21:25:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:25:13 INFO - 'download_minidump_stackwalk': True, 21:25:13 INFO - 'download_symbols': 'ondemand', 21:25:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:25:13 INFO - 'tooltool.py': '/tools/tooltool.py', 21:25:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:25:13 INFO - '/tools/misc-python/virtualenv.py')}, 21:25:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:25:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:25:13 INFO - 'gecko_profile': False, 21:25:13 INFO - 'gecko_profile_interval': 0, 21:25:13 INFO - 'installer_path': 'installer.exe', 21:25:13 INFO - 'log_level': 'info', 21:25:13 INFO - 'log_name': 'talos', 21:25:13 INFO - 'log_to_console': True, 21:25:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:25:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:25:13 INFO - 'opt_config_files': (), 21:25:13 INFO - 'pip_index': False, 21:25:13 INFO - 'suite': 'dromaeojs-e10s', 21:25:13 INFO - 'system_bits': '32', 21:25:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:25:13 INFO - 'title': 'talos-linux64-ix-017', 21:25:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:25:13 INFO - 'use_talos_json': True, 21:25:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:25:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:25:13 INFO - 'work_dir': 'build'} 21:25:13 INFO - [mozharness: 2017-03-22 04:25:13.572377Z] Running clobber step. 21:25:13 INFO - Running pre-action listener: _resource_record_pre_action 21:25:13 INFO - Running main action method: clobber 21:25:13 INFO - rmtree: /builds/slave/test/build 21:25:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:25:15 INFO - Running post-action listener: _resource_record_post_action 21:25:15 INFO - [mozharness: 2017-03-22 04:25:15.010277Z] Finished clobber step (success) 21:25:15 INFO - [mozharness: 2017-03-22 04:25:15.010376Z] Running read-buildbot-config step. 21:25:15 INFO - Running pre-action listener: _resource_record_pre_action 21:25:15 INFO - Running main action method: read_buildbot_config 21:25:15 INFO - Using buildbot properties: 21:25:15 INFO - { 21:25:15 INFO - "project": "", 21:25:15 INFO - "product": "firefox", 21:25:15 INFO - "who": "philringnalda@gmail.com", 21:25:15 INFO - "installer_path": "public/build/target.tar.bz2", 21:25:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 21:25:15 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 21:25:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 21:25:15 INFO - "stage_platform": "linux64", 21:25:15 INFO - "basedir": "/builds/slave/test", 21:25:15 INFO - "buildnumber": 729, 21:25:15 INFO - "platform": "ubuntu64_hw", 21:25:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:25:15 INFO - "slavebuilddir": "test", 21:25:15 INFO - "taskId": "CwPg4l_kQ1uSFQIzWMWqhA", 21:25:15 INFO - "branch": "mozilla-central", 21:25:15 INFO - "script_repo_revision": "production", 21:25:15 INFO - "revision": "201231223cd4354a450c3e5d80959f35b8e4cf0c", 21:25:15 INFO - "slavename": "talos-linux64-ix-017", 21:25:15 INFO - "repo_path": "mozilla-central" 21:25:15 INFO - } 21:25:15 INFO - Finding installer, test and symbols from parent task. 21:25:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CwPg4l_kQ1uSFQIzWMWqhA'}, attempt #1 21:25:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CwPg4l_kQ1uSFQIzWMWqhA'}, attempt #1 21:25:15 INFO - Task dependencies: MMsmozg5SXml2DBjKo-UDg 21:25:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MMsmozg5SXml2DBjKo-UDg'}, attempt #1 21:25:16 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/target.tar.bz2 21:25:16 INFO - Set test_url: https://queue.taskcluster.net/v1/task/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/test_packages.json 21:25:16 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/target.crashreporter-symbols.zip 21:25:16 INFO - Running post-action listener: _resource_record_post_action 21:25:16 INFO - [mozharness: 2017-03-22 04:25:16.390785Z] Finished read-buildbot-config step (success) 21:25:16 INFO - [mozharness: 2017-03-22 04:25:16.391002Z] Running download-and-extract step. 21:25:16 INFO - Running pre-action listener: _resource_record_pre_action 21:25:16 INFO - Running main action method: download_and_extract 21:25:16 INFO - mkdir: /builds/slave/test/build/tests 21:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:16 INFO - trying https://queue.taskcluster.net/v1/task/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/target.test_packages.json 21:25:16 INFO - Downloading https://queue.taskcluster.net/v1/task/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:25:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:25:16 INFO - Downloaded 986 bytes. 21:25:16 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:25:16 INFO - Using the following test package requirements: 21:25:16 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:25:16 INFO - u'common': [u'target.common.tests.zip'], 21:25:16 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:25:16 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:25:16 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:25:16 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:25:16 INFO - u'mozbase': [u'target.common.tests.zip'], 21:25:16 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:25:16 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:25:16 INFO - u'web-platform': [u'target.common.tests.zip', 21:25:16 INFO - u'target.web-platform.tests.zip'], 21:25:16 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:25:16 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 21:25:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/target.common.tests.zip 21:25:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:25:16 INFO - Fetch https://queue.taskcluster.net/v1/task/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/target.common.tests.zip into memory 21:25:18 INFO - Expected file size: 58193303 21:25:18 INFO - Obtained file size: 58193303 21:25:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 21:25:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/target.common.tests.zip 21:25:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:25:27 INFO - Fetch https://queue.taskcluster.net/v1/task/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/target.common.tests.zip into memory 21:25:29 INFO - Expected file size: 58193303 21:25:29 INFO - Obtained file size: 58193303 21:25:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/target.talos.tests.zip 21:25:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:25:39 INFO - Fetch https://queue.taskcluster.net/v1/task/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/target.talos.tests.zip into memory 21:25:40 INFO - Expected file size: 14404171 21:25:40 INFO - Obtained file size: 14404171 21:25:40 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')]} 21:25:40 INFO - trying https://queue.taskcluster.net/v1/task/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/target.tar.bz2 21:25:40 INFO - Downloading https://queue.taskcluster.net/v1/task/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:25:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:25:42 INFO - Downloaded 61958199 bytes. 21:25:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/target.tar.bz2 21:25:42 INFO - mkdir: /builds/slave/test/properties 21:25:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:25:42 INFO - Writing to file /builds/slave/test/properties/build_url 21:25:42 INFO - Contents: 21:25:42 INFO - build_url:https://queue.taskcluster.net/v1/task/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/target.tar.bz2 21:25:42 INFO - Running post-action listener: _resource_record_post_action 21:25:42 INFO - Running post-action listener: set_extra_try_arguments 21:25:42 INFO - [mozharness: 2017-03-22 04:25:42.324298Z] Finished download-and-extract step (success) 21:25:42 INFO - [mozharness: 2017-03-22 04:25:42.324395Z] Running populate-webroot step. 21:25:42 INFO - Running pre-action listener: _resource_record_pre_action 21:25:42 INFO - Running main action method: populate_webroot 21:25:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:25:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:25:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:25:42 INFO - '--tppagecycles', 21:25:42 INFO - '7'], 21:25:42 INFO - 'tests': ['tsvgm']}}, 21:25:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:25:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:25:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:25:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:25:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:25:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:25:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:25:42 INFO - 'talos_options': ['--disable-e10s'], 21:25:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:25:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:25:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:25:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:25:42 INFO - 'talos_options': ['--disable-e10s'], 21:25:42 INFO - 'tests': ['damp', 'tps']}, 21:25:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:25:42 INFO - 'tests': ['damp', 'tps']}, 21:25:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:25:42 INFO - 'tests': ['dromaeo_dom']}, 21:25:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:25:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:25:42 INFO - 'tests': ['basic_compositor_video']}, 21:25:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:25:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:25:42 INFO - 'tests': ['a11yr', 21:25:42 INFO - 'ts_paint', 21:25:42 INFO - 'tpaint', 21:25:42 INFO - 'sessionrestore', 21:25:42 INFO - 'sessionrestore_no_auto_restore', 21:25:42 INFO - 'tabpaint']}, 21:25:42 INFO - 'other-e10s': {'tests': ['a11yr', 21:25:42 INFO - 'ts_paint', 21:25:42 INFO - 'tpaint', 21:25:42 INFO - 'sessionrestore', 21:25:42 INFO - 'sessionrestore_no_auto_restore', 21:25:42 INFO - 'tabpaint']}, 21:25:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:25:42 INFO - 'ts_paint', 21:25:42 INFO - 'tpaint', 21:25:42 INFO - 'sessionrestore', 21:25:42 INFO - 'sessionrestore_no_auto_restore', 21:25:42 INFO - 'tabpaint']}, 21:25:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:25:42 INFO - 'ts_paint', 21:25:42 INFO - 'tpaint', 21:25:42 INFO - 'sessionrestore', 21:25:42 INFO - 'sessionrestore_no_auto_restore', 21:25:42 INFO - 'tabpaint']}, 21:25:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:25:42 INFO - 'tests': ['a11yr', 21:25:42 INFO - 'ts_paint', 21:25:42 INFO - 'tpaint', 21:25:42 INFO - 'sessionrestore', 21:25:42 INFO - 'sessionrestore_no_auto_restore', 21:25:42 INFO - 'tabpaint']}, 21:25:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:25:42 INFO - 'tests': ['a11yr', 21:25:42 INFO - 'ts_paint', 21:25:42 INFO - 'tpaint', 21:25:42 INFO - 'sessionrestore', 21:25:42 INFO - 'sessionrestore_no_auto_restore', 21:25:42 INFO - 'tabpaint']}, 21:25:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:25:42 INFO - 'tests': ['tsvgx', 21:25:42 INFO - 'tsvgr_opacity', 21:25:42 INFO - 'tart', 21:25:42 INFO - 'tscrollx', 21:25:42 INFO - 'cart', 21:25:42 INFO - 'tsvg_static']}, 21:25:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:25:42 INFO - 'tsvgr_opacity', 21:25:42 INFO - 'tart', 21:25:42 INFO - 'tscrollx', 21:25:42 INFO - 'cart', 21:25:42 INFO - 'tsvg_static']}, 21:25:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:25:42 INFO - 'talos_options': ['--disable-e10s'], 21:25:42 INFO - 'tests': ['tp5o']}, 21:25:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:25:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:25:42 INFO - 'talos_options': ['--disable-e10s', 21:25:42 INFO - '--xperf_path', 21:25:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:25:42 INFO - 'tests': ['tp5n']}, 21:25:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:25:42 INFO - 'talos_options': ['--xperf_path', 21:25:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:25:42 INFO - 'tests': ['tp5n']}}, 21:25:42 INFO - 'talos.zip': {'path': '', 21:25:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:25:42 INFO - Running post-action listener: _resource_record_post_action 21:25:42 INFO - [mozharness: 2017-03-22 04:25:42.337604Z] Finished populate-webroot step (success) 21:25:42 INFO - [mozharness: 2017-03-22 04:25:42.337693Z] Running create-virtualenv step. 21:25:42 INFO - Running pre-action listener: _resource_record_pre_action 21:25:42 INFO - Running main action method: create_virtualenv 21:25:42 INFO - Creating virtualenv /builds/slave/test/build/venv 21:25:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:25:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:25:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:25:42 INFO - Using real prefix '/usr' 21:25:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:25:42 INFO - Installing distribute.............................................................................................................................................................................................done. 21:25:44 INFO - Installing pip.................done. 21:25:44 INFO - Return code: 0 21:25:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:25:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:25:45 INFO - Reading from file tmpfile_stdout 21:25:45 INFO - Output received: 21:25:45 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:25:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c0b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29be290>, '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 0x29beb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bf040>, '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': '0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498', '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 21:25:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:25:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:25:45 INFO - Using env: {'DISPLAY': ':0', 21:25:45 INFO - 'HOME': '/home/cltbld', 21:25:45 INFO - 'LANG': 'en_US.UTF-8', 21:25:45 INFO - 'LANGUAGE': 'en_US:en', 21:25:45 INFO - 'LOGNAME': 'cltbld', 21:25:45 INFO - 'MAIL': '/var/mail/cltbld', 21:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:25:45 INFO - 'MOZ_NO_REMOTE': '1', 21:25:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:25:45 INFO - 'NO_EM_RESTART': '1', 21:25:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:25:45 INFO - 'PWD': '/builds/slave/test', 21:25:45 INFO - 'SHELL': '/bin/bash', 21:25:45 INFO - 'SHLVL': '1', 21:25:45 INFO - 'TERM': 'linux', 21:25:45 INFO - 'TMOUT': '86400', 21:25:45 INFO - 'USER': 'cltbld', 21:25:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498', 21:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:25:45 INFO - '_': '/tools/buildbot/bin/python'} 21:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:25:45 INFO - Cleaning up... 21:25:45 INFO - Return code: 0 21:25:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c0b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29be290>, '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 0x29beb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bf040>, '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': '0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498', '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 21:25:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:25:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:25:45 INFO - Using env: {'DISPLAY': ':0', 21:25:45 INFO - 'HOME': '/home/cltbld', 21:25:45 INFO - 'LANG': 'en_US.UTF-8', 21:25:45 INFO - 'LANGUAGE': 'en_US:en', 21:25:45 INFO - 'LOGNAME': 'cltbld', 21:25:45 INFO - 'MAIL': '/var/mail/cltbld', 21:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:25:45 INFO - 'MOZ_NO_REMOTE': '1', 21:25:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:25:45 INFO - 'NO_EM_RESTART': '1', 21:25:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:25:45 INFO - 'PWD': '/builds/slave/test', 21:25:45 INFO - 'SHELL': '/bin/bash', 21:25:45 INFO - 'SHLVL': '1', 21:25:45 INFO - 'TERM': 'linux', 21:25:45 INFO - 'TMOUT': '86400', 21:25:45 INFO - 'USER': 'cltbld', 21:25:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498', 21:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:25:45 INFO - '_': '/tools/buildbot/bin/python'} 21:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:25:45 INFO - Downloading/unpacking psutil>=3.1.1 21:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:25:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:25:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:25:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:25:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:25:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:25:47 INFO - Installing collected packages: psutil 21:25:47 INFO - Running setup.py install for psutil 21:25:47 INFO - building 'psutil._psutil_linux' extension 21:25:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:25:47 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 21:25:47 INFO - building 'psutil._psutil_posix' extension 21:25:47 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 21:25:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:25:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:25:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:25:48 INFO - Successfully installed psutil 21:25:48 INFO - Cleaning up... 21:25:48 INFO - Return code: 0 21:25:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c0b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29be290>, '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 0x29beb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bf040>, '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': '0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498', '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 21:25:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:25:48 INFO - Using env: {'DISPLAY': ':0', 21:25:48 INFO - 'HOME': '/home/cltbld', 21:25:48 INFO - 'LANG': 'en_US.UTF-8', 21:25:48 INFO - 'LANGUAGE': 'en_US:en', 21:25:48 INFO - 'LOGNAME': 'cltbld', 21:25:48 INFO - 'MAIL': '/var/mail/cltbld', 21:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:25:48 INFO - 'MOZ_NO_REMOTE': '1', 21:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:25:48 INFO - 'NO_EM_RESTART': '1', 21:25:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:25:48 INFO - 'PWD': '/builds/slave/test', 21:25:48 INFO - 'SHELL': '/bin/bash', 21:25:48 INFO - 'SHLVL': '1', 21:25:48 INFO - 'TERM': 'linux', 21:25:48 INFO - 'TMOUT': '86400', 21:25:48 INFO - 'USER': 'cltbld', 21:25:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498', 21:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:25:48 INFO - '_': '/tools/buildbot/bin/python'} 21:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:25:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:25:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:25:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:25:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:25:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:25:50 INFO - Installing collected packages: mozsystemmonitor 21:25:50 INFO - Running setup.py install for mozsystemmonitor 21:25:50 INFO - Successfully installed mozsystemmonitor 21:25:50 INFO - Cleaning up... 21:25:50 INFO - Return code: 0 21:25:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c0b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29be290>, '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 0x29beb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bf040>, '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': '0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498', '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 21:25:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:25:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:25:50 INFO - Using env: {'DISPLAY': ':0', 21:25:50 INFO - 'HOME': '/home/cltbld', 21:25:50 INFO - 'LANG': 'en_US.UTF-8', 21:25:50 INFO - 'LANGUAGE': 'en_US:en', 21:25:50 INFO - 'LOGNAME': 'cltbld', 21:25:50 INFO - 'MAIL': '/var/mail/cltbld', 21:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:25:50 INFO - 'MOZ_NO_REMOTE': '1', 21:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:25:50 INFO - 'NO_EM_RESTART': '1', 21:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:25:50 INFO - 'PWD': '/builds/slave/test', 21:25:50 INFO - 'SHELL': '/bin/bash', 21:25:50 INFO - 'SHLVL': '1', 21:25:50 INFO - 'TERM': 'linux', 21:25:50 INFO - 'TMOUT': '86400', 21:25:50 INFO - 'USER': 'cltbld', 21:25:50 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498', 21:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:25:50 INFO - '_': '/tools/buildbot/bin/python'} 21:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:25:50 INFO - Downloading/unpacking jsonschema==2.5.1 21:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:25:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:25:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:25:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:25:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:25:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:25:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:25:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:25:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:25:53 INFO - Downloading functools32-3.2.3-2.tar.gz 21:25:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:25:53 INFO - warning: no files found matching '*.txt' 21:25:53 INFO - no previously-included directories found matching 'build' 21:25:53 INFO - no previously-included directories found matching 'dist' 21:25:53 INFO - no previously-included directories found matching '.git*' 21:25:53 INFO - Installing collected packages: jsonschema, functools32 21:25:53 INFO - Running setup.py install for functools32 21:25:53 INFO - warning: no files found matching '*.txt' 21:25:53 INFO - no previously-included directories found matching 'build' 21:25:53 INFO - no previously-included directories found matching 'dist' 21:25:53 INFO - no previously-included directories found matching '.git*' 21:25:53 INFO - Successfully installed jsonschema functools32 21:25:53 INFO - Cleaning up... 21:25:53 INFO - Return code: 0 21:25:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c0b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29be290>, '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 0x29beb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bf040>, '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': '0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498', '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 21:25:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:25:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:25:53 INFO - Using env: {'DISPLAY': ':0', 21:25:53 INFO - 'HOME': '/home/cltbld', 21:25:53 INFO - 'LANG': 'en_US.UTF-8', 21:25:53 INFO - 'LANGUAGE': 'en_US:en', 21:25:53 INFO - 'LOGNAME': 'cltbld', 21:25:53 INFO - 'MAIL': '/var/mail/cltbld', 21:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:25:53 INFO - 'MOZ_NO_REMOTE': '1', 21:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:25:53 INFO - 'NO_EM_RESTART': '1', 21:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:25:53 INFO - 'PWD': '/builds/slave/test', 21:25:53 INFO - 'SHELL': '/bin/bash', 21:25:53 INFO - 'SHLVL': '1', 21:25:53 INFO - 'TERM': 'linux', 21:25:53 INFO - 'TMOUT': '86400', 21:25:53 INFO - 'USER': 'cltbld', 21:25:53 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498', 21:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:25:53 INFO - '_': '/tools/buildbot/bin/python'} 21:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:25:53 INFO - Cleaning up... 21:25:53 INFO - Return code: 0 21:25:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c0b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29be290>, '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 0x29beb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bf040>, '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': '0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498', '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 21:25:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:25:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:25:53 INFO - Using env: {'DISPLAY': ':0', 21:25:53 INFO - 'HOME': '/home/cltbld', 21:25:53 INFO - 'LANG': 'en_US.UTF-8', 21:25:53 INFO - 'LANGUAGE': 'en_US:en', 21:25:53 INFO - 'LOGNAME': 'cltbld', 21:25:53 INFO - 'MAIL': '/var/mail/cltbld', 21:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:25:53 INFO - 'MOZ_NO_REMOTE': '1', 21:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:25:53 INFO - 'NO_EM_RESTART': '1', 21:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:25:53 INFO - 'PWD': '/builds/slave/test', 21:25:53 INFO - 'SHELL': '/bin/bash', 21:25:53 INFO - 'SHLVL': '1', 21:25:53 INFO - 'TERM': 'linux', 21:25:53 INFO - 'TMOUT': '86400', 21:25:53 INFO - 'USER': 'cltbld', 21:25:53 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498', 21:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:25:53 INFO - '_': '/tools/buildbot/bin/python'} 21:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:25:53 INFO - Downloading/unpacking blobuploader==1.2.4 21:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:25:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:25:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:25:55 INFO - Downloading blobuploader-1.2.4.tar.gz 21:25:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:25:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:25:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:25:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:25:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:25:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:25:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:25:56 INFO - Downloading docopt-0.6.1.tar.gz 21:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:25:56 INFO - Installing collected packages: blobuploader, requests, docopt 21:25:56 INFO - Running setup.py install for blobuploader 21:25:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:25:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:25:56 INFO - Running setup.py install for requests 21:25:57 INFO - Running setup.py install for docopt 21:25:57 INFO - Successfully installed blobuploader requests docopt 21:25:57 INFO - Cleaning up... 21:25:57 INFO - Return code: 0 21:25:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c0b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29be290>, '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 0x29beb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bf040>, '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': '0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498', '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 21:25:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:25:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:25:57 INFO - Using env: {'DISPLAY': ':0', 21:25:57 INFO - 'HOME': '/home/cltbld', 21:25:57 INFO - 'LANG': 'en_US.UTF-8', 21:25:57 INFO - 'LANGUAGE': 'en_US:en', 21:25:57 INFO - 'LOGNAME': 'cltbld', 21:25:57 INFO - 'MAIL': '/var/mail/cltbld', 21:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:25:57 INFO - 'MOZ_NO_REMOTE': '1', 21:25:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:25:57 INFO - 'NO_EM_RESTART': '1', 21:25:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:25:57 INFO - 'PWD': '/builds/slave/test', 21:25:57 INFO - 'SHELL': '/bin/bash', 21:25:57 INFO - 'SHLVL': '1', 21:25:57 INFO - 'TERM': 'linux', 21:25:57 INFO - 'TMOUT': '86400', 21:25:57 INFO - 'USER': 'cltbld', 21:25:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498', 21:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:25:57 INFO - '_': '/tools/buildbot/bin/python'} 21:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:25:57 INFO - Running setup.py (path:/tmp/pip-dFDDWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:25:57 INFO - Running setup.py (path:/tmp/pip-DetV5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:25:57 INFO - Running setup.py (path:/tmp/pip-Gb8tPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:25:57 INFO - Running setup.py (path:/tmp/pip-6qpHQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:25:57 INFO - Running setup.py (path:/tmp/pip-a7dQod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:25:57 INFO - Running setup.py (path:/tmp/pip-weO_sa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:25:57 INFO - Running setup.py (path:/tmp/pip-R102XI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:25:57 INFO - Running setup.py (path:/tmp/pip-oxQx2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:25:58 INFO - Running setup.py (path:/tmp/pip-r20kRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:25:58 INFO - Running setup.py (path:/tmp/pip-2HHykp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:25:58 INFO - Running setup.py (path:/tmp/pip-IRB9oA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:25:58 INFO - Running setup.py (path:/tmp/pip-fEPDCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:25:58 INFO - Running setup.py (path:/tmp/pip-yv8WOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:25:58 INFO - Running setup.py (path:/tmp/pip-Bnxzf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:25:58 INFO - Running setup.py (path:/tmp/pip-tymNPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:25:58 INFO - Running setup.py (path:/tmp/pip-iikZEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:25:58 INFO - Running setup.py (path:/tmp/pip-yo_ABx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:25:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:25:58 INFO - Running setup.py install for manifestparser 21:25:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:25:58 INFO - Running setup.py install for mozcrash 21:25:58 INFO - Running setup.py install for mozdebug 21:25:58 INFO - Running setup.py install for mozdevice 21:25:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:25:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:25:59 INFO - Running setup.py install for mozfile 21:25:59 INFO - Running setup.py install for mozhttpd 21:25:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:25:59 INFO - Running setup.py install for mozinfo 21:25:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:25:59 INFO - Running setup.py install for mozInstall 21:25:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:25:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:25:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:25:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:25:59 INFO - Running setup.py install for mozleak 21:25:59 INFO - Running setup.py install for mozlog 21:25:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:25:59 INFO - Running setup.py install for moznetwork 21:25:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:25:59 INFO - Running setup.py install for mozprocess 21:25:59 INFO - Running setup.py install for mozprofile 21:26:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:26:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:26:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:26:00 INFO - Running setup.py install for mozrunner 21:26:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:26:00 INFO - Running setup.py install for mozscreenshot 21:26:00 INFO - Running setup.py install for moztest 21:26:00 INFO - Running setup.py install for mozversion 21:26:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:26:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:26:00 INFO - Cleaning up... 21:26:00 INFO - Return code: 0 21:26:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:26:00 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')]} 21:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:00 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')]} 21:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:00 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 0x27231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c0b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29be290>, '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 0x29beb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bf040>, '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': '0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498', '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 21:26:00 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 21:26:00 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 21:26:00 INFO - Using env: {'DISPLAY': ':0', 21:26:00 INFO - 'HOME': '/home/cltbld', 21:26:00 INFO - 'LANG': 'en_US.UTF-8', 21:26:00 INFO - 'LANGUAGE': 'en_US:en', 21:26:00 INFO - 'LOGNAME': 'cltbld', 21:26:00 INFO - 'MAIL': '/var/mail/cltbld', 21:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:00 INFO - 'MOZ_NO_REMOTE': '1', 21:26:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:26:00 INFO - 'NO_EM_RESTART': '1', 21:26:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:00 INFO - 'PWD': '/builds/slave/test', 21:26:00 INFO - 'SHELL': '/bin/bash', 21:26:00 INFO - 'SHLVL': '1', 21:26:00 INFO - 'TERM': 'linux', 21:26:00 INFO - 'TMOUT': '86400', 21:26:00 INFO - 'USER': 'cltbld', 21:26:00 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498', 21:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:00 INFO - '_': '/tools/buildbot/bin/python'} 21:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:26:00 INFO - Running setup.py (path:/tmp/pip-C0_N4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:26:00 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)) 21:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:26:00 INFO - Running setup.py (path:/tmp/pip-FPqTK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:26:00 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)) 21:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:26:00 INFO - Running setup.py (path:/tmp/pip-r1Nwvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:26:00 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)) 21:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:26:00 INFO - Running setup.py (path:/tmp/pip-NpGVrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:26:01 INFO - Running setup.py (path:/tmp/pip-VjZjky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:26:01 INFO - Running setup.py (path:/tmp/pip-tXjyVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:26:01 INFO - Running setup.py (path:/tmp/pip-5qjS6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:26:01 INFO - Running setup.py (path:/tmp/pip-VkXfk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:26:01 INFO - Running setup.py (path:/tmp/pip-zqbJj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:26:01 INFO - Running setup.py (path:/tmp/pip-3sw9ET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:26:01 INFO - Running setup.py (path:/tmp/pip-4tnKWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:26:01 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)) 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:26:01 INFO - Running setup.py (path:/tmp/pip-w5k7q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:26:01 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)) 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:26:01 INFO - Running setup.py (path:/tmp/pip-FSODgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:26:01 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)) 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:26:01 INFO - Running setup.py (path:/tmp/pip-9EgvuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:26:01 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)) 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:26:01 INFO - Running setup.py (path:/tmp/pip-alyQwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:26:01 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)) 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:26:01 INFO - Running setup.py (path:/tmp/pip-O5CCxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:26:01 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)) 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:26:01 INFO - Running setup.py (path:/tmp/pip-5TUAFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:26:01 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)) 21:26:01 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)) 21:26:01 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)) 21:26:01 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)) 21:26:01 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)) 21:26:01 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)) 21:26:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:26:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:26:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:26:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:26:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:26:04 INFO - Downloading blessings-1.6.tar.gz 21:26:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:26:04 INFO - Installing collected packages: blessings 21:26:04 INFO - Running setup.py install for blessings 21:26:04 INFO - Successfully installed blessings 21:26:04 INFO - Cleaning up... 21:26:04 INFO - Return code: 0 21:26:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:26:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:26:04 INFO - Reading from file tmpfile_stdout 21:26:04 INFO - Current package versions: 21:26:04 INFO - argparse == 1.2.1 21:26:04 INFO - blessings == 1.6 21:26:04 INFO - blobuploader == 1.2.4 21:26:04 INFO - docopt == 0.6.1 21:26:04 INFO - functools32 == 3.2.3-2 21:26:04 INFO - jsonschema == 2.5.1 21:26:04 INFO - manifestparser == 1.1 21:26:04 INFO - mozInstall == 1.12 21:26:04 INFO - mozcrash == 1.0 21:26:04 INFO - mozdebug == 0.1 21:26:04 INFO - mozdevice == 0.49 21:26:04 INFO - mozfile == 1.2 21:26:04 INFO - mozhttpd == 0.7 21:26:04 INFO - mozinfo == 0.9 21:26:04 INFO - mozleak == 0.1 21:26:04 INFO - mozlog == 3.4 21:26:04 INFO - moznetwork == 0.27 21:26:04 INFO - mozprocess == 0.25 21:26:04 INFO - mozprofile == 0.28 21:26:04 INFO - mozrunner == 6.13 21:26:04 INFO - mozscreenshot == 0.1 21:26:04 INFO - mozsystemmonitor == 0.3 21:26:04 INFO - moztest == 0.8 21:26:04 INFO - mozversion == 1.4 21:26:04 INFO - psutil == 3.1.1 21:26:04 INFO - requests == 1.2.3 21:26:04 INFO - wsgiref == 0.1.2 21:26:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c0b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29be290>, '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 0x29beb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bf040>, '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': '0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498', '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 21:26:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:26:04 INFO - Using env: {'DISPLAY': ':0', 21:26:04 INFO - 'HOME': '/home/cltbld', 21:26:04 INFO - 'LANG': 'en_US.UTF-8', 21:26:04 INFO - 'LANGUAGE': 'en_US:en', 21:26:04 INFO - 'LOGNAME': 'cltbld', 21:26:04 INFO - 'MAIL': '/var/mail/cltbld', 21:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:04 INFO - 'MOZ_NO_REMOTE': '1', 21:26:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:26:04 INFO - 'NO_EM_RESTART': '1', 21:26:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:04 INFO - 'PWD': '/builds/slave/test', 21:26:04 INFO - 'SHELL': '/bin/bash', 21:26:04 INFO - 'SHLVL': '1', 21:26:04 INFO - 'TERM': 'linux', 21:26:04 INFO - 'TMOUT': '86400', 21:26:04 INFO - 'USER': 'cltbld', 21:26:04 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498', 21:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:04 INFO - '_': '/tools/buildbot/bin/python'} 21:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:26:04 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)) 21:26:04 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)) 21:26:04 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)) 21:26:04 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)) 21:26:04 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)) 21:26:04 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)) 21:26:04 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)) 21:26:04 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)) 21:26:04 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)) 21:26:04 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)) 21:26:04 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)) 21:26:04 INFO - Cleaning up... 21:26:04 INFO - Return code: 0 21:26:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:04 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 0x27231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c0b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29be290>, '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 0x29beb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bf040>, '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': '0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498', '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 21:26:04 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 21:26:04 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 21:26:04 INFO - Using env: {'DISPLAY': ':0', 21:26:04 INFO - 'HOME': '/home/cltbld', 21:26:04 INFO - 'LANG': 'en_US.UTF-8', 21:26:04 INFO - 'LANGUAGE': 'en_US:en', 21:26:04 INFO - 'LOGNAME': 'cltbld', 21:26:04 INFO - 'MAIL': '/var/mail/cltbld', 21:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:04 INFO - 'MOZ_NO_REMOTE': '1', 21:26:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:26:04 INFO - 'NO_EM_RESTART': '1', 21:26:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:04 INFO - 'PWD': '/builds/slave/test', 21:26:04 INFO - 'SHELL': '/bin/bash', 21:26:04 INFO - 'SHLVL': '1', 21:26:04 INFO - 'TERM': 'linux', 21:26:04 INFO - 'TMOUT': '86400', 21:26:04 INFO - 'USER': 'cltbld', 21:26:04 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498', 21:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:04 INFO - '_': '/tools/buildbot/bin/python'} 21:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:26:04 INFO - Cleaning up... 21:26:04 INFO - Return code: 0 21:26:04 INFO - Running post-action listener: _resource_record_post_action 21:26:04 INFO - Running post-action listener: _start_resource_monitoring 21:26:05 INFO - Starting resource monitoring. 21:26:05 INFO - [mozharness: 2017-03-22 04:26:05.005212Z] Finished create-virtualenv step (success) 21:26:05 INFO - [mozharness: 2017-03-22 04:26:05.005689Z] Running install step. 21:26:05 INFO - Running pre-action listener: _resource_record_pre_action 21:26:05 INFO - Running main action method: install 21:26:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:26:05 INFO - Reading from file tmpfile_stdout 21:26:05 INFO - Detecting whether we're running mozinstall >=1.0... 21:26:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:26:05 INFO - Reading from file tmpfile_stdout 21:26:05 INFO - Output received: 21:26:05 INFO - Usage: mozinstall [options] installer 21:26:05 INFO - Options: 21:26:05 INFO - -h, --help show this help message and exit 21:26:05 INFO - -d DEST, --destination=DEST 21:26:05 INFO - Directory to install application into. [default: 21:26:05 INFO - "/builds/slave/test"] 21:26:05 INFO - --app=APP Application being installed. [default: firefox] 21:26:05 INFO - mkdir: /builds/slave/test/build/application 21:26:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:26:20 INFO - Reading from file tmpfile_stdout 21:26:20 INFO - Output received: 21:26:20 INFO - /builds/slave/test/build/application/firefox/firefox 21:26:20 INFO - Running post-action listener: _resource_record_post_action 21:26:20 INFO - [mozharness: 2017-03-22 04:26:20.744829Z] Finished install step (success) 21:26:20 INFO - [mozharness: 2017-03-22 04:26:20.745163Z] Running run-tests step. 21:26:20 INFO - Running pre-action listener: _resource_record_pre_action 21:26:20 INFO - Running main action method: run_tests 21:26:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:26:20 INFO - Python 2.7.3 21:26:20 INFO - Return code: 0 21:26:20 INFO - grabbing minidump binary from tooltool 21:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:20 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 0x29be290>, '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 0x29beb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bf040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:26:20 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 21:26:20 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 21:26:20 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 21:26:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:26:20 INFO - Return code: 0 21:26:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:26:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:26:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:26:20 INFO - ENV: RUST_BACKTRACE is now 1 21:26:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:26:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:26:20 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/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 21:26:20 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/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 21:26:20 INFO - Using env: {'DISPLAY': ':0', 21:26:20 INFO - 'HOME': '/home/cltbld', 21:26:20 INFO - 'LANG': 'en_US.UTF-8', 21:26:20 INFO - 'LANGUAGE': 'en_US:en', 21:26:20 INFO - 'LOGNAME': 'cltbld', 21:26:20 INFO - 'MAIL': '/var/mail/cltbld', 21:26:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:26:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:20 INFO - 'MOZ_NO_REMOTE': '1', 21:26:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:26:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:26:20 INFO - 'NO_EM_RESTART': '1', 21:26:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:20 INFO - 'PWD': '/builds/slave/test', 21:26:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:26:20 INFO - 'RUST_BACKTRACE': '1', 21:26:20 INFO - 'SHELL': '/bin/bash', 21:26:20 INFO - 'SHLVL': '1', 21:26:20 INFO - 'TERM': 'linux', 21:26:20 INFO - 'TMOUT': '86400', 21:26:20 INFO - 'USER': 'cltbld', 21:26:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498', 21:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:20 INFO - '_': '/tools/buildbot/bin/python'} 21:26:20 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/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 21:26:21 INFO - mozversion application_buildid: 20170322034826 21:26:21 INFO - mozversion application_changeset: 201231223cd4354a450c3e5d80959f35b8e4cf0c 21:26:21 INFO - mozversion application_display_name: Nightly 21:26:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:26:21 INFO - mozversion application_name: Firefox 21:26:21 INFO - mozversion application_remotingname: firefox 21:26:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:26:21 INFO - mozversion application_vendor: Mozilla 21:26:21 INFO - mozversion application_version: 55.0a1 21:26:21 INFO - mozversion platform_buildid: 20170322034826 21:26:21 INFO - mozversion platform_changeset: 201231223cd4354a450c3e5d80959f35b8e4cf0c 21:26:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:26:21 INFO - mozversion platform_version: 55.0a1 21:26:21 INFO - using testdate: 1490156781 21:26:21 INFO - actual date: 1490156781 21:26:21 INFO - starting webserver on 'localhost:44354' 21:26:21 INFO - SUITE-START | Running 2 tests 21:26:21 INFO - TEST-START | dromaeo_css 21:26:21 INFO - operating with platform_type : linux_ 21:26:21 INFO - Initialising browser for dromaeo_css test... 21:26:21 INFO - TEST-INFO | started process 17924 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUmM2Fn/profile http://localhost:44354/getInfo.html) 21:26:25 INFO - PID 17924 | __metrics Screen width/height:1600/1200 21:26:25 INFO - PID 17924 | colorDepth:24 21:26:25 INFO - PID 17924 | Browser inner width/height: 1024/697 21:26:25 INFO - PID 17924 | __metrics 21:26:26 ERROR - PID 17924 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 21:26:27 INFO - TEST-INFO | 17924: exit 0 21:26:27 INFO - Browser initialized. 21:26:27 INFO - Running cycle 1/1 for dromaeo_css test... 21:26:27 INFO - TEST-INFO | started process 18055 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUmM2Fn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:26:39 INFO - PID 18055 | RSS: Main: 155336704 21:26:39 INFO - PID 18055 | 21:29:44 INFO - PID 18055 | Cycle 1(1): loaded http://localhost:44354/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44354/tests/dromaeo/cssquery-ext.html) 21:29:46 INFO - PID 18055 | RSS: Main: 166813696 21:29:46 INFO - PID 18055 | 21:31:27 INFO - PID 18055 | ************************* 21:31:27 INFO - PID 18055 | A coding exception was thrown and uncaught in a Task. 21:31:27 INFO - PID 18055 | 21:31:27 ERROR - PID 18055 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:31:27 INFO - PID 18055 | Full stack: 21:31:27 INFO - PID 18055 | ************************* 21:32:48 INFO - PID 18055 | Cycle 1(1): loaded http://localhost:44354/tests/dromaeo/cssquery-ext.html (next: http://localhost:44354/tests/dromaeo/cssquery-jquery.html) 21:32:49 INFO - PID 18055 | RSS: Main: 160669696 21:32:49 INFO - PID 18055 | 21:35:51 INFO - PID 18055 | Cycle 1(1): loaded http://localhost:44354/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44354/tests/dromaeo/cssquery-mootools.html) 21:35:51 INFO - PID 18055 | RSS: Main: 168431616 21:35:51 INFO - PID 18055 | 21:38:53 INFO - PID 18055 | Cycle 1(1): loaded http://localhost:44354/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44354/tests/dromaeo/cssquery-prototype.html) 21:38:54 INFO - PID 18055 | RSS: Main: 161230848 21:38:54 INFO - PID 18055 | 21:41:57 INFO - PID 18055 | Cycle 1(1): loaded http://localhost:44354/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44354/tests/dromaeo/cssquery-yui.html) 21:41:57 INFO - PID 18055 | RSS: Main: 167677952 21:41:57 INFO - PID 18055 | 21:45:00 INFO - PID 18055 | Cycle 1(1): loaded http://localhost:44354/tests/dromaeo/cssquery-yui.html (next: http://localhost:44354/tests/dromaeo/cssquery-dojo.html) 21:45:00 INFO - PID 18055 | RSS: Main: 163614720 21:45:00 INFO - PID 18055 | 21:45:00 INFO - PID 18055 | __start_tp_report 21:45:00 INFO - PID 18055 | _x_x_mozilla_page_load 21:45:00 INFO - PID 18055 | _x_x_mozilla_page_load_details 21:45:00 INFO - PID 18055 | |i|pagename|runs| 21:45:00 INFO - PID 18055 | |0;dojo.html;2736.589511573264;2773.4453109378105;2786.2755683522278;2812.66248050234;2812.8171668841524;5217.191335343028;5339.893202135955;5360.892782144355;5376.8924621507595;5393.406725260228;5294.126469132598;5343.305370301855;5360.597955153369;5422;5451.37309209441;4852.393450818648;4892.926606100911;4913.091078150535;4919.631027672921;4938.901221975559;4912.656114072016;4945.876353091166;4967.180415231483;4970.179920313144;5015.874603134933;4754.381930349033;4799.712017278975;4857.222844344923;4874.439439464436;4898.289747986558;4842.709437433765;4867.026594681042;4873.342098816685;4910.828121015783;4935.383077115361;4781.282807578857;4791.856244312677;4823.734694591796;4844.903101937976;4871.050145221683;5100.464451232641;5177.068127737006;5300.708461034642;5333.359996800409;5378.623496355257;5760.798372056958;5785;5836.5914385993;5845.035569131088;5846.649201047951;5815.651060936358;5831.271091113611;5835.183074369592;5848.912266316009;5852.76588936442;5322.281491998608;5359.383670877821;5398.838034858961;5405.378381486179;5407.648502847303;5853.619514731528;5870.119482077723;5895.292564892155;5917.993941030035;5959.106134079922;5624.156376543469;5631.267935168402;5662.603617746719;5667.4615911488345;5674.687892165971;5784.479396854304;5790.42095790426;5793.768249269982;5805.564582656318;5821.505172060422;5689.203511508392;5725.4274572543245;5750.453706897838;5769.1923130761725;5770.24986751728;5580.051391263495;5602.607817452739;5637.098064309691;5655.688937108499;5662.546996240373;4735.052989402134;4738.123447162286;4744.5492678195515;4768.3085952536685;4799.688020278671;4062.715609907278;4065.9593404066172;4084.7344922579937;4087.4890638670167;4134.400511925754;4783.928241076386;4843.854684359475;4852.0295940811975;4885.755712214375;4925.401397291152;5825.359210486843;5858.882822343529;5861.120831875252;5870.207521984563;5886.705664716747;4948.331975183376;4952.702837829742;4957.7769000395065;4958.975205123951;5002.324686167321;4998.600111991032;5064.215046667846;5100.26046223303;5114.820981265638;5135.435102138762;5384.9730751346;5393.83818485446;5405.297311349499;5425.565954723692;5447.019536483313;5606.467385598362;5675.0919852825;5780.884382312414;5787.102999035156;5804.6807425592;5131.153359695609;5191.662541934762;5253.369595648546;5289.41816400188;5290.100682883996;5552.888942221214;5614.073677843274;5665.291838520185;5687.118496633028;5698.287714035746;5776.451237132465;5782.132680098019;5820.94179058204;5866.266716660418;5872.647641141545;5579.079451890392;5617.269754931833;5626.043572592751;5626.662400255997;5637.379888212376;5478.589105817;5499.202615620793;5594.1049432092295;5597.748101335368;5609.354924183771;5497.120460726424;5550.222968784454;5579.74891129892;5593.356763972032;5602.355729091207;5671.546276297969;5689.431056894277;5689.487946084872;5694.658320500783;5695.658260504383;5332.9733351333;5468.5351745100525;5535.142052981794;5549.056660367828;5550.417206193291 21:45:00 INFO - PID 18055 | |1;ext.html;670.3497607320897;724.8405350822819;741.7107328142024;1051;1056.4770438632868;29938;31117;31146.68853311469;31179.53230701541;31200.843995780047;33815.154621134425;33879.66120338796;34342;34359.31281374371;34381.65618343816;7171.605561694092;7184.676689548956;7280.745173918914;7303.634818259093;7311.305425984523;7235.276472352775;7262.963685181567;7276.163241227247;7313.780586582385;7325.194228634846;7310.780676579711;7324.597147156905;7332.230115837813;7339.669714862844;7357.705691772323;7290.05229320185;7300.342969132777;7305.89041164383;7315.634218289091;7324.194338622748;7220.386267167297;7287.489875708702;7292.19785823559;7302.853942921165;7331.413486921034;34105.488417673754;34332.82833585841;34450.31099377998;34656;34718;2578.4971930473566;2586.961195582068;2610.4126571521447;2639.2214296782495;2673.131232349494;21488.570228595498;22042.669359959455;22204.22285220026;22204.666929996063;22848.08607655692;2629.224378808256;2640.68311802583;2659.9335016624545;2667.7198894116227;2672.3586339278627;101365;103357;116031.99999999916;116534;117558;40746;40865;40939.7953010233;41033.17933641311;41049.38425923613;42161.789191053846;42181.15637687229;42227;42269.36595951063;42454.78772606179;11501.309921404743;11545.365004924643;11699.415029248674;11710.238834475731;11736.471858766376;9202.171804537624;9224.953875230582;9245.90754092464;9260.768480788034;9291.767705807273;13098.738025239632;13125.146865453715;13209.273489958145;13269.402876870565;13362.131461454974;5508.3114610673665;5508.9724551376985;5539.335279766454;5622.212890195376;5632.887342253132;862.6894318045498;882.8587426011808;892.4422236102436;902.4495058014605;917.7017469322363;20276.188952442033;21287.36137915865;21400.678989815166;21417;21453.356399308046;971.7619183299995;978.2565250409598;993.3642468819961;998.3710262534702;999.9500024998721;10547.419891906018;11032.400301956332;11205.775884482264;11221.102311815035;11274.216146903524;210051;210051;210654;210674;211254;43393.78303108464;43493.56506434958;43639.563604364186;43730.78134609306;43769.562304377185;1204.680759598707;1231.513552146897;1260.4832018872403;1261.4449642157422;1262.6212136359056;19568;19820.40538783839;20917.26789562358;20934.68597971001;21130.894345528788;30694.84652576723;30729.692703072684;30784.846075770372;30874.845625771726;30884.22789430282;209437;210169;210268;211212;211373;28702;29144.708552915046;29147.417051658424;29173.270668233465;29694.406111878074;33433.49849752207;33631.66368336383;33925.49111763276;34553.654463455045;34622.82688586541;28526.286842829097;28563.571546426403;30905.536416953313;31504.054878353687;31856.68143318537;31101;31656.525152122274;31814;32821;32892.68429262898;29706.702932971257;30125.548116778704;30248;30898.845505772326;31016;25065.373365666004;25537.23388298354;29084.12747617575;29361.559576606796;29420.264493387836;21274.680879786505;21896.562068758853;22769.886150569142;22994.19520316781;23195.652065219372 21:45:00 INFO - PID 18055 | |2;jquery.html;421.9118125449759;427.2715020889384;436.3955921049347;444.9421575195225;450.6169755707649;16571.83428165718;16862.494125176232;17198.914005429957;17354.392596259135;17417.912910435447;18397.54006149847;18587.256509739593;19519.902400488012;19634.214631414725;19735.1119199636;5722.599418040739;5762.366139724627;5874.823755287348;5887.793927212549;5918.319393269786;5830.416958304157;5836.124581312794;5840.240768700063;5878.794242201524;5887.676177810219;5588.133839254901;5672.914906276409;5691.686957217351;5720;5814.680192589406;5496.120620700669;5719.399463056381;5738.225339579166;5750.568707346944;5764.337101233328;5110.437851836295;5131.666441681279;5135.691858488465;5143.228515722672;5146.687594663337;22128.778712212832;22457.305123385297;22491;22855.771442285695;22922.885385573132;1563.7037810218258;1567.4670611991978;1567.608097975506;1592.3391792406137;1626.9593260168472;13646.2494562799;13865.37605807741;14085.64785880351;14157.362918668685;14905.403783848633;1721.6040310728476;1746.3800350875383;1756.2887030752565;1763.3651885321274;1771.7342398640178;79956;81437.59281203557;81606.18393816045;82593;83572.99999999939;10648.201384896163;10758.892411075945;10947.507362168562;11003.504842282116;11078;15091.471798487;15096;15110.093394396152;15118.09291442495;15127.319270632848;6796.4562834973085;6944.479164062715;7113.288671132846;7114.786556403316;7171;6280.246370435577;6300.621962682254;6319.273283572448;6457.2896981332015;6484.643344615997;6828.931710682829;6875.143150928597;6962.199347075049;7004.2645522220455;7038.331358520933;2041.3365656161807;2044.8670836395586;2082.125507286943;2099.769025407204;2225.6772767948555;851.438050886412;872.2150064941603;876.6773926817291;890.3100097424548;898.23201163006;16779.161041947853;16944.40694575684;17533;17592;17840.643187136186;851.8381507513552;856.5417501636595;858.1247127929477;860.1269711243093;884.2218847414234;9019.098090190928;9631.181349585364;9642.42145471274;9662.468564228895;9783.804323913624;309419;313972;439739;447921;449911;63415.682921585096;72128.63935680289;72615;73516.63241683757;88829.55585222032;1079.5735684404774;1082.577794660083;1111.5831563163813;1115;1120.2382379981527;16281.51155465338;17330.74003889968;18562.700610957105;18728.906355468134;18750;31665.683343166274;31885.521717173797;32361;37356.43965340577;39745.00637484086;53033.20450193173;53887;54722.452775471735;54886.45113548813;55121.724391377786;7789.33790627803;7825.608719563885;7854.882176767467;8091.716789912325;8289.171082891662;12626.684332891751;12630.305333206761;12747.808782868078;12771.48914043465;12948.870511294766;9824.705258842247;9833.4099954003;10410.271281010257;10852.131829453783;11387.715307117389;10476;10502.474876256309;10663.253572249869;10787.568497260021;11049.226554141133;10111.595536178766;10129.64546240878;10423.478826058818;10450.477476126316;10501.474926253504;8132.796680083045;8207.876881846658;8265.917340826514;8388.496690198608;8460.196281353261;10085.69742907714;10333.948330258601;10620.787584248117;10682.465876705977;10926.453677315943 21:45:00 INFO - PID 18055 | |3;mootools.html;1263.6714454241896;1322.8875545578626;1331.134762404437;1336.478773278421;1346.5758286139865;9338.626454941803;9718.65984690536;9719.076687714656;9724.173445257162;9898.109170174683;9604.903950960488;9804.117629413351;9821.852672209923;9825.361351512165;9837.360571562862;2088.2899814063217;2118.5868755592664;2131.6163090643677;2131.9893400532974;2132.488202831325;2039.867408618435;2101.642720737471;2106.968395474069;2107.4099252209407;2111.4826867417505;2049.221295907553;2054.5685406064745;2059.5366042640435;2061.927832525862;2075.906584203707;2028.5030167608882;2042.1218875883364;2043.948901277465;2044.37646517812;2050.9077091530844;1832.8075552066973;1897.2411035585737;2065.824404925583;2066.7519897612233;2136.647453170225;9420.952895235549;9577.952110239474;9578;9609.231261499064;9626.229901607925;5209.895802083937;5361.81233656824;5397.028534863723;5423.186522021689;5438.619296649236;3031.8787248510034;3093.6906309368883;3154.148379937427;3163.810171389724;3164.651888292286;908.5911339897073;911.9635214591408;915.3501014279869;953.4612943686794;973.1922504321396;13588.184708917497;13797.793033104512;13883.4446622135;13948.72102557943;13982.230977296245;4478.171538265431;4551.40831691878;4619.769011549409;4636.8145274188655;4658.440987081572;10883.619073332395;10896.455177241265;10944.507497162647;10962.451877406098;10966.287191332698;5278;5296.152615581488;5302.708351040653;5302.70835104073;5307.575393968474;4772.5227477252;4850.6362022847725;4862.902741945141;4917.680350777188;4947.851564453073;3631.2737452509077;3700.4264339027495;3743.756655817363;3786.5266841644793;3816.5229346331707;1072.7479042425025;1076.5155679944057;1076.8869268726828;1100.5872797700863;1101.2676570080966;646.767163821024;678.2166597579803;679.0595025889179;687.1445050911647;690.3165865792829;5233.738313084406;5259.447757985433;5376.327959005124;5483.8080667176455;5492.176173573996;783.4515838912783;805.7743831727125;805.7824387415365;807.8747794091926;812.3338862133112;3412.3004784019217;3521.6302288259876;3523.083998160497;3568.3398571264397;3657.798821064867;12463.75072498545;12877.162984405984;12931.418086186144;13122.14706044104;13145.53990610324;12913.677158070936;12950.093493455368;12953;12978.156419832681;12979.091463597646;9251.352405331696;9502.144806967406;9512.1439070484;9555.856662150074;9569.3779904306;5515.7242137893745;5619.662820230799;5637.154426836008;5680.346760122638;5822.3304320003745;11731.88268117342;11736.119791015537;11781.764364712486;11808.232464889754;11845.822312665145;10986.945065274622;11326.490307936327;11447.542098315975;11589.072874170215;11842.28946263227;8251.587420628824;8346;8355.498670079814;8448.957755211184;8461.746147615582;9324.487153206368;9362.297827662816;9408.482533460725;9418.058194180527;9444.48055356962;8179.10029896699;8364.372672049742;8388.161183881562;8506.276966457921;8630.913690863012;8115.269625733712;8138.87791683137;8142.18578142181;8145.226203510657;8403.831923361377;7096.432285417051;7153.141623005273;7178.928210717826;7238.710451582088;7262.709491620487;4872.3909511311085;4964.3298154748645;4979.950200497949;4980.078685443204;5044.470330615232;4834.105690447279;4850.5149485051215;4926.975365123151;4942;5024.799008039638 21:45:00 INFO - PID 18055 | |4;prototype.html;383.50910834132304;402.2698801674959;403.517796233501;406.82833439693695;410.4233551859638;5335.413104558495;5455.8363249102495;5552.583556233289;5553.805616803413;5556.805511807088;5341.038613049659;5415.64798288111;5422.186671999202;5425.159100339453;5458.61789674723;4172.395002724603;4192.937105943413;4197.307444271692;4206.980649288344;4217.40956266123;4018.176273863851;4176.415301857743;4214.199302132585;4215.894602634928;4221.366794980762;4142.97928510357;4148.253314403406;4155.210510003089;4159.209750147477;4170.582941705836;4145.398917157026;4151.60559746825;4159.126583417486;4169.187008533338;4184.811683474236;3607.458881167846;3685.8157092145284;3686;3702.8148592570265;3703.8518459261595;5286.180642000496;5294.682319060868;5295.682259064469;5322.2548843161985;5325.174597937326;4816.277558366238;4823.20417131173;4830.444498882638;4832.877150220777;4851.587615052725;5558;5689.203511508392;5727.914081288784;5731.455511726379;5759.452851979056;3997.540282867449;4006.198760247962;4013.3177359848605;4018.8593399230886;4035;5696.231008813798;5855.619384740021;5940.435658612425;5943;6064.848378790565;4097.467329247179;4119.402686610425;4119.649829764444;4126.339785634284;4128.277551428488;4150.937735933963;4182.728122672077;4186.35111557709;4190.53904070552;4197.8320867164975;4550.294704320836;4763.285507173951;4787.736674482937;4802.591779698765;4803.279508073747;5783.942160578425;5796.478316951495;5803.448672376117;5805.432533216008;5814.680192589363;1429.9142051476945;1439.2515891736239;1445.4796273341587;1448.0877047460244;1450.4343306110625;934.8914858096934;972.9951350243203;977.2524019125375;986.4574484033897;990.64336838738;4947.431045429822;4995.675281106789;4996.6752161110135;5017.397912250553;5025.497450254945;5950.375210602911;6001.489873360813;6002.669853158118;6035.275766907999;6040.791841631603;4880.902381952341;4953.851384458472;4996.200607902791;5011.924821127686;5019.548240658358;3132.4518209313733;3157.5475281370827;3164.730997865161;3165.113768144923;3167.3506931079073;5508.889822203533;5544.7782088716;5562.610617256834;5573.721313934287;5576.570409198313;5964.314103878023;6081.628165015647;6151.6924153793025;6153.261608606996;6154.415330543681;5555.749991250404;5562.694051827108;5578.3584887738425;5586.106223004381;5588.720563971785;5787.623804452697;5990.820275391745;6007.939920600738;6016;6024.518038556817;5884.823455296348;5887.293524777054;5887.704704964901;5904.940950590439;5914.881702365842;5206.6095042871175;5339.519443249971;5342.652727572696;5475.4250803665045;5502.724863756716;4111.568285330117;4116.238495878272;4142.06803469217;4144.150449157975;4146.979265103776;5632.915506267327;5951.791687290924;5955.731992060454;5978.252718410199;5985.700714964321;5713.628614140068;5776.768929242951;5792.90079807301;5807.390224026416;5807.506361959281;5811.547113221694;5817.301923769175;5818.33089194748;5828.988998795408;5836.774277401793;5594.216809646734;5692.772289108555;5707.9429205709075;5723.370429252695;5757.971210143923;5819.388964158872;5825.242718446744;5826;5833.212516310414;5848.356680765028;5520.806771762969;5666.829995100154;5681.715914204356;5685.118806584986;5692.089265717465 21:45:00 INFO - PID 18055 | |5;yui.html;682.5631595778706;698.1412862179519;702.5012241308671;722.4112348436021;733.5855241788391;12105.515779368825;12485.375731213448;12787.680307992294;12989.610311690642;13026.544070957518;11946;12175.756484870297;12189.695257618563;12199.695007624814;12782.488700451993;814.6212011414676;828.9171082891693;831.3058596072257;831.5426515416497;832.1636755061155;819.5082950229844;822.5393779483478;842.5913431985482;852.897652281727;853.2278288149234;883.9779005524881;885.7165706973739;889.7286327670058;890.7238755985633;891.7725979875123;886.2068448738343;886.8891388576428;887.3921363865772;888.1606881496988;889.0975659705405;646.2503495944682;647.8283254937445;649.909012738217;651.4983462733716;654.8853950558681;12102.39488025604;12496.875031249752;12525.498980040788;12560.685982850502;13175.670608234776;13002.674933126653;13373.66565835862;13387.330633468386;13593.252371119584;14025.859741402557;10092.854259184522;10420.635277765241;10522;10552.947235263851;10662.786744265071;2690.313969937673;4063.2482990646827;4121.505419349667;4136.689748268862;4174.20690068889;48571.75714121407;48627.75686121582;49605;50184.74907625475;50218;9046.819063618823;9172.403793753385;9385.671501497414;9419.24646028316;9485.241180705527;18421.287084607804;18458.169382377826;18611.348602798837;18639.627207455775;19103.140358683893;6125.724342404603;6251.218597675291;6399.168108145911;6432.903506447407;6513.772017979348;3204.455242608762;3231.1437469070715;3251.528528363374;3285.162283617662;3303.8348082595776;3477.4609935460044;3538.5046093546925;3542.2738338640515;3555;3562.3943929532043;648.4099469482748;651.3031056769306;667.0860920538893;668.4351722794231;676.3338111959715;463.1035907956911;466.1609103613482;466.51482458243726;490.8085846519789;497.3012916851829;7539.170691223961;7691.730789422343;7881.448298619041;7911.5253084815095;8013.599320033975;481.9903601927942;491.7172625740214;493.1591636260168;504.1681225977167;515.4201523286303;3396.847141878621;3592.7305452091196;3610.9277814443562;3710.239400922804;3714.4242642390473;45236.09527809425;50065;58373;59844.40155598388;59898.40101598928;52699.47300527022;52709.209361859605;53089.73455132777;53091.734541327045;53809.46190538044;39617.40573891394;39952.20095598072;40208.39687404691;44325.33511997323;45265.321020184725;7984.8003799903145;8741.562921853754;8923.616839389904;9028.683996060106;9054;22995.195168169703;23449.41376465602;24133.517329652957;24785;25134.49731005333;29810.403791924473;30092.24769380783;30117.548236776904;30280;30709.53935691011;11336.546538138382;11394.145439091935;11402.372869491926;11493.195476316578;11567.710807229887;11948.522059117538;12223.816642750187;12259.509619615115;12323.50705971787;12691.365431728562;10527.157827373945;10759.838602420814;11106.777864442503;11124.443777811239;11159.609413670483;11050.226484146033;11315.321080735182;11513.942430287794;11627.767444651228;12412.937935310265;10933.343999360064;11520.366379849189;11594.246373985665;11713.297202167898;11764.117691173367;9817.754556136153;9830.262730295113;10084.294099412971;10087.324900585638;10213.74465638365;8015.278624923551;8078.23256790604;8187.713430030159;8798.164174403422;9030.413023153475 21:45:00 INFO - PID 18055 | __end_tp_report 21:45:00 INFO - PID 18055 | __start_cc_report 21:45:00 INFO - PID 18055 | _x_x_mozilla_cycle_collect,385 21:45:00 INFO - PID 18055 | __end_cc_report 21:45:00 INFO - PID 18055 | __startTimestamp1490157900766__endTimestamp 21:45:00 INFO - PID 18055 | 21:45:00 INFO - PID 18055 | ------- Summary: start ------- 21:45:00 INFO - PID 18055 | Number of tests: 6 21:45:00 INFO - PID 18055 | 21:45:00 INFO - PID 18055 | [#0] dojo.html Cycles:165 Average:5281.14 Median:5422.00 stddev:612.90 (11.3%) stddev-sans-first:581.37 21:45:00 INFO - PID 18055 | Values: 2736.6 2773.4 2786.3 2812.7 2812.8 5217.2 5339.9 5360.9 5376.9 5393.4 5294.1 5343.3 5360.6 5422.0 5451.4 4852.4 4892.9 4913.1 4919.6 4938.9 4912.7 4945.9 4967.2 4970.2 5015.9 4754.4 4799.7 4857.2 4874.4 4898.3 4842.7 4867.0 4873.3 4910.8 4935.4 4781.3 4791.9 4823.7 4844.9 4871.1 5100.5 5177.1 5300.7 5333.4 5378.6 5760.8 5785.0 5836.6 5845.0 5846.6 5815.7 5831.3 5835.2 5848.9 5852.8 5322.3 5359.4 5398.8 5405.4 5407.6 5853.6 5870.1 5895.3 5918.0 5959.1 5624.2 5631.3 5662.6 5667.5 5674.7 5784.5 5790.4 5793.8 5805.6 5821.5 5689.2 5725.4 5750.5 5769.2 5770.2 5580.1 5602.6 5637.1 5655.7 5662.5 4735.1 4738.1 4744.5 4768.3 4799.7 4062.7 4066.0 4084.7 4087.5 4134.4 4783.9 4843.9 4852.0 4885.8 4925.4 5825.4 5858.9 5861.1 5870.2 5886.7 4948.3 4952.7 4957.8 4959.0 5002.3 4998.6 5064.2 5100.3 5114.8 5135.4 5385.0 5393.8 5405.3 5425.6 5447.0 5606.5 5675.1 5780.9 5787.1 5804.7 5131.2 5191.7 5253.4 5289.4 5290.1 5552.9 5614.1 5665.3 5687.1 5698.3 5776.5 5782.1 5820.9 5866.3 5872.6 5579.1 5617.3 5626.0 5626.7 5637.4 5478.6 5499.2 5594.1 5597.7 5609.4 5497.1 5550.2 5579.7 5593.4 5602.4 5671.5 5689.4 5689.5 5694.7 5695.7 5333.0 5468.5 5535.1 5549.1 5550.4 21:45:00 INFO - PID 18055 | 21:45:00 INFO - PID 18055 | [#1] ext.html Cycles:180 Average:32093.85 Median:31058.50 stddev:47825.22 (154.0%) stddev-sans-first:47901.18 21:45:00 INFO - PID 18055 | Values: 670.3 724.8 741.7 1051.0 1056.5 29938.0 31117.0 31146.7 31179.5 31200.8 33815.2 33879.7 34342.0 34359.3 34381.7 7171.6 7184.7 7280.7 7303.6 7311.3 7235.3 7263.0 7276.2 7313.8 7325.2 7310.8 7324.6 7332.2 7339.7 7357.7 7290.1 7300.3 7305.9 7315.6 7324.2 7220.4 7287.5 7292.2 7302.9 7331.4 34105.5 34332.8 34450.3 34656.0 34718.0 2578.5 2587.0 2610.4 2639.2 2673.1 21488.6 22042.7 22204.2 22204.7 22848.1 2629.2 2640.7 2659.9 2667.7 2672.4 101365.0 103357.0 116032.0 116534.0 117558.0 40746.0 40865.0 40939.8 41033.2 41049.4 42161.8 42181.2 42227.0 42269.4 42454.8 11501.3 11545.4 11699.4 11710.2 11736.5 9202.2 9225.0 9245.9 9260.8 9291.8 13098.7 13125.1 13209.3 13269.4 13362.1 5508.3 5509.0 5539.3 5622.2 5632.9 862.7 882.9 892.4 902.4 917.7 20276.2 21287.4 21400.7 21417.0 21453.4 971.8 978.3 993.4 998.4 1000.0 10547.4 11032.4 11205.8 11221.1 11274.2 210051.0 210051.0 210654.0 210674.0 211254.0 43393.8 43493.6 43639.6 43730.8 43769.6 1204.7 1231.5 1260.5 1261.4 1262.6 19568.0 19820.4 20917.3 20934.7 21130.9 30694.8 30729.7 30784.8 30874.8 30884.2 209437.0 210169.0 210268.0 211212.0 211373.0 28702.0 29144.7 29147.4 29173.3 29694.4 33433.5 33631.7 33925.5 34553.7 34622.8 28526.3 28563.6 30905.5 31504.1 31856.7 31101.0 31656.5 31814.0 32821.0 32892.7 29706.7 30125.5 30248.0 30898.8 31016.0 25065.4 25537.2 29084.1 29361.6 29420.3 21274.7 21896.6 22769.9 22994.2 23195.7 21:45:00 INFO - PID 18055 | 21:45:00 INFO - PID 18055 | [#2] jquery.html Cycles:180 Average:25253.07 Median:424.59 stddev:65817.95 (15501.5%) stddev-sans-first:65976.18 21:45:00 INFO - PID 18055 | Values: 421.9 427.3 436.4 444.9 450.6 16571.8 16862.5 17198.9 17354.4 17417.9 18397.5 18587.3 19519.9 19634.2 19735.1 5722.6 5762.4 5874.8 5887.8 5918.3 5830.4 5836.1 5840.2 5878.8 5887.7 5588.1 5672.9 5691.7 5720.0 5814.7 5496.1 5719.4 5738.2 5750.6 5764.3 5110.4 5131.7 5135.7 5143.2 5146.7 22128.8 22457.3 22491.0 22855.8 22922.9 1563.7 1567.5 1567.6 1592.3 1627.0 13646.2 13865.4 14085.6 14157.4 14905.4 1721.6 1746.4 1756.3 1763.4 1771.7 79956.0 81437.6 81606.2 82593.0 83573.0 10648.2 10758.9 10947.5 11003.5 11078.0 15091.5 15096.0 15110.1 15118.1 15127.3 6796.5 6944.5 7113.3 7114.8 7171.0 6280.2 6300.6 6319.3 6457.3 6484.6 6828.9 6875.1 6962.2 7004.3 7038.3 2041.3 2044.9 2082.1 2099.8 2225.7 851.4 872.2 876.7 890.3 898.2 16779.2 16944.4 17533.0 17592.0 17840.6 851.8 856.5 858.1 860.1 884.2 9019.1 9631.2 9642.4 9662.5 9783.8 309419.0 313972.0 439739.0 447921.0 449911.0 63415.7 72128.6 72615.0 73516.6 88829.6 1079.6 1082.6 1111.6 1115.0 1120.2 16281.5 17330.7 18562.7 18728.9 18750.0 31665.7 31885.5 32361.0 37356.4 39745.0 53033.2 53887.0 54722.5 54886.5 55121.7 7789.3 7825.6 7854.9 8091.7 8289.2 12626.7 12630.3 12747.8 12771.5 12948.9 9824.7 9833.4 10410.3 10852.1 11387.7 10476.0 10502.5 10663.3 10787.6 11049.2 10111.6 10129.6 10423.5 10450.5 10501.5 8132.8 8207.9 8265.9 8388.5 8460.2 10085.7 10333.9 10620.8 10682.5 10926.5 21:45:00 INFO - PID 18055 | 21:45:00 INFO - PID 18055 | [#3] mootools.html Cycles:180 Average:6123.99 Median:4895.04 stddev:3945.86 (80.6%) stddev-sans-first:3940.03 21:45:00 INFO - PID 18055 | Values: 1263.7 1322.9 1331.1 1336.5 1346.6 9338.6 9718.7 9719.1 9724.2 9898.1 9604.9 9804.1 9821.9 9825.4 9837.4 2088.3 2118.6 2131.6 2132.0 2132.5 2039.9 2101.6 2107.0 2107.4 2111.5 2049.2 2054.6 2059.5 2061.9 2075.9 2028.5 2042.1 2043.9 2044.4 2050.9 1832.8 1897.2 2065.8 2066.8 2136.6 9421.0 9578.0 9578.0 9609.2 9626.2 5209.9 5361.8 5397.0 5423.2 5438.6 3031.9 3093.7 3154.1 3163.8 3164.7 908.6 912.0 915.4 953.5 973.2 13588.2 13797.8 13883.4 13948.7 13982.2 4478.2 4551.4 4619.8 4636.8 4658.4 10883.6 10896.5 10944.5 10962.5 10966.3 5278.0 5296.2 5302.7 5302.7 5307.6 4772.5 4850.6 4862.9 4917.7 4947.9 3631.3 3700.4 3743.8 3786.5 3816.5 1072.7 1076.5 1076.9 1100.6 1101.3 646.8 678.2 679.1 687.1 690.3 5233.7 5259.4 5376.3 5483.8 5492.2 783.5 805.8 805.8 807.9 812.3 3412.3 3521.6 3523.1 3568.3 3657.8 12463.8 12877.2 12931.4 13122.1 13145.5 12913.7 12950.1 12953.0 12978.2 12979.1 9251.4 9502.1 9512.1 9555.9 9569.4 5515.7 5619.7 5637.2 5680.3 5822.3 11731.9 11736.1 11781.8 11808.2 11845.8 10986.9 11326.5 11447.5 11589.1 11842.3 8251.6 8346.0 8355.5 8449.0 8461.7 9324.5 9362.3 9408.5 9418.1 9444.5 8179.1 8364.4 8388.2 8506.3 8630.9 8115.3 8138.9 8142.2 8145.2 8403.8 7096.4 7153.1 7178.9 7238.7 7262.7 4872.4 4964.3 4980.0 4980.1 5044.5 4834.1 4850.5 4927.0 4942.0 5024.8 21:45:00 INFO - PID 18055 | 21:45:00 INFO - PID 18055 | [#4] prototype.html Cycles:180 Average:4752.01 Median:5418.92 stddev:1397.72 (25.8%) stddev-sans-first:1362.64 21:45:00 INFO - PID 18055 | Values: 383.5 402.3 403.5 406.8 410.4 5335.4 5455.8 5552.6 5553.8 5556.8 5341.0 5415.6 5422.2 5425.2 5458.6 4172.4 4192.9 4197.3 4207.0 4217.4 4018.2 4176.4 4214.2 4215.9 4221.4 4143.0 4148.3 4155.2 4159.2 4170.6 4145.4 4151.6 4159.1 4169.2 4184.8 3607.5 3685.8 3686.0 3702.8 3703.9 5286.2 5294.7 5295.7 5322.3 5325.2 4816.3 4823.2 4830.4 4832.9 4851.6 5558.0 5689.2 5727.9 5731.5 5759.5 3997.5 4006.2 4013.3 4018.9 4035.0 5696.2 5855.6 5940.4 5943.0 6064.8 4097.5 4119.4 4119.6 4126.3 4128.3 4150.9 4182.7 4186.4 4190.5 4197.8 4550.3 4763.3 4787.7 4802.6 4803.3 5783.9 5796.5 5803.4 5805.4 5814.7 1429.9 1439.3 1445.5 1448.1 1450.4 934.9 973.0 977.3 986.5 990.6 4947.4 4995.7 4996.7 5017.4 5025.5 5950.4 6001.5 6002.7 6035.3 6040.8 4880.9 4953.9 4996.2 5011.9 5019.5 3132.5 3157.5 3164.7 3165.1 3167.4 5508.9 5544.8 5562.6 5573.7 5576.6 5964.3 6081.6 6151.7 6153.3 6154.4 5555.7 5562.7 5578.4 5586.1 5588.7 5787.6 5990.8 6007.9 6016.0 6024.5 5884.8 5887.3 5887.7 5904.9 5914.9 5206.6 5339.5 5342.7 5475.4 5502.7 4111.6 4116.2 4142.1 4144.2 4147.0 5632.9 5951.8 5955.7 5978.3 5985.7 5713.6 5776.8 5792.9 5807.4 5807.5 5811.5 5817.3 5818.3 5829.0 5836.8 5594.2 5692.8 5707.9 5723.4 5758.0 5819.4 5825.2 5826.0 5833.2 5848.4 5520.8 5666.8 5681.7 5685.1 5692.1 21:45:00 INFO - PID 18055 | 21:45:00 INFO - PID 18055 | [#5] yui.html Cycles:180 Average:12847.61 Median:24249.77 stddev:14824.36 (61.1%) stddev-sans-first:14837.79 21:45:00 INFO - PID 18055 | Values: 682.6 698.1 702.5 722.4 733.6 12105.5 12485.4 12787.7 12989.6 13026.5 11946.0 12175.8 12189.7 12199.7 12782.5 814.6 828.9 831.3 831.5 832.2 819.5 822.5 842.6 852.9 853.2 884.0 885.7 889.7 890.7 891.8 886.2 886.9 887.4 888.2 889.1 646.3 647.8 649.9 651.5 654.9 12102.4 12496.9 12525.5 12560.7 13175.7 13002.7 13373.7 13387.3 13593.3 14025.9 10092.9 10420.6 10522.0 10552.9 10662.8 2690.3 4063.2 4121.5 4136.7 4174.2 48571.8 48627.8 49605.0 50184.7 50218.0 9046.8 9172.4 9385.7 9419.2 9485.2 18421.3 18458.2 18611.3 18639.6 19103.1 6125.7 6251.2 6399.2 6432.9 6513.8 3204.5 3231.1 3251.5 3285.2 3303.8 3477.5 3538.5 3542.3 3555.0 3562.4 648.4 651.3 667.1 668.4 676.3 463.1 466.2 466.5 490.8 497.3 7539.2 7691.7 7881.4 7911.5 8013.6 482.0 491.7 493.2 504.2 515.4 3396.8 3592.7 3610.9 3710.2 3714.4 45236.1 50065.0 58373.0 59844.4 59898.4 52699.5 52709.2 53089.7 53091.7 53809.5 39617.4 39952.2 40208.4 44325.3 45265.3 7984.8 8741.6 8923.6 9028.7 9054.0 22995.2 23449.4 24133.5 24785.0 25134.5 29810.4 30092.2 30117.5 30280.0 30709.5 11336.5 11394.1 11402.4 11493.2 11567.7 11948.5 12223.8 12259.5 12323.5 12691.4 10527.2 10759.8 11106.8 11124.4 11159.6 11050.2 11315.3 11513.9 11627.8 12412.9 10933.3 11520.4 11594.2 11713.3 11764.1 9817.8 9830.3 10084.3 10087.3 10213.7 8015.3 8078.2 8187.7 8798.2 9030.4 21:45:00 INFO - PID 18055 | -------- Summary: end -------- 21:45:00 INFO - PID 18055 | 21:45:01 INFO - TEST-INFO | 18055: exit 0 21:45:01 INFO - TEST-OK | dromaeo_css | took 1120579ms 21:45:01 INFO - TEST-START | kraken 21:45:01 INFO - operating with platform_type : linux_ 21:45:01 INFO - Initialising browser for kraken test... 21:45:01 INFO - TEST-INFO | started process 18435 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV8ChqM/profile http://localhost:44354/getInfo.html) 21:45:06 INFO - PID 18435 | __metrics Screen width/height:1600/1200 21:45:06 INFO - PID 18435 | colorDepth:24 21:45:06 INFO - PID 18435 | Browser inner width/height: 1024/697 21:45:06 INFO - PID 18435 | __metrics 21:45:06 ERROR - PID 18435 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 21:45:07 INFO - TEST-INFO | 18435: exit 0 21:45:07 INFO - Browser initialized. 21:45:07 INFO - Running cycle 1/1 for kraken test... 21:45:07 INFO - TEST-INFO | started process 18563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV8ChqM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:45:19 INFO - PID 18563 | RSS: Main: 155176960 21:45:19 INFO - PID 18563 | 21:45:22 INFO - PID 18563 | Cycle 1(1): loaded http://localhost:44354/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44354/tests/kraken/driver.html?testName=audio-beat-detection) 21:45:23 INFO - PID 18563 | RSS: Main: 161648640 21:45:23 INFO - PID 18563 | 21:45:26 INFO - PID 18563 | Cycle 1(1): loaded http://localhost:44354/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44354/tests/kraken/driver.html?testName=audio-dft) 21:45:26 INFO - PID 18563 | RSS: Main: 161259520 21:45:26 INFO - PID 18563 | 21:45:29 INFO - PID 18563 | Cycle 1(1): loaded http://localhost:44354/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44354/tests/kraken/driver.html?testName=audio-fft) 21:45:30 INFO - PID 18563 | RSS: Main: 157675520 21:45:30 INFO - PID 18563 | 21:45:32 INFO - PID 18563 | Cycle 1(1): loaded http://localhost:44354/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44354/tests/kraken/driver.html?testName=audio-oscillator) 21:45:33 INFO - PID 18563 | RSS: Main: 158498816 21:45:33 INFO - PID 18563 | 21:45:35 INFO - PID 18563 | Cycle 1(1): loaded http://localhost:44354/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44354/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:45:35 INFO - PID 18563 | RSS: Main: 158924800 21:45:35 INFO - PID 18563 | 21:45:39 INFO - PID 18563 | Cycle 1(1): loaded http://localhost:44354/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44354/tests/kraken/driver.html?testName=imaging-darkroom) 21:45:39 INFO - PID 18563 | RSS: Main: 163155968 21:45:39 INFO - PID 18563 | 21:45:43 INFO - PID 18563 | Cycle 1(1): loaded http://localhost:44354/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44354/tests/kraken/driver.html?testName=imaging-desaturate) 21:45:43 INFO - PID 18563 | RSS: Main: 161214464 21:45:43 INFO - PID 18563 | 21:45:46 INFO - PID 18563 | Cycle 1(1): loaded http://localhost:44354/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44354/tests/kraken/driver.html?testName=json-parse-financial) 21:45:47 INFO - PID 18563 | RSS: Main: 161992704 21:45:47 INFO - PID 18563 | 21:45:49 INFO - PID 18563 | Cycle 1(1): loaded http://localhost:44354/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44354/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:45:49 INFO - PID 18563 | RSS: Main: 162693120 21:45:49 INFO - PID 18563 | 21:45:51 INFO - PID 18563 | Cycle 1(1): loaded http://localhost:44354/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44354/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:45:52 INFO - PID 18563 | RSS: Main: 162271232 21:45:52 INFO - PID 18563 | 21:45:54 INFO - PID 18563 | Cycle 1(1): loaded http://localhost:44354/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44354/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:45:55 INFO - PID 18563 | RSS: Main: 163086336 21:45:55 INFO - PID 18563 | 21:45:58 INFO - PID 18563 | Cycle 1(1): loaded http://localhost:44354/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44354/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:45:58 INFO - PID 18563 | RSS: Main: 163889152 21:45:58 INFO - PID 18563 | 21:46:02 INFO - PID 18563 | Cycle 1(1): loaded http://localhost:44354/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44354/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:46:02 INFO - PID 18563 | RSS: Main: 163323904 21:46:02 INFO - PID 18563 | 21:46:04 INFO - PID 18563 | Cycle 1(1): loaded http://localhost:44354/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44354/tests/kraken/driver.html?testName=ai-astar) 21:46:04 INFO - PID 18563 | RSS: Main: 164708352 21:46:04 INFO - PID 18563 | 21:46:04 INFO - PID 18563 | __start_tp_report 21:46:04 INFO - PID 18563 | _x_x_mozilla_page_load 21:46:04 INFO - PID 18563 | _x_x_mozilla_page_load_details 21:46:04 INFO - PID 18563 | |i|pagename|runs| 21:46:04 INFO - PID 18563 | |0;ai-astar;103;111;111;111;113;113;112;112;111;113 21:46:04 INFO - PID 18563 | |1;audio-beat-detection;156;125;125;173;127;133;125;127;151;126 21:46:04 INFO - PID 18563 | |2;audio-dft;164;164;163;167;167;173;165;163;170;163 21:46:04 INFO - PID 18563 | |3;audio-fft;76;76;78;101;75;76;75;76;97;75 21:46:04 INFO - PID 18563 | |4;audio-oscillator;85;85;101;84;84;84;99;84;84;111 21:46:04 INFO - PID 18563 | |5;imaging-gaussian-blur;113;113;114;115;114;114;117;114;114;114 21:46:04 INFO - PID 18563 | |6;imaging-darkroom;151;150;151;150;158;150;150;150;153;151 21:46:04 INFO - PID 18563 | |7;imaging-desaturate;95;95;95;95;95;95;99;96;95;94 21:46:04 INFO - PID 18563 | |8;json-parse-financial;72;71;73;72;73;75;73;76;73;71 21:46:04 INFO - PID 18563 | |9;json-stringify-tinderbox;56;56;55;55;56;55;56;55;57;56 21:46:04 INFO - PID 18563 | |10;stanford-crypto-aes;83;83;83;82;85;84;88;90;82;83 21:46:04 INFO - PID 18563 | |11;stanford-crypto-ccm;142;133;136;150;142;133;138;153;194;138 21:46:04 INFO - PID 18563 | |12;stanford-crypto-pbkdf2;191;199;196;202;194;197;199;199;199;200 21:46:04 INFO - PID 18563 | |13;stanford-crypto-sha256-iterative;72;73;74;73;73;71;72;72;71;73 21:46:04 INFO - PID 18563 | __end_tp_report 21:46:04 INFO - PID 18563 | __start_cc_report 21:46:04 INFO - PID 18563 | _x_x_mozilla_cycle_collect,884 21:46:04 INFO - PID 18563 | __end_cc_report 21:46:04 INFO - PID 18563 | __startTimestamp1490157964920__endTimestamp 21:46:04 INFO - PID 18563 | 21:46:04 INFO - PID 18563 | ------- Summary: start ------- 21:46:04 INFO - PID 18563 | Number of tests: 14 21:46:04 INFO - PID 18563 | 21:46:04 INFO - PID 18563 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.94 (2.6%) stddev-sans-first:0.93 21:46:04 INFO - PID 18563 | Values: 103.0 111.0 111.0 111.0 113.0 113.0 112.0 112.0 111.0 113.0 21:46:04 INFO - PID 18563 | 21:46:04 INFO - PID 18563 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:130.00 stddev:17.07 (13.1%) stddev-sans-first:16.63 21:46:04 INFO - PID 18563 | Values: 156.0 125.0 125.0 173.0 127.0 133.0 125.0 127.0 151.0 126.0 21:46:04 INFO - PID 18563 | 21:46:04 INFO - PID 18563 | [#2] audio-dft Cycles:10 Average:165.90 Median:166.00 stddev:3.38 (2.0%) stddev-sans-first:3.52 21:46:04 INFO - PID 18563 | Values: 164.0 164.0 163.0 167.0 167.0 173.0 165.0 163.0 170.0 163.0 21:46:04 INFO - PID 18563 | 21:46:04 INFO - PID 18563 | [#3] audio-fft Cycles:10 Average:80.50 Median:76.00 stddev:9.83 (12.9%) stddev-sans-first:10.30 21:46:04 INFO - PID 18563 | Values: 76.0 76.0 78.0 101.0 75.0 76.0 75.0 76.0 97.0 75.0 21:46:04 INFO - PID 18563 | 21:46:04 INFO - PID 18563 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:84.00 stddev:9.85 (11.7%) stddev-sans-first:10.27 21:46:04 INFO - PID 18563 | Values: 85.0 85.0 101.0 84.0 84.0 84.0 99.0 84.0 84.0 111.0 21:46:04 INFO - PID 18563 | 21:46:04 INFO - PID 18563 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:1.14 (1.0%) stddev-sans-first:1.12 21:46:04 INFO - PID 18563 | Values: 113.0 113.0 114.0 115.0 114.0 114.0 117.0 114.0 114.0 114.0 21:46:04 INFO - PID 18563 | 21:46:04 INFO - PID 18563 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:151.00 stddev:2.50 (1.7%) stddev-sans-first:2.65 21:46:04 INFO - PID 18563 | Values: 151.0 150.0 151.0 150.0 158.0 150.0 150.0 150.0 153.0 151.0 21:46:04 INFO - PID 18563 | 21:46:04 INFO - PID 18563 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 21:46:04 INFO - PID 18563 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 99.0 96.0 95.0 94.0 21:46:04 INFO - PID 18563 | 21:46:04 INFO - PID 18563 | [#8] json-parse-financial Cycles:10 Average:72.90 Median:73.00 stddev:1.60 (2.2%) stddev-sans-first:1.66 21:46:04 INFO - PID 18563 | Values: 72.0 71.0 73.0 72.0 73.0 75.0 73.0 76.0 73.0 71.0 21:46:04 INFO - PID 18563 | 21:46:04 INFO - PID 18563 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:56.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 21:46:04 INFO - PID 18563 | Values: 56.0 56.0 55.0 55.0 56.0 55.0 56.0 55.0 57.0 56.0 21:46:04 INFO - PID 18563 | 21:46:04 INFO - PID 18563 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.50 stddev:2.67 (3.2%) stddev-sans-first:2.79 21:46:04 INFO - PID 18563 | Values: 83.0 83.0 83.0 82.0 85.0 84.0 88.0 90.0 82.0 83.0 21:46:04 INFO - PID 18563 | 21:46:04 INFO - PID 18563 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:142.00 stddev:18.16 (12.8%) stddev-sans-first:19.20 21:46:04 INFO - PID 18563 | Values: 142.0 133.0 136.0 150.0 142.0 133.0 138.0 153.0 194.0 138.0 21:46:04 INFO - PID 18563 | 21:46:04 INFO - PID 18563 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.60 Median:199.00 stddev:3.20 (1.6%) stddev-sans-first:2.35 21:46:04 INFO - PID 18563 | Values: 191.0 199.0 196.0 202.0 194.0 197.0 199.0 199.0 199.0 200.0 21:46:04 INFO - PID 18563 | 21:46:04 INFO - PID 18563 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:73.00 stddev:0.97 (1.3%) stddev-sans-first:1.01 21:46:04 INFO - PID 18563 | Values: 72.0 73.0 74.0 73.0 73.0 71.0 72.0 72.0 71.0 73.0 21:46:04 INFO - PID 18563 | -------- Summary: end -------- 21:46:04 INFO - PID 18563 | 21:46:06 INFO - TEST-INFO | 18563: exit 0 21:46:06 INFO - TEST-OK | kraken | took 64460ms 21:46:06 INFO - SUITE-END | took 1185s 21:46:06 INFO - Completed test suite (00:19:45) 21:46:06 INFO - javascript benchmark 21:46:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6558.905914462671, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2736.589511573264, 2773.4453109378105, 2786.2755683522278, 2812.66248050234, 2812.8171668841524, 5217.191335343028, 5339.893202135955, 5360.892782144355, 5376.8924621507595, 5393.406725260228, 5294.126469132598, 5343.305370301855, 5360.597955153369, 5422.0, 5451.37309209441, 4852.393450818648, 4892.926606100911, 4913.091078150535, 4919.631027672921, 4938.901221975559, 4912.656114072016, 4945.876353091166, 4967.180415231483, 4970.179920313144, 5015.874603134933, 4754.381930349033, 4799.712017278975, 4857.222844344923, 4874.439439464436, 4898.289747986558, 4842.709437433765, 4867.026594681042, 4873.342098816685, 4910.828121015783, 4935.383077115361, 4781.282807578857, 4791.856244312677, 4823.734694591796, 4844.903101937976, 4871.050145221683, 5100.464451232641, 5177.068127737006, 5300.708461034642, 5333.359996800409, 5378.623496355257, 5760.798372056958, 5785.0, 5836.5914385993, 5845.035569131088, 5846.649201047951, 5815.651060936358, 5831.271091113611, 5835.183074369592, 5848.912266316009, 5852.76588936442, 5322.281491998608, 5359.383670877821, 5398.838034858961, 5405.378381486179, 5407.648502847303, 5853.619514731528, 5870.119482077723, 5895.292564892155, 5917.993941030035, 5959.106134079922, 5624.156376543469, 5631.267935168402, 5662.603617746719, 5667.4615911488345, 5674.687892165971, 5784.479396854304, 5790.42095790426, 5793.768249269982, 5805.564582656318, 5821.505172060422, 5689.203511508392, 5725.4274572543245, 5750.453706897838, 5769.1923130761725, 5770.24986751728, 5580.051391263495, 5602.607817452739, 5637.098064309691, 5655.688937108499, 5662.546996240373, 4735.052989402134, 4738.123447162286, 4744.5492678195515, 4768.3085952536685, 4799.688020278671, 4062.715609907278, 4065.9593404066172, 4084.7344922579937, 4087.4890638670167, 4134.400511925754, 4783.928241076386, 4843.854684359475, 4852.0295940811975, 4885.755712214375, 4925.401397291152, 5825.359210486843, 5858.882822343529, 5861.120831875252, 5870.207521984563, 5886.705664716747, 4948.331975183376, 4952.702837829742, 4957.7769000395065, 4958.975205123951, 5002.324686167321, 4998.600111991032, 5064.215046667846, 5100.26046223303, 5114.820981265638, 5135.435102138762, 5384.9730751346, 5393.83818485446, 5405.297311349499, 5425.565954723692, 5447.019536483313, 5606.467385598362, 5675.0919852825, 5780.884382312414, 5787.102999035156, 5804.6807425592, 5131.153359695609, 5191.662541934762, 5253.369595648546, 5289.41816400188, 5290.100682883996, 5552.888942221214, 5614.073677843274, 5665.291838520185, 5687.118496633028, 5698.287714035746, 5776.451237132465, 5782.132680098019, 5820.94179058204, 5866.266716660418, 5872.647641141545, 5579.079451890392, 5617.269754931833, 5626.043572592751, 5626.662400255997, 5637.379888212376, 5478.589105817, 5499.202615620793, 5594.1049432092295, 5597.748101335368, 5609.354924183771, 5497.120460726424, 5550.222968784454, 5579.74891129892, 5593.356763972032, 5602.355729091207, 5671.546276297969, 5689.431056894277, 5689.487946084872, 5694.658320500783, 5695.658260504383, 5332.9733351333, 5468.5351745100525, 5535.142052981794, 5549.056660367828, 5550.417206193291], "value": 5236.8270779212025, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.3497607320897, 724.8405350822819, 741.7107328142024, 1051.0, 1056.4770438632868, 29938.0, 31117.0, 31146.68853311469, 31179.53230701541, 31200.843995780047, 33815.154621134425, 33879.66120338796, 34342.0, 34359.31281374371, 34381.65618343816, 7171.605561694092, 7184.676689548956, 7280.745173918914, 7303.634818259093, 7311.305425984523, 7235.276472352775, 7262.963685181567, 7276.163241227247, 7313.780586582385, 7325.194228634846, 7310.780676579711, 7324.597147156905, 7332.230115837813, 7339.669714862844, 7357.705691772323, 7290.05229320185, 7300.342969132777, 7305.89041164383, 7315.634218289091, 7324.194338622748, 7220.386267167297, 7287.489875708702, 7292.19785823559, 7302.853942921165, 7331.413486921034, 34105.488417673754, 34332.82833585841, 34450.31099377998, 34656.0, 34718.0, 2578.4971930473566, 2586.961195582068, 2610.4126571521447, 2639.2214296782495, 2673.131232349494, 21488.570228595498, 22042.669359959455, 22204.22285220026, 22204.666929996063, 22848.08607655692, 2629.224378808256, 2640.68311802583, 2659.9335016624545, 2667.7198894116227, 2672.3586339278627, 101365.0, 103357.0, 116031.99999999916, 116534.0, 117558.0, 40746.0, 40865.0, 40939.7953010233, 41033.17933641311, 41049.38425923613, 42161.789191053846, 42181.15637687229, 42227.0, 42269.36595951063, 42454.78772606179, 11501.309921404743, 11545.365004924643, 11699.415029248674, 11710.238834475731, 11736.471858766376, 9202.171804537624, 9224.953875230582, 9245.90754092464, 9260.768480788034, 9291.767705807273, 13098.738025239632, 13125.146865453715, 13209.273489958145, 13269.402876870565, 13362.131461454974, 5508.3114610673665, 5508.9724551376985, 5539.335279766454, 5622.212890195376, 5632.887342253132, 862.6894318045498, 882.8587426011808, 892.4422236102436, 902.4495058014605, 917.7017469322363, 20276.188952442033, 21287.36137915865, 21400.678989815166, 21417.0, 21453.356399308046, 971.7619183299995, 978.2565250409598, 993.3642468819961, 998.3710262534702, 999.9500024998721, 10547.419891906018, 11032.400301956332, 11205.775884482264, 11221.102311815035, 11274.216146903524, 210051.0, 210051.0, 210654.0, 210674.0, 211254.0, 43393.78303108464, 43493.56506434958, 43639.563604364186, 43730.78134609306, 43769.562304377185, 1204.680759598707, 1231.513552146897, 1260.4832018872403, 1261.4449642157422, 1262.6212136359056, 19568.0, 19820.40538783839, 20917.26789562358, 20934.68597971001, 21130.894345528788, 30694.84652576723, 30729.692703072684, 30784.846075770372, 30874.845625771726, 30884.22789430282, 209437.0, 210169.0, 210268.0, 211212.0, 211373.0, 28702.0, 29144.708552915046, 29147.417051658424, 29173.270668233465, 29694.406111878074, 33433.49849752207, 33631.66368336383, 33925.49111763276, 34553.654463455045, 34622.82688586541, 28526.286842829097, 28563.571546426403, 30905.536416953313, 31504.054878353687, 31856.68143318537, 31101.0, 31656.525152122274, 31814.0, 32821.0, 32892.68429262898, 29706.702932971257, 30125.548116778704, 30248.0, 30898.845505772326, 31016.0, 25065.373365666004, 25537.23388298354, 29084.12747617575, 29361.559576606796, 29420.264493387836, 21274.680879786505, 21896.562068758853, 22769.886150569142, 22994.19520316781, 23195.652065219372], "value": 14611.612773471954, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.9118125449759, 427.2715020889384, 436.3955921049347, 444.9421575195225, 450.6169755707649, 16571.83428165718, 16862.494125176232, 17198.914005429957, 17354.392596259135, 17417.912910435447, 18397.54006149847, 18587.256509739593, 19519.902400488012, 19634.214631414725, 19735.1119199636, 5722.599418040739, 5762.366139724627, 5874.823755287348, 5887.793927212549, 5918.319393269786, 5830.416958304157, 5836.124581312794, 5840.240768700063, 5878.794242201524, 5887.676177810219, 5588.133839254901, 5672.914906276409, 5691.686957217351, 5720.0, 5814.680192589406, 5496.120620700669, 5719.399463056381, 5738.225339579166, 5750.568707346944, 5764.337101233328, 5110.437851836295, 5131.666441681279, 5135.691858488465, 5143.228515722672, 5146.687594663337, 22128.778712212832, 22457.305123385297, 22491.0, 22855.771442285695, 22922.885385573132, 1563.7037810218258, 1567.4670611991978, 1567.608097975506, 1592.3391792406137, 1626.9593260168472, 13646.2494562799, 13865.37605807741, 14085.64785880351, 14157.362918668685, 14905.403783848633, 1721.6040310728476, 1746.3800350875383, 1756.2887030752565, 1763.3651885321274, 1771.7342398640178, 79956.0, 81437.59281203557, 81606.18393816045, 82593.0, 83572.99999999939, 10648.201384896163, 10758.892411075945, 10947.507362168562, 11003.504842282116, 11078.0, 15091.471798487, 15096.0, 15110.093394396152, 15118.09291442495, 15127.319270632848, 6796.4562834973085, 6944.479164062715, 7113.288671132846, 7114.786556403316, 7171.0, 6280.246370435577, 6300.621962682254, 6319.273283572448, 6457.2896981332015, 6484.643344615997, 6828.931710682829, 6875.143150928597, 6962.199347075049, 7004.2645522220455, 7038.331358520933, 2041.3365656161807, 2044.8670836395586, 2082.125507286943, 2099.769025407204, 2225.6772767948555, 851.438050886412, 872.2150064941603, 876.6773926817291, 890.3100097424548, 898.23201163006, 16779.161041947853, 16944.40694575684, 17533.0, 17592.0, 17840.643187136186, 851.8381507513552, 856.5417501636595, 858.1247127929477, 860.1269711243093, 884.2218847414234, 9019.098090190928, 9631.181349585364, 9642.42145471274, 9662.468564228895, 9783.804323913624, 309419.0, 313972.0, 439739.0, 447921.0, 449911.0, 63415.682921585096, 72128.63935680289, 72615.0, 73516.63241683757, 88829.55585222032, 1079.5735684404774, 1082.577794660083, 1111.5831563163813, 1115.0, 1120.2382379981527, 16281.51155465338, 17330.74003889968, 18562.700610957105, 18728.906355468134, 18750.0, 31665.683343166274, 31885.521717173797, 32361.0, 37356.43965340577, 39745.00637484086, 53033.20450193173, 53887.0, 54722.452775471735, 54886.45113548813, 55121.724391377786, 7789.33790627803, 7825.608719563885, 7854.882176767467, 8091.716789912325, 8289.171082891662, 12626.684332891751, 12630.305333206761, 12747.808782868078, 12771.48914043465, 12948.870511294766, 9824.705258842247, 9833.4099954003, 10410.271281010257, 10852.131829453783, 11387.715307117389, 10476.0, 10502.474876256309, 10663.253572249869, 10787.568497260021, 11049.226554141133, 10111.595536178766, 10129.64546240878, 10423.478826058818, 10450.477476126316, 10501.474926253504, 8132.796680083045, 8207.876881846658, 8265.917340826514, 8388.496690198608, 8460.196281353261, 10085.69742907714, 10333.948330258601, 10620.787584248117, 10682.465876705977, 10926.453677315943], "value": 8767.859762456217, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1263.6714454241896, 1322.8875545578626, 1331.134762404437, 1336.478773278421, 1346.5758286139865, 9338.626454941803, 9718.65984690536, 9719.076687714656, 9724.173445257162, 9898.109170174683, 9604.903950960488, 9804.117629413351, 9821.852672209923, 9825.361351512165, 9837.360571562862, 2088.2899814063217, 2118.5868755592664, 2131.6163090643677, 2131.9893400532974, 2132.488202831325, 2039.867408618435, 2101.642720737471, 2106.968395474069, 2107.4099252209407, 2111.4826867417505, 2049.221295907553, 2054.5685406064745, 2059.5366042640435, 2061.927832525862, 2075.906584203707, 2028.5030167608882, 2042.1218875883364, 2043.948901277465, 2044.37646517812, 2050.9077091530844, 1832.8075552066973, 1897.2411035585737, 2065.824404925583, 2066.7519897612233, 2136.647453170225, 9420.952895235549, 9577.952110239474, 9578.0, 9609.231261499064, 9626.229901607925, 5209.895802083937, 5361.81233656824, 5397.028534863723, 5423.186522021689, 5438.619296649236, 3031.8787248510034, 3093.6906309368883, 3154.148379937427, 3163.810171389724, 3164.651888292286, 908.5911339897073, 911.9635214591408, 915.3501014279869, 953.4612943686794, 973.1922504321396, 13588.184708917497, 13797.793033104512, 13883.4446622135, 13948.72102557943, 13982.230977296245, 4478.171538265431, 4551.40831691878, 4619.769011549409, 4636.8145274188655, 4658.440987081572, 10883.619073332395, 10896.455177241265, 10944.507497162647, 10962.451877406098, 10966.287191332698, 5278.0, 5296.152615581488, 5302.708351040653, 5302.70835104073, 5307.575393968474, 4772.5227477252, 4850.6362022847725, 4862.902741945141, 4917.680350777188, 4947.851564453073, 3631.2737452509077, 3700.4264339027495, 3743.756655817363, 3786.5266841644793, 3816.5229346331707, 1072.7479042425025, 1076.5155679944057, 1076.8869268726828, 1100.5872797700863, 1101.2676570080966, 646.767163821024, 678.2166597579803, 679.0595025889179, 687.1445050911647, 690.3165865792829, 5233.738313084406, 5259.447757985433, 5376.327959005124, 5483.8080667176455, 5492.176173573996, 783.4515838912783, 805.7743831727125, 805.7824387415365, 807.8747794091926, 812.3338862133112, 3412.3004784019217, 3521.6302288259876, 3523.083998160497, 3568.3398571264397, 3657.798821064867, 12463.75072498545, 12877.162984405984, 12931.418086186144, 13122.14706044104, 13145.53990610324, 12913.677158070936, 12950.093493455368, 12953.0, 12978.156419832681, 12979.091463597646, 9251.352405331696, 9502.144806967406, 9512.1439070484, 9555.856662150074, 9569.3779904306, 5515.7242137893745, 5619.662820230799, 5637.154426836008, 5680.346760122638, 5822.3304320003745, 11731.88268117342, 11736.119791015537, 11781.764364712486, 11808.232464889754, 11845.822312665145, 10986.945065274622, 11326.490307936327, 11447.542098315975, 11589.072874170215, 11842.28946263227, 8251.587420628824, 8346.0, 8355.498670079814, 8448.957755211184, 8461.746147615582, 9324.487153206368, 9362.297827662816, 9408.482533460725, 9418.058194180527, 9444.48055356962, 8179.10029896699, 8364.372672049742, 8388.161183881562, 8506.276966457921, 8630.913690863012, 8115.269625733712, 8138.87791683137, 8142.18578142181, 8145.226203510657, 8403.831923361377, 7096.432285417051, 7153.141623005273, 7178.928210717826, 7238.710451582088, 7262.709491620487, 4872.3909511311085, 4964.3298154748645, 4979.950200497949, 4980.078685443204, 5044.470330615232, 4834.105690447279, 4850.5149485051215, 4926.975365123151, 4942.0, 5024.799008039638], "value": 4576.638877281487, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.50910834132304, 402.2698801674959, 403.517796233501, 406.82833439693695, 410.4233551859638, 5335.413104558495, 5455.8363249102495, 5552.583556233289, 5553.805616803413, 5556.805511807088, 5341.038613049659, 5415.64798288111, 5422.186671999202, 5425.159100339453, 5458.61789674723, 4172.395002724603, 4192.937105943413, 4197.307444271692, 4206.980649288344, 4217.40956266123, 4018.176273863851, 4176.415301857743, 4214.199302132585, 4215.894602634928, 4221.366794980762, 4142.97928510357, 4148.253314403406, 4155.210510003089, 4159.209750147477, 4170.582941705836, 4145.398917157026, 4151.60559746825, 4159.126583417486, 4169.187008533338, 4184.811683474236, 3607.458881167846, 3685.8157092145284, 3686.0, 3702.8148592570265, 3703.8518459261595, 5286.180642000496, 5294.682319060868, 5295.682259064469, 5322.2548843161985, 5325.174597937326, 4816.277558366238, 4823.20417131173, 4830.444498882638, 4832.877150220777, 4851.587615052725, 5558.0, 5689.203511508392, 5727.914081288784, 5731.455511726379, 5759.452851979056, 3997.540282867449, 4006.198760247962, 4013.3177359848605, 4018.8593399230886, 4035.0, 5696.231008813798, 5855.619384740021, 5940.435658612425, 5943.0, 6064.848378790565, 4097.467329247179, 4119.402686610425, 4119.649829764444, 4126.339785634284, 4128.277551428488, 4150.937735933963, 4182.728122672077, 4186.35111557709, 4190.53904070552, 4197.8320867164975, 4550.294704320836, 4763.285507173951, 4787.736674482937, 4802.591779698765, 4803.279508073747, 5783.942160578425, 5796.478316951495, 5803.448672376117, 5805.432533216008, 5814.680192589363, 1429.9142051476945, 1439.2515891736239, 1445.4796273341587, 1448.0877047460244, 1450.4343306110625, 934.8914858096934, 972.9951350243203, 977.2524019125375, 986.4574484033897, 990.64336838738, 4947.431045429822, 4995.675281106789, 4996.6752161110135, 5017.397912250553, 5025.497450254945, 5950.375210602911, 6001.489873360813, 6002.669853158118, 6035.275766907999, 6040.791841631603, 4880.902381952341, 4953.851384458472, 4996.200607902791, 5011.924821127686, 5019.548240658358, 3132.4518209313733, 3157.5475281370827, 3164.730997865161, 3165.113768144923, 3167.3506931079073, 5508.889822203533, 5544.7782088716, 5562.610617256834, 5573.721313934287, 5576.570409198313, 5964.314103878023, 6081.628165015647, 6151.6924153793025, 6153.261608606996, 6154.415330543681, 5555.749991250404, 5562.694051827108, 5578.3584887738425, 5586.106223004381, 5588.720563971785, 5787.623804452697, 5990.820275391745, 6007.939920600738, 6016.0, 6024.518038556817, 5884.823455296348, 5887.293524777054, 5887.704704964901, 5904.940950590439, 5914.881702365842, 5206.6095042871175, 5339.519443249971, 5342.652727572696, 5475.4250803665045, 5502.724863756716, 4111.568285330117, 4116.238495878272, 4142.06803469217, 4144.150449157975, 4146.979265103776, 5632.915506267327, 5951.791687290924, 5955.731992060454, 5978.252718410199, 5985.700714964321, 5713.628614140068, 5776.768929242951, 5792.90079807301, 5807.390224026416, 5807.506361959281, 5811.547113221694, 5817.301923769175, 5818.33089194748, 5828.988998795408, 5836.774277401793, 5594.216809646734, 5692.772289108555, 5707.9429205709075, 5723.370429252695, 5757.971210143923, 5819.388964158872, 5825.242718446744, 5826.0, 5833.212516310414, 5848.356680765028, 5520.806771762969, 5666.829995100154, 5681.715914204356, 5685.118806584986, 5692.089265717465], "value": 4325.733621314412, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.5631595778706, 698.1412862179519, 702.5012241308671, 722.4112348436021, 733.5855241788391, 12105.515779368825, 12485.375731213448, 12787.680307992294, 12989.610311690642, 13026.544070957518, 11946.0, 12175.756484870297, 12189.695257618563, 12199.695007624814, 12782.488700451993, 814.6212011414676, 828.9171082891693, 831.3058596072257, 831.5426515416497, 832.1636755061155, 819.5082950229844, 822.5393779483478, 842.5913431985482, 852.897652281727, 853.2278288149234, 883.9779005524881, 885.7165706973739, 889.7286327670058, 890.7238755985633, 891.7725979875123, 886.2068448738343, 886.8891388576428, 887.3921363865772, 888.1606881496988, 889.0975659705405, 646.2503495944682, 647.8283254937445, 649.909012738217, 651.4983462733716, 654.8853950558681, 12102.39488025604, 12496.875031249752, 12525.498980040788, 12560.685982850502, 13175.670608234776, 13002.674933126653, 13373.66565835862, 13387.330633468386, 13593.252371119584, 14025.859741402557, 10092.854259184522, 10420.635277765241, 10522.0, 10552.947235263851, 10662.786744265071, 2690.313969937673, 4063.2482990646827, 4121.505419349667, 4136.689748268862, 4174.20690068889, 48571.75714121407, 48627.75686121582, 49605.0, 50184.74907625475, 50218.0, 9046.819063618823, 9172.403793753385, 9385.671501497414, 9419.24646028316, 9485.241180705527, 18421.287084607804, 18458.169382377826, 18611.348602798837, 18639.627207455775, 19103.140358683893, 6125.724342404603, 6251.218597675291, 6399.168108145911, 6432.903506447407, 6513.772017979348, 3204.455242608762, 3231.1437469070715, 3251.528528363374, 3285.162283617662, 3303.8348082595776, 3477.4609935460044, 3538.5046093546925, 3542.2738338640515, 3555.0, 3562.3943929532043, 648.4099469482748, 651.3031056769306, 667.0860920538893, 668.4351722794231, 676.3338111959715, 463.1035907956911, 466.1609103613482, 466.51482458243726, 490.8085846519789, 497.3012916851829, 7539.170691223961, 7691.730789422343, 7881.448298619041, 7911.5253084815095, 8013.599320033975, 481.9903601927942, 491.7172625740214, 493.1591636260168, 504.1681225977167, 515.4201523286303, 3396.847141878621, 3592.7305452091196, 3610.9277814443562, 3710.239400922804, 3714.4242642390473, 45236.09527809425, 50065.0, 58373.0, 59844.40155598388, 59898.40101598928, 52699.47300527022, 52709.209361859605, 53089.73455132777, 53091.734541327045, 53809.46190538044, 39617.40573891394, 39952.20095598072, 40208.39687404691, 44325.33511997323, 45265.321020184725, 7984.8003799903145, 8741.562921853754, 8923.616839389904, 9028.683996060106, 9054.0, 22995.195168169703, 23449.41376465602, 24133.517329652957, 24785.0, 25134.49731005333, 29810.403791924473, 30092.24769380783, 30117.548236776904, 30280.0, 30709.53935691011, 11336.546538138382, 11394.145439091935, 11402.372869491926, 11493.195476316578, 11567.710807229887, 11948.522059117538, 12223.816642750187, 12259.509619615115, 12323.50705971787, 12691.365431728562, 10527.157827373945, 10759.838602420814, 11106.777864442503, 11124.443777811239, 11159.609413670483, 11050.226484146033, 11315.321080735182, 11513.942430287794, 11627.767444651228, 12412.937935310265, 10933.343999360064, 11520.366379849189, 11594.246373985665, 11713.297202167898, 11764.117691173367, 9817.754556136153, 9830.262730295113, 10084.294099412971, 10087.324900585638, 10213.74465638365, 8015.278624923551, 8078.23256790604, 8187.713430030159, 8798.164174403422, 9030.413023153475], "value": 5993.622219269257, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1574.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 111.0, 111.0, 113.0, 113.0, 112.0, 112.0, 111.0, 113.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 125.0, 173.0, 127.0, 133.0, 125.0, 127.0, 151.0, 126.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 167.0, 167.0, 173.0, 165.0, 163.0, 170.0, 163.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 101.0, 75.0, 76.0, 75.0, 76.0, 97.0, 75.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 101.0, 84.0, 84.0, 84.0, 99.0, 84.0, 84.0, 111.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 115.0, 114.0, 114.0, 117.0, 114.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 150.0, 158.0, 150.0, 150.0, 150.0, 153.0, 151.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 99.0, 96.0, 95.0, 94.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 73.0, 72.0, 73.0, 75.0, 73.0, 76.0, 73.0, 71.0], "value": 72.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 55.0, 56.0, 55.0, 56.0, 55.0, 57.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 82.0, 85.0, 84.0, 88.0, 90.0, 82.0, 83.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 133.0, 136.0, 150.0, 142.0, 133.0, 138.0, 153.0, 194.0, 138.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 199.0, 196.0, 202.0, 194.0, 197.0, 199.0, 199.0, 199.0, 200.0], "value": 197.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 74.0, 73.0, 73.0, 71.0, 72.0, 72.0, 71.0, 73.0], "value": 72.4, "unit": "score"}]}]} 21:46:06 INFO - Return code: 0 21:46:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:46:06 ERROR - # TBPL SUCCESS # 21:46:06 INFO - Running post-action listener: _resource_record_post_action 21:46:06 INFO - [mozharness: 2017-03-22 04:46:06.745406Z] Finished run-tests step (success) 21:46:06 INFO - Running post-run listener: _resource_record_post_run 21:46:06 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 364101632; Read time: 12; Write time: 188524 21:46:06 INFO - TinderboxPrint: CPU usage
13.3% 21:46:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 21:46:06 INFO - TinderboxPrint: I/O write bytes / time
364,101,632 / 188,524 21:46:06 INFO - TinderboxPrint: CPU idle
8,309.4 (86.7%) 21:46:06 INFO - TinderboxPrint: CPU user
1,220.0 (12.7%) 21:46:06 INFO - TinderboxPrint: Swap in / out
0 / 0 21:46:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 104951808; Read time: 0; Write time: 60380 21:46:06 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 258727936; Read time: 12; Write time: 128120 21:46:07 INFO - Running post-run listener: _upload_blobber_files 21:46:07 INFO - Blob upload gear active. 21:46:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:46:07 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 21:46:07 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'] 21:46:07 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 21:46:07 INFO - (blobuploader) - INFO - Open directory for files ... 21:46:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:46:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:46:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:46:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:46:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:46:08 INFO - (blobuploader) - INFO - Done attempting. 21:46:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:46:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:46:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:46:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:46:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:46:09 INFO - (blobuploader) - INFO - Done attempting. 21:46:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:46:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:46:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:46:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:46:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:46:10 INFO - (blobuploader) - INFO - Done attempting. 21:46:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:46:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:46:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:46:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:46:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:46:13 INFO - (blobuploader) - INFO - Done attempting. 21:46:13 INFO - (blobuploader) - INFO - Iteration through files over. 21:46:13 INFO - Return code: 0 21:46:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:46:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:46:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/66d1854c49dcff71068317fb766a0efb698d75b8de84a5beeae029ff30742b35abe919cee9d3c76d912e0c79eee6f347ac8b6f658382657437e02807b52cdc2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/596ac3c2050335432dd17c2183f163d166e1add756001dfd8ff9a8ef0f48801dbad72c4a5ed59072915eeebc111e0c13c631d8078ae5035e4705381581412dd7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b6135a65063cb59506b3674436b5e9313aea811c13ca855703d749d318294d57f316929552d79a20980fbd9ef9ef5b59a2548c69d11f96cba19a0fec9296ab03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a8a1df79cb9b8385089c490ed8d1c78933b725d1880c598b2a1dcf193e297c617939e8a5fec89769f45270f5dabf3c27740131afc72f807a86ff8fe4335930dc"} 21:46:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:46:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:46:13 INFO - Contents: 21:46:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/66d1854c49dcff71068317fb766a0efb698d75b8de84a5beeae029ff30742b35abe919cee9d3c76d912e0c79eee6f347ac8b6f658382657437e02807b52cdc2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/596ac3c2050335432dd17c2183f163d166e1add756001dfd8ff9a8ef0f48801dbad72c4a5ed59072915eeebc111e0c13c631d8078ae5035e4705381581412dd7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b6135a65063cb59506b3674436b5e9313aea811c13ca855703d749d318294d57f316929552d79a20980fbd9ef9ef5b59a2548c69d11f96cba19a0fec9296ab03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a8a1df79cb9b8385089c490ed8d1c78933b725d1880c598b2a1dcf193e297c617939e8a5fec89769f45270f5dabf3c27740131afc72f807a86ff8fe4335930dc"} 21:46:13 INFO - Running post-run listener: copy_logs_to_upload_dir 21:46:13 INFO - Copying logs to upload dir... 21:46:13 INFO - mkdir: /builds/slave/test/build/upload/logs 21:46:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.344719 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-21 21:46:13.650069) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 21:46:13.653615) ========= 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=0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498 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/66d1854c49dcff71068317fb766a0efb698d75b8de84a5beeae029ff30742b35abe919cee9d3c76d912e0c79eee6f347ac8b6f658382657437e02807b52cdc2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/596ac3c2050335432dd17c2183f163d166e1add756001dfd8ff9a8ef0f48801dbad72c4a5ed59072915eeebc111e0c13c631d8078ae5035e4705381581412dd7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b6135a65063cb59506b3674436b5e9313aea811c13ca855703d749d318294d57f316929552d79a20980fbd9ef9ef5b59a2548c69d11f96cba19a0fec9296ab03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a8a1df79cb9b8385089c490ed8d1c78933b725d1880c598b2a1dcf193e297c617939e8a5fec89769f45270f5dabf3c27740131afc72f807a86ff8fe4335930dc"} build_url:https://queue.taskcluster.net/v1/task/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011418 build_url: 'https://queue.taskcluster.net/v1/task/MMsmozg5SXml2DBjKo-UDg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/66d1854c49dcff71068317fb766a0efb698d75b8de84a5beeae029ff30742b35abe919cee9d3c76d912e0c79eee6f347ac8b6f658382657437e02807b52cdc2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/596ac3c2050335432dd17c2183f163d166e1add756001dfd8ff9a8ef0f48801dbad72c4a5ed59072915eeebc111e0c13c631d8078ae5035e4705381581412dd7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b6135a65063cb59506b3674436b5e9313aea811c13ca855703d749d318294d57f316929552d79a20980fbd9ef9ef5b59a2548c69d11f96cba19a0fec9296ab03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a8a1df79cb9b8385089c490ed8d1c78933b725d1880c598b2a1dcf193e297c617939e8a5fec89769f45270f5dabf3c27740131afc72f807a86ff8fe4335930dc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 21:46:13.678606) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 21:46:13.678926) ========= 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=0333a256a5e4f052382dd180000001b1-1490155987.329309-331337498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 21:46:13.768436) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 21:46:13.768982) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 21:46:13.769498) ========= ========= Total master_lag: 0.18 =========