builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1486085023.21 results: success (0) revision: c8102da699dba43d85eb80b70956e80c6793feca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 17:23:43.211089) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 17:23:43.211608) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 17:23:43.211920) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 17:23:43.229397) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 17:23:43.230182) ========= 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=523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-02 17:23:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.3M=0s 2017-02-02 17:23:43 (42.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131486 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 17:23:43.380601) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 17:23:43.381350) ========= 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=523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014561 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 17:23:43.432675) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-02 17:23:43.433032) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c8102da699dba43d85eb80b70956e80c6793feca --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 c8102da699dba43d85eb80b70956e80c6793feca --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=523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-02 17:23:43,695 truncating revision to first 12 chars 2017-02-02 17:23:43,695 Setting DEBUG logging. 2017-02-02 17:23:43,695 attempt 1/10 2017-02-02 17:23:43,695 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c8102da699db?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-02 17:23:44,431 unpacking tar archive at: mozilla-central-c8102da699db/testing/mozharness/ program finished with exit code 0 elapsedTime=1.028917 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-02 17:23:44.475023) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 17:23:44.475387) ========= script_repo_revision: c8102da699dba43d85eb80b70956e80c6793feca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 17:23:44.475832) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 17:23:44.476137) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 17:23:44.484737) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-02-02 17:23:44.485078) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:23:44 INFO - MultiFileLogger online at 20170202 17:23:44 in /builds/slave/test 17:23:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 17:23:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:23:44 INFO - {'append_to_log': False, 17:23:44 INFO - 'base_work_dir': '/builds/slave/test', 17:23:44 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:23:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:23:44 INFO - 'branch': 'Firefox-Non-PGO', 17:23:44 INFO - 'buildbot_json_path': 'buildprops.json', 17:23:44 INFO - 'config_files': ('talos/linux_config.py',), 17:23:44 INFO - 'default_actions': ('clobber', 17:23:44 INFO - 'read-buildbot-config', 17:23:44 INFO - 'download-and-extract', 17:23:44 INFO - 'populate-webroot', 17:23:44 INFO - 'create-virtualenv', 17:23:44 INFO - 'install', 17:23:44 INFO - 'run-tests'), 17:23:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:23:44 INFO - 'download_minidump_stackwalk': True, 17:23:44 INFO - 'download_symbols': 'ondemand', 17:23:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:23:44 INFO - 'tooltool.py': '/tools/tooltool.py', 17:23:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:23:44 INFO - '/tools/misc-python/virtualenv.py')}, 17:23:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:23:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:23:44 INFO - 'installer_path': 'installer.exe', 17:23:44 INFO - 'log_level': 'info', 17:23:44 INFO - 'log_name': 'talos', 17:23:44 INFO - 'log_to_console': True, 17:23:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:23:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:23:44 INFO - 'opt_config_files': (), 17:23:44 INFO - 'pip_index': False, 17:23:44 INFO - 'sps_profile': False, 17:23:44 INFO - 'sps_profile_interval': 0, 17:23:44 INFO - 'suite': 'dromaeojs', 17:23:44 INFO - 'system_bits': '32', 17:23:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:23:44 INFO - 'title': 'talos-linux64-ix-065', 17:23:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:23:44 INFO - 'use_talos_json': True, 17:23:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:23:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:23:44 INFO - 'work_dir': 'build'} 17:23:44 INFO - [mozharness: 2017-02-03 01:23:44.841987Z] Running clobber step. 17:23:44 INFO - Running pre-action listener: _resource_record_pre_action 17:23:44 INFO - Running main action method: clobber 17:23:44 INFO - rmtree: /builds/slave/test/build 17:23:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:23:45 INFO - Running post-action listener: _resource_record_post_action 17:23:45 INFO - [mozharness: 2017-02-03 01:23:45.301777Z] Finished clobber step (success) 17:23:45 INFO - [mozharness: 2017-02-03 01:23:45.301878Z] Running read-buildbot-config step. 17:23:45 INFO - Running pre-action listener: _resource_record_pre_action 17:23:45 INFO - Running main action method: read_buildbot_config 17:23:45 INFO - Using buildbot properties: 17:23:45 INFO - { 17:23:45 INFO - "project": "", 17:23:45 INFO - "product": "firefox", 17:23:45 INFO - "who": "kwierso@gmail.com", 17:23:45 INFO - "installer_path": "public/build/target.tar.bz2", 17:23:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:23:45 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:23:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 17:23:45 INFO - "stage_platform": "linux64", 17:23:45 INFO - "basedir": "/builds/slave/test", 17:23:45 INFO - "buildnumber": 425, 17:23:45 INFO - "platform": "ubuntu64_hw", 17:23:45 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:23:45 INFO - "slavebuilddir": "test", 17:23:45 INFO - "taskId": "ZVftLxp-SWe_Em6hDma8yg", 17:23:45 INFO - "branch": "mozilla-central", 17:23:45 INFO - "script_repo_revision": "production", 17:23:45 INFO - "revision": "c8102da699dba43d85eb80b70956e80c6793feca", 17:23:45 INFO - "slavename": "talos-linux64-ix-065", 17:23:45 INFO - "repo_path": "mozilla-central" 17:23:45 INFO - } 17:23:45 INFO - Finding installer, test and symbols from parent task. 17:23:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZVftLxp-SWe_Em6hDma8yg'}, attempt #1 17:23:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZVftLxp-SWe_Em6hDma8yg'}, attempt #1 17:23:46 INFO - Task dependencies: eKoSjl51RMuAlXDLo7KL_Q 17:23:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q'}, attempt #1 17:23:46 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/target.tar.bz2 17:23:46 INFO - Set test_url: https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/test_packages.json 17:23:46 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/target.crashreporter-symbols.zip 17:23:46 INFO - Running post-action listener: _resource_record_post_action 17:23:46 INFO - [mozharness: 2017-02-03 01:23:46.723808Z] Finished read-buildbot-config step (success) 17:23:46 INFO - [mozharness: 2017-02-03 01:23:46.724027Z] Running download-and-extract step. 17:23:46 INFO - Running pre-action listener: _resource_record_pre_action 17:23:46 INFO - Running main action method: download_and_extract 17:23:46 INFO - mkdir: /builds/slave/test/build/tests 17:23:46 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')]} 17:23:46 INFO - trying https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/target.test_packages.json 17:23:46 INFO - Downloading https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:23:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:23:47 INFO - Downloaded 896 bytes. 17:23:47 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:23:47 INFO - Using the following test package requirements: 17:23:47 INFO - {u'common': [u'target.common.tests.zip'], 17:23:47 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:23:47 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:23:47 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:23:47 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:23:47 INFO - u'mozbase': [u'target.common.tests.zip'], 17:23:47 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:23:47 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:23:47 INFO - u'web-platform': [u'target.common.tests.zip', 17:23:47 INFO - u'target.web-platform.tests.zip'], 17:23:47 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:23:47 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:23:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/target.common.tests.zip 17:23:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:23:47 INFO - Fetch https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/target.common.tests.zip into memory 17:23:50 INFO - Expected file size: 39900454 17:23:50 INFO - Obtained file size: 39900454 17:23:54 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:23:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/target.common.tests.zip 17:23:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:23:54 INFO - Fetch https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/target.common.tests.zip into memory 17:23:55 INFO - Expected file size: 39900454 17:23:55 INFO - Obtained file size: 39900454 17:24:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/target.talos.tests.zip 17:24:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:24:00 INFO - Fetch https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/target.talos.tests.zip into memory 17:24:01 INFO - Expected file size: 14403454 17:24:01 INFO - Obtained file size: 14403454 17:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:01 INFO - trying https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/target.tar.bz2 17:24:01 INFO - Downloading https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:24:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:24:05 INFO - Downloaded 56250226 bytes. 17:24:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/target.tar.bz2 17:24:05 INFO - mkdir: /builds/slave/test/properties 17:24:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:24:05 INFO - Writing to file /builds/slave/test/properties/build_url 17:24:05 INFO - Contents: 17:24:05 INFO - build_url:https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/target.tar.bz2 17:24:05 INFO - Running post-action listener: _resource_record_post_action 17:24:05 INFO - Running post-action listener: set_extra_try_arguments 17:24:05 INFO - [mozharness: 2017-02-03 01:24:05.654490Z] Finished download-and-extract step (success) 17:24:05 INFO - [mozharness: 2017-02-03 01:24:05.654716Z] Running populate-webroot step. 17:24:05 INFO - Running pre-action listener: _resource_record_pre_action 17:24:05 INFO - Running main action method: populate_webroot 17:24:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:24:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:24:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:24:05 INFO - '--tppagecycles', 17:24:05 INFO - '7'], 17:24:05 INFO - 'tests': ['tsvgm']}}, 17:24:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:24:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:24:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:24:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:24:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:24:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:24:05 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:24:05 INFO - 'talos_options': ['--disable-e10s'], 17:24:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:24:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:24:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:24:05 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:24:05 INFO - 'talos_options': ['--disable-e10s'], 17:24:05 INFO - 'tests': ['damp', 'tps']}, 17:24:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:24:05 INFO - 'tests': ['damp', 'tps']}, 17:24:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:24:05 INFO - 'tests': ['dromaeo_dom']}, 17:24:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:24:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:24:05 INFO - 'tests': ['basic_compositor_video']}, 17:24:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:24:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:24:05 INFO - 'tests': ['a11yr', 17:24:05 INFO - 'ts_paint', 17:24:05 INFO - 'tpaint', 17:24:05 INFO - 'sessionrestore', 17:24:05 INFO - 'sessionrestore_no_auto_restore', 17:24:05 INFO - 'tabpaint']}, 17:24:05 INFO - 'other-e10s': {'tests': ['a11yr', 17:24:05 INFO - 'ts_paint', 17:24:05 INFO - 'tpaint', 17:24:05 INFO - 'sessionrestore', 17:24:05 INFO - 'sessionrestore_no_auto_restore', 17:24:05 INFO - 'tabpaint']}, 17:24:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:24:05 INFO - 'ts_paint', 17:24:05 INFO - 'tpaint', 17:24:05 INFO - 'sessionrestore', 17:24:05 INFO - 'sessionrestore_no_auto_restore', 17:24:05 INFO - 'tabpaint']}, 17:24:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:24:05 INFO - 'ts_paint', 17:24:05 INFO - 'tpaint', 17:24:05 INFO - 'sessionrestore', 17:24:05 INFO - 'sessionrestore_no_auto_restore', 17:24:05 INFO - 'tabpaint']}, 17:24:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:24:05 INFO - 'tests': ['a11yr', 17:24:05 INFO - 'ts_paint', 17:24:05 INFO - 'tpaint', 17:24:05 INFO - 'sessionrestore', 17:24:05 INFO - 'sessionrestore_no_auto_restore', 17:24:05 INFO - 'tabpaint']}, 17:24:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:24:05 INFO - 'tests': ['a11yr', 17:24:05 INFO - 'ts_paint', 17:24:05 INFO - 'tpaint', 17:24:05 INFO - 'sessionrestore', 17:24:05 INFO - 'sessionrestore_no_auto_restore', 17:24:05 INFO - 'tabpaint']}, 17:24:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:24:05 INFO - 'tests': ['tsvgx', 17:24:05 INFO - 'tsvgr_opacity', 17:24:05 INFO - 'tart', 17:24:05 INFO - 'tscrollx', 17:24:05 INFO - 'cart', 17:24:05 INFO - 'tsvg_static']}, 17:24:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:24:05 INFO - 'tsvgr_opacity', 17:24:05 INFO - 'tart', 17:24:05 INFO - 'tscrollx', 17:24:05 INFO - 'cart', 17:24:05 INFO - 'tsvg_static']}, 17:24:05 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:24:05 INFO - 'talos_options': ['--disable-e10s'], 17:24:05 INFO - 'tests': ['tp5o']}, 17:24:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:24:05 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:24:05 INFO - 'talos_options': ['--disable-e10s', 17:24:05 INFO - '--xperf_path', 17:24:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:24:05 INFO - 'tests': ['tp5n']}, 17:24:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:24:05 INFO - 'talos_options': ['--xperf_path', 17:24:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:24:05 INFO - 'tests': ['tp5n']}}, 17:24:05 INFO - 'talos.zip': {'path': '', 17:24:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:24:05 INFO - Running post-action listener: _resource_record_post_action 17:24:05 INFO - [mozharness: 2017-02-03 01:24:05.669532Z] Finished populate-webroot step (success) 17:24:05 INFO - [mozharness: 2017-02-03 01:24:05.669626Z] Running create-virtualenv step. 17:24:05 INFO - Running pre-action listener: _resource_record_pre_action 17:24:05 INFO - Running main action method: create_virtualenv 17:24:05 INFO - Creating virtualenv /builds/slave/test/build/venv 17:24:05 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 17:24:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:24:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:24:05 INFO - Using real prefix '/usr' 17:24:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:24:06 INFO - Installing distribute.............................................................................................................................................................................................done. 17:24:08 INFO - Installing pip.................done. 17:24:08 INFO - Return code: 0 17:24:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:24:08 INFO - Reading from file tmpfile_stdout 17:24:08 INFO - Output received: 17:24:08 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) 17:24:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d8850>, '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 0x154d6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154db60>, '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': '523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571', '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 17:24:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:24:08 INFO - Using env: {'DISPLAY': ':0', 17:24:08 INFO - 'HOME': '/home/cltbld', 17:24:08 INFO - 'LANG': 'en_US.UTF-8', 17:24:08 INFO - 'LANGUAGE': 'en_US:en', 17:24:08 INFO - 'LOGNAME': 'cltbld', 17:24:08 INFO - 'MAIL': '/var/mail/cltbld', 17:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:08 INFO - 'MOZ_NO_REMOTE': '1', 17:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:08 INFO - 'NO_EM_RESTART': '1', 17:24:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:08 INFO - 'PWD': '/builds/slave/test', 17:24:08 INFO - 'SHELL': '/bin/bash', 17:24:08 INFO - 'SHLVL': '1', 17:24:08 INFO - 'TERM': 'linux', 17:24:08 INFO - 'TMOUT': '86400', 17:24:08 INFO - 'USER': 'cltbld', 17:24:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571', 17:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:08 INFO - '_': '/tools/buildbot/bin/python'} 17:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:08 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 17:24:08 INFO - Cleaning up... 17:24:08 INFO - Return code: 0 17:24:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d8850>, '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 0x154d6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154db60>, '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': '523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571', '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 17:24:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:24:08 INFO - Using env: {'DISPLAY': ':0', 17:24:08 INFO - 'HOME': '/home/cltbld', 17:24:08 INFO - 'LANG': 'en_US.UTF-8', 17:24:08 INFO - 'LANGUAGE': 'en_US:en', 17:24:08 INFO - 'LOGNAME': 'cltbld', 17:24:08 INFO - 'MAIL': '/var/mail/cltbld', 17:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:08 INFO - 'MOZ_NO_REMOTE': '1', 17:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:08 INFO - 'NO_EM_RESTART': '1', 17:24:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:08 INFO - 'PWD': '/builds/slave/test', 17:24:08 INFO - 'SHELL': '/bin/bash', 17:24:08 INFO - 'SHLVL': '1', 17:24:08 INFO - 'TERM': 'linux', 17:24:08 INFO - 'TMOUT': '86400', 17:24:08 INFO - 'USER': 'cltbld', 17:24:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571', 17:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:08 INFO - '_': '/tools/buildbot/bin/python'} 17:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:08 INFO - Downloading/unpacking psutil>=3.1.1 17:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:24:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:24:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:24:10 INFO - Installing collected packages: psutil 17:24:10 INFO - Running setup.py install for psutil 17:24:11 INFO - building 'psutil._psutil_linux' extension 17:24:11 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 17:24:11 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 17:24:11 INFO - building 'psutil._psutil_posix' extension 17:24:11 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 17:24:11 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 17:24:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:24:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:24:11 INFO - Successfully installed psutil 17:24:11 INFO - Cleaning up... 17:24:11 INFO - Return code: 0 17:24:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:24:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d8850>, '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 0x154d6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154db60>, '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': '523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571', '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 17:24:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:24:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:24:11 INFO - Using env: {'DISPLAY': ':0', 17:24:11 INFO - 'HOME': '/home/cltbld', 17:24:11 INFO - 'LANG': 'en_US.UTF-8', 17:24:11 INFO - 'LANGUAGE': 'en_US:en', 17:24:11 INFO - 'LOGNAME': 'cltbld', 17:24:11 INFO - 'MAIL': '/var/mail/cltbld', 17:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:11 INFO - 'MOZ_NO_REMOTE': '1', 17:24:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:11 INFO - 'NO_EM_RESTART': '1', 17:24:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:11 INFO - 'PWD': '/builds/slave/test', 17:24:11 INFO - 'SHELL': '/bin/bash', 17:24:11 INFO - 'SHLVL': '1', 17:24:11 INFO - 'TERM': 'linux', 17:24:11 INFO - 'TMOUT': '86400', 17:24:11 INFO - 'USER': 'cltbld', 17:24:11 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571', 17:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:11 INFO - '_': '/tools/buildbot/bin/python'} 17:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:24:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:24:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:24:13 INFO - Installing collected packages: mozsystemmonitor 17:24:13 INFO - Running setup.py install for mozsystemmonitor 17:24:13 INFO - Successfully installed mozsystemmonitor 17:24:13 INFO - Cleaning up... 17:24:14 INFO - Return code: 0 17:24:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:14 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 0x11dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d8850>, '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 0x154d6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154db60>, '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': '523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571', '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 17:24:14 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 17:24:14 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 17:24:14 INFO - Using env: {'DISPLAY': ':0', 17:24:14 INFO - 'HOME': '/home/cltbld', 17:24:14 INFO - 'LANG': 'en_US.UTF-8', 17:24:14 INFO - 'LANGUAGE': 'en_US:en', 17:24:14 INFO - 'LOGNAME': 'cltbld', 17:24:14 INFO - 'MAIL': '/var/mail/cltbld', 17:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:14 INFO - 'MOZ_NO_REMOTE': '1', 17:24:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:14 INFO - 'NO_EM_RESTART': '1', 17:24:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:14 INFO - 'PWD': '/builds/slave/test', 17:24:14 INFO - 'SHELL': '/bin/bash', 17:24:14 INFO - 'SHLVL': '1', 17:24:14 INFO - 'TERM': 'linux', 17:24:14 INFO - 'TMOUT': '86400', 17:24:14 INFO - 'USER': 'cltbld', 17:24:14 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571', 17:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:14 INFO - '_': '/tools/buildbot/bin/python'} 17:24:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:14 INFO - Downloading/unpacking jsonschema==2.5.1 17:24:14 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 17:24:14 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 17:24:14 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 17:24:14 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 17:24:14 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 17:24:14 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 17:24:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:24:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:24:16 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 17:24:16 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 17:24:16 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 17:24:16 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 17:24:16 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 17:24:16 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 17:24:16 INFO - Downloading functools32-3.2.3-2.tar.gz 17:24:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:24:16 INFO - warning: no files found matching '*.txt' 17:24:16 INFO - no previously-included directories found matching 'build' 17:24:16 INFO - no previously-included directories found matching 'dist' 17:24:16 INFO - no previously-included directories found matching '.git*' 17:24:16 INFO - Installing collected packages: jsonschema, functools32 17:24:16 INFO - Running setup.py install for functools32 17:24:16 INFO - warning: no files found matching '*.txt' 17:24:16 INFO - no previously-included directories found matching 'build' 17:24:16 INFO - no previously-included directories found matching 'dist' 17:24:16 INFO - no previously-included directories found matching '.git*' 17:24:16 INFO - Successfully installed jsonschema functools32 17:24:16 INFO - Cleaning up... 17:24:16 INFO - Return code: 0 17:24:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:16 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 0x11dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d8850>, '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 0x154d6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154db60>, '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': '523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571', '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 17:24:16 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 17:24:16 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 17:24:16 INFO - Using env: {'DISPLAY': ':0', 17:24:16 INFO - 'HOME': '/home/cltbld', 17:24:16 INFO - 'LANG': 'en_US.UTF-8', 17:24:16 INFO - 'LANGUAGE': 'en_US:en', 17:24:16 INFO - 'LOGNAME': 'cltbld', 17:24:16 INFO - 'MAIL': '/var/mail/cltbld', 17:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:16 INFO - 'MOZ_NO_REMOTE': '1', 17:24:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:16 INFO - 'NO_EM_RESTART': '1', 17:24:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:16 INFO - 'PWD': '/builds/slave/test', 17:24:16 INFO - 'SHELL': '/bin/bash', 17:24:16 INFO - 'SHLVL': '1', 17:24:16 INFO - 'TERM': 'linux', 17:24:16 INFO - 'TMOUT': '86400', 17:24:16 INFO - 'USER': 'cltbld', 17:24:16 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571', 17:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:16 INFO - '_': '/tools/buildbot/bin/python'} 17:24:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:24:16 INFO - Cleaning up... 17:24:16 INFO - Return code: 0 17:24:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:16 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 0x11dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d8850>, '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 0x154d6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154db60>, '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': '523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571', '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 17:24:16 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 17:24:16 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 17:24:16 INFO - Using env: {'DISPLAY': ':0', 17:24:16 INFO - 'HOME': '/home/cltbld', 17:24:16 INFO - 'LANG': 'en_US.UTF-8', 17:24:16 INFO - 'LANGUAGE': 'en_US:en', 17:24:16 INFO - 'LOGNAME': 'cltbld', 17:24:16 INFO - 'MAIL': '/var/mail/cltbld', 17:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:16 INFO - 'MOZ_NO_REMOTE': '1', 17:24:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:16 INFO - 'NO_EM_RESTART': '1', 17:24:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:16 INFO - 'PWD': '/builds/slave/test', 17:24:16 INFO - 'SHELL': '/bin/bash', 17:24:16 INFO - 'SHLVL': '1', 17:24:16 INFO - 'TERM': 'linux', 17:24:16 INFO - 'TMOUT': '86400', 17:24:16 INFO - 'USER': 'cltbld', 17:24:16 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571', 17:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:16 INFO - '_': '/tools/buildbot/bin/python'} 17:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:17 INFO - Downloading/unpacking blobuploader==1.2.4 17:24:17 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 17:24:17 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 17:24:17 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 17:24:17 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 17:24:17 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 17:24:17 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 17:24:19 INFO - Downloading blobuploader-1.2.4.tar.gz 17:24:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:24:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:24:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:19 INFO - Downloading docopt-0.6.1.tar.gz 17:24:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:24:20 INFO - Installing collected packages: blobuploader, requests, docopt 17:24:20 INFO - Running setup.py install for blobuploader 17:24:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:24:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:24:20 INFO - Running setup.py install for requests 17:24:20 INFO - Running setup.py install for docopt 17:24:20 INFO - Successfully installed blobuploader requests docopt 17:24:20 INFO - Cleaning up... 17:24:20 INFO - Return code: 0 17:24:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:20 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 0x11dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d8850>, '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 0x154d6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154db60>, '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': '523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571', '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 17:24:20 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 17:24:20 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 17:24:20 INFO - Using env: {'DISPLAY': ':0', 17:24:20 INFO - 'HOME': '/home/cltbld', 17:24:20 INFO - 'LANG': 'en_US.UTF-8', 17:24:20 INFO - 'LANGUAGE': 'en_US:en', 17:24:20 INFO - 'LOGNAME': 'cltbld', 17:24:20 INFO - 'MAIL': '/var/mail/cltbld', 17:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:20 INFO - 'MOZ_NO_REMOTE': '1', 17:24:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:20 INFO - 'NO_EM_RESTART': '1', 17:24:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:20 INFO - 'PWD': '/builds/slave/test', 17:24:20 INFO - 'SHELL': '/bin/bash', 17:24:20 INFO - 'SHLVL': '1', 17:24:20 INFO - 'TERM': 'linux', 17:24:20 INFO - 'TMOUT': '86400', 17:24:20 INFO - 'USER': 'cltbld', 17:24:20 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571', 17:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:20 INFO - '_': '/tools/buildbot/bin/python'} 17:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:24:20 INFO - Running setup.py (path:/tmp/pip-JglKnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:24:20 INFO - Running setup.py (path:/tmp/pip-mldPRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:24:20 INFO - Running setup.py (path:/tmp/pip-XVuPhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:24:21 INFO - Running setup.py (path:/tmp/pip-coKfC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:24:21 INFO - Running setup.py (path:/tmp/pip-NZBQtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:24:21 INFO - Running setup.py (path:/tmp/pip-S4r83I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:24:21 INFO - Running setup.py (path:/tmp/pip-uC_rpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:24:21 INFO - Running setup.py (path:/tmp/pip-rfmD1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:24:21 INFO - Running setup.py (path:/tmp/pip-XOplN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:24:21 INFO - Running setup.py (path:/tmp/pip-alaVNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:24:21 INFO - Running setup.py (path:/tmp/pip-aAVKLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:24:21 INFO - Running setup.py (path:/tmp/pip-wmTZ0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:24:21 INFO - Running setup.py (path:/tmp/pip-G_7rjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:24:21 INFO - Running setup.py (path:/tmp/pip-R_y1KB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:21 INFO - Running setup.py (path:/tmp/pip-ZDPDIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:24:21 INFO - Running setup.py (path:/tmp/pip-0CkgQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:24:21 INFO - Running setup.py (path:/tmp/pip-R7Xwwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:24:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:24:22 INFO - Running setup.py install for manifestparser 17:24:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:24:22 INFO - Running setup.py install for mozcrash 17:24:22 INFO - Running setup.py install for mozdebug 17:24:22 INFO - Running setup.py install for mozdevice 17:24:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:24:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:24:22 INFO - Running setup.py install for mozfile 17:24:22 INFO - Running setup.py install for mozhttpd 17:24:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:24:22 INFO - Running setup.py install for mozinfo 17:24:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:24:22 INFO - Running setup.py install for mozInstall 17:24:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:24:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:24:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:24:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:24:22 INFO - Running setup.py install for mozleak 17:24:22 INFO - Running setup.py install for mozlog 17:24:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:24:23 INFO - Running setup.py install for moznetwork 17:24:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:24:23 INFO - Running setup.py install for mozprocess 17:24:23 INFO - Running setup.py install for mozprofile 17:24:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:24:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:24:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:24:23 INFO - Running setup.py install for mozrunner 17:24:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:24:23 INFO - Running setup.py install for mozscreenshot 17:24:23 INFO - Running setup.py install for moztest 17:24:23 INFO - Running setup.py install for mozversion 17:24:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:24:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:24:23 INFO - Cleaning up... 17:24:23 INFO - Return code: 0 17:24:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:24:23 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')]} 17:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:23 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')]} 17:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:23 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 0x11dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d8850>, '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 0x154d6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154db60>, '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': '523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571', '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 17:24:23 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 17:24:23 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 17:24:23 INFO - Using env: {'DISPLAY': ':0', 17:24:23 INFO - 'HOME': '/home/cltbld', 17:24:23 INFO - 'LANG': 'en_US.UTF-8', 17:24:23 INFO - 'LANGUAGE': 'en_US:en', 17:24:23 INFO - 'LOGNAME': 'cltbld', 17:24:23 INFO - 'MAIL': '/var/mail/cltbld', 17:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:23 INFO - 'MOZ_NO_REMOTE': '1', 17:24:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:23 INFO - 'NO_EM_RESTART': '1', 17:24:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:23 INFO - 'PWD': '/builds/slave/test', 17:24:23 INFO - 'SHELL': '/bin/bash', 17:24:23 INFO - 'SHLVL': '1', 17:24:23 INFO - 'TERM': 'linux', 17:24:23 INFO - 'TMOUT': '86400', 17:24:23 INFO - 'USER': 'cltbld', 17:24:23 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571', 17:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:23 INFO - '_': '/tools/buildbot/bin/python'} 17:24:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:24:24 INFO - Running setup.py (path:/tmp/pip-yeLoU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:24:24 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)) 17:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:24:24 INFO - Running setup.py (path:/tmp/pip-CkPeTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:24:24 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)) 17:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:24:24 INFO - Running setup.py (path:/tmp/pip-BxO8P_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:24:24 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)) 17:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:24:24 INFO - Running setup.py (path:/tmp/pip-OcSVvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:24:24 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)) 17:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:24:24 INFO - Running setup.py (path:/tmp/pip-lxhW1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:24:24 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)) 17:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:24:24 INFO - Running setup.py (path:/tmp/pip-TgQpGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:24:24 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)) 17:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:24:24 INFO - Running setup.py (path:/tmp/pip-4lnZ78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:24:24 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)) 17:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:24:24 INFO - Running setup.py (path:/tmp/pip-RUIHIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:24:24 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)) 17:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:24:24 INFO - Running setup.py (path:/tmp/pip-120Oqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:24:24 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)) 17:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:24:24 INFO - Running setup.py (path:/tmp/pip-pGCw5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:24:24 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)) 17:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:24:24 INFO - Running setup.py (path:/tmp/pip-ybba5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:24:24 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)) 17:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:24:24 INFO - Running setup.py (path:/tmp/pip-zD8YHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:24:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 17:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:24:24 INFO - Running setup.py (path:/tmp/pip-WQhU5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:24:25 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)) 17:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:24:25 INFO - Running setup.py (path:/tmp/pip-qNLUfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:24:25 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)) 17:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:25 INFO - Running setup.py (path:/tmp/pip-Do5Nj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:25 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)) 17:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:24:25 INFO - Running setup.py (path:/tmp/pip-Y9L1Xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:24:25 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)) 17:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:24:25 INFO - Running setup.py (path:/tmp/pip-sMZA2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:24:25 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)) 17:24:25 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)) 17:24:25 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)) 17:24:25 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)) 17:24:25 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)) 17:24:25 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)) 17:24:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:24:25 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 17:24:25 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 17:24:25 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 17:24:25 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 17:24:25 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 17:24:25 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 17:24:27 INFO - Downloading blessings-1.6.tar.gz 17:24:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:24:27 INFO - Installing collected packages: blessings 17:24:27 INFO - Running setup.py install for blessings 17:24:27 INFO - Successfully installed blessings 17:24:27 INFO - Cleaning up... 17:24:27 INFO - Return code: 0 17:24:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:24:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:24:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:24:27 INFO - Reading from file tmpfile_stdout 17:24:27 INFO - Current package versions: 17:24:27 INFO - argparse == 1.2.1 17:24:27 INFO - blessings == 1.6 17:24:27 INFO - blobuploader == 1.2.4 17:24:27 INFO - docopt == 0.6.1 17:24:27 INFO - functools32 == 3.2.3-2 17:24:27 INFO - jsonschema == 2.5.1 17:24:27 INFO - manifestparser == 1.1 17:24:27 INFO - mozInstall == 1.12 17:24:27 INFO - mozcrash == 1.0 17:24:27 INFO - mozdebug == 0.1 17:24:27 INFO - mozdevice == 0.49 17:24:27 INFO - mozfile == 1.2 17:24:27 INFO - mozhttpd == 0.7 17:24:27 INFO - mozinfo == 0.9 17:24:27 INFO - mozleak == 0.1 17:24:27 INFO - mozlog == 3.4 17:24:27 INFO - moznetwork == 0.27 17:24:27 INFO - mozprocess == 0.24 17:24:27 INFO - mozprofile == 0.28 17:24:27 INFO - mozrunner == 6.13 17:24:27 INFO - mozscreenshot == 0.1 17:24:27 INFO - mozsystemmonitor == 0.3 17:24:27 INFO - moztest == 0.8 17:24:27 INFO - mozversion == 1.4 17:24:27 INFO - psutil == 3.1.1 17:24:27 INFO - requests == 1.2.3 17:24:27 INFO - wsgiref == 0.1.2 17:24:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:24:27 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')]} 17:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:27 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')]} 17:24:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:27 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 0x11dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d8850>, '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 0x154d6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154db60>, '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': '523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571', '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 17:24:27 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 17:24:27 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 17:24:27 INFO - Using env: {'DISPLAY': ':0', 17:24:27 INFO - 'HOME': '/home/cltbld', 17:24:27 INFO - 'LANG': 'en_US.UTF-8', 17:24:27 INFO - 'LANGUAGE': 'en_US:en', 17:24:27 INFO - 'LOGNAME': 'cltbld', 17:24:27 INFO - 'MAIL': '/var/mail/cltbld', 17:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:27 INFO - 'MOZ_NO_REMOTE': '1', 17:24:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:27 INFO - 'NO_EM_RESTART': '1', 17:24:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:27 INFO - 'PWD': '/builds/slave/test', 17:24:27 INFO - 'SHELL': '/bin/bash', 17:24:27 INFO - 'SHLVL': '1', 17:24:27 INFO - 'TERM': 'linux', 17:24:27 INFO - 'TMOUT': '86400', 17:24:27 INFO - 'USER': 'cltbld', 17:24:27 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571', 17:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:27 INFO - '_': '/tools/buildbot/bin/python'} 17:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:28 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)) 17:24:28 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)) 17:24:28 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)) 17:24:28 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)) 17:24:28 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)) 17:24:28 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)) 17:24:28 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)) 17:24:28 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)) 17:24:28 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)) 17:24:28 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)) 17:24:28 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)) 17:24:28 INFO - Cleaning up... 17:24:28 INFO - Return code: 0 17:24:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:24:28 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')]} 17:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:28 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')]} 17:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:28 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 0x11dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d8850>, '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 0x154d6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154db60>, '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': '523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571', '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 17:24:28 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 17:24:28 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 17:24:28 INFO - Using env: {'DISPLAY': ':0', 17:24:28 INFO - 'HOME': '/home/cltbld', 17:24:28 INFO - 'LANG': 'en_US.UTF-8', 17:24:28 INFO - 'LANGUAGE': 'en_US:en', 17:24:28 INFO - 'LOGNAME': 'cltbld', 17:24:28 INFO - 'MAIL': '/var/mail/cltbld', 17:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:28 INFO - 'MOZ_NO_REMOTE': '1', 17:24:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:28 INFO - 'NO_EM_RESTART': '1', 17:24:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:28 INFO - 'PWD': '/builds/slave/test', 17:24:28 INFO - 'SHELL': '/bin/bash', 17:24:28 INFO - 'SHLVL': '1', 17:24:28 INFO - 'TERM': 'linux', 17:24:28 INFO - 'TMOUT': '86400', 17:24:28 INFO - 'USER': 'cltbld', 17:24:28 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571', 17:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:28 INFO - '_': '/tools/buildbot/bin/python'} 17:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:24:28 INFO - Cleaning up... 17:24:28 INFO - Return code: 0 17:24:28 INFO - Running post-action listener: _resource_record_post_action 17:24:28 INFO - Running post-action listener: _start_resource_monitoring 17:24:28 INFO - Starting resource monitoring. 17:24:28 INFO - [mozharness: 2017-02-03 01:24:28.278636Z] Finished create-virtualenv step (success) 17:24:28 INFO - [mozharness: 2017-02-03 01:24:28.279096Z] Running install step. 17:24:28 INFO - Running pre-action listener: _resource_record_pre_action 17:24:28 INFO - Running main action method: install 17:24:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:24:28 INFO - Reading from file tmpfile_stdout 17:24:28 INFO - Detecting whether we're running mozinstall >=1.0... 17:24:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:24:28 INFO - Reading from file tmpfile_stdout 17:24:28 INFO - Output received: 17:24:28 INFO - Usage: mozinstall [options] installer 17:24:28 INFO - Options: 17:24:28 INFO - -h, --help show this help message and exit 17:24:28 INFO - -d DEST, --destination=DEST 17:24:28 INFO - Directory to install application into. [default: 17:24:28 INFO - "/builds/slave/test"] 17:24:28 INFO - --app=APP Application being installed. [default: firefox] 17:24:28 INFO - mkdir: /builds/slave/test/build/application 17:24:28 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'] 17:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:24:44 INFO - Reading from file tmpfile_stdout 17:24:44 INFO - Output received: 17:24:44 INFO - /builds/slave/test/build/application/firefox/firefox 17:24:44 INFO - Running post-action listener: _resource_record_post_action 17:24:44 INFO - [mozharness: 2017-02-03 01:24:44.831943Z] Finished install step (success) 17:24:44 INFO - [mozharness: 2017-02-03 01:24:44.832218Z] Running run-tests step. 17:24:44 INFO - Running pre-action listener: _resource_record_pre_action 17:24:44 INFO - Running main action method: run_tests 17:24:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:24:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:24:44 INFO - Python 2.7.3 17:24:44 INFO - Return code: 0 17:24:44 INFO - grabbing minidump binary from tooltool 17:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:44 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 0x15d8850>, '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 0x154d6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154db60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:24:44 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 17:24:44 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 17:24:44 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 17:24:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:24:44 INFO - Return code: 0 17:24:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:24:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:24:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:24:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:24:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:24:44 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:24:44 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:24:44 INFO - Using env: {'DISPLAY': ':0', 17:24:44 INFO - 'HOME': '/home/cltbld', 17:24:44 INFO - 'LANG': 'en_US.UTF-8', 17:24:44 INFO - 'LANGUAGE': 'en_US:en', 17:24:44 INFO - 'LOGNAME': 'cltbld', 17:24:44 INFO - 'MAIL': '/var/mail/cltbld', 17:24:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:24:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:44 INFO - 'MOZ_NO_REMOTE': '1', 17:24:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:24:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:44 INFO - 'NO_EM_RESTART': '1', 17:24:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:44 INFO - 'PWD': '/builds/slave/test', 17:24:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:24:44 INFO - 'SHELL': '/bin/bash', 17:24:44 INFO - 'SHLVL': '1', 17:24:44 INFO - 'TERM': 'linux', 17:24:44 INFO - 'TMOUT': '86400', 17:24:44 INFO - 'USER': 'cltbld', 17:24:44 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571', 17:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:44 INFO - '_': '/tools/buildbot/bin/python'} 17:24:44 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:24:45 INFO - mozversion application_buildid: 20170203003930 17:24:45 INFO - mozversion application_changeset: c8102da699dba43d85eb80b70956e80c6793feca 17:24:45 INFO - mozversion application_display_name: Nightly 17:24:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:24:45 INFO - mozversion application_name: Firefox 17:24:45 INFO - mozversion application_remotingname: firefox 17:24:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:24:45 INFO - mozversion application_vendor: Mozilla 17:24:45 INFO - mozversion application_version: 54.0a1 17:24:45 INFO - mozversion platform_buildid: 20170203003930 17:24:45 INFO - mozversion platform_changeset: c8102da699dba43d85eb80b70956e80c6793feca 17:24:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:24:45 INFO - mozversion platform_version: 54.0a1 17:24:45 INFO - using testdate: 1486085085 17:24:45 INFO - actual date: 1486085085 17:24:45 INFO - starting webserver on 'localhost:38899' 17:24:45 INFO - SUITE-START | Running 2 tests 17:24:45 INFO - TEST-START | dromaeo_css 17:24:45 INFO - operating with platform_type : linux_ 17:24:45 INFO - Initialising browser for dromaeo_css test... 17:24:45 INFO - TEST-INFO | started process 31311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe4SlvY/profile http://localhost:38899/getInfo.html) 17:24:48 INFO - PROCESS | 31311 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 17:24:49 INFO - PROCESS | 31311 | __metrics Screen width/height:1600/1200 17:24:49 INFO - PROCESS | 31311 | colorDepth:24 17:24:49 INFO - PROCESS | 31311 | Browser inner width/height: 1024/697 17:24:49 INFO - PROCESS | 31311 | __metrics 17:24:49 INFO - PROCESS | 31311 | 1486085089611 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 17:24:49 INFO - PROCESS | 31311 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:24:49 INFO - PROCESS | 31311 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:24:50 INFO - PROCESS | 31311 | console.error: PushService: 17:24:50 INFO - PROCESS | 31311 | stateChangeProcessEnqueue: Error transitioning state 17:24:50 INFO - PROCESS | 31311 | UnknownError 17:24:50 INFO - TEST-INFO | 31311: exit 0 17:24:50 INFO - Browser initialized. 17:24:50 INFO - Running cycle 1/1 for dromaeo_css test... 17:24:50 INFO - TEST-INFO | started process 31393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe4SlvY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:25:02 INFO - PROCESS | 31393 | RSS: Main: 154640384 17:25:02 INFO - PROCESS | 31393 | 17:28:07 INFO - PROCESS | 31393 | Cycle 1(1): loaded http://localhost:38899/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38899/tests/dromaeo/cssquery-ext.html) 17:28:08 INFO - PROCESS | 31393 | RSS: Main: 262516736 17:28:08 INFO - PROCESS | 31393 | 17:29:52 INFO - PROCESS | 31393 | ************************* 17:29:52 INFO - PROCESS | 31393 | A coding exception was thrown and uncaught in a Task. 17:29:52 INFO - PROCESS | 31393 | 17:29:52 ERROR - PROCESS | 31393 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:29:52 INFO - PROCESS | 31393 | Full stack: 17:29:52 INFO - PROCESS | 31393 | ************************* 17:31:11 INFO - PROCESS | 31393 | Cycle 1(1): loaded http://localhost:38899/tests/dromaeo/cssquery-ext.html (next: http://localhost:38899/tests/dromaeo/cssquery-jquery.html) 17:31:12 INFO - PROCESS | 31393 | RSS: Main: 241201152 17:31:12 INFO - PROCESS | 31393 | 17:34:14 INFO - PROCESS | 31393 | Cycle 1(1): loaded http://localhost:38899/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38899/tests/dromaeo/cssquery-mootools.html) 17:34:14 INFO - PROCESS | 31393 | RSS: Main: 187969536 17:34:14 INFO - PROCESS | 31393 | 17:37:17 INFO - PROCESS | 31393 | Cycle 1(1): loaded http://localhost:38899/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38899/tests/dromaeo/cssquery-prototype.html) 17:37:17 INFO - PROCESS | 31393 | RSS: Main: 189517824 17:37:17 INFO - PROCESS | 31393 | 17:40:20 INFO - PROCESS | 31393 | Cycle 1(1): loaded http://localhost:38899/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38899/tests/dromaeo/cssquery-yui.html) 17:40:21 INFO - PROCESS | 31393 | RSS: Main: 188526592 17:40:21 INFO - PROCESS | 31393 | 17:43:24 INFO - PROCESS | 31393 | Cycle 1(1): loaded http://localhost:38899/tests/dromaeo/cssquery-yui.html (next: http://localhost:38899/tests/dromaeo/cssquery-dojo.html) 17:43:24 INFO - PROCESS | 31393 | RSS: Main: 288989184 17:43:24 INFO - PROCESS | 31393 | 17:43:24 INFO - PROCESS | 31393 | __start_tp_report 17:43:24 INFO - PROCESS | 31393 | _x_x_mozilla_page_load 17:43:24 INFO - PROCESS | 31393 | _x_x_mozilla_page_load_details 17:43:24 INFO - PROCESS | 31393 | |i|pagename|runs| 17:43:24 INFO - PROCESS | 31393 | |0;dojo.html;2493.90024399024;2521.168014555197;2527.140772137473;2550.77043066124;2556.9488610227786;4475.1944649963;4539.614132798708;4600.930986035212;4612.677112602119;4644.744539050351;4562.634989200864;4589.059242855215;4593.219152744033;4606.355110284554;4653.534646535345;4125.8968525786795;4218.240716670998;4274.487061552611;4327.199468098396;4341.45731783527;4283.079137985333;4339.739615623057;4352.129574085196;4360.520342762294;4387.276099443604;4160.251154792136;4208.705390622657;4222.704410691253;4251.319788833772;4264.168487145008;4262.445882035347;4268.509121451042;4275.957240427587;4307.741535507848;4320.783960801948;4246.681498887596;4259.254630439661;4262.573742625713;4284.228838809013;4286.099919016979;4436.933445998313;4468.8882777930485;4574.451065872084;4643.442786865564;4666.136764698542;4928.876778080541;5005.6496045276845;5006.299118123466;5009.799608015675;5011.949880501184;4965.627577931669;4966.180580204262;4984.22744474607;4985.750712464399;5031.547160755549;4665.930011049837;4667.766611669369;4669.019505903798;4674.719516829001;4713.622910167179;4881.658283920092;4928.236123400879;4935.654504184745;4946.183879659816;4947.307376967227;4757.381540399795;4759.904801904012;4762.59517940972;4780.211265141283;4813.927791083137;4836.516348365135;4844.878878028077;4910.975445122752;4913.115639184981;4958.628102892298;4797.280407938767;4826.444958829779;4882.5605695486865;4883.51164883516;4931.013797240495;4829.879253018632;4840.854774356775;4864.36763220779;4886.047220791983;4954.083494553519;4253;4254.510731265944;4254.914901701949;4258.5954334338185;4301.290287102593;3669.229461812996;3682.1531047858607;3688.133288677159;3706.166112624692;3718.163413232055;4196.706230563831;4234.978825105916;4269.252880745857;4277.230098582223;4301.376300436419;4926.679765815211;4928.211486162197;4937.308776771255;4944.134776414185;4966.329545511382;4239.89762661704;4274.401583778274;4279.058607106432;4279.7646129462555;4294.549072347421;4367;4431.379606855043;4441.022974945507;4442.289233722653;4474.574915383034;4636.095961287651;4640.141573808856;4654.557817007379;4667.509911459316;4677.2750223715375;4806.014766972832;4853.102176097434;4965.354503914468;4970.776315065758;5022.146235140108;4576.702514336557;4580.404547408815;4583.427071616048;4584.35818985349;4591;4782.713037217778;4830.806767729251;4831.541003604652;4833.854984350334;4834.129856625841;4873.951260487492;4901.14230009754;4916.926246106383;4917.852464426073;4919.237518184687;4741.122892264942;4744.169770290255;4744.359511466046;4752.049590081929;4762.404699412574;4704.870831000604;4717.9056418872115;4720.740359280273;4759.857204283877;4798.808047678054;4723.527647235249;4739.265413860857;4740.4785473597185;4761.357216775691;4780.163471392562;4813.374261346003;4824.252240902666;4826.710397376169;4829.806807727651;4865.732384718733;4573.039661670953;4621.79201935907;4669.7431641260055;4721.929171062368;4753.83361582343 17:43:24 INFO - PROCESS | 31393 | |1;ext.html;538.9893948845914;561.8735784448498;563.1833840930649;566.9036263835151;580.9564282678795;30455.695443045563;41425;42994.57005429949;43174.13651726964;47217.52782472183;42314.15371692572;42675.14649707004;42764.358534622006;42821.35767963483;42849.35725964105;7466.178720340758;7818.530888146715;7992.520448773063;7996.24035716606;7996.760097197093;7515.286047825448;10185.745356366113;10430.895691043106;10440.373577585331;10711.625093121742;10417.739556511073;10475.109615682675;10488.632897848576;10489.423081730502;10491.58033678652;10326.432046237454;10385.169186465064;10399.272050956437;10401.791964160675;10408.323458975143;10170.338927969658;10238.53926573306;10252.538635761408;10252.74368140795;10264.076233138978;40766.18467630631;41147.58852411497;41150.38274425886;41186.794066029775;41218.1756364874;3570.892873213808;3668.3213605482806;3681.7054635629083;3682.097886017916;3688.409854423306;29642;30245.395092098253;30572.54141187884;30634.387312253853;30834.53748193779;3283.5238890360765;3314.5691060162026;3340.081477593657;3431.1422144463886;3444.4144495435585;237519;237599;238594;238763;239991;49994;50318.496815032115;50346.74826625844;54246.72876635592;55979;60365;61849.69075154595;61870.38129618646;66947.3305266941;67859.32140678629;15835.366585336687;15979.920100399657;15989.920050399905;15994.76007859883;16014.919925400298;11969.46137423818;12050.698732531757;12078.275303481643;12086.274823510617;12088.456019479145;16551.83448165503;17017.31930722782;17895.642087158445;18326.633467330845;18433.815661843477;6490.837729056811;6559.311272316433;6584.473242140617;6717.361850624183;6778;791.7070683847013;804.7706403675041;808.9797755056171;814.4380377539597;838.4005436113208;26755;27577.207481513637;28270.71729282722;28335;28448.573271400946;885.1367870632355;971.4608392342318;981.4454833019321;982.4891056650501;997.2919227348518;14656.706865862836;14988.925055374653;15177.696446071237;15216.391344346324;15394;322377;324614;325401;325588;326321;50920.23619645708;50978.490215098114;51000;51084;51088.233676494885;1180.3095189314176;1234.7715672600598;1243.0801207106856;1244.0918129765323;1249.787536118862;26114.477710446066;27068.32329191786;27309.590356145072;27717.307067322672;27883.302917427227;43042.56957430386;43616.56383436125;43642;43659.12681746411;43682.563174367846;273179;274085;275062;275231;275557;35493.29013419666;36331.636683633886;36691.44962825613;36702.63297366992;36767.264654707295;39392.80303598464;39988.800055999534;40028.59971400365;40179.39730903981;40667.59332406638;34060.82969585136;34144.14639634029;34205.48691769576;34269;34371.82814086013;33742;34233.144171395914;34479;35646.64353356433;35882.28235435329;33579.3284134311;33892.49161262534;33938;34237;34637.48043779396;26819.463610728068;27728.168154955383;28341;28422.289442764097;28551.286217843888;23360.53278934378;23539.17612883541;23579.360867387364;23835.880820595787;24109.276721698378 17:43:24 INFO - PROCESS | 31393 | |2;jquery.html;354.2843456218437;366.22177872021956;387.25453502008634;391.62208468827583;410.93835924611307;13480.123791953529;17285.82714172858;18121.184546695396;19107.617847643072;19300.324488642902;17601.29594816209;17706.911465442656;18391;18400.26398944044;19206.135723892425;4697.7651117444075;4938.061768264036;4940.110780059588;4949.975250123744;4970.15507363749;3583.587887392944;3697.1496555792182;4810.855674329776;4879.6828206166665;4880.292357608162;4006.4190692349594;4048.7570745755347;6380.234371875382;6480.773172938948;6493.058506516552;6258.906116408258;6263.467605253559;6392.23293204816;6470.191226096738;6472.644004579723;5661.943380566183;5666.263385759866;5668.064769313059;5676.403977582336;5679.488846003838;22036;22149.778502214933;22830.657540136912;22924.54150916989;22976.88511557448;2254.5716313900307;2313.884305784704;2383.7377888432256;2398.8560686358874;2471.3327401601646;9218.124278193562;9682.806343873082;9695.90304096964;9769.951150244275;13587.864121358758;1667.4914151183884;1690.4252554131654;1716.5880188754734;1726.3008481564987;1735.6268402293442;79849.60075199587;82724.17275827225;82976.58511707463;84110.57944710237;84266.57866710688;10798.244122911321;10985.835212471819;10994;11039.821156866808;11090.223684342018;15497.845021549865;15514.146721930176;15531.223438828014;15538.06771593708;15554.22228888551;7567.621618919032;7630;7818.7654370367845;7901.367890568741;7913.604319783988;7157.785266442015;7190.316919892602;7238.0952380952385;7413.66638501258;7432.033835601337;4623.86128416148;4629.777706700803;4788.401449818773;4847.297141914402;4898.951010489921;1856.7214917762444;1932.7294178814977;1940.5245714799964;1998.510364960594;2006.709027191049;725.1733024352243;744.3747252308087;753;754.1741792736944;767.2021098058069;17255.3960611378;17395.04327262013;18427.26290948347;19999.60000800005;20555.794442055387;864.5907171310723;871.302957633903;873.3057219510505;887.4187407248263;892.2237653241591;9760.658376956773;9820.165285950774;10061.748456288651;10092.142167915663;10176.643817466502;480542.19457804976;495623;506672;506853;509238;99930.5003474978;101535;101668.49165754272;104980;107995.46002269938;934.3086116273909;979.3732011512637;999.9950000250097;1003.3377970539555;1003.5885287032281;15082.472113475975;15272;15427.460038898585;15761.448349307719;16123.516294511184;36855;42928.57071429246;43086.01306666905;43583;44261.77869110634;44225.33661995137;54939.45060549343;55183.72408137934;56173.71913140408;56747.432525674216;7806.297433231037;7830.92169078302;7894.1316455188735;7967.2431119043595;8339.583020849055;10317.48412579353;11889.583864564698;12153.392330383622;12566.371681416076;13006.479740810262;5350.571954243729;6974.755883544051;8489.514334991229;9827.164691001344;10293.330933489298;10602.363858168535;10829.133669306595;10888.237823352289;10921.290116142425;11130.666080017612;6707.396334329934;9574.808503829745;9903.801923961624;10422.009909058628;10593.205509586658;6943.340382663639;7092.680829362795;7203.603801790951;7394.8890766639615;8052.194780521901;8549.871751923602;9796.461194634363;9895.406275623485;10158.08577228053;10444.216683748597 17:43:24 INFO - PROCESS | 31393 | |3;mootools.html;1298.7921932490801;1308.659748465399;1320.115522599858;1332.0475859760281;1341.9060665753402;6946.687399067041;7266.237045110253;7301.6714247858845;7377.188509263977;7377.299156580129;6928.411085057776;7094.396976257011;7171.784846454601;7174.282571742836;7319.926800732004;2074.0459388681224;2105.4104850641843;2107.9683804742863;2109.377733568593;2109.9050542725536;2008.4875103462489;2092.4559614500185;2099.4121645939163;2101.7477902651704;2102.4008157675066;1749.658816530777;1832.285408690605;1979.3270288102042;2043.1316690406593;2052.5997430501056;2084.9166033358647;2100.24391219161;2100.306898723433;2104.537001859596;2105.557832855087;1792.3010026089835;2069.3481553310658;2141.817945474621;2143.5498545305504;2146.356093172042;6371.33101024395;7158.892616610755;7422.443316751212;7440.181580026193;7615.695372185106;4433.556644335573;4534.705244159152;4551.749653769041;4557.134144512532;4564.7717614119165;2675.4114094899287;2800.8879644814183;2815.0428854189468;2836.2200394891365;2844.2747099489707;1099.367863478495;1113.4210210690396;1122.2312715789628;1122.360254654847;1160.14729174057;9850.605975761033;9953;9967.202623790079;9968.102870741668;9968.950155249177;3787;3951.3677811550015;4005.4792876925812;4010.258102251093;4016.096378314914;7975.7607271781935;7979.162187970295;7983.081945576217;7984.6806127754235;7996.960015199887;4525.977370113194;4526.072155208174;4527.139843429738;4531.614812740888;4531.954680453153;4018.9397159042637;4123.299039163349;4162.458880345535;4181.60274773896;4193.203291374629;3358.1604598850286;3396.626371099177;3479.8086105263947;3495.545579074704;3503;1048.6928756735213;1063.1547919404093;1066.072516910293;1068.038765111406;1074.4681382715605;782.6321628834439;805.287320721166;807.1403954788132;815.4699445360444;815.8449894520022;4713.175194340976;4742.478327383985;4854.344663470386;4856.757162141949;5148.407933087743;513.2327170879558;522.6994478175064;522.8013354925104;524.8425472358354;540.9053415652245;3304.619968703582;3361.2941282330985;3388.9661103389144;3391.7795343302605;3423.871746353367;7390.556566606021;7851.311967926923;8331.95834020826;8665.653373864974;8770.605322760492;8941.329400295004;8949.865752013726;8975.147361000694;8978.82042359149;8980.820383592292;5958.76164953397;6227.408396202353;6635;6875.896861547081;6930.688119034656;4852.514748525119;4915.434725006527;4964.032013757427;4966.652334336562;5013.373328333958;7571.583562904093;7642.961785191039;7804.102528209329;7883.526988380716;7895.052593688794;7832.412569057229;7947.205279472007;7984.281414672707;7993.320567751573;8053.114157442794;5749.741261643319;5870.148828419769;5870.354261031369;5876.206712093813;5876.706164691663;6855.280195579392;6855.348741869514;6911.861762764616;6923.584584924921;6928.549644273106;6307.495400368051;6321.209848768904;6321.841953951004;6329.936700633119;6362.650054247061;6218.440340369389;6240.687965601793;6248.625082495065;6262.185915831095;6272.5922815016875;5461.044317244546;5494.340679118532;5523.447655234605;5541.030319694118;5541.2796336476;4056.6957478188665;4134.152498737812;4159.91680166389;4189.685773567056;4207.347861081537;4330.870073897788;4333.068390296102;4335.696501245009;4410.889727756703;4439.223135951131 17:43:24 INFO - PROCESS | 31393 | |4;prototype.html;340.81084997826207;350.2854177477945;351.38332226941714;353.08550853290006;359.4428635614798;4835.782389792459;4880.609551235902;4884.658073934826;4884.682495637781;4897.436794768598;4799.904001919968;4819.32529445877;4824;4825.855224343275;4834.299026641135;3606.855725770966;3730.7761534307892;3744.794036328001;3748.5501739791125;3798.525184351956;3766.8493260269556;3777;3789.2989796887528;3793.4499497572833;3795.772253664789;3692.581359209722;3750.4561838533396;3753.136778540937;3762.7930463824478;3777.8111094445303;3637.727170462226;3725.3480640888006;3761.41698036802;3776.1314897573575;3776.206996530732;3268.5812498750993;3270.5421241026274;3272.934541309184;3289.0297362278184;3290.3090351026076;4651.232546629802;4690.296455531663;4726.76366181693;4729.290606409032;4748.311494833264;4282.550332215135;4286.549912259199;4305.97847010763;4310.80601372939;4316.438862947828;4813.350197723297;5025.949740502585;5058.494150584912;5076.416212135578;5079.542841144278;3571.4464258039784;3596.856125754967;3599.4342461029537;3613.175346450052;3627.383344831385;5046.243063540462;5171.948280517222;5242.528172464458;5359.1425371940695;5374.6237763356585;3351.1789611545328;3462.7229821614715;3464.5149679044953;3466.480027995821;3691.7046636269033;3702.3705969985167;3711;3716.646918542734;3721.3859713147026;3725.4970578972034;4217.557156498585;4245.433835578129;4292.926768307923;4293.914121717548;4296.2266791977745;4967.40391153064;4973.593088734228;5037.740564858786;5065.721385323843;5074.340335756328;1240.2512457434973;1245.9377031148406;1249.7562975219926;1260.1305099481328;1265.2034111561604;814.2142832166987;851.7827953871723;861.9655213791503;873.724776695339;873.7815546113471;4303.2469317869245;4310.978445107817;4320.870373888788;4322.481302243688;4330.783460826946;5037.244413338029;5064.670796398223;5069.290299358093;5085.694858308513;5182.32629758129;4362.825486980549;4374.103308821684;4381.715188512737;4423.800928958204;4431.468223813163;2517.282574466268;2644.1094617348303;2692.0846912049997;2697.9595306070423;2702.9189124326303;4677.462091859412;4715.760013993395;4718;4736.810527578928;4783.904321913542;4916.606671466274;5157.8452646420665;5190.766415511311;5205.2192171173865;5208.739563021833;4722.890120821673;4729.66558576203;4750.168720473903;4753.643476739258;4759.7858096386435;5092.41437234708;5096.51583099605;5098.847034588968;5115.85134243626;5136.922946155885;4823.807047718052;5017.67385119966;5029.094762942559;5041.344625198701;5053.570446511941;4620.907581848277;4732.124556956974;4841.515848415131;4859.3682821233015;4896.510348965075;3522.7357948153476;3633.6911362533424;3635.763675361093;3650.616685248117;3652.269546090846;5204.401493828258;5224.164133738584;5232.215167724872;5241.68549887008;5246.868828279324;4947.678400903929;5043.672161309503;5069.695818250917;5077.588145630796;5100;5004.899902001866;5024.472430394756;5072.923906141485;5081.288619593186;5083.618728595444;5008.749562521786;5016.473270306711;5036.169032109661;5046.520580544842;5049.570786483043;4858.906745982125;5085.46602606721;5103.974480127576;5104.285400044071;5111.830664987731;4986.900261994812;4992.326035985096;5007.1487847065355;5007.949920500894;5012.87467813293 17:43:24 INFO - PROCESS | 31393 | |5;yui.html;652.5269179844616;671.7447369999403;714.1109318897973;742.3949481172843;755.1089714137318;12777.616671499858;13956.93021534891;13964.371603277852;14057.22685252312;14110.153390796546;13331.733365332711;13485.325733713324;13494.46022159115;13509.864901350984;13522.932385338085;799.936005119589;801.1667865419971;814.9877751833727;816.2205094135087;824.7072289337289;810.7648781853255;811.452269717941;811.6428771340621;811.7321283976303;812.2689579378577;839.7354833227545;846.1411667157839;846.3863698818369;846.3990566697652;846.5682501924032;840.5209030852417;840.5503055865083;840.6931470013432;840.8822764812932;841.9158084191594;616.8519555306694;617.6016469377226;617.8671585609071;618.011182108627;618.4742968476804;13571.253581053039;13858.16850988944;13912.234827084507;13942.51201207963;13953.162810231419;12340.38298085101;12431.627051188389;12628.747425051448;13426.664333391645;13682.863171368259;11109.166812489095;11221.943890280578;11306.095512358992;11355.375454350007;11405.144614153889;3787.6591106800242;3803.562590302123;3874.8062596870045;3973.443717879499;3974.046228905042;62165.378346216414;63886;64215.35784642141;64399.356006439804;65185.674071629815;9901.257405694601;9941.204703623693;10093.798124037625;10334.224933130045;10384.688459346231;17518.38685645996;17622.911885440746;17711.202995865217;17810.376636817648;17815.10924453772;6313.747450101944;6369.5222858285815;6407;6492.837679058061;6527.902081468782;3344.665533446636;3361.4957756336257;3388.508666243381;3409.3522230776075;3457.8271086445575;2813.4795062913427;2862.7137286271204;2884.336602581418;2891.2916335497516;2895.319599894023;498.9226669866104;504.1807063521777;511.0366958283662;512.6360284198187;512.9794808207705;547.6741338903346;551.503646717949;563.2002556369964;578;592.2123575644382;8047.155048719917;8048.275655191061;8243.216894395024;8248.917510824815;8336.458130221516;423.2592962315947;425.987220383389;433.5859254412029;459.3362591055959;472.3175012107472;3974.960250397517;4008.7193896427552;4073.429719839225;4165.062860856283;4247.532771395144;63384.36615633785;65758;66784.69763243823;68016.319836801;68971.3102868975;57507.42492575021;58343.70828145832;60473;60566;61027.38972610306;50366.74816625967;50548.74725626496;50820;50916.74541627268;50941.745291273306;7592.582407967394;7620.542767433972;7706.884396733942;7870.212978702084;7929.246721561442;36433;36525.63474365223;36997.890063298146;37982;37998.042362480846;43712.34431483594;44608.553914461736;46044.30933536067;47682;47803.52196477991;8805.779855503664;8942.150495702897;9018.549072546477;9383.390079644802;9720.173785228335;10054.8491772622;10093.899061009295;10253.231007674603;10328.018838210359;10729.839052414063;9357.672481463116;9419.293552983416;9506.857397139187;9625.759356015875;9656.130948214695;9651.131398174199;9716.174125199437;9720.368176068532;9733.513324333897;9771.267154963549;8629.95685021596;8633.223009929137;8702.782430439289;8810;9034.548272586213;7756.340711039399;7853.293203611703;8023.879641805261;8064.153263907206;8084.231997960184;7375.778726638209;7443.702251909863;7450.701971921062;7468.92531074704;7507.286807753255 17:43:24 INFO - PROCESS | 31393 | __end_tp_report 17:43:24 INFO - PROCESS | 31393 | __start_cc_report 17:43:24 INFO - PROCESS | 31393 | _x_x_mozilla_cycle_collect,1111 17:43:24 INFO - PROCESS | 31393 | __end_cc_report 17:43:24 INFO - PROCESS | 31393 | __startTimestamp1486086204694__endTimestamp 17:43:24 INFO - PROCESS | 31393 | 17:43:24 INFO - PROCESS | 31393 | ------- Summary: start ------- 17:43:24 INFO - PROCESS | 31393 | Number of tests: 6 17:43:24 INFO - PROCESS | 31393 | 17:43:24 INFO - PROCESS | 31393 | [#0] dojo.html Cycles:165 Average:4549.12 Median:4667.77 stddev:466.67 (10.0%) stddev-sans-first:439.37 17:43:24 INFO - PROCESS | 31393 | Values: 2493.9 2521.2 2527.1 2550.8 2556.9 4475.2 4539.6 4600.9 4612.7 4644.7 4562.6 4589.1 4593.2 4606.4 4653.5 4125.9 4218.2 4274.5 4327.2 4341.5 4283.1 4339.7 4352.1 4360.5 4387.3 4160.3 4208.7 4222.7 4251.3 4264.2 4262.4 4268.5 4276.0 4307.7 4320.8 4246.7 4259.3 4262.6 4284.2 4286.1 4436.9 4468.9 4574.5 4643.4 4666.1 4928.9 5005.6 5006.3 5009.8 5011.9 4965.6 4966.2 4984.2 4985.8 5031.5 4665.9 4667.8 4669.0 4674.7 4713.6 4881.7 4928.2 4935.7 4946.2 4947.3 4757.4 4759.9 4762.6 4780.2 4813.9 4836.5 4844.9 4911.0 4913.1 4958.6 4797.3 4826.4 4882.6 4883.5 4931.0 4829.9 4840.9 4864.4 4886.0 4954.1 4253.0 4254.5 4254.9 4258.6 4301.3 3669.2 3682.2 3688.1 3706.2 3718.2 4196.7 4235.0 4269.3 4277.2 4301.4 4926.7 4928.2 4937.3 4944.1 4966.3 4239.9 4274.4 4279.1 4279.8 4294.5 4367.0 4431.4 4441.0 4442.3 4474.6 4636.1 4640.1 4654.6 4667.5 4677.3 4806.0 4853.1 4965.4 4970.8 5022.1 4576.7 4580.4 4583.4 4584.4 4591.0 4782.7 4830.8 4831.5 4833.9 4834.1 4874.0 4901.1 4916.9 4917.9 4919.2 4741.1 4744.2 4744.4 4752.0 4762.4 4704.9 4717.9 4720.7 4759.9 4798.8 4723.5 4739.3 4740.5 4761.4 4780.2 4813.4 4824.3 4826.7 4829.8 4865.7 4573.0 4621.8 4669.7 4721.9 4753.8 17:43:24 INFO - PROCESS | 31393 | 17:43:24 INFO - PROCESS | 31393 | [#1] ext.html Cycles:180 Average:44909.04 Median:33915.25 stddev:73520.93 (216.8%) stddev-sans-first:73651.69 17:43:24 INFO - PROCESS | 31393 | Values: 539.0 561.9 563.2 566.9 581.0 30455.7 41425.0 42994.6 43174.1 47217.5 42314.2 42675.1 42764.4 42821.4 42849.4 7466.2 7818.5 7992.5 7996.2 7996.8 7515.3 10185.7 10430.9 10440.4 10711.6 10417.7 10475.1 10488.6 10489.4 10491.6 10326.4 10385.2 10399.3 10401.8 10408.3 10170.3 10238.5 10252.5 10252.7 10264.1 40766.2 41147.6 41150.4 41186.8 41218.2 3570.9 3668.3 3681.7 3682.1 3688.4 29642.0 30245.4 30572.5 30634.4 30834.5 3283.5 3314.6 3340.1 3431.1 3444.4 237519.0 237599.0 238594.0 238763.0 239991.0 49994.0 50318.5 50346.7 54246.7 55979.0 60365.0 61849.7 61870.4 66947.3 67859.3 15835.4 15979.9 15989.9 15994.8 16014.9 11969.5 12050.7 12078.3 12086.3 12088.5 16551.8 17017.3 17895.6 18326.6 18433.8 6490.8 6559.3 6584.5 6717.4 6778.0 791.7 804.8 809.0 814.4 838.4 26755.0 27577.2 28270.7 28335.0 28448.6 885.1 971.5 981.4 982.5 997.3 14656.7 14988.9 15177.7 15216.4 15394.0 322377.0 324614.0 325401.0 325588.0 326321.0 50920.2 50978.5 51000.0 51084.0 51088.2 1180.3 1234.8 1243.1 1244.1 1249.8 26114.5 27068.3 27309.6 27717.3 27883.3 43042.6 43616.6 43642.0 43659.1 43682.6 273179.0 274085.0 275062.0 275231.0 275557.0 35493.3 36331.6 36691.4 36702.6 36767.3 39392.8 39988.8 40028.6 40179.4 40667.6 34060.8 34144.1 34205.5 34269.0 34371.8 33742.0 34233.1 34479.0 35646.6 35882.3 33579.3 33892.5 33938.0 34237.0 34637.5 26819.5 27728.2 28341.0 28422.3 28551.3 23360.5 23539.2 23579.4 23835.9 24109.3 17:43:24 INFO - PROCESS | 31393 | 17:43:24 INFO - PROCESS | 31393 | [#2] jquery.html Cycles:180 Average:28944.80 Median:4626.82 stddev:82755.68 (1788.6%) stddev-sans-first:82959.99 17:43:24 INFO - PROCESS | 31393 | Values: 354.3 366.2 387.3 391.6 410.9 13480.1 17285.8 18121.2 19107.6 19300.3 17601.3 17706.9 18391.0 18400.3 19206.1 4697.8 4938.1 4940.1 4950.0 4970.2 3583.6 3697.1 4810.9 4879.7 4880.3 4006.4 4048.8 6380.2 6480.8 6493.1 6258.9 6263.5 6392.2 6470.2 6472.6 5661.9 5666.3 5668.1 5676.4 5679.5 22036.0 22149.8 22830.7 22924.5 22976.9 2254.6 2313.9 2383.7 2398.9 2471.3 9218.1 9682.8 9695.9 9770.0 13587.9 1667.5 1690.4 1716.6 1726.3 1735.6 79849.6 82724.2 82976.6 84110.6 84266.6 10798.2 10985.8 10994.0 11039.8 11090.2 15497.8 15514.1 15531.2 15538.1 15554.2 7567.6 7630.0 7818.8 7901.4 7913.6 7157.8 7190.3 7238.1 7413.7 7432.0 4623.9 4629.8 4788.4 4847.3 4899.0 1856.7 1932.7 1940.5 1998.5 2006.7 725.2 744.4 753.0 754.2 767.2 17255.4 17395.0 18427.3 19999.6 20555.8 864.6 871.3 873.3 887.4 892.2 9760.7 9820.2 10061.7 10092.1 10176.6 480542.2 495623.0 506672.0 506853.0 509238.0 99930.5 101535.0 101668.5 104980.0 107995.5 934.3 979.4 1000.0 1003.3 1003.6 15082.5 15272.0 15427.5 15761.4 16123.5 36855.0 42928.6 43086.0 43583.0 44261.8 44225.3 54939.5 55183.7 56173.7 56747.4 7806.3 7830.9 7894.1 7967.2 8339.6 10317.5 11889.6 12153.4 12566.4 13006.5 5350.6 6974.8 8489.5 9827.2 10293.3 10602.4 10829.1 10888.2 10921.3 11130.7 6707.4 9574.8 9903.8 10422.0 10593.2 6943.3 7092.7 7203.6 7394.9 8052.2 8549.9 9796.5 9895.4 10158.1 10444.2 17:43:24 INFO - PROCESS | 31393 | 17:43:24 INFO - PROCESS | 31393 | [#3] mootools.html Cycles:180 Average:4721.18 Median:4939.73 stddev:2571.93 (52.1%) stddev-sans-first:2566.28 17:43:24 INFO - PROCESS | 31393 | Values: 1298.8 1308.7 1320.1 1332.0 1341.9 6946.7 7266.2 7301.7 7377.2 7377.3 6928.4 7094.4 7171.8 7174.3 7319.9 2074.0 2105.4 2108.0 2109.4 2109.9 2008.5 2092.5 2099.4 2101.7 2102.4 1749.7 1832.3 1979.3 2043.1 2052.6 2084.9 2100.2 2100.3 2104.5 2105.6 1792.3 2069.3 2141.8 2143.5 2146.4 6371.3 7158.9 7422.4 7440.2 7615.7 4433.6 4534.7 4551.7 4557.1 4564.8 2675.4 2800.9 2815.0 2836.2 2844.3 1099.4 1113.4 1122.2 1122.4 1160.1 9850.6 9953.0 9967.2 9968.1 9969.0 3787.0 3951.4 4005.5 4010.3 4016.1 7975.8 7979.2 7983.1 7984.7 7997.0 4526.0 4526.1 4527.1 4531.6 4532.0 4018.9 4123.3 4162.5 4181.6 4193.2 3358.2 3396.6 3479.8 3495.5 3503.0 1048.7 1063.2 1066.1 1068.0 1074.5 782.6 805.3 807.1 815.5 815.8 4713.2 4742.5 4854.3 4856.8 5148.4 513.2 522.7 522.8 524.8 540.9 3304.6 3361.3 3389.0 3391.8 3423.9 7390.6 7851.3 8332.0 8665.7 8770.6 8941.3 8949.9 8975.1 8978.8 8980.8 5958.8 6227.4 6635.0 6875.9 6930.7 4852.5 4915.4 4964.0 4966.7 5013.4 7571.6 7643.0 7804.1 7883.5 7895.1 7832.4 7947.2 7984.3 7993.3 8053.1 5749.7 5870.1 5870.4 5876.2 5876.7 6855.3 6855.3 6911.9 6923.6 6928.5 6307.5 6321.2 6321.8 6329.9 6362.7 6218.4 6240.7 6248.6 6262.2 6272.6 5461.0 5494.3 5523.4 5541.0 5541.3 4056.7 4134.2 4159.9 4189.7 4207.3 4330.9 4333.1 4335.7 4410.9 4439.2 17:43:24 INFO - PROCESS | 31393 | 17:43:24 INFO - PROCESS | 31393 | [#4] prototype.html Cycles:180 Average:4160.21 Median:4734.47 stddev:1210.29 (25.6%) stddev-sans-first:1179.24 17:43:24 INFO - PROCESS | 31393 | Values: 340.8 350.3 351.4 353.1 359.4 4835.8 4880.6 4884.7 4884.7 4897.4 4799.9 4819.3 4824.0 4825.9 4834.3 3606.9 3730.8 3744.8 3748.6 3798.5 3766.8 3777.0 3789.3 3793.4 3795.8 3692.6 3750.5 3753.1 3762.8 3777.8 3637.7 3725.3 3761.4 3776.1 3776.2 3268.6 3270.5 3272.9 3289.0 3290.3 4651.2 4690.3 4726.8 4729.3 4748.3 4282.6 4286.5 4306.0 4310.8 4316.4 4813.4 5025.9 5058.5 5076.4 5079.5 3571.4 3596.9 3599.4 3613.2 3627.4 5046.2 5171.9 5242.5 5359.1 5374.6 3351.2 3462.7 3464.5 3466.5 3691.7 3702.4 3711.0 3716.6 3721.4 3725.5 4217.6 4245.4 4292.9 4293.9 4296.2 4967.4 4973.6 5037.7 5065.7 5074.3 1240.3 1245.9 1249.8 1260.1 1265.2 814.2 851.8 862.0 873.7 873.8 4303.2 4311.0 4320.9 4322.5 4330.8 5037.2 5064.7 5069.3 5085.7 5182.3 4362.8 4374.1 4381.7 4423.8 4431.5 2517.3 2644.1 2692.1 2698.0 2702.9 4677.5 4715.8 4718.0 4736.8 4783.9 4916.6 5157.8 5190.8 5205.2 5208.7 4722.9 4729.7 4750.2 4753.6 4759.8 5092.4 5096.5 5098.8 5115.9 5136.9 4823.8 5017.7 5029.1 5041.3 5053.6 4620.9 4732.1 4841.5 4859.4 4896.5 3522.7 3633.7 3635.8 3650.6 3652.3 5204.4 5224.2 5232.2 5241.7 5246.9 4947.7 5043.7 5069.7 5077.6 5100.0 5004.9 5024.5 5072.9 5081.3 5083.6 5008.7 5016.5 5036.2 5046.5 5049.6 4858.9 5085.5 5104.0 5104.3 5111.8 4986.9 4992.3 5007.1 5007.9 5012.9 17:43:24 INFO - PROCESS | 31393 | 17:43:24 INFO - PROCESS | 31393 | [#5] yui.html Cycles:180 Average:14519.91 Median:60519.50 stddev:18784.51 (31.0%) stddev-sans-first:18808.34 17:43:24 INFO - PROCESS | 31393 | Values: 652.5 671.7 714.1 742.4 755.1 12777.6 13956.9 13964.4 14057.2 14110.2 13331.7 13485.3 13494.5 13509.9 13522.9 799.9 801.2 815.0 816.2 824.7 810.8 811.5 811.6 811.7 812.3 839.7 846.1 846.4 846.4 846.6 840.5 840.6 840.7 840.9 841.9 616.9 617.6 617.9 618.0 618.5 13571.3 13858.2 13912.2 13942.5 13953.2 12340.4 12431.6 12628.7 13426.7 13682.9 11109.2 11221.9 11306.1 11355.4 11405.1 3787.7 3803.6 3874.8 3973.4 3974.0 62165.4 63886.0 64215.4 64399.4 65185.7 9901.3 9941.2 10093.8 10334.2 10384.7 17518.4 17622.9 17711.2 17810.4 17815.1 6313.7 6369.5 6407.0 6492.8 6527.9 3344.7 3361.5 3388.5 3409.4 3457.8 2813.5 2862.7 2884.3 2891.3 2895.3 498.9 504.2 511.0 512.6 513.0 547.7 551.5 563.2 578.0 592.2 8047.2 8048.3 8243.2 8248.9 8336.5 423.3 426.0 433.6 459.3 472.3 3975.0 4008.7 4073.4 4165.1 4247.5 63384.4 65758.0 66784.7 68016.3 68971.3 57507.4 58343.7 60473.0 60566.0 61027.4 50366.7 50548.7 50820.0 50916.7 50941.7 7592.6 7620.5 7706.9 7870.2 7929.2 36433.0 36525.6 36997.9 37982.0 37998.0 43712.3 44608.6 46044.3 47682.0 47803.5 8805.8 8942.2 9018.5 9383.4 9720.2 10054.8 10093.9 10253.2 10328.0 10729.8 9357.7 9419.3 9506.9 9625.8 9656.1 9651.1 9716.2 9720.4 9733.5 9771.3 8630.0 8633.2 8702.8 8810.0 9034.5 7756.3 7853.3 8023.9 8064.2 8084.2 7375.8 7443.7 7450.7 7468.9 7507.3 17:43:24 INFO - PROCESS | 31393 | -------- Summary: end -------- 17:43:24 INFO - PROCESS | 31393 | 17:43:25 INFO - TEST-INFO | 31393: exit 0 17:43:25 INFO - TEST-OK | dromaeo_css | took 1120417ms 17:43:25 INFO - TEST-START | kraken 17:43:25 INFO - operating with platform_type : linux_ 17:43:25 INFO - Initialising browser for kraken test... 17:43:25 INFO - TEST-INFO | started process 31692 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqBJJFs/profile http://localhost:38899/getInfo.html) 17:43:28 INFO - PROCESS | 31692 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 17:43:29 INFO - PROCESS | 31692 | __metrics Screen width/height:1600/1200 17:43:29 INFO - PROCESS | 31692 | colorDepth:24 17:43:29 INFO - PROCESS | 31692 | Browser inner width/height: 1024/697 17:43:29 INFO - PROCESS | 31692 | __metrics 17:43:29 INFO - PROCESS | 31692 | 1486086209973 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 17:43:30 INFO - PROCESS | 31692 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:43:30 INFO - PROCESS | 31692 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:43:30 INFO - PROCESS | 31692 | console.error: PushService: 17:43:30 INFO - PROCESS | 31692 | stateChangeProcessEnqueue: Error transitioning state 17:43:30 INFO - PROCESS | 31692 | UnknownError 17:43:31 INFO - TEST-INFO | 31692: exit 0 17:43:31 INFO - Browser initialized. 17:43:31 INFO - Running cycle 1/1 for kraken test... 17:43:31 INFO - TEST-INFO | started process 31772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqBJJFs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:43:43 INFO - PROCESS | 31772 | RSS: Main: 153714688 17:43:43 INFO - PROCESS | 31772 | 17:43:45 INFO - PROCESS | 31772 | Cycle 1(1): loaded http://localhost:38899/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38899/tests/kraken/driver.html?testName=audio-beat-detection) 17:43:46 INFO - PROCESS | 31772 | RSS: Main: 209076224 17:43:46 INFO - PROCESS | 31772 | 17:43:49 INFO - PROCESS | 31772 | Cycle 1(1): loaded http://localhost:38899/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38899/tests/kraken/driver.html?testName=audio-dft) 17:43:50 INFO - PROCESS | 31772 | RSS: Main: 187359232 17:43:50 INFO - PROCESS | 31772 | 17:43:53 INFO - PROCESS | 31772 | Cycle 1(1): loaded http://localhost:38899/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38899/tests/kraken/driver.html?testName=audio-fft) 17:43:53 INFO - PROCESS | 31772 | RSS: Main: 269733888 17:43:53 INFO - PROCESS | 31772 | 17:43:56 INFO - PROCESS | 31772 | Cycle 1(1): loaded http://localhost:38899/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38899/tests/kraken/driver.html?testName=audio-oscillator) 17:43:56 INFO - PROCESS | 31772 | RSS: Main: 182325248 17:43:56 INFO - PROCESS | 31772 | 17:43:58 INFO - PROCESS | 31772 | Cycle 1(1): loaded http://localhost:38899/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38899/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:43:59 INFO - PROCESS | 31772 | RSS: Main: 185090048 17:43:59 INFO - PROCESS | 31772 | 17:44:02 INFO - PROCESS | 31772 | Cycle 1(1): loaded http://localhost:38899/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38899/tests/kraken/driver.html?testName=imaging-darkroom) 17:44:03 INFO - PROCESS | 31772 | RSS: Main: 224120832 17:44:03 INFO - PROCESS | 31772 | 17:44:06 INFO - PROCESS | 31772 | Cycle 1(1): loaded http://localhost:38899/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38899/tests/kraken/driver.html?testName=imaging-desaturate) 17:44:07 INFO - PROCESS | 31772 | RSS: Main: 218365952 17:44:07 INFO - PROCESS | 31772 | 17:44:10 INFO - PROCESS | 31772 | Cycle 1(1): loaded http://localhost:38899/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38899/tests/kraken/driver.html?testName=json-parse-financial) 17:44:10 INFO - PROCESS | 31772 | RSS: Main: 220459008 17:44:10 INFO - PROCESS | 31772 | 17:44:12 INFO - PROCESS | 31772 | Cycle 1(1): loaded http://localhost:38899/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38899/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:44:13 INFO - PROCESS | 31772 | RSS: Main: 183779328 17:44:13 INFO - PROCESS | 31772 | 17:44:15 INFO - PROCESS | 31772 | Cycle 1(1): loaded http://localhost:38899/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38899/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:44:15 INFO - PROCESS | 31772 | RSS: Main: 192098304 17:44:15 INFO - PROCESS | 31772 | 17:44:17 INFO - PROCESS | 31772 | Cycle 1(1): loaded http://localhost:38899/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38899/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:44:18 INFO - PROCESS | 31772 | RSS: Main: 200429568 17:44:18 INFO - PROCESS | 31772 | 17:44:21 INFO - PROCESS | 31772 | Cycle 1(1): loaded http://localhost:38899/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38899/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:44:22 INFO - PROCESS | 31772 | RSS: Main: 209571840 17:44:22 INFO - PROCESS | 31772 | 17:44:25 INFO - PROCESS | 31772 | Cycle 1(1): loaded http://localhost:38899/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38899/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:44:25 INFO - PROCESS | 31772 | RSS: Main: 205422592 17:44:25 INFO - PROCESS | 31772 | 17:44:27 INFO - PROCESS | 31772 | Cycle 1(1): loaded http://localhost:38899/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38899/tests/kraken/driver.html?testName=ai-astar) 17:44:27 INFO - PROCESS | 31772 | RSS: Main: 256757760 17:44:27 INFO - PROCESS | 31772 | 17:44:27 INFO - PROCESS | 31772 | __start_tp_report 17:44:27 INFO - PROCESS | 31772 | _x_x_mozilla_page_load 17:44:27 INFO - PROCESS | 31772 | _x_x_mozilla_page_load_details 17:44:27 INFO - PROCESS | 31772 | |i|pagename|runs| 17:44:27 INFO - PROCESS | 31772 | |0;ai-astar;114;116;116;117;117;115;115;115;114;114 17:44:27 INFO - PROCESS | 31772 | |1;audio-beat-detection;148;127;127;171;129;127;123;124;151;124 17:44:27 INFO - PROCESS | 31772 | |2;audio-dft;162;160;162;161;162;161;162;162;161;160 17:44:27 INFO - PROCESS | 31772 | |3;audio-fft;77;76;77;100;77;78;76;78;102;76 17:44:27 INFO - PROCESS | 31772 | |4;audio-oscillator;84;84;104;85;84;84;102;83;85;110 17:44:27 INFO - PROCESS | 31772 | |5;imaging-gaussian-blur;117;117;117;118;117;116;117;120;118;118 17:44:27 INFO - PROCESS | 31772 | |6;imaging-darkroom;149;149;150;148;149;148;148;148;149;148 17:44:27 INFO - PROCESS | 31772 | |7;imaging-desaturate;96;95;96;96;95;95;94;95;96;95 17:44:27 INFO - PROCESS | 31772 | |8;json-parse-financial;60;61;61;60;62;61;63;62;63;70 17:44:27 INFO - PROCESS | 31772 | |9;json-stringify-tinderbox;68;67;67;68;67;68;67;66;67;68 17:44:27 INFO - PROCESS | 31772 | |10;stanford-crypto-aes;93;88;91;85;85;85;86;85;85;84 17:44:27 INFO - PROCESS | 31772 | |11;stanford-crypto-ccm;144;138;131;133;142;131;132;131;181;152 17:44:27 INFO - PROCESS | 31772 | |12;stanford-crypto-pbkdf2;183;180;180;178;176;183;178;180;181;184 17:44:27 INFO - PROCESS | 31772 | |13;stanford-crypto-sha256-iterative;68;67;67;68;69;67;66;66;68;67 17:44:27 INFO - PROCESS | 31772 | __end_tp_report 17:44:27 INFO - PROCESS | 31772 | __start_cc_report 17:44:27 INFO - PROCESS | 31772 | _x_x_mozilla_cycle_collect,1873 17:44:27 INFO - PROCESS | 31772 | __end_cc_report 17:44:27 INFO - PROCESS | 31772 | __startTimestamp1486086267814__endTimestamp 17:44:27 INFO - PROCESS | 31772 | 17:44:27 INFO - PROCESS | 31772 | ------- Summary: start ------- 17:44:27 INFO - PROCESS | 31772 | Number of tests: 14 17:44:27 INFO - PROCESS | 31772 | 17:44:27 INFO - PROCESS | 31772 | [#0] ai-astar Cycles:10 Average:115.30 Median:115.50 stddev:1.16 (1.0%) stddev-sans-first:1.13 17:44:27 INFO - PROCESS | 31772 | Values: 114.0 116.0 116.0 117.0 117.0 115.0 115.0 115.0 114.0 114.0 17:44:27 INFO - PROCESS | 31772 | 17:44:27 INFO - PROCESS | 31772 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:128.00 stddev:16.11 (12.6%) stddev-sans-first:16.39 17:44:27 INFO - PROCESS | 31772 | Values: 148.0 127.0 127.0 171.0 129.0 127.0 123.0 124.0 151.0 124.0 17:44:27 INFO - PROCESS | 31772 | 17:44:27 INFO - PROCESS | 31772 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 17:44:27 INFO - PROCESS | 31772 | Values: 162.0 160.0 162.0 161.0 162.0 161.0 162.0 162.0 161.0 160.0 17:44:27 INFO - PROCESS | 31772 | 17:44:27 INFO - PROCESS | 31772 | [#3] audio-fft Cycles:10 Average:81.70 Median:77.00 stddev:10.21 (13.3%) stddev-sans-first:10.69 17:44:27 INFO - PROCESS | 31772 | Values: 77.0 76.0 77.0 100.0 77.0 78.0 76.0 78.0 102.0 76.0 17:44:27 INFO - PROCESS | 31772 | 17:44:27 INFO - PROCESS | 31772 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:84.00 stddev:10.44 (12.4%) stddev-sans-first:10.80 17:44:27 INFO - PROCESS | 31772 | Values: 84.0 84.0 104.0 85.0 84.0 84.0 102.0 83.0 85.0 110.0 17:44:27 INFO - PROCESS | 31772 | 17:44:27 INFO - PROCESS | 31772 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:1.08 (0.9%) stddev-sans-first:1.13 17:44:27 INFO - PROCESS | 31772 | Values: 117.0 117.0 117.0 118.0 117.0 116.0 117.0 120.0 118.0 118.0 17:44:27 INFO - PROCESS | 31772 | 17:44:27 INFO - PROCESS | 31772 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 17:44:27 INFO - PROCESS | 31772 | Values: 149.0 149.0 150.0 148.0 149.0 148.0 148.0 148.0 149.0 148.0 17:44:27 INFO - PROCESS | 31772 | 17:44:27 INFO - PROCESS | 31772 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 17:44:27 INFO - PROCESS | 31772 | Values: 96.0 95.0 96.0 96.0 95.0 95.0 94.0 95.0 96.0 95.0 17:44:27 INFO - PROCESS | 31772 | 17:44:27 INFO - PROCESS | 31772 | [#8] json-parse-financial Cycles:10 Average:62.30 Median:62.00 stddev:2.91 (4.7%) stddev-sans-first:2.96 17:44:27 INFO - PROCESS | 31772 | Values: 60.0 61.0 61.0 60.0 62.0 61.0 63.0 62.0 63.0 70.0 17:44:27 INFO - PROCESS | 31772 | 17:44:27 INFO - PROCESS | 31772 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 17:44:27 INFO - PROCESS | 31772 | Values: 68.0 67.0 67.0 68.0 67.0 68.0 67.0 66.0 67.0 68.0 17:44:27 INFO - PROCESS | 31772 | 17:44:27 INFO - PROCESS | 31772 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:85.50 stddev:3.02 (3.5%) stddev-sans-first:2.18 17:44:27 INFO - PROCESS | 31772 | Values: 93.0 88.0 91.0 85.0 85.0 85.0 86.0 85.0 85.0 84.0 17:44:27 INFO - PROCESS | 31772 | 17:44:27 INFO - PROCESS | 31772 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:140.00 stddev:15.57 (11.1%) stddev-sans-first:16.49 17:44:27 INFO - PROCESS | 31772 | Values: 144.0 138.0 131.0 133.0 142.0 131.0 132.0 131.0 181.0 152.0 17:44:27 INFO - PROCESS | 31772 | 17:44:27 INFO - PROCESS | 31772 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.30 Median:180.50 stddev:2.54 (1.4%) stddev-sans-first:2.50 17:44:27 INFO - PROCESS | 31772 | Values: 183.0 180.0 180.0 178.0 176.0 183.0 178.0 180.0 181.0 184.0 17:44:27 INFO - PROCESS | 31772 | 17:44:27 INFO - PROCESS | 31772 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:0.95 (1.4%) stddev-sans-first:0.97 17:44:27 INFO - PROCESS | 31772 | Values: 68.0 67.0 67.0 68.0 69.0 67.0 66.0 66.0 68.0 67.0 17:44:27 INFO - PROCESS | 31772 | -------- Summary: end -------- 17:44:27 INFO - PROCESS | 31772 | 17:44:28 INFO - TEST-INFO | 31772: exit 0 17:44:28 INFO - TEST-OK | kraken | took 63415ms 17:44:28 INFO - SUITE-END | took 1183s 17:44:28 INFO - Completed test suite (00:19:43) 17:44:28 INFO - javascript benchmark 17:44:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6280.834294170475, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2493.90024399024, 2521.168014555197, 2527.140772137473, 2550.77043066124, 2556.9488610227786, 4475.1944649963, 4539.614132798708, 4600.930986035212, 4612.677112602119, 4644.744539050351, 4562.634989200864, 4589.059242855215, 4593.219152744033, 4606.355110284554, 4653.534646535345, 4125.8968525786795, 4218.240716670998, 4274.487061552611, 4327.199468098396, 4341.45731783527, 4283.079137985333, 4339.739615623057, 4352.129574085196, 4360.520342762294, 4387.276099443604, 4160.251154792136, 4208.705390622657, 4222.704410691253, 4251.319788833772, 4264.168487145008, 4262.445882035347, 4268.509121451042, 4275.957240427587, 4307.741535507848, 4320.783960801948, 4246.681498887596, 4259.254630439661, 4262.573742625713, 4284.228838809013, 4286.099919016979, 4436.933445998313, 4468.8882777930485, 4574.451065872084, 4643.442786865564, 4666.136764698542, 4928.876778080541, 5005.6496045276845, 5006.299118123466, 5009.799608015675, 5011.949880501184, 4965.627577931669, 4966.180580204262, 4984.22744474607, 4985.750712464399, 5031.547160755549, 4665.930011049837, 4667.766611669369, 4669.019505903798, 4674.719516829001, 4713.622910167179, 4881.658283920092, 4928.236123400879, 4935.654504184745, 4946.183879659816, 4947.307376967227, 4757.381540399795, 4759.904801904012, 4762.59517940972, 4780.211265141283, 4813.927791083137, 4836.516348365135, 4844.878878028077, 4910.975445122752, 4913.115639184981, 4958.628102892298, 4797.280407938767, 4826.444958829779, 4882.5605695486865, 4883.51164883516, 4931.013797240495, 4829.879253018632, 4840.854774356775, 4864.36763220779, 4886.047220791983, 4954.083494553519, 4253.0, 4254.510731265944, 4254.914901701949, 4258.5954334338185, 4301.290287102593, 3669.229461812996, 3682.1531047858607, 3688.133288677159, 3706.166112624692, 3718.163413232055, 4196.706230563831, 4234.978825105916, 4269.252880745857, 4277.230098582223, 4301.376300436419, 4926.679765815211, 4928.211486162197, 4937.308776771255, 4944.134776414185, 4966.329545511382, 4239.89762661704, 4274.401583778274, 4279.058607106432, 4279.7646129462555, 4294.549072347421, 4367.0, 4431.379606855043, 4441.022974945507, 4442.289233722653, 4474.574915383034, 4636.095961287651, 4640.141573808856, 4654.557817007379, 4667.509911459316, 4677.2750223715375, 4806.014766972832, 4853.102176097434, 4965.354503914468, 4970.776315065758, 5022.146235140108, 4576.702514336557, 4580.404547408815, 4583.427071616048, 4584.35818985349, 4591.0, 4782.713037217778, 4830.806767729251, 4831.541003604652, 4833.854984350334, 4834.129856625841, 4873.951260487492, 4901.14230009754, 4916.926246106383, 4917.852464426073, 4919.237518184687, 4741.122892264942, 4744.169770290255, 4744.359511466046, 4752.049590081929, 4762.404699412574, 4704.870831000604, 4717.9056418872115, 4720.740359280273, 4759.857204283877, 4798.808047678054, 4723.527647235249, 4739.265413860857, 4740.4785473597185, 4761.357216775691, 4780.163471392562, 4813.374261346003, 4824.252240902666, 4826.710397376169, 4829.806807727651, 4865.732384718733, 4573.039661670953, 4621.79201935907, 4669.7431641260055, 4721.929171062368, 4753.83361582343], "value": 4519.293593999819, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.9893948845914, 561.8735784448498, 563.1833840930649, 566.9036263835151, 580.9564282678795, 30455.695443045563, 41425.0, 42994.57005429949, 43174.13651726964, 47217.52782472183, 42314.15371692572, 42675.14649707004, 42764.358534622006, 42821.35767963483, 42849.35725964105, 7466.178720340758, 7818.530888146715, 7992.520448773063, 7996.24035716606, 7996.760097197093, 7515.286047825448, 10185.745356366113, 10430.895691043106, 10440.373577585331, 10711.625093121742, 10417.739556511073, 10475.109615682675, 10488.632897848576, 10489.423081730502, 10491.58033678652, 10326.432046237454, 10385.169186465064, 10399.272050956437, 10401.791964160675, 10408.323458975143, 10170.338927969658, 10238.53926573306, 10252.538635761408, 10252.74368140795, 10264.076233138978, 40766.18467630631, 41147.58852411497, 41150.38274425886, 41186.794066029775, 41218.1756364874, 3570.892873213808, 3668.3213605482806, 3681.7054635629083, 3682.097886017916, 3688.409854423306, 29642.0, 30245.395092098253, 30572.54141187884, 30634.387312253853, 30834.53748193779, 3283.5238890360765, 3314.5691060162026, 3340.081477593657, 3431.1422144463886, 3444.4144495435585, 237519.0, 237599.0, 238594.0, 238763.0, 239991.0, 49994.0, 50318.496815032115, 50346.74826625844, 54246.72876635592, 55979.0, 60365.0, 61849.69075154595, 61870.38129618646, 66947.3305266941, 67859.32140678629, 15835.366585336687, 15979.920100399657, 15989.920050399905, 15994.76007859883, 16014.919925400298, 11969.46137423818, 12050.698732531757, 12078.275303481643, 12086.274823510617, 12088.456019479145, 16551.83448165503, 17017.31930722782, 17895.642087158445, 18326.633467330845, 18433.815661843477, 6490.837729056811, 6559.311272316433, 6584.473242140617, 6717.361850624183, 6778.0, 791.7070683847013, 804.7706403675041, 808.9797755056171, 814.4380377539597, 838.4005436113208, 26755.0, 27577.207481513637, 28270.71729282722, 28335.0, 28448.573271400946, 885.1367870632355, 971.4608392342318, 981.4454833019321, 982.4891056650501, 997.2919227348518, 14656.706865862836, 14988.925055374653, 15177.696446071237, 15216.391344346324, 15394.0, 322377.0, 324614.0, 325401.0, 325588.0, 326321.0, 50920.23619645708, 50978.490215098114, 51000.0, 51084.0, 51088.233676494885, 1180.3095189314176, 1234.7715672600598, 1243.0801207106856, 1244.0918129765323, 1249.787536118862, 26114.477710446066, 27068.32329191786, 27309.590356145072, 27717.307067322672, 27883.302917427227, 43042.56957430386, 43616.56383436125, 43642.0, 43659.12681746411, 43682.563174367846, 273179.0, 274085.0, 275062.0, 275231.0, 275557.0, 35493.29013419666, 36331.636683633886, 36691.44962825613, 36702.63297366992, 36767.264654707295, 39392.80303598464, 39988.800055999534, 40028.59971400365, 40179.39730903981, 40667.59332406638, 34060.82969585136, 34144.14639634029, 34205.48691769576, 34269.0, 34371.82814086013, 33742.0, 34233.144171395914, 34479.0, 35646.64353356433, 35882.28235435329, 33579.3284134311, 33892.49161262534, 33938.0, 34237.0, 34637.48043779396, 26819.463610728068, 27728.168154955383, 28341.0, 28422.289442764097, 28551.286217843888, 23360.53278934378, 23539.17612883541, 23579.360867387364, 23835.880820595787, 24109.276721698378], "value": 18128.494029216014, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.2843456218437, 366.22177872021956, 387.25453502008634, 391.62208468827583, 410.93835924611307, 13480.123791953529, 17285.82714172858, 18121.184546695396, 19107.617847643072, 19300.324488642902, 17601.29594816209, 17706.911465442656, 18391.0, 18400.26398944044, 19206.135723892425, 4697.7651117444075, 4938.061768264036, 4940.110780059588, 4949.975250123744, 4970.15507363749, 3583.587887392944, 3697.1496555792182, 4810.855674329776, 4879.6828206166665, 4880.292357608162, 4006.4190692349594, 4048.7570745755347, 6380.234371875382, 6480.773172938948, 6493.058506516552, 6258.906116408258, 6263.467605253559, 6392.23293204816, 6470.191226096738, 6472.644004579723, 5661.943380566183, 5666.263385759866, 5668.064769313059, 5676.403977582336, 5679.488846003838, 22036.0, 22149.778502214933, 22830.657540136912, 22924.54150916989, 22976.88511557448, 2254.5716313900307, 2313.884305784704, 2383.7377888432256, 2398.8560686358874, 2471.3327401601646, 9218.124278193562, 9682.806343873082, 9695.90304096964, 9769.951150244275, 13587.864121358758, 1667.4914151183884, 1690.4252554131654, 1716.5880188754734, 1726.3008481564987, 1735.6268402293442, 79849.60075199587, 82724.17275827225, 82976.58511707463, 84110.57944710237, 84266.57866710688, 10798.244122911321, 10985.835212471819, 10994.0, 11039.821156866808, 11090.223684342018, 15497.845021549865, 15514.146721930176, 15531.223438828014, 15538.06771593708, 15554.22228888551, 7567.621618919032, 7630.0, 7818.7654370367845, 7901.367890568741, 7913.604319783988, 7157.785266442015, 7190.316919892602, 7238.0952380952385, 7413.66638501258, 7432.033835601337, 4623.86128416148, 4629.777706700803, 4788.401449818773, 4847.297141914402, 4898.951010489921, 1856.7214917762444, 1932.7294178814977, 1940.5245714799964, 1998.510364960594, 2006.709027191049, 725.1733024352243, 744.3747252308087, 753.0, 754.1741792736944, 767.2021098058069, 17255.3960611378, 17395.04327262013, 18427.26290948347, 19999.60000800005, 20555.794442055387, 864.5907171310723, 871.302957633903, 873.3057219510505, 887.4187407248263, 892.2237653241591, 9760.658376956773, 9820.165285950774, 10061.748456288651, 10092.142167915663, 10176.643817466502, 480542.19457804976, 495623.0, 506672.0, 506853.0, 509238.0, 99930.5003474978, 101535.0, 101668.49165754272, 104980.0, 107995.46002269938, 934.3086116273909, 979.3732011512637, 999.9950000250097, 1003.3377970539555, 1003.5885287032281, 15082.472113475975, 15272.0, 15427.460038898585, 15761.448349307719, 16123.516294511184, 36855.0, 42928.57071429246, 43086.01306666905, 43583.0, 44261.77869110634, 44225.33661995137, 54939.45060549343, 55183.72408137934, 56173.71913140408, 56747.432525674216, 7806.297433231037, 7830.92169078302, 7894.1316455188735, 7967.2431119043595, 8339.583020849055, 10317.48412579353, 11889.583864564698, 12153.392330383622, 12566.371681416076, 13006.479740810262, 5350.571954243729, 6974.755883544051, 8489.514334991229, 9827.164691001344, 10293.330933489298, 10602.363858168535, 10829.133669306595, 10888.237823352289, 10921.290116142425, 11130.666080017612, 6707.396334329934, 9574.808503829745, 9903.801923961624, 10422.009909058628, 10593.205509586658, 6943.340382663639, 7092.680829362795, 7203.603801790951, 7394.8890766639615, 8052.194780521901, 8549.871751923602, 9796.461194634363, 9895.406275623485, 10158.08577228053, 10444.216683748597], "value": 8610.195736920768, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.7921932490801, 1308.659748465399, 1320.115522599858, 1332.0475859760281, 1341.9060665753402, 6946.687399067041, 7266.237045110253, 7301.6714247858845, 7377.188509263977, 7377.299156580129, 6928.411085057776, 7094.396976257011, 7171.784846454601, 7174.282571742836, 7319.926800732004, 2074.0459388681224, 2105.4104850641843, 2107.9683804742863, 2109.377733568593, 2109.9050542725536, 2008.4875103462489, 2092.4559614500185, 2099.4121645939163, 2101.7477902651704, 2102.4008157675066, 1749.658816530777, 1832.285408690605, 1979.3270288102042, 2043.1316690406593, 2052.5997430501056, 2084.9166033358647, 2100.24391219161, 2100.306898723433, 2104.537001859596, 2105.557832855087, 1792.3010026089835, 2069.3481553310658, 2141.817945474621, 2143.5498545305504, 2146.356093172042, 6371.33101024395, 7158.892616610755, 7422.443316751212, 7440.181580026193, 7615.695372185106, 4433.556644335573, 4534.705244159152, 4551.749653769041, 4557.134144512532, 4564.7717614119165, 2675.4114094899287, 2800.8879644814183, 2815.0428854189468, 2836.2200394891365, 2844.2747099489707, 1099.367863478495, 1113.4210210690396, 1122.2312715789628, 1122.360254654847, 1160.14729174057, 9850.605975761033, 9953.0, 9967.202623790079, 9968.102870741668, 9968.950155249177, 3787.0, 3951.3677811550015, 4005.4792876925812, 4010.258102251093, 4016.096378314914, 7975.7607271781935, 7979.162187970295, 7983.081945576217, 7984.6806127754235, 7996.960015199887, 4525.977370113194, 4526.072155208174, 4527.139843429738, 4531.614812740888, 4531.954680453153, 4018.9397159042637, 4123.299039163349, 4162.458880345535, 4181.60274773896, 4193.203291374629, 3358.1604598850286, 3396.626371099177, 3479.8086105263947, 3495.545579074704, 3503.0, 1048.6928756735213, 1063.1547919404093, 1066.072516910293, 1068.038765111406, 1074.4681382715605, 782.6321628834439, 805.287320721166, 807.1403954788132, 815.4699445360444, 815.8449894520022, 4713.175194340976, 4742.478327383985, 4854.344663470386, 4856.757162141949, 5148.407933087743, 513.2327170879558, 522.6994478175064, 522.8013354925104, 524.8425472358354, 540.9053415652245, 3304.619968703582, 3361.2941282330985, 3388.9661103389144, 3391.7795343302605, 3423.871746353367, 7390.556566606021, 7851.311967926923, 8331.95834020826, 8665.653373864974, 8770.605322760492, 8941.329400295004, 8949.865752013726, 8975.147361000694, 8978.82042359149, 8980.820383592292, 5958.76164953397, 6227.408396202353, 6635.0, 6875.896861547081, 6930.688119034656, 4852.514748525119, 4915.434725006527, 4964.032013757427, 4966.652334336562, 5013.373328333958, 7571.583562904093, 7642.961785191039, 7804.102528209329, 7883.526988380716, 7895.052593688794, 7832.412569057229, 7947.205279472007, 7984.281414672707, 7993.320567751573, 8053.114157442794, 5749.741261643319, 5870.148828419769, 5870.354261031369, 5876.206712093813, 5876.706164691663, 6855.280195579392, 6855.348741869514, 6911.861762764616, 6923.584584924921, 6928.549644273106, 6307.495400368051, 6321.209848768904, 6321.841953951004, 6329.936700633119, 6362.650054247061, 6218.440340369389, 6240.687965601793, 6248.625082495065, 6262.185915831095, 6272.5922815016875, 5461.044317244546, 5494.340679118532, 5523.447655234605, 5541.030319694118, 5541.2796336476, 4056.6957478188665, 4134.152498737812, 4159.91680166389, 4189.685773567056, 4207.347861081537, 4330.870073897788, 4333.068390296102, 4335.696501245009, 4410.889727756703, 4439.223135951131], "value": 3819.42101032358, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.81084997826207, 350.2854177477945, 351.38332226941714, 353.08550853290006, 359.4428635614798, 4835.782389792459, 4880.609551235902, 4884.658073934826, 4884.682495637781, 4897.436794768598, 4799.904001919968, 4819.32529445877, 4824.0, 4825.855224343275, 4834.299026641135, 3606.855725770966, 3730.7761534307892, 3744.794036328001, 3748.5501739791125, 3798.525184351956, 3766.8493260269556, 3777.0, 3789.2989796887528, 3793.4499497572833, 3795.772253664789, 3692.581359209722, 3750.4561838533396, 3753.136778540937, 3762.7930463824478, 3777.8111094445303, 3637.727170462226, 3725.3480640888006, 3761.41698036802, 3776.1314897573575, 3776.206996530732, 3268.5812498750993, 3270.5421241026274, 3272.934541309184, 3289.0297362278184, 3290.3090351026076, 4651.232546629802, 4690.296455531663, 4726.76366181693, 4729.290606409032, 4748.311494833264, 4282.550332215135, 4286.549912259199, 4305.97847010763, 4310.80601372939, 4316.438862947828, 4813.350197723297, 5025.949740502585, 5058.494150584912, 5076.416212135578, 5079.542841144278, 3571.4464258039784, 3596.856125754967, 3599.4342461029537, 3613.175346450052, 3627.383344831385, 5046.243063540462, 5171.948280517222, 5242.528172464458, 5359.1425371940695, 5374.6237763356585, 3351.1789611545328, 3462.7229821614715, 3464.5149679044953, 3466.480027995821, 3691.7046636269033, 3702.3705969985167, 3711.0, 3716.646918542734, 3721.3859713147026, 3725.4970578972034, 4217.557156498585, 4245.433835578129, 4292.926768307923, 4293.914121717548, 4296.2266791977745, 4967.40391153064, 4973.593088734228, 5037.740564858786, 5065.721385323843, 5074.340335756328, 1240.2512457434973, 1245.9377031148406, 1249.7562975219926, 1260.1305099481328, 1265.2034111561604, 814.2142832166987, 851.7827953871723, 861.9655213791503, 873.724776695339, 873.7815546113471, 4303.2469317869245, 4310.978445107817, 4320.870373888788, 4322.481302243688, 4330.783460826946, 5037.244413338029, 5064.670796398223, 5069.290299358093, 5085.694858308513, 5182.32629758129, 4362.825486980549, 4374.103308821684, 4381.715188512737, 4423.800928958204, 4431.468223813163, 2517.282574466268, 2644.1094617348303, 2692.0846912049997, 2697.9595306070423, 2702.9189124326303, 4677.462091859412, 4715.760013993395, 4718.0, 4736.810527578928, 4783.904321913542, 4916.606671466274, 5157.8452646420665, 5190.766415511311, 5205.2192171173865, 5208.739563021833, 4722.890120821673, 4729.66558576203, 4750.168720473903, 4753.643476739258, 4759.7858096386435, 5092.41437234708, 5096.51583099605, 5098.847034588968, 5115.85134243626, 5136.922946155885, 4823.807047718052, 5017.67385119966, 5029.094762942559, 5041.344625198701, 5053.570446511941, 4620.907581848277, 4732.124556956974, 4841.515848415131, 4859.3682821233015, 4896.510348965075, 3522.7357948153476, 3633.6911362533424, 3635.763675361093, 3650.616685248117, 3652.269546090846, 5204.401493828258, 5224.164133738584, 5232.215167724872, 5241.68549887008, 5246.868828279324, 4947.678400903929, 5043.672161309503, 5069.695818250917, 5077.588145630796, 5100.0, 5004.899902001866, 5024.472430394756, 5072.923906141485, 5081.288619593186, 5083.618728595444, 5008.749562521786, 5016.473270306711, 5036.169032109661, 5046.520580544842, 5049.570786483043, 4858.906745982125, 5085.46602606721, 5103.974480127576, 5104.285400044071, 5111.830664987731, 4986.900261994812, 4992.326035985096, 5007.1487847065355, 5007.949920500894, 5012.87467813293], "value": 3789.4693243930597, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.5269179844616, 671.7447369999403, 714.1109318897973, 742.3949481172843, 755.1089714137318, 12777.616671499858, 13956.93021534891, 13964.371603277852, 14057.22685252312, 14110.153390796546, 13331.733365332711, 13485.325733713324, 13494.46022159115, 13509.864901350984, 13522.932385338085, 799.936005119589, 801.1667865419971, 814.9877751833727, 816.2205094135087, 824.7072289337289, 810.7648781853255, 811.452269717941, 811.6428771340621, 811.7321283976303, 812.2689579378577, 839.7354833227545, 846.1411667157839, 846.3863698818369, 846.3990566697652, 846.5682501924032, 840.5209030852417, 840.5503055865083, 840.6931470013432, 840.8822764812932, 841.9158084191594, 616.8519555306694, 617.6016469377226, 617.8671585609071, 618.011182108627, 618.4742968476804, 13571.253581053039, 13858.16850988944, 13912.234827084507, 13942.51201207963, 13953.162810231419, 12340.38298085101, 12431.627051188389, 12628.747425051448, 13426.664333391645, 13682.863171368259, 11109.166812489095, 11221.943890280578, 11306.095512358992, 11355.375454350007, 11405.144614153889, 3787.6591106800242, 3803.562590302123, 3874.8062596870045, 3973.443717879499, 3974.046228905042, 62165.378346216414, 63886.0, 64215.35784642141, 64399.356006439804, 65185.674071629815, 9901.257405694601, 9941.204703623693, 10093.798124037625, 10334.224933130045, 10384.688459346231, 17518.38685645996, 17622.911885440746, 17711.202995865217, 17810.376636817648, 17815.10924453772, 6313.747450101944, 6369.5222858285815, 6407.0, 6492.837679058061, 6527.902081468782, 3344.665533446636, 3361.4957756336257, 3388.508666243381, 3409.3522230776075, 3457.8271086445575, 2813.4795062913427, 2862.7137286271204, 2884.336602581418, 2891.2916335497516, 2895.319599894023, 498.9226669866104, 504.1807063521777, 511.0366958283662, 512.6360284198187, 512.9794808207705, 547.6741338903346, 551.503646717949, 563.2002556369964, 578.0, 592.2123575644382, 8047.155048719917, 8048.275655191061, 8243.216894395024, 8248.917510824815, 8336.458130221516, 423.2592962315947, 425.987220383389, 433.5859254412029, 459.3362591055959, 472.3175012107472, 3974.960250397517, 4008.7193896427552, 4073.429719839225, 4165.062860856283, 4247.532771395144, 63384.36615633785, 65758.0, 66784.69763243823, 68016.319836801, 68971.3102868975, 57507.42492575021, 58343.70828145832, 60473.0, 60566.0, 61027.38972610306, 50366.74816625967, 50548.74725626496, 50820.0, 50916.74541627268, 50941.745291273306, 7592.582407967394, 7620.542767433972, 7706.884396733942, 7870.212978702084, 7929.246721561442, 36433.0, 36525.63474365223, 36997.890063298146, 37982.0, 37998.042362480846, 43712.34431483594, 44608.553914461736, 46044.30933536067, 47682.0, 47803.52196477991, 8805.779855503664, 8942.150495702897, 9018.549072546477, 9383.390079644802, 9720.173785228335, 10054.8491772622, 10093.899061009295, 10253.231007674603, 10328.018838210359, 10729.839052414063, 9357.672481463116, 9419.293552983416, 9506.857397139187, 9625.759356015875, 9656.130948214695, 9651.131398174199, 9716.174125199437, 9720.368176068532, 9733.513324333897, 9771.267154963549, 8629.95685021596, 8633.223009929137, 8702.782430439289, 8810.0, 9034.548272586213, 7756.340711039399, 7853.293203611703, 8023.879641805261, 8064.153263907206, 8084.231997960184, 7375.778726638209, 7443.702251909863, 7450.701971921062, 7468.92531074704, 7507.286807753255], "value": 6012.1059728320915, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 116.0, 117.0, 117.0, 115.0, 115.0, 115.0, 114.0, 114.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 127.0, 127.0, 171.0, 129.0, 127.0, 123.0, 124.0, 151.0, 124.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 161.0, 162.0, 161.0, 162.0, 162.0, 161.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 100.0, 77.0, 78.0, 76.0, 78.0, 102.0, 76.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 104.0, 85.0, 84.0, 84.0, 102.0, 83.0, 85.0, 110.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 120.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 150.0, 148.0, 149.0, 148.0, 148.0, 148.0, 149.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 94.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 62.0, 61.0, 63.0, 62.0, 63.0, 70.0], "value": 62.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 68.0, 67.0, 68.0, 67.0, 66.0, 67.0, 68.0], "value": 67.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 88.0, 91.0, 85.0, 85.0, 85.0, 86.0, 85.0, 85.0, 84.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 138.0, 131.0, 133.0, 142.0, 131.0, 132.0, 131.0, 181.0, 152.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 180.0, 180.0, 178.0, 176.0, 183.0, 178.0, 180.0, 181.0, 184.0], "value": 180.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 68.0, 69.0, 67.0, 66.0, 66.0, 68.0, 67.0], "value": 67.3, "unit": "score"}]}]} 17:44:29 INFO - Return code: 0 17:44:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:44:29 ERROR - # TBPL SUCCESS # 17:44:29 INFO - Running post-action listener: _resource_record_post_action 17:44:29 INFO - [mozharness: 2017-02-03 01:44:29.126665Z] Finished run-tests step (success) 17:44:29 INFO - Running post-run listener: _resource_record_post_run 17:44:29 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 385392640; Read time: 4; Write time: 245932 17:44:29 INFO - TinderboxPrint: CPU usage
13.1% 17:44:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 17:44:29 INFO - TinderboxPrint: I/O write bytes / time
385,392,640 / 245,932 17:44:29 INFO - TinderboxPrint: CPU idle
8,324.3 (86.9%) 17:44:29 INFO - TinderboxPrint: CPU user
1,211.0 (12.6%) 17:44:29 INFO - TinderboxPrint: Swap in / out
0 / 0 17:44:29 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 99655680; Read time: 0; Write time: 69748 17:44:29 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 285736960; Read time: 0; Write time: 176184 17:44:29 INFO - Running post-run listener: _upload_blobber_files 17:44:29 INFO - Blob upload gear active. 17:44:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:44:29 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 17:44:29 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'] 17:44:29 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 17:44:30 INFO - (blobuploader) - INFO - Open directory for files ... 17:44:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:44:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:44:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:44:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:44:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:44:31 INFO - (blobuploader) - INFO - Done attempting. 17:44:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:44:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:44:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:44:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:44:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:44:35 INFO - (blobuploader) - INFO - Done attempting. 17:44:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:44:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:44:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:44:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:44:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:44:35 INFO - (blobuploader) - INFO - Done attempting. 17:44:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:44:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:44:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:44:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:44:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:44:36 INFO - (blobuploader) - INFO - Done attempting. 17:44:36 INFO - (blobuploader) - INFO - Iteration through files over. 17:44:36 INFO - Return code: 0 17:44:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:44:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:44:36 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b161e858de9a3df790ad655960baea47b987e804e0e5a5e646a09069486464ee9f8ece5019f6553dba1c7a8dbd16a58200a10b7cd843f9aecebfc65f81693b31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad82ea50711f749d0e225afd922b565db8a47a9d5e44d98419305b7d8d02e23bc0f7aaacd95ac2796016d533aba2b032d373efb570bd41627c9f23d6801897ba", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5889970899684599a23b25ef823ec3bf738922a9c21864a04412514a07db99873ef374c1a8dade438c757dd37395904bd62ea42503050f2fa10d32abf8df3883", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8a006a4d60540e5f506632a235b6c15666e91209defb9bbca22113ed4f1459028b6cbae06ad43a1ee2085b390dd388a300582ba8c398df269e00a55003417d63"} 17:44:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:44:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:44:36 INFO - Contents: 17:44:36 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b161e858de9a3df790ad655960baea47b987e804e0e5a5e646a09069486464ee9f8ece5019f6553dba1c7a8dbd16a58200a10b7cd843f9aecebfc65f81693b31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad82ea50711f749d0e225afd922b565db8a47a9d5e44d98419305b7d8d02e23bc0f7aaacd95ac2796016d533aba2b032d373efb570bd41627c9f23d6801897ba", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5889970899684599a23b25ef823ec3bf738922a9c21864a04412514a07db99873ef374c1a8dade438c757dd37395904bd62ea42503050f2fa10d32abf8df3883", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8a006a4d60540e5f506632a235b6c15666e91209defb9bbca22113ed4f1459028b6cbae06ad43a1ee2085b390dd388a300582ba8c398df269e00a55003417d63"} 17:44:36 INFO - Running post-run listener: copy_logs_to_upload_dir 17:44:36 INFO - Copying logs to upload dir... 17:44:36 INFO - mkdir: /builds/slave/test/build/upload/logs 17:44:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.926597 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-02-02 17:44:36.425039) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 17:44:36.429286) ========= 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=523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571 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/b161e858de9a3df790ad655960baea47b987e804e0e5a5e646a09069486464ee9f8ece5019f6553dba1c7a8dbd16a58200a10b7cd843f9aecebfc65f81693b31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad82ea50711f749d0e225afd922b565db8a47a9d5e44d98419305b7d8d02e23bc0f7aaacd95ac2796016d533aba2b032d373efb570bd41627c9f23d6801897ba", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5889970899684599a23b25ef823ec3bf738922a9c21864a04412514a07db99873ef374c1a8dade438c757dd37395904bd62ea42503050f2fa10d32abf8df3883", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8a006a4d60540e5f506632a235b6c15666e91209defb9bbca22113ed4f1459028b6cbae06ad43a1ee2085b390dd388a300582ba8c398df269e00a55003417d63"} build_url:https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011404 build_url: 'https://queue.taskcluster.net/v1/task/eKoSjl51RMuAlXDLo7KL_Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b161e858de9a3df790ad655960baea47b987e804e0e5a5e646a09069486464ee9f8ece5019f6553dba1c7a8dbd16a58200a10b7cd843f9aecebfc65f81693b31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad82ea50711f749d0e225afd922b565db8a47a9d5e44d98419305b7d8d02e23bc0f7aaacd95ac2796016d533aba2b032d373efb570bd41627c9f23d6801897ba", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5889970899684599a23b25ef823ec3bf738922a9c21864a04412514a07db99873ef374c1a8dade438c757dd37395904bd62ea42503050f2fa10d32abf8df3883", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8a006a4d60540e5f506632a235b6c15666e91209defb9bbca22113ed4f1459028b6cbae06ad43a1ee2085b390dd388a300582ba8c398df269e00a55003417d63"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 17:44:36.461155) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 17:44:36.461785) ========= 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=523ca41ca1e0623de333ad52000001bf-1486085022.793311-787689571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 17:44:36.544026) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 17:44:36.544359) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 17:44:36.544701) ========= ========= Total master_lag: 0.18 =========