builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-080 starttime: 1490195909.04 results: success (0) revision: 00c595de162736689a83e894a84f9eb99a5fa6ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:29.040774) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:29.041240) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:29.041549) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:29.060487) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:29.060820) ========= 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=781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-22 08:18:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2017-03-22 08:18:29 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.091347 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:29.166810) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:29.167159) ========= 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=781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018160 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:29.217374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:29.217758) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 00c595de162736689a83e894a84f9eb99a5fa6ac --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 00c595de162736689a83e894a84f9eb99a5fa6ac --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=781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-22 08:18:29,351 truncating revision to first 12 chars 2017-03-22 08:18:29,351 Setting DEBUG logging. 2017-03-22 08:18:29,351 attempt 1/10 2017-03-22 08:18:29,351 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/00c595de1627?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-22 08:18:29,882 unpacking tar archive at: mozilla-central-00c595de1627/testing/mozharness/ program finished with exit code 0 elapsedTime=0.797019 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:30.126358) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:30.126853) ========= script_repo_revision: 00c595de162736689a83e894a84f9eb99a5fa6ac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:30.127536) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:30.127832) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:30.139111) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-03-22 08:18:30.139588) ========= /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=781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:18:30 INFO - MultiFileLogger online at 20170322 08:18:30 in /builds/slave/test 08:18:30 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 08:18:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:18:30 INFO - {'append_to_log': False, 08:18:30 INFO - 'base_work_dir': '/builds/slave/test', 08:18:30 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:18:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:18:30 INFO - 'branch': 'Firefox-Non-PGO', 08:18:30 INFO - 'buildbot_json_path': 'buildprops.json', 08:18:30 INFO - 'config_files': ('talos/linux_config.py',), 08:18:30 INFO - 'default_actions': ('clobber', 08:18:30 INFO - 'read-buildbot-config', 08:18:30 INFO - 'download-and-extract', 08:18:30 INFO - 'populate-webroot', 08:18:30 INFO - 'create-virtualenv', 08:18:30 INFO - 'install', 08:18:30 INFO - 'run-tests'), 08:18:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:18:30 INFO - 'download_minidump_stackwalk': True, 08:18:30 INFO - 'download_symbols': 'ondemand', 08:18:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:18:30 INFO - 'tooltool.py': '/tools/tooltool.py', 08:18:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:18:30 INFO - '/tools/misc-python/virtualenv.py')}, 08:18:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:18:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:18:30 INFO - 'gecko_profile': False, 08:18:30 INFO - 'gecko_profile_interval': 0, 08:18:30 INFO - 'installer_path': 'installer.exe', 08:18:30 INFO - 'log_level': 'info', 08:18:30 INFO - 'log_name': 'talos', 08:18:30 INFO - 'log_to_console': True, 08:18:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:18:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:18:30 INFO - 'opt_config_files': (), 08:18:30 INFO - 'pip_index': False, 08:18:30 INFO - 'suite': 'dromaeojs', 08:18:30 INFO - 'system_bits': '32', 08:18:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:18:30 INFO - 'title': 'talos-linux64-ix-080', 08:18:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:18:30 INFO - 'use_talos_json': True, 08:18:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:18:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:18:30 INFO - 'work_dir': 'build'} 08:18:30 INFO - [mozharness: 2017-03-22 15:18:30.376786Z] Running clobber step. 08:18:30 INFO - Running pre-action listener: _resource_record_pre_action 08:18:30 INFO - Running main action method: clobber 08:18:30 INFO - rmtree: /builds/slave/test/build 08:18:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:18:31 INFO - Running post-action listener: _resource_record_post_action 08:18:31 INFO - [mozharness: 2017-03-22 15:18:31.825742Z] Finished clobber step (success) 08:18:31 INFO - [mozharness: 2017-03-22 15:18:31.825840Z] Running read-buildbot-config step. 08:18:31 INFO - Running pre-action listener: _resource_record_pre_action 08:18:31 INFO - Running main action method: read_buildbot_config 08:18:31 INFO - Using buildbot properties: 08:18:31 INFO - { 08:18:31 INFO - "project": "", 08:18:31 INFO - "product": "firefox", 08:18:31 INFO - "who": "ffxbld@noreply.mozilla.org", 08:18:31 INFO - "installer_path": "public/build/target.tar.bz2", 08:18:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:18:31 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:18:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:18:31 INFO - "stage_platform": "linux64", 08:18:31 INFO - "basedir": "/builds/slave/test", 08:18:31 INFO - "buildnumber": 891, 08:18:31 INFO - "platform": "ubuntu64_hw", 08:18:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:18:31 INFO - "slavebuilddir": "test", 08:18:31 INFO - "taskId": "YAVGEVUBQI-J5rwCwBxGnw", 08:18:31 INFO - "branch": "mozilla-central", 08:18:31 INFO - "script_repo_revision": "production", 08:18:31 INFO - "revision": "00c595de162736689a83e894a84f9eb99a5fa6ac", 08:18:31 INFO - "slavename": "talos-linux64-ix-080", 08:18:31 INFO - "repo_path": "mozilla-central" 08:18:31 INFO - } 08:18:31 INFO - Finding installer, test and symbols from parent task. 08:18:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YAVGEVUBQI-J5rwCwBxGnw'}, attempt #1 08:18:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YAVGEVUBQI-J5rwCwBxGnw'}, attempt #1 08:18:32 INFO - Task dependencies: NCVlMVCEQb6oMUK_FqfiRg 08:18:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg'}, attempt #1 08:18:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.tar.bz2 08:18:33 INFO - Set test_url: https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/test_packages.json 08:18:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.crashreporter-symbols.zip 08:18:33 INFO - Running post-action listener: _resource_record_post_action 08:18:33 INFO - [mozharness: 2017-03-22 15:18:33.230503Z] Finished read-buildbot-config step (success) 08:18:33 INFO - [mozharness: 2017-03-22 15:18:33.230723Z] Running download-and-extract step. 08:18:33 INFO - Running pre-action listener: _resource_record_pre_action 08:18:33 INFO - Running main action method: download_and_extract 08:18:33 INFO - mkdir: /builds/slave/test/build/tests 08:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:33 INFO - trying https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.test_packages.json 08:18:33 INFO - Downloading https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:18:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:18:33 INFO - Downloaded 986 bytes. 08:18:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:18:33 INFO - Using the following test package requirements: 08:18:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:18:33 INFO - u'common': [u'target.common.tests.zip'], 08:18:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:18:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:18:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:18:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:18:33 INFO - u'mozbase': [u'target.common.tests.zip'], 08:18:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:18:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:18:33 INFO - u'web-platform': [u'target.common.tests.zip', 08:18:33 INFO - u'target.web-platform.tests.zip'], 08:18:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:18:33 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:18:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.common.tests.zip 08:18:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:18:33 INFO - Fetch https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.common.tests.zip into memory 08:18:34 INFO - Expected file size: 58119319 08:18:34 INFO - Obtained file size: 58119319 08:18:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:18:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.common.tests.zip 08:18:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:18:44 INFO - Fetch https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.common.tests.zip into memory 08:18:45 INFO - Expected file size: 58119319 08:18:45 INFO - Obtained file size: 58119319 08:18:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.talos.tests.zip 08:18:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:18:56 INFO - Fetch https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.talos.tests.zip into memory 08:18:57 INFO - Expected file size: 14404171 08:18:57 INFO - Obtained file size: 14404171 08:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:57 INFO - trying https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.tar.bz2 08:18:57 INFO - Downloading https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:18:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:18:58 INFO - Downloaded 61863816 bytes. 08:18:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.tar.bz2 08:18:58 INFO - mkdir: /builds/slave/test/properties 08:18:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:18:58 INFO - Writing to file /builds/slave/test/properties/build_url 08:18:58 INFO - Contents: 08:18:58 INFO - build_url:https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.tar.bz2 08:18:58 INFO - Running post-action listener: _resource_record_post_action 08:18:58 INFO - Running post-action listener: set_extra_try_arguments 08:18:58 INFO - [mozharness: 2017-03-22 15:18:58.434852Z] Finished download-and-extract step (success) 08:18:58 INFO - [mozharness: 2017-03-22 15:18:58.434949Z] Running populate-webroot step. 08:18:58 INFO - Running pre-action listener: _resource_record_pre_action 08:18:58 INFO - Running main action method: populate_webroot 08:18:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:18:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:18:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:18:58 INFO - '--tppagecycles', 08:18:58 INFO - '7'], 08:18:58 INFO - 'tests': ['tsvgm']}}, 08:18:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:18:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:18:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:18:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:18:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:18:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:18:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:18:58 INFO - 'talos_options': ['--disable-e10s'], 08:18:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:18:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:18:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:18:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:18:58 INFO - 'talos_options': ['--disable-e10s'], 08:18:58 INFO - 'tests': ['damp', 'tps']}, 08:18:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:18:58 INFO - 'tests': ['damp', 'tps']}, 08:18:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:18:58 INFO - 'tests': ['dromaeo_dom']}, 08:18:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:18:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:18:58 INFO - 'tests': ['basic_compositor_video']}, 08:18:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:18:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:18:58 INFO - 'tests': ['a11yr', 08:18:58 INFO - 'ts_paint', 08:18:58 INFO - 'tpaint', 08:18:58 INFO - 'sessionrestore', 08:18:58 INFO - 'sessionrestore_no_auto_restore', 08:18:58 INFO - 'tabpaint']}, 08:18:58 INFO - 'other-e10s': {'tests': ['a11yr', 08:18:58 INFO - 'ts_paint', 08:18:58 INFO - 'tpaint', 08:18:58 INFO - 'sessionrestore', 08:18:58 INFO - 'sessionrestore_no_auto_restore', 08:18:58 INFO - 'tabpaint']}, 08:18:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:18:58 INFO - 'ts_paint', 08:18:58 INFO - 'tpaint', 08:18:58 INFO - 'sessionrestore', 08:18:58 INFO - 'sessionrestore_no_auto_restore', 08:18:58 INFO - 'tabpaint']}, 08:18:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:18:58 INFO - 'ts_paint', 08:18:58 INFO - 'tpaint', 08:18:58 INFO - 'sessionrestore', 08:18:58 INFO - 'sessionrestore_no_auto_restore', 08:18:58 INFO - 'tabpaint']}, 08:18:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:18:58 INFO - 'tests': ['a11yr', 08:18:58 INFO - 'ts_paint', 08:18:58 INFO - 'tpaint', 08:18:58 INFO - 'sessionrestore', 08:18:58 INFO - 'sessionrestore_no_auto_restore', 08:18:58 INFO - 'tabpaint']}, 08:18:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:18:58 INFO - 'tests': ['a11yr', 08:18:58 INFO - 'ts_paint', 08:18:58 INFO - 'tpaint', 08:18:58 INFO - 'sessionrestore', 08:18:58 INFO - 'sessionrestore_no_auto_restore', 08:18:58 INFO - 'tabpaint']}, 08:18:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:18:58 INFO - 'tests': ['tsvgx', 08:18:58 INFO - 'tsvgr_opacity', 08:18:58 INFO - 'tart', 08:18:58 INFO - 'tscrollx', 08:18:58 INFO - 'cart', 08:18:58 INFO - 'tsvg_static']}, 08:18:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:18:58 INFO - 'tsvgr_opacity', 08:18:58 INFO - 'tart', 08:18:58 INFO - 'tscrollx', 08:18:58 INFO - 'cart', 08:18:58 INFO - 'tsvg_static']}, 08:18:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:18:58 INFO - 'talos_options': ['--disable-e10s'], 08:18:58 INFO - 'tests': ['tp5o']}, 08:18:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:18:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:18:58 INFO - 'talos_options': ['--disable-e10s', 08:18:58 INFO - '--xperf_path', 08:18:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:18:58 INFO - 'tests': ['tp5n']}, 08:18:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:18:58 INFO - 'talos_options': ['--xperf_path', 08:18:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:18:58 INFO - 'tests': ['tp5n']}}, 08:18:58 INFO - 'talos.zip': {'path': '', 08:18:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:18:58 INFO - Running post-action listener: _resource_record_post_action 08:18:58 INFO - [mozharness: 2017-03-22 15:18:58.448059Z] Finished populate-webroot step (success) 08:18:58 INFO - [mozharness: 2017-03-22 15:18:58.448148Z] Running create-virtualenv step. 08:18:58 INFO - Running pre-action listener: _resource_record_pre_action 08:18:58 INFO - Running main action method: create_virtualenv 08:18:58 INFO - Creating virtualenv /builds/slave/test/build/venv 08:18:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:18:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:18:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:18:58 INFO - Using real prefix '/usr' 08:18:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:18:59 INFO - Installing distribute.............................................................................................................................................................................................done. 08:19:01 INFO - Installing pip.................done. 08:19:01 INFO - Return code: 0 08:19:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:19:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:19:01 INFO - Reading from file tmpfile_stdout 08:19:01 INFO - Output received: 08:19:01 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:19:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:01 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 0xdb81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053290>, '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 0x1053b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054040>, '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': '781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:19:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:19:01 INFO - Using env: {'DISPLAY': ':0', 08:19:01 INFO - 'HOME': '/home/cltbld', 08:19:01 INFO - 'LANG': 'en_US.UTF-8', 08:19:01 INFO - 'LANGUAGE': 'en_US:en', 08:19:01 INFO - 'LOGNAME': 'cltbld', 08:19:01 INFO - 'MAIL': '/var/mail/cltbld', 08:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:01 INFO - 'MOZ_NO_REMOTE': '1', 08:19:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:01 INFO - 'NO_EM_RESTART': '1', 08:19:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:01 INFO - 'PWD': '/builds/slave/test', 08:19:01 INFO - 'SHELL': '/bin/bash', 08:19:01 INFO - 'SHLVL': '1', 08:19:01 INFO - 'TERM': 'linux', 08:19:01 INFO - 'TMOUT': '86400', 08:19:01 INFO - 'USER': 'cltbld', 08:19:01 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913', 08:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:01 INFO - '_': '/tools/buildbot/bin/python'} 08:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:19:01 INFO - Cleaning up... 08:19:01 INFO - Return code: 0 08:19:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:01 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 0xdb81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053290>, '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 0x1053b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054040>, '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': '781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:19:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:19:01 INFO - Using env: {'DISPLAY': ':0', 08:19:01 INFO - 'HOME': '/home/cltbld', 08:19:01 INFO - 'LANG': 'en_US.UTF-8', 08:19:01 INFO - 'LANGUAGE': 'en_US:en', 08:19:01 INFO - 'LOGNAME': 'cltbld', 08:19:01 INFO - 'MAIL': '/var/mail/cltbld', 08:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:01 INFO - 'MOZ_NO_REMOTE': '1', 08:19:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:01 INFO - 'NO_EM_RESTART': '1', 08:19:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:01 INFO - 'PWD': '/builds/slave/test', 08:19:01 INFO - 'SHELL': '/bin/bash', 08:19:01 INFO - 'SHLVL': '1', 08:19:01 INFO - 'TERM': 'linux', 08:19:01 INFO - 'TMOUT': '86400', 08:19:01 INFO - 'USER': 'cltbld', 08:19:01 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913', 08:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:01 INFO - '_': '/tools/buildbot/bin/python'} 08:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:01 INFO - Downloading/unpacking psutil>=3.1.1 08:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:19:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:03 INFO - Installing collected packages: psutil 08:19:03 INFO - Running setup.py install for psutil 08:19:03 INFO - building 'psutil._psutil_linux' extension 08:19:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:19:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:19:04 INFO - building 'psutil._psutil_posix' extension 08:19:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:19:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:19:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:04 INFO - Successfully installed psutil 08:19:04 INFO - Cleaning up... 08:19:04 INFO - Return code: 0 08:19:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053290>, '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 0x1053b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054040>, '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': '781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:19:04 INFO - Using env: {'DISPLAY': ':0', 08:19:04 INFO - 'HOME': '/home/cltbld', 08:19:04 INFO - 'LANG': 'en_US.UTF-8', 08:19:04 INFO - 'LANGUAGE': 'en_US:en', 08:19:04 INFO - 'LOGNAME': 'cltbld', 08:19:04 INFO - 'MAIL': '/var/mail/cltbld', 08:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:04 INFO - 'MOZ_NO_REMOTE': '1', 08:19:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:04 INFO - 'NO_EM_RESTART': '1', 08:19:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:04 INFO - 'PWD': '/builds/slave/test', 08:19:04 INFO - 'SHELL': '/bin/bash', 08:19:04 INFO - 'SHLVL': '1', 08:19:04 INFO - 'TERM': 'linux', 08:19:04 INFO - 'TMOUT': '86400', 08:19:04 INFO - 'USER': 'cltbld', 08:19:04 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913', 08:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:04 INFO - '_': '/tools/buildbot/bin/python'} 08:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:19:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:19:06 INFO - Installing collected packages: mozsystemmonitor 08:19:06 INFO - Running setup.py install for mozsystemmonitor 08:19:06 INFO - Successfully installed mozsystemmonitor 08:19:06 INFO - Cleaning up... 08:19:06 INFO - Return code: 0 08:19:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:06 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 0xdb81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053290>, '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 0x1053b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054040>, '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': '781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:19:06 INFO - Using env: {'DISPLAY': ':0', 08:19:06 INFO - 'HOME': '/home/cltbld', 08:19:06 INFO - 'LANG': 'en_US.UTF-8', 08:19:06 INFO - 'LANGUAGE': 'en_US:en', 08:19:06 INFO - 'LOGNAME': 'cltbld', 08:19:06 INFO - 'MAIL': '/var/mail/cltbld', 08:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:06 INFO - 'MOZ_NO_REMOTE': '1', 08:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:06 INFO - 'NO_EM_RESTART': '1', 08:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:06 INFO - 'PWD': '/builds/slave/test', 08:19:06 INFO - 'SHELL': '/bin/bash', 08:19:06 INFO - 'SHLVL': '1', 08:19:06 INFO - 'TERM': 'linux', 08:19:06 INFO - 'TMOUT': '86400', 08:19:06 INFO - 'USER': 'cltbld', 08:19:06 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913', 08:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:06 INFO - '_': '/tools/buildbot/bin/python'} 08:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:07 INFO - Downloading/unpacking jsonschema==2.5.1 08:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:19:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:09 INFO - Downloading functools32-3.2.3-2.tar.gz 08:19:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:19:09 INFO - warning: no files found matching '*.txt' 08:19:09 INFO - no previously-included directories found matching 'build' 08:19:09 INFO - no previously-included directories found matching 'dist' 08:19:09 INFO - no previously-included directories found matching '.git*' 08:19:09 INFO - Installing collected packages: jsonschema, functools32 08:19:09 INFO - Running setup.py install for functools32 08:19:09 INFO - warning: no files found matching '*.txt' 08:19:09 INFO - no previously-included directories found matching 'build' 08:19:09 INFO - no previously-included directories found matching 'dist' 08:19:09 INFO - no previously-included directories found matching '.git*' 08:19:09 INFO - Successfully installed jsonschema functools32 08:19:09 INFO - Cleaning up... 08:19:09 INFO - Return code: 0 08:19:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:09 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 0xdb81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053290>, '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 0x1053b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054040>, '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': '781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:19:09 INFO - Using env: {'DISPLAY': ':0', 08:19:09 INFO - 'HOME': '/home/cltbld', 08:19:09 INFO - 'LANG': 'en_US.UTF-8', 08:19:09 INFO - 'LANGUAGE': 'en_US:en', 08:19:09 INFO - 'LOGNAME': 'cltbld', 08:19:09 INFO - 'MAIL': '/var/mail/cltbld', 08:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:09 INFO - 'MOZ_NO_REMOTE': '1', 08:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:09 INFO - 'NO_EM_RESTART': '1', 08:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:09 INFO - 'PWD': '/builds/slave/test', 08:19:09 INFO - 'SHELL': '/bin/bash', 08:19:09 INFO - 'SHLVL': '1', 08:19:09 INFO - 'TERM': 'linux', 08:19:09 INFO - 'TMOUT': '86400', 08:19:09 INFO - 'USER': 'cltbld', 08:19:09 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913', 08:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:09 INFO - '_': '/tools/buildbot/bin/python'} 08:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:19:09 INFO - Cleaning up... 08:19:09 INFO - Return code: 0 08:19:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:09 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 0xdb81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053290>, '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 0x1053b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054040>, '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': '781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:19:09 INFO - Using env: {'DISPLAY': ':0', 08:19:09 INFO - 'HOME': '/home/cltbld', 08:19:09 INFO - 'LANG': 'en_US.UTF-8', 08:19:09 INFO - 'LANGUAGE': 'en_US:en', 08:19:09 INFO - 'LOGNAME': 'cltbld', 08:19:09 INFO - 'MAIL': '/var/mail/cltbld', 08:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:09 INFO - 'MOZ_NO_REMOTE': '1', 08:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:09 INFO - 'NO_EM_RESTART': '1', 08:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:09 INFO - 'PWD': '/builds/slave/test', 08:19:09 INFO - 'SHELL': '/bin/bash', 08:19:09 INFO - 'SHLVL': '1', 08:19:09 INFO - 'TERM': 'linux', 08:19:09 INFO - 'TMOUT': '86400', 08:19:09 INFO - 'USER': 'cltbld', 08:19:09 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913', 08:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:09 INFO - '_': '/tools/buildbot/bin/python'} 08:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:10 INFO - Downloading/unpacking blobuploader==1.2.4 08:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:12 INFO - Downloading blobuploader-1.2.4.tar.gz 08:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:19:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:19:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:12 INFO - Downloading docopt-0.6.1.tar.gz 08:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:19:12 INFO - Installing collected packages: blobuploader, requests, docopt 08:19:12 INFO - Running setup.py install for blobuploader 08:19:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:19:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:19:12 INFO - Running setup.py install for requests 08:19:13 INFO - Running setup.py install for docopt 08:19:13 INFO - Successfully installed blobuploader requests docopt 08:19:13 INFO - Cleaning up... 08:19:13 INFO - Return code: 0 08:19:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:13 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 0xdb81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053290>, '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 0x1053b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054040>, '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': '781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:19:13 INFO - Using env: {'DISPLAY': ':0', 08:19:13 INFO - 'HOME': '/home/cltbld', 08:19:13 INFO - 'LANG': 'en_US.UTF-8', 08:19:13 INFO - 'LANGUAGE': 'en_US:en', 08:19:13 INFO - 'LOGNAME': 'cltbld', 08:19:13 INFO - 'MAIL': '/var/mail/cltbld', 08:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:13 INFO - 'MOZ_NO_REMOTE': '1', 08:19:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:13 INFO - 'NO_EM_RESTART': '1', 08:19:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:13 INFO - 'PWD': '/builds/slave/test', 08:19:13 INFO - 'SHELL': '/bin/bash', 08:19:13 INFO - 'SHLVL': '1', 08:19:13 INFO - 'TERM': 'linux', 08:19:13 INFO - 'TMOUT': '86400', 08:19:13 INFO - 'USER': 'cltbld', 08:19:13 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913', 08:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:13 INFO - '_': '/tools/buildbot/bin/python'} 08:19:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:19:13 INFO - Running setup.py (path:/tmp/pip-W8rBEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:19:13 INFO - Running setup.py (path:/tmp/pip-EYaRZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:19:13 INFO - Running setup.py (path:/tmp/pip-MymdcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:19:13 INFO - Running setup.py (path:/tmp/pip-zAa7vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:19:13 INFO - Running setup.py (path:/tmp/pip-w1FUZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:19:14 INFO - Running setup.py (path:/tmp/pip-twWWMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:19:14 INFO - Running setup.py (path:/tmp/pip-g3ffG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:19:14 INFO - Running setup.py (path:/tmp/pip-CG8Usj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:19:14 INFO - Running setup.py (path:/tmp/pip-MiGVSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:19:14 INFO - Running setup.py (path:/tmp/pip-4PpOKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:19:14 INFO - Running setup.py (path:/tmp/pip-LQIhcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:19:14 INFO - Running setup.py (path:/tmp/pip-nDsaw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:19:14 INFO - Running setup.py (path:/tmp/pip-tDWFth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:19:14 INFO - Running setup.py (path:/tmp/pip-JjLyAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:14 INFO - Running setup.py (path:/tmp/pip-ZRulxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:19:14 INFO - Running setup.py (path:/tmp/pip-nc73li-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:19:14 INFO - Running setup.py (path:/tmp/pip-xSnqI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:19:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:19:14 INFO - Running setup.py install for manifestparser 08:19:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:19:15 INFO - Running setup.py install for mozcrash 08:19:15 INFO - Running setup.py install for mozdebug 08:19:15 INFO - Running setup.py install for mozdevice 08:19:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:19:15 INFO - Running setup.py install for mozfile 08:19:15 INFO - Running setup.py install for mozhttpd 08:19:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:19:15 INFO - Running setup.py install for mozinfo 08:19:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:19:15 INFO - Running setup.py install for mozInstall 08:19:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:19:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:19:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:19:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:19:15 INFO - Running setup.py install for mozleak 08:19:15 INFO - Running setup.py install for mozlog 08:19:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:19:15 INFO - Running setup.py install for moznetwork 08:19:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:19:16 INFO - Running setup.py install for mozprocess 08:19:16 INFO - Running setup.py install for mozprofile 08:19:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:19:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:19:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:19:16 INFO - Running setup.py install for mozrunner 08:19:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:19:16 INFO - Running setup.py install for mozscreenshot 08:19:16 INFO - Running setup.py install for moztest 08:19:16 INFO - Running setup.py install for mozversion 08:19:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:19:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:19:16 INFO - Cleaning up... 08:19:16 INFO - Return code: 0 08:19:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19: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')]} 08:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19: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')]} 08:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:16 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 0xdb81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053290>, '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 0x1053b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054040>, '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': '781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:19:16 INFO - Using env: {'DISPLAY': ':0', 08:19:16 INFO - 'HOME': '/home/cltbld', 08:19:16 INFO - 'LANG': 'en_US.UTF-8', 08:19:16 INFO - 'LANGUAGE': 'en_US:en', 08:19:16 INFO - 'LOGNAME': 'cltbld', 08:19:16 INFO - 'MAIL': '/var/mail/cltbld', 08:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:16 INFO - 'MOZ_NO_REMOTE': '1', 08:19:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:16 INFO - 'NO_EM_RESTART': '1', 08:19:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:16 INFO - 'PWD': '/builds/slave/test', 08:19:16 INFO - 'SHELL': '/bin/bash', 08:19:16 INFO - 'SHLVL': '1', 08:19:16 INFO - 'TERM': 'linux', 08:19:16 INFO - 'TMOUT': '86400', 08:19:16 INFO - 'USER': 'cltbld', 08:19:16 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913', 08:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:16 INFO - '_': '/tools/buildbot/bin/python'} 08:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:19:16 INFO - Running setup.py (path:/tmp/pip-tYIF6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:19:17 INFO - Running setup.py (path:/tmp/pip-0UoVqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:19:17 INFO - Running setup.py (path:/tmp/pip-61r5uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:19:17 INFO - Running setup.py (path:/tmp/pip-277JR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:19:17 INFO - Running setup.py (path:/tmp/pip-er4NmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:19:17 INFO - Running setup.py (path:/tmp/pip-mdQvk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:19:17 INFO - Running setup.py (path:/tmp/pip-tkrmLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:19:17 INFO - Running setup.py (path:/tmp/pip-VQpW49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:19:17 INFO - Running setup.py (path:/tmp/pip-sLfA78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:19:17 INFO - Running setup.py (path:/tmp/pip-5aPEsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:19:17 INFO - Running setup.py (path:/tmp/pip-HGj6on-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:19:17 INFO - Running setup.py (path:/tmp/pip-enV8uC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:19:17 INFO - Running setup.py (path:/tmp/pip-9qnwYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:19:17 INFO - Running setup.py (path:/tmp/pip-RV_e5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:17 INFO - Running setup.py (path:/tmp/pip-G3EdPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:19:18 INFO - Running setup.py (path:/tmp/pip-LY5pBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:19:18 INFO - Running setup.py (path:/tmp/pip-3YhpkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:19:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:20 INFO - Downloading blessings-1.6.tar.gz 08:19:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:19:20 INFO - Installing collected packages: blessings 08:19:20 INFO - Running setup.py install for blessings 08:19:20 INFO - Successfully installed blessings 08:19:20 INFO - Cleaning up... 08:19:20 INFO - Return code: 0 08:19:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:19:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:19:20 INFO - Reading from file tmpfile_stdout 08:19:20 INFO - Current package versions: 08:19:20 INFO - argparse == 1.2.1 08:19:20 INFO - blessings == 1.6 08:19:20 INFO - blobuploader == 1.2.4 08:19:20 INFO - docopt == 0.6.1 08:19:20 INFO - functools32 == 3.2.3-2 08:19:20 INFO - jsonschema == 2.5.1 08:19:20 INFO - manifestparser == 1.1 08:19:20 INFO - mozInstall == 1.12 08:19:20 INFO - mozcrash == 1.0 08:19:20 INFO - mozdebug == 0.1 08:19:20 INFO - mozdevice == 0.49 08:19:20 INFO - mozfile == 1.2 08:19:20 INFO - mozhttpd == 0.7 08:19:20 INFO - mozinfo == 0.9 08:19:20 INFO - mozleak == 0.1 08:19:20 INFO - mozlog == 3.4 08:19:20 INFO - moznetwork == 0.27 08:19:20 INFO - mozprocess == 0.25 08:19:20 INFO - mozprofile == 0.28 08:19:20 INFO - mozrunner == 6.13 08:19:20 INFO - mozscreenshot == 0.1 08:19:20 INFO - mozsystemmonitor == 0.3 08:19:20 INFO - moztest == 0.8 08:19:20 INFO - mozversion == 1.4 08:19:20 INFO - psutil == 3.1.1 08:19:20 INFO - requests == 1.2.3 08:19:20 INFO - wsgiref == 0.1.2 08:19:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19: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')]} 08:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19: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')]} 08:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:20 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 0xdb81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053290>, '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 0x1053b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054040>, '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': '781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:19:20 INFO - Using env: {'DISPLAY': ':0', 08:19:20 INFO - 'HOME': '/home/cltbld', 08:19:20 INFO - 'LANG': 'en_US.UTF-8', 08:19:20 INFO - 'LANGUAGE': 'en_US:en', 08:19:20 INFO - 'LOGNAME': 'cltbld', 08:19:20 INFO - 'MAIL': '/var/mail/cltbld', 08:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:20 INFO - 'MOZ_NO_REMOTE': '1', 08:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:20 INFO - 'NO_EM_RESTART': '1', 08:19:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:20 INFO - 'PWD': '/builds/slave/test', 08:19:20 INFO - 'SHELL': '/bin/bash', 08:19:20 INFO - 'SHLVL': '1', 08:19:20 INFO - 'TERM': 'linux', 08:19:20 INFO - 'TMOUT': '86400', 08:19:20 INFO - 'USER': 'cltbld', 08:19:20 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913', 08:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:20 INFO - '_': '/tools/buildbot/bin/python'} 08:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:19:20 INFO - Cleaning up... 08:19:20 INFO - Return code: 0 08:19:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:19: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')]} 08:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19: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')]} 08:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:20 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 0xdb81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053290>, '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 0x1053b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054040>, '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': '781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:19:20 INFO - Using env: {'DISPLAY': ':0', 08:19:20 INFO - 'HOME': '/home/cltbld', 08:19:20 INFO - 'LANG': 'en_US.UTF-8', 08:19:20 INFO - 'LANGUAGE': 'en_US:en', 08:19:20 INFO - 'LOGNAME': 'cltbld', 08:19:20 INFO - 'MAIL': '/var/mail/cltbld', 08:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:20 INFO - 'MOZ_NO_REMOTE': '1', 08:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:20 INFO - 'NO_EM_RESTART': '1', 08:19:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:20 INFO - 'PWD': '/builds/slave/test', 08:19:20 INFO - 'SHELL': '/bin/bash', 08:19:20 INFO - 'SHLVL': '1', 08:19:20 INFO - 'TERM': 'linux', 08:19:20 INFO - 'TMOUT': '86400', 08:19:20 INFO - 'USER': 'cltbld', 08:19:20 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913', 08:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:20 INFO - '_': '/tools/buildbot/bin/python'} 08:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:19:21 INFO - Cleaning up... 08:19:21 INFO - Return code: 0 08:19:21 INFO - Running post-action listener: _resource_record_post_action 08:19:21 INFO - Running post-action listener: _start_resource_monitoring 08:19:21 INFO - Starting resource monitoring. 08:19:21 INFO - [mozharness: 2017-03-22 15:19:21.175592Z] Finished create-virtualenv step (success) 08:19:21 INFO - [mozharness: 2017-03-22 15:19:21.176102Z] Running install step. 08:19:21 INFO - Running pre-action listener: _resource_record_pre_action 08:19:21 INFO - Running main action method: install 08:19:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:19:21 INFO - Reading from file tmpfile_stdout 08:19:21 INFO - Detecting whether we're running mozinstall >=1.0... 08:19:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:19:21 INFO - Reading from file tmpfile_stdout 08:19:21 INFO - Output received: 08:19:21 INFO - Usage: mozinstall [options] installer 08:19:21 INFO - Options: 08:19:21 INFO - -h, --help show this help message and exit 08:19:21 INFO - -d DEST, --destination=DEST 08:19:21 INFO - Directory to install application into. [default: 08:19:21 INFO - "/builds/slave/test"] 08:19:21 INFO - --app=APP Application being installed. [default: firefox] 08:19:21 INFO - mkdir: /builds/slave/test/build/application 08:19:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:19:37 INFO - Reading from file tmpfile_stdout 08:19:37 INFO - Output received: 08:19:37 INFO - /builds/slave/test/build/application/firefox/firefox 08:19:37 INFO - Running post-action listener: _resource_record_post_action 08:19:37 INFO - [mozharness: 2017-03-22 15:19:37.243600Z] Finished install step (success) 08:19:37 INFO - [mozharness: 2017-03-22 15:19:37.243872Z] Running run-tests step. 08:19:37 INFO - Running pre-action listener: _resource_record_pre_action 08:19:37 INFO - Running main action method: run_tests 08:19:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:19:37 INFO - Python 2.7.3 08:19:37 INFO - Return code: 0 08:19:37 INFO - grabbing minidump binary from tooltool 08:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:37 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 0x1053290>, '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 0x1053b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:19:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:19:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:19:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:19:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:19:37 INFO - Return code: 0 08:19:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:19:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:19:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:19:37 INFO - ENV: RUST_BACKTRACE is now 1 08:19:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:19:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:19:37 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/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--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 08:19:37 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/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-080 --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 08:19:37 INFO - Using env: {'DISPLAY': ':0', 08:19:37 INFO - 'HOME': '/home/cltbld', 08:19:37 INFO - 'LANG': 'en_US.UTF-8', 08:19:37 INFO - 'LANGUAGE': 'en_US:en', 08:19:37 INFO - 'LOGNAME': 'cltbld', 08:19:37 INFO - 'MAIL': '/var/mail/cltbld', 08:19:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:19:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:37 INFO - 'MOZ_NO_REMOTE': '1', 08:19:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:37 INFO - 'NO_EM_RESTART': '1', 08:19:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:37 INFO - 'PWD': '/builds/slave/test', 08:19:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:19:37 INFO - 'RUST_BACKTRACE': '1', 08:19:37 INFO - 'SHELL': '/bin/bash', 08:19:37 INFO - 'SHLVL': '1', 08:19:37 INFO - 'TERM': 'linux', 08:19:37 INFO - 'TMOUT': '86400', 08:19:37 INFO - 'USER': 'cltbld', 08:19:37 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913', 08:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:37 INFO - '_': '/tools/buildbot/bin/python'} 08:19:37 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/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--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 08:19:37 INFO - mozversion application_buildid: 20170322145025 08:19:37 INFO - mozversion application_changeset: 00c595de162736689a83e894a84f9eb99a5fa6ac 08:19:37 INFO - mozversion application_display_name: Nightly 08:19:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:19:37 INFO - mozversion application_name: Firefox 08:19:37 INFO - mozversion application_remotingname: firefox 08:19:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:19:37 INFO - mozversion application_vendor: Mozilla 08:19:37 INFO - mozversion application_version: 55.0a1 08:19:37 INFO - mozversion platform_buildid: 20170322145025 08:19:37 INFO - mozversion platform_changeset: 00c595de162736689a83e894a84f9eb99a5fa6ac 08:19:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:19:37 INFO - mozversion platform_version: 55.0a1 08:19:37 INFO - using testdate: 1490195977 08:19:37 INFO - actual date: 1490195977 08:19:37 INFO - starting webserver on 'localhost:53118' 08:19:37 INFO - SUITE-START | Running 2 tests 08:19:37 INFO - TEST-START | dromaeo_css 08:19:37 INFO - operating with platform_type : linux_ 08:19:37 INFO - Initialising browser for dromaeo_css test... 08:19:37 INFO - TEST-INFO | started process 14124 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRYQTlz/profile http://localhost:53118/getInfo.html) 08:19:42 INFO - PID 14124 | __metrics Screen width/height:1600/1200 08:19:42 INFO - PID 14124 | colorDepth:24 08:19:42 INFO - PID 14124 | Browser inner width/height: 1024/697 08:19:42 INFO - PID 14124 | __metrics 08:19:43 INFO - PID 14124 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:19:43 INFO - PID 14124 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:19:44 INFO - TEST-INFO | 14124: exit 0 08:19:44 INFO - Browser initialized. 08:19:44 INFO - Running cycle 1/1 for dromaeo_css test... 08:19:44 INFO - TEST-INFO | started process 14218 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRYQTlz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:56 INFO - PID 14218 | RSS: Main: 149225472 08:19:56 INFO - PID 14218 | 08:23:02 INFO - PID 14218 | Cycle 1(1): loaded http://localhost:53118/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53118/tests/dromaeo/cssquery-ext.html) 08:23:04 INFO - PID 14218 | RSS: Main: 253460480 08:23:04 INFO - PID 14218 | 08:24:45 INFO - PID 14218 | ************************* 08:24:45 INFO - PID 14218 | A coding exception was thrown and uncaught in a Task. 08:24:45 INFO - PID 14218 | 08:24:45 ERROR - PID 14218 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:24:45 INFO - PID 14218 | Full stack: 08:24:45 INFO - PID 14218 | ************************* 08:26:06 INFO - PID 14218 | Cycle 1(1): loaded http://localhost:53118/tests/dromaeo/cssquery-ext.html (next: http://localhost:53118/tests/dromaeo/cssquery-jquery.html) 08:26:07 INFO - PID 14218 | RSS: Main: 244002816 08:26:07 INFO - PID 14218 | 08:29:09 INFO - PID 14218 | Cycle 1(1): loaded http://localhost:53118/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53118/tests/dromaeo/cssquery-mootools.html) 08:29:10 INFO - PID 14218 | RSS: Main: 204046336 08:29:10 INFO - PID 14218 | 08:32:12 INFO - PID 14218 | Cycle 1(1): loaded http://localhost:53118/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53118/tests/dromaeo/cssquery-prototype.html) 08:32:12 INFO - PID 14218 | RSS: Main: 206016512 08:32:12 INFO - PID 14218 | 08:35:16 INFO - PID 14218 | Cycle 1(1): loaded http://localhost:53118/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53118/tests/dromaeo/cssquery-yui.html) 08:35:16 INFO - PID 14218 | RSS: Main: 185552896 08:35:16 INFO - PID 14218 | 08:38:20 INFO - PID 14218 | Cycle 1(1): loaded http://localhost:53118/tests/dromaeo/cssquery-yui.html (next: http://localhost:53118/tests/dromaeo/cssquery-dojo.html) 08:38:20 INFO - PID 14218 | RSS: Main: 259330048 08:38:20 INFO - PID 14218 | 08:38:20 INFO - PID 14218 | __start_tp_report 08:38:20 INFO - PID 14218 | _x_x_mozilla_page_load 08:38:20 INFO - PID 14218 | _x_x_mozilla_page_load_details 08:38:20 INFO - PID 14218 | |i|pagename|runs| 08:38:20 INFO - PID 14218 | |0;dojo.html;2640.749128832761;2657.7608015278647;2687.3281679580105;2688.556388195948;2694.757471827535;5056.342675452195;5116.23256511523;5140.15187494064;5150.1759718445055;5188.6367954243215;5064.746762661871;5103.591712662987;5147.459516750743;5165.63840531162;5179.093658609747;4617.468991066028;4639.280911458729;4688.742119183444;4767.90464190716;4821.7830197641015;4695.436547614274;4696.976515117437;4762.452317983424;4766.380370551823;4777.307290442901;4657.906841863178;4704.929426058612;4710.076188003629;4712.811487540494;4771.904561908743;4703.529647035303;4706.74112923789;4714.175019371631;4770.260609605517;4780.928286075712;4639.652026098056;4691.7888695008805;4695.60087392572;4728.550787675165;4745.145873742725;4984.127777638935;5029.949700502984;5042.445331013586;5154.7680354383765;5170.870728231786;5543.750531226105;5554.250176226198;5554.2779438673115;5564.221009058735;5622.100463925753;5606.383297837235;5610.943890561124;5634.408387119334;5668.659880407189;5672.035753921802;5214.817481388133;5220.164773636238;5225.764840582183;5226.137687281556;5279.630425870152;5547.44525547442;5682.744276507485;5694.800681976111;5754.683492407874;5755.740991655385;5469.917951230735;5474;5474.91787623186;5509.889802204014;5526.640768350045;5584.050711379075;5587.1339942309005;5589.469000444951;5590.357108932443;5590.944090559124;5404.83785486436;5473.644213126134;5538.9169162462595;5540.390557038722;5547.389787123413;5405.621606487587;5487.807926722546;5546.306711661043;5550.972245138749;5556.833295001156;4615.353850460938;4629.0973260214605;4631.698939568917;4632;4676.018036212434;3966.504186976628;3979.582143874851;3983;4002.579729128458;4012.538558065801;4681.297805329228;4745.074710431501;4779.474257831635;4806.975965120152;4817.181079216542;5626.774929002876;5627.380988091307;5627.887442251132;5654.095344744904;5685.431456854281;4760.642951778561;4793.041391721669;4795.928061079087;4809.44691360491;4849.587785038311;4761.714297142183;4867.026594681007;4871.926921096187;4918.065567542227;4918.360613120271;5210;5219.556337711337;5276.314079169683;5278.60410469224;5281.207818827053;5444.754986025559;5505.669659820263;5512.834614961557;5512.944870551243;5586.413426590312;5152.175651895828;5162.303089082926;5165.121929272108;5168.0697474453455;5169.172932330809;5386.272853164773;5394.406615272238;5439.401665816677;5443.401225865231;5446.1558458439;5533.944660553504;5534.1145416733125;5610.551155907599;5615.157726341082;5629.802956896489;5424.24060631504;5437.157240627709;5444.101723215784;5447.782088716565;5448.945510545002;5436.809711660073;5437.4018857926385;5442.401335852974;5444.292242008513;5446.128619420873;5182.507661772125;5245.396779370269;5253.632245742914;5350.598705097211;5386.622936394415;5449.836504904859;5455;5455.290812194548;5478.096114141122;5500.22996780459;5290.867728306823;5304.443033481429;5310.575153987749;5313.282706834682;5328.946710532845 08:38:20 INFO - PID 14218 | |1;ext.html;634.2864277687602;681.1213534540443;702.8524009957907;1060.416770776073;1075.0969185883855;25962.091326803566;31749.523757143634;32241;32256.99999999997;32290.35419291613;36290;36987.260254794885;37035;37049.81475092628;37143.071423214365;7332.083489563818;7471.887921681179;7472.551646901204;7479.027726395561;7480.588567628778;5577.888442231153;5725.456081672234;7192.892106618405;7334.559926404406;7366.300201480877;7388.224236455176;7468.850622987537;7469.813254668622;7473.850522989537;7481.289277518627;7370.594617296047;7428.33145016951;7429.925700742978;7433.888491672602;7440.367568756662;5559.388467268597;5724.198612194296;7118.964405177992;7249.71001159953;7282.563046217244;31444;31850.522242166386;31852.20369490758;31858.840705796323;31916.20209494758;2641.1020253114034;2655.9336016599545;2655.9336016599545;2660.414708764088;2692.17888543994;21586.676199857015;21809.2366767164;22203.777962220494;22291.554168916693;24010.519789604285;2993.655729591103;3035.1653295343735;3041.817490950528;3051.25244315142;3093.6751641077813;147963;148237;148455;148512;148661.25669371692;41942.370864437056;42274.36588451175;42345.576544234165;42399.788001059795;42405.787971059945;44994.325085123746;45025.099498009855;45059.54940450619;45062.32406513905;45093.774531127136;12274.877251227552;12336.876631233752;12414.937925310496;12432.948563486923;12460.190087644274;10016.599336026477;10020.949895250476;10039.4478303694;10041.347312424668;10044.799104017879;10274.178065754722;10515.211359148094;11426.885731142582;11580.47887845049;11672.716001239856;4789.402173913082;4824.204006338985;4847.127517046965;4857.927131093036;4864.78108485119;830.667732906842;850.6639877248452;873.5413907698509;892.4734406700078;901;19040.839489456634;19333.419997400102;19799;19842.801571984095;20131.597368052557;908.1463424381061;938.643315540104;964.4550828781715;975.2929126383316;975.3757595139117;10193.74515637115;10829.523899143756;10946.069584085442;11168.888311116785;11296.943515282372;197288;198100;198366;198443;198522;41229.793851030554;41457.1708565833;41536.37695434571;41543.584564154575;41548.79225603853;942.0108885670019;1177.587844254504;1240.9813852792215;1251.086706704111;1255.5731051442554;18812.623747525246;18841;19721.309754158534;19748.703769443182;20232;29292.121236362942;29371.11886643404;29455.85272073626;29468.852655737443;29486.852565737034;182161;182173;182208;182305;182723.08638456723;27813.721862781113;27825;27874.303142421602;27888;27946.301342466602;32951.34097318088;33595.664043359255;33707.325853483286;34145;34519.65480345265;30741.846290768404;31009.534856977614;31224;31261.687383125878;32256.193595160308;30268;30425.695743042284;30630.540541892336;30864.382712345177;31711;30388.24029399283;30963.690363096983;31092.844535777178;31107;31130.84434577903;27298.317542060813;27702.584461233502;28017.439651206452;28167.71832281651;28279.29301767472;21483.677744834153;21847.890760546095;22068.88965555162;22112.88943555272;22133.225337113123 08:38:20 INFO - PID 14218 | |2;jquery.html;386.30850777108975;431.4542104238137;434.8456298014205;451.798949467487;455.4170661553213;15032.323545440455;18272.360467383645;18841.24635014601;19343.613127737437;19434.22263109474;18623.255069797193;18717.25130994762;18842.246310147613;19251.518712032208;19266.61466770664;5740.368559458467;5954.4938680212235;5958;5960.284765828107;5966;3450.1202193440763;3647.562292524901;5599.832005039835;5847.8538036549;5861.0915308127305;5810.331811841629;5821.8835623287505;5824.184614154022;5826.796062137826;5834.095715164156;5539.9169012464645;5720.628159169662;5742.54059675225;5743;5745.913811292834;5100.336956195708;5153.123968925292;5213.895722085537;5213.973930130325;5215.895682086375;23190;23326.7667323328;23330;23494.412639683975;23615.05539778407;1596.449225017367;1615.4588212948677;1641.8522332990087;1644.8930819496695;1658.7346024636001;12848.807267890988;13363.465461381533;13638.659033524242;14555.490557830424;14900.776488352683;1561.461295852929;1597.728386174353;1617.7411614141681;1625.9349626014946;1662.3849175804908;90386.54806725924;91125.54437227771;92471.53764231203;93393.53303233441;94730.52634736782;9893.901060989298;11244.718882028015;11316.547338106384;11334.886651133547;11698.29810211373;14575.416983320549;15857.127857967922;16414.83585164157;16429;16442.342306307615;7766.456348055582;7837.725679601301;8020.518768873886;8021.197880212048;8085.716999905093;7105;7162.7493037743425;7263.927360726325;7333.046703928455;7370.48406611532;6983.3016698330775;7185.6766445510075;7211.350978411968;7216.386607138452;7258.564486130849;2080;2094.214669498938;2113.7674855765854;2155.665871789875;2235.2958817972285;828.8093738440192;852.2372476633378;856.4390324337569;873.5151990645126;877.0308808766349;16802.243899024572;16937.153142342835;17390.913045434943;17595.12024398775;17864;869.6390997735995;873.2882700598991;888.5734847273345;888.6001299415288;890.9109089091169;9214.216791572657;9683.564239609235;9705.369151005161;9709.6601618943;9710.320277580642;457683.6237212247;464313;464790;468469;471952;90239.09760902438;91238;92710.53644731732;92752;93113;1081.4322480697697;1123.505657510709;1135.4266095621824;1137.0846468592697;1140.6007897235902;16969;17534.91232543829;18445.354412595494;18470;18577.721334180267;28091.259129882696;41961.370579441944;42128.83809752411;43210.35184472298;44363.55636443594;48009.75995120002;52166.391680416586;52723.736381317845;52971.47028529665;53881.46118538921;8220.301274391504;8291.95854020726;8340.082590915115;8413.831723365376;8678.349123815866;11911.880881191077;12046.397680116135;12049.638510844688;12119.454624542093;13683.947407888896;10948.671539853816;11274.661760147208;11343.376114313793;11368.431578421212;11406;11463.942680286546;11480.94259528697;11516.94241528787;11624;11740.88259117432;11478.82781758291;11654.125940554322;11690.76618467643;11794;12100;8523.616437260214;8571.4000019998;8685.568040948545;8718.694845680371;8852.468851868909;10847.67456976292;10945.945270273598;11307.886921130683;11325.15061370417;11381.658550243506 08:38:20 INFO - PID 14218 | |3;mootools.html;1256.7549327881063;1323.9338033098343;1335.125492802215;1338.859419760925;1346.8114463975041;9388.295877809165;9785.315027948047;9785.7553561161;9793;10008.849867251978;9721.125098741111;9834.901650983487;9954.452505112216;10006.649767258148;10010.149137323337;2184.6941428200025;2225.2100504320974;2228.186711850179;2228.732552093751;2228.754836967932;1849.5653521422455;2102.5059111108876;2176;2177.1182671018264;2184.2573525001494;1927.5662975830467;2151.0535364439675;2203.526241858;2220.4226901005773;2230.8996095175676;2144.292383513437;2147.8389120815923;2161.4164175672636;2163.56728654269;2167.328128280238;2085.4265077103764;2142.7642959274467;2143.98928005359;2145.517258616814;2146.162996431393;9818;9877.654282100164;9908.20734341251;9912.504374781232;9919.156871665917;5463.672179669193;5655.943440565624;5672.262605861253;5674.148877668342;5675.063614503602;2898.7970842041063;3171.4767063434506;3213.983930080358;3223.597050368704;3236.093893709765;927.5315965437411;1008.6520150548123;1045.0698877998586;1062.8512008318842;1078.0459293525287;14666.413343466249;14778.334974926154;14790.630234244014;14791.482298119514;14798.778018329735;4908.656394052454;5099.566536844335;5105.821296254613;5106.821261255838;5110.131277682803;10713.946430267799;10813.351198928089;10839.349639021684;10846.566137354575;10852.728681783019;5507.972460137674;5508.862278442991;5509.201165831012;5519.39286678465;5522.0336441122645;4926.9014619707405;5066.569341605931;5105.668131571436;5124.615653825978;5137.075326441276;3738.476613274144;3856.840169505086;3860.247251785931;3947.1908258806875;3950.6839452843706;1142.4687520302932;1151.6026970695098;1161.1233518693332;1179.628417048627;1195.462042081067;564.3211445948272;628.1614045249643;705.2770909817376;715.8103102677794;719.5215181903975;5574.160527026072;5583.664980101207;5708.172315014383;5758.481736643638;5767.106098554731;795.188907314536;823.300194834398;828.4532208742202;830.8753686946885;838.4298676899766;3472.826358682056;3632.164602141522;3633.7819730816236;3648.2156336387275;3710.257948410329;12405;13012;13041.152325098838;13150.60548183556;13155.67110822218;12856.935715321364;13032.80450793239;13048;13048.54330098442;13240.801387979189;9247.213986811063;9367.953160234156;9428.340016198801;9469.90530094704;9524.523773811281;5499.615026948075;5501.14732216507;5510.586705997146;5566.610337276352;5701.230333904869;11587.246828956091;11688.824667629822;11700.239484433485;11787.233829801036;11796.94101529487;11593.362365070003;11823.704407389883;11948.402579871146;11951.402429878297;12071.879281207075;7377.372923301365;7451.478396512192;7461.365783908429;7464.738734144279;7829.217078292125;9165.220956218796;9182.265418766616;9236.861447078165;9244.861327080234;9252;7647.349975252166;7683.03735944146;7885.093214280202;8008.039035315799;8025.879611805711;7751.651175696994;7942.920570794449;7947.761567152995;7952.920470795218;7986.520808751494;6849.383555480031;7152.070230870162;7239.746608868664;7242.275772422716;7245.637718113968;5100.566451851634;5129.615278854176;5167.896642067062;5242.921356179584;5327.067763141357;4820.758962051813;4980.701157930535;5060.291559181791;5130.769115389891;5387.75755091014 08:38:20 INFO - PID 14218 | |4;prototype.html;380.4768443390337;399.50062421972535;401.24365570898857;403.1010845813837;405.14514374669443;5328.360596728393;5392.379876314225;5407.540359069474;5408.4050754416985;5410.458954104588;5039.697618142914;5216.217567364888;5272.314599102111;5277.340332458442;5310.62825602208;4128.071183983595;4137.524184718758;4143.854965076223;4145.7719825409595;4149.190907772985;4103.753774773509;4122.835086596532;4144.8134833932545;4147.108371700084;4165.375193720935;3932.390479475686;4084.121913788535;4109.958900411002;4130.359794231884;4134.462519872427;4056.290149223874;4073.4093556434445;4081.7142800003717;4086.427900093989;4087.652549533293;3619.8733044343585;3621.420572708354;3622.8913132606062;3626.510421093145;3626.9455958160647;4959.925601115986;5152.58779297659;5158.458361871987;5195.480192106826;5207.4377686694215;4715.1748444022505;4715.528447155291;4717.9292310615365;4723.598494128003;4748.335233067373;5569.944300556983;5588.776448942038;5590.552755779528;5591.916121258144;5593.440655934414;3850.6534411902785;3974.0859602291634;3978.4484051220047;3981.203759248162;3988.481497405319;5572.916406253909;5613.607047506635;5749.482546570787;5782.595218334718;5808.3030036395485;4026.4362989181536;4029.49631296088;4043.696722745806;4047.817848196838;4053.756774593534;4106.377980697608;4119;4119.567445418248;4123.092919557693;4135.110951145518;4402.119576084732;4464.486584042812;4583.312503124492;4668.5798278155125;4675.836345727883;5521.089020311684;5579.6931168785295;5580.162975553618;5581.358143813432;5583.277140930579;1410.9506167284096;1424.7649137892338;1425.7148570285983;1427;1428.071753360324;936.4053825820516;963.2342287881152;972.6887396033202;976.3409698453515;982.4940155819759;4874.122657921537;4876.463589005207;4899.485554016848;4900.921797204609;4907.435644900811;5723.712164762895;5735.483806457439;5735.512481439041;5740.56945729072;5744.052231381859;4675.742834144155;4813.4945830687275;4880.707157570557;4896.359719494009;4899.289603007615;2998.9550156747664;3025.909222723322;3034.9377717798593;3044.497657886424;3054.2059064643354;5344.679319240858;5345.037893179265;5355.518003379714;5367.9065164585845;5379.569634429315;5725.713714314351;5807.157962095557;5835.124731290255;5845.298564172326;5860.912086318709;5337.973310133424;5347.171188465794;5348.545373643284;5350.38470575881;5377.435369286247;5505.421930697219;5711.371749107678;5720.742566584597;5729.169270455677;5741.684207368635;5590.37879015081;5611.5230205433;5611.8877622448135;5615.6630602164005;5624.943750562442;5092.872678183075;5259.710715910662;5260.684358938476;5283.47165283484;5375.543078838343;3813.796411014761;3930.390789427643;3953.189596132728;4015.477987861559;4062.6343629073526;5680.204771331934;5683.3748287687495;5685.289338832646;5711.8870215731695;5715.257016587817;5373.247745315581;5473.8357849264585;5500.28496295479;5525.696086715269;5536.363318218296;5530.585206109477;5532.6680399176175;5535.474129957647;5560.833175004756;5570.777168913198;5342.813001544927;5461.290032295776;5482.2873026506295;5498.945010549844;5504.422035686355;5574.77700891976;5587.664740115606;5591;5606.495415412633;5613.887722245614;5442.809501667422;5449.155380915964;5449.972750136224;5468.781248750005;5481.808136715196 08:38:20 INFO - PID 14218 | |5;yui.html;678.0845858091575;693.8542905989742;702.652187167352;703.5497281739684;714.5177005521272;12423;12931.353432328393;12952.611421657342;12980.221186728792;13082.345882705862;13042.673933151653;13119.212847229173;13145.145565538234;13156.407961641726;13178;835.9749207523769;864.4942708515526;868.8001759595265;868.9608967596473;873.5326600268858;858.7938894665267;860.995695021524;864.8529749942525;865.3726048614767;865.8571335729597;905.5245995852198;910.3127139010038;910.6311943662794;917.1837065012145;917.4266083697689;906.8413027720155;909.195362104539;909.8589718593629;910.2399496420497;910.6311943662827;658.8846951783419;662.1392190152782;665.5141746525064;666.1573110015834;666.2737615998536;14238.786418203736;14304.427822887072;14357.425702971974;14521.20133392663;14759.262036898219;13729.313534323244;14255.78616320756;14266.714665706628;14298.571042868627;14302.427902883872;10634.20243481742;10723.30298530593;10785.83821242682;10819.080378167866;10918.399488028155;2744.684361298436;2783.6381270434917;2786.6238057862333;2792.6648802143873;2869.03887197789;63758.04362934606;64429;64763.43801090938;65221.673891630715;65614.3438565613;9815.36200146988;9944.950275248577;9955;10218.437985910698;10267.127294180078;21515.246966356415;21646.675299870516;21652;21767.67348489774;21865.453363666034;5859.912101318484;5914.852128696817;5921.407859214044;6149.046897730769;6164.876702466016;3499.492573576817;3519.9472007919903;3576.624454432247;3581.6418358163974;3584.964150358463;3636.9272614547563;3676.283124790694;3693.169036966661;3714.9071273217846;3729.9440508392395;612.091044798474;618.811262564922;627.5889292513411;629.76069093745;635.1489004733679;532.9440408757102;544.6106034185497;555.2892297858747;556.1907424697056;556.9777208911679;7721;7731.188225236382;7814.921850781533;7836.921630783733;8036.557989310527;499.4406264983242;521.4082016910758;530.0485628297216;551.2525294815445;562.2606272751401;3397.9490307645406;3460.498227756961;3615.9276814463565;3654.196076863139;3735.4210097434943;54369.72815135899;55317.72341138349;55409.44590554124;55646.443535564125;57512.137317940265;35485.64514354875;37745.24509509849;46962.530374695816;52627.947441050965;54677.1798423016;43394.34908476375;44092.77953610211;44174.33738493925;44974.55025449704;45202.09595808065;7824.921750782647;8202.917970820215;8209.590466282058;8296.419250652396;8389.916100838913;23687.289381318587;23772.4056898572;23999.52000960006;24252.51494970126;24850.37874053091;28477.430451391272;28716;28809.42381152407;29001.709982900746;29012.27469313284;10661.520231589442;10726;10775.245732798629;10890.836637450286;11049.39228342449;12515.311657858905;12808.487660493476;13083.738325233633;13646.727065458834;14251.35868885882;11244.718882028015;11417.200795944203;11556.47995840206;11755.88244117548;11949.701257468285;12129.757404851676;12300.692482687646;12423.875761242272;12532.87467125317;12759.80860287115;10919.235653504178;11160.274582152135;11585.478653460783;11653.6503904883;11931.702319196746;9371.625134994523;9755.804883902425;9798.51007449639;10137.290389672653;10163.644272450429;8932.910670893469;9136.908630913606;9337.486438245962;9415.85876211871;9421.905780942378 08:38:20 INFO - PID 14218 | __end_tp_report 08:38:20 INFO - PID 14218 | __start_cc_report 08:38:20 INFO - PID 14218 | _x_x_mozilla_cycle_collect,1258 08:38:20 INFO - PID 14218 | __end_cc_report 08:38:20 INFO - PID 14218 | __startTimestamp1490197100465__endTimestamp 08:38:20 INFO - PID 14218 | 08:38:20 INFO - PID 14218 | ------- Summary: start ------- 08:38:20 INFO - PID 14218 | Number of tests: 6 08:38:20 INFO - PID 14218 | 08:38:20 INFO - PID 14218 | [#0] dojo.html Cycles:165 Average:5103.23 Median:5245.40 stddev:585.50 (11.2%) stddev-sans-first:554.51 08:38:20 INFO - PID 14218 | Values: 2640.7 2657.8 2687.3 2688.6 2694.8 5056.3 5116.2 5140.2 5150.2 5188.6 5064.7 5103.6 5147.5 5165.6 5179.1 4617.5 4639.3 4688.7 4767.9 4821.8 4695.4 4697.0 4762.5 4766.4 4777.3 4657.9 4704.9 4710.1 4712.8 4771.9 4703.5 4706.7 4714.2 4770.3 4780.9 4639.7 4691.8 4695.6 4728.6 4745.1 4984.1 5029.9 5042.4 5154.8 5170.9 5543.8 5554.3 5554.3 5564.2 5622.1 5606.4 5610.9 5634.4 5668.7 5672.0 5214.8 5220.2 5225.8 5226.1 5279.6 5547.4 5682.7 5694.8 5754.7 5755.7 5469.9 5474.0 5474.9 5509.9 5526.6 5584.1 5587.1 5589.5 5590.4 5590.9 5404.8 5473.6 5538.9 5540.4 5547.4 5405.6 5487.8 5546.3 5551.0 5556.8 4615.4 4629.1 4631.7 4632.0 4676.0 3966.5 3979.6 3983.0 4002.6 4012.5 4681.3 4745.1 4779.5 4807.0 4817.2 5626.8 5627.4 5627.9 5654.1 5685.4 4760.6 4793.0 4795.9 4809.4 4849.6 4761.7 4867.0 4871.9 4918.1 4918.4 5210.0 5219.6 5276.3 5278.6 5281.2 5444.8 5505.7 5512.8 5512.9 5586.4 5152.2 5162.3 5165.1 5168.1 5169.2 5386.3 5394.4 5439.4 5443.4 5446.2 5533.9 5534.1 5610.6 5615.2 5629.8 5424.2 5437.2 5444.1 5447.8 5448.9 5436.8 5437.4 5442.4 5444.3 5446.1 5182.5 5245.4 5253.6 5350.6 5386.6 5449.8 5455.0 5455.3 5478.1 5500.2 5290.9 5304.4 5310.6 5313.3 5328.9 08:38:20 INFO - PID 14218 | 08:38:20 INFO - PID 14218 | [#1] ext.html Cycles:180 Average:31858.18 Median:30803.11 stddev:46023.72 (149.4%) stddev-sans-first:46093.11 08:38:20 INFO - PID 14218 | Values: 634.3 681.1 702.9 1060.4 1075.1 25962.1 31749.5 32241.0 32257.0 32290.4 36290.0 36987.3 37035.0 37049.8 37143.1 7332.1 7471.9 7472.6 7479.0 7480.6 5577.9 5725.5 7192.9 7334.6 7366.3 7388.2 7468.9 7469.8 7473.9 7481.3 7370.6 7428.3 7429.9 7433.9 7440.4 5559.4 5724.2 7119.0 7249.7 7282.6 31444.0 31850.5 31852.2 31858.8 31916.2 2641.1 2655.9 2655.9 2660.4 2692.2 21586.7 21809.2 22203.8 22291.6 24010.5 2993.7 3035.2 3041.8 3051.3 3093.7 147963.0 148237.0 148455.0 148512.0 148661.3 41942.4 42274.4 42345.6 42399.8 42405.8 44994.3 45025.1 45059.5 45062.3 45093.8 12274.9 12336.9 12414.9 12432.9 12460.2 10016.6 10020.9 10039.4 10041.3 10044.8 10274.2 10515.2 11426.9 11580.5 11672.7 4789.4 4824.2 4847.1 4857.9 4864.8 830.7 850.7 873.5 892.5 901.0 19040.8 19333.4 19799.0 19842.8 20131.6 908.1 938.6 964.5 975.3 975.4 10193.7 10829.5 10946.1 11168.9 11296.9 197288.0 198100.0 198366.0 198443.0 198522.0 41229.8 41457.2 41536.4 41543.6 41548.8 942.0 1177.6 1241.0 1251.1 1255.6 18812.6 18841.0 19721.3 19748.7 20232.0 29292.1 29371.1 29455.9 29468.9 29486.9 182161.0 182173.0 182208.0 182305.0 182723.1 27813.7 27825.0 27874.3 27888.0 27946.3 32951.3 33595.7 33707.3 34145.0 34519.7 30741.8 31009.5 31224.0 31261.7 32256.2 30268.0 30425.7 30630.5 30864.4 31711.0 30388.2 30963.7 31092.8 31107.0 31130.8 27298.3 27702.6 28017.4 28167.7 28279.3 21483.7 21847.9 22068.9 22112.9 22133.2 08:38:20 INFO - PID 14218 | 08:38:20 INFO - PID 14218 | [#2] jquery.html Cycles:180 Average:28383.75 Median:21820.90 stddev:77077.25 (353.2%) stddev-sans-first:77264.80 08:38:20 INFO - PID 14218 | Values: 386.3 431.5 434.8 451.8 455.4 15032.3 18272.4 18841.2 19343.6 19434.2 18623.3 18717.3 18842.2 19251.5 19266.6 5740.4 5954.5 5958.0 5960.3 5966.0 3450.1 3647.6 5599.8 5847.9 5861.1 5810.3 5821.9 5824.2 5826.8 5834.1 5539.9 5720.6 5742.5 5743.0 5745.9 5100.3 5153.1 5213.9 5214.0 5215.9 23190.0 23326.8 23330.0 23494.4 23615.1 1596.4 1615.5 1641.9 1644.9 1658.7 12848.8 13363.5 13638.7 14555.5 14900.8 1561.5 1597.7 1617.7 1625.9 1662.4 90386.5 91125.5 92471.5 93393.5 94730.5 9893.9 11244.7 11316.5 11334.9 11698.3 14575.4 15857.1 16414.8 16429.0 16442.3 7766.5 7837.7 8020.5 8021.2 8085.7 7105.0 7162.7 7263.9 7333.0 7370.5 6983.3 7185.7 7211.4 7216.4 7258.6 2080.0 2094.2 2113.8 2155.7 2235.3 828.8 852.2 856.4 873.5 877.0 16802.2 16937.2 17390.9 17595.1 17864.0 869.6 873.3 888.6 888.6 890.9 9214.2 9683.6 9705.4 9709.7 9710.3 457683.6 464313.0 464790.0 468469.0 471952.0 90239.1 91238.0 92710.5 92752.0 93113.0 1081.4 1123.5 1135.4 1137.1 1140.6 16969.0 17534.9 18445.4 18470.0 18577.7 28091.3 41961.4 42128.8 43210.4 44363.6 48009.8 52166.4 52723.7 52971.5 53881.5 8220.3 8292.0 8340.1 8413.8 8678.3 11911.9 12046.4 12049.6 12119.5 13683.9 10948.7 11274.7 11343.4 11368.4 11406.0 11463.9 11480.9 11516.9 11624.0 11740.9 11478.8 11654.1 11690.8 11794.0 12100.0 8523.6 8571.4 8685.6 8718.7 8852.5 10847.7 10945.9 11307.9 11325.2 11381.7 08:38:20 INFO - PID 14218 | 08:38:20 INFO - PID 14218 | [#3] mootools.html Cycles:180 Average:6192.80 Median:5020.50 stddev:3965.42 (79.0%) stddev-sans-first:3959.19 08:38:20 INFO - PID 14218 | Values: 1256.8 1323.9 1335.1 1338.9 1346.8 9388.3 9785.3 9785.8 9793.0 10008.8 9721.1 9834.9 9954.5 10006.6 10010.1 2184.7 2225.2 2228.2 2228.7 2228.8 1849.6 2102.5 2176.0 2177.1 2184.3 1927.6 2151.1 2203.5 2220.4 2230.9 2144.3 2147.8 2161.4 2163.6 2167.3 2085.4 2142.8 2144.0 2145.5 2146.2 9818.0 9877.7 9908.2 9912.5 9919.2 5463.7 5655.9 5672.3 5674.1 5675.1 2898.8 3171.5 3214.0 3223.6 3236.1 927.5 1008.7 1045.1 1062.9 1078.0 14666.4 14778.3 14790.6 14791.5 14798.8 4908.7 5099.6 5105.8 5106.8 5110.1 10713.9 10813.4 10839.3 10846.6 10852.7 5508.0 5508.9 5509.2 5519.4 5522.0 4926.9 5066.6 5105.7 5124.6 5137.1 3738.5 3856.8 3860.2 3947.2 3950.7 1142.5 1151.6 1161.1 1179.6 1195.5 564.3 628.2 705.3 715.8 719.5 5574.2 5583.7 5708.2 5758.5 5767.1 795.2 823.3 828.5 830.9 838.4 3472.8 3632.2 3633.8 3648.2 3710.3 12405.0 13012.0 13041.2 13150.6 13155.7 12856.9 13032.8 13048.0 13048.5 13240.8 9247.2 9368.0 9428.3 9469.9 9524.5 5499.6 5501.1 5510.6 5566.6 5701.2 11587.2 11688.8 11700.2 11787.2 11796.9 11593.4 11823.7 11948.4 11951.4 12071.9 7377.4 7451.5 7461.4 7464.7 7829.2 9165.2 9182.3 9236.9 9244.9 9252.0 7647.3 7683.0 7885.1 8008.0 8025.9 7751.7 7942.9 7947.8 7952.9 7986.5 6849.4 7152.1 7239.7 7242.3 7245.6 5100.6 5129.6 5167.9 5242.9 5327.1 4820.8 4980.7 5060.3 5130.8 5387.8 08:38:20 INFO - PID 14218 | 08:38:20 INFO - PID 14218 | [#4] prototype.html Cycles:180 Average:4600.16 Median:5274.83 stddev:1329.26 (25.2%) stddev-sans-first:1294.71 08:38:20 INFO - PID 14218 | Values: 380.5 399.5 401.2 403.1 405.1 5328.4 5392.4 5407.5 5408.4 5410.5 5039.7 5216.2 5272.3 5277.3 5310.6 4128.1 4137.5 4143.9 4145.8 4149.2 4103.8 4122.8 4144.8 4147.1 4165.4 3932.4 4084.1 4110.0 4130.4 4134.5 4056.3 4073.4 4081.7 4086.4 4087.7 3619.9 3621.4 3622.9 3626.5 3626.9 4959.9 5152.6 5158.5 5195.5 5207.4 4715.2 4715.5 4717.9 4723.6 4748.3 5569.9 5588.8 5590.6 5591.9 5593.4 3850.7 3974.1 3978.4 3981.2 3988.5 5572.9 5613.6 5749.5 5782.6 5808.3 4026.4 4029.5 4043.7 4047.8 4053.8 4106.4 4119.0 4119.6 4123.1 4135.1 4402.1 4464.5 4583.3 4668.6 4675.8 5521.1 5579.7 5580.2 5581.4 5583.3 1411.0 1424.8 1425.7 1427.0 1428.1 936.4 963.2 972.7 976.3 982.5 4874.1 4876.5 4899.5 4900.9 4907.4 5723.7 5735.5 5735.5 5740.6 5744.1 4675.7 4813.5 4880.7 4896.4 4899.3 2999.0 3025.9 3034.9 3044.5 3054.2 5344.7 5345.0 5355.5 5367.9 5379.6 5725.7 5807.2 5835.1 5845.3 5860.9 5338.0 5347.2 5348.5 5350.4 5377.4 5505.4 5711.4 5720.7 5729.2 5741.7 5590.4 5611.5 5611.9 5615.7 5624.9 5092.9 5259.7 5260.7 5283.5 5375.5 3813.8 3930.4 3953.2 4015.5 4062.6 5680.2 5683.4 5685.3 5711.9 5715.3 5373.2 5473.8 5500.3 5525.7 5536.4 5530.6 5532.7 5535.5 5560.8 5570.8 5342.8 5461.3 5482.3 5498.9 5504.4 5574.8 5587.7 5591.0 5606.5 5613.9 5442.8 5449.2 5450.0 5468.8 5481.8 08:38:20 INFO - PID 14218 | 08:38:20 INFO - PID 14218 | [#5] yui.html Cycles:180 Average:13366.35 Median:40569.80 stddev:15782.46 (38.9%) stddev-sans-first:15797.97 08:38:20 INFO - PID 14218 | Values: 678.1 693.9 702.7 703.5 714.5 12423.0 12931.4 12952.6 12980.2 13082.3 13042.7 13119.2 13145.1 13156.4 13178.0 836.0 864.5 868.8 869.0 873.5 858.8 861.0 864.9 865.4 865.9 905.5 910.3 910.6 917.2 917.4 906.8 909.2 909.9 910.2 910.6 658.9 662.1 665.5 666.2 666.3 14238.8 14304.4 14357.4 14521.2 14759.3 13729.3 14255.8 14266.7 14298.6 14302.4 10634.2 10723.3 10785.8 10819.1 10918.4 2744.7 2783.6 2786.6 2792.7 2869.0 63758.0 64429.0 64763.4 65221.7 65614.3 9815.4 9945.0 9955.0 10218.4 10267.1 21515.2 21646.7 21652.0 21767.7 21865.5 5859.9 5914.9 5921.4 6149.0 6164.9 3499.5 3519.9 3576.6 3581.6 3585.0 3636.9 3676.3 3693.2 3714.9 3729.9 612.1 618.8 627.6 629.8 635.1 532.9 544.6 555.3 556.2 557.0 7721.0 7731.2 7814.9 7836.9 8036.6 499.4 521.4 530.0 551.3 562.3 3397.9 3460.5 3615.9 3654.2 3735.4 54369.7 55317.7 55409.4 55646.4 57512.1 35485.6 37745.2 46962.5 52627.9 54677.2 43394.3 44092.8 44174.3 44974.6 45202.1 7824.9 8202.9 8209.6 8296.4 8389.9 23687.3 23772.4 23999.5 24252.5 24850.4 28477.4 28716.0 28809.4 29001.7 29012.3 10661.5 10726.0 10775.2 10890.8 11049.4 12515.3 12808.5 13083.7 13646.7 14251.4 11244.7 11417.2 11556.5 11755.9 11949.7 12129.8 12300.7 12423.9 12532.9 12759.8 10919.2 11160.3 11585.5 11653.7 11931.7 9371.6 9755.8 9798.5 10137.3 10163.6 8932.9 9136.9 9337.5 9415.9 9421.9 08:38:20 INFO - PID 14218 | -------- Summary: end -------- 08:38:20 INFO - PID 14218 | 08:38:21 INFO - TEST-INFO | 14218: exit 0 08:38:21 INFO - TEST-OK | dromaeo_css | took 1123806ms 08:38:21 INFO - TEST-START | kraken 08:38:21 INFO - operating with platform_type : linux_ 08:38:21 INFO - Initialising browser for kraken test... 08:38:21 INFO - TEST-INFO | started process 14538 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTm0WdG/profile http://localhost:53118/getInfo.html) 08:38:25 INFO - PID 14538 | __metrics Screen width/height:1600/1200 08:38:25 INFO - PID 14538 | colorDepth:24 08:38:25 INFO - PID 14538 | Browser inner width/height: 1024/697 08:38:25 INFO - PID 14538 | __metrics 08:38:26 INFO - PID 14538 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:38:26 INFO - PID 14538 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:38:27 INFO - TEST-INFO | 14538: exit 0 08:38:27 INFO - Browser initialized. 08:38:27 INFO - Running cycle 1/1 for kraken test... 08:38:27 INFO - TEST-INFO | started process 14634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTm0WdG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:38:39 INFO - PID 14634 | RSS: Main: 149151744 08:38:39 INFO - PID 14634 | 08:38:42 INFO - PID 14634 | Cycle 1(1): loaded http://localhost:53118/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53118/tests/kraken/driver.html?testName=audio-beat-detection) 08:38:43 INFO - PID 14634 | RSS: Main: 203968512 08:38:43 INFO - PID 14634 | 08:38:46 INFO - PID 14634 | Cycle 1(1): loaded http://localhost:53118/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53118/tests/kraken/driver.html?testName=audio-dft) 08:38:46 INFO - PID 14634 | RSS: Main: 183074816 08:38:46 INFO - PID 14634 | 08:38:49 INFO - PID 14634 | Cycle 1(1): loaded http://localhost:53118/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53118/tests/kraken/driver.html?testName=audio-fft) 08:38:50 INFO - PID 14634 | RSS: Main: 266018816 08:38:50 INFO - PID 14634 | 08:38:52 INFO - PID 14634 | Cycle 1(1): loaded http://localhost:53118/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53118/tests/kraken/driver.html?testName=audio-oscillator) 08:38:53 INFO - PID 14634 | RSS: Main: 176676864 08:38:53 INFO - PID 14634 | 08:38:55 INFO - PID 14634 | Cycle 1(1): loaded http://localhost:53118/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53118/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:38:56 INFO - PID 14634 | RSS: Main: 180011008 08:38:56 INFO - PID 14634 | 08:38:59 INFO - PID 14634 | Cycle 1(1): loaded http://localhost:53118/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53118/tests/kraken/driver.html?testName=imaging-darkroom) 08:38:59 INFO - PID 14634 | RSS: Main: 219398144 08:38:59 INFO - PID 14634 | 08:39:03 INFO - PID 14634 | Cycle 1(1): loaded http://localhost:53118/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53118/tests/kraken/driver.html?testName=imaging-desaturate) 08:39:04 INFO - PID 14634 | RSS: Main: 214089728 08:39:04 INFO - PID 14634 | 08:39:07 INFO - PID 14634 | Cycle 1(1): loaded http://localhost:53118/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53118/tests/kraken/driver.html?testName=json-parse-financial) 08:39:07 INFO - PID 14634 | RSS: Main: 216518656 08:39:07 INFO - PID 14634 | 08:39:09 INFO - PID 14634 | Cycle 1(1): loaded http://localhost:53118/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53118/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:39:09 INFO - PID 14634 | RSS: Main: 179720192 08:39:09 INFO - PID 14634 | 08:39:11 INFO - PID 14634 | Cycle 1(1): loaded http://localhost:53118/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53118/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:39:12 INFO - PID 14634 | RSS: Main: 187453440 08:39:12 INFO - PID 14634 | 08:39:14 INFO - PID 14634 | Cycle 1(1): loaded http://localhost:53118/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53118/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:39:15 INFO - PID 14634 | RSS: Main: 196489216 08:39:15 INFO - PID 14634 | 08:39:17 INFO - PID 14634 | Cycle 1(1): loaded http://localhost:53118/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53118/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:39:18 INFO - PID 14634 | RSS: Main: 205848576 08:39:18 INFO - PID 14634 | 08:39:21 INFO - PID 14634 | Cycle 1(1): loaded http://localhost:53118/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53118/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:39:22 INFO - PID 14634 | RSS: Main: 202244096 08:39:22 INFO - PID 14634 | 08:39:24 INFO - PID 14634 | Cycle 1(1): loaded http://localhost:53118/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53118/tests/kraken/driver.html?testName=ai-astar) 08:39:24 INFO - PID 14634 | RSS: Main: 270770176 08:39:24 INFO - PID 14634 | 08:39:24 INFO - PID 14634 | __start_tp_report 08:39:24 INFO - PID 14634 | _x_x_mozilla_page_load 08:39:24 INFO - PID 14634 | _x_x_mozilla_page_load_details 08:39:24 INFO - PID 14634 | |i|pagename|runs| 08:39:24 INFO - PID 14634 | |0;ai-astar;108;109;111;110;111;109;109;110;111;110 08:39:24 INFO - PID 14634 | |1;audio-beat-detection;159;126;123;170;129;125;126;124;164;125 08:39:24 INFO - PID 14634 | |2;audio-dft;162;162;163;162;163;163;163;163;162;162 08:39:24 INFO - PID 14634 | |3;audio-fft;74;75;76;106;77;75;75;74;94;76 08:39:24 INFO - PID 14634 | |4;audio-oscillator;84;84;104;85;84;86;108;84;84;102 08:39:24 INFO - PID 14634 | |5;imaging-gaussian-blur;114;114;113;113;113;113;113;113;113;114 08:39:24 INFO - PID 14634 | |6;imaging-darkroom;149;150;148;149;148;153;149;149;151;149 08:39:24 INFO - PID 14634 | |7;imaging-desaturate;94;95;94;94;94;95;95;94;95;94 08:39:24 INFO - PID 14634 | |8;json-parse-financial;64;63;63;63;64;64;64;65;64;65 08:39:24 INFO - PID 14634 | |9;json-stringify-tinderbox;56;55;56;57;57;56;55;56;57;56 08:39:24 INFO - PID 14634 | |10;stanford-crypto-aes;82;84;84;81;82;83;82;82;82;81 08:39:24 INFO - PID 14634 | |11;stanford-crypto-ccm;134;134;130;133;132;150;130;133;192;133 08:39:24 INFO - PID 14634 | |12;stanford-crypto-pbkdf2;185;194;200;192;194;193;193;192;192;192 08:39:24 INFO - PID 14634 | |13;stanford-crypto-sha256-iterative;73;71;72;70;70;76;70;70;68;72 08:39:24 INFO - PID 14634 | __end_tp_report 08:39:24 INFO - PID 14634 | __start_cc_report 08:39:24 INFO - PID 14634 | _x_x_mozilla_cycle_collect,2006 08:39:24 INFO - PID 14634 | __end_cc_report 08:39:24 INFO - PID 14634 | __startTimestamp1490197164642__endTimestamp 08:39:24 INFO - PID 14634 | 08:39:24 INFO - PID 14634 | ------- Summary: start ------- 08:39:24 INFO - PID 14634 | Number of tests: 14 08:39:24 INFO - PID 14634 | 08:39:24 INFO - PID 14634 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.00 stddev:1.03 (0.9%) stddev-sans-first:0.87 08:39:24 INFO - PID 14634 | Values: 108.0 109.0 111.0 110.0 111.0 109.0 109.0 110.0 111.0 110.0 08:39:24 INFO - PID 14634 | 08:39:24 INFO - PID 14634 | [#1] audio-beat-detection Cycles:10 Average:137.10 Median:127.50 stddev:19.03 (14.9%) stddev-sans-first:18.47 08:39:24 INFO - PID 14634 | Values: 159.0 126.0 123.0 170.0 129.0 125.0 126.0 124.0 164.0 125.0 08:39:24 INFO - PID 14634 | 08:39:24 INFO - PID 14634 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 08:39:24 INFO - PID 14634 | Values: 162.0 162.0 163.0 162.0 163.0 163.0 163.0 163.0 162.0 162.0 08:39:24 INFO - PID 14634 | 08:39:24 INFO - PID 14634 | [#3] audio-fft Cycles:10 Average:80.20 Median:75.50 stddev:10.85 (14.4%) stddev-sans-first:11.27 08:39:24 INFO - PID 14634 | Values: 74.0 75.0 76.0 106.0 77.0 75.0 75.0 74.0 94.0 76.0 08:39:24 INFO - PID 14634 | 08:39:24 INFO - PID 14634 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:84.00 stddev:9.90 (11.8%) stddev-sans-first:10.22 08:39:24 INFO - PID 14634 | Values: 84.0 84.0 104.0 85.0 84.0 86.0 108.0 84.0 84.0 102.0 08:39:24 INFO - PID 14634 | 08:39:24 INFO - PID 14634 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:113.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 08:39:24 INFO - PID 14634 | Values: 114.0 114.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 114.0 08:39:24 INFO - PID 14634 | 08:39:24 INFO - PID 14634 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:149.00 stddev:1.51 (1.0%) stddev-sans-first:1.59 08:39:24 INFO - PID 14634 | Values: 149.0 150.0 148.0 149.0 148.0 153.0 149.0 149.0 151.0 149.0 08:39:24 INFO - PID 14634 | 08:39:24 INFO - PID 14634 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:39:24 INFO - PID 14634 | Values: 94.0 95.0 94.0 94.0 94.0 95.0 95.0 94.0 95.0 94.0 08:39:24 INFO - PID 14634 | 08:39:24 INFO - PID 14634 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 08:39:24 INFO - PID 14634 | Values: 64.0 63.0 63.0 63.0 64.0 64.0 64.0 65.0 64.0 65.0 08:39:24 INFO - PID 14634 | 08:39:24 INFO - PID 14634 | [#9] json-stringify-tinderbox Cycles:10 Average:56.10 Median:56.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 08:39:24 INFO - PID 14634 | Values: 56.0 55.0 56.0 57.0 57.0 56.0 55.0 56.0 57.0 56.0 08:39:24 INFO - PID 14634 | 08:39:24 INFO - PID 14634 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.00 stddev:1.06 (1.3%) stddev-sans-first:1.12 08:39:24 INFO - PID 14634 | Values: 82.0 84.0 84.0 81.0 82.0 83.0 82.0 82.0 82.0 81.0 08:39:24 INFO - PID 14634 | 08:39:24 INFO - PID 14634 | [#11] stanford-crypto-ccm Cycles:10 Average:140.10 Median:133.50 stddev:19.11 (14.3%) stddev-sans-first:20.14 08:39:24 INFO - PID 14634 | Values: 134.0 134.0 130.0 133.0 132.0 150.0 130.0 133.0 192.0 133.0 08:39:24 INFO - PID 14634 | 08:39:24 INFO - PID 14634 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.70 Median:193.00 stddev:3.62 (1.9%) stddev-sans-first:2.55 08:39:24 INFO - PID 14634 | Values: 185.0 194.0 200.0 192.0 194.0 193.0 193.0 192.0 192.0 192.0 08:39:24 INFO - PID 14634 | 08:39:24 INFO - PID 14634 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:71.50 stddev:2.20 (3.1%) stddev-sans-first:2.24 08:39:24 INFO - PID 14634 | Values: 73.0 71.0 72.0 70.0 70.0 76.0 70.0 70.0 68.0 72.0 08:39:24 INFO - PID 14634 | -------- Summary: end -------- 08:39:24 INFO - PID 14634 | 08:39:25 INFO - TEST-INFO | 14634: exit 0 08:39:25 INFO - TEST-OK | kraken | took 64545ms 08:39:25 INFO - SUITE-END | took 1188s 08:39:26 INFO - Completed test suite (00:19:48) 08:39:26 INFO - javascript benchmark 08:39:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6563.196707928525, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2640.749128832761, 2657.7608015278647, 2687.3281679580105, 2688.556388195948, 2694.757471827535, 5056.342675452195, 5116.23256511523, 5140.15187494064, 5150.1759718445055, 5188.6367954243215, 5064.746762661871, 5103.591712662987, 5147.459516750743, 5165.63840531162, 5179.093658609747, 4617.468991066028, 4639.280911458729, 4688.742119183444, 4767.90464190716, 4821.7830197641015, 4695.436547614274, 4696.976515117437, 4762.452317983424, 4766.380370551823, 4777.307290442901, 4657.906841863178, 4704.929426058612, 4710.076188003629, 4712.811487540494, 4771.904561908743, 4703.529647035303, 4706.74112923789, 4714.175019371631, 4770.260609605517, 4780.928286075712, 4639.652026098056, 4691.7888695008805, 4695.60087392572, 4728.550787675165, 4745.145873742725, 4984.127777638935, 5029.949700502984, 5042.445331013586, 5154.7680354383765, 5170.870728231786, 5543.750531226105, 5554.250176226198, 5554.2779438673115, 5564.221009058735, 5622.100463925753, 5606.383297837235, 5610.943890561124, 5634.408387119334, 5668.659880407189, 5672.035753921802, 5214.817481388133, 5220.164773636238, 5225.764840582183, 5226.137687281556, 5279.630425870152, 5547.44525547442, 5682.744276507485, 5694.800681976111, 5754.683492407874, 5755.740991655385, 5469.917951230735, 5474.0, 5474.91787623186, 5509.889802204014, 5526.640768350045, 5584.050711379075, 5587.1339942309005, 5589.469000444951, 5590.357108932443, 5590.944090559124, 5404.83785486436, 5473.644213126134, 5538.9169162462595, 5540.390557038722, 5547.389787123413, 5405.621606487587, 5487.807926722546, 5546.306711661043, 5550.972245138749, 5556.833295001156, 4615.353850460938, 4629.0973260214605, 4631.698939568917, 4632.0, 4676.018036212434, 3966.504186976628, 3979.582143874851, 3983.0, 4002.579729128458, 4012.538558065801, 4681.297805329228, 4745.074710431501, 4779.474257831635, 4806.975965120152, 4817.181079216542, 5626.774929002876, 5627.380988091307, 5627.887442251132, 5654.095344744904, 5685.431456854281, 4760.642951778561, 4793.041391721669, 4795.928061079087, 4809.44691360491, 4849.587785038311, 4761.714297142183, 4867.026594681007, 4871.926921096187, 4918.065567542227, 4918.360613120271, 5210.0, 5219.556337711337, 5276.314079169683, 5278.60410469224, 5281.207818827053, 5444.754986025559, 5505.669659820263, 5512.834614961557, 5512.944870551243, 5586.413426590312, 5152.175651895828, 5162.303089082926, 5165.121929272108, 5168.0697474453455, 5169.172932330809, 5386.272853164773, 5394.406615272238, 5439.401665816677, 5443.401225865231, 5446.1558458439, 5533.944660553504, 5534.1145416733125, 5610.551155907599, 5615.157726341082, 5629.802956896489, 5424.24060631504, 5437.157240627709, 5444.101723215784, 5447.782088716565, 5448.945510545002, 5436.809711660073, 5437.4018857926385, 5442.401335852974, 5444.292242008513, 5446.128619420873, 5182.507661772125, 5245.396779370269, 5253.632245742914, 5350.598705097211, 5386.622936394415, 5449.836504904859, 5455.0, 5455.290812194548, 5478.096114141122, 5500.22996780459, 5290.867728306823, 5304.443033481429, 5310.575153987749, 5313.282706834682, 5328.946710532845], "value": 5061.00600335242, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.2864277687602, 681.1213534540443, 702.8524009957907, 1060.416770776073, 1075.0969185883855, 25962.091326803566, 31749.523757143634, 32241.0, 32256.99999999997, 32290.35419291613, 36290.0, 36987.260254794885, 37035.0, 37049.81475092628, 37143.071423214365, 7332.083489563818, 7471.887921681179, 7472.551646901204, 7479.027726395561, 7480.588567628778, 5577.888442231153, 5725.456081672234, 7192.892106618405, 7334.559926404406, 7366.300201480877, 7388.224236455176, 7468.850622987537, 7469.813254668622, 7473.850522989537, 7481.289277518627, 7370.594617296047, 7428.33145016951, 7429.925700742978, 7433.888491672602, 7440.367568756662, 5559.388467268597, 5724.198612194296, 7118.964405177992, 7249.71001159953, 7282.563046217244, 31444.0, 31850.522242166386, 31852.20369490758, 31858.840705796323, 31916.20209494758, 2641.1020253114034, 2655.9336016599545, 2655.9336016599545, 2660.414708764088, 2692.17888543994, 21586.676199857015, 21809.2366767164, 22203.777962220494, 22291.554168916693, 24010.519789604285, 2993.655729591103, 3035.1653295343735, 3041.817490950528, 3051.25244315142, 3093.6751641077813, 147963.0, 148237.0, 148455.0, 148512.0, 148661.25669371692, 41942.370864437056, 42274.36588451175, 42345.576544234165, 42399.788001059795, 42405.787971059945, 44994.325085123746, 45025.099498009855, 45059.54940450619, 45062.32406513905, 45093.774531127136, 12274.877251227552, 12336.876631233752, 12414.937925310496, 12432.948563486923, 12460.190087644274, 10016.599336026477, 10020.949895250476, 10039.4478303694, 10041.347312424668, 10044.799104017879, 10274.178065754722, 10515.211359148094, 11426.885731142582, 11580.47887845049, 11672.716001239856, 4789.402173913082, 4824.204006338985, 4847.127517046965, 4857.927131093036, 4864.78108485119, 830.667732906842, 850.6639877248452, 873.5413907698509, 892.4734406700078, 901.0, 19040.839489456634, 19333.419997400102, 19799.0, 19842.801571984095, 20131.597368052557, 908.1463424381061, 938.643315540104, 964.4550828781715, 975.2929126383316, 975.3757595139117, 10193.74515637115, 10829.523899143756, 10946.069584085442, 11168.888311116785, 11296.943515282372, 197288.0, 198100.0, 198366.0, 198443.0, 198522.0, 41229.793851030554, 41457.1708565833, 41536.37695434571, 41543.584564154575, 41548.79225603853, 942.0108885670019, 1177.587844254504, 1240.9813852792215, 1251.086706704111, 1255.5731051442554, 18812.623747525246, 18841.0, 19721.309754158534, 19748.703769443182, 20232.0, 29292.121236362942, 29371.11886643404, 29455.85272073626, 29468.852655737443, 29486.852565737034, 182161.0, 182173.0, 182208.0, 182305.0, 182723.08638456723, 27813.721862781113, 27825.0, 27874.303142421602, 27888.0, 27946.301342466602, 32951.34097318088, 33595.664043359255, 33707.325853483286, 34145.0, 34519.65480345265, 30741.846290768404, 31009.534856977614, 31224.0, 31261.687383125878, 32256.193595160308, 30268.0, 30425.695743042284, 30630.540541892336, 30864.382712345177, 31711.0, 30388.24029399283, 30963.690363096983, 31092.844535777178, 31107.0, 31130.84434577903, 27298.317542060813, 27702.584461233502, 28017.439651206452, 28167.71832281651, 28279.29301767472, 21483.677744834153, 21847.890760546095, 22068.88965555162, 22112.88943555272, 22133.225337113123], "value": 14449.83794413409, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.30850777108975, 431.4542104238137, 434.8456298014205, 451.798949467487, 455.4170661553213, 15032.323545440455, 18272.360467383645, 18841.24635014601, 19343.613127737437, 19434.22263109474, 18623.255069797193, 18717.25130994762, 18842.246310147613, 19251.518712032208, 19266.61466770664, 5740.368559458467, 5954.4938680212235, 5958.0, 5960.284765828107, 5966.0, 3450.1202193440763, 3647.562292524901, 5599.832005039835, 5847.8538036549, 5861.0915308127305, 5810.331811841629, 5821.8835623287505, 5824.184614154022, 5826.796062137826, 5834.095715164156, 5539.9169012464645, 5720.628159169662, 5742.54059675225, 5743.0, 5745.913811292834, 5100.336956195708, 5153.123968925292, 5213.895722085537, 5213.973930130325, 5215.895682086375, 23190.0, 23326.7667323328, 23330.0, 23494.412639683975, 23615.05539778407, 1596.449225017367, 1615.4588212948677, 1641.8522332990087, 1644.8930819496695, 1658.7346024636001, 12848.807267890988, 13363.465461381533, 13638.659033524242, 14555.490557830424, 14900.776488352683, 1561.461295852929, 1597.728386174353, 1617.7411614141681, 1625.9349626014946, 1662.3849175804908, 90386.54806725924, 91125.54437227771, 92471.53764231203, 93393.53303233441, 94730.52634736782, 9893.901060989298, 11244.718882028015, 11316.547338106384, 11334.886651133547, 11698.29810211373, 14575.416983320549, 15857.127857967922, 16414.83585164157, 16429.0, 16442.342306307615, 7766.456348055582, 7837.725679601301, 8020.518768873886, 8021.197880212048, 8085.716999905093, 7105.0, 7162.7493037743425, 7263.927360726325, 7333.046703928455, 7370.48406611532, 6983.3016698330775, 7185.6766445510075, 7211.350978411968, 7216.386607138452, 7258.564486130849, 2080.0, 2094.214669498938, 2113.7674855765854, 2155.665871789875, 2235.2958817972285, 828.8093738440192, 852.2372476633378, 856.4390324337569, 873.5151990645126, 877.0308808766349, 16802.243899024572, 16937.153142342835, 17390.913045434943, 17595.12024398775, 17864.0, 869.6390997735995, 873.2882700598991, 888.5734847273345, 888.6001299415288, 890.9109089091169, 9214.216791572657, 9683.564239609235, 9705.369151005161, 9709.6601618943, 9710.320277580642, 457683.6237212247, 464313.0, 464790.0, 468469.0, 471952.0, 90239.09760902438, 91238.0, 92710.53644731732, 92752.0, 93113.0, 1081.4322480697697, 1123.505657510709, 1135.4266095621824, 1137.0846468592697, 1140.6007897235902, 16969.0, 17534.91232543829, 18445.354412595494, 18470.0, 18577.721334180267, 28091.259129882696, 41961.370579441944, 42128.83809752411, 43210.35184472298, 44363.55636443594, 48009.75995120002, 52166.391680416586, 52723.736381317845, 52971.47028529665, 53881.46118538921, 8220.301274391504, 8291.95854020726, 8340.082590915115, 8413.831723365376, 8678.349123815866, 11911.880881191077, 12046.397680116135, 12049.638510844688, 12119.454624542093, 13683.947407888896, 10948.671539853816, 11274.661760147208, 11343.376114313793, 11368.431578421212, 11406.0, 11463.942680286546, 11480.94259528697, 11516.94241528787, 11624.0, 11740.88259117432, 11478.82781758291, 11654.125940554322, 11690.76618467643, 11794.0, 12100.0, 8523.616437260214, 8571.4000019998, 8685.568040948545, 8718.694845680371, 8852.468851868909, 10847.67456976292, 10945.945270273598, 11307.886921130683, 11325.15061370417, 11381.658550243506], "value": 9086.294601401392, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1256.7549327881063, 1323.9338033098343, 1335.125492802215, 1338.859419760925, 1346.8114463975041, 9388.295877809165, 9785.315027948047, 9785.7553561161, 9793.0, 10008.849867251978, 9721.125098741111, 9834.901650983487, 9954.452505112216, 10006.649767258148, 10010.149137323337, 2184.6941428200025, 2225.2100504320974, 2228.186711850179, 2228.732552093751, 2228.754836967932, 1849.5653521422455, 2102.5059111108876, 2176.0, 2177.1182671018264, 2184.2573525001494, 1927.5662975830467, 2151.0535364439675, 2203.526241858, 2220.4226901005773, 2230.8996095175676, 2144.292383513437, 2147.8389120815923, 2161.4164175672636, 2163.56728654269, 2167.328128280238, 2085.4265077103764, 2142.7642959274467, 2143.98928005359, 2145.517258616814, 2146.162996431393, 9818.0, 9877.654282100164, 9908.20734341251, 9912.504374781232, 9919.156871665917, 5463.672179669193, 5655.943440565624, 5672.262605861253, 5674.148877668342, 5675.063614503602, 2898.7970842041063, 3171.4767063434506, 3213.983930080358, 3223.597050368704, 3236.093893709765, 927.5315965437411, 1008.6520150548123, 1045.0698877998586, 1062.8512008318842, 1078.0459293525287, 14666.413343466249, 14778.334974926154, 14790.630234244014, 14791.482298119514, 14798.778018329735, 4908.656394052454, 5099.566536844335, 5105.821296254613, 5106.821261255838, 5110.131277682803, 10713.946430267799, 10813.351198928089, 10839.349639021684, 10846.566137354575, 10852.728681783019, 5507.972460137674, 5508.862278442991, 5509.201165831012, 5519.39286678465, 5522.0336441122645, 4926.9014619707405, 5066.569341605931, 5105.668131571436, 5124.615653825978, 5137.075326441276, 3738.476613274144, 3856.840169505086, 3860.247251785931, 3947.1908258806875, 3950.6839452843706, 1142.4687520302932, 1151.6026970695098, 1161.1233518693332, 1179.628417048627, 1195.462042081067, 564.3211445948272, 628.1614045249643, 705.2770909817376, 715.8103102677794, 719.5215181903975, 5574.160527026072, 5583.664980101207, 5708.172315014383, 5758.481736643638, 5767.106098554731, 795.188907314536, 823.300194834398, 828.4532208742202, 830.8753686946885, 838.4298676899766, 3472.826358682056, 3632.164602141522, 3633.7819730816236, 3648.2156336387275, 3710.257948410329, 12405.0, 13012.0, 13041.152325098838, 13150.60548183556, 13155.67110822218, 12856.935715321364, 13032.80450793239, 13048.0, 13048.54330098442, 13240.801387979189, 9247.213986811063, 9367.953160234156, 9428.340016198801, 9469.90530094704, 9524.523773811281, 5499.615026948075, 5501.14732216507, 5510.586705997146, 5566.610337276352, 5701.230333904869, 11587.246828956091, 11688.824667629822, 11700.239484433485, 11787.233829801036, 11796.94101529487, 11593.362365070003, 11823.704407389883, 11948.402579871146, 11951.402429878297, 12071.879281207075, 7377.372923301365, 7451.478396512192, 7461.365783908429, 7464.738734144279, 7829.217078292125, 9165.220956218796, 9182.265418766616, 9236.861447078165, 9244.861327080234, 9252.0, 7647.349975252166, 7683.03735944146, 7885.093214280202, 8008.039035315799, 8025.879611805711, 7751.651175696994, 7942.920570794449, 7947.761567152995, 7952.920470795218, 7986.520808751494, 6849.383555480031, 7152.070230870162, 7239.746608868664, 7242.275772422716, 7245.637718113968, 5100.566451851634, 5129.615278854176, 5167.896642067062, 5242.921356179584, 5327.067763141357, 4820.758962051813, 4980.701157930535, 5060.291559181791, 5130.769115389891, 5387.75755091014], "value": 4666.470977332607, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.4768443390337, 399.50062421972535, 401.24365570898857, 403.1010845813837, 405.14514374669443, 5328.360596728393, 5392.379876314225, 5407.540359069474, 5408.4050754416985, 5410.458954104588, 5039.697618142914, 5216.217567364888, 5272.314599102111, 5277.340332458442, 5310.62825602208, 4128.071183983595, 4137.524184718758, 4143.854965076223, 4145.7719825409595, 4149.190907772985, 4103.753774773509, 4122.835086596532, 4144.8134833932545, 4147.108371700084, 4165.375193720935, 3932.390479475686, 4084.121913788535, 4109.958900411002, 4130.359794231884, 4134.462519872427, 4056.290149223874, 4073.4093556434445, 4081.7142800003717, 4086.427900093989, 4087.652549533293, 3619.8733044343585, 3621.420572708354, 3622.8913132606062, 3626.510421093145, 3626.9455958160647, 4959.925601115986, 5152.58779297659, 5158.458361871987, 5195.480192106826, 5207.4377686694215, 4715.1748444022505, 4715.528447155291, 4717.9292310615365, 4723.598494128003, 4748.335233067373, 5569.944300556983, 5588.776448942038, 5590.552755779528, 5591.916121258144, 5593.440655934414, 3850.6534411902785, 3974.0859602291634, 3978.4484051220047, 3981.203759248162, 3988.481497405319, 5572.916406253909, 5613.607047506635, 5749.482546570787, 5782.595218334718, 5808.3030036395485, 4026.4362989181536, 4029.49631296088, 4043.696722745806, 4047.817848196838, 4053.756774593534, 4106.377980697608, 4119.0, 4119.567445418248, 4123.092919557693, 4135.110951145518, 4402.119576084732, 4464.486584042812, 4583.312503124492, 4668.5798278155125, 4675.836345727883, 5521.089020311684, 5579.6931168785295, 5580.162975553618, 5581.358143813432, 5583.277140930579, 1410.9506167284096, 1424.7649137892338, 1425.7148570285983, 1427.0, 1428.071753360324, 936.4053825820516, 963.2342287881152, 972.6887396033202, 976.3409698453515, 982.4940155819759, 4874.122657921537, 4876.463589005207, 4899.485554016848, 4900.921797204609, 4907.435644900811, 5723.712164762895, 5735.483806457439, 5735.512481439041, 5740.56945729072, 5744.052231381859, 4675.742834144155, 4813.4945830687275, 4880.707157570557, 4896.359719494009, 4899.289603007615, 2998.9550156747664, 3025.909222723322, 3034.9377717798593, 3044.497657886424, 3054.2059064643354, 5344.679319240858, 5345.037893179265, 5355.518003379714, 5367.9065164585845, 5379.569634429315, 5725.713714314351, 5807.157962095557, 5835.124731290255, 5845.298564172326, 5860.912086318709, 5337.973310133424, 5347.171188465794, 5348.545373643284, 5350.38470575881, 5377.435369286247, 5505.421930697219, 5711.371749107678, 5720.742566584597, 5729.169270455677, 5741.684207368635, 5590.37879015081, 5611.5230205433, 5611.8877622448135, 5615.6630602164005, 5624.943750562442, 5092.872678183075, 5259.710715910662, 5260.684358938476, 5283.47165283484, 5375.543078838343, 3813.796411014761, 3930.390789427643, 3953.189596132728, 4015.477987861559, 4062.6343629073526, 5680.204771331934, 5683.3748287687495, 5685.289338832646, 5711.8870215731695, 5715.257016587817, 5373.247745315581, 5473.8357849264585, 5500.28496295479, 5525.696086715269, 5536.363318218296, 5530.585206109477, 5532.6680399176175, 5535.474129957647, 5560.833175004756, 5570.777168913198, 5342.813001544927, 5461.290032295776, 5482.2873026506295, 5498.945010549844, 5504.422035686355, 5574.77700891976, 5587.664740115606, 5591.0, 5606.495415412633, 5613.887722245614, 5442.809501667422, 5449.155380915964, 5449.972750136224, 5468.781248750005, 5481.808136715196], "value": 4198.518170002395, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.0845858091575, 693.8542905989742, 702.652187167352, 703.5497281739684, 714.5177005521272, 12423.0, 12931.353432328393, 12952.611421657342, 12980.221186728792, 13082.345882705862, 13042.673933151653, 13119.212847229173, 13145.145565538234, 13156.407961641726, 13178.0, 835.9749207523769, 864.4942708515526, 868.8001759595265, 868.9608967596473, 873.5326600268858, 858.7938894665267, 860.995695021524, 864.8529749942525, 865.3726048614767, 865.8571335729597, 905.5245995852198, 910.3127139010038, 910.6311943662794, 917.1837065012145, 917.4266083697689, 906.8413027720155, 909.195362104539, 909.8589718593629, 910.2399496420497, 910.6311943662827, 658.8846951783419, 662.1392190152782, 665.5141746525064, 666.1573110015834, 666.2737615998536, 14238.786418203736, 14304.427822887072, 14357.425702971974, 14521.20133392663, 14759.262036898219, 13729.313534323244, 14255.78616320756, 14266.714665706628, 14298.571042868627, 14302.427902883872, 10634.20243481742, 10723.30298530593, 10785.83821242682, 10819.080378167866, 10918.399488028155, 2744.684361298436, 2783.6381270434917, 2786.6238057862333, 2792.6648802143873, 2869.03887197789, 63758.04362934606, 64429.0, 64763.43801090938, 65221.673891630715, 65614.3438565613, 9815.36200146988, 9944.950275248577, 9955.0, 10218.437985910698, 10267.127294180078, 21515.246966356415, 21646.675299870516, 21652.0, 21767.67348489774, 21865.453363666034, 5859.912101318484, 5914.852128696817, 5921.407859214044, 6149.046897730769, 6164.876702466016, 3499.492573576817, 3519.9472007919903, 3576.624454432247, 3581.6418358163974, 3584.964150358463, 3636.9272614547563, 3676.283124790694, 3693.169036966661, 3714.9071273217846, 3729.9440508392395, 612.091044798474, 618.811262564922, 627.5889292513411, 629.76069093745, 635.1489004733679, 532.9440408757102, 544.6106034185497, 555.2892297858747, 556.1907424697056, 556.9777208911679, 7721.0, 7731.188225236382, 7814.921850781533, 7836.921630783733, 8036.557989310527, 499.4406264983242, 521.4082016910758, 530.0485628297216, 551.2525294815445, 562.2606272751401, 3397.9490307645406, 3460.498227756961, 3615.9276814463565, 3654.196076863139, 3735.4210097434943, 54369.72815135899, 55317.72341138349, 55409.44590554124, 55646.443535564125, 57512.137317940265, 35485.64514354875, 37745.24509509849, 46962.530374695816, 52627.947441050965, 54677.1798423016, 43394.34908476375, 44092.77953610211, 44174.33738493925, 44974.55025449704, 45202.09595808065, 7824.921750782647, 8202.917970820215, 8209.590466282058, 8296.419250652396, 8389.916100838913, 23687.289381318587, 23772.4056898572, 23999.52000960006, 24252.51494970126, 24850.37874053091, 28477.430451391272, 28716.0, 28809.42381152407, 29001.709982900746, 29012.27469313284, 10661.520231589442, 10726.0, 10775.245732798629, 10890.836637450286, 11049.39228342449, 12515.311657858905, 12808.487660493476, 13083.738325233633, 13646.727065458834, 14251.35868885882, 11244.718882028015, 11417.200795944203, 11556.47995840206, 11755.88244117548, 11949.701257468285, 12129.757404851676, 12300.692482687646, 12423.875761242272, 12532.87467125317, 12759.80860287115, 10919.235653504178, 11160.274582152135, 11585.478653460783, 11653.6503904883, 11931.702319196746, 9371.625134994523, 9755.804883902425, 9798.51007449639, 10137.290389672653, 10163.644272450429, 8932.910670893469, 9136.908630913606, 9337.486438245962, 9415.85876211871, 9421.905780942378], "value": 6138.855309795131, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 109.0, 111.0, 110.0, 111.0, 109.0, 109.0, 110.0, 111.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 126.0, 123.0, 170.0, 129.0, 125.0, 126.0, 124.0, 164.0, 125.0], "value": 137.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 163.0, 163.0, 163.0, 163.0, 162.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 106.0, 77.0, 75.0, 75.0, 74.0, 94.0, 76.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 104.0, 85.0, 84.0, 86.0, 108.0, 84.0, 84.0, 102.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 148.0, 149.0, 148.0, 153.0, 149.0, 149.0, 151.0, 149.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 57.0, 57.0, 56.0, 55.0, 56.0, 57.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 84.0, 81.0, 82.0, 83.0, 82.0, 82.0, 82.0, 81.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 134.0, 130.0, 133.0, 132.0, 150.0, 130.0, 133.0, 192.0, 133.0], "value": 140.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 194.0, 200.0, 192.0, 194.0, 193.0, 193.0, 192.0, 192.0, 192.0], "value": 192.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 72.0, 70.0, 70.0, 76.0, 70.0, 70.0, 68.0, 72.0], "value": 71.2, "unit": "score"}]}]} 08:39:26 INFO - Return code: 0 08:39:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:39:26 ERROR - # TBPL SUCCESS # 08:39:26 INFO - Running post-action listener: _resource_record_post_action 08:39:26 INFO - [mozharness: 2017-03-22 15:39:26.449577Z] Finished run-tests step (success) 08:39:26 INFO - Running post-run listener: _resource_record_post_run 08:39:26 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 8192; Write bytes: 362283008; Read time: 24; Write time: 211644 08:39:26 INFO - TinderboxPrint: CPU usage
13.0% 08:39:26 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 08:39:26 INFO - TinderboxPrint: I/O write bytes / time
362,283,008 / 211,644 08:39:26 INFO - TinderboxPrint: CPU idle
8,371.6 (87.0%) 08:39:26 INFO - TinderboxPrint: CPU user
1,200.3 (12.5%) 08:39:26 INFO - TinderboxPrint: Swap in / out
0 / 0 08:39:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105984000; Read time: 0; Write time: 82836 08:39:26 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 256299008; Read time: 12; Write time: 128808 08:39:27 INFO - Running post-run listener: _upload_blobber_files 08:39:27 INFO - Blob upload gear active. 08:39:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:39:27 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 08:39:27 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'] 08:39:27 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 08:39:27 INFO - (blobuploader) - INFO - Open directory for files ... 08:39:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:39:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:39:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:29 INFO - (blobuploader) - INFO - Done attempting. 08:39:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:39:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:39:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:30 INFO - (blobuploader) - INFO - Done attempting. 08:39:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:39:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:39:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:31 INFO - (blobuploader) - INFO - Done attempting. 08:39:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:39:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:39:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:34 INFO - (blobuploader) - INFO - Done attempting. 08:39:34 INFO - (blobuploader) - INFO - Iteration through files over. 08:39:34 INFO - Return code: 0 08:39:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:39:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:39:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31c59b51217171d3330eecec289e88048611c4108aa58eb8e1f907feb1d6c662da12caf504ea6d4d248a661b439e1be944ead994b0de8b163914366b5db61ec8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3171cff33e27166f9486433f2838266be2c4a1ce171bece4fa07b23066c6f40aea8b3bbdd88a4f645da66e0ce58a3b170ae74fbf91c059383568c61412793a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a26f7eab4aa775e9ddf594b9bfec66b576f3902135c5e60c796d846f3bda09732737286b2a16ce0535f966ac6e748904d55ccf3c4624dfd4b3f77ac1dcf5efdf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8dddf92666173855c7f5ae5bf6f06f1128291d4a96e24f5b8d6c942f4355d922b3f68997fb9a4a1b54fd1dcd63650e84214eee0b68cd5de3a4f6d83d5a442318"} 08:39:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:39:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:39:34 INFO - Contents: 08:39:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31c59b51217171d3330eecec289e88048611c4108aa58eb8e1f907feb1d6c662da12caf504ea6d4d248a661b439e1be944ead994b0de8b163914366b5db61ec8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3171cff33e27166f9486433f2838266be2c4a1ce171bece4fa07b23066c6f40aea8b3bbdd88a4f645da66e0ce58a3b170ae74fbf91c059383568c61412793a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a26f7eab4aa775e9ddf594b9bfec66b576f3902135c5e60c796d846f3bda09732737286b2a16ce0535f966ac6e748904d55ccf3c4624dfd4b3f77ac1dcf5efdf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8dddf92666173855c7f5ae5bf6f06f1128291d4a96e24f5b8d6c942f4355d922b3f68997fb9a4a1b54fd1dcd63650e84214eee0b68cd5de3a4f6d83d5a442318"} 08:39:34 INFO - Running post-run listener: copy_logs_to_upload_dir 08:39:34 INFO - Copying logs to upload dir... 08:39:34 INFO - mkdir: /builds/slave/test/build/upload/logs 08:39:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.613860 ========= master_lag: -0.23 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-03-22 08:39:34.522253) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 08:39:34.526834) ========= 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=781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31c59b51217171d3330eecec289e88048611c4108aa58eb8e1f907feb1d6c662da12caf504ea6d4d248a661b439e1be944ead994b0de8b163914366b5db61ec8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3171cff33e27166f9486433f2838266be2c4a1ce171bece4fa07b23066c6f40aea8b3bbdd88a4f645da66e0ce58a3b170ae74fbf91c059383568c61412793a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a26f7eab4aa775e9ddf594b9bfec66b576f3902135c5e60c796d846f3bda09732737286b2a16ce0535f966ac6e748904d55ccf3c4624dfd4b3f77ac1dcf5efdf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8dddf92666173855c7f5ae5bf6f06f1128291d4a96e24f5b8d6c942f4355d922b3f68997fb9a4a1b54fd1dcd63650e84214eee0b68cd5de3a4f6d83d5a442318"} build_url:https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011259 build_url: 'https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31c59b51217171d3330eecec289e88048611c4108aa58eb8e1f907feb1d6c662da12caf504ea6d4d248a661b439e1be944ead994b0de8b163914366b5db61ec8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3171cff33e27166f9486433f2838266be2c4a1ce171bece4fa07b23066c6f40aea8b3bbdd88a4f645da66e0ce58a3b170ae74fbf91c059383568c61412793a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a26f7eab4aa775e9ddf594b9bfec66b576f3902135c5e60c796d846f3bda09732737286b2a16ce0535f966ac6e748904d55ccf3c4624dfd4b3f77ac1dcf5efdf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8dddf92666173855c7f5ae5bf6f06f1128291d4a96e24f5b8d6c942f4355d922b3f68997fb9a4a1b54fd1dcd63650e84214eee0b68cd5de3a4f6d83d5a442318"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 08:39:34.560249) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:39:34.560697) ========= 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=781b77c4c33858b1f599d705000001c1-1490195822.769781-432283913 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:39:34.640019) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 08:39:34.643565) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 08:39:34.644013) ========= ========= Total master_lag: 0.02 =========