builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-076 starttime: 1489943523.16 results: success (0) revision: 1b9293be51637f841275541d8991314ca56561a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-19 10:12:03.161201) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-19 10:12:03.161650) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-19 10:12:03.161948) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-19 10:12:03.176341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 10:12:03.176707) ========= 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=9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-19 10:12:03-- 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% 220M=0s 2017-03-19 10:12:03 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.095255 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 10:12:03.285534) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 10:12:03.288883) ========= 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=9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020116 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 10:12:03.338661) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-19 10:12:03.342032) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1b9293be51637f841275541d8991314ca56561a5 --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 1b9293be51637f841275541d8991314ca56561a5 --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=9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-19 10:12:03,591 truncating revision to first 12 chars 2017-03-19 10:12:03,591 Setting DEBUG logging. 2017-03-19 10:12:03,592 attempt 1/10 2017-03-19 10:12:03,592 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1b9293be5163?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-19 10:12:04,349 unpacking tar archive at: mozilla-central-1b9293be5163/testing/mozharness/ program finished with exit code 0 elapsedTime=1.050376 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-19 10:12:04.408333) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-19 10:12:04.408680) ========= script_repo_revision: 1b9293be51637f841275541d8991314ca56561a5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-19 10:12:04.409100) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-19 10:12:04.409384) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-19 10:12:04.418992) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-03-19 10:12:04.419355) ========= /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=9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:12:04 INFO - MultiFileLogger online at 20170319 10:12:04 in /builds/slave/test 10:12:04 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 10:12:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:12:04 INFO - {'append_to_log': False, 10:12:04 INFO - 'base_work_dir': '/builds/slave/test', 10:12:04 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 10:12:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:12:04 INFO - 'branch': 'Firefox-Non-PGO', 10:12:04 INFO - 'buildbot_json_path': 'buildprops.json', 10:12:04 INFO - 'config_files': ('talos/linux_config.py',), 10:12:04 INFO - 'default_actions': ('clobber', 10:12:04 INFO - 'read-buildbot-config', 10:12:04 INFO - 'download-and-extract', 10:12:04 INFO - 'populate-webroot', 10:12:04 INFO - 'create-virtualenv', 10:12:04 INFO - 'install', 10:12:04 INFO - 'run-tests'), 10:12:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:12:04 INFO - 'download_minidump_stackwalk': True, 10:12:04 INFO - 'download_symbols': 'ondemand', 10:12:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:12:04 INFO - 'tooltool.py': '/tools/tooltool.py', 10:12:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:12:04 INFO - '/tools/misc-python/virtualenv.py')}, 10:12:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:12:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:12:04 INFO - 'gecko_profile': False, 10:12:04 INFO - 'gecko_profile_interval': 0, 10:12:04 INFO - 'installer_path': 'installer.exe', 10:12:04 INFO - 'log_level': 'info', 10:12:04 INFO - 'log_name': 'talos', 10:12:04 INFO - 'log_to_console': True, 10:12:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:12:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:12:04 INFO - 'opt_config_files': (), 10:12:04 INFO - 'pip_index': False, 10:12:04 INFO - 'suite': 'dromaeojs-e10s', 10:12:04 INFO - 'system_bits': '32', 10:12:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:12:04 INFO - 'title': 'talos-linux64-ix-076', 10:12:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:12:04 INFO - 'use_talos_json': True, 10:12:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:12:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:12:04 INFO - 'work_dir': 'build'} 10:12:04 INFO - [mozharness: 2017-03-19 17:12:04.771355Z] Running clobber step. 10:12:04 INFO - Running pre-action listener: _resource_record_pre_action 10:12:04 INFO - Running main action method: clobber 10:12:04 INFO - rmtree: /builds/slave/test/build 10:12:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:12:05 INFO - Running post-action listener: _resource_record_post_action 10:12:05 INFO - [mozharness: 2017-03-19 17:12:05.815330Z] Finished clobber step (success) 10:12:05 INFO - [mozharness: 2017-03-19 17:12:05.815429Z] Running read-buildbot-config step. 10:12:05 INFO - Running pre-action listener: _resource_record_pre_action 10:12:05 INFO - Running main action method: read_buildbot_config 10:12:05 INFO - Using buildbot properties: 10:12:05 INFO - { 10:12:05 INFO - "project": "", 10:12:05 INFO - "product": "firefox", 10:12:05 INFO - "who": "archaeopteryx@coole-files.de", 10:12:05 INFO - "installer_path": "public/build/target.tar.bz2", 10:12:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:12:05 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 10:12:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 10:12:05 INFO - "stage_platform": "linux64", 10:12:05 INFO - "basedir": "/builds/slave/test", 10:12:05 INFO - "buildnumber": 759, 10:12:05 INFO - "platform": "ubuntu64_hw", 10:12:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:12:05 INFO - "slavebuilddir": "test", 10:12:05 INFO - "taskId": "A9X1NsjTSu-b6Id4-utlIw", 10:12:05 INFO - "branch": "mozilla-central", 10:12:05 INFO - "script_repo_revision": "production", 10:12:05 INFO - "revision": "1b9293be51637f841275541d8991314ca56561a5", 10:12:05 INFO - "slavename": "talos-linux64-ix-076", 10:12:05 INFO - "repo_path": "mozilla-central" 10:12:05 INFO - } 10:12:05 INFO - Finding installer, test and symbols from parent task. 10:12:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A9X1NsjTSu-b6Id4-utlIw'}, attempt #1 10:12:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A9X1NsjTSu-b6Id4-utlIw'}, attempt #1 10:12:06 INFO - Task dependencies: bXL_s-x7T7KRu78V4r6yFA 10:12:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA'}, attempt #1 10:12:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/target.tar.bz2 10:12:07 INFO - Set test_url: https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/test_packages.json 10:12:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/target.crashreporter-symbols.zip 10:12:07 INFO - Running post-action listener: _resource_record_post_action 10:12:07 INFO - [mozharness: 2017-03-19 17:12:07.220125Z] Finished read-buildbot-config step (success) 10:12:07 INFO - [mozharness: 2017-03-19 17:12:07.220343Z] Running download-and-extract step. 10:12:07 INFO - Running pre-action listener: _resource_record_pre_action 10:12:07 INFO - Running main action method: download_and_extract 10:12:07 INFO - mkdir: /builds/slave/test/build/tests 10:12:07 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')]} 10:12:07 INFO - trying https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/target.test_packages.json 10:12:07 INFO - Downloading https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:12:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:12:07 INFO - Downloaded 986 bytes. 10:12:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:12:07 INFO - Using the following test package requirements: 10:12:07 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:12:07 INFO - u'common': [u'target.common.tests.zip'], 10:12:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:12:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:12:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:12:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:12:07 INFO - u'mozbase': [u'target.common.tests.zip'], 10:12:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:12:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:12:07 INFO - u'web-platform': [u'target.common.tests.zip', 10:12:07 INFO - u'target.web-platform.tests.zip'], 10:12:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:12:07 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:12:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/target.common.tests.zip 10:12:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:12:07 INFO - Fetch https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/target.common.tests.zip into memory 10:12:08 INFO - Expected file size: 58186512 10:12:08 INFO - Obtained file size: 58186512 10:12:18 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:12:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/target.common.tests.zip 10:12:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:12:18 INFO - Fetch https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/target.common.tests.zip into memory 10:12:19 INFO - Expected file size: 58186512 10:12:19 INFO - Obtained file size: 58186512 10:12:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/target.talos.tests.zip 10:12:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:12:30 INFO - Fetch https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/target.talos.tests.zip into memory 10:12:31 INFO - Expected file size: 14404171 10:12:31 INFO - Obtained file size: 14404171 10:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:31 INFO - trying https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/target.tar.bz2 10:12:31 INFO - Downloading https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:12:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:12:32 INFO - Downloaded 61842202 bytes. 10:12:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/target.tar.bz2 10:12:32 INFO - mkdir: /builds/slave/test/properties 10:12:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:12:32 INFO - Writing to file /builds/slave/test/properties/build_url 10:12:32 INFO - Contents: 10:12:32 INFO - build_url:https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/target.tar.bz2 10:12:32 INFO - Running post-action listener: _resource_record_post_action 10:12:32 INFO - Running post-action listener: set_extra_try_arguments 10:12:32 INFO - [mozharness: 2017-03-19 17:12:32.669690Z] Finished download-and-extract step (success) 10:12:32 INFO - [mozharness: 2017-03-19 17:12:32.669786Z] Running populate-webroot step. 10:12:32 INFO - Running pre-action listener: _resource_record_pre_action 10:12:32 INFO - Running main action method: populate_webroot 10:12:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:12:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:12:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:12:32 INFO - '--tppagecycles', 10:12:32 INFO - '7'], 10:12:32 INFO - 'tests': ['tsvgm']}}, 10:12:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:12:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:12:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:12:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:12:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:12:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:12:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:12:32 INFO - 'talos_options': ['--disable-e10s'], 10:12:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:12:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:12:32 INFO - 'talos_options': ['--disable-e10s'], 10:12:32 INFO - 'tests': ['damp', 'tps']}, 10:12:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:12:32 INFO - 'tests': ['damp', 'tps']}, 10:12:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:12:32 INFO - 'tests': ['dromaeo_dom']}, 10:12:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:12:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:12:32 INFO - 'tests': ['basic_compositor_video']}, 10:12:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:12:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:12:32 INFO - 'tests': ['a11yr', 10:12:32 INFO - 'ts_paint', 10:12:32 INFO - 'tpaint', 10:12:32 INFO - 'sessionrestore', 10:12:32 INFO - 'sessionrestore_no_auto_restore', 10:12:32 INFO - 'tabpaint']}, 10:12:32 INFO - 'other-e10s': {'tests': ['a11yr', 10:12:32 INFO - 'ts_paint', 10:12:32 INFO - 'tpaint', 10:12:32 INFO - 'sessionrestore', 10:12:32 INFO - 'sessionrestore_no_auto_restore', 10:12:32 INFO - 'tabpaint']}, 10:12:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:12:32 INFO - 'ts_paint', 10:12:32 INFO - 'tpaint', 10:12:32 INFO - 'sessionrestore', 10:12:32 INFO - 'sessionrestore_no_auto_restore', 10:12:32 INFO - 'tabpaint']}, 10:12:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:12:32 INFO - 'ts_paint', 10:12:32 INFO - 'tpaint', 10:12:32 INFO - 'sessionrestore', 10:12:32 INFO - 'sessionrestore_no_auto_restore', 10:12:32 INFO - 'tabpaint']}, 10:12:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:12:32 INFO - 'tests': ['a11yr', 10:12:32 INFO - 'ts_paint', 10:12:32 INFO - 'tpaint', 10:12:32 INFO - 'sessionrestore', 10:12:32 INFO - 'sessionrestore_no_auto_restore', 10:12:32 INFO - 'tabpaint']}, 10:12:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:12:32 INFO - 'tests': ['a11yr', 10:12:32 INFO - 'ts_paint', 10:12:32 INFO - 'tpaint', 10:12:32 INFO - 'sessionrestore', 10:12:32 INFO - 'sessionrestore_no_auto_restore', 10:12:32 INFO - 'tabpaint']}, 10:12:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:12:32 INFO - 'tests': ['tsvgx', 10:12:32 INFO - 'tsvgr_opacity', 10:12:32 INFO - 'tart', 10:12:32 INFO - 'tscrollx', 10:12:32 INFO - 'cart', 10:12:32 INFO - 'tsvg_static']}, 10:12:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:12:32 INFO - 'tsvgr_opacity', 10:12:32 INFO - 'tart', 10:12:32 INFO - 'tscrollx', 10:12:32 INFO - 'cart', 10:12:32 INFO - 'tsvg_static']}, 10:12:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:12:32 INFO - 'talos_options': ['--disable-e10s'], 10:12:32 INFO - 'tests': ['tp5o']}, 10:12:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:12:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:12:32 INFO - 'talos_options': ['--disable-e10s', 10:12:32 INFO - '--xperf_path', 10:12:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:32 INFO - 'tests': ['tp5n']}, 10:12:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:12:32 INFO - 'talos_options': ['--xperf_path', 10:12:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:32 INFO - 'tests': ['tp5n']}}, 10:12:32 INFO - 'talos.zip': {'path': '', 10:12:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:12:32 INFO - Running post-action listener: _resource_record_post_action 10:12:32 INFO - [mozharness: 2017-03-19 17:12:32.683054Z] Finished populate-webroot step (success) 10:12:32 INFO - [mozharness: 2017-03-19 17:12:32.683144Z] Running create-virtualenv step. 10:12:32 INFO - Running pre-action listener: _resource_record_pre_action 10:12:32 INFO - Running main action method: create_virtualenv 10:12:32 INFO - Creating virtualenv /builds/slave/test/build/venv 10:12:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:12:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:12:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:12:32 INFO - Using real prefix '/usr' 10:12:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:12:33 INFO - Installing distribute.............................................................................................................................................................................................done. 10:12:35 INFO - Installing pip.................done. 10:12:35 INFO - Return code: 0 10:12:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:12:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:12:35 INFO - Reading from file tmpfile_stdout 10:12:35 INFO - Output received: 10:12:35 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:12:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2424b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2422290>, '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 0x2422b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423040>, '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': '9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929', '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 10:12:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:12:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:12:35 INFO - Using env: {'DISPLAY': ':0', 10:12:35 INFO - 'HOME': '/home/cltbld', 10:12:35 INFO - 'LANG': 'en_US.UTF-8', 10:12:35 INFO - 'LANGUAGE': 'en_US:en', 10:12:35 INFO - 'LOGNAME': 'cltbld', 10:12:35 INFO - 'MAIL': '/var/mail/cltbld', 10:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:35 INFO - 'MOZ_NO_REMOTE': '1', 10:12:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:35 INFO - 'NO_EM_RESTART': '1', 10:12:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:35 INFO - 'PWD': '/builds/slave/test', 10:12:35 INFO - 'SHELL': '/bin/bash', 10:12:35 INFO - 'SHLVL': '1', 10:12:35 INFO - 'TERM': 'linux', 10:12:35 INFO - 'TMOUT': '86400', 10:12:35 INFO - 'USER': 'cltbld', 10:12:35 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929', 10:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:35 INFO - '_': '/tools/buildbot/bin/python'} 10:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:12:35 INFO - Cleaning up... 10:12:35 INFO - Return code: 0 10:12:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2424b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2422290>, '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 0x2422b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423040>, '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': '9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929', '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 10:12:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:12:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:12:35 INFO - Using env: {'DISPLAY': ':0', 10:12:35 INFO - 'HOME': '/home/cltbld', 10:12:35 INFO - 'LANG': 'en_US.UTF-8', 10:12:35 INFO - 'LANGUAGE': 'en_US:en', 10:12:35 INFO - 'LOGNAME': 'cltbld', 10:12:35 INFO - 'MAIL': '/var/mail/cltbld', 10:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:35 INFO - 'MOZ_NO_REMOTE': '1', 10:12:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:35 INFO - 'NO_EM_RESTART': '1', 10:12:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:35 INFO - 'PWD': '/builds/slave/test', 10:12:35 INFO - 'SHELL': '/bin/bash', 10:12:35 INFO - 'SHLVL': '1', 10:12:35 INFO - 'TERM': 'linux', 10:12:35 INFO - 'TMOUT': '86400', 10:12:35 INFO - 'USER': 'cltbld', 10:12:35 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929', 10:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:35 INFO - '_': '/tools/buildbot/bin/python'} 10:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:35 INFO - Downloading/unpacking psutil>=3.1.1 10:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:12:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:37 INFO - Installing collected packages: psutil 10:12:37 INFO - Running setup.py install for psutil 10:12:38 INFO - building 'psutil._psutil_linux' extension 10:12:38 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 10:12:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:12:38 INFO - building 'psutil._psutil_posix' extension 10:12:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:12:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:12:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:38 INFO - Successfully installed psutil 10:12:38 INFO - Cleaning up... 10:12:38 INFO - Return code: 0 10:12:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:38 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 0x21871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2424b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2422290>, '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 0x2422b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423040>, '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': '9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929', '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 10:12:38 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 10:12:38 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 10:12:38 INFO - Using env: {'DISPLAY': ':0', 10:12:38 INFO - 'HOME': '/home/cltbld', 10:12:38 INFO - 'LANG': 'en_US.UTF-8', 10:12:38 INFO - 'LANGUAGE': 'en_US:en', 10:12:38 INFO - 'LOGNAME': 'cltbld', 10:12:38 INFO - 'MAIL': '/var/mail/cltbld', 10:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:38 INFO - 'MOZ_NO_REMOTE': '1', 10:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:38 INFO - 'NO_EM_RESTART': '1', 10:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:38 INFO - 'PWD': '/builds/slave/test', 10:12:38 INFO - 'SHELL': '/bin/bash', 10:12:38 INFO - 'SHLVL': '1', 10:12:38 INFO - 'TERM': 'linux', 10:12:38 INFO - 'TMOUT': '86400', 10:12:38 INFO - 'USER': 'cltbld', 10:12:38 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929', 10:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:38 INFO - '_': '/tools/buildbot/bin/python'} 10:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:12:38 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 10:12:38 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 10:12:38 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 10:12:38 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 10:12:38 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 10:12:38 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 10:12:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:12:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:12:40 INFO - Installing collected packages: mozsystemmonitor 10:12:40 INFO - Running setup.py install for mozsystemmonitor 10:12:40 INFO - Successfully installed mozsystemmonitor 10:12:40 INFO - Cleaning up... 10:12:40 INFO - Return code: 0 10:12:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:40 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 0x21871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2424b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2422290>, '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 0x2422b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423040>, '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': '9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929', '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 10:12:40 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 10:12:40 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 10:12:40 INFO - Using env: {'DISPLAY': ':0', 10:12:40 INFO - 'HOME': '/home/cltbld', 10:12:40 INFO - 'LANG': 'en_US.UTF-8', 10:12:40 INFO - 'LANGUAGE': 'en_US:en', 10:12:40 INFO - 'LOGNAME': 'cltbld', 10:12:40 INFO - 'MAIL': '/var/mail/cltbld', 10:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:40 INFO - 'MOZ_NO_REMOTE': '1', 10:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:40 INFO - 'NO_EM_RESTART': '1', 10:12:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:40 INFO - 'PWD': '/builds/slave/test', 10:12:40 INFO - 'SHELL': '/bin/bash', 10:12:40 INFO - 'SHLVL': '1', 10:12:40 INFO - 'TERM': 'linux', 10:12:40 INFO - 'TMOUT': '86400', 10:12:40 INFO - 'USER': 'cltbld', 10:12:40 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929', 10:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:40 INFO - '_': '/tools/buildbot/bin/python'} 10:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:41 INFO - Downloading/unpacking jsonschema==2.5.1 10:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:12:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:43 INFO - Downloading functools32-3.2.3-2.tar.gz 10:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:12:43 INFO - warning: no files found matching '*.txt' 10:12:43 INFO - no previously-included directories found matching 'build' 10:12:43 INFO - no previously-included directories found matching 'dist' 10:12:43 INFO - no previously-included directories found matching '.git*' 10:12:43 INFO - Installing collected packages: jsonschema, functools32 10:12:43 INFO - Running setup.py install for functools32 10:12:43 INFO - warning: no files found matching '*.txt' 10:12:43 INFO - no previously-included directories found matching 'build' 10:12:43 INFO - no previously-included directories found matching 'dist' 10:12:43 INFO - no previously-included directories found matching '.git*' 10:12:43 INFO - Successfully installed jsonschema functools32 10:12:43 INFO - Cleaning up... 10:12:43 INFO - Return code: 0 10:12:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:12:43 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')]} 10:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:43 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')]} 10:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:43 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 0x21871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2424b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2422290>, '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 0x2422b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423040>, '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': '9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929', '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 10:12:43 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 10:12:43 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 10:12:43 INFO - Using env: {'DISPLAY': ':0', 10:12:43 INFO - 'HOME': '/home/cltbld', 10:12:43 INFO - 'LANG': 'en_US.UTF-8', 10:12:43 INFO - 'LANGUAGE': 'en_US:en', 10:12:43 INFO - 'LOGNAME': 'cltbld', 10:12:43 INFO - 'MAIL': '/var/mail/cltbld', 10:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:43 INFO - 'MOZ_NO_REMOTE': '1', 10:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:43 INFO - 'NO_EM_RESTART': '1', 10:12:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:43 INFO - 'PWD': '/builds/slave/test', 10:12:43 INFO - 'SHELL': '/bin/bash', 10:12:43 INFO - 'SHLVL': '1', 10:12:43 INFO - 'TERM': 'linux', 10:12:43 INFO - 'TMOUT': '86400', 10:12:43 INFO - 'USER': 'cltbld', 10:12:43 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929', 10:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:43 INFO - '_': '/tools/buildbot/bin/python'} 10:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:12:43 INFO - Cleaning up... 10:12:43 INFO - Return code: 0 10:12:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:12:43 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')]} 10:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:43 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')]} 10:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:43 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 0x21871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2424b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2422290>, '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 0x2422b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423040>, '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': '9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929', '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 10:12:43 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 10:12:43 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 10:12:43 INFO - Using env: {'DISPLAY': ':0', 10:12:43 INFO - 'HOME': '/home/cltbld', 10:12:43 INFO - 'LANG': 'en_US.UTF-8', 10:12:43 INFO - 'LANGUAGE': 'en_US:en', 10:12:43 INFO - 'LOGNAME': 'cltbld', 10:12:43 INFO - 'MAIL': '/var/mail/cltbld', 10:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:43 INFO - 'MOZ_NO_REMOTE': '1', 10:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:43 INFO - 'NO_EM_RESTART': '1', 10:12:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:43 INFO - 'PWD': '/builds/slave/test', 10:12:43 INFO - 'SHELL': '/bin/bash', 10:12:43 INFO - 'SHLVL': '1', 10:12:43 INFO - 'TERM': 'linux', 10:12:43 INFO - 'TMOUT': '86400', 10:12:43 INFO - 'USER': 'cltbld', 10:12:43 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929', 10:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:43 INFO - '_': '/tools/buildbot/bin/python'} 10:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:44 INFO - Downloading/unpacking blobuploader==1.2.4 10:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:46 INFO - Downloading blobuploader-1.2.4.tar.gz 10:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:12:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:12:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:46 INFO - Downloading docopt-0.6.1.tar.gz 10:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:12:46 INFO - Installing collected packages: blobuploader, requests, docopt 10:12:46 INFO - Running setup.py install for blobuploader 10:12:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:12:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:12:47 INFO - Running setup.py install for requests 10:12:47 INFO - Running setup.py install for docopt 10:12:47 INFO - Successfully installed blobuploader requests docopt 10:12:47 INFO - Cleaning up... 10:12:47 INFO - Return code: 0 10:12:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:47 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')]} 10:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:47 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')]} 10:12:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:47 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 0x21871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2424b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2422290>, '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 0x2422b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423040>, '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': '9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929', '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 10:12:47 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 10:12:47 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 10:12:47 INFO - Using env: {'DISPLAY': ':0', 10:12:47 INFO - 'HOME': '/home/cltbld', 10:12:47 INFO - 'LANG': 'en_US.UTF-8', 10:12:47 INFO - 'LANGUAGE': 'en_US:en', 10:12:47 INFO - 'LOGNAME': 'cltbld', 10:12:47 INFO - 'MAIL': '/var/mail/cltbld', 10:12:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:47 INFO - 'MOZ_NO_REMOTE': '1', 10:12:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:47 INFO - 'NO_EM_RESTART': '1', 10:12:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:47 INFO - 'PWD': '/builds/slave/test', 10:12:47 INFO - 'SHELL': '/bin/bash', 10:12:47 INFO - 'SHLVL': '1', 10:12:47 INFO - 'TERM': 'linux', 10:12:47 INFO - 'TMOUT': '86400', 10:12:47 INFO - 'USER': 'cltbld', 10:12:47 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929', 10:12:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:47 INFO - '_': '/tools/buildbot/bin/python'} 10:12:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:47 INFO - Running setup.py (path:/tmp/pip-rKpfT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:47 INFO - Running setup.py (path:/tmp/pip-yEz_ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:47 INFO - Running setup.py (path:/tmp/pip-l6NcYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:47 INFO - Running setup.py (path:/tmp/pip-jSi4Em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:48 INFO - Running setup.py (path:/tmp/pip-TXjXpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:48 INFO - Running setup.py (path:/tmp/pip-hDMjxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:48 INFO - Running setup.py (path:/tmp/pip-KpvI6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:48 INFO - Running setup.py (path:/tmp/pip-dFGHCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:48 INFO - Running setup.py (path:/tmp/pip-5c5eqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:48 INFO - Running setup.py (path:/tmp/pip-Lhng4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:48 INFO - Running setup.py (path:/tmp/pip-eawqTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:48 INFO - Running setup.py (path:/tmp/pip-6ZfZHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:48 INFO - Running setup.py (path:/tmp/pip-ELnonP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:48 INFO - Running setup.py (path:/tmp/pip-8jiPEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:48 INFO - Running setup.py (path:/tmp/pip-xDAhXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:48 INFO - Running setup.py (path:/tmp/pip-rtP6g1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:48 INFO - Running setup.py (path:/tmp/pip-FR493M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:12:48 INFO - Running setup.py install for manifestparser 10:12:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:12:49 INFO - Running setup.py install for mozcrash 10:12:49 INFO - Running setup.py install for mozdebug 10:12:49 INFO - Running setup.py install for mozdevice 10:12:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:12:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:12:49 INFO - Running setup.py install for mozfile 10:12:49 INFO - Running setup.py install for mozhttpd 10:12:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:12:49 INFO - Running setup.py install for mozinfo 10:12:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:12:49 INFO - Running setup.py install for mozInstall 10:12:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:12:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:12:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:12:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:12:49 INFO - Running setup.py install for mozleak 10:12:49 INFO - Running setup.py install for mozlog 10:12:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:12:50 INFO - Running setup.py install for moznetwork 10:12:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:12:50 INFO - Running setup.py install for mozprocess 10:12:50 INFO - Running setup.py install for mozprofile 10:12:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:12:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:12:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:12:50 INFO - Running setup.py install for mozrunner 10:12:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:12:50 INFO - Running setup.py install for mozscreenshot 10:12:50 INFO - Running setup.py install for moztest 10:12:50 INFO - Running setup.py install for mozversion 10:12:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:12:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:12:50 INFO - Cleaning up... 10:12:50 INFO - Return code: 0 10:12:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:50 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 0x21871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2424b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2422290>, '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 0x2422b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423040>, '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': '9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929', '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 10:12:50 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 10:12:50 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 10:12:50 INFO - Using env: {'DISPLAY': ':0', 10:12:50 INFO - 'HOME': '/home/cltbld', 10:12:50 INFO - 'LANG': 'en_US.UTF-8', 10:12:50 INFO - 'LANGUAGE': 'en_US:en', 10:12:50 INFO - 'LOGNAME': 'cltbld', 10:12:50 INFO - 'MAIL': '/var/mail/cltbld', 10:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:50 INFO - 'MOZ_NO_REMOTE': '1', 10:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:50 INFO - 'NO_EM_RESTART': '1', 10:12:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:50 INFO - 'PWD': '/builds/slave/test', 10:12:50 INFO - 'SHELL': '/bin/bash', 10:12:50 INFO - 'SHLVL': '1', 10:12:50 INFO - 'TERM': 'linux', 10:12:50 INFO - 'TMOUT': '86400', 10:12:50 INFO - 'USER': 'cltbld', 10:12:50 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929', 10:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:50 INFO - '_': '/tools/buildbot/bin/python'} 10:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:51 INFO - Running setup.py (path:/tmp/pip-NR5bWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:51 INFO - Running setup.py (path:/tmp/pip-ebvRoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:51 INFO - Running setup.py (path:/tmp/pip-k8kHuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:51 INFO - Running setup.py (path:/tmp/pip-IIIrEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:51 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)) 10:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:51 INFO - Running setup.py (path:/tmp/pip-Ns1qTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:51 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)) 10:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:51 INFO - Running setup.py (path:/tmp/pip-zIkxTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:51 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)) 10:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:51 INFO - Running setup.py (path:/tmp/pip-PIQByy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:51 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)) 10:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:51 INFO - Running setup.py (path:/tmp/pip-oemK3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:51 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)) 10:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:51 INFO - Running setup.py (path:/tmp/pip-jxtevy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:51 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)) 10:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:51 INFO - Running setup.py (path:/tmp/pip-I5LCFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:51 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)) 10:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:51 INFO - Running setup.py (path:/tmp/pip-67nTst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:51 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)) 10:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:51 INFO - Running setup.py (path:/tmp/pip-H9g2au-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:51 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)) 10:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:51 INFO - Running setup.py (path:/tmp/pip-JhEfcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:51 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)) 10:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:51 INFO - Running setup.py (path:/tmp/pip-aWB8VZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:52 INFO - Running setup.py (path:/tmp/pip-56kYlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:52 INFO - Running setup.py (path:/tmp/pip-nO0esi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:52 INFO - Running setup.py (path:/tmp/pip-Nfz_jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:12:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:54 INFO - Downloading blessings-1.6.tar.gz 10:12:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:12:54 INFO - Installing collected packages: blessings 10:12:54 INFO - Running setup.py install for blessings 10:12:54 INFO - Successfully installed blessings 10:12:54 INFO - Cleaning up... 10:12:54 INFO - Return code: 0 10:12:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:12:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:54 INFO - Reading from file tmpfile_stdout 10:12:54 INFO - Current package versions: 10:12:54 INFO - argparse == 1.2.1 10:12:54 INFO - blessings == 1.6 10:12:54 INFO - blobuploader == 1.2.4 10:12:54 INFO - docopt == 0.6.1 10:12:54 INFO - functools32 == 3.2.3-2 10:12:54 INFO - jsonschema == 2.5.1 10:12:54 INFO - manifestparser == 1.1 10:12:54 INFO - mozInstall == 1.12 10:12:54 INFO - mozcrash == 1.0 10:12:54 INFO - mozdebug == 0.1 10:12:54 INFO - mozdevice == 0.49 10:12:54 INFO - mozfile == 1.2 10:12:54 INFO - mozhttpd == 0.7 10:12:54 INFO - mozinfo == 0.9 10:12:54 INFO - mozleak == 0.1 10:12:54 INFO - mozlog == 3.4 10:12:54 INFO - moznetwork == 0.27 10:12:54 INFO - mozprocess == 0.25 10:12:54 INFO - mozprofile == 0.28 10:12:54 INFO - mozrunner == 6.13 10:12:54 INFO - mozscreenshot == 0.1 10:12:54 INFO - mozsystemmonitor == 0.3 10:12:54 INFO - moztest == 0.8 10:12:54 INFO - mozversion == 1.4 10:12:54 INFO - psutil == 3.1.1 10:12:54 INFO - requests == 1.2.3 10:12:54 INFO - wsgiref == 0.1.2 10:12:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12: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')]} 10:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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')]} 10:12:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:54 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 0x21871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2424b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2422290>, '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 0x2422b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423040>, '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': '9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929', '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 10:12:54 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 10:12:54 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 10:12:54 INFO - Using env: {'DISPLAY': ':0', 10:12:54 INFO - 'HOME': '/home/cltbld', 10:12:54 INFO - 'LANG': 'en_US.UTF-8', 10:12:54 INFO - 'LANGUAGE': 'en_US:en', 10:12:54 INFO - 'LOGNAME': 'cltbld', 10:12:54 INFO - 'MAIL': '/var/mail/cltbld', 10:12:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:54 INFO - 'MOZ_NO_REMOTE': '1', 10:12:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:54 INFO - 'NO_EM_RESTART': '1', 10:12:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:54 INFO - 'PWD': '/builds/slave/test', 10:12:54 INFO - 'SHELL': '/bin/bash', 10:12:54 INFO - 'SHLVL': '1', 10:12:54 INFO - 'TERM': 'linux', 10:12:54 INFO - 'TMOUT': '86400', 10:12:54 INFO - 'USER': 'cltbld', 10:12:54 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929', 10:12:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:54 INFO - '_': '/tools/buildbot/bin/python'} 10:12:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:54 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)) 10:12:54 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)) 10:12:54 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)) 10:12:54 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)) 10:12:54 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)) 10:12:54 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)) 10:12:54 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)) 10:12:54 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)) 10:12:54 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)) 10:12:54 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)) 10:12:54 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)) 10:12:54 INFO - Cleaning up... 10:12:54 INFO - Return code: 0 10:12:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:12: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')]} 10:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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')]} 10:12:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2424b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2422290>, '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 0x2422b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423040>, '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': '9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929', '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 10:12: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', 'jsonschema'] in /builds/slave/test/build 10:12: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 jsonschema 10:12:54 INFO - Using env: {'DISPLAY': ':0', 10:12:54 INFO - 'HOME': '/home/cltbld', 10:12:54 INFO - 'LANG': 'en_US.UTF-8', 10:12:54 INFO - 'LANGUAGE': 'en_US:en', 10:12:54 INFO - 'LOGNAME': 'cltbld', 10:12:54 INFO - 'MAIL': '/var/mail/cltbld', 10:12:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:54 INFO - 'MOZ_NO_REMOTE': '1', 10:12:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:54 INFO - 'NO_EM_RESTART': '1', 10:12:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:54 INFO - 'PWD': '/builds/slave/test', 10:12:54 INFO - 'SHELL': '/bin/bash', 10:12:54 INFO - 'SHLVL': '1', 10:12:54 INFO - 'TERM': 'linux', 10:12:54 INFO - 'TMOUT': '86400', 10:12:54 INFO - 'USER': 'cltbld', 10:12:54 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929', 10:12:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:54 INFO - '_': '/tools/buildbot/bin/python'} 10:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:12:55 INFO - Cleaning up... 10:12:55 INFO - Return code: 0 10:12:55 INFO - Running post-action listener: _resource_record_post_action 10:12:55 INFO - Running post-action listener: _start_resource_monitoring 10:12:55 INFO - Starting resource monitoring. 10:12:55 INFO - [mozharness: 2017-03-19 17:12:55.208125Z] Finished create-virtualenv step (success) 10:12:55 INFO - [mozharness: 2017-03-19 17:12:55.208638Z] Running install step. 10:12:55 INFO - Running pre-action listener: _resource_record_pre_action 10:12:55 INFO - Running main action method: install 10:12:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:55 INFO - Reading from file tmpfile_stdout 10:12:55 INFO - Detecting whether we're running mozinstall >=1.0... 10:12:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:12:55 INFO - Reading from file tmpfile_stdout 10:12:55 INFO - Output received: 10:12:55 INFO - Usage: mozinstall [options] installer 10:12:55 INFO - Options: 10:12:55 INFO - -h, --help show this help message and exit 10:12:55 INFO - -d DEST, --destination=DEST 10:12:55 INFO - Directory to install application into. [default: 10:12:55 INFO - "/builds/slave/test"] 10:12:55 INFO - --app=APP Application being installed. [default: firefox] 10:12:55 INFO - mkdir: /builds/slave/test/build/application 10:12:55 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'] 10:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:13:10 INFO - Reading from file tmpfile_stdout 10:13:10 INFO - Output received: 10:13:10 INFO - /builds/slave/test/build/application/firefox/firefox 10:13:10 INFO - Running post-action listener: _resource_record_post_action 10:13:10 INFO - [mozharness: 2017-03-19 17:13:10.952621Z] Finished install step (success) 10:13:10 INFO - [mozharness: 2017-03-19 17:13:10.952897Z] Running run-tests step. 10:13:10 INFO - Running pre-action listener: _resource_record_pre_action 10:13:10 INFO - Running main action method: run_tests 10:13:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:13:10 INFO - Python 2.7.3 10:13:10 INFO - Return code: 0 10:13:10 INFO - grabbing minidump binary from tooltool 10:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:10 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 0x2422290>, '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 0x2422b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:13:10 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 10:13:10 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 10:13:10 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 10:13:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:13:11 INFO - Return code: 0 10:13:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:13:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:13:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:13:11 INFO - ENV: RUST_BACKTRACE is now 1 10:13:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:13:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:13:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 10:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-076 --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 10:13:11 INFO - Using env: {'DISPLAY': ':0', 10:13:11 INFO - 'HOME': '/home/cltbld', 10:13:11 INFO - 'LANG': 'en_US.UTF-8', 10:13:11 INFO - 'LANGUAGE': 'en_US:en', 10:13:11 INFO - 'LOGNAME': 'cltbld', 10:13:11 INFO - 'MAIL': '/var/mail/cltbld', 10:13:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:13:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:13:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:11 INFO - 'MOZ_NO_REMOTE': '1', 10:13:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:13:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:11 INFO - 'NO_EM_RESTART': '1', 10:13:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:11 INFO - 'PWD': '/builds/slave/test', 10:13:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:13:11 INFO - 'RUST_BACKTRACE': '1', 10:13:11 INFO - 'SHELL': '/bin/bash', 10:13:11 INFO - 'SHLVL': '1', 10:13:11 INFO - 'TERM': 'linux', 10:13:11 INFO - 'TMOUT': '86400', 10:13:11 INFO - 'USER': 'cltbld', 10:13:11 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929', 10:13:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:11 INFO - '_': '/tools/buildbot/bin/python'} 10:13:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 10:13:11 INFO - mozversion application_buildid: 20170319152621 10:13:11 INFO - mozversion application_changeset: 1b9293be51637f841275541d8991314ca56561a5 10:13:11 INFO - mozversion application_display_name: Nightly 10:13:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:13:11 INFO - mozversion application_name: Firefox 10:13:11 INFO - mozversion application_remotingname: firefox 10:13:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:13:11 INFO - mozversion application_vendor: Mozilla 10:13:11 INFO - mozversion application_version: 55.0a1 10:13:11 INFO - mozversion platform_buildid: 20170319152621 10:13:11 INFO - mozversion platform_changeset: 1b9293be51637f841275541d8991314ca56561a5 10:13:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:13:11 INFO - mozversion platform_version: 55.0a1 10:13:11 INFO - using testdate: 1489943591 10:13:11 INFO - actual date: 1489943591 10:13:11 INFO - starting webserver on 'localhost:37596' 10:13:11 INFO - SUITE-START | Running 2 tests 10:13:11 INFO - TEST-START | dromaeo_css 10:13:11 INFO - operating with platform_type : linux_ 10:13:11 INFO - Initialising browser for dromaeo_css test... 10:13:11 INFO - TEST-INFO | started process 13963 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCmbllR/profile http://localhost:37596/getInfo.html) 10:13:16 INFO - PID 13963 | __metrics Screen width/height:1600/1200 10:13:16 INFO - PID 13963 | colorDepth:24 10:13:16 INFO - PID 13963 | Browser inner width/height: 1024/697 10:13:16 INFO - PID 13963 | __metrics 10:13:17 ERROR - PID 13963 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 10:13:18 INFO - TEST-INFO | 13963: exit 0 10:13:18 INFO - Browser initialized. 10:13:18 INFO - Running cycle 1/1 for dromaeo_css test... 10:13:18 INFO - TEST-INFO | started process 14095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCmbllR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:13:30 INFO - PID 14095 | RSS: Main: 155672576 10:13:30 INFO - PID 14095 | 10:16:34 INFO - PID 14095 | Cycle 1(1): loaded http://localhost:37596/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37596/tests/dromaeo/cssquery-ext.html) 10:16:36 INFO - PID 14095 | RSS: Main: 167202816 10:16:36 INFO - PID 14095 | 10:18:18 INFO - PID 14095 | ************************* 10:18:18 INFO - PID 14095 | A coding exception was thrown and uncaught in a Task. 10:18:18 INFO - PID 14095 | 10:18:18 ERROR - PID 14095 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:18:18 INFO - PID 14095 | Full stack: 10:18:18 INFO - PID 14095 | ************************* 10:19:39 INFO - PID 14095 | Cycle 1(1): loaded http://localhost:37596/tests/dromaeo/cssquery-ext.html (next: http://localhost:37596/tests/dromaeo/cssquery-jquery.html) 10:19:40 INFO - PID 14095 | RSS: Main: 160813056 10:19:40 INFO - PID 14095 | 10:22:42 INFO - PID 14095 | Cycle 1(1): loaded http://localhost:37596/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37596/tests/dromaeo/cssquery-mootools.html) 10:22:42 INFO - PID 14095 | RSS: Main: 169492480 10:22:42 INFO - PID 14095 | 10:25:44 INFO - PID 14095 | Cycle 1(1): loaded http://localhost:37596/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37596/tests/dromaeo/cssquery-prototype.html) 10:25:45 INFO - PID 14095 | RSS: Main: 161476608 10:25:45 INFO - PID 14095 | 10:28:48 INFO - PID 14095 | Cycle 1(1): loaded http://localhost:37596/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37596/tests/dromaeo/cssquery-yui.html) 10:28:48 INFO - PID 14095 | RSS: Main: 168112128 10:28:48 INFO - PID 14095 | 10:31:51 INFO - PID 14095 | Cycle 1(1): loaded http://localhost:37596/tests/dromaeo/cssquery-yui.html (next: http://localhost:37596/tests/dromaeo/cssquery-dojo.html) 10:31:52 INFO - PID 14095 | RSS: Main: 162344960 10:31:52 INFO - PID 14095 | 10:31:52 INFO - PID 14095 | __start_tp_report 10:31:52 INFO - PID 14095 | _x_x_mozilla_page_load 10:31:52 INFO - PID 14095 | _x_x_mozilla_page_load_details 10:31:52 INFO - PID 14095 | |i|pagename|runs| 10:31:52 INFO - PID 14095 | |0;dojo.html;2684.2081585932146;2690.8923643054277;2691.9192424227253;2729.358600728828;2733.576295674171;5022.121128802463;5090.109230884595;5112.207607820789;5125.769340379683;5169.121249387604;5047.015831912779;5131.512506311894;5143.228515722643;5207.869803254921;5221.034108689895;4689.57793798558;4690.484046754863;4715.811367545294;4732.2428411454175;4762.1428142934255;4740.1704701677245;4767;4768.499307572707;4773.116973359922;4824.228123500241;4664.440267167927;4705.458872229703;4709.764511774398;4716.410448693913;4734.526547345273;4711.623070154379;4714.599259062984;4727.692699974525;4757.833475828364;4764.071006153801;4636.0727854428915;4676.836310729108;4692.085043416535;4693.812247510095;4736.786844592001;4963.280324352949;5011.974940125312;5101.770420331094;5148.4079330876675;5184.559312458446;5512.228288039678;5522.337319521643;5529.557635389159;5564.666120032811;5581.832545023656;5554.472325129106;5561.4716601922755;5564.387917329091;5565.387807341189;5571.303587051619;5019.749012549358;5060.266261392151;5070.163423035232;5173.301604283449;5185.118529849935;5504.532114770209;5544.0575102232715;5544.584156188302;5549.722513874371;5564.443555644403;5340.91988620171;5462.0987537056735;5482.122860342326;5511.614187006951;5518.172274158828;5532.972335138379;5557.194206839986;5559.861003474945;5566.137248726453;5570.275864137717;5533.335999680065;5543.1408131739645;5552.91670624941;5554.250176226238;5613.298337707786;5303.4696530346655;5367.275417818622;5486.259354987025;5498.477644623755;5526.806561770319;4687.179743544866;4695.131400690883;4696.788644511005;4715.080559290974;4731.030138821533;4008.2584721826556;4010.137820368635;4026.3960405939342;4028.295048366524;4076.7553946763287;4601.447826260804;4658.34783130362;4753.025629745894;4774.546418090275;4789.114013907439;5550.222968784374;5574.832755017356;5581.246531718166;5588.692621905834;5647.6893770843;4689.742064186503;4736.242201247784;4737.928931066037;4747.976260118747;4758.78585463655;4782.426108866958;4849.224124140121;4960.23116416956;4967.453580106186;4983.725895075733;5162.225666149958;5164.251183578285;5172.224166374924;5211.530962213419;5222.764975576032;5360.383555891122;5421.864453388697;5575.665460072409;5578.470045345685;5582.49757521825;5140.871478212925;5163.6127290454115;5184.45563215872;5209.947900520946;5212.009718153538;5266.683998960075;5315.840524784263;5335.919961200508;5401.162819762943;5417.972910135424;5385.649932754359;5400.432954539874;5402.675839449488;5406.702631355313;5413.296271484682;5181.326427564392;5194.168932970707;5196.636235463481;5207.791688332424;5210.140326846028;5261.053010458154;5293.629445938747;5296.788128474972;5299.920501192408;5300.575953923754;5149.742512874266;5171.3018742469285;5188.533032027136;5189.065968125774;5193.272941788228;5329.493698098674;5338.466153384786;5340.973295133499;5341.946580534145;5352.5985551084605;5153.098207813543;5179.948200517946;5198.402183748917;5244.160934250502;5255.737213139404 10:31:52 INFO - PID 14095 | |1;ext.html;694.6839188169383;717.7093277222723;760.574078516031;784.0395515493518;832.7460124661976;31300.84349578252;32220.194495137603;32367.51448728271;34739.47890781634;34866.47700284498;30258.394832103346;30553.541696874563;30566;30651;30667.846660766663;6137.38626137386;6260.092286618437;6268.404501572343;8876.156765107336;9099.499527525983;9217;9243.58403871824;9312.115349041864;9338.206252468548;9357.064293570656;9363.95318023409;9437.622495100188;9441.19749821266;9442.716718498421;9472.242220622335;9357.064293570656;9377.390469619453;9417.387869788441;9426.340156189104;9443.386179898285;9147.77130571741;9170.266378689688;9238.6304547818;9240.537973101318;9247.72256832296;33308.833455832806;33896.15259618505;33921.83039084813;33933.830330848185;34052;3145.1665308693214;3177.1421716136515;3191.6010498687665;3215.5015972524297;3258.1365938026443;23866.642000370008;23969.52060958771;24187.637185442232;24206.39484012896;24331.391715207083;2827.20838165312;2856.185986993697;2933.7359637632503;2948.9852550737323;2956.8078074925274;159435.20282398514;159791;160827;161152;161607;32825.67174328274;33348.33213342927;40414.1917161661;43695.344569831475;44026.33960490595;42260;42450.57549424528;42467.57532424636;42533.36199957003;42557.57442425598;12587.496500140074;12678.366081696062;12705.491780328683;12740.044496662787;12785.488580456864;10148.238882083873;10155.339902906288;10160.237982151368;10179.236557258235;10259.948700256451;13165.47338106465;13230.536931207555;13230.73538529224;13284.800727989088;13404.262765547794;5349.22436246742;5362.812301569505;5495.395506494282;5542.085555883315;5544.667319960815;898.7169041751828;945.0643862576001;962.0716009051159;963.349738926222;971.1114330387617;21253.68119478209;21351.67972480414;21465.67801482979;21512;21775;993.7465946183821;1014.9797004060025;1030.2015937648232;1034.5189486888632;1038.7299302181336;10965.725856853642;11381;11423.485943132579;11458;11472.254303470248;226355;227447;227691;227939;229834;40905;41104;41106.38340424896;41296.58703412987;41448.37827432591;1125.8536390269376;1171.0455978377595;1176.9705757355964;1178.4225729392535;1179.6461061681462;19602.313919012766;19663.70504442406;20664.896675516527;20766.517237433316;20832.791672083084;33059.669403305656;33518.664813351555;33561.16097097592;33603;33688.66311336855;213448;216491;216745;216805;216943;28950.855245723636;29338.706612933598;29639.25901852471;30500.237494062825;30602.387952241275;35921.28157436889;36118.8194059028;36934.26131477409;37073.629263707015;37119.17450731387;31194.68805311918;31388;31574.842125789222;31735.206619833767;32150.35699286048;30735.692643074177;31432.842835785676;31677;32523.18692032718;32561.674383256814;29933.55099673463;29939.700602993693;30601.846990764905;30811.537826932166;30920.690793092683;27112.32219194536;27701.72298277072;28188.43623127567;28308.575371369036;28334.43331133407;22014.33956981293;22305.10779568799;22358.552828943655;22405.88797056004;22451.326460205568 10:31:52 INFO - PID 14095 | |2;jquery.html;390.5411141908257;395.351623337726;405.9797010149493;415.6799264566284;416.7582801974855;12856.807147892765;17805.46583602491;18596.90701546492;19394.612107757854;19400.514987125312;15537.84462155378;15678.921605391957;15712.842871571282;16506.17469126545;16733.414330498435;5516.586256030793;5537.667739935597;5669.971650141743;5758.078707406816;5764.394738552454;5578.219049333096;5670.8015219467325;5674.631148975303;5680.4319568043275;5699.287589051369;5491.341039075317;5627.549796016309;5668.744906479198;5691.51622112121;5704.600677952545;5645.350784659776;5662.575306851982;5665.461781130786;5674.829755107312;5682;5543.1408131739645;5558.333000039981;6362;6608.4052435281055;6664.86670266592;20740.274090406765;21482.892585537127;21642.783572164233;22541;22890.65664015041;2118.3962570667286;2179.161023006154;2180.160638154322;2202.2072054060527;2275.6131457652073;13527;14014.85985140156;14158.646033849132;15072.924635376863;15141.697166056618;1904.419152158591;1906.7235250888543;1948.39599724086;1950.5806251655963;1950.6391317606287;83439;84920;85524.57237713771;86444;86641.56679216627;16849.663006739796;16891.324347026228;16926.322947082226;17080.231389587498;17465.38871139504;26362.340941476617;28377.858110709316;28412.715872841007;28568.71431285702;29382.55926161109;8959.238464730572;9081.182693557612;9136.223421009156;9152.816943661222;9230.400023998418;7377.704891804375;7465.06686664167;7553.169151393342;7608.543487390774;7661.693532258759;9002.369834111549;9029.41308814925;9095.68112623679;9106.408083474553;9300.302477314228;3404.6084700259294;3501.3347463981763;3530.6469353065004;3657.8719744808805;3790.33669107905;730.7844185965153;745.8955746195537;762.089303282583;778.7780482562442;780.4692808889896;18201.45395638133;19245.230190792212;19330.130144143546;19541.21835126579;19846.1069251884;741.1254719431015;753.1263734068455;760.8744557148119;763.6334559411514;768.3161985832613;10219.744506387251;10800.945995269973;10808.352408464278;10810.783784324269;10834.404107774148;451902;453427;454754;455101;461449;88774;88783.55608221918;88931.55534222287;91990;92518;1089.1014912697058;1090.7654854206385;1123.4831977290537;1129.8079326514512;1133.1501373969522;16239.756403654192;16688.499345019667;17248.741268880727;17259.872745175282;17409.216585253947;40400.79799600983;41282.793586033076;41895.7905210472;42060.36909446422;42083.368749469395;54155.72922135364;56209.156862646276;56298.43701562932;56369.43630563642;57402.42597574138;10605.628802992167;10959.506822192861;10991.670249892515;11070.944645277044;11305;13077.869221307665;13174.934125329311;13228.669283267995;13321.866781332063;13704.931475342559;9997.55011024491;10038.1467575254;10083.747906302402;10197.796044078928;10457.47712614351;10548.367097974146;10614.681559553226;10664.89335106639;10976.560937562728;11167;10447.111995480469;10614.203934705083;10685.893141068489;10730.785384292114;11084.833727493933;10640.733981650521;10666.520006599567;10684.412357320422;11092.279001864854;11117.388543630179;9556.904430955601;9675.322727409013;9723.319367644197;9893.547903443336;10078.647247346307 10:31:52 INFO - PID 14095 | |3;mootools.html;1277.5592420614885;1289.8774616411438;1290.7160424706567;1322.3850909327161;1431.456046702253;9059.637614495421;9177.449353038823;9366.297527685434;9441.150296473315;9535.666251681192;9457;9591.808163836718;9602.711918642435;9612;9642.807143857137;2048.252387878425;2093.2150443583655;2099.737532808399;2100.9474763130893;2101.4536220582604;1988.5724569217687;2051.4461095504207;2060.4745789823573;2062.298818401743;2071.5442602627472;1962.3916585858358;2015.405455390656;2026;2028.4725971247435;2040.55107876267;1909.8185672361103;1915.1190452391847;1915.205189846212;1920.7214953831756;1953.345629214215;1605.5584714203687;1642.3266460751154;1933.6906095024729;1953.199188332791;1980.4652743759248;9223.723288301295;9526.047395260488;9526.90473095267;9541.809163816753;9560.28297877662;4299.6775241856985;4410.713303635285;4433.13553856998;4440.489343725449;4440.711353761995;2596.31197732601;2626.855522946237;2651.178134778225;2653.1775149703653;2669.065826960568;962.7400601837464;982.4301904895144;986.9851952220722;990.074280547683;1004.392342632704;12317.260964342078;13649.385777640031;13686.247256400893;13793.655158621015;13820.792688109686;3799.810009499514;3927.842886284574;3966.1671049080014;3969.1069509360163;3969.920601587952;10494.527746251437;10539.736506587244;10618.415987120783;10621.681349559525;10677.252592318619;4629.86110416688;4666.976665116653;4670.7664616769025;4684.203685373426;4684.461286951976;4117.07365842683;4136.172765446922;4158.064435502049;4160;4248.638865696388;3138.403703296412;3222.9033129005697;3285.868565257363;3289.802611843297;3342.6490218526706;820.5404973215019;830.9792255193669;844.3245403677034;848.0628905059943;848.1857416879741;746.8655641984495;749.4079677055174;760.5094713909498;762.8703120469534;779.8245394786242;5159.993801208803;5308.177232528964;5353.518183363516;5488.231647569343;5754.827355179267;832.3216578488513;838.2623291503438;851.4550687559966;878.6221924572495;885.623609965762;3359.6136444308727;3386.153461634591;3424.4863270509127;3471;3513.8243087845503;10451;10811.35131892089;11228.66314010581;11436.199466037298;11938.492916487636;11774;11776.234544754563;11795.292282462908;11803.468843902045;11810.350430726221;8673.219410253107;8971.19259266656;8973.416727912665;8994.86507702385;9021.819563608691;5952.434518720715;5961.195238642727;5961.344252132175;5994.250718660168;6100.816975490742;9702.951485242529;10342.224333174892;10357.067863892285;10436.269461137952;10563.841542377024;10102.141317988053;10161.593536258466;10215.846762298423;10227.437490937773;10257.33327333721;7751.457397982313;7856.25365590268;7924.920750792418;7950.363970882431;8044.959775201087;8723.956380218058;8863.645454182019;8915.955420222857;8918.955405222932;8934.240589549961;7564.962175189089;7690.461667683208;7777.883331749915;7939.364850811806;8006.19938006218;7543.811404714926;7662.272084151997;7671.69313227487;7724.0731112266885;7767.495112817649;6831.521793474409;6858.211305699709;6968.79093627192;6973.3375329343635;6980;4798.520147985174;4913.65604407688;4926.753662316942;4976.2286845539;5117.360329958755;4854.393200849894;4861.708297502161;4879.707217566957;5115.104856650146;5128.358955130609 10:31:52 INFO - PID 14095 | |4;prototype.html;342.2590092449846;353.75767599194546;354.28257777999534;358.99102522436937;361.6040435722884;5333.280007199027;5468.261784659075;5483.890322193553;5534.252875861757;5577.972110139443;5299;5352.892942141155;5353.785848566063;5383.946160538393;5394.433584473632;4456.821727130911;4479.820807167709;4490.8877278067985;4493.68544201906;4512.638988880898;4356.324769660692;4464.464264288274;4468.75421851798;4484.663650226246;4496.2581174106235;4446.644268458532;4452.955470445287;4454;4458.79935402906;4462.754548499831;4423.955760442403;4429.645628349725;4451.643868490513;4453.755043472608;4461.353103799931;4051.9797401012806;4103.179364127186;4138.110306284163;4168.228877657643;4169.332906734908;5232.691827043239;5256.216842673187;5262.973685131588;5285.365756109253;5296.09966305729;5200.141976573861;5210.957808438327;5223.660462069991;5223.869403264949;5226.843194704165;5439.755211015514;5716.828495145152;5749.540036797088;5751.281089863767;5763.596548241625;4592.035672508777;4596.3794887690065;4604.953950460486;4614.607758340511;4620.561046700558;5745.741441635095;5823.272090988627;5909.109085092772;6045.377798647256;6088.512918966472;4733.148033354029;4735.431748190171;4744.667873248839;4748.430188377417;4757.191277482836;4818.927716084261;4830.516948305141;4839.830605928775;4841.15279826029;4844.539768721966;5117.5394214520875;5188.766505507261;5189.40321862983;5199.48005199477;5214.113600687816;5692.975264452439;5697.0599851024945;5712.314522257273;5713.657180569179;5713.8285851424525;1668.8915220510871;1695.8982461052376;1703.4719237036559;1704.386420888479;1707.2232134378828;1216.3735676126803;1252.136026141959;1259.4962015193812;1261.9336660521844;1288.2978776566792;4964.478729733326;4967.783826981655;4983.227599722049;5006.4492905780335;5008.946332003934;5941.7623295067715;5947.762089516457;5969.343372229051;5970.2238708968425;5980.820575382745;4768.976155119202;4974.427940786783;4984;5010.123228435009;5011.323471331397;3135.7177853992794;3165.3511030238747;3165.446046941776;3171.1437911763696;3176.5235214717977;5241.868953276198;5387.218853266255;5475.67145971243;5492.862678433071;5506.724663766796;6034.969825150846;6078.848028799227;6096.451319381277;6096.542759293071;6121.816345509642;5472.34331880169;5488.9725551372785;5491.643043202179;5497.862553436196;5499.670019798825;5737.282839645044;5803.970980145241;5823.912641310299;5877.529797616266;5923.466887980103;5455.263539422286;5796.159556864147;5830.53355731549;5830.941690583039;5876.236089308362;5268.57851371897;5273.8681532960445;5442.6462279951675;5446.700431476307;5483.177523371367;4679.742614156118;4712.62299016071;4742.170120228877;4759.524047595212;4762.6189904808225;5767.826965191051;5894.764209431574;5904.888440464099;5929.547260921102;5969.70151492415;5694.601377903507;5705.315362156568;5709.143628455598;5717.256756621613;5723.112917497794;5687.971560142173;5711.600187986801;5720.8283751487525;5724.513416359656;5725.685087320071;5423.322084739408;5549.389567147691;5597.440255974533;5598.720063996865;5604.822987172739;5754.19441278213;5757.165211044459;5774.2782152230975;5792.797252096157;5803.39064398249;5341.3857406398765;5583.553315734813;5586.804461843816;5614.382417934105;5619.016672082287 10:31:52 INFO - PID 14095 | |5;yui.html;596.4065754574196;621.232777519763;623.1836294454263;627.3287582286952;631.1605564599083;12028.939855300721;12094.516219351215;12496.56262030829;12506.81239781404;12610.306433146174;12078.698032549191;12099.213551119194;12193.1464797464;12313.384330783447;12809.423575939105;814.5153633588005;814.7677911795155;837.6105111123327;838.149278482341;841.0748177005306;846.2975730143966;846.4286606540561;846.4371193156544;849.6006876767909;849.7535714642746;895.2882458445551;895.3285036222833;896.1620884473039;897.0312062971975;897.0580890065438;882.5851849630664;883.1212943121571;883.6553744039829;885.4952676974127;886.8935727712651;653.2128784814288;656.1437324291797;656.4387448731361;657.1949362031521;658.318640207383;12694.174878632859;12868.549600763929;13018.739625207443;13049.347532623331;13846.93076534611;12386.318752468611;12668.4299206535;12687.746245075046;12978.286194259312;13272.340892538268;9856.260780441424;10022.148117410028;10197.133243674296;10207.08136267732;10705.304155229886;3040.771942104329;3056.906019376734;3164.145680666207;3173.7461003119697;3178.110129163838;63077;64459.67770161166;65074.3492565073;66830.66584667045;67084.32915670829;10130.138938190188;10160.898391016142;10206;10328.122109620766;10596.152307815357;19736.605267894563;20031.799682002995;20073.899630501754;20201.696974545393;20233.595328093357;6570.211574610982;6608.107905432801;6674.833129171712;6679.699413526306;6690.565113267719;3280.5899262592175;3289.3750187464307;3296.8186749728993;3338.532605435241;3359.6808303211155;2735.4529094181244;2776.292045528418;2779.082902642164;2779.1523585306677;2788.9442211155665;454.94768101668734;463.9791209395585;467.92045352290194;474.66773258719036;478.7654049515712;580.7734983356494;605.8485378655337;609.460627344803;625.4683519008897;629.7040391016216;8432.494050356998;8741.956290218508;8848.1151884811;8958.238549723346;9054.139856713602;588.7321268822675;618.783425800966;621.6114928169894;623.76297007137;630.7634637011121;4190.182914331737;4341.3487976803735;4360.978195109004;4369.519352871182;4413.933282850427;47638.523614764104;48054.16238745234;61102.38897610967;64597.67701161558;65193;48604.27093593599;48778.268325975136;50105.74947125241;50222.74888625534;51207.487925121015;44187;45089.32366014512;46260.53739462562;46372;48145.277820832016;8781.473111613324;9295.209907157967;9374.718758437259;9384.81230375375;9398.718038458857;31503.684963150074;31599.36801263916;31946.84026579852;32412.351752964336;32611;37388.813055934545;38149.80925095357;38580.614193857706;38925.416118757676;39799;10596.31123976939;11428;11551.595694150665;11602.5358985643;11747.177697561088;12409.62771116868;12547;12728.490860365482;12957.287349195885;13029.674258143623;10571.2600117991;11156.49795759209;11286.379249141377;11359.772804543698;11434;11584.826227606423;11654.30074195551;12045.156839021185;12070.215435996632;12597.27602149194;10503.632372866912;10772.084372828398;10838.837417438586;10874.293170943864;11200.495977680861;9307.76730581741;9464.668736594462;9475.905240947503;9621.51892405363;9856.260780441638;9751.804963900824;9841.507924603598;9863.901360986298;9936.403815771077;9943.30396872212 10:31:52 INFO - PID 14095 | __end_tp_report 10:31:52 INFO - PID 14095 | __start_cc_report 10:31:52 INFO - PID 14095 | _x_x_mozilla_cycle_collect,381 10:31:52 INFO - PID 14095 | __end_cc_report 10:31:52 INFO - PID 14095 | __startTimestamp1489944711995__endTimestamp 10:31:52 INFO - PID 14095 | 10:31:52 INFO - PID 14095 | ------- Summary: start ------- 10:31:52 INFO - PID 14095 | Number of tests: 6 10:31:52 INFO - PID 14095 | 10:31:52 INFO - PID 14095 | [#0] dojo.html Cycles:165 Average:5058.94 Median:5184.56 stddev:553.06 (10.7%) stddev-sans-first:522.44 10:31:52 INFO - PID 14095 | Values: 2684.2 2690.9 2691.9 2729.4 2733.6 5022.1 5090.1 5112.2 5125.8 5169.1 5047.0 5131.5 5143.2 5207.9 5221.0 4689.6 4690.5 4715.8 4732.2 4762.1 4740.2 4767.0 4768.5 4773.1 4824.2 4664.4 4705.5 4709.8 4716.4 4734.5 4711.6 4714.6 4727.7 4757.8 4764.1 4636.1 4676.8 4692.1 4693.8 4736.8 4963.3 5012.0 5101.8 5148.4 5184.6 5512.2 5522.3 5529.6 5564.7 5581.8 5554.5 5561.5 5564.4 5565.4 5571.3 5019.7 5060.3 5070.2 5173.3 5185.1 5504.5 5544.1 5544.6 5549.7 5564.4 5340.9 5462.1 5482.1 5511.6 5518.2 5533.0 5557.2 5559.9 5566.1 5570.3 5533.3 5543.1 5552.9 5554.3 5613.3 5303.5 5367.3 5486.3 5498.5 5526.8 4687.2 4695.1 4696.8 4715.1 4731.0 4008.3 4010.1 4026.4 4028.3 4076.8 4601.4 4658.3 4753.0 4774.5 4789.1 5550.2 5574.8 5581.2 5588.7 5647.7 4689.7 4736.2 4737.9 4748.0 4758.8 4782.4 4849.2 4960.2 4967.5 4983.7 5162.2 5164.3 5172.2 5211.5 5222.8 5360.4 5421.9 5575.7 5578.5 5582.5 5140.9 5163.6 5184.5 5209.9 5212.0 5266.7 5315.8 5335.9 5401.2 5418.0 5385.6 5400.4 5402.7 5406.7 5413.3 5181.3 5194.2 5196.6 5207.8 5210.1 5261.1 5293.6 5296.8 5299.9 5300.6 5149.7 5171.3 5188.5 5189.1 5193.3 5329.5 5338.5 5341.0 5341.9 5352.6 5153.1 5179.9 5198.4 5244.2 5255.7 10:31:52 INFO - PID 14095 | 10:31:52 INFO - PID 14095 | [#1] ext.html Cycles:180 Average:34498.46 Median:31247.77 stddev:52799.70 (169.0%) stddev-sans-first:52886.81 10:31:52 INFO - PID 14095 | Values: 694.7 717.7 760.6 784.0 832.7 31300.8 32220.2 32367.5 34739.5 34866.5 30258.4 30553.5 30566.0 30651.0 30667.8 6137.4 6260.1 6268.4 8876.2 9099.5 9217.0 9243.6 9312.1 9338.2 9357.1 9364.0 9437.6 9441.2 9442.7 9472.2 9357.1 9377.4 9417.4 9426.3 9443.4 9147.8 9170.3 9238.6 9240.5 9247.7 33308.8 33896.2 33921.8 33933.8 34052.0 3145.2 3177.1 3191.6 3215.5 3258.1 23866.6 23969.5 24187.6 24206.4 24331.4 2827.2 2856.2 2933.7 2949.0 2956.8 159435.2 159791.0 160827.0 161152.0 161607.0 32825.7 33348.3 40414.2 43695.3 44026.3 42260.0 42450.6 42467.6 42533.4 42557.6 12587.5 12678.4 12705.5 12740.0 12785.5 10148.2 10155.3 10160.2 10179.2 10259.9 13165.5 13230.5 13230.7 13284.8 13404.3 5349.2 5362.8 5495.4 5542.1 5544.7 898.7 945.1 962.1 963.3 971.1 21253.7 21351.7 21465.7 21512.0 21775.0 993.7 1015.0 1030.2 1034.5 1038.7 10965.7 11381.0 11423.5 11458.0 11472.3 226355.0 227447.0 227691.0 227939.0 229834.0 40905.0 41104.0 41106.4 41296.6 41448.4 1125.9 1171.0 1177.0 1178.4 1179.6 19602.3 19663.7 20664.9 20766.5 20832.8 33059.7 33518.7 33561.2 33603.0 33688.7 213448.0 216491.0 216745.0 216805.0 216943.0 28950.9 29338.7 29639.3 30500.2 30602.4 35921.3 36118.8 36934.3 37073.6 37119.2 31194.7 31388.0 31574.8 31735.2 32150.4 30735.7 31432.8 31677.0 32523.2 32561.7 29933.6 29939.7 30601.8 30811.5 30920.7 27112.3 27701.7 28188.4 28308.6 28334.4 22014.3 22305.1 22358.6 22405.9 22451.3 10:31:52 INFO - PID 14095 | 10:31:52 INFO - PID 14095 | [#2] jquery.html Cycles:180 Average:28678.40 Median:3452.97 stddev:75192.16 (2177.6%) stddev-sans-first:75373.10 10:31:52 INFO - PID 14095 | Values: 390.5 395.4 406.0 415.7 416.8 12856.8 17805.5 18596.9 19394.6 19400.5 15537.8 15678.9 15712.8 16506.2 16733.4 5516.6 5537.7 5670.0 5758.1 5764.4 5578.2 5670.8 5674.6 5680.4 5699.3 5491.3 5627.5 5668.7 5691.5 5704.6 5645.4 5662.6 5665.5 5674.8 5682.0 5543.1 5558.3 6362.0 6608.4 6664.9 20740.3 21482.9 21642.8 22541.0 22890.7 2118.4 2179.2 2180.2 2202.2 2275.6 13527.0 14014.9 14158.6 15072.9 15141.7 1904.4 1906.7 1948.4 1950.6 1950.6 83439.0 84920.0 85524.6 86444.0 86641.6 16849.7 16891.3 16926.3 17080.2 17465.4 26362.3 28377.9 28412.7 28568.7 29382.6 8959.2 9081.2 9136.2 9152.8 9230.4 7377.7 7465.1 7553.2 7608.5 7661.7 9002.4 9029.4 9095.7 9106.4 9300.3 3404.6 3501.3 3530.6 3657.9 3790.3 730.8 745.9 762.1 778.8 780.5 18201.5 19245.2 19330.1 19541.2 19846.1 741.1 753.1 760.9 763.6 768.3 10219.7 10800.9 10808.4 10810.8 10834.4 451902.0 453427.0 454754.0 455101.0 461449.0 88774.0 88783.6 88931.6 91990.0 92518.0 1089.1 1090.8 1123.5 1129.8 1133.2 16239.8 16688.5 17248.7 17259.9 17409.2 40400.8 41282.8 41895.8 42060.4 42083.4 54155.7 56209.2 56298.4 56369.4 57402.4 10605.6 10959.5 10991.7 11070.9 11305.0 13077.9 13174.9 13228.7 13321.9 13704.9 9997.6 10038.1 10083.7 10197.8 10457.5 10548.4 10614.7 10664.9 10976.6 11167.0 10447.1 10614.2 10685.9 10730.8 11084.8 10640.7 10666.5 10684.4 11092.3 11117.4 9556.9 9675.3 9723.3 9893.5 10078.6 10:31:52 INFO - PID 14095 | 10:31:52 INFO - PID 14095 | [#3] mootools.html Cycles:180 Average:5733.91 Median:4648.42 stddev:3672.42 (79.0%) stddev-sans-first:3667.46 10:31:52 INFO - PID 14095 | Values: 1277.6 1289.9 1290.7 1322.4 1431.5 9059.6 9177.4 9366.3 9441.2 9535.7 9457.0 9591.8 9602.7 9612.0 9642.8 2048.3 2093.2 2099.7 2100.9 2101.5 1988.6 2051.4 2060.5 2062.3 2071.5 1962.4 2015.4 2026.0 2028.5 2040.6 1909.8 1915.1 1915.2 1920.7 1953.3 1605.6 1642.3 1933.7 1953.2 1980.5 9223.7 9526.0 9526.9 9541.8 9560.3 4299.7 4410.7 4433.1 4440.5 4440.7 2596.3 2626.9 2651.2 2653.2 2669.1 962.7 982.4 987.0 990.1 1004.4 12317.3 13649.4 13686.2 13793.7 13820.8 3799.8 3927.8 3966.2 3969.1 3969.9 10494.5 10539.7 10618.4 10621.7 10677.3 4629.9 4667.0 4670.8 4684.2 4684.5 4117.1 4136.2 4158.1 4160.0 4248.6 3138.4 3222.9 3285.9 3289.8 3342.6 820.5 831.0 844.3 848.1 848.2 746.9 749.4 760.5 762.9 779.8 5160.0 5308.2 5353.5 5488.2 5754.8 832.3 838.3 851.5 878.6 885.6 3359.6 3386.2 3424.5 3471.0 3513.8 10451.0 10811.4 11228.7 11436.2 11938.5 11774.0 11776.2 11795.3 11803.5 11810.4 8673.2 8971.2 8973.4 8994.9 9021.8 5952.4 5961.2 5961.3 5994.3 6100.8 9703.0 10342.2 10357.1 10436.3 10563.8 10102.1 10161.6 10215.8 10227.4 10257.3 7751.5 7856.3 7924.9 7950.4 8045.0 8724.0 8863.6 8916.0 8919.0 8934.2 7565.0 7690.5 7777.9 7939.4 8006.2 7543.8 7662.3 7671.7 7724.1 7767.5 6831.5 6858.2 6968.8 6973.3 6980.0 4798.5 4913.7 4926.8 4976.2 5117.4 4854.4 4861.7 4879.7 5115.1 5128.4 10:31:52 INFO - PID 14095 | 10:31:52 INFO - PID 14095 | [#4] prototype.html Cycles:180 Average:4867.54 Median:5279.62 stddev:1304.60 (24.7%) stddev-sans-first:1263.27 10:31:52 INFO - PID 14095 | Values: 342.3 353.8 354.3 359.0 361.6 5333.3 5468.3 5483.9 5534.3 5578.0 5299.0 5352.9 5353.8 5383.9 5394.4 4456.8 4479.8 4490.9 4493.7 4512.6 4356.3 4464.5 4468.8 4484.7 4496.3 4446.6 4453.0 4454.0 4458.8 4462.8 4424.0 4429.6 4451.6 4453.8 4461.4 4052.0 4103.2 4138.1 4168.2 4169.3 5232.7 5256.2 5263.0 5285.4 5296.1 5200.1 5211.0 5223.7 5223.9 5226.8 5439.8 5716.8 5749.5 5751.3 5763.6 4592.0 4596.4 4605.0 4614.6 4620.6 5745.7 5823.3 5909.1 6045.4 6088.5 4733.1 4735.4 4744.7 4748.4 4757.2 4818.9 4830.5 4839.8 4841.2 4844.5 5117.5 5188.8 5189.4 5199.5 5214.1 5693.0 5697.1 5712.3 5713.7 5713.8 1668.9 1695.9 1703.5 1704.4 1707.2 1216.4 1252.1 1259.5 1261.9 1288.3 4964.5 4967.8 4983.2 5006.4 5008.9 5941.8 5947.8 5969.3 5970.2 5980.8 4769.0 4974.4 4984.0 5010.1 5011.3 3135.7 3165.4 3165.4 3171.1 3176.5 5241.9 5387.2 5475.7 5492.9 5506.7 6035.0 6078.8 6096.5 6096.5 6121.8 5472.3 5489.0 5491.6 5497.9 5499.7 5737.3 5804.0 5823.9 5877.5 5923.5 5455.3 5796.2 5830.5 5830.9 5876.2 5268.6 5273.9 5442.6 5446.7 5483.2 4679.7 4712.6 4742.2 4759.5 4762.6 5767.8 5894.8 5904.9 5929.5 5969.7 5694.6 5705.3 5709.1 5717.3 5723.1 5688.0 5711.6 5720.8 5724.5 5725.7 5423.3 5549.4 5597.4 5598.7 5604.8 5754.2 5757.2 5774.3 5792.8 5803.4 5341.4 5583.6 5586.8 5614.4 5619.0 10:31:52 INFO - PID 14095 | 10:31:52 INFO - PID 14095 | [#5] yui.html Cycles:180 Average:13951.94 Median:22772.14 stddev:16792.61 (73.7%) stddev-sans-first:16809.76 10:31:52 INFO - PID 14095 | Values: 596.4 621.2 623.2 627.3 631.2 12028.9 12094.5 12496.6 12506.8 12610.3 12078.7 12099.2 12193.1 12313.4 12809.4 814.5 814.8 837.6 838.1 841.1 846.3 846.4 846.4 849.6 849.8 895.3 895.3 896.2 897.0 897.1 882.6 883.1 883.7 885.5 886.9 653.2 656.1 656.4 657.2 658.3 12694.2 12868.5 13018.7 13049.3 13846.9 12386.3 12668.4 12687.7 12978.3 13272.3 9856.3 10022.1 10197.1 10207.1 10705.3 3040.8 3056.9 3164.1 3173.7 3178.1 63077.0 64459.7 65074.3 66830.7 67084.3 10130.1 10160.9 10206.0 10328.1 10596.2 19736.6 20031.8 20073.9 20201.7 20233.6 6570.2 6608.1 6674.8 6679.7 6690.6 3280.6 3289.4 3296.8 3338.5 3359.7 2735.5 2776.3 2779.1 2779.2 2788.9 454.9 464.0 467.9 474.7 478.8 580.8 605.8 609.5 625.5 629.7 8432.5 8742.0 8848.1 8958.2 9054.1 588.7 618.8 621.6 623.8 630.8 4190.2 4341.3 4361.0 4369.5 4413.9 47638.5 48054.2 61102.4 64597.7 65193.0 48604.3 48778.3 50105.7 50222.7 51207.5 44187.0 45089.3 46260.5 46372.0 48145.3 8781.5 9295.2 9374.7 9384.8 9398.7 31503.7 31599.4 31946.8 32412.4 32611.0 37388.8 38149.8 38580.6 38925.4 39799.0 10596.3 11428.0 11551.6 11602.5 11747.2 12409.6 12547.0 12728.5 12957.3 13029.7 10571.3 11156.5 11286.4 11359.8 11434.0 11584.8 11654.3 12045.2 12070.2 12597.3 10503.6 10772.1 10838.8 10874.3 11200.5 9307.8 9464.7 9475.9 9621.5 9856.3 9751.8 9841.5 9863.9 9936.4 9943.3 10:31:52 INFO - PID 14095 | -------- Summary: end -------- 10:31:52 INFO - PID 14095 | 10:31:52 INFO - TEST-INFO | 14095: exit 0 10:31:52 INFO - TEST-OK | dromaeo_css | took 1121622ms 10:31:52 INFO - TEST-START | kraken 10:31:52 INFO - operating with platform_type : linux_ 10:31:52 INFO - Initialising browser for kraken test... 10:31:52 INFO - TEST-INFO | started process 14478 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9X28Un/profile http://localhost:37596/getInfo.html) 10:31:57 INFO - PID 14478 | __metrics Screen width/height:1600/1200 10:31:57 INFO - PID 14478 | colorDepth:24 10:31:57 INFO - PID 14478 | Browser inner width/height: 1024/697 10:31:57 INFO - PID 14478 | __metrics 10:31:58 ERROR - PID 14478 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 10:31:59 INFO - TEST-INFO | 14478: exit 0 10:31:59 INFO - Browser initialized. 10:31:59 INFO - Running cycle 1/1 for kraken test... 10:31:59 INFO - TEST-INFO | started process 14609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9X28Un/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:32:11 INFO - PID 14609 | RSS: Main: 155611136 10:32:11 INFO - PID 14609 | 10:32:14 INFO - PID 14609 | Cycle 1(1): loaded http://localhost:37596/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37596/tests/kraken/driver.html?testName=audio-beat-detection) 10:32:15 INFO - PID 14609 | RSS: Main: 161718272 10:32:15 INFO - PID 14609 | 10:32:18 INFO - PID 14609 | Cycle 1(1): loaded http://localhost:37596/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37596/tests/kraken/driver.html?testName=audio-dft) 10:32:18 INFO - PID 14609 | RSS: Main: 160784384 10:32:18 INFO - PID 14609 | 10:32:21 INFO - PID 14609 | Cycle 1(1): loaded http://localhost:37596/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37596/tests/kraken/driver.html?testName=audio-fft) 10:32:22 INFO - PID 14609 | RSS: Main: 157044736 10:32:22 INFO - PID 14609 | 10:32:24 INFO - PID 14609 | Cycle 1(1): loaded http://localhost:37596/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37596/tests/kraken/driver.html?testName=audio-oscillator) 10:32:25 INFO - PID 14609 | RSS: Main: 158191616 10:32:25 INFO - PID 14609 | 10:32:27 INFO - PID 14609 | Cycle 1(1): loaded http://localhost:37596/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37596/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:32:27 INFO - PID 14609 | RSS: Main: 158511104 10:32:27 INFO - PID 14609 | 10:32:31 INFO - PID 14609 | Cycle 1(1): loaded http://localhost:37596/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37596/tests/kraken/driver.html?testName=imaging-darkroom) 10:32:31 INFO - PID 14609 | RSS: Main: 162951168 10:32:31 INFO - PID 14609 | 10:32:35 INFO - PID 14609 | Cycle 1(1): loaded http://localhost:37596/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37596/tests/kraken/driver.html?testName=imaging-desaturate) 10:32:35 INFO - PID 14609 | RSS: Main: 160628736 10:32:35 INFO - PID 14609 | 10:32:38 INFO - PID 14609 | Cycle 1(1): loaded http://localhost:37596/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37596/tests/kraken/driver.html?testName=json-parse-financial) 10:32:39 INFO - PID 14609 | RSS: Main: 161984512 10:32:39 INFO - PID 14609 | 10:32:41 INFO - PID 14609 | Cycle 1(1): loaded http://localhost:37596/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37596/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:32:42 INFO - PID 14609 | RSS: Main: 162627584 10:32:42 INFO - PID 14609 | 10:32:43 INFO - PID 14609 | Cycle 1(1): loaded http://localhost:37596/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37596/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:32:44 INFO - PID 14609 | RSS: Main: 162398208 10:32:44 INFO - PID 14609 | 10:32:46 INFO - PID 14609 | Cycle 1(1): loaded http://localhost:37596/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37596/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:32:47 INFO - PID 14609 | RSS: Main: 162729984 10:32:47 INFO - PID 14609 | 10:32:50 INFO - PID 14609 | Cycle 1(1): loaded http://localhost:37596/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37596/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:32:50 INFO - PID 14609 | RSS: Main: 163512320 10:32:50 INFO - PID 14609 | 10:32:54 INFO - PID 14609 | Cycle 1(1): loaded http://localhost:37596/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37596/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:32:54 INFO - PID 14609 | RSS: Main: 160899072 10:32:54 INFO - PID 14609 | 10:32:56 INFO - PID 14609 | Cycle 1(1): loaded http://localhost:37596/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37596/tests/kraken/driver.html?testName=ai-astar) 10:32:56 INFO - PID 14609 | RSS: Main: 162607104 10:32:56 INFO - PID 14609 | 10:32:56 INFO - PID 14609 | __start_tp_report 10:32:56 INFO - PID 14609 | _x_x_mozilla_page_load 10:32:56 INFO - PID 14609 | _x_x_mozilla_page_load_details 10:32:56 INFO - PID 14609 | |i|pagename|runs| 10:32:56 INFO - PID 14609 | |0;ai-astar;114;124;120;120;121;119;122;120;121;121 10:32:56 INFO - PID 14609 | |1;audio-beat-detection;151;124;125;180;125;127;132;125;152;131 10:32:56 INFO - PID 14609 | |2;audio-dft;165;164;167;171;171;166;167;164;164;165 10:32:56 INFO - PID 14609 | |3;audio-fft;75;75;76;111;78;77;76;76;93;75 10:32:56 INFO - PID 14609 | |4;audio-oscillator;85;86;112;86;85;85;107;84;85;109 10:32:56 INFO - PID 14609 | |5;imaging-gaussian-blur;114;114;114;114;113;116;114;113;114;113 10:32:56 INFO - PID 14609 | |6;imaging-darkroom;152;151;150;151;152;150;150;150;151;151 10:32:56 INFO - PID 14609 | |7;imaging-desaturate;95;95;94;94;95;96;95;95;94;94 10:32:56 INFO - PID 14609 | |8;json-parse-financial;79;71;72;74;73;73;74;74;75;74 10:32:56 INFO - PID 14609 | |9;json-stringify-tinderbox;56;56;55;54;56;57;55;55;56;56 10:32:56 INFO - PID 14609 | |10;stanford-crypto-aes;83;82;82;80;83;83;82;83;91;85 10:32:56 INFO - PID 14609 | |11;stanford-crypto-ccm;134;138;134;150;141;139;138;133;223;137 10:32:56 INFO - PID 14609 | |12;stanford-crypto-pbkdf2;193;194;196;195;197;204;194;194;195;216 10:32:56 INFO - PID 14609 | |13;stanford-crypto-sha256-iterative;71;75;73;70;75;73;70;71;69;71 10:32:56 INFO - PID 14609 | __end_tp_report 10:32:56 INFO - PID 14609 | __start_cc_report 10:32:56 INFO - PID 14609 | _x_x_mozilla_cycle_collect,871 10:32:56 INFO - PID 14609 | __end_cc_report 10:32:56 INFO - PID 14609 | __startTimestamp1489944776934__endTimestamp 10:32:56 INFO - PID 14609 | 10:32:56 INFO - PID 14609 | ------- Summary: start ------- 10:32:56 INFO - PID 14609 | Number of tests: 14 10:32:56 INFO - PID 14609 | 10:32:56 INFO - PID 14609 | [#0] ai-astar Cycles:10 Average:120.20 Median:121.00 stddev:2.57 (2.1%) stddev-sans-first:1.45 10:32:56 INFO - PID 14609 | Values: 114.0 124.0 120.0 120.0 121.0 119.0 122.0 120.0 121.0 121.0 10:32:56 INFO - PID 14609 | 10:32:56 INFO - PID 14609 | [#1] audio-beat-detection Cycles:10 Average:137.20 Median:131.50 stddev:18.35 (14.0%) stddev-sans-first:18.77 10:32:56 INFO - PID 14609 | Values: 151.0 124.0 125.0 180.0 125.0 127.0 132.0 125.0 152.0 131.0 10:32:56 INFO - PID 14609 | 10:32:56 INFO - PID 14609 | [#2] audio-dft Cycles:10 Average:166.40 Median:166.50 stddev:2.67 (1.6%) stddev-sans-first:2.79 10:32:56 INFO - PID 14609 | Values: 165.0 164.0 167.0 171.0 171.0 166.0 167.0 164.0 164.0 165.0 10:32:56 INFO - PID 14609 | 10:32:56 INFO - PID 14609 | [#3] audio-fft Cycles:10 Average:81.20 Median:76.00 stddev:11.79 (15.5%) stddev-sans-first:12.29 10:32:56 INFO - PID 14609 | Values: 75.0 75.0 76.0 111.0 78.0 77.0 76.0 76.0 93.0 75.0 10:32:56 INFO - PID 14609 | 10:32:56 INFO - PID 14609 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:85.00 stddev:11.76 (13.8%) stddev-sans-first:12.16 10:32:56 INFO - PID 14609 | Values: 85.0 86.0 112.0 86.0 85.0 85.0 107.0 84.0 85.0 109.0 10:32:56 INFO - PID 14609 | 10:32:56 INFO - PID 14609 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.88 (0.8%) stddev-sans-first:0.93 10:32:56 INFO - PID 14609 | Values: 114.0 114.0 114.0 114.0 113.0 116.0 114.0 113.0 114.0 113.0 10:32:56 INFO - PID 14609 | 10:32:56 INFO - PID 14609 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 10:32:56 INFO - PID 14609 | Values: 152.0 151.0 150.0 151.0 152.0 150.0 150.0 150.0 151.0 151.0 10:32:56 INFO - PID 14609 | 10:32:56 INFO - PID 14609 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 10:32:56 INFO - PID 14609 | Values: 95.0 95.0 94.0 94.0 95.0 96.0 95.0 95.0 94.0 94.0 10:32:56 INFO - PID 14609 | 10:32:56 INFO - PID 14609 | [#8] json-parse-financial Cycles:10 Average:73.90 Median:74.00 stddev:2.13 (2.9%) stddev-sans-first:1.22 10:32:56 INFO - PID 14609 | Values: 79.0 71.0 72.0 74.0 73.0 73.0 74.0 74.0 75.0 74.0 10:32:56 INFO - PID 14609 | 10:32:56 INFO - PID 14609 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:56.00 stddev:0.84 (1.5%) stddev-sans-first:0.88 10:32:56 INFO - PID 14609 | Values: 56.0 56.0 55.0 54.0 56.0 57.0 55.0 55.0 56.0 56.0 10:32:56 INFO - PID 14609 | 10:32:56 INFO - PID 14609 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:2.95 (3.6%) stddev-sans-first:3.13 10:32:56 INFO - PID 14609 | Values: 83.0 82.0 82.0 80.0 83.0 83.0 82.0 83.0 91.0 85.0 10:32:56 INFO - PID 14609 | 10:32:56 INFO - PID 14609 | [#11] stanford-crypto-ccm Cycles:10 Average:146.70 Median:138.50 stddev:27.24 (19.7%) stddev-sans-first:28.51 10:32:56 INFO - PID 14609 | Values: 134.0 138.0 134.0 150.0 141.0 139.0 138.0 133.0 223.0 137.0 10:32:56 INFO - PID 14609 | 10:32:56 INFO - PID 14609 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.80 Median:195.50 stddev:7.11 (3.6%) stddev-sans-first:7.33 10:32:56 INFO - PID 14609 | Values: 193.0 194.0 196.0 195.0 197.0 204.0 194.0 194.0 195.0 216.0 10:32:56 INFO - PID 14609 | 10:32:56 INFO - PID 14609 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:72.00 stddev:2.10 (2.9%) stddev-sans-first:2.20 10:32:56 INFO - PID 14609 | Values: 71.0 75.0 73.0 70.0 75.0 73.0 70.0 71.0 69.0 71.0 10:32:56 INFO - PID 14609 | -------- Summary: end -------- 10:32:56 INFO - PID 14609 | 10:32:58 INFO - TEST-INFO | 14609: exit 0 10:32:58 INFO - TEST-OK | kraken | took 65268ms 10:32:58 INFO - SUITE-END | took 1186s 10:32:58 INFO - Completed test suite (00:19:47) 10:32:58 INFO - javascript benchmark 10:32:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6692.776535065916, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2684.2081585932146, 2690.8923643054277, 2691.9192424227253, 2729.358600728828, 2733.576295674171, 5022.121128802463, 5090.109230884595, 5112.207607820789, 5125.769340379683, 5169.121249387604, 5047.015831912779, 5131.512506311894, 5143.228515722643, 5207.869803254921, 5221.034108689895, 4689.57793798558, 4690.484046754863, 4715.811367545294, 4732.2428411454175, 4762.1428142934255, 4740.1704701677245, 4767.0, 4768.499307572707, 4773.116973359922, 4824.228123500241, 4664.440267167927, 4705.458872229703, 4709.764511774398, 4716.410448693913, 4734.526547345273, 4711.623070154379, 4714.599259062984, 4727.692699974525, 4757.833475828364, 4764.071006153801, 4636.0727854428915, 4676.836310729108, 4692.085043416535, 4693.812247510095, 4736.786844592001, 4963.280324352949, 5011.974940125312, 5101.770420331094, 5148.4079330876675, 5184.559312458446, 5512.228288039678, 5522.337319521643, 5529.557635389159, 5564.666120032811, 5581.832545023656, 5554.472325129106, 5561.4716601922755, 5564.387917329091, 5565.387807341189, 5571.303587051619, 5019.749012549358, 5060.266261392151, 5070.163423035232, 5173.301604283449, 5185.118529849935, 5504.532114770209, 5544.0575102232715, 5544.584156188302, 5549.722513874371, 5564.443555644403, 5340.91988620171, 5462.0987537056735, 5482.122860342326, 5511.614187006951, 5518.172274158828, 5532.972335138379, 5557.194206839986, 5559.861003474945, 5566.137248726453, 5570.275864137717, 5533.335999680065, 5543.1408131739645, 5552.91670624941, 5554.250176226238, 5613.298337707786, 5303.4696530346655, 5367.275417818622, 5486.259354987025, 5498.477644623755, 5526.806561770319, 4687.179743544866, 4695.131400690883, 4696.788644511005, 4715.080559290974, 4731.030138821533, 4008.2584721826556, 4010.137820368635, 4026.3960405939342, 4028.295048366524, 4076.7553946763287, 4601.447826260804, 4658.34783130362, 4753.025629745894, 4774.546418090275, 4789.114013907439, 5550.222968784374, 5574.832755017356, 5581.246531718166, 5588.692621905834, 5647.6893770843, 4689.742064186503, 4736.242201247784, 4737.928931066037, 4747.976260118747, 4758.78585463655, 4782.426108866958, 4849.224124140121, 4960.23116416956, 4967.453580106186, 4983.725895075733, 5162.225666149958, 5164.251183578285, 5172.224166374924, 5211.530962213419, 5222.764975576032, 5360.383555891122, 5421.864453388697, 5575.665460072409, 5578.470045345685, 5582.49757521825, 5140.871478212925, 5163.6127290454115, 5184.45563215872, 5209.947900520946, 5212.009718153538, 5266.683998960075, 5315.840524784263, 5335.919961200508, 5401.162819762943, 5417.972910135424, 5385.649932754359, 5400.432954539874, 5402.675839449488, 5406.702631355313, 5413.296271484682, 5181.326427564392, 5194.168932970707, 5196.636235463481, 5207.791688332424, 5210.140326846028, 5261.053010458154, 5293.629445938747, 5296.788128474972, 5299.920501192408, 5300.575953923754, 5149.742512874266, 5171.3018742469285, 5188.533032027136, 5189.065968125774, 5193.272941788228, 5329.493698098674, 5338.466153384786, 5340.973295133499, 5341.946580534145, 5352.5985551084605, 5153.098207813543, 5179.948200517946, 5198.402183748917, 5244.160934250502, 5255.737213139404], "value": 5020.9601740760045, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.6839188169383, 717.7093277222723, 760.574078516031, 784.0395515493518, 832.7460124661976, 31300.84349578252, 32220.194495137603, 32367.51448728271, 34739.47890781634, 34866.47700284498, 30258.394832103346, 30553.541696874563, 30566.0, 30651.0, 30667.846660766663, 6137.38626137386, 6260.092286618437, 6268.404501572343, 8876.156765107336, 9099.499527525983, 9217.0, 9243.58403871824, 9312.115349041864, 9338.206252468548, 9357.064293570656, 9363.95318023409, 9437.622495100188, 9441.19749821266, 9442.716718498421, 9472.242220622335, 9357.064293570656, 9377.390469619453, 9417.387869788441, 9426.340156189104, 9443.386179898285, 9147.77130571741, 9170.266378689688, 9238.6304547818, 9240.537973101318, 9247.72256832296, 33308.833455832806, 33896.15259618505, 33921.83039084813, 33933.830330848185, 34052.0, 3145.1665308693214, 3177.1421716136515, 3191.6010498687665, 3215.5015972524297, 3258.1365938026443, 23866.642000370008, 23969.52060958771, 24187.637185442232, 24206.39484012896, 24331.391715207083, 2827.20838165312, 2856.185986993697, 2933.7359637632503, 2948.9852550737323, 2956.8078074925274, 159435.20282398514, 159791.0, 160827.0, 161152.0, 161607.0, 32825.67174328274, 33348.33213342927, 40414.1917161661, 43695.344569831475, 44026.33960490595, 42260.0, 42450.57549424528, 42467.57532424636, 42533.36199957003, 42557.57442425598, 12587.496500140074, 12678.366081696062, 12705.491780328683, 12740.044496662787, 12785.488580456864, 10148.238882083873, 10155.339902906288, 10160.237982151368, 10179.236557258235, 10259.948700256451, 13165.47338106465, 13230.536931207555, 13230.73538529224, 13284.800727989088, 13404.262765547794, 5349.22436246742, 5362.812301569505, 5495.395506494282, 5542.085555883315, 5544.667319960815, 898.7169041751828, 945.0643862576001, 962.0716009051159, 963.349738926222, 971.1114330387617, 21253.68119478209, 21351.67972480414, 21465.67801482979, 21512.0, 21775.0, 993.7465946183821, 1014.9797004060025, 1030.2015937648232, 1034.5189486888632, 1038.7299302181336, 10965.725856853642, 11381.0, 11423.485943132579, 11458.0, 11472.254303470248, 226355.0, 227447.0, 227691.0, 227939.0, 229834.0, 40905.0, 41104.0, 41106.38340424896, 41296.58703412987, 41448.37827432591, 1125.8536390269376, 1171.0455978377595, 1176.9705757355964, 1178.4225729392535, 1179.6461061681462, 19602.313919012766, 19663.70504442406, 20664.896675516527, 20766.517237433316, 20832.791672083084, 33059.669403305656, 33518.664813351555, 33561.16097097592, 33603.0, 33688.66311336855, 213448.0, 216491.0, 216745.0, 216805.0, 216943.0, 28950.855245723636, 29338.706612933598, 29639.25901852471, 30500.237494062825, 30602.387952241275, 35921.28157436889, 36118.8194059028, 36934.26131477409, 37073.629263707015, 37119.17450731387, 31194.68805311918, 31388.0, 31574.842125789222, 31735.206619833767, 32150.35699286048, 30735.692643074177, 31432.842835785676, 31677.0, 32523.18692032718, 32561.674383256814, 29933.55099673463, 29939.700602993693, 30601.846990764905, 30811.537826932166, 30920.690793092683, 27112.32219194536, 27701.72298277072, 28188.43623127567, 28308.575371369036, 28334.43331133407, 22014.33956981293, 22305.10779568799, 22358.552828943655, 22405.88797056004, 22451.326460205568], "value": 15451.108863677859, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.5411141908257, 395.351623337726, 405.9797010149493, 415.6799264566284, 416.7582801974855, 12856.807147892765, 17805.46583602491, 18596.90701546492, 19394.612107757854, 19400.514987125312, 15537.84462155378, 15678.921605391957, 15712.842871571282, 16506.17469126545, 16733.414330498435, 5516.586256030793, 5537.667739935597, 5669.971650141743, 5758.078707406816, 5764.394738552454, 5578.219049333096, 5670.8015219467325, 5674.631148975303, 5680.4319568043275, 5699.287589051369, 5491.341039075317, 5627.549796016309, 5668.744906479198, 5691.51622112121, 5704.600677952545, 5645.350784659776, 5662.575306851982, 5665.461781130786, 5674.829755107312, 5682.0, 5543.1408131739645, 5558.333000039981, 6362.0, 6608.4052435281055, 6664.86670266592, 20740.274090406765, 21482.892585537127, 21642.783572164233, 22541.0, 22890.65664015041, 2118.3962570667286, 2179.161023006154, 2180.160638154322, 2202.2072054060527, 2275.6131457652073, 13527.0, 14014.85985140156, 14158.646033849132, 15072.924635376863, 15141.697166056618, 1904.419152158591, 1906.7235250888543, 1948.39599724086, 1950.5806251655963, 1950.6391317606287, 83439.0, 84920.0, 85524.57237713771, 86444.0, 86641.56679216627, 16849.663006739796, 16891.324347026228, 16926.322947082226, 17080.231389587498, 17465.38871139504, 26362.340941476617, 28377.858110709316, 28412.715872841007, 28568.71431285702, 29382.55926161109, 8959.238464730572, 9081.182693557612, 9136.223421009156, 9152.816943661222, 9230.400023998418, 7377.704891804375, 7465.06686664167, 7553.169151393342, 7608.543487390774, 7661.693532258759, 9002.369834111549, 9029.41308814925, 9095.68112623679, 9106.408083474553, 9300.302477314228, 3404.6084700259294, 3501.3347463981763, 3530.6469353065004, 3657.8719744808805, 3790.33669107905, 730.7844185965153, 745.8955746195537, 762.089303282583, 778.7780482562442, 780.4692808889896, 18201.45395638133, 19245.230190792212, 19330.130144143546, 19541.21835126579, 19846.1069251884, 741.1254719431015, 753.1263734068455, 760.8744557148119, 763.6334559411514, 768.3161985832613, 10219.744506387251, 10800.945995269973, 10808.352408464278, 10810.783784324269, 10834.404107774148, 451902.0, 453427.0, 454754.0, 455101.0, 461449.0, 88774.0, 88783.55608221918, 88931.55534222287, 91990.0, 92518.0, 1089.1014912697058, 1090.7654854206385, 1123.4831977290537, 1129.8079326514512, 1133.1501373969522, 16239.756403654192, 16688.499345019667, 17248.741268880727, 17259.872745175282, 17409.216585253947, 40400.79799600983, 41282.793586033076, 41895.7905210472, 42060.36909446422, 42083.368749469395, 54155.72922135364, 56209.156862646276, 56298.43701562932, 56369.43630563642, 57402.42597574138, 10605.628802992167, 10959.506822192861, 10991.670249892515, 11070.944645277044, 11305.0, 13077.869221307665, 13174.934125329311, 13228.669283267995, 13321.866781332063, 13704.931475342559, 9997.55011024491, 10038.1467575254, 10083.747906302402, 10197.796044078928, 10457.47712614351, 10548.367097974146, 10614.681559553226, 10664.89335106639, 10976.560937562728, 11167.0, 10447.111995480469, 10614.203934705083, 10685.893141068489, 10730.785384292114, 11084.833727493933, 10640.733981650521, 10666.520006599567, 10684.412357320422, 11092.279001864854, 11117.388543630179, 9556.904430955601, 9675.322727409013, 9723.319367644197, 9893.547903443336, 10078.647247346307], "value": 9707.74525637003, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1277.5592420614885, 1289.8774616411438, 1290.7160424706567, 1322.3850909327161, 1431.456046702253, 9059.637614495421, 9177.449353038823, 9366.297527685434, 9441.150296473315, 9535.666251681192, 9457.0, 9591.808163836718, 9602.711918642435, 9612.0, 9642.807143857137, 2048.252387878425, 2093.2150443583655, 2099.737532808399, 2100.9474763130893, 2101.4536220582604, 1988.5724569217687, 2051.4461095504207, 2060.4745789823573, 2062.298818401743, 2071.5442602627472, 1962.3916585858358, 2015.405455390656, 2026.0, 2028.4725971247435, 2040.55107876267, 1909.8185672361103, 1915.1190452391847, 1915.205189846212, 1920.7214953831756, 1953.345629214215, 1605.5584714203687, 1642.3266460751154, 1933.6906095024729, 1953.199188332791, 1980.4652743759248, 9223.723288301295, 9526.047395260488, 9526.90473095267, 9541.809163816753, 9560.28297877662, 4299.6775241856985, 4410.713303635285, 4433.13553856998, 4440.489343725449, 4440.711353761995, 2596.31197732601, 2626.855522946237, 2651.178134778225, 2653.1775149703653, 2669.065826960568, 962.7400601837464, 982.4301904895144, 986.9851952220722, 990.074280547683, 1004.392342632704, 12317.260964342078, 13649.385777640031, 13686.247256400893, 13793.655158621015, 13820.792688109686, 3799.810009499514, 3927.842886284574, 3966.1671049080014, 3969.1069509360163, 3969.920601587952, 10494.527746251437, 10539.736506587244, 10618.415987120783, 10621.681349559525, 10677.252592318619, 4629.86110416688, 4666.976665116653, 4670.7664616769025, 4684.203685373426, 4684.461286951976, 4117.07365842683, 4136.172765446922, 4158.064435502049, 4160.0, 4248.638865696388, 3138.403703296412, 3222.9033129005697, 3285.868565257363, 3289.802611843297, 3342.6490218526706, 820.5404973215019, 830.9792255193669, 844.3245403677034, 848.0628905059943, 848.1857416879741, 746.8655641984495, 749.4079677055174, 760.5094713909498, 762.8703120469534, 779.8245394786242, 5159.993801208803, 5308.177232528964, 5353.518183363516, 5488.231647569343, 5754.827355179267, 832.3216578488513, 838.2623291503438, 851.4550687559966, 878.6221924572495, 885.623609965762, 3359.6136444308727, 3386.153461634591, 3424.4863270509127, 3471.0, 3513.8243087845503, 10451.0, 10811.35131892089, 11228.66314010581, 11436.199466037298, 11938.492916487636, 11774.0, 11776.234544754563, 11795.292282462908, 11803.468843902045, 11810.350430726221, 8673.219410253107, 8971.19259266656, 8973.416727912665, 8994.86507702385, 9021.819563608691, 5952.434518720715, 5961.195238642727, 5961.344252132175, 5994.250718660168, 6100.816975490742, 9702.951485242529, 10342.224333174892, 10357.067863892285, 10436.269461137952, 10563.841542377024, 10102.141317988053, 10161.593536258466, 10215.846762298423, 10227.437490937773, 10257.33327333721, 7751.457397982313, 7856.25365590268, 7924.920750792418, 7950.363970882431, 8044.959775201087, 8723.956380218058, 8863.645454182019, 8915.955420222857, 8918.955405222932, 8934.240589549961, 7564.962175189089, 7690.461667683208, 7777.883331749915, 7939.364850811806, 8006.19938006218, 7543.811404714926, 7662.272084151997, 7671.69313227487, 7724.0731112266885, 7767.495112817649, 6831.521793474409, 6858.211305699709, 6968.79093627192, 6973.3375329343635, 6980.0, 4798.520147985174, 4913.65604407688, 4926.753662316942, 4976.2286845539, 5117.360329958755, 4854.393200849894, 4861.708297502161, 4879.707217566957, 5115.104856650146, 5128.358955130609], "value": 4316.964541703311, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.2590092449846, 353.75767599194546, 354.28257777999534, 358.99102522436937, 361.6040435722884, 5333.280007199027, 5468.261784659075, 5483.890322193553, 5534.252875861757, 5577.972110139443, 5299.0, 5352.892942141155, 5353.785848566063, 5383.946160538393, 5394.433584473632, 4456.821727130911, 4479.820807167709, 4490.8877278067985, 4493.68544201906, 4512.638988880898, 4356.324769660692, 4464.464264288274, 4468.75421851798, 4484.663650226246, 4496.2581174106235, 4446.644268458532, 4452.955470445287, 4454.0, 4458.79935402906, 4462.754548499831, 4423.955760442403, 4429.645628349725, 4451.643868490513, 4453.755043472608, 4461.353103799931, 4051.9797401012806, 4103.179364127186, 4138.110306284163, 4168.228877657643, 4169.332906734908, 5232.691827043239, 5256.216842673187, 5262.973685131588, 5285.365756109253, 5296.09966305729, 5200.141976573861, 5210.957808438327, 5223.660462069991, 5223.869403264949, 5226.843194704165, 5439.755211015514, 5716.828495145152, 5749.540036797088, 5751.281089863767, 5763.596548241625, 4592.035672508777, 4596.3794887690065, 4604.953950460486, 4614.607758340511, 4620.561046700558, 5745.741441635095, 5823.272090988627, 5909.109085092772, 6045.377798647256, 6088.512918966472, 4733.148033354029, 4735.431748190171, 4744.667873248839, 4748.430188377417, 4757.191277482836, 4818.927716084261, 4830.516948305141, 4839.830605928775, 4841.15279826029, 4844.539768721966, 5117.5394214520875, 5188.766505507261, 5189.40321862983, 5199.48005199477, 5214.113600687816, 5692.975264452439, 5697.0599851024945, 5712.314522257273, 5713.657180569179, 5713.8285851424525, 1668.8915220510871, 1695.8982461052376, 1703.4719237036559, 1704.386420888479, 1707.2232134378828, 1216.3735676126803, 1252.136026141959, 1259.4962015193812, 1261.9336660521844, 1288.2978776566792, 4964.478729733326, 4967.783826981655, 4983.227599722049, 5006.4492905780335, 5008.946332003934, 5941.7623295067715, 5947.762089516457, 5969.343372229051, 5970.2238708968425, 5980.820575382745, 4768.976155119202, 4974.427940786783, 4984.0, 5010.123228435009, 5011.323471331397, 3135.7177853992794, 3165.3511030238747, 3165.446046941776, 3171.1437911763696, 3176.5235214717977, 5241.868953276198, 5387.218853266255, 5475.67145971243, 5492.862678433071, 5506.724663766796, 6034.969825150846, 6078.848028799227, 6096.451319381277, 6096.542759293071, 6121.816345509642, 5472.34331880169, 5488.9725551372785, 5491.643043202179, 5497.862553436196, 5499.670019798825, 5737.282839645044, 5803.970980145241, 5823.912641310299, 5877.529797616266, 5923.466887980103, 5455.263539422286, 5796.159556864147, 5830.53355731549, 5830.941690583039, 5876.236089308362, 5268.57851371897, 5273.8681532960445, 5442.6462279951675, 5446.700431476307, 5483.177523371367, 4679.742614156118, 4712.62299016071, 4742.170120228877, 4759.524047595212, 4762.6189904808225, 5767.826965191051, 5894.764209431574, 5904.888440464099, 5929.547260921102, 5969.70151492415, 5694.601377903507, 5705.315362156568, 5709.143628455598, 5717.256756621613, 5723.112917497794, 5687.971560142173, 5711.600187986801, 5720.8283751487525, 5724.513416359656, 5725.685087320071, 5423.322084739408, 5549.389567147691, 5597.440255974533, 5598.720063996865, 5604.822987172739, 5754.19441278213, 5757.165211044459, 5774.2782152230975, 5792.797252096157, 5803.39064398249, 5341.3857406398765, 5583.553315734813, 5586.804461843816, 5614.382417934105, 5619.016672082287], "value": 4470.367388323877, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.4065754574196, 621.232777519763, 623.1836294454263, 627.3287582286952, 631.1605564599083, 12028.939855300721, 12094.516219351215, 12496.56262030829, 12506.81239781404, 12610.306433146174, 12078.698032549191, 12099.213551119194, 12193.1464797464, 12313.384330783447, 12809.423575939105, 814.5153633588005, 814.7677911795155, 837.6105111123327, 838.149278482341, 841.0748177005306, 846.2975730143966, 846.4286606540561, 846.4371193156544, 849.6006876767909, 849.7535714642746, 895.2882458445551, 895.3285036222833, 896.1620884473039, 897.0312062971975, 897.0580890065438, 882.5851849630664, 883.1212943121571, 883.6553744039829, 885.4952676974127, 886.8935727712651, 653.2128784814288, 656.1437324291797, 656.4387448731361, 657.1949362031521, 658.318640207383, 12694.174878632859, 12868.549600763929, 13018.739625207443, 13049.347532623331, 13846.93076534611, 12386.318752468611, 12668.4299206535, 12687.746245075046, 12978.286194259312, 13272.340892538268, 9856.260780441424, 10022.148117410028, 10197.133243674296, 10207.08136267732, 10705.304155229886, 3040.771942104329, 3056.906019376734, 3164.145680666207, 3173.7461003119697, 3178.110129163838, 63077.0, 64459.67770161166, 65074.3492565073, 66830.66584667045, 67084.32915670829, 10130.138938190188, 10160.898391016142, 10206.0, 10328.122109620766, 10596.152307815357, 19736.605267894563, 20031.799682002995, 20073.899630501754, 20201.696974545393, 20233.595328093357, 6570.211574610982, 6608.107905432801, 6674.833129171712, 6679.699413526306, 6690.565113267719, 3280.5899262592175, 3289.3750187464307, 3296.8186749728993, 3338.532605435241, 3359.6808303211155, 2735.4529094181244, 2776.292045528418, 2779.082902642164, 2779.1523585306677, 2788.9442211155665, 454.94768101668734, 463.9791209395585, 467.92045352290194, 474.66773258719036, 478.7654049515712, 580.7734983356494, 605.8485378655337, 609.460627344803, 625.4683519008897, 629.7040391016216, 8432.494050356998, 8741.956290218508, 8848.1151884811, 8958.238549723346, 9054.139856713602, 588.7321268822675, 618.783425800966, 621.6114928169894, 623.76297007137, 630.7634637011121, 4190.182914331737, 4341.3487976803735, 4360.978195109004, 4369.519352871182, 4413.933282850427, 47638.523614764104, 48054.16238745234, 61102.38897610967, 64597.67701161558, 65193.0, 48604.27093593599, 48778.268325975136, 50105.74947125241, 50222.74888625534, 51207.487925121015, 44187.0, 45089.32366014512, 46260.53739462562, 46372.0, 48145.277820832016, 8781.473111613324, 9295.209907157967, 9374.718758437259, 9384.81230375375, 9398.718038458857, 31503.684963150074, 31599.36801263916, 31946.84026579852, 32412.351752964336, 32611.0, 37388.813055934545, 38149.80925095357, 38580.614193857706, 38925.416118757676, 39799.0, 10596.31123976939, 11428.0, 11551.595694150665, 11602.5358985643, 11747.177697561088, 12409.62771116868, 12547.0, 12728.490860365482, 12957.287349195885, 13029.674258143623, 10571.2600117991, 11156.49795759209, 11286.379249141377, 11359.772804543698, 11434.0, 11584.826227606423, 11654.30074195551, 12045.156839021185, 12070.215435996632, 12597.27602149194, 10503.632372866912, 10772.084372828398, 10838.837417438586, 10874.293170943864, 11200.495977680861, 9307.76730581741, 9464.668736594462, 9475.905240947503, 9621.51892405363, 9856.260780441638, 9751.804963900824, 9841.507924603598, 9863.901360986298, 9936.403815771077, 9943.30396872212], "value": 6183.202508665834, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 124.0, 120.0, 120.0, 121.0, 119.0, 122.0, 120.0, 121.0, 121.0], "value": 120.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 125.0, 180.0, 125.0, 127.0, 132.0, 125.0, 152.0, 131.0], "value": 137.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 167.0, 171.0, 171.0, 166.0, 167.0, 164.0, 164.0, 165.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 111.0, 78.0, 77.0, 76.0, 76.0, 93.0, 75.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 112.0, 86.0, 85.0, 85.0, 107.0, 84.0, 85.0, 109.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 116.0, 114.0, 113.0, 114.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 150.0, 151.0, 152.0, 150.0, 150.0, 150.0, 151.0, 151.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 96.0, 95.0, 95.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 71.0, 72.0, 74.0, 73.0, 73.0, 74.0, 74.0, 75.0, 74.0], "value": 73.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 54.0, 56.0, 57.0, 55.0, 55.0, 56.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 80.0, 83.0, 83.0, 82.0, 83.0, 91.0, 85.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 138.0, 134.0, 150.0, 141.0, 139.0, 138.0, 133.0, 223.0, 137.0], "value": 146.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 194.0, 196.0, 195.0, 197.0, 204.0, 194.0, 194.0, 195.0, 216.0], "value": 197.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 75.0, 73.0, 70.0, 75.0, 73.0, 70.0, 71.0, 69.0, 71.0], "value": 71.8, "unit": "score"}]}]} 10:32:58 INFO - Return code: 0 10:32:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:32:58 ERROR - # TBPL SUCCESS # 10:32:58 INFO - Running post-action listener: _resource_record_post_action 10:32:58 INFO - [mozharness: 2017-03-19 17:32:58.739046Z] Finished run-tests step (success) 10:32:58 INFO - Running post-run listener: _resource_record_post_run 10:32:58 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 196608; Write bytes: 373972992; Read time: 80; Write time: 241144 10:32:58 INFO - TinderboxPrint: CPU usage
13.3% 10:32:58 INFO - TinderboxPrint: I/O read bytes / time
196,608 / 80 10:32:58 INFO - TinderboxPrint: I/O write bytes / time
373,972,992 / 241,144 10:32:58 INFO - TinderboxPrint: CPU idle
8,323.7 (86.7%) 10:32:58 INFO - TinderboxPrint: CPU user
1,219.0 (12.7%) 10:32:58 INFO - TinderboxPrint: Swap in / out
0 / 0 10:32:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 116891648; Read time: 0; Write time: 78744 10:32:58 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 196608; Write bytes: 257081344; Read time: 80; Write time: 162400 10:32:59 INFO - Running post-run listener: _upload_blobber_files 10:32:59 INFO - Blob upload gear active. 10:32:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:32:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:32:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:32:59 INFO - (blobuploader) - INFO - Open directory for files ... 10:32:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:32:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:33:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:00 INFO - (blobuploader) - INFO - Done attempting. 10:33:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:33:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:33:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:04 INFO - (blobuploader) - INFO - Done attempting. 10:33:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:33:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:33:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:05 INFO - (blobuploader) - INFO - Done attempting. 10:33:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:33:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:33:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:06 INFO - (blobuploader) - INFO - Done attempting. 10:33:06 INFO - (blobuploader) - INFO - Iteration through files over. 10:33:06 INFO - Return code: 0 10:33:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:33:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:33:06 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a1ba65da8883ea009ab04e8232ed093abb326c88bade9dd74240bca8beca1c8247d1857a6de388ee4696e7b00f3544e49a122fb1c5d76cfcd0ae6cdc1e13ab5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02181e95ab588c0aebe91adc31a733cd20176255746dae66c8bddc11f09894b8e8218058eefc68553aee8002603a8439e33209092dfcf96a3f2049c2150dc2a2", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/298da1381cfe2fec3b43c92a5252235f84f6ba73c8eb83bf18ac75f3c03bd1b5b68bb273a92589155117c6dad8035fb4106c372244b547c02b934785c9551c5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2af5e68abdcf2acfd31ef19cacdf422445618f17ce60871ad5136d31154a28208012182db8e881cabb36392b946018fbda267ebbfaced717de61b37f8edeec90"} 10:33:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:33:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:33:06 INFO - Contents: 10:33:06 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a1ba65da8883ea009ab04e8232ed093abb326c88bade9dd74240bca8beca1c8247d1857a6de388ee4696e7b00f3544e49a122fb1c5d76cfcd0ae6cdc1e13ab5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02181e95ab588c0aebe91adc31a733cd20176255746dae66c8bddc11f09894b8e8218058eefc68553aee8002603a8439e33209092dfcf96a3f2049c2150dc2a2", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/298da1381cfe2fec3b43c92a5252235f84f6ba73c8eb83bf18ac75f3c03bd1b5b68bb273a92589155117c6dad8035fb4106c372244b547c02b934785c9551c5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2af5e68abdcf2acfd31ef19cacdf422445618f17ce60871ad5136d31154a28208012182db8e881cabb36392b946018fbda267ebbfaced717de61b37f8edeec90"} 10:33:06 INFO - Running post-run listener: copy_logs_to_upload_dir 10:33:06 INFO - Copying logs to upload dir... 10:33:06 INFO - mkdir: /builds/slave/test/build/upload/logs 10:33:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.724313 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-03-19 10:33:06.155982) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-19 10:33:06.159489) ========= 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=9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a1ba65da8883ea009ab04e8232ed093abb326c88bade9dd74240bca8beca1c8247d1857a6de388ee4696e7b00f3544e49a122fb1c5d76cfcd0ae6cdc1e13ab5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02181e95ab588c0aebe91adc31a733cd20176255746dae66c8bddc11f09894b8e8218058eefc68553aee8002603a8439e33209092dfcf96a3f2049c2150dc2a2", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/298da1381cfe2fec3b43c92a5252235f84f6ba73c8eb83bf18ac75f3c03bd1b5b68bb273a92589155117c6dad8035fb4106c372244b547c02b934785c9551c5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2af5e68abdcf2acfd31ef19cacdf422445618f17ce60871ad5136d31154a28208012182db8e881cabb36392b946018fbda267ebbfaced717de61b37f8edeec90"} build_url:https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011289 build_url: 'https://queue.taskcluster.net/v1/task/bXL_s-x7T7KRu78V4r6yFA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a1ba65da8883ea009ab04e8232ed093abb326c88bade9dd74240bca8beca1c8247d1857a6de388ee4696e7b00f3544e49a122fb1c5d76cfcd0ae6cdc1e13ab5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02181e95ab588c0aebe91adc31a733cd20176255746dae66c8bddc11f09894b8e8218058eefc68553aee8002603a8439e33209092dfcf96a3f2049c2150dc2a2", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/298da1381cfe2fec3b43c92a5252235f84f6ba73c8eb83bf18ac75f3c03bd1b5b68bb273a92589155117c6dad8035fb4106c372244b547c02b934785c9551c5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2af5e68abdcf2acfd31ef19cacdf422445618f17ce60871ad5136d31154a28208012182db8e881cabb36392b946018fbda267ebbfaced717de61b37f8edeec90"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-19 10:33:06.191363) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 10:33:06.191945) ========= 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=9bfb7e13875ed353a705960e000001c0-1489943522.643716-1388367929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 10:33:06.273182) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-19 10:33:06.273512) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-19 10:33:06.273895) ========= ========= Total master_lag: 0.17 =========