builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1489592593.0 results: success (0) revision: 8c89d1991786625a64d868798281610872a2bc26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 08:43:12.997780) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 08:43:12.998278) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 08:43:12.998547) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 08:43:13.013136) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 08:43:13.013621) ========= 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-1489592592.349961-1128998071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-15 08:43:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 19.1M=0.001s 2017-03-15 08:43:13 (19.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106445 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 08:43:13.133825) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 08:43:13.134130) ========= 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-1489592592.349961-1128998071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018679 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 08:43:13.183944) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 08:43:13.184643) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8c89d1991786625a64d868798281610872a2bc26 --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 8c89d1991786625a64d868798281610872a2bc26 --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-1489592592.349961-1128998071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-15 08:43:13,301 truncating revision to first 12 chars 2017-03-15 08:43:13,301 Setting DEBUG logging. 2017-03-15 08:43:13,301 attempt 1/10 2017-03-15 08:43:13,301 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8c89d1991786?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-15 08:43:13,883 unpacking tar archive at: mozilla-central-8c89d1991786/testing/mozharness/ program finished with exit code 0 elapsedTime=0.890410 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 08:43:14.088370) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 08:43:14.088698) ========= script_repo_revision: 8c89d1991786625a64d868798281610872a2bc26 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 08:43:14.089083) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 08:43:14.089338) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 08:43:14.098078) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-15 08:43:14.098348) ========= /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-1489592592.349961-1128998071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:43:14 INFO - MultiFileLogger online at 20170315 08:43:14 in /builds/slave/test 08:43:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:43:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:43:14 INFO - {'append_to_log': False, 08:43:14 INFO - 'base_work_dir': '/builds/slave/test', 08:43:14 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:43:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:43:14 INFO - 'branch': 'Firefox-Non-PGO', 08:43:14 INFO - 'buildbot_json_path': 'buildprops.json', 08:43:14 INFO - 'config_files': ('talos/linux_config.py',), 08:43:14 INFO - 'default_actions': ('clobber', 08:43:14 INFO - 'read-buildbot-config', 08:43:14 INFO - 'download-and-extract', 08:43:14 INFO - 'populate-webroot', 08:43:14 INFO - 'create-virtualenv', 08:43:14 INFO - 'install', 08:43:14 INFO - 'run-tests'), 08:43:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:43:14 INFO - 'download_minidump_stackwalk': True, 08:43:14 INFO - 'download_symbols': 'ondemand', 08:43:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:43:14 INFO - 'tooltool.py': '/tools/tooltool.py', 08:43:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:43:14 INFO - '/tools/misc-python/virtualenv.py')}, 08:43:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:43:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:43:14 INFO - 'gecko_profile': False, 08:43:14 INFO - 'gecko_profile_interval': 0, 08:43:14 INFO - 'installer_path': 'installer.exe', 08:43:14 INFO - 'log_level': 'info', 08:43:14 INFO - 'log_name': 'talos', 08:43:14 INFO - 'log_to_console': True, 08:43:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:43:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:43:14 INFO - 'opt_config_files': (), 08:43:14 INFO - 'pip_index': False, 08:43:14 INFO - 'suite': 'dromaeojs-e10s', 08:43:14 INFO - 'system_bits': '32', 08:43:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:43:14 INFO - 'title': 'talos-linux64-ix-017', 08:43:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:43:14 INFO - 'use_talos_json': True, 08:43:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:43:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:43:14 INFO - 'work_dir': 'build'} 08:43:14 INFO - [mozharness: 2017-03-15 15:43:14.313542Z] Running clobber step. 08:43:14 INFO - Running pre-action listener: _resource_record_pre_action 08:43:14 INFO - Running main action method: clobber 08:43:14 INFO - rmtree: /builds/slave/test/build 08:43:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:43:15 INFO - Running post-action listener: _resource_record_post_action 08:43:15 INFO - [mozharness: 2017-03-15 15:43:15.883714Z] Finished clobber step (success) 08:43:15 INFO - [mozharness: 2017-03-15 15:43:15.883814Z] Running read-buildbot-config step. 08:43:15 INFO - Running pre-action listener: _resource_record_pre_action 08:43:15 INFO - Running main action method: read_buildbot_config 08:43:15 INFO - Using buildbot properties: 08:43:15 INFO - { 08:43:15 INFO - "project": "", 08:43:15 INFO - "product": "firefox", 08:43:15 INFO - "who": "ffxbld@noreply.mozilla.org", 08:43:15 INFO - "installer_path": "public/build/target.tar.bz2", 08:43:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:43:15 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:43:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:43:15 INFO - "stage_platform": "linux64", 08:43:15 INFO - "basedir": "/builds/slave/test", 08:43:15 INFO - "buildnumber": 464, 08:43:15 INFO - "platform": "ubuntu64_hw", 08:43:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:43:15 INFO - "slavebuilddir": "test", 08:43:15 INFO - "taskId": "EUQMoseSTqG2T2dfClnt2g", 08:43:15 INFO - "branch": "mozilla-central", 08:43:15 INFO - "script_repo_revision": "production", 08:43:15 INFO - "revision": "8c89d1991786625a64d868798281610872a2bc26", 08:43:15 INFO - "slavename": "talos-linux64-ix-017", 08:43:15 INFO - "repo_path": "mozilla-central" 08:43:15 INFO - } 08:43:15 INFO - Finding installer, test and symbols from parent task. 08:43:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EUQMoseSTqG2T2dfClnt2g'}, attempt #1 08:43:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EUQMoseSTqG2T2dfClnt2g'}, attempt #1 08:43:16 INFO - Task dependencies: Fun8OAyKRYeVvGTo2wsRmA 08:43:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA'}, attempt #1 08:43:17 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.tar.bz2 08:43:17 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/test_packages.json 08:43:17 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.crashreporter-symbols.zip 08:43:17 INFO - Running post-action listener: _resource_record_post_action 08:43:17 INFO - [mozharness: 2017-03-15 15:43:17.251328Z] Finished read-buildbot-config step (success) 08:43:17 INFO - [mozharness: 2017-03-15 15:43:17.251543Z] Running download-and-extract step. 08:43:17 INFO - Running pre-action listener: _resource_record_pre_action 08:43:17 INFO - Running main action method: download_and_extract 08:43:17 INFO - mkdir: /builds/slave/test/build/tests 08:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:17 INFO - trying https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.test_packages.json 08:43:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:43:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:43:17 INFO - Downloaded 896 bytes. 08:43:17 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:43:17 INFO - Using the following test package requirements: 08:43:17 INFO - {u'common': [u'target.common.tests.zip'], 08:43:17 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:43:17 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:43:17 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:43:17 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:43:17 INFO - u'mozbase': [u'target.common.tests.zip'], 08:43:17 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:43:17 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:43:17 INFO - u'web-platform': [u'target.common.tests.zip', 08:43:17 INFO - u'target.web-platform.tests.zip'], 08:43:17 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:43:17 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:43:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.common.tests.zip 08:43:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:43:17 INFO - Fetch https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.common.tests.zip into memory 08:43:18 INFO - Expected file size: 58185627 08:43:18 INFO - Obtained file size: 58185627 08:43:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:43:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.common.tests.zip 08:43:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:43:28 INFO - Fetch https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.common.tests.zip into memory 08:43:29 INFO - Expected file size: 58185627 08:43:29 INFO - Obtained file size: 58185627 08:43:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.talos.tests.zip 08:43:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:43:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.talos.tests.zip into memory 08:43:41 INFO - Expected file size: 14404452 08:43:41 INFO - Obtained file size: 14404452 08:43:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:41 INFO - trying https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.tar.bz2 08:43:41 INFO - Downloading https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:43:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:43:42 INFO - Downloaded 61644587 bytes. 08:43:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.tar.bz2 08:43:42 INFO - mkdir: /builds/slave/test/properties 08:43:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:43:42 INFO - Writing to file /builds/slave/test/properties/build_url 08:43:42 INFO - Contents: 08:43:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.tar.bz2 08:43:42 INFO - Running post-action listener: _resource_record_post_action 08:43:42 INFO - Running post-action listener: set_extra_try_arguments 08:43:42 INFO - [mozharness: 2017-03-15 15:43:42.711931Z] Finished download-and-extract step (success) 08:43:42 INFO - [mozharness: 2017-03-15 15:43:42.712027Z] Running populate-webroot step. 08:43:42 INFO - Running pre-action listener: _resource_record_pre_action 08:43:42 INFO - Running main action method: populate_webroot 08:43:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:43:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:43:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:43:42 INFO - '--tppagecycles', 08:43:42 INFO - '7'], 08:43:42 INFO - 'tests': ['tsvgm']}}, 08:43:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:43:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:43:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:43:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:43:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:43:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:43:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:43:42 INFO - 'talos_options': ['--disable-e10s'], 08:43:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:43:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:43:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:43:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:43:42 INFO - 'talos_options': ['--disable-e10s'], 08:43:42 INFO - 'tests': ['damp', 'tps']}, 08:43:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:43:42 INFO - 'tests': ['damp', 'tps']}, 08:43:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:43:42 INFO - 'tests': ['dromaeo_dom']}, 08:43:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:43:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:43:42 INFO - 'tests': ['basic_compositor_video']}, 08:43:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:43:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:43:42 INFO - 'tests': ['a11yr', 08:43:42 INFO - 'ts_paint', 08:43:42 INFO - 'tpaint', 08:43:42 INFO - 'sessionrestore', 08:43:42 INFO - 'sessionrestore_no_auto_restore', 08:43:42 INFO - 'tabpaint']}, 08:43:42 INFO - 'other-e10s': {'tests': ['a11yr', 08:43:42 INFO - 'ts_paint', 08:43:42 INFO - 'tpaint', 08:43:42 INFO - 'sessionrestore', 08:43:42 INFO - 'sessionrestore_no_auto_restore', 08:43:42 INFO - 'tabpaint']}, 08:43:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:43:42 INFO - 'ts_paint', 08:43:42 INFO - 'tpaint', 08:43:42 INFO - 'sessionrestore', 08:43:42 INFO - 'sessionrestore_no_auto_restore', 08:43:42 INFO - 'tabpaint']}, 08:43:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:43:42 INFO - 'ts_paint', 08:43:42 INFO - 'tpaint', 08:43:42 INFO - 'sessionrestore', 08:43:42 INFO - 'sessionrestore_no_auto_restore', 08:43:42 INFO - 'tabpaint']}, 08:43:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:43:42 INFO - 'tests': ['a11yr', 08:43:42 INFO - 'ts_paint', 08:43:42 INFO - 'tpaint', 08:43:42 INFO - 'sessionrestore', 08:43:42 INFO - 'sessionrestore_no_auto_restore', 08:43:42 INFO - 'tabpaint']}, 08:43:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:43:42 INFO - 'tests': ['a11yr', 08:43:42 INFO - 'ts_paint', 08:43:42 INFO - 'tpaint', 08:43:42 INFO - 'sessionrestore', 08:43:42 INFO - 'sessionrestore_no_auto_restore', 08:43:42 INFO - 'tabpaint']}, 08:43:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:43:42 INFO - 'tests': ['tsvgx', 08:43:42 INFO - 'tsvgr_opacity', 08:43:42 INFO - 'tart', 08:43:42 INFO - 'tscrollx', 08:43:42 INFO - 'cart', 08:43:42 INFO - 'tsvg_static']}, 08:43:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:43:42 INFO - 'tsvgr_opacity', 08:43:42 INFO - 'tart', 08:43:42 INFO - 'tscrollx', 08:43:42 INFO - 'cart', 08:43:42 INFO - 'tsvg_static']}, 08:43:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:43:42 INFO - 'talos_options': ['--disable-e10s'], 08:43:42 INFO - 'tests': ['tp5o']}, 08:43:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:43:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:43:42 INFO - 'talos_options': ['--disable-e10s', 08:43:42 INFO - '--xperf_path', 08:43:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:42 INFO - 'tests': ['tp5n']}, 08:43:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:43:42 INFO - 'talos_options': ['--xperf_path', 08:43:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:42 INFO - 'tests': ['tp5n']}}, 08:43:42 INFO - 'talos.zip': {'path': '', 08:43:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:43:42 INFO - Running post-action listener: _resource_record_post_action 08:43:42 INFO - [mozharness: 2017-03-15 15:43:42.725070Z] Finished populate-webroot step (success) 08:43:42 INFO - [mozharness: 2017-03-15 15:43:42.725178Z] Running create-virtualenv step. 08:43:42 INFO - Running pre-action listener: _resource_record_pre_action 08:43:42 INFO - Running main action method: create_virtualenv 08:43:42 INFO - Creating virtualenv /builds/slave/test/build/venv 08:43: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 08:43:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:43:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:43:42 INFO - Using real prefix '/usr' 08:43:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:43:43 INFO - Installing distribute.............................................................................................................................................................................................done. 08:43:45 INFO - Installing pip.................done. 08:43:45 INFO - Return code: 0 08:43:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:43:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:43:45 INFO - Reading from file tmpfile_stdout 08:43:45 INFO - Output received: 08:43: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) 08:43:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:43: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')]} 08:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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')]} 08:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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 0x1bda1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e77b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75290>, '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 0x1e75b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e76040>, '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-1489592592.349961-1128998071', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:43: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 08:43: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 08:43:45 INFO - Using env: {'DISPLAY': ':0', 08:43:45 INFO - 'HOME': '/home/cltbld', 08:43:45 INFO - 'LANG': 'en_US.UTF-8', 08:43:45 INFO - 'LANGUAGE': 'en_US:en', 08:43:45 INFO - 'LOGNAME': 'cltbld', 08:43:45 INFO - 'MAIL': '/var/mail/cltbld', 08:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:45 INFO - 'MOZ_NO_REMOTE': '1', 08:43:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:45 INFO - 'NO_EM_RESTART': '1', 08:43:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:45 INFO - 'PWD': '/builds/slave/test', 08:43:45 INFO - 'SHELL': '/bin/bash', 08:43:45 INFO - 'SHLVL': '1', 08:43:45 INFO - 'TERM': 'linux', 08:43:45 INFO - 'TMOUT': '86400', 08:43:45 INFO - 'USER': 'cltbld', 08:43:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1489592592.349961-1128998071', 08:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:45 INFO - '_': '/tools/buildbot/bin/python'} 08:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43: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 08:43:45 INFO - Cleaning up... 08:43:45 INFO - Return code: 0 08:43:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:43: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')]} 08:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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')]} 08:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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 0x1bda1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e77b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75290>, '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 0x1e75b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e76040>, '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-1489592592.349961-1128998071', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:43: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 08:43: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 08:43:45 INFO - Using env: {'DISPLAY': ':0', 08:43:45 INFO - 'HOME': '/home/cltbld', 08:43:45 INFO - 'LANG': 'en_US.UTF-8', 08:43:45 INFO - 'LANGUAGE': 'en_US:en', 08:43:45 INFO - 'LOGNAME': 'cltbld', 08:43:45 INFO - 'MAIL': '/var/mail/cltbld', 08:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:45 INFO - 'MOZ_NO_REMOTE': '1', 08:43:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:45 INFO - 'NO_EM_RESTART': '1', 08:43:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:45 INFO - 'PWD': '/builds/slave/test', 08:43:45 INFO - 'SHELL': '/bin/bash', 08:43:45 INFO - 'SHLVL': '1', 08:43:45 INFO - 'TERM': 'linux', 08:43:45 INFO - 'TMOUT': '86400', 08:43:45 INFO - 'USER': 'cltbld', 08:43:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1489592592.349961-1128998071', 08:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:45 INFO - '_': '/tools/buildbot/bin/python'} 08:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:45 INFO - Downloading/unpacking psutil>=3.1.1 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:43:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:48 INFO - Installing collected packages: psutil 08:43:48 INFO - Running setup.py install for psutil 08:43:48 INFO - building 'psutil._psutil_linux' extension 08:43:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:43:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:43:48 INFO - building 'psutil._psutil_posix' extension 08:43:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:43: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 08:43:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:48 INFO - Successfully installed psutil 08:43:48 INFO - Cleaning up... 08:43:48 INFO - Return code: 0 08:43:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:43: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')]} 08:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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')]} 08:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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 0x1bda1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e77b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75290>, '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 0x1e75b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e76040>, '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-1489592592.349961-1128998071', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:43: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 08:43: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 08:43:48 INFO - Using env: {'DISPLAY': ':0', 08:43:48 INFO - 'HOME': '/home/cltbld', 08:43:48 INFO - 'LANG': 'en_US.UTF-8', 08:43:48 INFO - 'LANGUAGE': 'en_US:en', 08:43:48 INFO - 'LOGNAME': 'cltbld', 08:43:48 INFO - 'MAIL': '/var/mail/cltbld', 08:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:48 INFO - 'MOZ_NO_REMOTE': '1', 08:43:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:48 INFO - 'NO_EM_RESTART': '1', 08:43:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:48 INFO - 'PWD': '/builds/slave/test', 08:43:48 INFO - 'SHELL': '/bin/bash', 08:43:48 INFO - 'SHLVL': '1', 08:43:48 INFO - 'TERM': 'linux', 08:43:48 INFO - 'TMOUT': '86400', 08:43:48 INFO - 'USER': 'cltbld', 08:43:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1489592592.349961-1128998071', 08:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:48 INFO - '_': '/tools/buildbot/bin/python'} 08:43:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:43:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:43:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:43:51 INFO - Installing collected packages: mozsystemmonitor 08:43:51 INFO - Running setup.py install for mozsystemmonitor 08:43:51 INFO - Successfully installed mozsystemmonitor 08:43:51 INFO - Cleaning up... 08:43:51 INFO - Return code: 0 08:43:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:51 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 0x1bda1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e77b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75290>, '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 0x1e75b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e76040>, '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-1489592592.349961-1128998071', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:43:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:43:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:43:51 INFO - Using env: {'DISPLAY': ':0', 08:43:51 INFO - 'HOME': '/home/cltbld', 08:43:51 INFO - 'LANG': 'en_US.UTF-8', 08:43:51 INFO - 'LANGUAGE': 'en_US:en', 08:43:51 INFO - 'LOGNAME': 'cltbld', 08:43:51 INFO - 'MAIL': '/var/mail/cltbld', 08:43:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:51 INFO - 'MOZ_NO_REMOTE': '1', 08:43:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:51 INFO - 'NO_EM_RESTART': '1', 08:43:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:51 INFO - 'PWD': '/builds/slave/test', 08:43:51 INFO - 'SHELL': '/bin/bash', 08:43:51 INFO - 'SHLVL': '1', 08:43:51 INFO - 'TERM': 'linux', 08:43:51 INFO - 'TMOUT': '86400', 08:43:51 INFO - 'USER': 'cltbld', 08:43:51 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1489592592.349961-1128998071', 08:43:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:51 INFO - '_': '/tools/buildbot/bin/python'} 08:43:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:51 INFO - Downloading/unpacking jsonschema==2.5.1 08:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:43:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43:53 INFO - Downloading functools32-3.2.3-2.tar.gz 08:43:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:43:53 INFO - warning: no files found matching '*.txt' 08:43:53 INFO - no previously-included directories found matching 'build' 08:43:53 INFO - no previously-included directories found matching 'dist' 08:43:53 INFO - no previously-included directories found matching '.git*' 08:43:53 INFO - Installing collected packages: jsonschema, functools32 08:43:53 INFO - Running setup.py install for functools32 08:43:53 INFO - warning: no files found matching '*.txt' 08:43:53 INFO - no previously-included directories found matching 'build' 08:43:53 INFO - no previously-included directories found matching 'dist' 08:43:53 INFO - no previously-included directories found matching '.git*' 08:43:53 INFO - Successfully installed jsonschema functools32 08:43:53 INFO - Cleaning up... 08:43:53 INFO - Return code: 0 08:43:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:43: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')]} 08:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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')]} 08:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:54 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 0x1bda1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e77b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75290>, '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 0x1e75b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e76040>, '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-1489592592.349961-1128998071', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:43:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:43:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:43:54 INFO - Using env: {'DISPLAY': ':0', 08:43:54 INFO - 'HOME': '/home/cltbld', 08:43:54 INFO - 'LANG': 'en_US.UTF-8', 08:43:54 INFO - 'LANGUAGE': 'en_US:en', 08:43:54 INFO - 'LOGNAME': 'cltbld', 08:43:54 INFO - 'MAIL': '/var/mail/cltbld', 08:43:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:54 INFO - 'MOZ_NO_REMOTE': '1', 08:43:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:54 INFO - 'NO_EM_RESTART': '1', 08:43:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:54 INFO - 'PWD': '/builds/slave/test', 08:43:54 INFO - 'SHELL': '/bin/bash', 08:43:54 INFO - 'SHLVL': '1', 08:43:54 INFO - 'TERM': 'linux', 08:43:54 INFO - 'TMOUT': '86400', 08:43:54 INFO - 'USER': 'cltbld', 08:43:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1489592592.349961-1128998071', 08:43:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:54 INFO - '_': '/tools/buildbot/bin/python'} 08:43:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:43:54 INFO - Cleaning up... 08:43:54 INFO - Return code: 0 08:43:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:43:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:54 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 0x1bda1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e77b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75290>, '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 0x1e75b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e76040>, '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-1489592592.349961-1128998071', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:43:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:43:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:43:54 INFO - Using env: {'DISPLAY': ':0', 08:43:54 INFO - 'HOME': '/home/cltbld', 08:43:54 INFO - 'LANG': 'en_US.UTF-8', 08:43:54 INFO - 'LANGUAGE': 'en_US:en', 08:43:54 INFO - 'LOGNAME': 'cltbld', 08:43:54 INFO - 'MAIL': '/var/mail/cltbld', 08:43:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:54 INFO - 'MOZ_NO_REMOTE': '1', 08:43:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:54 INFO - 'NO_EM_RESTART': '1', 08:43:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:54 INFO - 'PWD': '/builds/slave/test', 08:43:54 INFO - 'SHELL': '/bin/bash', 08:43:54 INFO - 'SHLVL': '1', 08:43:54 INFO - 'TERM': 'linux', 08:43:54 INFO - 'TMOUT': '86400', 08:43:54 INFO - 'USER': 'cltbld', 08:43:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1489592592.349961-1128998071', 08:43:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:54 INFO - '_': '/tools/buildbot/bin/python'} 08:43:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:54 INFO - Downloading/unpacking blobuploader==1.2.4 08:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:56 INFO - Downloading blobuploader-1.2.4.tar.gz 08:43:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:43:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:43:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43:57 INFO - Downloading docopt-0.6.1.tar.gz 08:43:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:43:57 INFO - Installing collected packages: blobuploader, requests, docopt 08:43:57 INFO - Running setup.py install for blobuploader 08:43:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:43:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:43:57 INFO - Running setup.py install for requests 08:43:57 INFO - Running setup.py install for docopt 08:43:57 INFO - Successfully installed blobuploader requests docopt 08:43:57 INFO - Cleaning up... 08:43:57 INFO - Return code: 0 08:43:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43: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')]} 08:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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')]} 08:43:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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 0x1bda1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e77b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75290>, '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 0x1e75b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e76040>, '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-1489592592.349961-1128998071', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:43: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 08:43: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 08:43:57 INFO - Using env: {'DISPLAY': ':0', 08:43:57 INFO - 'HOME': '/home/cltbld', 08:43:57 INFO - 'LANG': 'en_US.UTF-8', 08:43:57 INFO - 'LANGUAGE': 'en_US:en', 08:43:57 INFO - 'LOGNAME': 'cltbld', 08:43:57 INFO - 'MAIL': '/var/mail/cltbld', 08:43:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:57 INFO - 'MOZ_NO_REMOTE': '1', 08:43:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:57 INFO - 'NO_EM_RESTART': '1', 08:43:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:57 INFO - 'PWD': '/builds/slave/test', 08:43:57 INFO - 'SHELL': '/bin/bash', 08:43:57 INFO - 'SHLVL': '1', 08:43:57 INFO - 'TERM': 'linux', 08:43:57 INFO - 'TMOUT': '86400', 08:43:57 INFO - 'USER': 'cltbld', 08:43:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1489592592.349961-1128998071', 08:43:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:57 INFO - '_': '/tools/buildbot/bin/python'} 08:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:43:58 INFO - Running setup.py (path:/tmp/pip-o1AWFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:43:58 INFO - Running setup.py (path:/tmp/pip-VYW7Kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:43:58 INFO - Running setup.py (path:/tmp/pip-Kiqucy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:43:58 INFO - Running setup.py (path:/tmp/pip-t2gFOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:43:58 INFO - Running setup.py (path:/tmp/pip-qGW4hU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:43:58 INFO - Running setup.py (path:/tmp/pip-a2Ebat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:43:58 INFO - Running setup.py (path:/tmp/pip-olPAGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:43:58 INFO - Running setup.py (path:/tmp/pip-M9BCzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:43:58 INFO - Running setup.py (path:/tmp/pip-N9qoku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:43:58 INFO - Running setup.py (path:/tmp/pip-L2fXea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:43:58 INFO - Running setup.py (path:/tmp/pip-6DPOvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:43:58 INFO - Running setup.py (path:/tmp/pip-ifINFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:43:58 INFO - Running setup.py (path:/tmp/pip-w5Gg4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:43:59 INFO - Running setup.py (path:/tmp/pip-go10mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:59 INFO - Running setup.py (path:/tmp/pip-yuiFi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:43:59 INFO - Running setup.py (path:/tmp/pip-Baa_Pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:43:59 INFO - Running setup.py (path:/tmp/pip-aCveST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:43:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:43:59 INFO - Running setup.py install for manifestparser 08:43:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:43:59 INFO - Running setup.py install for mozcrash 08:43:59 INFO - Running setup.py install for mozdebug 08:43:59 INFO - Running setup.py install for mozdevice 08:43:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:43:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:43:59 INFO - Running setup.py install for mozfile 08:43:59 INFO - Running setup.py install for mozhttpd 08:43:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:43:59 INFO - Running setup.py install for mozinfo 08:43:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:44:00 INFO - Running setup.py install for mozInstall 08:44:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:44:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:44:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:44:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:44:00 INFO - Running setup.py install for mozleak 08:44:00 INFO - Running setup.py install for mozlog 08:44:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:44:00 INFO - Running setup.py install for moznetwork 08:44:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:44:00 INFO - Running setup.py install for mozprocess 08:44:00 INFO - Running setup.py install for mozprofile 08:44:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:44:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:44:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:44:00 INFO - Running setup.py install for mozrunner 08:44:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:44:00 INFO - Running setup.py install for mozscreenshot 08:44:00 INFO - Running setup.py install for moztest 08:44:00 INFO - Running setup.py install for mozversion 08:44:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:44:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:44:01 INFO - Cleaning up... 08:44:01 INFO - Return code: 0 08:44:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bda1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e77b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75290>, '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 0x1e75b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e76040>, '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-1489592592.349961-1128998071', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:44:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:44:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:44:01 INFO - Using env: {'DISPLAY': ':0', 08:44:01 INFO - 'HOME': '/home/cltbld', 08:44:01 INFO - 'LANG': 'en_US.UTF-8', 08:44:01 INFO - 'LANGUAGE': 'en_US:en', 08:44:01 INFO - 'LOGNAME': 'cltbld', 08:44:01 INFO - 'MAIL': '/var/mail/cltbld', 08:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:01 INFO - 'MOZ_NO_REMOTE': '1', 08:44:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:01 INFO - 'NO_EM_RESTART': '1', 08:44:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:01 INFO - 'PWD': '/builds/slave/test', 08:44:01 INFO - 'SHELL': '/bin/bash', 08:44:01 INFO - 'SHLVL': '1', 08:44:01 INFO - 'TERM': 'linux', 08:44:01 INFO - 'TMOUT': '86400', 08:44:01 INFO - 'USER': 'cltbld', 08:44:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1489592592.349961-1128998071', 08:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:01 INFO - '_': '/tools/buildbot/bin/python'} 08:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:44:01 INFO - Running setup.py (path:/tmp/pip-6vzFYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:44:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:44:01 INFO - Running setup.py (path:/tmp/pip-2E5u5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:44:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:44:01 INFO - Running setup.py (path:/tmp/pip-PzpbOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:44:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:44:01 INFO - Running setup.py (path:/tmp/pip-8ec4e6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:44: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)) 08:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:44:01 INFO - Running setup.py (path:/tmp/pip-vD8bIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:44: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)) 08:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:44:01 INFO - Running setup.py (path:/tmp/pip-yncvLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:44: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)) 08:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:44:01 INFO - Running setup.py (path:/tmp/pip-qIRbL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:44: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)) 08:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:44:01 INFO - Running setup.py (path:/tmp/pip-udhPD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:44: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)) 08:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:44:01 INFO - Running setup.py (path:/tmp/pip-vLkTcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:44: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)) 08:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:44:01 INFO - Running setup.py (path:/tmp/pip-p31IwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:44:02 INFO - Running setup.py (path:/tmp/pip-VxrsDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:44:02 INFO - Running setup.py (path:/tmp/pip-daUQw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:44:02 INFO - Running setup.py (path:/tmp/pip-TRpOE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:44:02 INFO - Running setup.py (path:/tmp/pip-ZiScOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:02 INFO - Running setup.py (path:/tmp/pip-LPVsbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:44:02 INFO - Running setup.py (path:/tmp/pip-P5wCTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:44:02 INFO - Running setup.py (path:/tmp/pip-xdoEeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:44:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44:04 INFO - Downloading blessings-1.6.tar.gz 08:44:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:44:04 INFO - Installing collected packages: blessings 08:44:04 INFO - Running setup.py install for blessings 08:44:04 INFO - Successfully installed blessings 08:44:04 INFO - Cleaning up... 08:44:04 INFO - Return code: 0 08:44:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:44:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:44:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:44:05 INFO - Reading from file tmpfile_stdout 08:44:05 INFO - Current package versions: 08:44:05 INFO - argparse == 1.2.1 08:44:05 INFO - blessings == 1.6 08:44:05 INFO - blobuploader == 1.2.4 08:44:05 INFO - docopt == 0.6.1 08:44:05 INFO - functools32 == 3.2.3-2 08:44:05 INFO - jsonschema == 2.5.1 08:44:05 INFO - manifestparser == 1.1 08:44:05 INFO - mozInstall == 1.12 08:44:05 INFO - mozcrash == 1.0 08:44:05 INFO - mozdebug == 0.1 08:44:05 INFO - mozdevice == 0.49 08:44:05 INFO - mozfile == 1.2 08:44:05 INFO - mozhttpd == 0.7 08:44:05 INFO - mozinfo == 0.9 08:44:05 INFO - mozleak == 0.1 08:44:05 INFO - mozlog == 3.4 08:44:05 INFO - moznetwork == 0.27 08:44:05 INFO - mozprocess == 0.25 08:44:05 INFO - mozprofile == 0.28 08:44:05 INFO - mozrunner == 6.13 08:44:05 INFO - mozscreenshot == 0.1 08:44:05 INFO - mozsystemmonitor == 0.3 08:44:05 INFO - moztest == 0.8 08:44:05 INFO - mozversion == 1.4 08:44:05 INFO - psutil == 3.1.1 08:44:05 INFO - requests == 1.2.3 08:44:05 INFO - wsgiref == 0.1.2 08:44:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:05 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 0x1bda1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e77b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75290>, '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 0x1e75b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e76040>, '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-1489592592.349961-1128998071', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:44:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:44:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:44:05 INFO - Using env: {'DISPLAY': ':0', 08:44:05 INFO - 'HOME': '/home/cltbld', 08:44:05 INFO - 'LANG': 'en_US.UTF-8', 08:44:05 INFO - 'LANGUAGE': 'en_US:en', 08:44:05 INFO - 'LOGNAME': 'cltbld', 08:44:05 INFO - 'MAIL': '/var/mail/cltbld', 08:44:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:05 INFO - 'MOZ_NO_REMOTE': '1', 08:44:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:05 INFO - 'NO_EM_RESTART': '1', 08:44:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:05 INFO - 'PWD': '/builds/slave/test', 08:44:05 INFO - 'SHELL': '/bin/bash', 08:44:05 INFO - 'SHLVL': '1', 08:44:05 INFO - 'TERM': 'linux', 08:44:05 INFO - 'TMOUT': '86400', 08:44:05 INFO - 'USER': 'cltbld', 08:44:05 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1489592592.349961-1128998071', 08:44:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:05 INFO - '_': '/tools/buildbot/bin/python'} 08:44:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:44:05 INFO - Cleaning up... 08:44:05 INFO - Return code: 0 08:44:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:44:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bda1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e77b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75290>, '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 0x1e75b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e76040>, '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-1489592592.349961-1128998071', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:44:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:44:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:44:05 INFO - Using env: {'DISPLAY': ':0', 08:44:05 INFO - 'HOME': '/home/cltbld', 08:44:05 INFO - 'LANG': 'en_US.UTF-8', 08:44:05 INFO - 'LANGUAGE': 'en_US:en', 08:44:05 INFO - 'LOGNAME': 'cltbld', 08:44:05 INFO - 'MAIL': '/var/mail/cltbld', 08:44:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:05 INFO - 'MOZ_NO_REMOTE': '1', 08:44:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:05 INFO - 'NO_EM_RESTART': '1', 08:44:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:05 INFO - 'PWD': '/builds/slave/test', 08:44:05 INFO - 'SHELL': '/bin/bash', 08:44:05 INFO - 'SHLVL': '1', 08:44:05 INFO - 'TERM': 'linux', 08:44:05 INFO - 'TMOUT': '86400', 08:44:05 INFO - 'USER': 'cltbld', 08:44:05 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1489592592.349961-1128998071', 08:44:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:05 INFO - '_': '/tools/buildbot/bin/python'} 08:44:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:44:05 INFO - Cleaning up... 08:44:05 INFO - Return code: 0 08:44:05 INFO - Running post-action listener: _resource_record_post_action 08:44:05 INFO - Running post-action listener: _start_resource_monitoring 08:44:05 INFO - Starting resource monitoring. 08:44:05 INFO - [mozharness: 2017-03-15 15:44:05.528649Z] Finished create-virtualenv step (success) 08:44:05 INFO - [mozharness: 2017-03-15 15:44:05.529120Z] Running install step. 08:44:05 INFO - Running pre-action listener: _resource_record_pre_action 08:44:05 INFO - Running main action method: install 08:44:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:44:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:44:05 INFO - Reading from file tmpfile_stdout 08:44:05 INFO - Detecting whether we're running mozinstall >=1.0... 08:44:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:44:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:44:05 INFO - Reading from file tmpfile_stdout 08:44:05 INFO - Output received: 08:44:05 INFO - Usage: mozinstall [options] installer 08:44:05 INFO - Options: 08:44:05 INFO - -h, --help show this help message and exit 08:44:05 INFO - -d DEST, --destination=DEST 08:44:05 INFO - Directory to install application into. [default: 08:44:05 INFO - "/builds/slave/test"] 08:44:05 INFO - --app=APP Application being installed. [default: firefox] 08:44:05 INFO - mkdir: /builds/slave/test/build/application 08:44: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'] 08:44:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:44:21 INFO - Reading from file tmpfile_stdout 08:44:21 INFO - Output received: 08:44:21 INFO - /builds/slave/test/build/application/firefox/firefox 08:44:21 INFO - Running post-action listener: _resource_record_post_action 08:44:21 INFO - [mozharness: 2017-03-15 15:44:21.319695Z] Finished install step (success) 08:44:21 INFO - [mozharness: 2017-03-15 15:44:21.319849Z] Running run-tests step. 08:44:21 INFO - Running pre-action listener: _resource_record_pre_action 08:44:21 INFO - Running main action method: run_tests 08:44:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:44:21 INFO - Python 2.7.3 08:44:21 INFO - Return code: 0 08:44:21 INFO - grabbing minidump binary from tooltool 08:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:21 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75290>, '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 0x1e75b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e76040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:44:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:44:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:44:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:44:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:44:21 INFO - Return code: 0 08:44:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:44:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:44:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:44:21 INFO - ENV: RUST_BACKTRACE is now 1 08:44:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:44:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:44:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/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 08:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/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 08:44:21 INFO - Using env: {'DISPLAY': ':0', 08:44:21 INFO - 'HOME': '/home/cltbld', 08:44:21 INFO - 'LANG': 'en_US.UTF-8', 08:44:21 INFO - 'LANGUAGE': 'en_US:en', 08:44:21 INFO - 'LOGNAME': 'cltbld', 08:44:21 INFO - 'MAIL': '/var/mail/cltbld', 08:44:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:44:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:44:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:21 INFO - 'MOZ_NO_REMOTE': '1', 08:44:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:44:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:21 INFO - 'NO_EM_RESTART': '1', 08:44:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:21 INFO - 'PWD': '/builds/slave/test', 08:44:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:44:21 INFO - 'RUST_BACKTRACE': '1', 08:44:21 INFO - 'SHELL': '/bin/bash', 08:44:21 INFO - 'SHLVL': '1', 08:44:21 INFO - 'TERM': 'linux', 08:44:21 INFO - 'TMOUT': '86400', 08:44:21 INFO - 'USER': 'cltbld', 08:44:21 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1489592592.349961-1128998071', 08:44:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:21 INFO - '_': '/tools/buildbot/bin/python'} 08:44:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/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 08:44:21 INFO - mozversion application_buildid: 20170315151240 08:44:21 INFO - mozversion application_changeset: 8c89d1991786625a64d868798281610872a2bc26 08:44:21 INFO - mozversion application_display_name: Nightly 08:44:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:44:21 INFO - mozversion application_name: Firefox 08:44:21 INFO - mozversion application_remotingname: firefox 08:44:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:44:21 INFO - mozversion application_vendor: Mozilla 08:44:21 INFO - mozversion application_version: 55.0a1 08:44:21 INFO - mozversion platform_buildid: 20170315151240 08:44:21 INFO - mozversion platform_changeset: 8c89d1991786625a64d868798281610872a2bc26 08:44:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:44:21 INFO - mozversion platform_version: 55.0a1 08:44:21 INFO - using testdate: 1489592661 08:44:21 INFO - actual date: 1489592661 08:44:21 INFO - starting webserver on 'localhost:58381' 08:44:21 INFO - SUITE-START | Running 2 tests 08:44:21 INFO - TEST-START | dromaeo_css 08:44:21 INFO - operating with platform_type : linux_ 08:44:21 INFO - Initialising browser for dromaeo_css test... 08:44:21 INFO - TEST-INFO | started process 29350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC5tcG3/profile http://localhost:58381/getInfo.html) 08:44:26 INFO - PID 29350 | __metrics Screen width/height:1600/1200 08:44:26 INFO - PID 29350 | colorDepth:24 08:44:26 INFO - PID 29350 | Browser inner width/height: 1024/697 08:44:26 INFO - PID 29350 | __metrics 08:44:26 ERROR - PID 29350 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 08:44:27 INFO - TEST-INFO | 29350: exit 0 08:44:27 INFO - Browser initialized. 08:44:27 INFO - Running cycle 1/1 for dromaeo_css test... 08:44:27 INFO - TEST-INFO | started process 29485 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC5tcG3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:44:40 INFO - PID 29485 | RSS: Main: 155312128 08:44:40 INFO - PID 29485 | 08:47:44 INFO - PID 29485 | Cycle 1(1): loaded http://localhost:58381/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58381/tests/dromaeo/cssquery-ext.html) 08:47:46 INFO - PID 29485 | RSS: Main: 165498880 08:47:46 INFO - PID 29485 | 08:49:28 INFO - PID 29485 | ************************* 08:49:28 INFO - PID 29485 | A coding exception was thrown and uncaught in a Task. 08:49:28 INFO - PID 29485 | 08:49:28 ERROR - PID 29485 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:49:28 INFO - PID 29485 | Full stack: 08:49:28 INFO - PID 29485 | ************************* 08:50:48 INFO - PID 29485 | Cycle 1(1): loaded http://localhost:58381/tests/dromaeo/cssquery-ext.html (next: http://localhost:58381/tests/dromaeo/cssquery-jquery.html) 08:50:49 INFO - PID 29485 | RSS: Main: 161112064 08:50:49 INFO - PID 29485 | 08:53:51 INFO - PID 29485 | Cycle 1(1): loaded http://localhost:58381/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58381/tests/dromaeo/cssquery-mootools.html) 08:53:52 INFO - PID 29485 | RSS: Main: 169582592 08:53:52 INFO - PID 29485 | 08:56:54 INFO - PID 29485 | Cycle 1(1): loaded http://localhost:58381/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58381/tests/dromaeo/cssquery-prototype.html) 08:56:54 INFO - PID 29485 | RSS: Main: 162852864 08:56:54 INFO - PID 29485 | 08:59:57 INFO - PID 29485 | Cycle 1(1): loaded http://localhost:58381/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58381/tests/dromaeo/cssquery-yui.html) 08:59:58 INFO - PID 29485 | RSS: Main: 168497152 08:59:58 INFO - PID 29485 | 09:03:01 INFO - PID 29485 | Cycle 1(1): loaded http://localhost:58381/tests/dromaeo/cssquery-yui.html (next: http://localhost:58381/tests/dromaeo/cssquery-dojo.html) 09:03:01 INFO - PID 29485 | RSS: Main: 161329152 09:03:01 INFO - PID 29485 | 09:03:01 INFO - PID 29485 | __start_tp_report 09:03:01 INFO - PID 29485 | _x_x_mozilla_page_load 09:03:01 INFO - PID 29485 | _x_x_mozilla_page_load_details 09:03:01 INFO - PID 29485 | |i|pagename|runs| 09:03:01 INFO - PID 29485 | |0;dojo.html;2652.1115426332176;2671.1051797647788;2681.8524981126043;2690.287073925409;2701.3651791828925;4888.095702295073;4974.204127339626;4981.35242418486;5016.4231113421965;5039.1433456312425;5000.7749651265685;5041.042201981621;5052;5075.314832497621;5095.261187127873;4550.453945526533;4613.838515651953;4618.630509559227;4626.537346265381;4636.09596128755;4602.286645569942;4623.121606894696;4655.86032419028;4673.579377855992;4699.318598803188;4553.954460455419;4556.179887620227;4612.976935115336;4656.511066338019;4658.510856360067;4635.513271106519;4642.466116396624;4643.3963584733765;4679.110968915895;4687.414073240845;4562.339507865666;4604.240300350438;4610.101030299093;4623.861284161447;4659.720416775004;4929.383827021622;4987.301777751118;4988.201887697987;5005.849824505271;5034.672746271517;5351.170568561879;5377.9512994966;5380.892382152335;5384.811531596375;5400.135978243501;5408.972955135199;5414.864628384283;5421.051316019681;5427.185922111715;5445.809396671137;4974.602031837517;4999.3500844890295;5005.424376196747;5041.495850414929;5086.821961231339;5580.804671836548;5596.552275817925;5598.216249725042;5599.776008959596;5602.439756024446;5300.628955973122;5339.492748188916;5370.758315875795;5383.78464861409;5396.406395296514;5445.700486473282;5467.316585426822;5485.094959331665;5489.368722596872;5526.47498487643;5400.729963501809;5422.213779002102;5431.21247419122;5442.12925931849;5479.287692599936;5310.362756469249;5351.143816989263;5369.140937449989;5406.324209473816;5428.267183930119;4579.977100114545;4590.724556526619;4608.055348653585;4622.375979242826;4630.282306242538;3954.149857780591;3979.582143874851;4008.719389642697;4035.778032208198;4050.6151915567975;4643.3963584733765;4677.7193368398;4695.319178719066;4709.858704238878;4758.738269395217;5489.533389661844;5504.146857237135;5514.145307477347;5534.446555344514;5557.722113894289;4699;4711.199096153662;4714.4106986626675;4717.481077081518;4744.786484608201;4727.739974301447;4795.592374648124;4883.926741098886;4909.386326709161;4976.601871850244;5028.170351891897;5043;5043.697378157322;5046.9906018795655;5056.797728090835;5360.249565060973;5403.864903377447;5423.132298832325;5424.647397919122;5425.864353391197;5028.9245661315845;5055.898882022412;5097.439281678938;5101.107306221322;5106.438291787826;5346.732663366894;5361.51746342831;5399.109146990702;5400.8649783754145;5412.702301373462;5395.24466574672;5496;5501.449855014626;5506.752196151103;5546.389897111234;5265.473452654857;5302.70835104073;5324.627276090637;5356.544693701079;5358.785648574013;5293.708846013352;5307;5307.52232299095;5307.681539107666;5309.920351194813;5174.197999309962;5223.399309079505;5225.9216111759115;5253.001929633358;5305.018571564273;5168.457311982188;5227.869303267449;5228.529432351107;5233;5237.135872580981;5142.76857541404;5169.405518365436;5185.040767458032;5185.844424667266;5200.843974680765 09:03:01 INFO - PID 29485 | |1;ext.html;618.9319174890761;676.1244188775535;698.6436917172243;813.9226773456523;822.2394285286109;32637;33363.33273334532;33363.833180834125;33388.332233355315;33413.33173336532;32323.838380808123;32779.50830737541;32809.34381312372;32822.179445513815;32849.67150328502;5871;6348.111264422984;8811.95594022029;8992.865107023366;8994.68518601849;9101.817963640724;9186.311026672993;9261.95369023154;9262.351635385527;9299.16307532322;9329.906700933007;9341.53292335384;9366.718998430024;9390.107939745747;9434.481103539303;9312.580933857993;9317.39436936597;9338.673146439909;9354.859677104849;9377.578008989578;9184.540772961325;9195;9214.861777073349;9272.304577156672;9281.257499400099;33982;34096.147596310046;34139.317213655835;34226.315473690636;34303.4854477183;3379.138319728478;3471.1669199392218;3492.720582353431;3526.7002304803864;3530.6822385985383;24159.396015099588;24198.516029679486;24286.392840179138;24307.63538546923;24582.754172458226;2946.351802603424;2949.8967536136347;3029.74247188987;3118.8128712277335;3118.8752449901976;163621;164484.9999999988;164672;165355;166274;44161.33757993633;44281.557184427744;44327.778361108634;44361.556384436386;44370.334444982705;44922.32616510755;45020.549794502294;45030.09939801186;45223.321650175276;45289;13020.739585208243;13224.471021159046;13273.800892986614;13293.335333233299;13307.467701292033;10657.081725289523;10680.893191068146;10702.732431689114;10707.411092389993;10715.785684286271;12632.736726327294;13321.200727956353;13340.132891362224;13405.396757145953;13546.390412431465;5405.459454054563;5433;5453.400125986138;5502.724863756796;5555.3611334697025;998.4957596413765;1009.2430676992255;1037.444966942682;1060.2207377577474;1070.2454769387564;21154.471138221666;22386.664200037012;22392.55214895693;22644.395894472018;22797.88601056984;979.5591983607405;1003.9648612298535;1011.9797604048025;1012.3925644613173;1161.6814915071454;12034.81947770784;12884.613461596167;12986.35068246584;13025.218486890817;13087.738245235232;230912;232285;232448;233384;233423;43071;43379;43402;43411.56588434075;43440;1118.2898859224451;1139.6865861888048;1140.9959235872545;1142.4116579961326;1242.863285038645;24225.00062389203;24309.513809723354;25411.745882540938;25478.872605636854;25706.357341065876;33365.16587085342;33795.32409351848;33840.83079584586;33858.3228335427;33881;232039;232244;232673;232993;233220;29123;29425.411491770472;29710;29896.551551727178;29956.850215748782;35091;35833.82083089672;35877.461838071926;35973;36016;29852.552211717277;30143.246418839706;30403.695963040085;30530.542041868946;30960.380792384476;29444;29484.557731633613;29807.55288670715;30364;31219.531707024868;29837.10488685343;30340.84829575838;30589.08232753021;30673.386532269677;30756.384872302875;25785.226443206735;27334.589981150697;27733.722662773114;27820.70788955143;27921.58117628278;21683.241086562524;22215.44461388478;22236.221732239293;22437;22443.77556224417 09:03:01 INFO - PID 29485 | |2;jquery.html;395.9030037640775;410.5299432150187;415.2711990456748;430.6533240741203;432.08182611949604;12138.514459421613;17388.91305543472;17939.64120717585;18009.7298540522;18030.098495075228;18208.81791182088;18606.627867442643;18742;19028;19279.518012049706;4345.652347812167;5513.035218836708;5660.29246344207;5667.263255776743;5713.342965558952;5456.863578410552;5547.25112109866;5591.161325801122;5604.243427137346;5609.971950140243;5567.220589117527;5575.553955683536;6378.904316435257;6674.566153200027;6690.866182676344;6585.835354116138;6619.536632435731;6630.900536491957;6659.770011544397;6699.631520266384;6783.966080169617;6832.45340372769;6833.384995350392;6833.4191593714095;6838.555493892931;20187.697184542245;21885.343439696833;22672.43318917024;22734.77265227343;22779.08883644652;2229.3423440085053;2286.062714287151;2304.781045800646;2305.4812667149927;2345.4019225097663;13634.318284085755;13933.372998215003;14017.229052402114;14375.928120359436;14998.625034374229;1825.6439994201137;1855.3413538193881;1859.5537071102974;1881.482592287132;1889.9811001889943;78725;79256.19422703049;80595;84757.57621211917;91530.5423472885;16478.588035299214;16888.240029198714;16940.745888811678;16974;17098.316067357166;28246.85876570604;29202.269943251587;29368.853155734083;29375;29781.404371912875;8919.777005574913;9042.909570904207;9062.546872656341;9073.183413492818;9214.585343659552;7219.278072192738;7262.818429539304;7466.887996680054;7499.512531685423;7513.774586762406;8504.192101750325;8862.64549418029;8931.642734290555;8949.552522373855;9113.544322783835;3781.8487260509823;3879.398693202558;3881.9805900970314;3924.2151569685607;3958.148997965451;997.3218211616025;1021.070825548762;1028.681108856257;1029.2537910015178;1030.5105075089273;19571.21715131407;19736.70394944077;19781.802181978284;19902.60194796096;20308.796912030986;1018.6638409324905;1020.1277907389224;1021.8416145497459;1024.8718910136233;1044.7283706236433;10412.47937603132;10881.264966966895;10887.129029677606;11013.779724405467;11028.338299702044;449175;450451;451906;460253;519314.0857392826;91687;93775;94307.52846235725;95540;95581.52209238909;1091.6724982505216;1130.2540323386525;1153.2330999884982;1153.4348169397103;1155.6706338693432;16361.590960226089;16666.833331666527;16807.915960420607;17257.741133883253;17431.47705568835;42490.57509424866;42715.3592696116;43238.351424728025;43785.78107109444;44082.77958610315;54977.1753423691;55279;55305.723471382385;56776;57128.85742285214;10288.485575721033;10308.12380947628;10317.587296508056;10385.740356491147;10945.398003109905;11763.588274410355;12022.699432514257;12074.75850483003;12369.134160608672;12446.626601201979;10638.41488718128;10649.840252396376;10744;10822.621208257673;11144.2199046066;10624.84062739044;10647.201459890694;10648.307859989076;10689.144868410664;10714.25000249975;9843.2125429964;9904.207663387057;10388.792224155626;10928.125749939827;11271.154663400443;10248.538815753458;10262.43556604394;10358.171346292429;10683.89316106829;10787.190960677824;9632.27757918145;9800.65697700577;9962.950185249027;10150.644727434505;10440.060394564525 09:03:01 INFO - PID 29485 | |3;mootools.html;1278.5525066226828;1278.567047477523;1300.9414576344063;1304.5564508067262;1425.0879437160215;8822.955885220581;9127.224185944186;9188.173064424209;9205.171534561896;9361.906380936189;8882.822343553125;9013.54932253388;9200.677976270832;9216.585253663585;9253.167214950654;2023.615513052519;2067.348785132686;2068.6173057984247;2073.6785798201304;2076.8338532917332;1944.8346890514324;1991.3627639155477;2004;2005.1077270614583;2006.1975209916004;1938.2440848069264;1957.9706304405445;1958.735570697959;1967.655660259456;1972.0829814136423;1887.631911777204;1888.3485197606803;1890.1210936914333;1891.6973284274588;1894.0908363985295;1678.8656907447375;1740.3734655524001;1899.08843754997;1914;1957.0997341223053;9247.72256832296;9413.246940244764;9505.524723763785;9508.191803696694;9514;4441.444819397575;4625.259958406638;4628.5371462853445;4633.096546173498;4638.327442520816;2581.0579138614457;2619.6332513448133;2665.626812246287;2682.9060982865703;2693.946121077587;969.6993931881069;988.2439933450916;990.1929927109383;1031.7523794289316;1042.3224903812506;12544.74910501794;13095.934520327433;13098.34508274592;13115.934420327838;13724.382402791798;3559.857605695743;3665.651763082556;3759.71802114837;3776.0937375029794;3780.6219378062524;10444.843327350096;10473.423961682029;10497;10514.842277365846;10545.789084218426;4355.695101342875;4418.889527761768;4433.7561434121435;4478.753668548196;4479;4041.3735870939463;4055.7566546007333;4086.0806318578675;4090.3250963591267;4092.242935057024;3146.7797254192446;3155.2111972006996;3230.8707651693667;3254.23525471514;3259.1689119274433;796.5937371940237;813.4712436916052;815.7838172884191;821.3757544266281;824.4558591329813;676.9593824370553;678.3420082519948;697.3410127429631;825.1748251748252;834.3325339728315;5478.671279723229;5650.180723795109;5671.858203544944;5686.687232202268;5749.88500229993;896.5382827843666;904.8280826642916;912.3385545479474;939.1500691873865;950.6720181537358;3502.5067642845815;3678.319510890494;3814.275287695329;3833.789141597183;3841.116543195025;11060.834087488694;11402.600908968312;11427.371494567878;11486.253393529394;12041.939790300992;11086.944565277123;11250.212485126127;11305.94347028276;11327.32036077838;11343.602973896039;8306.252437280553;8532.104129066358;8563.272121869586;8585.785355366166;8588.785280367916;5673.375928647928;5828.912566311594;5949.2266005419015;5964.910526342195;6071.635701857903;10715.41065241388;10788.244822862638;10795.136389089012;10984.450777461256;11045.558177673125;11283.435828208721;11304.039156671775;11359.261647992855;11406.828897566376;11417.942910285396;7738.2261773822165;7803.765887023398;7913.089994650459;7953.125156232694;7957.562334071682;8418.200270974248;8418.242358187792;8509.319254459751;8542.957285213783;8599.054104048424;7366.263373662591;7486.213947535431;7556.357709594746;7691.730789422343;7713.961430193038;7413.740519081806;7550.282723141512;7573.242675732383;7652.120006199136;7692.230776922263;6716;6767.661616919233;6792.592444453151;6815.659217039029;6830.385265326145;4960.826371076995;4978.8257410990445;5073.949260507496;5075.898482030412;5261.289725886956;5102.800841802247;5159.17453207485;5239.816606418757;5327.413984461628;5332.733363331896 09:03:01 INFO - PID 29485 | |4;prototype.html;352.99647003529975;380.1807105687244;380.74870585413635;384.40609258695315;385.82444987530675;5413.133898576229;5444.972775136119;5473.644213126144;5503.862403439911;5506.587005974553;5354.14333706607;5370.489803468674;5381.408045115034;5383.300170977777;5387.434319396466;4232.830686772525;4340.435743353368;4343.78281085946;4428;4500.684952053358;4475.552444755514;4476.798544065525;4491.169133710274;4495.50549439563;4498.145352383053;4471.217536931041;4490.797914093857;4492.573205545468;4498.52765459627;4499.61753250974;4360.585744354313;4378.562143785628;4436.24583820748;4489.46126464823;4508.842190523316;4111.48606424197;4112.91774164518;4113.197926404352;4122.814473348706;4124.154548317588;5245.56415547813;5251.212318152269;5255.579553635738;5259.815906443295;5267.947320526784;4880.877978050577;5082.339295891547;5171.7672704728375;5189.117849965477;5214.713190774506;5671.234383358235;5681.857953551194;5687.374388817227;5701.2018317435595;5706.80026199081;4519.209138400766;4537.069900670354;4538.7503687297185;4546.340780586829;4557.56703113207;5848.766049358021;5965.403459654043;6000.129981152709;6047.365026672224;6049;4669.696469729457;4690.390249267642;4703.341532185496;4705.12955103307;4708.340832283483;4723.716577005391;4759.547842954914;4773.522647735199;4781.665283430196;4785.784639691153;5044.873878153076;5133.640645154878;5133.768980395891;5151.124308867502;5162.6902385856965;5646.842397308542;5676.545876329967;5681.801136960269;5688.971555142198;5703.087505999103;1659.468969929611;1680.8907421017595;1681.2434404518017;1689.121656738489;1692.1370101248451;1193.0515240383916;1239.324568110382;1250.64929875734;1251.2117366059324;1259.4332550352378;4958.256261560723;4961.420061567965;4988.451270360258;4990.4011518618;4992.701897506675;5908.379620139824;5924.229850119457;5935.614185077956;5942.7920022799;5948.345681974979;4736.739479328601;4963.592657561152;4980.975095124501;5001.1495746574;5005.824796132118;3102.7828052036593;3151.2668032581987;3151.4800057990633;3154.9053528394184;3187.6971687689634;5202.606800871566;5461.672299662033;5462.508374246337;5463.69949652765;5469.671819690831;5647;6024.969875150597;6065.696715164224;6070.3929607038945;6079.878402431927;5272.885301257774;5356.196570514454;5508.669479831143;5509.449055094458;5513.531349835149;5917.171595976481;5926.762929482945;5928.110783382527;5937.732802024006;5959.940400596112;5724.685142317213;5792.4497172768515;5817.476427121579;5837.153612726216;5837.474627283565;5491.807786727445;5503.669779813224;5511.807086751945;5532.612717109924;5540.113581826889;4669.182892993645;4702.623790096715;4716.221823399238;4722.126406614787;4723.952760472352;5740.942590574041;5827.650340979555;5866.472017518444;5872.677002764718;5893.174955506147;5700.315962084576;5702.087665973424;5702.91644587527;5720.856978575569;5726.112452569859;5404;5653.575981801299;5708.429157084258;5712.314522257356;5729.3984131665575;5564.137558678412;5639.520640745583;5651.802186923438;5667.234923285304;5683.857903552444;5788.507976822018;5795.449432303924;5805.738741756547;5818.272715910512;5821.854453638693;5494.120940649477;5559.63862348946;5561.1658251261015;5602.431319230622;5610.523105535912 09:03:01 INFO - PID 29485 | |5;yui.html;669.1401549009523;682.63137905531;688.0814113158935;696.6412297666699;699.1470406104552;12908.677283067927;13365.19808811472;13490.865091349084;13514.594562163125;13519.594412167638;11822.469727897895;11863.288202707843;11994.280343179415;12822.80765788514;12869.5495657652;817.2236375443338;843.1273631791097;847.9321654267644;848.9320854331638;851.3614788908319;810.5541951926417;817.207308910356;832.650286879509;846.1369403208723;868.2966796894505;906.714384968736;912.7581190984395;913.5158366065996;914.8719179314901;915.1809130827905;901.0133903375826;907.0476000199797;909.0909090909091;909.4043401571981;910.544727636182;663.4559661077918;663.8473151175208;668.1647940074906;669.437672355224;669.8660267946382;13979.301034948212;14095.295235238196;14118.223497707622;14127.505537306248;14803;13255.337233138305;13758.65603359914;14318.78521822163;14336.219552386303;14416.207108609022;10822.837657435144;10909.127269818395;11004.834927476095;11165.075197540173;11327.376994265313;2881.3228891210547;2946.1456177708437;2984.8358340291275;3039.7264246217946;3057.908262752121;60680.39319606792;62452;63076.684616577084;63134.68432657807;63647;9496.572654230438;9560.28297877662;9562;9587.712368628952;9940.552675129637;18390.816091839177;18486;18504.722429163572;18692.532686682942;18767.718484222747;6432.774852880127;6542.149520562297;6569;6587.670616469158;6789.913613821765;3407.454807230831;3436.9312613748084;3446.3968805458944;3461.152017755616;3504.9649503505148;2734.2754170144926;2777.222377734238;2794.9580756288674;2796.4127533217843;2812.943741125207;448.31184132356674;455.78350283615015;459.30415420637763;468.0895657945332;468.42383867842744;616.8396216983526;631.9020551814476;635.3836778325017;650.5186162239909;672.3713328038202;8784.516851573226;8977.596008179647;9004.279657627374;9121;9153.496557689392;595.9314678811992;603.7403916315939;611.7338957553478;615.227888999303;626.223482881224;4051.2505186540584;4197.349410841324;4251.404803327537;4331.675124365685;4388.363687265392;45128.54871451309;54863.72568137134;55952;58313.70843145757;58741.41258587445;39102.80448597739;41876.162476750294;46819.063618727436;49531.50468495341;50869.49130508648;44941.550584493736;46348.36931281931;46756;47115.29327060097;47578;9327.393719408217;9785.559649815918;9838.508074596384;9845.60617575289;9892.356996795184;32133.839330803195;32493.35013299768;32506.61160743364;32740.181495462803;32912.67087329096;37675.43486847754;38238.42642360311;38393;38408.615913840506;39424;11279.154063445438;11880.227785193934;11912.761744764883;11928.522859085539;11950.880491194977;12382.504699811907;12404.75190496167;12495.812562811383;12625.747485050431;13287.335633218494;11280.60517881903;11320.980215424273;11859.466324015268;11892;12052.578159764365;11544.769104617693;11640.650780476599;11694.122940779305;12057.041069171582;12158.817617735918;11396.430178490877;11951.701207469883;12090.153689241668;12479.937600312303;12502.937485312515;9861.909382697677;9978;10169.084782369622;10263.846042309222;10795.244332896622;9061.77345566366;9171.44971301724;9951.601935922483;10182.796344073226;10241.539130738985 09:03:01 INFO - PID 29485 | __end_tp_report 09:03:01 INFO - PID 29485 | __start_cc_report 09:03:01 INFO - PID 29485 | _x_x_mozilla_cycle_collect,369 09:03:01 INFO - PID 29485 | __end_cc_report 09:03:01 INFO - PID 29485 | __startTimestamp1489593781530__endTimestamp 09:03:01 INFO - PID 29485 | 09:03:01 INFO - PID 29485 | ------- Summary: start ------- 09:03:01 INFO - PID 29485 | Number of tests: 6 09:03:01 INFO - PID 29485 | 09:03:01 INFO - PID 29485 | [#0] dojo.html Cycles:165 Average:4999.20 Median:5097.44 stddev:551.85 (10.8%) stddev-sans-first:521.93 09:03:01 INFO - PID 29485 | Values: 2652.1 2671.1 2681.9 2690.3 2701.4 4888.1 4974.2 4981.4 5016.4 5039.1 5000.8 5041.0 5052.0 5075.3 5095.3 4550.5 4613.8 4618.6 4626.5 4636.1 4602.3 4623.1 4655.9 4673.6 4699.3 4554.0 4556.2 4613.0 4656.5 4658.5 4635.5 4642.5 4643.4 4679.1 4687.4 4562.3 4604.2 4610.1 4623.9 4659.7 4929.4 4987.3 4988.2 5005.8 5034.7 5351.2 5378.0 5380.9 5384.8 5400.1 5409.0 5414.9 5421.1 5427.2 5445.8 4974.6 4999.4 5005.4 5041.5 5086.8 5580.8 5596.6 5598.2 5599.8 5602.4 5300.6 5339.5 5370.8 5383.8 5396.4 5445.7 5467.3 5485.1 5489.4 5526.5 5400.7 5422.2 5431.2 5442.1 5479.3 5310.4 5351.1 5369.1 5406.3 5428.3 4580.0 4590.7 4608.1 4622.4 4630.3 3954.1 3979.6 4008.7 4035.8 4050.6 4643.4 4677.7 4695.3 4709.9 4758.7 5489.5 5504.1 5514.1 5534.4 5557.7 4699.0 4711.2 4714.4 4717.5 4744.8 4727.7 4795.6 4883.9 4909.4 4976.6 5028.2 5043.0 5043.7 5047.0 5056.8 5360.2 5403.9 5423.1 5424.6 5425.9 5028.9 5055.9 5097.4 5101.1 5106.4 5346.7 5361.5 5399.1 5400.9 5412.7 5395.2 5496.0 5501.4 5506.8 5546.4 5265.5 5302.7 5324.6 5356.5 5358.8 5293.7 5307.0 5307.5 5307.7 5309.9 5174.2 5223.4 5225.9 5253.0 5305.0 5168.5 5227.9 5228.5 5233.0 5237.1 5142.8 5169.4 5185.0 5185.8 5200.8 09:03:01 INFO - PID 29485 | 09:03:01 INFO - PID 29485 | [#1] ext.html Cycles:180 Average:35690.47 Median:30559.81 stddev:55131.24 (180.4%) stddev-sans-first:55223.01 09:03:01 INFO - PID 29485 | Values: 618.9 676.1 698.6 813.9 822.2 32637.0 33363.3 33363.8 33388.3 33413.3 32323.8 32779.5 32809.3 32822.2 32849.7 5871.0 6348.1 8812.0 8992.9 8994.7 9101.8 9186.3 9262.0 9262.4 9299.2 9329.9 9341.5 9366.7 9390.1 9434.5 9312.6 9317.4 9338.7 9354.9 9377.6 9184.5 9195.0 9214.9 9272.3 9281.3 33982.0 34096.1 34139.3 34226.3 34303.5 3379.1 3471.2 3492.7 3526.7 3530.7 24159.4 24198.5 24286.4 24307.6 24582.8 2946.4 2949.9 3029.7 3118.8 3118.9 163621.0 164485.0 164672.0 165355.0 166274.0 44161.3 44281.6 44327.8 44361.6 44370.3 44922.3 45020.5 45030.1 45223.3 45289.0 13020.7 13224.5 13273.8 13293.3 13307.5 10657.1 10680.9 10702.7 10707.4 10715.8 12632.7 13321.2 13340.1 13405.4 13546.4 5405.5 5433.0 5453.4 5502.7 5555.4 998.5 1009.2 1037.4 1060.2 1070.2 21154.5 22386.7 22392.6 22644.4 22797.9 979.6 1004.0 1012.0 1012.4 1161.7 12034.8 12884.6 12986.4 13025.2 13087.7 230912.0 232285.0 232448.0 233384.0 233423.0 43071.0 43379.0 43402.0 43411.6 43440.0 1118.3 1139.7 1141.0 1142.4 1242.9 24225.0 24309.5 25411.7 25478.9 25706.4 33365.2 33795.3 33840.8 33858.3 33881.0 232039.0 232244.0 232673.0 232993.0 233220.0 29123.0 29425.4 29710.0 29896.6 29956.9 35091.0 35833.8 35877.5 35973.0 36016.0 29852.6 30143.2 30403.7 30530.5 30960.4 29444.0 29484.6 29807.6 30364.0 31219.5 29837.1 30340.8 30589.1 30673.4 30756.4 25785.2 27334.6 27733.7 27820.7 27921.6 21683.2 22215.4 22236.2 22437.0 22443.8 09:03:01 INFO - PID 29485 | 09:03:01 INFO - PID 29485 | [#2] jquery.html Cycles:180 Average:29179.45 Median:2295.42 stddev:77080.89 (3358.0%) stddev-sans-first:77266.82 09:03:01 INFO - PID 29485 | Values: 395.9 410.5 415.3 430.7 432.1 12138.5 17388.9 17939.6 18009.7 18030.1 18208.8 18606.6 18742.0 19028.0 19279.5 4345.7 5513.0 5660.3 5667.3 5713.3 5456.9 5547.3 5591.2 5604.2 5610.0 5567.2 5575.6 6378.9 6674.6 6690.9 6585.8 6619.5 6630.9 6659.8 6699.6 6784.0 6832.5 6833.4 6833.4 6838.6 20187.7 21885.3 22672.4 22734.8 22779.1 2229.3 2286.1 2304.8 2305.5 2345.4 13634.3 13933.4 14017.2 14375.9 14998.6 1825.6 1855.3 1859.6 1881.5 1890.0 78725.0 79256.2 80595.0 84757.6 91530.5 16478.6 16888.2 16940.7 16974.0 17098.3 28246.9 29202.3 29368.9 29375.0 29781.4 8919.8 9042.9 9062.5 9073.2 9214.6 7219.3 7262.8 7466.9 7499.5 7513.8 8504.2 8862.6 8931.6 8949.6 9113.5 3781.8 3879.4 3882.0 3924.2 3958.1 997.3 1021.1 1028.7 1029.3 1030.5 19571.2 19736.7 19781.8 19902.6 20308.8 1018.7 1020.1 1021.8 1024.9 1044.7 10412.5 10881.3 10887.1 11013.8 11028.3 449175.0 450451.0 451906.0 460253.0 519314.1 91687.0 93775.0 94307.5 95540.0 95581.5 1091.7 1130.3 1153.2 1153.4 1155.7 16361.6 16666.8 16807.9 17257.7 17431.5 42490.6 42715.4 43238.4 43785.8 44082.8 54977.2 55279.0 55305.7 56776.0 57128.9 10288.5 10308.1 10317.6 10385.7 10945.4 11763.6 12022.7 12074.8 12369.1 12446.6 10638.4 10649.8 10744.0 10822.6 11144.2 10624.8 10647.2 10648.3 10689.1 10714.3 9843.2 9904.2 10388.8 10928.1 11271.2 10248.5 10262.4 10358.2 10683.9 10787.2 9632.3 9800.7 9963.0 10150.6 10440.1 09:03:01 INFO - PID 29485 | 09:03:01 INFO - PID 29485 | [#3] mootools.html Cycles:180 Average:5718.50 Median:4460.10 stddev:3661.92 (82.1%) stddev-sans-first:3657.00 09:03:01 INFO - PID 29485 | Values: 1278.6 1278.6 1300.9 1304.6 1425.1 8823.0 9127.2 9188.2 9205.2 9361.9 8882.8 9013.5 9200.7 9216.6 9253.2 2023.6 2067.3 2068.6 2073.7 2076.8 1944.8 1991.4 2004.0 2005.1 2006.2 1938.2 1958.0 1958.7 1967.7 1972.1 1887.6 1888.3 1890.1 1891.7 1894.1 1678.9 1740.4 1899.1 1914.0 1957.1 9247.7 9413.2 9505.5 9508.2 9514.0 4441.4 4625.3 4628.5 4633.1 4638.3 2581.1 2619.6 2665.6 2682.9 2693.9 969.7 988.2 990.2 1031.8 1042.3 12544.7 13095.9 13098.3 13115.9 13724.4 3559.9 3665.7 3759.7 3776.1 3780.6 10444.8 10473.4 10497.0 10514.8 10545.8 4355.7 4418.9 4433.8 4478.8 4479.0 4041.4 4055.8 4086.1 4090.3 4092.2 3146.8 3155.2 3230.9 3254.2 3259.2 796.6 813.5 815.8 821.4 824.5 677.0 678.3 697.3 825.2 834.3 5478.7 5650.2 5671.9 5686.7 5749.9 896.5 904.8 912.3 939.2 950.7 3502.5 3678.3 3814.3 3833.8 3841.1 11060.8 11402.6 11427.4 11486.3 12041.9 11086.9 11250.2 11305.9 11327.3 11343.6 8306.3 8532.1 8563.3 8585.8 8588.8 5673.4 5828.9 5949.2 5964.9 6071.6 10715.4 10788.2 10795.1 10984.5 11045.6 11283.4 11304.0 11359.3 11406.8 11417.9 7738.2 7803.8 7913.1 7953.1 7957.6 8418.2 8418.2 8509.3 8543.0 8599.1 7366.3 7486.2 7556.4 7691.7 7714.0 7413.7 7550.3 7573.2 7652.1 7692.2 6716.0 6767.7 6792.6 6815.7 6830.4 4960.8 4978.8 5073.9 5075.9 5261.3 5102.8 5159.2 5239.8 5327.4 5332.7 09:03:01 INFO - PID 29485 | 09:03:01 INFO - PID 29485 | [#4] prototype.html Cycles:180 Average:4857.27 Median:5270.42 stddev:1306.85 (24.8%) stddev-sans-first:1266.03 09:03:01 INFO - PID 29485 | Values: 353.0 380.2 380.7 384.4 385.8 5413.1 5445.0 5473.6 5503.9 5506.6 5354.1 5370.5 5381.4 5383.3 5387.4 4232.8 4340.4 4343.8 4428.0 4500.7 4475.6 4476.8 4491.2 4495.5 4498.1 4471.2 4490.8 4492.6 4498.5 4499.6 4360.6 4378.6 4436.2 4489.5 4508.8 4111.5 4112.9 4113.2 4122.8 4124.2 5245.6 5251.2 5255.6 5259.8 5267.9 4880.9 5082.3 5171.8 5189.1 5214.7 5671.2 5681.9 5687.4 5701.2 5706.8 4519.2 4537.1 4538.8 4546.3 4557.6 5848.8 5965.4 6000.1 6047.4 6049.0 4669.7 4690.4 4703.3 4705.1 4708.3 4723.7 4759.5 4773.5 4781.7 4785.8 5044.9 5133.6 5133.8 5151.1 5162.7 5646.8 5676.5 5681.8 5689.0 5703.1 1659.5 1680.9 1681.2 1689.1 1692.1 1193.1 1239.3 1250.6 1251.2 1259.4 4958.3 4961.4 4988.5 4990.4 4992.7 5908.4 5924.2 5935.6 5942.8 5948.3 4736.7 4963.6 4981.0 5001.1 5005.8 3102.8 3151.3 3151.5 3154.9 3187.7 5202.6 5461.7 5462.5 5463.7 5469.7 5647.0 6025.0 6065.7 6070.4 6079.9 5272.9 5356.2 5508.7 5509.4 5513.5 5917.2 5926.8 5928.1 5937.7 5959.9 5724.7 5792.4 5817.5 5837.2 5837.5 5491.8 5503.7 5511.8 5532.6 5540.1 4669.2 4702.6 4716.2 4722.1 4724.0 5740.9 5827.7 5866.5 5872.7 5893.2 5700.3 5702.1 5702.9 5720.9 5726.1 5404.0 5653.6 5708.4 5712.3 5729.4 5564.1 5639.5 5651.8 5667.2 5683.9 5788.5 5795.4 5805.7 5818.3 5821.9 5494.1 5559.6 5561.2 5602.4 5610.5 09:03:01 INFO - PID 29485 | 09:03:01 INFO - PID 29485 | [#5] yui.html Cycles:180 Average:13855.38 Median:4360.02 stddev:16119.07 (369.7%) stddev-sans-first:16133.87 09:03:01 INFO - PID 29485 | Values: 669.1 682.6 688.1 696.6 699.1 12908.7 13365.2 13490.9 13514.6 13519.6 11822.5 11863.3 11994.3 12822.8 12869.5 817.2 843.1 847.9 848.9 851.4 810.6 817.2 832.7 846.1 868.3 906.7 912.8 913.5 914.9 915.2 901.0 907.0 909.1 909.4 910.5 663.5 663.8 668.2 669.4 669.9 13979.3 14095.3 14118.2 14127.5 14803.0 13255.3 13758.7 14318.8 14336.2 14416.2 10822.8 10909.1 11004.8 11165.1 11327.4 2881.3 2946.1 2984.8 3039.7 3057.9 60680.4 62452.0 63076.7 63134.7 63647.0 9496.6 9560.3 9562.0 9587.7 9940.6 18390.8 18486.0 18504.7 18692.5 18767.7 6432.8 6542.1 6569.0 6587.7 6789.9 3407.5 3436.9 3446.4 3461.2 3505.0 2734.3 2777.2 2795.0 2796.4 2812.9 448.3 455.8 459.3 468.1 468.4 616.8 631.9 635.4 650.5 672.4 8784.5 8977.6 9004.3 9121.0 9153.5 595.9 603.7 611.7 615.2 626.2 4051.3 4197.3 4251.4 4331.7 4388.4 45128.5 54863.7 55952.0 58313.7 58741.4 39102.8 41876.2 46819.1 49531.5 50869.5 44941.6 46348.4 46756.0 47115.3 47578.0 9327.4 9785.6 9838.5 9845.6 9892.4 32133.8 32493.4 32506.6 32740.2 32912.7 37675.4 38238.4 38393.0 38408.6 39424.0 11279.2 11880.2 11912.8 11928.5 11950.9 12382.5 12404.8 12495.8 12625.7 13287.3 11280.6 11321.0 11859.5 11892.0 12052.6 11544.8 11640.7 11694.1 12057.0 12158.8 11396.4 11951.7 12090.2 12479.9 12502.9 9861.9 9978.0 10169.1 10263.8 10795.2 9061.8 9171.4 9951.6 10182.8 10241.5 09:03:01 INFO - PID 29485 | -------- Summary: end -------- 09:03:01 INFO - PID 29485 | 09:03:02 INFO - TEST-INFO | 29485: exit 0 09:03:02 INFO - TEST-OK | dromaeo_css | took 1120860ms 09:03:02 INFO - TEST-START | kraken 09:03:02 INFO - operating with platform_type : linux_ 09:03:02 INFO - Initialising browser for kraken test... 09:03:02 INFO - TEST-INFO | started process 29860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHqSvBv/profile http://localhost:58381/getInfo.html) 09:03:06 INFO - PID 29860 | __metrics Screen width/height:1600/1200 09:03:06 INFO - PID 29860 | colorDepth:24 09:03:06 INFO - PID 29860 | Browser inner width/height: 1024/697 09:03:06 INFO - PID 29860 | __metrics 09:03:07 ERROR - PID 29860 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 09:03:08 INFO - TEST-INFO | 29860: exit 0 09:03:08 INFO - Browser initialized. 09:03:08 INFO - Running cycle 1/1 for kraken test... 09:03:08 INFO - TEST-INFO | started process 29993 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHqSvBv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:03:20 INFO - PID 29993 | RSS: Main: 155643904 09:03:20 INFO - PID 29993 | 09:03:23 INFO - PID 29993 | Cycle 1(1): loaded http://localhost:58381/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58381/tests/kraken/driver.html?testName=audio-beat-detection) 09:03:24 INFO - PID 29993 | RSS: Main: 161538048 09:03:24 INFO - PID 29993 | 09:03:26 INFO - PID 29993 | Cycle 1(1): loaded http://localhost:58381/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58381/tests/kraken/driver.html?testName=audio-dft) 09:03:27 INFO - PID 29993 | RSS: Main: 160813056 09:03:27 INFO - PID 29993 | 09:03:30 INFO - PID 29993 | Cycle 1(1): loaded http://localhost:58381/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58381/tests/kraken/driver.html?testName=audio-fft) 09:03:31 INFO - PID 29993 | RSS: Main: 157429760 09:03:31 INFO - PID 29993 | 09:03:33 INFO - PID 29993 | Cycle 1(1): loaded http://localhost:58381/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58381/tests/kraken/driver.html?testName=audio-oscillator) 09:03:33 INFO - PID 29993 | RSS: Main: 158253056 09:03:33 INFO - PID 29993 | 09:03:36 INFO - PID 29993 | Cycle 1(1): loaded http://localhost:58381/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58381/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:03:36 INFO - PID 29993 | RSS: Main: 158449664 09:03:36 INFO - PID 29993 | 09:03:39 INFO - PID 29993 | Cycle 1(1): loaded http://localhost:58381/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58381/tests/kraken/driver.html?testName=imaging-darkroom) 09:03:40 INFO - PID 29993 | RSS: Main: 163393536 09:03:40 INFO - PID 29993 | 09:03:44 INFO - PID 29993 | Cycle 1(1): loaded http://localhost:58381/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58381/tests/kraken/driver.html?testName=imaging-desaturate) 09:03:44 INFO - PID 29993 | RSS: Main: 161095680 09:03:44 INFO - PID 29993 | 09:03:47 INFO - PID 29993 | Cycle 1(1): loaded http://localhost:58381/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58381/tests/kraken/driver.html?testName=json-parse-financial) 09:03:48 INFO - PID 29993 | RSS: Main: 162045952 09:03:48 INFO - PID 29993 | 09:03:50 INFO - PID 29993 | Cycle 1(1): loaded http://localhost:58381/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58381/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:03:50 INFO - PID 29993 | RSS: Main: 162713600 09:03:50 INFO - PID 29993 | 09:03:52 INFO - PID 29993 | Cycle 1(1): loaded http://localhost:58381/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58381/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:03:53 INFO - PID 29993 | RSS: Main: 162516992 09:03:53 INFO - PID 29993 | 09:03:55 INFO - PID 29993 | Cycle 1(1): loaded http://localhost:58381/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58381/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:03:56 INFO - PID 29993 | RSS: Main: 163196928 09:03:56 INFO - PID 29993 | 09:03:58 INFO - PID 29993 | Cycle 1(1): loaded http://localhost:58381/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58381/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:03:59 INFO - PID 29993 | RSS: Main: 163524608 09:03:59 INFO - PID 29993 | 09:04:02 INFO - PID 29993 | Cycle 1(1): loaded http://localhost:58381/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58381/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:04:03 INFO - PID 29993 | RSS: Main: 162963456 09:04:03 INFO - PID 29993 | 09:04:05 INFO - PID 29993 | Cycle 1(1): loaded http://localhost:58381/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58381/tests/kraken/driver.html?testName=ai-astar) 09:04:05 INFO - PID 29993 | RSS: Main: 164581376 09:04:05 INFO - PID 29993 | 09:04:05 INFO - PID 29993 | __start_tp_report 09:04:05 INFO - PID 29993 | _x_x_mozilla_page_load 09:04:05 INFO - PID 29993 | _x_x_mozilla_page_load_details 09:04:05 INFO - PID 29993 | |i|pagename|runs| 09:04:05 INFO - PID 29993 | |0;ai-astar;111;125;119;119;121;119;120;119;122;118 09:04:05 INFO - PID 29993 | |1;audio-beat-detection;148;127;126;183;128;127;128;126;152;128 09:04:05 INFO - PID 29993 | |2;audio-dft;165;165;166;169;167;166;164;164;164;163 09:04:05 INFO - PID 29993 | |3;audio-fft;75;75;76;102;76;76;75;76;102;77 09:04:05 INFO - PID 29993 | |4;audio-oscillator;85;84;107;86;86;88;102;87;86;107 09:04:05 INFO - PID 29993 | |5;imaging-gaussian-blur;114;113;118;114;114;121;114;114;115;114 09:04:05 INFO - PID 29993 | |6;imaging-darkroom;152;151;151;152;150;150;151;152;151;151 09:04:05 INFO - PID 29993 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 09:04:05 INFO - PID 29993 | |8;json-parse-financial;72;71;72;73;74;72;74;78;72;72 09:04:05 INFO - PID 29993 | |9;json-stringify-tinderbox;57;56;56;55;56;56;56;56;56;56 09:04:05 INFO - PID 29993 | |10;stanford-crypto-aes;85;84;83;84;83;84;83;83;82;81 09:04:05 INFO - PID 29993 | |11;stanford-crypto-ccm;136;142;136;135;141;137;134;134;177;142 09:04:05 INFO - PID 29993 | |12;stanford-crypto-pbkdf2;193;190;198;193;195;194;194;207;190;194 09:04:05 INFO - PID 29993 | |13;stanford-crypto-sha256-iterative;74;72;74;73;73;72;72;72;78;72 09:04:05 INFO - PID 29993 | __end_tp_report 09:04:05 INFO - PID 29993 | __start_cc_report 09:04:05 INFO - PID 29993 | _x_x_mozilla_cycle_collect,873 09:04:05 INFO - PID 29993 | __end_cc_report 09:04:05 INFO - PID 29993 | __startTimestamp1489593845633__endTimestamp 09:04:05 INFO - PID 29993 | 09:04:05 INFO - PID 29993 | ------- Summary: start ------- 09:04:05 INFO - PID 29993 | Number of tests: 14 09:04:05 INFO - PID 29993 | 09:04:05 INFO - PID 29993 | [#0] ai-astar Cycles:10 Average:119.30 Median:119.50 stddev:3.56 (3.0%) stddev-sans-first:2.17 09:04:05 INFO - PID 29993 | Values: 111.0 125.0 119.0 119.0 121.0 119.0 120.0 119.0 122.0 118.0 09:04:05 INFO - PID 29993 | 09:04:05 INFO - PID 29993 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:128.00 stddev:18.70 (14.6%) stddev-sans-first:19.43 09:04:05 INFO - PID 29993 | Values: 148.0 127.0 126.0 183.0 128.0 127.0 128.0 126.0 152.0 128.0 09:04:05 INFO - PID 29993 | 09:04:05 INFO - PID 29993 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.50 stddev:1.77 (1.1%) stddev-sans-first:1.87 09:04:05 INFO - PID 29993 | Values: 165.0 165.0 166.0 169.0 167.0 166.0 164.0 164.0 164.0 163.0 09:04:05 INFO - PID 29993 | 09:04:05 INFO - PID 29993 | [#3] audio-fft Cycles:10 Average:81.00 Median:76.00 stddev:11.09 (14.6%) stddev-sans-first:11.54 09:04:05 INFO - PID 29993 | Values: 75.0 75.0 76.0 102.0 76.0 76.0 75.0 76.0 102.0 77.0 09:04:05 INFO - PID 29993 | 09:04:05 INFO - PID 29993 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:86.00 stddev:9.50 (11.0%) stddev-sans-first:9.75 09:04:05 INFO - PID 29993 | Values: 85.0 84.0 107.0 86.0 86.0 88.0 102.0 87.0 86.0 107.0 09:04:05 INFO - PID 29993 | 09:04:05 INFO - PID 29993 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:114.00 stddev:2.47 (2.2%) stddev-sans-first:2.59 09:04:05 INFO - PID 29993 | Values: 114.0 113.0 118.0 114.0 114.0 121.0 114.0 114.0 115.0 114.0 09:04:05 INFO - PID 29993 | 09:04:05 INFO - PID 29993 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 09:04:05 INFO - PID 29993 | Values: 152.0 151.0 151.0 152.0 150.0 150.0 151.0 152.0 151.0 151.0 09:04:05 INFO - PID 29993 | 09:04:05 INFO - PID 29993 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:04:05 INFO - PID 29993 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 09:04:05 INFO - PID 29993 | 09:04:05 INFO - PID 29993 | [#8] json-parse-financial Cycles:10 Average:73.00 Median:72.50 stddev:2.00 (2.8%) stddev-sans-first:2.09 09:04:05 INFO - PID 29993 | Values: 72.0 71.0 72.0 73.0 74.0 72.0 74.0 78.0 72.0 72.0 09:04:05 INFO - PID 29993 | 09:04:05 INFO - PID 29993 | [#9] json-stringify-tinderbox Cycles:10 Average:56.00 Median:56.00 stddev:0.47 (0.8%) stddev-sans-first:0.33 09:04:05 INFO - PID 29993 | Values: 57.0 56.0 56.0 55.0 56.0 56.0 56.0 56.0 56.0 56.0 09:04:05 INFO - PID 29993 | 09:04:05 INFO - PID 29993 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.50 stddev:1.14 (1.4%) stddev-sans-first:1.00 09:04:05 INFO - PID 29993 | Values: 85.0 84.0 83.0 84.0 83.0 84.0 83.0 83.0 82.0 81.0 09:04:05 INFO - PID 29993 | 09:04:05 INFO - PID 29993 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:139.00 stddev:12.89 (9.3%) stddev-sans-first:13.53 09:04:05 INFO - PID 29993 | Values: 136.0 142.0 136.0 135.0 141.0 137.0 134.0 134.0 177.0 142.0 09:04:05 INFO - PID 29993 | 09:04:05 INFO - PID 29993 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.80 Median:194.00 stddev:4.87 (2.5%) stddev-sans-first:5.12 09:04:05 INFO - PID 29993 | Values: 193.0 190.0 198.0 193.0 195.0 194.0 194.0 207.0 190.0 194.0 09:04:05 INFO - PID 29993 | 09:04:05 INFO - PID 29993 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:73.00 stddev:1.87 (2.6%) stddev-sans-first:1.96 09:04:05 INFO - PID 29993 | Values: 74.0 72.0 74.0 73.0 73.0 72.0 72.0 72.0 78.0 72.0 09:04:05 INFO - PID 29993 | -------- Summary: end -------- 09:04:05 INFO - PID 29993 | 09:04:06 INFO - TEST-INFO | 29993: exit 0 09:04:06 INFO - TEST-OK | kraken | took 64342ms 09:04:06 INFO - SUITE-END | took 1185s 09:04:07 INFO - Completed test suite (00:19:45) 09:04:07 INFO - javascript benchmark 09:04:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6755.44248018808, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2652.1115426332176, 2671.1051797647788, 2681.8524981126043, 2690.287073925409, 2701.3651791828925, 4888.095702295073, 4974.204127339626, 4981.35242418486, 5016.4231113421965, 5039.1433456312425, 5000.7749651265685, 5041.042201981621, 5052.0, 5075.314832497621, 5095.261187127873, 4550.453945526533, 4613.838515651953, 4618.630509559227, 4626.537346265381, 4636.09596128755, 4602.286645569942, 4623.121606894696, 4655.86032419028, 4673.579377855992, 4699.318598803188, 4553.954460455419, 4556.179887620227, 4612.976935115336, 4656.511066338019, 4658.510856360067, 4635.513271106519, 4642.466116396624, 4643.3963584733765, 4679.110968915895, 4687.414073240845, 4562.339507865666, 4604.240300350438, 4610.101030299093, 4623.861284161447, 4659.720416775004, 4929.383827021622, 4987.301777751118, 4988.201887697987, 5005.849824505271, 5034.672746271517, 5351.170568561879, 5377.9512994966, 5380.892382152335, 5384.811531596375, 5400.135978243501, 5408.972955135199, 5414.864628384283, 5421.051316019681, 5427.185922111715, 5445.809396671137, 4974.602031837517, 4999.3500844890295, 5005.424376196747, 5041.495850414929, 5086.821961231339, 5580.804671836548, 5596.552275817925, 5598.216249725042, 5599.776008959596, 5602.439756024446, 5300.628955973122, 5339.492748188916, 5370.758315875795, 5383.78464861409, 5396.406395296514, 5445.700486473282, 5467.316585426822, 5485.094959331665, 5489.368722596872, 5526.47498487643, 5400.729963501809, 5422.213779002102, 5431.21247419122, 5442.12925931849, 5479.287692599936, 5310.362756469249, 5351.143816989263, 5369.140937449989, 5406.324209473816, 5428.267183930119, 4579.977100114545, 4590.724556526619, 4608.055348653585, 4622.375979242826, 4630.282306242538, 3954.149857780591, 3979.582143874851, 4008.719389642697, 4035.778032208198, 4050.6151915567975, 4643.3963584733765, 4677.7193368398, 4695.319178719066, 4709.858704238878, 4758.738269395217, 5489.533389661844, 5504.146857237135, 5514.145307477347, 5534.446555344514, 5557.722113894289, 4699.0, 4711.199096153662, 4714.4106986626675, 4717.481077081518, 4744.786484608201, 4727.739974301447, 4795.592374648124, 4883.926741098886, 4909.386326709161, 4976.601871850244, 5028.170351891897, 5043.0, 5043.697378157322, 5046.9906018795655, 5056.797728090835, 5360.249565060973, 5403.864903377447, 5423.132298832325, 5424.647397919122, 5425.864353391197, 5028.9245661315845, 5055.898882022412, 5097.439281678938, 5101.107306221322, 5106.438291787826, 5346.732663366894, 5361.51746342831, 5399.109146990702, 5400.8649783754145, 5412.702301373462, 5395.24466574672, 5496.0, 5501.449855014626, 5506.752196151103, 5546.389897111234, 5265.473452654857, 5302.70835104073, 5324.627276090637, 5356.544693701079, 5358.785648574013, 5293.708846013352, 5307.0, 5307.52232299095, 5307.681539107666, 5309.920351194813, 5174.197999309962, 5223.399309079505, 5225.9216111759115, 5253.001929633358, 5305.018571564273, 5168.457311982188, 5227.869303267449, 5228.529432351107, 5233.0, 5237.135872580981, 5142.76857541404, 5169.405518365436, 5185.040767458032, 5185.844424667266, 5200.843974680765], "value": 4961.11879886359, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.9319174890761, 676.1244188775535, 698.6436917172243, 813.9226773456523, 822.2394285286109, 32637.0, 33363.33273334532, 33363.833180834125, 33388.332233355315, 33413.33173336532, 32323.838380808123, 32779.50830737541, 32809.34381312372, 32822.179445513815, 32849.67150328502, 5871.0, 6348.111264422984, 8811.95594022029, 8992.865107023366, 8994.68518601849, 9101.817963640724, 9186.311026672993, 9261.95369023154, 9262.351635385527, 9299.16307532322, 9329.906700933007, 9341.53292335384, 9366.718998430024, 9390.107939745747, 9434.481103539303, 9312.580933857993, 9317.39436936597, 9338.673146439909, 9354.859677104849, 9377.578008989578, 9184.540772961325, 9195.0, 9214.861777073349, 9272.304577156672, 9281.257499400099, 33982.0, 34096.147596310046, 34139.317213655835, 34226.315473690636, 34303.4854477183, 3379.138319728478, 3471.1669199392218, 3492.720582353431, 3526.7002304803864, 3530.6822385985383, 24159.396015099588, 24198.516029679486, 24286.392840179138, 24307.63538546923, 24582.754172458226, 2946.351802603424, 2949.8967536136347, 3029.74247188987, 3118.8128712277335, 3118.8752449901976, 163621.0, 164484.9999999988, 164672.0, 165355.0, 166274.0, 44161.33757993633, 44281.557184427744, 44327.778361108634, 44361.556384436386, 44370.334444982705, 44922.32616510755, 45020.549794502294, 45030.09939801186, 45223.321650175276, 45289.0, 13020.739585208243, 13224.471021159046, 13273.800892986614, 13293.335333233299, 13307.467701292033, 10657.081725289523, 10680.893191068146, 10702.732431689114, 10707.411092389993, 10715.785684286271, 12632.736726327294, 13321.200727956353, 13340.132891362224, 13405.396757145953, 13546.390412431465, 5405.459454054563, 5433.0, 5453.400125986138, 5502.724863756796, 5555.3611334697025, 998.4957596413765, 1009.2430676992255, 1037.444966942682, 1060.2207377577474, 1070.2454769387564, 21154.471138221666, 22386.664200037012, 22392.55214895693, 22644.395894472018, 22797.88601056984, 979.5591983607405, 1003.9648612298535, 1011.9797604048025, 1012.3925644613173, 1161.6814915071454, 12034.81947770784, 12884.613461596167, 12986.35068246584, 13025.218486890817, 13087.738245235232, 230912.0, 232285.0, 232448.0, 233384.0, 233423.0, 43071.0, 43379.0, 43402.0, 43411.56588434075, 43440.0, 1118.2898859224451, 1139.6865861888048, 1140.9959235872545, 1142.4116579961326, 1242.863285038645, 24225.00062389203, 24309.513809723354, 25411.745882540938, 25478.872605636854, 25706.357341065876, 33365.16587085342, 33795.32409351848, 33840.83079584586, 33858.3228335427, 33881.0, 232039.0, 232244.0, 232673.0, 232993.0, 233220.0, 29123.0, 29425.411491770472, 29710.0, 29896.551551727178, 29956.850215748782, 35091.0, 35833.82083089672, 35877.461838071926, 35973.0, 36016.0, 29852.552211717277, 30143.246418839706, 30403.695963040085, 30530.542041868946, 30960.380792384476, 29444.0, 29484.557731633613, 29807.55288670715, 30364.0, 31219.531707024868, 29837.10488685343, 30340.84829575838, 30589.08232753021, 30673.386532269677, 30756.384872302875, 25785.226443206735, 27334.589981150697, 27733.722662773114, 27820.70788955143, 27921.58117628278, 21683.241086562524, 22215.44461388478, 22236.221732239293, 22437.0, 22443.77556224417], "value": 15880.345657630916, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.9030037640775, 410.5299432150187, 415.2711990456748, 430.6533240741203, 432.08182611949604, 12138.514459421613, 17388.91305543472, 17939.64120717585, 18009.7298540522, 18030.098495075228, 18208.81791182088, 18606.627867442643, 18742.0, 19028.0, 19279.518012049706, 4345.652347812167, 5513.035218836708, 5660.29246344207, 5667.263255776743, 5713.342965558952, 5456.863578410552, 5547.25112109866, 5591.161325801122, 5604.243427137346, 5609.971950140243, 5567.220589117527, 5575.553955683536, 6378.904316435257, 6674.566153200027, 6690.866182676344, 6585.835354116138, 6619.536632435731, 6630.900536491957, 6659.770011544397, 6699.631520266384, 6783.966080169617, 6832.45340372769, 6833.384995350392, 6833.4191593714095, 6838.555493892931, 20187.697184542245, 21885.343439696833, 22672.43318917024, 22734.77265227343, 22779.08883644652, 2229.3423440085053, 2286.062714287151, 2304.781045800646, 2305.4812667149927, 2345.4019225097663, 13634.318284085755, 13933.372998215003, 14017.229052402114, 14375.928120359436, 14998.625034374229, 1825.6439994201137, 1855.3413538193881, 1859.5537071102974, 1881.482592287132, 1889.9811001889943, 78725.0, 79256.19422703049, 80595.0, 84757.57621211917, 91530.5423472885, 16478.588035299214, 16888.240029198714, 16940.745888811678, 16974.0, 17098.316067357166, 28246.85876570604, 29202.269943251587, 29368.853155734083, 29375.0, 29781.404371912875, 8919.777005574913, 9042.909570904207, 9062.546872656341, 9073.183413492818, 9214.585343659552, 7219.278072192738, 7262.818429539304, 7466.887996680054, 7499.512531685423, 7513.774586762406, 8504.192101750325, 8862.64549418029, 8931.642734290555, 8949.552522373855, 9113.544322783835, 3781.8487260509823, 3879.398693202558, 3881.9805900970314, 3924.2151569685607, 3958.148997965451, 997.3218211616025, 1021.070825548762, 1028.681108856257, 1029.2537910015178, 1030.5105075089273, 19571.21715131407, 19736.70394944077, 19781.802181978284, 19902.60194796096, 20308.796912030986, 1018.6638409324905, 1020.1277907389224, 1021.8416145497459, 1024.8718910136233, 1044.7283706236433, 10412.47937603132, 10881.264966966895, 10887.129029677606, 11013.779724405467, 11028.338299702044, 449175.0, 450451.0, 451906.0, 460253.0, 519314.0857392826, 91687.0, 93775.0, 94307.52846235725, 95540.0, 95581.52209238909, 1091.6724982505216, 1130.2540323386525, 1153.2330999884982, 1153.4348169397103, 1155.6706338693432, 16361.590960226089, 16666.833331666527, 16807.915960420607, 17257.741133883253, 17431.47705568835, 42490.57509424866, 42715.3592696116, 43238.351424728025, 43785.78107109444, 44082.77958610315, 54977.1753423691, 55279.0, 55305.723471382385, 56776.0, 57128.85742285214, 10288.485575721033, 10308.12380947628, 10317.587296508056, 10385.740356491147, 10945.398003109905, 11763.588274410355, 12022.699432514257, 12074.75850483003, 12369.134160608672, 12446.626601201979, 10638.41488718128, 10649.840252396376, 10744.0, 10822.621208257673, 11144.2199046066, 10624.84062739044, 10647.201459890694, 10648.307859989076, 10689.144868410664, 10714.25000249975, 9843.2125429964, 9904.207663387057, 10388.792224155626, 10928.125749939827, 11271.154663400443, 10248.538815753458, 10262.43556604394, 10358.171346292429, 10683.89316106829, 10787.190960677824, 9632.27757918145, 9800.65697700577, 9962.950185249027, 10150.644727434505, 10440.060394564525], "value": 10006.477341029453, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1278.5525066226828, 1278.567047477523, 1300.9414576344063, 1304.5564508067262, 1425.0879437160215, 8822.955885220581, 9127.224185944186, 9188.173064424209, 9205.171534561896, 9361.906380936189, 8882.822343553125, 9013.54932253388, 9200.677976270832, 9216.585253663585, 9253.167214950654, 2023.615513052519, 2067.348785132686, 2068.6173057984247, 2073.6785798201304, 2076.8338532917332, 1944.8346890514324, 1991.3627639155477, 2004.0, 2005.1077270614583, 2006.1975209916004, 1938.2440848069264, 1957.9706304405445, 1958.735570697959, 1967.655660259456, 1972.0829814136423, 1887.631911777204, 1888.3485197606803, 1890.1210936914333, 1891.6973284274588, 1894.0908363985295, 1678.8656907447375, 1740.3734655524001, 1899.08843754997, 1914.0, 1957.0997341223053, 9247.72256832296, 9413.246940244764, 9505.524723763785, 9508.191803696694, 9514.0, 4441.444819397575, 4625.259958406638, 4628.5371462853445, 4633.096546173498, 4638.327442520816, 2581.0579138614457, 2619.6332513448133, 2665.626812246287, 2682.9060982865703, 2693.946121077587, 969.6993931881069, 988.2439933450916, 990.1929927109383, 1031.7523794289316, 1042.3224903812506, 12544.74910501794, 13095.934520327433, 13098.34508274592, 13115.934420327838, 13724.382402791798, 3559.857605695743, 3665.651763082556, 3759.71802114837, 3776.0937375029794, 3780.6219378062524, 10444.843327350096, 10473.423961682029, 10497.0, 10514.842277365846, 10545.789084218426, 4355.695101342875, 4418.889527761768, 4433.7561434121435, 4478.753668548196, 4479.0, 4041.3735870939463, 4055.7566546007333, 4086.0806318578675, 4090.3250963591267, 4092.242935057024, 3146.7797254192446, 3155.2111972006996, 3230.8707651693667, 3254.23525471514, 3259.1689119274433, 796.5937371940237, 813.4712436916052, 815.7838172884191, 821.3757544266281, 824.4558591329813, 676.9593824370553, 678.3420082519948, 697.3410127429631, 825.1748251748252, 834.3325339728315, 5478.671279723229, 5650.180723795109, 5671.858203544944, 5686.687232202268, 5749.88500229993, 896.5382827843666, 904.8280826642916, 912.3385545479474, 939.1500691873865, 950.6720181537358, 3502.5067642845815, 3678.319510890494, 3814.275287695329, 3833.789141597183, 3841.116543195025, 11060.834087488694, 11402.600908968312, 11427.371494567878, 11486.253393529394, 12041.939790300992, 11086.944565277123, 11250.212485126127, 11305.94347028276, 11327.32036077838, 11343.602973896039, 8306.252437280553, 8532.104129066358, 8563.272121869586, 8585.785355366166, 8588.785280367916, 5673.375928647928, 5828.912566311594, 5949.2266005419015, 5964.910526342195, 6071.635701857903, 10715.41065241388, 10788.244822862638, 10795.136389089012, 10984.450777461256, 11045.558177673125, 11283.435828208721, 11304.039156671775, 11359.261647992855, 11406.828897566376, 11417.942910285396, 7738.2261773822165, 7803.765887023398, 7913.089994650459, 7953.125156232694, 7957.562334071682, 8418.200270974248, 8418.242358187792, 8509.319254459751, 8542.957285213783, 8599.054104048424, 7366.263373662591, 7486.213947535431, 7556.357709594746, 7691.730789422343, 7713.961430193038, 7413.740519081806, 7550.282723141512, 7573.242675732383, 7652.120006199136, 7692.230776922263, 6716.0, 6767.661616919233, 6792.592444453151, 6815.659217039029, 6830.385265326145, 4960.826371076995, 4978.8257410990445, 5073.949260507496, 5075.898482030412, 5261.289725886956, 5102.800841802247, 5159.17453207485, 5239.816606418757, 5327.413984461628, 5332.733363331896], "value": 4307.872828769952, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.99647003529975, 380.1807105687244, 380.74870585413635, 384.40609258695315, 385.82444987530675, 5413.133898576229, 5444.972775136119, 5473.644213126144, 5503.862403439911, 5506.587005974553, 5354.14333706607, 5370.489803468674, 5381.408045115034, 5383.300170977777, 5387.434319396466, 4232.830686772525, 4340.435743353368, 4343.78281085946, 4428.0, 4500.684952053358, 4475.552444755514, 4476.798544065525, 4491.169133710274, 4495.50549439563, 4498.145352383053, 4471.217536931041, 4490.797914093857, 4492.573205545468, 4498.52765459627, 4499.61753250974, 4360.585744354313, 4378.562143785628, 4436.24583820748, 4489.46126464823, 4508.842190523316, 4111.48606424197, 4112.91774164518, 4113.197926404352, 4122.814473348706, 4124.154548317588, 5245.56415547813, 5251.212318152269, 5255.579553635738, 5259.815906443295, 5267.947320526784, 4880.877978050577, 5082.339295891547, 5171.7672704728375, 5189.117849965477, 5214.713190774506, 5671.234383358235, 5681.857953551194, 5687.374388817227, 5701.2018317435595, 5706.80026199081, 4519.209138400766, 4537.069900670354, 4538.7503687297185, 4546.340780586829, 4557.56703113207, 5848.766049358021, 5965.403459654043, 6000.129981152709, 6047.365026672224, 6049.0, 4669.696469729457, 4690.390249267642, 4703.341532185496, 4705.12955103307, 4708.340832283483, 4723.716577005391, 4759.547842954914, 4773.522647735199, 4781.665283430196, 4785.784639691153, 5044.873878153076, 5133.640645154878, 5133.768980395891, 5151.124308867502, 5162.6902385856965, 5646.842397308542, 5676.545876329967, 5681.801136960269, 5688.971555142198, 5703.087505999103, 1659.468969929611, 1680.8907421017595, 1681.2434404518017, 1689.121656738489, 1692.1370101248451, 1193.0515240383916, 1239.324568110382, 1250.64929875734, 1251.2117366059324, 1259.4332550352378, 4958.256261560723, 4961.420061567965, 4988.451270360258, 4990.4011518618, 4992.701897506675, 5908.379620139824, 5924.229850119457, 5935.614185077956, 5942.7920022799, 5948.345681974979, 4736.739479328601, 4963.592657561152, 4980.975095124501, 5001.1495746574, 5005.824796132118, 3102.7828052036593, 3151.2668032581987, 3151.4800057990633, 3154.9053528394184, 3187.6971687689634, 5202.606800871566, 5461.672299662033, 5462.508374246337, 5463.69949652765, 5469.671819690831, 5647.0, 6024.969875150597, 6065.696715164224, 6070.3929607038945, 6079.878402431927, 5272.885301257774, 5356.196570514454, 5508.669479831143, 5509.449055094458, 5513.531349835149, 5917.171595976481, 5926.762929482945, 5928.110783382527, 5937.732802024006, 5959.940400596112, 5724.685142317213, 5792.4497172768515, 5817.476427121579, 5837.153612726216, 5837.474627283565, 5491.807786727445, 5503.669779813224, 5511.807086751945, 5532.612717109924, 5540.113581826889, 4669.182892993645, 4702.623790096715, 4716.221823399238, 4722.126406614787, 4723.952760472352, 5740.942590574041, 5827.650340979555, 5866.472017518444, 5872.677002764718, 5893.174955506147, 5700.315962084576, 5702.087665973424, 5702.91644587527, 5720.856978575569, 5726.112452569859, 5404.0, 5653.575981801299, 5708.429157084258, 5712.314522257356, 5729.3984131665575, 5564.137558678412, 5639.520640745583, 5651.802186923438, 5667.234923285304, 5683.857903552444, 5788.507976822018, 5795.449432303924, 5805.738741756547, 5818.272715910512, 5821.854453638693, 5494.120940649477, 5559.63862348946, 5561.1658251261015, 5602.431319230622, 5610.523105535912], "value": 4465.433061061768, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.1401549009523, 682.63137905531, 688.0814113158935, 696.6412297666699, 699.1470406104552, 12908.677283067927, 13365.19808811472, 13490.865091349084, 13514.594562163125, 13519.594412167638, 11822.469727897895, 11863.288202707843, 11994.280343179415, 12822.80765788514, 12869.5495657652, 817.2236375443338, 843.1273631791097, 847.9321654267644, 848.9320854331638, 851.3614788908319, 810.5541951926417, 817.207308910356, 832.650286879509, 846.1369403208723, 868.2966796894505, 906.714384968736, 912.7581190984395, 913.5158366065996, 914.8719179314901, 915.1809130827905, 901.0133903375826, 907.0476000199797, 909.0909090909091, 909.4043401571981, 910.544727636182, 663.4559661077918, 663.8473151175208, 668.1647940074906, 669.437672355224, 669.8660267946382, 13979.301034948212, 14095.295235238196, 14118.223497707622, 14127.505537306248, 14803.0, 13255.337233138305, 13758.65603359914, 14318.78521822163, 14336.219552386303, 14416.207108609022, 10822.837657435144, 10909.127269818395, 11004.834927476095, 11165.075197540173, 11327.376994265313, 2881.3228891210547, 2946.1456177708437, 2984.8358340291275, 3039.7264246217946, 3057.908262752121, 60680.39319606792, 62452.0, 63076.684616577084, 63134.68432657807, 63647.0, 9496.572654230438, 9560.28297877662, 9562.0, 9587.712368628952, 9940.552675129637, 18390.816091839177, 18486.0, 18504.722429163572, 18692.532686682942, 18767.718484222747, 6432.774852880127, 6542.149520562297, 6569.0, 6587.670616469158, 6789.913613821765, 3407.454807230831, 3436.9312613748084, 3446.3968805458944, 3461.152017755616, 3504.9649503505148, 2734.2754170144926, 2777.222377734238, 2794.9580756288674, 2796.4127533217843, 2812.943741125207, 448.31184132356674, 455.78350283615015, 459.30415420637763, 468.0895657945332, 468.42383867842744, 616.8396216983526, 631.9020551814476, 635.3836778325017, 650.5186162239909, 672.3713328038202, 8784.516851573226, 8977.596008179647, 9004.279657627374, 9121.0, 9153.496557689392, 595.9314678811992, 603.7403916315939, 611.7338957553478, 615.227888999303, 626.223482881224, 4051.2505186540584, 4197.349410841324, 4251.404803327537, 4331.675124365685, 4388.363687265392, 45128.54871451309, 54863.72568137134, 55952.0, 58313.70843145757, 58741.41258587445, 39102.80448597739, 41876.162476750294, 46819.063618727436, 49531.50468495341, 50869.49130508648, 44941.550584493736, 46348.36931281931, 46756.0, 47115.29327060097, 47578.0, 9327.393719408217, 9785.559649815918, 9838.508074596384, 9845.60617575289, 9892.356996795184, 32133.839330803195, 32493.35013299768, 32506.61160743364, 32740.181495462803, 32912.67087329096, 37675.43486847754, 38238.42642360311, 38393.0, 38408.615913840506, 39424.0, 11279.154063445438, 11880.227785193934, 11912.761744764883, 11928.522859085539, 11950.880491194977, 12382.504699811907, 12404.75190496167, 12495.812562811383, 12625.747485050431, 13287.335633218494, 11280.60517881903, 11320.980215424273, 11859.466324015268, 11892.0, 12052.578159764365, 11544.769104617693, 11640.650780476599, 11694.122940779305, 12057.041069171582, 12158.817617735918, 11396.430178490877, 11951.701207469883, 12090.153689241668, 12479.937600312303, 12502.937485312515, 9861.909382697677, 9978.0, 10169.084782369622, 10263.846042309222, 10795.244332896622, 9061.77345566366, 9171.44971301724, 9951.601935922483, 10182.796344073226, 10241.539130738985], "value": 6266.652728177701, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1577.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 125.0, 119.0, 119.0, 121.0, 119.0, 120.0, 119.0, 122.0, 118.0], "value": 119.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 127.0, 126.0, 183.0, 128.0, 127.0, 128.0, 126.0, 152.0, 128.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 166.0, 169.0, 167.0, 166.0, 164.0, 164.0, 164.0, 163.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 102.0, 76.0, 76.0, 75.0, 76.0, 102.0, 77.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 107.0, 86.0, 86.0, 88.0, 102.0, 87.0, 86.0, 107.0], "value": 91.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 118.0, 114.0, 114.0, 121.0, 114.0, 114.0, 115.0, 114.0], "value": 115.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 151.0, 152.0, 150.0, 150.0, 151.0, 152.0, 151.0, 151.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 72.0, 73.0, 74.0, 72.0, 74.0, 78.0, 72.0, 72.0], "value": 73.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 55.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0], "value": 56.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 84.0, 83.0, 84.0, 83.0, 83.0, 82.0, 81.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 142.0, 136.0, 135.0, 141.0, 137.0, 134.0, 134.0, 177.0, 142.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 190.0, 198.0, 193.0, 195.0, 194.0, 194.0, 207.0, 190.0, 194.0], "value": 194.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 74.0, 73.0, 73.0, 72.0, 72.0, 72.0, 78.0, 72.0], "value": 73.2, "unit": "score"}]}]} 09:04:07 INFO - Return code: 0 09:04:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:04:07 ERROR - # TBPL SUCCESS # 09:04:07 INFO - Running post-action listener: _resource_record_post_action 09:04:07 INFO - [mozharness: 2017-03-15 16:04:07.426856Z] Finished run-tests step (success) 09:04:07 INFO - Running post-run listener: _resource_record_post_run 09:04:07 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 12288; Write bytes: 363126784; Read time: 132; Write time: 183936 09:04:07 INFO - TinderboxPrint: CPU usage
13.3% 09:04:07 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 132 09:04:07 INFO - TinderboxPrint: I/O write bytes / time
363,126,784 / 183,936 09:04:07 INFO - TinderboxPrint: CPU idle
8,309.6 (86.7%) 09:04:07 INFO - TinderboxPrint: CPU user
1,219.7 (12.7%) 09:04:07 INFO - TinderboxPrint: Swap in / out
0 / 0 09:04:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 105283584; Read time: 40; Write time: 74360 09:04:07 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 257843200; Read time: 92; Write time: 109576 09:04:08 INFO - Running post-run listener: _upload_blobber_files 09:04:08 INFO - Blob upload gear active. 09:04:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:04:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:04:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:04:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:04:08 INFO - (blobuploader) - INFO - Open directory for files ... 09:04:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:04:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:04:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:09 INFO - (blobuploader) - INFO - Done attempting. 09:04:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:04:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:04:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:10 INFO - (blobuploader) - INFO - Done attempting. 09:04:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:04:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:04:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:10 INFO - (blobuploader) - INFO - Done attempting. 09:04:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:04:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:04:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:14 INFO - (blobuploader) - INFO - Done attempting. 09:04:14 INFO - (blobuploader) - INFO - Iteration through files over. 09:04:14 INFO - Return code: 0 09:04:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:04:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:04:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b631fe6a13381ef6a2fe7ea3a70be35375f49e3e9fd929c15960c27406b41b0ab2adb7f5d5bd64b5cc0ae79f00df7c2fe1ee61968f172e25f4a6379a19e1168a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07ed3f5238dd735249f40455b860a6704bd3dc6680aedea6e144afe2b59ecf0eb97b58d864295079b490fabe865619d94e03a099412e51ae4207606a7033814f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4f57713071be084769dfbfd4fc1ae26613b422d8170a2655d2f32d2b7254aff9eaab6c40b37ece702073de78002aba8fdb00a080485bde454784df81d0e7223", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46189e8b772aa9531a15199a72fd9a33ac4e5cacc897eae1a0b5eb1a4dfd8eb97c3d4ba901e20ac5d184e7db509141a8447cf06c3762cf2a64d449ba5a7eec40"} 09:04:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:04:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:04:14 INFO - Contents: 09:04:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b631fe6a13381ef6a2fe7ea3a70be35375f49e3e9fd929c15960c27406b41b0ab2adb7f5d5bd64b5cc0ae79f00df7c2fe1ee61968f172e25f4a6379a19e1168a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07ed3f5238dd735249f40455b860a6704bd3dc6680aedea6e144afe2b59ecf0eb97b58d864295079b490fabe865619d94e03a099412e51ae4207606a7033814f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4f57713071be084769dfbfd4fc1ae26613b422d8170a2655d2f32d2b7254aff9eaab6c40b37ece702073de78002aba8fdb00a080485bde454784df81d0e7223", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46189e8b772aa9531a15199a72fd9a33ac4e5cacc897eae1a0b5eb1a4dfd8eb97c3d4ba901e20ac5d184e7db509141a8447cf06c3762cf2a64d449ba5a7eec40"} 09:04:14 INFO - Running post-run listener: copy_logs_to_upload_dir 09:04:14 INFO - Copying logs to upload dir... 09:04:14 INFO - mkdir: /builds/slave/test/build/upload/logs 09:04:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.233442 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-15 09:04:14.344285) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 09:04:14.348375) ========= 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-1489592592.349961-1128998071 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/b631fe6a13381ef6a2fe7ea3a70be35375f49e3e9fd929c15960c27406b41b0ab2adb7f5d5bd64b5cc0ae79f00df7c2fe1ee61968f172e25f4a6379a19e1168a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07ed3f5238dd735249f40455b860a6704bd3dc6680aedea6e144afe2b59ecf0eb97b58d864295079b490fabe865619d94e03a099412e51ae4207606a7033814f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4f57713071be084769dfbfd4fc1ae26613b422d8170a2655d2f32d2b7254aff9eaab6c40b37ece702073de78002aba8fdb00a080485bde454784df81d0e7223", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46189e8b772aa9531a15199a72fd9a33ac4e5cacc897eae1a0b5eb1a4dfd8eb97c3d4ba901e20ac5d184e7db509141a8447cf06c3762cf2a64d449ba5a7eec40"} build_url:https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011248 build_url: 'https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b631fe6a13381ef6a2fe7ea3a70be35375f49e3e9fd929c15960c27406b41b0ab2adb7f5d5bd64b5cc0ae79f00df7c2fe1ee61968f172e25f4a6379a19e1168a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07ed3f5238dd735249f40455b860a6704bd3dc6680aedea6e144afe2b59ecf0eb97b58d864295079b490fabe865619d94e03a099412e51ae4207606a7033814f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4f57713071be084769dfbfd4fc1ae26613b422d8170a2655d2f32d2b7254aff9eaab6c40b37ece702073de78002aba8fdb00a080485bde454784df81d0e7223", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46189e8b772aa9531a15199a72fd9a33ac4e5cacc897eae1a0b5eb1a4dfd8eb97c3d4ba901e20ac5d184e7db509141a8447cf06c3762cf2a64d449ba5a7eec40"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 09:04:14.373351) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 09:04:14.373683) ========= 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-1489592592.349961-1128998071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004391 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 09:04:14.458725) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 09:04:14.459044) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 09:04:14.459344) ========= ========= Total master_lag: 0.17 =========